2018/12/17 16:00:28 - currents01ws 4.8.0-36-generic #36~16.04.1-Ubuntu SMP Sun Feb 5 09:39:57 UTC 2017 x86_64 2018/12/17 16:00:28 - Error: BX 200.0 is out of range 2018/12/17 16:00:28 - Error: validation of commands from file /home/adcp/config/cmdfiles/wh600_default.cmd failed 2018/12/17 16:00:28 - /dev/ttyUSB2 2018/12/17 16:00:28 - /dev/ttyUSB3 2018/12/17 16:00:28 - In CruiseSetup.init 2018/12/17 16:00:28 - About to run mainloop 2018/12/17 16:00:45 - adcptree.py /home/data/WS18351_Kelble/proc/wh600 -d uhdas --configpath /home/data/WS18351_Kelble/raw/config --cruisename WS18351_Kelble 2018/12/17 16:00:45 - found adcp templates at /usr/local/lib/python2.7/dist-packages/pycurrents/adcp/templates otherdemo is /usr/local/lib/python2.7/dist-packages/pycurrents/adcp/templates/uhdas_template ** data type is uhdas - copying additional files for data type uhdas - config files for raw processing are in /home/data/WS18351_Kelble/proc/wh600/config copying config files using this wildcard expansion: /home/data/WS18351_Kelble/raw/config/WS18351_Kelble* 2018/12/17 16:00:45 - adcptree.py /home/data/WS18351_Kelble/proc/os75bb -d uhdas --configpath /home/data/WS18351_Kelble/raw/config --cruisename WS18351_Kelble 2018/12/17 16:00:45 - found adcp templates at /usr/local/lib/python2.7/dist-packages/pycurrents/adcp/templates otherdemo is /usr/local/lib/python2.7/dist-packages/pycurrents/adcp/templates/uhdas_template ** data type is uhdas - copying additional files for data type uhdas - config files for raw processing are in /home/data/WS18351_Kelble/proc/os75bb/config copying config files using this wildcard expansion: /home/data/WS18351_Kelble/raw/config/WS18351_Kelble* 2018/12/17 16:00:45 - adcptree.py /home/data/WS18351_Kelble/proc/os75nb -d uhdas --configpath /home/data/WS18351_Kelble/raw/config --cruisename WS18351_Kelble 2018/12/17 16:00:45 - found adcp templates at /usr/local/lib/python2.7/dist-packages/pycurrents/adcp/templates otherdemo is /usr/local/lib/python2.7/dist-packages/pycurrents/adcp/templates/uhdas_template ** data type is uhdas - copying additional files for data type uhdas - config files for raw processing are in /home/data/WS18351_Kelble/proc/os75nb/config copying config files using this wildcard expansion: /home/data/WS18351_Kelble/raw/config/WS18351_Kelble* 2018/12/17 16:00:45 - /bin/rm -Rf /home/adcp/www; uhdas_webgen.py -s ws --website /home/adcp/www 2018/12/17 16:00:47 - web page for Walton Smith found instruments: ['wh600', 'os75'] found sonars (instping): ['wh600', 'os75bb', 'os75nb'] found attitude devices: ['posmv'] 2018/12/17 16:00:48 - Entering buildLoggers 2018/12/17 16:00:48 - device: 2018/12/17 16:00:48 - ttyUSB0 2018/12/17 16:00:48 - -f ws -F -m 1 -H 2 -e raw -lE -c -O -I -Z tcp://127.0.0.1:38010 2018/12/17 16:00:48 - Created output directory with mode 775 2018/12/17 16:00:48 - device: 2018/12/17 16:00:48 - ttyUSB0 2018/12/17 16:00:48 - -f ws -F -m 1 -H 2 -e raw -lE -c -O -I 2018/12/17 16:00:48 - Created output directory with mode 775 2018/12/17 16:00:48 - device: 2018/12/17 16:00:48 - ttyUSB0 2018/12/17 16:00:48 - -f ws -F -m 1 -H 2 -e pmv -c -Y2 2018/12/17 16:00:48 - Created output directory with mode 775 2018/12/17 16:00:48 - device: 2018/12/17 16:00:48 - ttyUSB0 2018/12/17 16:00:48 - -f ws -F -m 1 -H 2 -e gps 2018/12/17 16:00:48 - Created output directory with mode 775 2018/12/17 16:00:48 - device: 2018/12/17 16:00:48 - ttyUSB0 2018/12/17 16:00:48 - -f ws -F -m 1 -H 2 -e hnc -s7 -c -Y2 2018/12/17 16:00:48 - Created output directory with mode 775 2018/12/17 16:00:48 - >>>> C_ss enabled <<<<< 2018/12/17 16:00:48 - Leaving buildLoggers 2018/12/17 16:00:48 - Start Cruise 2018/12/17 16:01:00 - enter StartLogging, resume = 2018/12/17 16:01:00 - 0 2018/12/17 16:01:03 - TS? 2018/12/17 16:01:03 - TS18/12/17, 16:01:03 2018/12/17 16:01:03 - CR1 2018/12/17 16:01:03 - CL0 2018/12/17 16:01:04 - WD 111 000 000 2018/12/17 16:01:04 - TE00:00:00.00 2018/12/17 16:01:04 - CF11110 2018/12/17 16:01:04 - EX00000 2018/12/17 16:01:04 - EZ1011101 2018/12/17 16:01:04 - ES0 2018/12/17 16:01:04 - WP1 2018/12/17 16:01:04 - WN70 2018/12/17 16:01:04 - WS100 2018/12/17 16:01:04 - WF100 2018/12/17 16:01:04 - BP0 2018/12/17 16:01:04 - BX500 2018/12/17 16:01:04 - WB0 2018/12/17 16:01:04 - WV550 2018/12/17 16:01:04 - TP00:00.70 2018/12/17 16:01:04 - B? 2018/12/17 16:01:05 - W? 2018/12/17 16:01:06 - E? 2018/12/17 16:01:06 - C? 2018/12/17 16:01:07 - T? 2018/12/17 16:01:09 - PS0 2018/12/17 16:01:10 - In whbb_check_D_params 2018/12/17 16:01:10 - CF11110 2018/12/17 16:01:23 - term 1 ADCP os75 startup failure 2018/12/17 16:01:23 - Traceback (most recent call last): 2018/12/17 16:01:23 - File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 356, in StartLogging 2018/12/17 16:01:23 - term.start_binary(cmdlist) 2018/12/17 16:01:23 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 234, in start_binary 2018/12/17 16:01:23 - self.wakeup() 2018/12/17 16:01:23 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup 2018/12/17 16:01:23 - self.slow_wakeup() 2018/12/17 16:01:23 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 126, in slow_wakeup 2018/12/17 16:01:23 - self.waitfor(b'>', timeout=3, quiet=0.5) 2018/12/17 16:01:23 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 286, in waitfor 2018/12/17 16:01:23 - raise Timeout 2018/12/17 16:01:23 - Timeout 2018/12/17 16:04:59 - TS? 2018/12/17 16:05:09 - enter StartLogging, resume = 2018/12/17 16:05:09 - 0 2018/12/17 16:05:12 - TS? 2018/12/17 16:05:12 - TS18/12/17, 16:05:12 2018/12/17 16:05:12 - CR1 2018/12/17 16:05:12 - CL0 2018/12/17 16:05:12 - WD 111 000 000 2018/12/17 16:05:12 - TE00:00:00.00 2018/12/17 16:05:12 - CF11110 2018/12/17 16:05:13 - EX00000 2018/12/17 16:05:13 - EZ1011101 2018/12/17 16:05:13 - ES0 2018/12/17 16:05:13 - WP1 2018/12/17 16:05:13 - WN70 2018/12/17 16:05:13 - WS100 2018/12/17 16:05:13 - WF100 2018/12/17 16:05:13 - BP0 2018/12/17 16:05:13 - BX500 2018/12/17 16:05:13 - WB0 2018/12/17 16:05:13 - WV550 2018/12/17 16:05:13 - TP00:00.70 2018/12/17 16:05:13 - B? 2018/12/17 16:05:13 - W? 2018/12/17 16:05:14 - E? 2018/12/17 16:05:15 - C? 2018/12/17 16:05:16 - T? 2018/12/17 16:05:18 - PS0 2018/12/17 16:05:19 - In whbb_check_D_params 2018/12/17 16:05:19 - CF11110 2018/12/17 16:05:24 - TS? 2018/12/17 16:05:24 - TS181217160524 2018/12/17 16:05:24 - CR1 2018/12/17 16:05:24 - WD 111 00 0000 2018/12/17 16:05:24 - ND 111 00 0000 2018/12/17 16:05:24 - EA04500 2018/12/17 16:05:24 - NP1 2018/12/17 16:05:24 - NN60 2018/12/17 16:05:24 - NS1600 2018/12/17 16:05:24 - NF800 2018/12/17 16:05:24 - WP1 2018/12/17 16:05:24 - WN80 2018/12/17 16:05:24 - WS800 2018/12/17 16:05:25 - WF800 2018/12/17 16:05:25 - BP0 2018/12/17 16:05:25 - BX10000 2018/12/17 16:05:25 - TP00:01.80 2018/12/17 16:05:25 - CX0,0 2018/12/17 16:05:25 - B? 2018/12/17 16:05:26 - N? 2018/12/17 16:05:27 - W? 2018/12/17 16:05:28 - E? 2018/12/17 16:05:30 - C? 2018/12/17 16:05:32 - T? 2018/12/17 16:05:33 - PS0 2018/12/17 16:05:33 - In os_check_D_params 2018/12/17 16:05:33 - in os_check_D_params: 111000000 2018/12/17 16:05:33 - in os_check_D_params: 111000000 2018/12/17 16:05:33 - CF11110 2018/12/17 16:05:34 - Entering Loggers.start_logging 2018/12/17 16:05:34 - /usr/local/bin/ser_bin -y 2018 -P ttyUSB2 -b 19200 -d /home/data/WS18351_Kelble/raw/wh600 -i /tmp/SerialLogger/inpipe.ttyUSB2 -o /tmp/SerialLogger/outpipe.ttyUSB2 -T 1545062734 -f ws -F -m 1 -H 2 -e raw -lE -c -O -I -Z tcp://127.0.0.1:38010 2> /tmp/stderr.ttyUSB2 & 2018/12/17 16:05:35 - /usr/local/bin/ser_bin -y 2018 -P ttyUSB3 -b 19200 -d /home/data/WS18351_Kelble/raw/os75 -i /tmp/SerialLogger/inpipe.ttyUSB3 -o /tmp/SerialLogger/outpipe.ttyUSB3 -T 1545062734 -f ws -F -m 1 -H 2 -e raw -lE -c -O -I 2> /tmp/stderr.ttyUSB3 & 2018/12/17 16:05:35 - /usr/local/bin/ser_asc -y 2018 -P ttyUSB1 -b 19200 -d /home/data/WS18351_Kelble/raw/posmv -i /tmp/SerialLogger/inpipe.ttyUSB1 -o /tmp/SerialLogger/outpipe.ttyUSB1 -T 1545062734 -f ws -F -m 1 -H 2 -e pmv -c -Y2 '$INGGA' '$PASHR' 2> /tmp/stderr.ttyUSB1 & 2018/12/17 16:05:35 - /usr/local/bin/zmq_asc -y 2018 -Z tcp://127.0.0.1:38000 -d /home/data/WS18351_Kelble/raw/gpsnav -i /tmp/SerialLogger/inpipe.tcp:--127.0.0.1:38000 -o /tmp/SerialLogger/outpipe.tcp:--127.0.0.1:38000 -T 1545062734 -f ws -F -m 1 -H 2 -e gps '$GPGGA' 2> /tmp/stderr.tcp:--127.0.0.1:38000 & 2018/12/17 16:05:35 - /usr/local/bin/ser_asc -y 2018 -P ttyUSB0 -b 4800 -d /home/data/WS18351_Kelble/raw/gyro -i /tmp/SerialLogger/inpipe.ttyUSB0 -o /tmp/SerialLogger/outpipe.ttyUSB0 -T 1545062734 -f ws -F -m 1 -H 2 -e hnc -s7 -c -Y2 '$HEHDT' 2> /tmp/stderr.ttyUSB0 & 2018/12/17 16:05:35 - Leaving Loggers.start_logging 2018/12/17 16:05:35 - Updated SVs_present from SVs and wrote cmds 2018/12/17 16:05:35 - 0 2018/12/17 16:05:35 - Updated SVs_present from SVs and wrote cmds 2018/12/17 16:05:35 - 1 2018/12/17 16:05:35 - Running /usr/local/currents/bin/DAS_while_logging.py 2018/12/17 16:05:35 - Exiting StartLogging 2018/12/19 11:52:08 - Entering StopLogging 2018/12/19 11:52:11 - Loggers.check_stop_logging: all log processes ended 2018/12/19 11:52:15 - TS? 2018/12/19 11:52:19 - TS? 2018/12/19 11:52:20 - Removed /home/adcp/flags/DAS.logging 2018/12/19 11:52:20 - Exiting StopLogging 2018/12/19 11:52:23 - Ready to destroy_loggers. 2018/12/19 11:52:23 - After destroy_loggers. 2018/12/19 11:52:23 - cp -au /home/adcp/log/* /home/data/WS18351_Kelble/raw/log/