0 INFO NodeMain [main]: NodeMain.main(): portalHost = null 1379 INFO NodeManager [main]: Starting NodeManager at 02/19/2016 00:23:09 GMT (1455841389720), version: $Name: $ 1381 INFO NodeManager [main]: Node IP: node2/134.89.36.2 2051 INFO NodeManager [main]: Node ID has been set to 1598 3264 INFO PortManager [main]: Found 14 configured ports in properties file 3328 INFO MOOSPortManager [main]: Found DPA at slot: 0 5209 INFO MOOSPortManager [main]: Found DPA at slot: 1 6818 INFO MOOSPortManager [main]: Found DPA at slot: 2 8408 INFO MOOSPortManager [main]: Found DPA at slot: 3 9996 INFO MOOSPortManager [main]: No DPA found at slot: 4 10000 INFO MOOSPortManager [main]: No DPA found at slot: 5 10035 INFO WDTManager [main]: WDTManager constructor 10037 INFO MOOSWDTManager [main]: MOOSWDTManager constructor 10100 INFO SleepManager [main]: SleepManager constructor 10104 INFO MOOSSleepManager [main]: MOOSSleepManager constructor 11794 INFO CommsLeaseListener [main]: CommsLeaseListener() complete 11860 INFO CpuLeaseSleepRollcallListener [main]: CpuLeaseSleepRollcallListener() constructor 11876 INFO CpuLease [main]: CpuLease() constructor 11878 INFO CpuLease [Thread-5]: CpuLease started 13735 ERROR NodeService [main]: Turbinator constructor failed: com.rbnb.sapi.SAPIException: Nesting java.net.ConnectException 13834 INFO MOOSNodeService [main]: Last MMC reset code: 6 14064 INFO NodeManager [main]: Starting registry... 14105 INFO NodeManager [main]: registry started. 14106 INFO NodeManager [main]: binding NodeService to rmi://localhost/node 14664 INFO NodeManager [main]: NodeService is bound to rmi://localhost/node 14689 INFO MOOSWDTManager [Thread-2]: WDTManager initializing watchdog timer 14758 ERROR MOOSWDTManager [Thread-2]: !!! Reboot due to watchdog reset !!! 14993 INFO PortManager [main]: Service jar not specified for port /dev/ttySX0 15916 INFO PortManager [main]: Starting service... 16125 INFO MOOSWDTManager [Thread-2]: WDTManager watchdog initialization successful 32104 INFO BaseInstrumentService [main]: initializeInstrument() for 33678 WARN StreamingSBE19 [main]: Did not receive expected confirmation prompt from command: MP 38714 INFO StreamingSBE19 [main]: Event detection disabled by attribute 38862 INFO BaseInstrumentService [main]: done with initializeInstrument() for 46978 INFO PortManager [main]: service started 47459 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 48176 INFO PortManager [main]: Starting service... 68816 INFO BaseInstrumentService [main]: initializeInstrument() for 68818 INFO WetLabsECO [main]: Initializing... 84278 INFO WetLabsECO [main]: Initializing completed 84279 INFO BaseInstrumentService [main]: done with initializeInstrument() for 93371 INFO PolledInstrumentService [main]: prepareToRun(): sampleMasterId = 1827 93373 INFO PolledInstrumentService [main]: id 1535 slaved to 1827 93391 INFO PortManager [main]: service started 93414 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 93430 INFO WetLabsECO [Thread-25]: TEST: ID=1535, trigger sample at 1455841481778 95445 INFO PortManager [main]: Starting service... 95804 INFO WetLabsECO [Thread-25]: TEST: ID=1535, got complete sample at + 1455841484152 156971 INFO BaseInstrumentService [main]: initializeInstrument() for 159068 INFO Aquadopp [main]: sendSoftBreak(): instrument in mode 2 165255 INFO BaseInstrumentService [main]: done with initializeInstrument() for 165363 INFO Aquadopp [main]: Retrieving Aquadopp state Metadata... 167347 INFO Aquadopp [main]: sendSoftBreak(): instrument in mode 2 175129 INFO PortManager [main]: service started 175134 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 175530 INFO PortManager [main]: Starting service... 177257 INFO Aquadopp [Thread-34]: sendSoftBreak(): instrument in mode 2 186694 INFO BaseInstrumentService [main]: initializeInstrument() for 188568 ERROR StreamingInstrumentService [Thread-34]: acquireFromStream(), tried startStreaming(): Instrument didn't acknowledge SR command 191627 INFO BaseInstrumentService [main]: done with initializeInstrument() for 193489 INFO PolledInstrumentService [main]: prepareToRun(): sampleMasterId = 1535 193490 INFO PolledInstrumentService [main]: id 1524 slaved to 1535 193497 INFO PortManager [main]: service started 193504 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 193516 INFO AanderaaO2 [Thread-38]: TT: ID=1524, trigger sample at 1455841581865 194547 INFO PortManager [main]: Starting service... 228666 INFO StreamingWorkhorseADCP-0 [main]: getSerialParameters(): baud=9600 234294 INFO BaseInstrumentService [main]: initializeInstrument() for 234296 INFO StreamingWorkhorseADCP-1825 [main]: Initializing Workhorse 1825 234307 INFO StreamingWorkhorseADCP-1825 [main]: Instrument has been pre-configured; ignore configuration attributes 237144 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request TE? 237183 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 237227 INFO StreamingWorkhorseADCP-1825 [main]: TE response: TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 237228 INFO StreamingWorkhorseADCP-1825 [main]: getProperty(): response=TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 237464 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request CF? 237503 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 237548 INFO StreamingWorkhorseADCP-1825 [main]: initializeInstrument(): response = CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 237549 INFO StreamingWorkhorseADCP-1825 [main]: getProperty(): response=CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 237551 INFO StreamingWorkhorseADCP-1825 [main]: initializeInstrument(): property=11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) >, char 3=1 237552 INFO StreamingWorkhorseADCP-1825 [main]: initializeInstrument(): property char 3=1 237554 INFO StreamingWorkhorseADCP-1825 [main]: Start pinging 237741 INFO BaseInstrumentService [main]: done with initializeInstrument() for 240755 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WD? 240802 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 241344 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WF? 241382 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 241914 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WN? 241952 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 242484 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WP? 242522 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 243054 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WS? 243092 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 243624 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request WV? 243662 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 244194 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request TE? 244280 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 244824 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request TP? 244862 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 245434 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request TS? 245472 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 246006 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request EA? 246052 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 246584 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request EB? 246623 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 247154 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request ED? 247193 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 247724 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request ES? 247762 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 248334 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request EX? 248372 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 248914 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request EZ? 248952 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 249522 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request CF? 249569 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 250094 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request RA? 250127 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 250684 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request RR? 250727 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 256414 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request RF? 256444 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 256994 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request CB? 257033 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 257574 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request PS0 257598 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 259494 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request PS3 259518 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 260834 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request RF 260870 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 261354 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: wrote request AC 261392 INFO StreamingWorkhorseADCP-1825 [main]: sendRequest: got echo response: 263691 INFO PortManager [main]: service started 263694 INFO NodeManager [Thread-1]: serviceInstalled(): invoke remote callbacks 265085 INFO PortManager [main]: Starting service... 301137 ERROR DeviceLog [main]: readLogData: data size mismatch 301138 ERROR DeviceLog [main]: bytes read from file: 1173 301139 ERROR DeviceLog [main]: dataSize in index entry: 1927 301209 INFO StreamingWorkhorseADCP-0 [main]: getSerialParameters(): baud=9600 311864 INFO BaseInstrumentService [main]: initializeInstrument() for 311867 INFO StreamingWorkhorseADCP-1828 [main]: Initializing Workhorse 1828 311877 INFO StreamingWorkhorseADCP-1828 [main]: Instrument has been pre-configured; ignore configuration attributes 314554 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request TE? 314594 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 314637 INFO StreamingWorkhorseADCP-1828 [main]: TE response: TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 314638 INFO StreamingWorkhorseADCP-1828 [main]: getProperty(): response=TE 00:00:10.00 --------- Time per Ensemble (hrs:min:sec.sec/100) > 314874 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request CF? 314914 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 314959 INFO StreamingWorkhorseADCP-1828 [main]: initializeInstrument(): response = CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 314960 INFO StreamingWorkhorseADCP-1828 [main]: getProperty(): response=CF = 11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) > 314962 INFO StreamingWorkhorseADCP-1828 [main]: initializeInstrument(): property=11111 --------------- Flow Ctrl (EnsCyc;PngCyc;Binry;Ser;Rec) >, char 3=1 314964 INFO StreamingWorkhorseADCP-1828 [main]: initializeInstrument(): property char 3=1 314965 INFO StreamingWorkhorseADCP-1828 [main]: Start pinging 315152 INFO BaseInstrumentService [main]: done with initializeInstrument() for 317964 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WD? 318008 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 318634 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WF? 318672 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 319204 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WN? 319243 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 319774 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WP? 319813 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 320344 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WS? 320383 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 320905 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request WV? 320943 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 321532 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request TE? 321579 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 322105 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request TP? 322143 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 322716 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request TS? 322763 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 323316 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request EA? 323363 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 323956 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request EB? 324009 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 324614 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request ED? 324653 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 325234 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request ES? 325273 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 325824 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request EX? 325860 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 326414 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request EZ? 326453 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 326994 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request CF? 327033 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 327574 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request RA? 327598 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 328114 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request RR? 328154 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 331744 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request RF? 331777 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 332326 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request CB? 332375 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 332936 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request PS0 332962 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 334864 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request PS3 334888 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 336184 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request RF 336216 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: 336704 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: wrote request AC 336742 INFO StreamingWorkhorseADCP-1828 [main]: sendRequest: got echo response: