2016/12/01 20:40:25 - currents01skq 3.13.0-24-generic #47-Ubuntu SMP Fri May 2 23:30:00 UTC 2014 x86_64 2016/12/01 20:40:26 - /dev/ttyUSB6 2016/12/01 20:40:26 - /dev/ttyUSB7 2016/12/01 20:40:26 - In CruiseSetup.init 2016/12/01 20:40:26 - About to run mainloop 2016/12/01 20:40:33 - Entering buildLoggers 2016/12/01 20:40:33 - >>>> C_ss enabled <<<<< 2016/12/01 20:40:33 - Leaving buildLoggers 2016/12/01 20:40:33 - Start Cruise 2016/12/01 20:40:36 - enter StartLogging, resume = 2016/12/01 20:40:36 - 0 2016/12/01 20:40:39 - TS? 2016/12/01 20:40:39 - TS161201204039 2016/12/01 20:40:39 - CR1 2016/12/01 20:40:39 - WD 111 00 0000 2016/12/01 20:40:39 - ND 111 00 0000 2016/12/01 20:40:39 - EA45000 2016/12/01 20:40:40 - NP1 2016/12/01 20:40:40 - NN60 2016/12/01 20:40:40 - NS800 2016/12/01 20:40:40 - NF400 2016/12/01 20:40:40 - WP1 2016/12/01 20:40:40 - WN80 2016/12/01 20:40:40 - WS400 2016/12/01 20:40:40 - WF400 2016/12/01 20:40:40 - BP0 2016/12/01 20:40:40 - BX5000 2016/12/01 20:40:40 - TP00:01.10 2016/12/01 20:40:40 - CX0,0 2016/12/01 20:40:40 - B? 2016/12/01 20:40:41 - N? 2016/12/01 20:40:42 - W? 2016/12/01 20:40:43 - E? 2016/12/01 20:40:46 - C? 2016/12/01 20:40:47 - T? 2016/12/01 20:40:48 - PS0 2016/12/01 20:40:49 - In os_check_D_params 2016/12/01 20:40:49 - in os_check_D_params: 111000000 2016/12/01 20:40:49 - in os_check_D_params: 111000000 2016/12/01 20:40:49 - CF11110 2016/12/01 20:41:01 - term 1 ADCP os75 startup failure 2016/12/01 20:41:01 - Traceback (most recent call last): 2016/12/01 20:41:01 - File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 356, in StartLogging 2016/12/01 20:41:01 - term.start_binary(cmdlist) 2016/12/01 20:41:01 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 234, in start_binary 2016/12/01 20:41:01 - self.wakeup() 2016/12/01 20:41:01 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup 2016/12/01 20:41:01 - self.slow_wakeup() 2016/12/01 20:41:01 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 126, in slow_wakeup 2016/12/01 20:41:01 - self.waitfor(b'>', timeout=3, quiet=0.5) 2016/12/01 20:41:01 - File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 286, in waitfor 2016/12/01 20:41:01 - raise Timeout 2016/12/01 20:41:01 - Timeout 2016/12/01 20:41:01 - Entering Loggers.start_logging 2016/12/01 20:41:01 - /usr/local/bin/ser_bin -y 2016 -P ttyUSB6 -b 38400 -d /home/data/jtest02/raw/os150 -i /tmp/SerialLogger/inpipe.ttyUSB6 -o /tmp/SerialLogger/outpipe.ttyUSB6 -T 1480624861 -f skq -F -m 1 -H 2 -e raw -rlE -c -O -I -Z tcp://127.0.0.1:38010 2> /tmp/stderr.ttyUSB6 & 2016/12/01 20:41:02 - /usr/local/bin/ser_bin -y 2016 -P ttyUSB7 -b 38400 -d /home/data/jtest02/raw/os75 -i /tmp/SerialLogger/inpipe.ttyUSB7 -o /tmp/SerialLogger/outpipe.ttyUSB7 -T 1480624861 -f skq -F -m 1 -H 2 -e raw -rlE -c -O -I 2> /tmp/stderr.ttyUSB7 & 2016/12/01 20:41:02 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB0 -b 9600 -d /home/data/jtest02/raw/seapath -i /tmp/SerialLogger/inpipe.ttyUSB0 -o /tmp/SerialLogger/outpipe.ttyUSB0 -T 1480624861 -f skq -F -m 1 -H 2 -e sea -tc '$GPGGA' '$PSXN,20' '$PSXN,23' '$GPHDT' 2> /tmp/stderr.ttyUSB0 & 2016/12/01 20:41:02 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB1 -b 9600 -d /home/data/jtest02/raw/cnav -i /tmp/SerialLogger/inpipe.ttyUSB1 -o /tmp/SerialLogger/outpipe.ttyUSB1 -T 1480624861 -f skq -F -m 1 -H 2 -e gps -tc '' 2> /tmp/stderr.ttyUSB1 & 2016/12/01 20:41:02 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB2 -b 4800 -d /home/data/jtest02/raw/gyro1 -i /tmp/SerialLogger/inpipe.ttyUSB2 -o /tmp/SerialLogger/outpipe.ttyUSB2 -T 1480624861 -f skq -F -m 1 -H 2 -e hdg -tc -s9 '$HEHDT' 2> /tmp/stderr.ttyUSB2 & 2016/12/01 20:41:03 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB3 -b 4800 -d /home/data/jtest02/raw/gyro2 -i /tmp/SerialLogger/inpipe.ttyUSB3 -o /tmp/SerialLogger/outpipe.ttyUSB3 -T 1480624861 -f skq -F -m 1 -H 2 -e hdg -tc -s9 '$HEHDT' 2> /tmp/stderr.ttyUSB3 & 2016/12/01 20:41:03 - Leaving Loggers.start_logging 2016/12/01 20:41:03 - Updated SVs_present from SVs and wrote cmds 2016/12/01 20:41:03 - 0 2016/12/01 20:41:03 - Updated SVs_present from SVs and wrote cmds 2016/12/01 20:41:03 - 1 2016/12/01 20:41:03 - Running /usr/local/currents/bin/DAS_while_logging.py 2016/12/01 20:41:03 - Exiting StartLogging 2016/12/02 16:58:26 - Entering StopLogging 2016/12/02 16:58:30 - Loggers.check_stop_logging: all log processes ended 2016/12/02 16:58:34 - TS? 2016/12/02 16:58:46 - Wakeup of os75 timed out. 2016/12/02 16:58:46 - Removed /home/adcp/flags/DAS.logging 2016/12/02 16:58:46 - Exiting StopLogging 2016/12/02 16:59:06 - Ready to destroy_loggers. 2016/12/02 16:59:06 - After destroy_loggers. 2016/12/02 16:59:06 - cp -au /home/adcp/log/* /home/data/jtest02/raw/log/ 2016/12/02 16:59:06 - End Cruise 2016/12/02 17:00:01 - adcptree.py /home/data/skq201616T/proc/os150nb -d uhdas --configpath /home/data/skq201616T/raw/config --cruisename skq201616T 2016/12/02 17:00:01 - 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/skq201616T/proc/os150nb/adcpdb making directory /home/data/skq201616T/proc/os150nb/cal making directory /home/data/skq201616T/proc/os150nb/cal/watertrk making directory /home/data/skq201616T/proc/os150nb/cal/botmtrk making directory /home/data/skq201616T/proc/os150nb/cal/heading making directory /home/data/skq201616T/proc/os150nb/cal/rotate making directory /home/data/skq201616T/proc/os150nb/contour making directory /home/data/skq201616T/proc/os150nb/edit making directory /home/data/skq201616T/proc/os150nb/grid making directory /home/data/skq201616T/proc/os150nb/load making directory /home/data/skq201616T/proc/os150nb/nav making directory /home/data/skq201616T/proc/os150nb/quality making directory /home/data/skq201616T/proc/os150nb/ping making directory /home/data/skq201616T/proc/os150nb/scan making directory /home/data/skq201616T/proc/os150nb/stick making directory /home/data/skq201616T/proc/os150nb/vector - copying additional files for data type uhdas - config files for raw processing are in /home/data/skq201616T/proc/os150nb/config copying config files using this wildcard expansion: /home/data/skq201616T/raw/config/skq201616T* 2016/12/02 17:00:01 - adcptree.py /home/data/skq201616T/proc/os150bb -d uhdas --configpath /home/data/skq201616T/raw/config --cruisename skq201616T 2016/12/02 17:00:01 - 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/skq201616T/proc/os150bb/adcpdb making directory /home/data/skq201616T/proc/os150bb/cal making directory /home/data/skq201616T/proc/os150bb/cal/watertrk making directory /home/data/skq201616T/proc/os150bb/cal/botmtrk making directory /home/data/skq201616T/proc/os150bb/cal/heading making directory /home/data/skq201616T/proc/os150bb/cal/rotate making directory /home/data/skq201616T/proc/os150bb/contour making directory /home/data/skq201616T/proc/os150bb/edit making directory /home/data/skq201616T/proc/os150bb/grid making directory /home/data/skq201616T/proc/os150bb/load making directory /home/data/skq201616T/proc/os150bb/nav making directory /home/data/skq201616T/proc/os150bb/quality making directory /home/data/skq201616T/proc/os150bb/ping making directory /home/data/skq201616T/proc/os150bb/scan making directory /home/data/skq201616T/proc/os150bb/stick making directory /home/data/skq201616T/proc/os150bb/vector - copying additional files for data type uhdas - config files for raw processing are in /home/data/skq201616T/proc/os150bb/config copying config files using this wildcard expansion: /home/data/skq201616T/raw/config/skq201616T* 2016/12/02 17:00:01 - adcptree.py /home/data/skq201616T/proc/os75nb -d uhdas --configpath /home/data/skq201616T/raw/config --cruisename skq201616T 2016/12/02 17:00:01 - 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/skq201616T/proc/os75nb/adcpdb making directory /home/data/skq201616T/proc/os75nb/cal making directory /home/data/skq201616T/proc/os75nb/cal/watertrk making directory /home/data/skq201616T/proc/os75nb/cal/botmtrk making directory /home/data/skq201616T/proc/os75nb/cal/heading making directory /home/data/skq201616T/proc/os75nb/cal/rotate making directory /home/data/skq201616T/proc/os75nb/contour making directory /home/data/skq201616T/proc/os75nb/edit making directory /home/data/skq201616T/proc/os75nb/grid making directory /home/data/skq201616T/proc/os75nb/load making directory /home/data/skq201616T/proc/os75nb/nav making directory /home/data/skq201616T/proc/os75nb/quality making directory /home/data/skq201616T/proc/os75nb/ping making directory /home/data/skq201616T/proc/os75nb/scan making directory /home/data/skq201616T/proc/os75nb/stick making directory /home/data/skq201616T/proc/os75nb/vector - copying additional files for data type uhdas - config files for raw processing are in /home/data/skq201616T/proc/os75nb/config copying config files using this wildcard expansion: /home/data/skq201616T/raw/config/skq201616T* 2016/12/02 17:00:01 - adcptree.py /home/data/skq201616T/proc/os75bb -d uhdas --configpath /home/data/skq201616T/raw/config --cruisename skq201616T 2016/12/02 17:00:01 - 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/skq201616T/proc/os75bb/adcpdb making directory /home/data/skq201616T/proc/os75bb/cal making directory /home/data/skq201616T/proc/os75bb/cal/watertrk making directory /home/data/skq201616T/proc/os75bb/cal/botmtrk making directory /home/data/skq201616T/proc/os75bb/cal/heading making directory /home/data/skq201616T/proc/os75bb/cal/rotate making directory /home/data/skq201616T/proc/os75bb/contour making directory /home/data/skq201616T/proc/os75bb/edit making directory /home/data/skq201616T/proc/os75bb/grid making directory /home/data/skq201616T/proc/os75bb/load making directory /home/data/skq201616T/proc/os75bb/nav making directory /home/data/skq201616T/proc/os75bb/quality making directory /home/data/skq201616T/proc/os75bb/ping making directory /home/data/skq201616T/proc/os75bb/scan making directory /home/data/skq201616T/proc/os75bb/stick making directory /home/data/skq201616T/proc/os75bb/vector - copying additional files for data type uhdas - config files for raw processing are in /home/data/skq201616T/proc/os75bb/config copying config files using this wildcard expansion: /home/data/skq201616T/raw/config/skq201616T* 2016/12/02 17:00:03 - Entering buildLoggers 2016/12/02 17:00:03 - Created output directory with mode 775 2016/12/02 17:00:03 - Created output directory with mode 775 2016/12/02 17:00:03 - Created output directory with mode 775 2016/12/02 17:00:03 - Created output directory with mode 775 2016/12/02 17:00:03 - Created output directory with mode 775 2016/12/02 17:00:03 - Created output directory with mode 775 2016/12/02 17:00:03 - >>>> C_ss enabled <<<<< 2016/12/02 17:00:03 - Leaving buildLoggers 2016/12/02 17:00:03 - Start Cruise 2016/12/02 17:00:23 - enter StartLogging, resume = 2016/12/02 17:00:23 - 0 2016/12/02 17:00:27 - TS? 2016/12/02 17:00:27 - TS161202170027 2016/12/02 17:00:27 - CR1 2016/12/02 17:00:28 - WD 111 00 0000 2016/12/02 17:00:28 - ND 111 00 0000 2016/12/02 17:00:28 - EA45000 2016/12/02 17:00:28 - NP1 2016/12/02 17:00:28 - NN60 2016/12/02 17:00:28 - NS800 2016/12/02 17:00:28 - NF400 2016/12/02 17:00:28 - WP1 2016/12/02 17:00:28 - WN80 2016/12/02 17:00:28 - WS400 2016/12/02 17:00:28 - WF400 2016/12/02 17:00:28 - BP0 2016/12/02 17:00:28 - BX5000 2016/12/02 17:00:28 - TP00:01.10 2016/12/02 17:00:28 - CX0,0 2016/12/02 17:00:28 - B? 2016/12/02 17:00:29 - N? 2016/12/02 17:00:30 - W? 2016/12/02 17:00:32 - E? 2016/12/02 17:00:34 - C? 2016/12/02 17:00:36 - T? 2016/12/02 17:00:36 - PS0 2016/12/02 17:00:37 - In os_check_D_params 2016/12/02 17:00:37 - in os_check_D_params: 111000000 2016/12/02 17:00:37 - in os_check_D_params: 111000000 2016/12/02 17:00:37 - CF11110 2016/12/02 17:00:38 - Entering Loggers.start_logging 2016/12/02 17:00:38 - /usr/local/bin/ser_bin -y 2016 -P ttyUSB6 -b 38400 -d /home/data/skq201616T/raw/os150 -i /tmp/SerialLogger/inpipe.ttyUSB6 -o /tmp/SerialLogger/outpipe.ttyUSB6 -T 1480698038 -f skq -F -m 1 -H 2 -e raw -rlE -c -O -I -Z tcp://127.0.0.1:38010 2> /tmp/stderr.ttyUSB6 & 2016/12/02 17:00:38 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB0 -b 9600 -d /home/data/skq201616T/raw/seapath -i /tmp/SerialLogger/inpipe.ttyUSB0 -o /tmp/SerialLogger/outpipe.ttyUSB0 -T 1480698038 -f skq -F -m 1 -H 2 -e sea -tc '$GPGGA' '$PSXN,20' '$PSXN,23' '$GPHDT' 2> /tmp/stderr.ttyUSB0 & 2016/12/02 17:00:39 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB1 -b 9600 -d /home/data/skq201616T/raw/cnav -i /tmp/SerialLogger/inpipe.ttyUSB1 -o /tmp/SerialLogger/outpipe.ttyUSB1 -T 1480698038 -f skq -F -m 1 -H 2 -e gps -tc '' 2> /tmp/stderr.ttyUSB1 & 2016/12/02 17:00:39 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB2 -b 4800 -d /home/data/skq201616T/raw/gyro1 -i /tmp/SerialLogger/inpipe.ttyUSB2 -o /tmp/SerialLogger/outpipe.ttyUSB2 -T 1480698038 -f skq -F -m 1 -H 2 -e hdg -tc -s9 '$HEHDT' 2> /tmp/stderr.ttyUSB2 & 2016/12/02 17:00:39 - /usr/local/bin/ser_asc -y 2016 -P ttyUSB3 -b 4800 -d /home/data/skq201616T/raw/gyro2 -i /tmp/SerialLogger/inpipe.ttyUSB3 -o /tmp/SerialLogger/outpipe.ttyUSB3 -T 1480698038 -f skq -F -m 1 -H 2 -e hdg -tc -s9 '$HEHDT' 2> /tmp/stderr.ttyUSB3 & 2016/12/02 17:00:39 - Leaving Loggers.start_logging 2016/12/02 17:00:39 - Updated SVs_present from SVs and wrote cmds 2016/12/02 17:00:39 - 0 2016/12/02 17:00:39 - Updated SVs_present from SVs and wrote cmds 2016/12/02 17:00:39 - 1 2016/12/02 17:00:39 - Running /usr/local/currents/bin/DAS_while_logging.py 2016/12/02 17:00:39 - Exiting StartLogging 2016/12/16 23:46:04 - Entering StopLogging 2016/12/16 23:46:07 - Loggers.check_stop_logging: all log processes ended 2016/12/16 23:46:11 - TS? 2016/12/16 23:46:11 - Removed /home/adcp/flags/DAS.logging 2016/12/16 23:46:11 - Exiting StopLogging 2016/12/17 16:12:17 - Ready to destroy_loggers. 2016/12/17 16:12:17 - After destroy_loggers. 2016/12/17 16:12:17 - cp -au /home/adcp/log/* /home/data/skq201616T/raw/log/