hi,
Here is the log file coming with StreamDevice, can anyone give me some suggestions? Thanks a lot.
2008/10/06 11:14:01.888 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:01.888 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:01.889 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:01.889 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:01.889 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:01.889 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:01.889 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:01.889 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:01.889 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:01.889 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:01.889 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:01.890 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:01.890 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:01.890 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:01.890 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:01.890 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:01.890 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:01.890 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:01.890 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:01.892 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:01.892 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:01.892 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:01.892 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:01.892 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:01.893 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:02.892 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:02.892 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>z;<05>"
2008/10/06 11:14:02.892 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>z;<05>", size=7)
2008/10/06 11:14:02.892 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>z;<05>", size 8
2008/10/06 11:14:02.892 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:02.892 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>z;<05>"
2008/10/06 11:14:02.892 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:02.892 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>z;<05>"
2008/10/06 11:14:02.892 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00381470
2008/10/06 11:14:02.892 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:02.892 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:02.892 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:02.892 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:02.892 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:02.892 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:02.893 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:02.893 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:02.893 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:02.896 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:02.896 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:02.896 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:02.896 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:02.896 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:02.896 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:02.896 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:02.896 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:02.896 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:02.896 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:02.896 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:02.896 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:02.896 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:02.896 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:02.896 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:02.896 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:02.896 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:02.897 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:02.897 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:02.899 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:02.899 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:02.899 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:02.899 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:02.899 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:02.899 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:03.896 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:03.896 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>z;<05>"
2008/10/06 11:14:03.896 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>z;<05>", size=7)
2008/10/06 11:14:03.896 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>z;<05>", size 8
2008/10/06 11:14:03.896 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:03.896 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>z;<05>"
2008/10/06 11:14:03.896 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:03.896 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>z;<05>"
2008/10/06 11:14:03.896 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00381470
2008/10/06 11:14:03.896 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:03.896 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:03.896 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:03.896 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:03.896 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:03.897 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:03.897 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:03.897 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:03.897 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:03.904 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:03.904 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:03.904 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:03.904 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:03.904 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:03.904 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:03.904 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:03.904 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:03.904 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:03.904 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:03.904 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:03.904 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:03.904 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:03.904 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:03.904 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:03.904 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:03.905 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:03.905 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:03.905 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:03.907 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:03.907 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:03.907 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:03.907 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:03.907 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:03.907 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:04.904 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:04.904 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>p;<0f>"
2008/10/06 11:14:04.904 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>p;<0f>", size=7)
2008/10/06 11:14:04.904 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>p;<0f>", size 8
2008/10/06 11:14:04.904 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:04.904 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>p;<0f>"
2008/10/06 11:14:04.904 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:04.904 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>p;<0f>"
2008/10/06 11:14:04.904 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00366211
2008/10/06 11:14:04.904 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:04.904 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:04.904 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:04.904 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:04.904 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:04.904 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:04.905 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:04.905 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:04.905 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:04.912 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:04.912 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:04.912 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:04.912 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:04.912 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:04.912 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:04.912 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:04.912 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:04.912 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:04.912 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:04.912 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:04.912 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:04.912 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:04.912 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:04.912 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:04.912 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:04.913 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:04.913 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:04.913 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:04.915 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:04.915 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:04.915 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:04.915 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:04.915 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:04.915 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:05.913 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:05.913 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>k;<14>"
2008/10/06 11:14:05.914 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>k;<14>", size=7)
2008/10/06 11:14:05.914 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>k;<14>", size 8
2008/10/06 11:14:05.914 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:05.914 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>k;<14>"
2008/10/06 11:14:05.914 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:05.914 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>k;<14>"
2008/10/06 11:14:05.914 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00358582
2008/10/06 11:14:05.914 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:05.914 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:05.914 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:05.914 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:05.914 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:05.914 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:05.914 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:05.915 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:05.915 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:05.920 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:05.920 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:05.920 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:05.920 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:05.920 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:05.920 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:05.920 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:05.920 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:05.920 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:05.920 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:05.920 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:05.920 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:05.920 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:05.920 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:05.921 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:05.921 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:05.921 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:05.921 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:05.921 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:05.923 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:05.923 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:05.923 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:05.923 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:05.923 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:05.923 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:06.920 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:06.920 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>k;<14>"
2008/10/06 11:14:06.920 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>k;<14>", size=7)
2008/10/06 11:14:06.920 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>k;<14>", size 8
2008/10/06 11:14:06.920 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:06.920 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>k;<14>"
2008/10/06 11:14:06.920 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:06.920 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>k;<14>"
2008/10/06 11:14:06.920 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00358582
2008/10/06 11:14:06.920 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:06.920 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:06.920 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:06.920 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:06.920 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:06.921 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:06.921 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:06.921 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:06.921 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:06.928 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:06.928 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:06.928 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:06.928 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:06.928 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:06.928 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:06.928 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:06.928 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:06.928 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:06.928 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:06.928 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:06.928 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:06.929 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:06.929 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:06.929 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:06.929 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:06.929 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:06.929 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:06.929 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:06.931 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:06.931 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:06.931 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:06.931 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:06.931 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:06.931 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:07.929 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:07.929 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>k;<14>"
2008/10/06 11:14:07.929 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>k;<14>", size=7)
2008/10/06 11:14:07.929 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>k;<14>", size 8
2008/10/06 11:14:07.929 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:07.929 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>k;<14>"
2008/10/06 11:14:07.929 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:07.929 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>k;<14>"
2008/10/06 11:14:07.929 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00358582
2008/10/06 11:14:07.929 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:07.929 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:07.929 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:07.929 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:07.929 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:07.929 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:07.929 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:07.929 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:07.929 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:07.936 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:07.936 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:07.936 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:07.936 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:07.936 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:07.936 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:07.936 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:07.936 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:07.936 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:07.936 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:07.936 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:07.936 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:07.936 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:07.936 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:07.936 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:07.937 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:07.937 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:07.937 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:07.937 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:07.939 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:07.939 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:07.939 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:07.939 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:07.939 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:07.939 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:08.936 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:08.936 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>k;<14>"
2008/10/06 11:14:08.936 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>k;<14>", size=7)
2008/10/06 11:14:08.936 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>k;<14>", size 8
2008/10/06 11:14:08.936 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:08.936 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>k;<14>"
2008/10/06 11:14:08.936 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:08.936 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>k;<14>"
2008/10/06 11:14:08.936 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00358582
2008/10/06 11:14:08.937 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:08.937 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:08.937 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:08.937 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:08.937 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:08.937 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:08.937 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:08.937 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:08.937 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:08.944 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:08.944 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:08.944 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:08.944 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:08.944 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:08.944 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:08.944 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:08.944 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:08.944 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:08.944 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:08.944 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:08.944 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:08.944 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:08.944 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:08.945 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:08.945 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:08.945 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:08.945 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:08.945 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:08.947 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:08.947 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:08.947 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:08.947 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:08.947 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:08.947 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:09.944 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:09.944 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>z;<05>"
2008/10/06 11:14:09.944 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>z;<05>", size=7)
2008/10/06 11:14:09.944 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>z;<05>", size 8
2008/10/06 11:14:09.944 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:09.944 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>z;<05>"
2008/10/06 11:14:09.945 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:09.945 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>z;<05>"
2008/10/06 11:14:09.945 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00381470
2008/10/06 11:14:09.945 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:09.945 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:09.945 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:09.945 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:09.945 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:09.945 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:09.945 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:09.945 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:09.945 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:09.952 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:09.952 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:09.952 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:09.952 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:09.952 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:09.952 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:09.952 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:09.952 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:09.952 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:09.952 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:09.952 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:09.952 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:09.952 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:09.953 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:09.953 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:09.953 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:09.953 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:09.953 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:09.953 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:09.955 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:09.955 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:09.955 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:09.955 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:09.955 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:09.955 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:10.952 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:10.953 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>u;<0a>"
2008/10/06 11:14:10.953 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>u;<0a>", size=7)
2008/10/06 11:14:10.953 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>u;<0a>", size 8
2008/10/06 11:14:10.953 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:10.953 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>u;<0a>"
2008/10/06 11:14:10.953 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:10.953 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>u;<0a>"
2008/10/06 11:14:10.953 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00373840
2008/10/06 11:14:10.953 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:10.953 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:10.953 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:10.953 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:10.953 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:10.953 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:10.953 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:10.953 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:10.954 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:10.960 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:10.960 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:10.960 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:10.960 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:10.960 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:10.960 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:10.960 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:10.960 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:10.960 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:10.960 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:10.960 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:10.961 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:10.961 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:10.961 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:10.961 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:10.961 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:10.961 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:10.961 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:10.961 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:10.963 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:10.963 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:10.963 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:10.963 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:10.963 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:10.963 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:11.964 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:11.964 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>p;<0f>"
2008/10/06 11:14:11.964 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>p;<0f>", size=7)
2008/10/06 11:14:11.964 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>p;<0f>", size 8
2008/10/06 11:14:11.964 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:11.964 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>p;<0f>"
2008/10/06 11:14:11.964 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:11.964 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>p;<0f>"
2008/10/06 11:14:11.964 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00366211
2008/10/06 11:14:11.965 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:11.965 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:11.965 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:11.965 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:11.965 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:11.965 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:11.965 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:11.965 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:11.965 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:11.968 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:11.968 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:11.968 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:11.968 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:11.968 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:11.968 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:11.968 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:11.968 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:11.968 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:11.969 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:11.969 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:11.969 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:11.969 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:11.969 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:11.969 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:11.969 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:11.969 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:11.969 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:11.969 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:11.971 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:11.971 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:11.971 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:11.971 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:11.971 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:11.971 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:12.968 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:12.968 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00><82>;?
2008/10/06 11:14:12.968 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00><82>;?, size=7)
2008/10/06 11:14:12.968 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00><82>;?, size 8
2008/10/06 11:14:12.968 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:12.968 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00><82>;?
2008/10/06 11:14:12.968 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:12.968 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00><82>;?
2008/10/06 11:14:12.969 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00396729
2008/10/06 11:14:12.969 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:12.969 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:12.969 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:12.969 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:12.969 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:12.969 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:12.969 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:12.969 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:12.969 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:12.976 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:12.976 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:12.976 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:12.976 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:12.976 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:12.976 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:12.976 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:12.976 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:12.976 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:12.976 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:12.976 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:12.977 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:12.977 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:12.977 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:12.977 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:12.977 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:12.977 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:12.977 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:12.977 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:12.979 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:12.979 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:12.979 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:12.979 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:12.979 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:12.979 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:13.976 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:13.976 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>k;<14>"
2008/10/06 11:14:13.976 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>k;<14>", size=7)
2008/10/06 11:14:13.976 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>k;<14>", size 8
2008/10/06 11:14:13.976 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:13.976 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>k;<14>"
2008/10/06 11:14:13.976 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:13.977 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>k;<14>"
2008/10/06 11:14:13.977 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00358582
2008/10/06 11:14:13.977 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:13.977 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:13.977 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:13.977 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:13.977 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:13.977 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:13.977 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:13.977 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:13.977 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:13.984 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:13.984 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:13.984 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:13.984 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:13.984 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:13.984 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:13.984 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:13.984 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:13.984 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:13.984 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:13.984 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:13.985 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:13.985 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:13.985 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:13.985 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:13.985 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:13.985 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:13.985 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:13.985 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:13.987 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:13.987 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:13.987 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:13.987 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:13.987 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:13.987 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:14.984 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:14.984 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>p;<0f>"
2008/10/06 11:14:14.984 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>p;<0f>", size=7)
2008/10/06 11:14:14.984 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>p;<0f>", size 8
2008/10/06 11:14:14.984 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:14.984 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>p;<0f>"
2008/10/06 11:14:14.984 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:14.985 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>p;<0f>"
2008/10/06 11:14:14.985 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00366211
2008/10/06 11:14:14.985 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:14.985 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:14.985 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:14.985 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:14.985 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:14.985 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:14.985 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:14.985 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:14.985 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:14.992 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:14.992 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:14.992 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:14.992 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:14.992 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:14.992 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:14.992 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:14.992 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:14.992 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:14.992 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:14.993 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:14.993 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:14.993 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:14.993 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:14.993 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:14.993 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:14.993 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:14.993 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:14.993 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:14.995 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:14.995 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:14.995 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:14.995 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:14.995 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:14.995 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:15.996 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:15.997 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>k;<14>"
2008/10/06 11:14:15.997 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>k;<14>", size=7)
2008/10/06 11:14:15.997 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>k;<14>", size 8
2008/10/06 11:14:15.997 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:15.997 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>k;<14>"
2008/10/06 11:14:15.997 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:15.997 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>k;<14>"
2008/10/06 11:14:15.997 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00358582
2008/10/06 11:14:15.997 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:15.997 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:15.997 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:15.997 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:15.997 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:15.998 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:15.998 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:15.998 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:15.998 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:16.000 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:16.000 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:16.000 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:16.000 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:16.000 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:16.000 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:16.000 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:16.000 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:16.001 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:16.001 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:16.001 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:16.001 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:16.001 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:16.001 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:16.001 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:16.001 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:16.001 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:16.001 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:16.001 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:16.003 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:16.003 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:16.003 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:16.003 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:16.003 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:16.003 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:17.000 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:17.000 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00>z;<05>"
2008/10/06 11:14:17.000 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00>z;<05>", size=7)
2008/10/06 11:14:17.000 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00>z;<05>", size 8
2008/10/06 11:14:17.001 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:17.001 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00>z;<05>"
2008/10/06 11:14:17.001 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:17.001 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00>z;<05>"
2008/10/06 11:14:17.001 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00381470
2008/10/06 11:14:17.001 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
2008/10/06 11:14:17.001 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = end
2008/10/06 11:14:17.001 terminal StreamCore.cc:519: StreamCore::finishProtocol(DZ:ai, status=Success) bus owner
2008/10/06 11:14:17.001 terminal AsynDriverInterface.cc:545: AsynDriverInterface::unlock(DZ:ai)
2008/10/06 11:14:17.001 terminal AsynDriverInterface.cc:1267: AsynDriverInterface::finish(DZ:ai) start
2008/10/06 11:14:17.001 terminal AsynDriverInterface.cc:1277: AsynDriverInterface::finish(DZ:ai) done
2008/10/06 11:14:17.001 cbLow StreamEpics.cc:891: streamRecordProcessCallback(DZ:ai) processing record
2008/10/06 11:14:17.001 cbLow StreamEpics.cc:696: Stream::process(DZ:ai) ready. convert
2008/10/06 11:14:17.001 cbLow StreamEpics.cc:896: streamRecordProcessCallback(DZ:ai) processing record done
2008/10/06 11:14:17.008 scan0.5 StreamEpics.cc:708: Stream::process(DZ:ai) start
2008/10/06 11:14:17.008 scan0.5 StreamCore.cc:413: StreamCore::startProtocol(DZ:ai, startMode=StartNormal)
2008/10/06 11:14:17.008 scan0.5 StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = out
2008/10/06 11:14:17.008 scan0.5 StreamCore.cc:602: StreamCore::evalOut: outputLine = "?81><00><81>"
2008/10/06 11:14:17.008 scan0.5 StreamCore.cc:613: StreamCore::evalOut(DZ:ai): lockRequest(5000)
2008/10/06 11:14:17.008 scan0.5 AsynDriverInterface.cc:464: AsynDriverInterface::lockRequest(DZ:ai, 5000 msec)
2008/10/06 11:14:17.008 scan0.5 StreamEpics.cc:719: Stream::process(DZ:ai): protocol started
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Lock
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:534: AsynDriverInterface::lockHandler(DZ:ai)
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:496: AsynDriverInterface::connectToAsynPort(DZ:ai)
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:505: AsynDriverInterface::connectToAsynPort(DZ:ai) is already connected
2008/10/06 11:14:17.009 terminal StreamCore.cc:795: StreamCore::lockCallback(DZ:ai, status=Success)
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:557: AsynDriverInterface::writeRequest(DZ:ai, "?81><00><81>", 100 msec)
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Write
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:585: AsynDriverInterface::writeHandler(DZ:ai)
2008/10/06 11:14:17.009 terminal StreamCore.cc:821: StreamCore::writeCallback(DZ:ai, status=Success)
2008/10/06 11:14:17.009 terminal StreamCore.cc:554: StreamCore::evalCommand(DZ:ai): activeCommand = in
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:674: AsynDriverInterface::readRequest(DZ:ai, 10000 msec reply, 1000 msec read, expect 0 bytes, asyn=no)
2008/10/06 11:14:17.009 terminal AsynDriverInterface.cc:1287: AsynDriverInterface::handleRequest(DZ:ai) Read
2008/10/06 11:14:17.011 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=1, ...) [timeout=10.000000 seconds] = asynSuccess
2008/10/06 11:14:17.011 terminal AsynDriverInterface.cc:830: AsynDriverInterface::readHandler(DZ:ai): received 1 of 1 bytes "U" eomReason=CNT
2008/10/06 11:14:17.011 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoSuccess input="U", size=1)
2008/10/06 11:14:17.011 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U", size 1
2008/10/06 11:14:17.011 terminal StreamCore.cc:1028: StreamCore::readCallback(DZ:ai) wait for more input
2008/10/06 11:14:17.011 terminal AsynDriverInterface.cc:935: AsynDriverInterface::readHandler(DZ:ai) readMore=-1 bytesToRead=63
2008/10/06 11:14:18.012 terminal AsynDriverInterface.cc:803: AsynDriverInterface::readHandler(DZ:ai): read(..., bytesToRead=63, ...) [timeout=1.000000 seconds] = asynTimeout
2008/10/06 11:14:18.012 terminal AsynDriverInterface.cc:889: AsynDriverInterface::readHandler(DZ:ai): ioAction=Read, timeout after 7 of 63 bytes "@<04><00><00><7f>;<00>"
2008/10/06 11:14:18.012 terminal StreamCore.cc:910: StreamCore::readCallback(DZ:ai, status=StreamIoTimeout input="@<04><00><00><7f>;<00>", size=7)
2008/10/06 11:14:18.012 terminal StreamCore.cc:967: StreamCore::readCallback(DZ:ai) inputBuffer="U@<04><00><00><7f>;<00>", size 8
2008/10/06 11:14:18.012 terminal StreamCore.cc:999: StreamCore::readCallback(DZ:ai) end flag received
2008/10/06 11:14:18.013 terminal StreamCore.cc:1056: StreamCore::readCallback(DZ:ai) input line: "U@<04><00><00><7f>;<00>"
2008/10/06 11:14:18.013 terminal StreamEpics.cc:504: streamScanfN(DZ:ai,format=%R,maxStringSize=40)
2008/10/06 11:14:18.013 terminal StreamCore.cc:1345: StreamCore::scanValue(DZ:ai, format=%R, double) input="<00><00><7f>;<00>"
2008/10/06 11:14:18.013 terminal StreamCore.cc:1349: StreamCore::scanValue(DZ:ai) scanned 0.00389099
2008/10/06 11:14:18.013 terminal StreamEpics.cc:513: streamScanfN(DZ:ai) success, value=""
======= At 2008-10-04, 23:25:45 you wrote: =======
>The input string is a zero-length string, which is OK, but the char
>*value pointer is NULL for some reason, so when it tries to copy \0 to
>value[0] you are getting an access violation. I don't know why
>value=NULL.
>
>Mark
>
>
>-----Original Message-----
>From: [email protected]
>[mailto:[email protected]] On Behalf Of Silver
>Sent: Saturday, October 04, 2008 10:18 AM
>To: tech-talk
>Subject: Re: RE: problem of using Streamdevice
>
>hi, Mark:
>
> Following is gdb message, could you give me some hints?
>
>Core was generated by `O.linux-x86/streamApp example.cmd'.
>Program terminated with signal 11, Segmentation fault.
>#0 StdStringConverter::scanString (this=0x9268b8, fmt=@0xb7f6aa14,
>input=0x88d2deb "", value=0x0, maxlen=0)
> at ../StreamFormatConverter.cc:281
>281 value[0] = '\0';
>(gdb) bt
>#0 StdStringConverter::scanString (this=0x9268b8, fmt=@0xb7f6aa14,
>input=0x88d2deb "", value=0x0, maxlen=0)
> at ../StreamFormatConverter.cc:281
>#1 0x00913ce0 in StreamCore::matchInput (this=0x88d29e0) at
>../StreamCore.cc:1153
>#2 0x00916667 in StreamCore::readCallback (this=0x88d29e0,
>status=StreamIoEnd, input=0x88d384c, size=7) at ../StreamCore.cc:1058
>#3 0x008ffc6b in AsynDriverInterface::readHandler (this=0x88d37d8) at
>../StreamBusInterface.h:112
>#4 0x0090100a in handleRequest (pasynUser=0x88ce90c) at
>../AsynDriverInterface.cc:1304
>#5 0x009509d3 in portThread (pport=0x888fb68) at
>../../asyn/asynDriver/asynManager.c:779
>#6 0x0064783f in start_routine (arg=0x88ce590) at
>../../../src/libCom/osi/os/posix/osdThread.c:320
>#7 0x0084b322 in start_thread () from
>/lib/i686/nosegneg/libpthread.so.0
>#8 0x0028a9ce in clone () from /lib/i686/nosegneg/libc.so.6
>(gdb)
>
>here is some parts of StreamFormatConverter.cc:
>int StdStringConverter::
>
>scanString(const StreamFormat& fmt, const char* input,
>
> char* value, size_t maxlen)
>
>{
>
> int length = -1;
>
> if (*input == '\0')
>
> {
>
> // match empty string
>
> value[0] = '\0';
>
> return 0;
>
> }
>
> if (fmt.flags & skip_flag)
>
> {
>
> /* can't use return value on vxWorks: sscanf with %* format
>
> returns -1 at end of string whether value is found or not */
>
> sscanf(input, fmt.info, &length);
>
> }
>
>
>
>======= At 2008-10-04, 20:04:51 you wrote: =======
>
>>You should enable core dumps and then run gdb on the core file to see
>where it crashed.
>>
>>________________________________
>>
>>From: [email protected] on behalf of Silver
>>Sent: Sat 10/4/2008 6:31 AM
>>To: tech-talk
>>Subject: problem of using Streamdevice
>>
>>
>>
>>hi, all:
>>
>> I am just trying Streamdevice driver by Franksen's suggestion. Seems
>it's a flexabile way of controlling our equipment. But I met some
>problems, the ioc will crash quickly after starting.
>>our streamdevice will response 8 bytes data in hex like "55 40 04 67 39
>47 be e3". in the data, "67 39 47 be" is a float's 4 bytes. other bytes
>are header or crc. So I write my protocol file like this:
>># example stream protocol file
>>
>>#Terminator = CR LF;
>>ReplyTimeout = 80000; # 10 sec is very long, for keyboard input
>>ReadTimeout = 1000; # also long for keyboard input
>>
>># note the field access
>>ai {
>> out 170 129 00 129;
>> in "%*3c%#R%*1c";
>>}
>>
>>my example.db is like this:
>># process this record to reload all stream protocols
>>
>>record (ai, "$(PREFIX):ai")
>>{
>> field (DESC, "An analog value")
>> field (DTYP, "stream")
>> field (INP, "@example.proto ai terminal")
>># field (PREC, "3")
>># field (LINR, "LINEAR")
>># field (ESLO, "0.000305180437934") # 20.0 / 0xffff
>># field (EOFF, "-10")
>># field (EGU, "V")
>> field (SCAN, ".5 second")
>>}
>>
>>my example.cmd file:
>>#!./streamApp
>>
>>dbLoadDatabase "O.Common/streamApp.dbd"
>>streamApp_registerRecordDeviceDriver
>>
>>#where can protocols be located?
>>epicsEnvSet "STREAM_PROTOCOL_PATH", ".:protocols:../protocols/"
>>
>>#setup the busses
>>
>>#example telnet style IP port setup
>>drvAsynIPPortConfigure "terminal", "192.168.1.103:4001"
>>#asynOctetSetInputEos "terminal",0,"\r\n"
>>#asynOctetSetOutputEos "terminal",0,"\r\n"
>>
>>#example VXI11 (GPIB via IP) port setup
>>#vxi11Configure "GPIB","ins023",1,5.0,"hpib"
>>
>>#load the records
>>dbLoadRecords "example.db","PREFIX=DZ"
>>#dbLoadRecords "scalcout.db","PREFIX=DZ"
>>
>>#lots! of debug output
>>#var streamDebug 1
>>
>>#enable debug output
>>var streamDebug 1
>>
>>iocInit
>>
>>my output of running ioc:
>>
>>~/testApp/StreamDevice-2-4/streamApp>./example.cmd
>>#!./streamApp
>>dbLoadDatabase "O.Common/streamApp.dbd"
>>streamApp_registerRecordDeviceDriver
>>#where can protocols be located?
>>epicsEnvSet "STREAM_PROTOCOL_PATH", ".:protocols:../protocols/"
>>#setup the busses
>>#example telnet style IP port setup
>>drvAsynIPPortConfigure "terminal", "192.168.1.103:4001"
>>#asynOctetSetInputEos "terminal",0,"\r\n"
>>#asynOctetSetOutputEos "terminal",0,"\r\n"
>>#example VXI11 (GPIB via IP) port setup
>>#vxi11Configure "GPIB","ins023",1,5.0,"hpib"
>>#load the records
>>dbLoadRecords "example.db","PREFIX=DZ"
>>#dbLoadRecords "scalcout.db","PREFIX=DZ"
>>#lots! of debug output
>>#var streamDebug 1
>>iocInit
>>Starting iocInit
>>#######################################################################
>#####
>>### EPICS IOC CORE built on Sep 27 2008
>>### EPICS R3.14.8.2 $R3-14-8-2$ $2006/01/06 15:55:13$
>>#######################################################################
>#####
>>iocInit: All initialization complete
>>#enable debug output
>>var streamDebug 1
>>epics>
>>epics> dbpr DZ:ai
>>ASG: DESC: An analog value DISA: 0
>
>>DISP: 0 DISV: 1 NAME: DZ:ai RVAL: 0
>
>>SEVR: NO_ALARM STAT: NO_ALARM SVAL: 0 TPRO: 0
>
>>VAL: 0.003662109375
>>epics> Segmentation fault
>>:~/testApp/StreamDevice-2-4/streamApp>
>>
>>Can anybody give me some hints? thanks a lot for your help.
>>
>>Best regards
>>Geyang 2008-10-04
>
>= = = = = = = = = = = = = = = = = = = =
>
>
>Best regards
>Geyang 2008-10-04
= = = = = = = = = = = = = = = = = = = =
Best regards
Geyang 2008-10-06
- References:
- RE: RE: problem of using Streamdevice Mark Rivers
- Navigate by Date:
- Prev:
RE: RE: problem of using Streamdevice Mark Rivers
- Next:
Process 'bo' on write? David Dudley
- Index:
1994
1995
1996
1997
1998
1999
2000
2001
2002
2003
2004
2005
2006
2007
<2008>
2009
2010
2011
2012
2013
2014
2015
2016
2017
2018
2019
2020
2021
2022
2023
2024
- Navigate by Thread:
- Prev:
RE: RE: problem of using Streamdevice Mark Rivers
- Next:
Re: problem of using Streamdevice Dirk Zimoch
- Index:
1994
1995
1996
1997
1998
1999
2000
2001
2002
2003
2004
2005
2006
2007
<2008>
2009
2010
2011
2012
2013
2014
2015
2016
2017
2018
2019
2020
2021
2022
2023
2024
|