1 INFO NodeMain [main]: NodeMain.main(): portalHost = null 1382 INFO NodeManager [main]: Starting NodeManager at 10/02/2015 22:27:15 GMT (1443824835398), version: $Name: $ 1384 INFO NodeManager [main]: Node IP: node2/134.89.36.2 2084 INFO NodeManager [main]: Node ID has been set to 1598 3134 INFO PortManager [main]: Found 14 configured ports in properties file 3199 INFO MOOSPortManager [main]: Found DPA at slot: 0 5109 INFO MOOSPortManager [main]: Found DPA at slot: 1 6749 INFO MOOSPortManager [main]: Found DPA at slot: 2 8349 INFO MOOSPortManager [main]: Found DPA at slot: 3 9947 INFO MOOSPortManager [main]: No DPA found at slot: 4 9951 INFO MOOSPortManager [main]: No DPA found at slot: 5 9986 INFO WDTManager [main]: WDTManager constructor 9987 INFO MOOSWDTManager [main]: MOOSWDTManager constructor 10051 INFO SleepManager [main]: SleepManager constructor 10054 INFO MOOSSleepManager [main]: MOOSSleepManager constructor 12175 INFO CommsLeaseListener [main]: CommsLeaseListener() complete 12243 INFO CpuLeaseSleepRollcallListener [main]: CpuLeaseSleepRollcallListener() constructor 12258 INFO CpuLease [main]: CpuLease() constructor 12260 INFO CpuLease [Thread-5]: CpuLease started 14230 ERROR NodeService [main]: Turbinator constructor failed: com.rbnb.sapi.SAPIException: Nesting java.net.ConnectException 14373 INFO MOOSNodeService [main]: Last MMC reset code: 1 14731 INFO NodeManager [main]: Starting registry... 14769 INFO NodeManager [main]: registry started. 14770 INFO NodeManager [main]: binding NodeService to rmi://localhost/node 15274 INFO NodeManager [main]: NodeService is bound to rmi://localhost/node 15417 INFO MOOSWDTManager [Thread-2]: WDTManager initializing watchdog timer 15431 INFO MOOSWDTManager [Thread-2]: Reboot due to hardware reset 15608 INFO PortManager [main]: Service jar not specified for port /dev/ttySX0 16535 INFO PortManager [main]: Starting service... 16809 INFO MOOSWDTManager [Thread-2]: WDTManager watchdog initialization successful 32274 INFO BaseInstrumentService [main]: initializeInstrument() for 33849 WARN StreamingSBE19 [main]: Did not receive expected confirmation prompt from command: MP 38884 INFO StreamingSBE19 [main]: Event detection disabled by attribute 38993 INFO BaseInstrumentService [main]: done with initializeInstrument() for 47192 INFO PortManager [main]: service started 47614 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 48422 INFO PortManager [main]: Starting service... 68534 INFO BaseInstrumentService [main]: initializeInstrument() for 68536 INFO WetLabsECO [main]: Initializing... 83928 INFO WetLabsECO [main]: Initializing completed 83929 INFO BaseInstrumentService [main]: done with initializeInstrument() for 92947 INFO PolledInstrumentService [main]: prepareToRun(): sampleMasterId = 1827 92950 INFO PolledInstrumentService [main]: id 1535 slaved to 1827 92968 INFO PortManager [main]: service started 92974 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 93005 INFO WetLabsECO [Thread-25]: TEST: ID=1535, trigger sample at 1443824927029 95005 INFO PortManager [main]: Starting service... 95429 INFO WetLabsECO [Thread-25]: TEST: ID=1535, got complete sample at + 1443824929453 156512 INFO BaseInstrumentService [main]: initializeInstrument() for 158548 INFO Aquadopp [main]: sendSoftBreak(): instrument in mode 2 164726 INFO BaseInstrumentService [main]: done with initializeInstrument() for 164833 INFO Aquadopp [main]: Retrieving Aquadopp state Metadata... 166817 INFO Aquadopp [main]: sendSoftBreak(): instrument in mode 2 174626 INFO PortManager [main]: service started 174634 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 175031 INFO PortManager [main]: Starting service... 176748 INFO Aquadopp [Thread-34]: sendSoftBreak(): instrument in mode 2 186294 INFO BaseInstrumentService [main]: initializeInstrument() for 191077 INFO BaseInstrumentService [main]: done with initializeInstrument() for 192951 INFO PolledInstrumentService [main]: prepareToRun(): sampleMasterId = 1535 192952 INFO PolledInstrumentService [main]: id 1524 slaved to 1535 192959 INFO PortManager [main]: service started 192990 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 192999 INFO AanderaaO2 [Thread-38]: TT: ID=1524, trigger sample at 1443825027023 194278 INFO PortManager [main]: Starting service... 230199 INFO StreamingWorkhorseADCP-0 [main]: getSerialParameters(): baud=9600 235824 INFO BaseInstrumentService [main]: initializeInstrument() for 235827 INFO StreamingWorkhorseADCP-1825 [main]: Initializing Workhorse 1825 235837 INFO StreamingWorkhorseADCP-1825 [main]: Instrument has been pre-configured; ignore configuration attributes 239285 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request TE? 239323 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 239367 INFO StreamingWorkhorseADCP-1825 [main]: TE response: TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 239368 INFO StreamingWorkhorseADCP-1825 [main]: getProperty(): response=TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 239605 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request CF? 239671 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 239717 INFO StreamingWorkhorseADCP-1825 [main]: initializeInstrument(): response = CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 239718 INFO StreamingWorkhorseADCP-1825 [main]: getProperty(): response=CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 239720 INFO StreamingWorkhorseADCP-1825 [main]: initializeInstrument(): property=11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) >, char 3=1 239722 INFO StreamingWorkhorseADCP-1825 [main]: initializeInstrument(): property char 3=1 239723 INFO StreamingWorkhorseADCP-1825 [main]: Start pinging 239912 INFO BaseInstrumentService [main]: done with initializeInstrument() for 243375 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WD? 243413 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 243955 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WF? 243993 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 244565 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WN? 244603 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 245134 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WP? 245173 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 245708 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WS? 245748 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 246274 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WV? 246321 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 246944 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request TE? 246983 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 247544 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request TP? 247583 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 248114 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request TS? 248153 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 248715 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request EA? 248753 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 249284 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request EB? 249323 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 249854 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request ED? 249893 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 250425 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request ES? 250463 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 250994 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request EX? 251033 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 251575 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request EZ? 251661 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 252196 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request CF? 252241 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 252795 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request RA? 252818 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 253335 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request RR? 253373 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 254295 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request RF? 254331 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 254895 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request CB? 254934 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 255525 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request PS0 255549 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 257405 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request PS3 257429 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 258735 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request RF 258772 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 259255 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request AC 259296 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 261523 INFO PortManager [main]: service started 261525 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 262693 INFO PortManager [main]: Starting service... 300200 INFO StreamingWorkhorseADCP-0 [main]: getSerialParameters(): baud=9600 310856 INFO BaseInstrumentService [main]: initializeInstrument() for 310859 INFO StreamingWorkhorseADCP-1828 [main]: Initializing Workhorse 1828 310871 INFO StreamingWorkhorseADCP-1828 [main]: Instrument has been pre-configured; ignore configuration attributes 314355 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request TE? 314395 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 314438 INFO StreamingWorkhorseADCP-1828 [main]: TE response: TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 314439 INFO StreamingWorkhorseADCP-1828 [main]: getProperty(): response=TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 314674 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request CF? 314713 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 314801 INFO StreamingWorkhorseADCP-1828 [main]: initializeInstrument(): response = CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 314802 INFO StreamingWorkhorseADCP-1828 [main]: getProperty(): response=CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 314805 INFO StreamingWorkhorseADCP-1828 [main]: initializeInstrument(): property=11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) >, char 3=1 314807 INFO StreamingWorkhorseADCP-1828 [main]: initializeInstrument(): property char 3=1 314808 INFO StreamingWorkhorseADCP-1828 [main]: Start pinging 315001 INFO BaseInstrumentService [main]: done with initializeInstrument() for 318545 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WD? 318583 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 319125 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WF? 319163 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 319695 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WN? 319772 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 320304 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WP? 320343 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 320876 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WS? 320923 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 321457 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WV? 321503 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 322116 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request TE? 322163 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 322735 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request TP? 322774 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 323304 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request TS? 323343 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 323914 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request EA? 323953 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 324485 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request EB? 324561 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 325095 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request ED? 325133 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 325664 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request ES? 325703 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 326285 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request EX? 326323 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 326874 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request EZ? 326911 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 327455 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request CF? 327493 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 328055 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request RA? 328078 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 328594 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request RR? 328633 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 329504 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request RF? 329541 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 330094 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request CB? 330136 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 330687 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request PS0 330717 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 332594 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request PS3 332619 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 333895 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request RF 333933 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 334415 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request AC 334453 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 336632 INFO PortManager [main]: service started 336635 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 337700 INFO PortManager [main]: Starting service... 375299 INFO StreamingWorkhorseADCP-0 [main]: getSerialParameters(): baud=9600 380936 INFO BaseInstrumentService [main]: initializeInstrument() for 380938 INFO StreamingWorkhorseADCP-1827 [main]: Initializing Workhorse 1827 380951 INFO StreamingWorkhorseADCP-1827 [main]: Instrument has been pre-configured; ignore configuration attributes 384435 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request TE? 384522 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 384568 INFO StreamingWorkhorseADCP-1827 [main]: TE response: TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 384569 INFO StreamingWorkhorseADCP-1827 [main]: getProperty(): response=TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 384804 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request CF? 384844 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 384889 INFO StreamingWorkhorseADCP-1827 [main]: initializeInstrument(): response = CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 384890 INFO StreamingWorkhorseADCP-1827 [main]: getProperty(): response=CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 384892 INFO StreamingWorkhorseADCP-1827 [main]: initializeInstrument(): property=11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) >, char 3=1 384894 INFO StreamingWorkhorseADCP-1827 [main]: initializeInstrument(): property char 3=1 384896 INFO StreamingWorkhorseADCP-1827 [main]: Start pinging 385083 INFO BaseInstrumentService [main]: done with initializeInstrument() for 388644 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request WD? 388684 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 389265 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request WF? 389303 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 389835 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request WN? 389874 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 390452 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request WP? 390498 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 391037 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request WS? 391086 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 391627 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request WV? 391677 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 392229 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request TE? 392280 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 392855 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request TP? 392894 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 393425 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request TS? 393464 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 394004 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request EA? 394047 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 394585 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request EB? 394623 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 395204 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request ED? 395244 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 395797 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request ES? 395846 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 396387 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request EX? 396437 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 397046 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request EZ? 397113 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 397694 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request CF? 397733 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 398275 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request RA? 398298 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 398814 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request RR? 398853 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 399724 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request RF? 399762 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 400305 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request CB? 400344 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 400896 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request PS0 400927 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 402825 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request PS3 402849 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 404210 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request RF 404260 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 404735 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: wrote request AC 404773 INFO StreamingWorkhorseADCP-1827 [main]: sendRequest: got echo response: 407079 INFO PortManager [main]: service started 407085 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 407315 INFO PortManager [main]: Service jar not specified for port /dev/ttySX8 407316 INFO PortManager [main]: Service jar not specified for port /dev/ttySX9 407317 INFO PortManager [main]: Service jar not specified for port /dev/ttySX10 407318 INFO PortManager [main]: Service jar not specified for port /dev/ttySX11 407696 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825241720 407795 INFO PortManager [main]: Starting service... 410101 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825244124 410322 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825244346 419278 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825253301 420536 INFO BaseInstrumentService [main]: initializeInstrument() for 421693 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825255717 421822 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825255846 421948 INFO BaseInstrumentService [main]: done with initializeInstrument() for 425518 INFO PolledInstrumentService [main]: prepareToRun(): sampleMasterId = -1 425520 INFO PolledInstrumentService [main]: id 1599 not slaved 425523 INFO PortManager [main]: service started 425526 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 425671 INFO PortManager [main]: Service jar not specified for port /dev/ttySA2 425721 INFO CommsSchedulerTask [Thread-70]: CommsSchedulerTask.run(): Oct 2, 2015 10:34:19 PM 425992 INFO CommsLeaseListener [Thread-70]: Calling SyncProcessRunner("echo ethOn"); attempt #0 426077 INFO ThreadUtility [Thread-73]: ThreadGroup "main" includes about 37 threads 426245 INFO CommsLeaseListener [Thread-70]: 428180 INFO ThreadUtility [Thread-73]: thread: "Thread-73" alive thread: "Thread-71" alive thread: "Thread-70" alive thread: "Thread-69" alive thread: "Thread-66" alive daemon thread: "Thread-65" alive thread: "Thread-57" alive daemon thread: "Thread-56" alive thread: "Thread-48" alive daemon thread: "Thread-47" alive thread: "Thread-40" alive daemon thread: "Thread-39" alive thread: "Thread-38" alive thread: "Thread-35" alive daemon thread: "Thread-34" alive thread: "Thread-27" alive daemon thread: "Thread-26" alive thread: "Thread-25" alive thread: "Thread-22" alive thread: "Thread-19" alive daemon thread: "Thread-18" alive thread: "Thread-10" alive daemon thread: "RMI-Leaser" alive daemon thread: "RMI-ConnectionGC" alive daemon thread: "RMI-Accept:1099" alive daemon thread: "Thread-8" alive thread: "Thread-6" alive thread: "Thread-5" alive thread: "Thread-4" alive thread: "RMI-Accept:1025" alive daemon thread: "RMI-DGC" alive thread: "RMI-Ref GC" alive daemon thread: "Thread-3" alive thread: "Thread-2" alive thread: "Thread-1" alive thread: "main" alive 428271 INFO NodeManager [main]: NodeManager "node" started. 430152 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825264176 432640 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825266664 432720 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825266743 438365 INFO CommsLeaseListener [Thread-75]: SyncProcessRunner.exec("echo ethOff"), connect time = 12 438406 INFO CommsLeaseListener [Thread-75]: 440769 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825274792 443161 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825277185 443228 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825277252 451573 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825285597 453971 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825287995 454042 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825288065 462449 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825296473 464885 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825298865 465105 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825299129 473170 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825307194 475583 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825309607 475759 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825309783 483970 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825317994 486417 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825320441 486508 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825320531 494745 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825328769 497198 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825331222 497316 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825331340 505592 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825339615 507980 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825342004 508052 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825342076 515569 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825349593 517961 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825351985 518031 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825352055 526372 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825360396 528760 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825362784 528835 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825362859 537210 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825371233 539649 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825373673 539818 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825373841 547941 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825381965 550381 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825384405 550458 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825384482 558750 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825392774 561163 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825395187 561243 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825395267 569564 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825403588 571983 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825406007 572069 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825406093 580404 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825414428 582800 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825416824 582874 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825416898 591236 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825425260 593631 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825427655 593699 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825427723 601350 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825435374 603740 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825437764 603827 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825437851 612071 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825446095 614470 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825448494 614538 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825448562 622757 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825456780 625160 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825459184 625307 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825459330 633553 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825467577 635977 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825470001 636293 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825470317 644382 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825478406 646803 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825480827 646942 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825480966 655196 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825489220 657591 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825491614 657662 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825491685 666117 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825500141 668511 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825502535 668672 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825502696 676971 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825510995 679360 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825513384 679519 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825513542 686789 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825520813 689198 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825523221 689277 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825523301 697566 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825531590 699960 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825533984 700071 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825534094 708376 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825542399 710793 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825544817 710932 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825544956 719168 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825553192 721591 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825555615 721729 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825555753 729967 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825563991 732417 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825566441 732567 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825566591 740970 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825574994 743360 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825577384 743477 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825577501 751591 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825585615 753981 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825588004 754103 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825588127 762466 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825596490 764861 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825598885 764949 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825598973 772455 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825606479 774910 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825608934 774978 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825609002 783199 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825617223 785613 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825619637 785751 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825619775 793984 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825628008 796470 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825630494 796549 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825630573 804783 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825638807 807248 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825641272 807318 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825641342 815643 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825649667 818041 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825652065 818108 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825652132 826412 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825660436 828811 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825662834 828878 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825662902 837231 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825671255 839621 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825673645 839691 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825673714 847991 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825682014 850427 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825684451 850509 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825684533 857990 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825692014 860431 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825694455 860500 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825694524 868872 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825702895 871283 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825705306 871363 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825705387 879612 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825713636 882033 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825716057 882121 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825716145 890445 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825724469 892841 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825726865 892922 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825726946 901209 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825735233 903600 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825737624 903759 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825737782 912022 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825746046 914421 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825748444 914497 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825748521 922811 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825756834 925210 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825759234 925282 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825759306 933597 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825767621 936077 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825770101 936168 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825770191 943622 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825777646 946033 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825780057 946113 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825780136 954576 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825788600 956993 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825791017 957122 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825791145 965222 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825799246 967611 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825801635 967682 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825801706 976030 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825810053 978421 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825812445 978628 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825812652 986817 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825820841 989348 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825823372 989421 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825823444 997595 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825831619 999991 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825834015 1000058 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825834082 1008403 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825842427 1010823 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825844847 1010906 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825844927 1019206 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825853230 1021626 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825855648 1021708 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825855731 1025846 INFO CommsSchedulerTask [Thread-70]: CommsSchedulerTask.run(): Oct 2, 2015 10:44:19 PM 1026405 INFO CommsLeaseListener [Thread-70]: Calling SyncProcessRunner("echo ethOn"); attempt #0 1026478 INFO CommsLeaseListener [Thread-70]: 1029201 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825863225 1031618 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825865642 1031709 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825865732 1037494 INFO CommsLeaseListener [Thread-127]: SyncProcessRunner.exec("echo ethOff"), connect time = 11 1037536 INFO CommsLeaseListener [Thread-127]: 1040020 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825874043 1042470 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825876494 1042599 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825876623 1050833 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825884856 1053230 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825887254 1053298 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825887322 1061637 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825895660 1064030 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825898054 1064107 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825898131 1072466 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825906490 1075001 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825909025 1075388 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825909412 1083201 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825917225 1085647 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825919670 1085811 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825919835 1094090 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825928114 1096503 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825930527 1096583 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825930606 1104868 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825938891 1107311 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825941335 1107382 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825941406 1114821 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825948844 1117269 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825951293 1117345 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825951369 1125624 INFO WetLabsECO [Thread-26]: TEST: ID=1535, trigger sample at 1443825959647 1128021 INFO WetLabsECO [Thread-26]: TEST: ID=1535, got complete sample at + 1443825962044 1128148 INFO AanderaaO2 [Thread-39]: TT: ID=1524, trigger sample at 1443825962172