2016/02/26 01:07:18 - currents1665 3.16.0-30-generic #40~14.04.1-Ubuntu SMP Thu Jan 15 17:43:14 UTC 2015 x86_64 2016/02/26 01:07:18 - /dev/ttyUSB4 2016/02/26 01:07:18 - /dev/ttyUSB5 2016/02/26 01:07:18 - In CruiseSetup.init 2016/02/26 01:07:18 - About to run mainloop 2016/02/26 01:08:04 - adcptree.py /home/data/EX1603_02/proc/wh300 -d uhdas --configpath /home/data/EX1603_02/raw/config --cruisename EX1603_02 2016/02/26 01:08:04 - 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 making directory /home/data/EX1603_02/proc/wh300/adcpdb making directory /home/data/EX1603_02/proc/wh300/cal making directory /home/data/EX1603_02/proc/wh300/cal/watertrk making directory /home/data/EX1603_02/proc/wh300/cal/botmtrk making directory /home/data/EX1603_02/proc/wh300/cal/heading making directory /home/data/EX1603_02/proc/wh300/cal/rotate making directory /home/data/EX1603_02/proc/wh300/contour making directory /home/data/EX1603_02/proc/wh300/edit making directory /home/data/EX1603_02/proc/wh300/grid making directory /home/data/EX1603_02/proc/wh300/load making directory /home/data/EX1603_02/proc/wh300/nav making directory /home/data/EX1603_02/proc/wh300/quality making directory /home/data/EX1603_02/proc/wh300/ping making directory /home/data/EX1603_02/proc/wh300/scan making directory /home/data/EX1603_02/proc/wh300/stick making directory /home/data/EX1603_02/proc/wh300/vector - copying additional files for data type uhdas - config files for raw processing are in /home/data/EX1603_02/proc/wh300/config copying config files using this wildcard expansion: /home/data/EX1603_02/raw/config/EX1603_02* 2016/02/26 01:08:04 - adcptree.py /home/data/EX1603_02/proc/os38bb -d uhdas --configpath /home/data/EX1603_02/raw/config --cruisename EX1603_02 2016/02/26 01:08:04 - 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 making directory /home/data/EX1603_02/proc/os38bb/adcpdb making directory /home/data/EX1603_02/proc/os38bb/cal making directory /home/data/EX1603_02/proc/os38bb/cal/watertrk making directory /home/data/EX1603_02/proc/os38bb/cal/botmtrk making directory /home/data/EX1603_02/proc/os38bb/cal/heading making directory /home/data/EX1603_02/proc/os38bb/cal/rotate making directory /home/data/EX1603_02/proc/os38bb/contour making directory /home/data/EX1603_02/proc/os38bb/edit making directory /home/data/EX1603_02/proc/os38bb/grid making directory /home/data/EX1603_02/proc/os38bb/load making directory /home/data/EX1603_02/proc/os38bb/nav making directory /home/data/EX1603_02/proc/os38bb/quality making directory /home/data/EX1603_02/proc/os38bb/ping making directory /home/data/EX1603_02/proc/os38bb/scan making directory /home/data/EX1603_02/proc/os38bb/stick making directory /home/data/EX1603_02/proc/os38bb/vector - copying additional files for data type uhdas - config files for raw processing are in /home/data/EX1603_02/proc/os38bb/config copying config files using this wildcard expansion: /home/data/EX1603_02/raw/config/EX1603_02* 2016/02/26 01:08:04 - adcptree.py /home/data/EX1603_02/proc/os38nb -d uhdas --configpath /home/data/EX1603_02/raw/config --cruisename EX1603_02 2016/02/26 01:08:04 - 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 making directory /home/data/EX1603_02/proc/os38nb/adcpdb making directory /home/data/EX1603_02/proc/os38nb/cal making directory /home/data/EX1603_02/proc/os38nb/cal/watertrk making directory /home/data/EX1603_02/proc/os38nb/cal/botmtrk making directory /home/data/EX1603_02/proc/os38nb/cal/heading making directory /home/data/EX1603_02/proc/os38nb/cal/rotate making directory /home/data/EX1603_02/proc/os38nb/contour making directory /home/data/EX1603_02/proc/os38nb/edit making directory /home/data/EX1603_02/proc/os38nb/grid making directory /home/data/EX1603_02/proc/os38nb/load making directory /home/data/EX1603_02/proc/os38nb/nav making directory /home/data/EX1603_02/proc/os38nb/quality making directory /home/data/EX1603_02/proc/os38nb/ping making directory /home/data/EX1603_02/proc/os38nb/scan making directory /home/data/EX1603_02/proc/os38nb/stick making directory /home/data/EX1603_02/proc/os38nb/vector - copying additional files for data type uhdas - config files for raw processing are in /home/data/EX1603_02/proc/os38nb/config copying config files using this wildcard expansion: /home/data/EX1603_02/raw/config/EX1603_02* 2016/02/26 01:08:05 - Entering buildLoggers 2016/02/26 01:08:05 - Created output directory with mode 775 2016/02/26 01:08:05 - Created output directory with mode 775 2016/02/26 01:08:05 - Created output directory with mode 775 2016/02/26 01:08:05 - Created output directory with mode 775 2016/02/26 01:08:05 - Created output directory with mode 775 2016/02/26 01:08:05 - >>>> C_ss enabled <<<<< 2016/02/26 01:08:05 - Leaving buildLoggers 2016/02/26 01:08:05 - Start Cruise 2016/02/26 01:08:26 - enter StartLogging, resume = 2016/02/26 01:08:26 - 0 2016/02/26 01:08:37 - term 0 ADCP wh300 startup failure 2016/02/26 01:08:37 - Traceback (most recent call last): 2016/02/26 01:08:37 - File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 356, in StartLogging 2016/02/26 01:08:37 - term.start_binary(cmdlist) 2016/02/26 01:08:37 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 234, in start_binary 2016/02/26 01:08:37 - self.wakeup() 2016/02/26 01:08:37 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup 2016/02/26 01:08:37 - self.slow_wakeup() 2016/02/26 01:08:37 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 126, in slow_wakeup 2016/02/26 01:08:37 - self.waitfor(b'>', timeout=3, quiet=0.5) 2016/02/26 01:08:37 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 286, in waitfor 2016/02/26 01:08:37 - raise Timeout 2016/02/26 01:08:37 - Timeout 2016/02/26 02:14:20 - enter StartLogging, resume = 2016/02/26 02:14:20 - 0 2016/02/26 02:14:23 - TS? 2016/02/26 02:14:23 - TS16/02/26, 02:14:23 2016/02/26 02:14:23 - CR1 2016/02/26 02:14:24 - CL0 2016/02/26 02:14:24 - WD 111 000 000 2016/02/26 02:14:24 - TE00:00:00.00 2016/02/26 02:14:24 - CF11110 2016/02/26 02:14:24 - EX00000 2016/02/26 02:14:24 - EZ1011101 2016/02/26 02:14:24 - CL0 2016/02/26 02:14:24 - WP1 2016/02/26 02:14:24 - WN70 2016/02/26 02:14:24 - WS200 2016/02/26 02:14:24 - WF600 2016/02/26 02:14:24 - BP0 2016/02/26 02:14:24 - BX2000 2016/02/26 02:14:24 - WB0 2016/02/26 02:14:24 - WV550 2016/02/26 02:14:24 - TP00:00.80 2016/02/26 02:14:24 - B? 2016/02/26 02:14:25 - W? 2016/02/26 02:14:26 - E? 2016/02/26 02:14:26 - C? 2016/02/26 02:14:27 - T? 2016/02/26 02:14:29 - PS0 2016/02/26 02:14:30 - In whbb_check_D_params 2016/02/26 02:14:30 - CF11110 2016/02/26 02:14:35 - TS? 2016/02/26 02:14:35 - TS160226021435 2016/02/26 02:14:35 - CR1 2016/02/26 02:14:36 - WD 111 00 0000 2016/02/26 02:14:36 - ND 111 00 0000 2016/02/26 02:14:36 - EA04500 2016/02/26 02:14:36 - NP1 2016/02/26 02:14:36 - NN60 2016/02/26 02:14:36 - NS2400 2016/02/26 02:14:36 - NF1600 2016/02/26 02:14:36 - WP1 2016/02/26 02:14:36 - WN80 2016/02/26 02:14:36 - WS1200 2016/02/26 02:14:36 - WF1600 2016/02/26 02:14:36 - BP0 2016/02/26 02:14:36 - BX10000 2016/02/26 02:14:36 - TP00:03.00 2016/02/26 02:14:36 - CX0,0 2016/02/26 02:14:36 - B? 2016/02/26 02:14:37 - N? 2016/02/26 02:14:38 - W? 2016/02/26 02:14:40 - E? 2016/02/26 02:14:42 - C? 2016/02/26 02:14:44 - T? 2016/02/26 02:14:44 - PS0 2016/02/26 02:14:45 - In os_check_D_params 2016/02/26 02:14:45 - in os_check_D_params: 111000000 2016/02/26 02:14:45 - in os_check_D_params: 111000000 2016/02/26 02:14:45 - CF11110 2016/02/26 02:14:46 - Entering Loggers.start_logging 2016/02/26 02:14:46 - /usr/local/bin/ser_bin -y 2016 -P ttyUSB4 -b 38400 -d /home/data/EX1603_02/raw/wh300 -i /tmp/SerialLogger/inpipe.ttyUSB4 -o /tmp/SerialLogger/outpipe.ttyUSB4 -T 1456452886 -f ex -F -m 1 -H 2 -e raw -rlE -c -O -I -Z tcp://127.0.0.1:38010 2> /tmp/stderr.ttyUSB4 & 2016/02/26 02:14:46 - /usr/local/bin/ser_bin -y 2016 -P ttyUSB5 -b 38400 -d /home/data/EX1603_02/raw/os38 -i /tmp/SerialLogger/inpipe.ttyUSB5 -o /tmp/SerialLogger/outpipe.ttyUSB5 -T 1456452886 -f ex -F -m 1 -H 2 -e raw -rlE -c -O -I 2> /tmp/stderr.ttyUSB5 & 2016/02/26 02:14:46 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB3 -b 9600 -d /home/data/EX1603_02/raw/cnav -i /tmp/SerialLogger/inpipe.ttyUSB3 -o /tmp/SerialLogger/outpipe.ttyUSB3 -T 1456452886 -f ex -F -m 1 -H 2 -e gps -tc '' 2> /tmp/stderr.ttyUSB3 & 2016/02/26 02:14:47 - /usr/local/bin/zmq_asc -y 2016 -Z tcp://127.0.0.1:38000 -d /home/data/EX1603_02/raw/posmv -i /tmp/SerialLogger/inpipe.tcp:--127.0.0.1:38000 -o /tmp/SerialLogger/outpipe.tcp:--127.0.0.1:38000 -T 1456452886 -f ex -F -m 1 -H 2 -e pmv '$GPGGA' '$PASHR' 2> /tmp/stderr.tcp:--127.0.0.1:38000 & 2016/02/26 02:14:47 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB0 -b 4800 -d /home/data/EX1603_02/raw/gyro -i /tmp/SerialLogger/inpipe.ttyUSB0 -o /tmp/SerialLogger/outpipe.ttyUSB0 -T 1456452886 -f ex -F -m 1 -H 2 -e hdg -tc -s5 '$HEHDT' 2> /tmp/stderr.ttyUSB0 & 2016/02/26 02:14:47 - Leaving Loggers.start_logging 2016/02/26 02:14:47 - Updated SVs_present from SVs and wrote cmds 2016/02/26 02:14:47 - 0 2016/02/26 02:14:47 - Updated SVs_present from SVs and wrote cmds 2016/02/26 02:14:47 - 1 2016/02/26 02:14:47 - Running /usr/local/currents/bin/DAS_while_logging.py 2016/02/26 02:14:47 - Exiting StartLogging 2016/02/26 02:37:59 - Entering StopLogging 2016/02/26 02:38:08 - Loggers.check_stop_logging: all log processes ended 2016/02/26 02:38:12 - TS? 2016/02/26 02:38:16 - TS? 2016/02/26 02:38:16 - Removed /home/adcp/flags/DAS.logging 2016/02/26 02:38:16 - Exiting StopLogging 2016/02/26 02:41:04 - enter StartLogging, resume = 2016/02/26 02:41:04 - 0 2016/02/26 02:41:08 - TS? 2016/02/26 02:41:08 - TS16/02/26, 02:41:08 2016/02/26 02:41:08 - CR1 2016/02/26 02:41:08 - CL0 2016/02/26 02:41:08 - WD 111 000 000 2016/02/26 02:41:08 - TE00:00:00.00 2016/02/26 02:41:08 - CF11110 2016/02/26 02:41:08 - EX00000 2016/02/26 02:41:08 - EZ1011101 2016/02/26 02:41:08 - CL0 2016/02/26 02:41:08 - WP1 2016/02/26 02:41:08 - WN70 2016/02/26 02:41:08 - WS200 2016/02/26 02:41:08 - WF600 2016/02/26 02:41:09 - BP0 2016/02/26 02:41:09 - BX2000 2016/02/26 02:41:09 - WB0 2016/02/26 02:41:09 - WV550 2016/02/26 02:41:09 - TP00:00.80 2016/02/26 02:41:09 - B? 2016/02/26 02:41:09 - W? 2016/02/26 02:41:10 - E? 2016/02/26 02:41:11 - C? 2016/02/26 02:41:12 - T? 2016/02/26 02:41:13 - PS0 2016/02/26 02:41:15 - In whbb_check_D_params 2016/02/26 02:41:15 - CF11110 2016/02/26 02:41:16 - Entering Loggers.start_logging 2016/02/26 02:41:16 - /usr/local/bin/ser_bin -y 2016 -P ttyUSB4 -b 38400 -d /home/data/EX1603_02/raw/wh300 -i /tmp/SerialLogger/inpipe.ttyUSB4 -o /tmp/SerialLogger/outpipe.ttyUSB4 -T 1456454476 -f ex -F -m 1 -H 2 -e raw -rlE -c -O -I -Z tcp://127.0.0.1:38010 2> /tmp/stderr.ttyUSB4 & 2016/02/26 02:41:16 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB3 -b 9600 -d /home/data/EX1603_02/raw/cnav -i /tmp/SerialLogger/inpipe.ttyUSB3 -o /tmp/SerialLogger/outpipe.ttyUSB3 -T 1456454476 -f ex -F -m 1 -H 2 -e gps -tc '' 2> /tmp/stderr.ttyUSB3 & 2016/02/26 02:41:16 - /usr/local/bin/zmq_asc -y 2016 -Z tcp://127.0.0.1:38000 -d /home/data/EX1603_02/raw/posmv -i /tmp/SerialLogger/inpipe.tcp:--127.0.0.1:38000 -o /tmp/SerialLogger/outpipe.tcp:--127.0.0.1:38000 -T 1456454476 -f ex -F -m 1 -H 2 -e pmv '$GPGGA' '$PASHR' 2> /tmp/stderr.tcp:--127.0.0.1:38000 & 2016/02/26 02:41:17 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB0 -b 4800 -d /home/data/EX1603_02/raw/gyro -i /tmp/SerialLogger/inpipe.ttyUSB0 -o /tmp/SerialLogger/outpipe.ttyUSB0 -T 1456454476 -f ex -F -m 1 -H 2 -e hdg -tc -s5 '$HEHDT' 2> /tmp/stderr.ttyUSB0 & 2016/02/26 02:41:17 - Leaving Loggers.start_logging 2016/02/26 02:41:17 - Updated SVs_present from SVs and wrote cmds 2016/02/26 02:41:17 - 0 2016/02/26 02:41:17 - Updated SVs_present from SVs and wrote cmds 2016/02/26 02:41:17 - 1 2016/02/26 02:41:17 - Running /usr/local/currents/bin/DAS_while_logging.py 2016/02/26 02:41:17 - Exiting StartLogging