2009/10/14 08:00:11 - currents 2.6.24-23-generic #1 SMP Mon Jan 26 00:13:11 UTC 2009 i686 2009/10/14 08:00:11 - tk_terminal 2009/10/14 08:00:11 - 08:00:11 2009/10/14 08:00:11 - In CruiseSetup.init 2009/10/14 08:00:17 - adcptree.py /home/data/RRdelete/proc/nb150 /home/currents/programs -d uhdas -i nb -n nb150 --configpath /home/adcp/uhdas_tmp --configbase RRdelete 2009/10/14 08:00:18 - uh_progs = /home/currents/programs otherdemo is /home/currents/programs/adcp_templates/uhdas_template making directory /home/data/RRdelete/proc/nb150/adcpdb making directory /home/data/RRdelete/proc/nb150/cal making directory /home/data/RRdelete/proc/nb150/cal/watertrk making directory /home/data/RRdelete/proc/nb150/cal/botmtrk making directory /home/data/RRdelete/proc/nb150/cal/heading making directory /home/data/RRdelete/proc/nb150/cal/rotate making directory /home/data/RRdelete/proc/nb150/contour making directory /home/data/RRdelete/proc/nb150/edit making directory /home/data/RRdelete/proc/nb150/grid making directory /home/data/RRdelete/proc/nb150/load making directory /home/data/RRdelete/proc/nb150/nav making directory /home/data/RRdelete/proc/nb150/quality making directory /home/data/RRdelete/proc/nb150/ping making directory /home/data/RRdelete/proc/nb150/scan making directory /home/data/RRdelete/proc/nb150/stick making directory /home/data/RRdelete/proc/nb150/vector ** data type is uhdas copying additional files for data type uhdas file exists: not copying vmadcp.def to /home/data/RRdelete/proc/nb150/load configbase RRdelete configpath /home/adcp/uhdas_tmp datatype uhdas demopath /home/currents/programs/adcp_templates/demo docpath /home/currents/programs/adcp_doc help 0 instclass nb pingtype nb procdir /home/data/RRdelete/proc/nb150 uh_progs /home/currents/programs varvals 0 verbose 0 config files for raw processing are in /home/data/RRdelete/proc/nb150/config ** UHDAS demo data are in /home/currents/programs/q_demos/uhdas/data (1) writing template text file for processing notes: /home/data/RRdelete/proc/nb150/template_rpt.txt (2) creating local web page for documentation open this file in your web browser: /home/data/RRdelete/proc/nb150/adcp_processing.html done. 2009/10/14 08:00:18 - Entering buildLoggers 2009/10/14 08:00:18 - Created output directory with mode 775 2009/10/14 08:00:18 - Created output directory with mode 775 2009/10/14 08:00:18 - Created output directory with mode 775 2009/10/14 08:00:18 - Created output directory with mode 775 2009/10/14 08:00:18 - Created output directory with mode 775 2009/10/14 08:00:18 - >>>> C_ss enabled <<<<< 2009/10/14 08:00:18 - Leaving buildLoggers 2009/10/14 08:00:18 - Start Cruise 2009/10/14 08:00:19 - enter StartLogging, resume = 2009/10/14 08:00:19 - 0 2009/10/14 08:00:19 - Commands for nb150: 2009/10/14 08:00:19 - ['Z', 'B009001', 'E0004020099', 'P00001', 'Q050', 'L3', 'I08', 'J080', 'FH00255', '?', 'F?'] 2009/10/14 08:00:21 - T10140800 2009/10/14 08:00:22 - Z 2009/10/14 08:00:23 - B009001 2009/10/14 08:00:24 - E0004020099 2009/10/14 08:00:25 - P00001 2009/10/14 08:00:25 - Q050 2009/10/14 08:00:26 - L3 2009/10/14 08:00:27 - I08 2009/10/14 08:00:27 - J080 2009/10/14 08:00:28 - FH00255 2009/10/14 08:00:29 - ? 2009/10/14 08:00:29 - F? 2009/10/14 08:00:30 - W064 2009/10/14 08:00:31 - Entering Loggers.start_logging 2009/10/14 08:00:31 - /usr/local/bin/ser_bin -y 2009 -P ttyS0 -b 19200 -d /home/data/RRdelete/raw/nb150 -i /tmp/SerialLogger/inpipe.ttyS0 -o /tmp/SerialLogger/outpipe.ttyS0 -T 1255507231 -f rr -F -m 1 -H 2 -e raw -rlE -c -I 2> /tmp/stderr.ttyS0 & 2009/10/14 08:00:31 - /usr/local/bin/ser_asc -y 2009 -P ttyR0 -b 4800 -d /home/data/RRdelete/raw/gpsnav -i /tmp/SerialLogger/inpipe.ttyR0 -o /tmp/SerialLogger/outpipe.ttyR0 -T 1255507231 -f rr -F -m 1 -H 2 -e gps -tc '$GPGGA' 2> /tmp/stderr.ttyR0 & 2009/10/14 08:00:31 - /usr/local/bin/ser_asc -y 2009 -P ttyR1 -b 9600 -d /home/data/RRdelete/raw/gyro -i /tmp/SerialLogger/inpipe.ttyR1 -o /tmp/SerialLogger/outpipe.ttyR1 -T 1255507231 -f rr -F -m 1 -H 2 -e hnc -t -s2 '$HEHDT' 2> /tmp/stderr.ttyR1 & 2009/10/14 08:00:31 - /usr/local/bin/ser_asc -y 2009 -P ttyR2 -b 9600 -d /home/data/RRdelete/raw/ashtech -i /tmp/SerialLogger/inpipe.ttyR2 -o /tmp/SerialLogger/outpipe.ttyR2 -T 1255507231 -f rr -F -m 1 -H 2 -e adu -tc '$GPGGA' '$PASHR,ATT' 2> /tmp/stderr.ttyR2 & 2009/10/14 08:00:32 - /usr/local/bin/ser_asc -y 2009 -P ttyR5 -b 9600 -d /home/data/RRdelete/raw/phins -i /tmp/SerialLogger/inpipe.ttyR5 -o /tmp/SerialLogger/outpipe.ttyR5 -T 1255507231 -f rr -F -m 1 -H 2 -e hdg -tc -s5 '$HEHDT' 2> /tmp/stderr.ttyR5 & 2009/10/14 08:00:32 - Leaving Loggers.start_logging 2009/10/14 08:00:32 - Updated SVs_present from SVs and wrote cmds 2009/10/14 08:00:32 - 0 2009/10/14 08:00:32 - Running /home/currents/programs/uhdas/scripts/DAS_while_logging.py 2009/10/14 08:00:32 - Exiting StartLogging 2009/10/15 01:59:10 - Entering StopLogging 2009/10/15 01:59:19 - Removed /home/adcp/flags/DAS.logging 2009/10/15 01:59:19 - Exiting StopLogging 2009/10/16 22:20:46 - Ready to destroy_loggers. 2009/10/16 22:20:46 - After destroy_loggers. 2009/10/16 22:20:46 - cp -au /home/adcp/log/* /home/data/RRdelete/raw/log/ 2009/10/16 22:20:46 - cp -au /home/adcp/config/* /home/data/RRdelete/raw/config/ 2009/10/16 22:20:46 - failed to remove file /home/adcp/config/RRdelete_proc.m 2009/10/16 22:20:46 - failed to remove file /home/adcp/config/RRdelete_cfg.m 2009/10/16 22:20:46 - End Cruise 2009/10/17 02:26:19 - adcptree.py /home/data/RR0913/proc/nb150 /home/currents/programs -d uhdas -i nb -n nb150 --configpath /home/adcp/uhdas_tmp --configbase RR0913 2009/10/17 02:26:19 - uh_progs = /home/currents/programs otherdemo is /home/currents/programs/adcp_templates/uhdas_template making directory /home/data/RR0913/proc/nb150/adcpdb making directory /home/data/RR0913/proc/nb150/cal making directory /home/data/RR0913/proc/nb150/cal/watertrk making directory /home/data/RR0913/proc/nb150/cal/botmtrk making directory /home/data/RR0913/proc/nb150/cal/heading making directory /home/data/RR0913/proc/nb150/cal/rotate making directory /home/data/RR0913/proc/nb150/contour making directory /home/data/RR0913/proc/nb150/edit making directory /home/data/RR0913/proc/nb150/grid making directory /home/data/RR0913/proc/nb150/load making directory /home/data/RR0913/proc/nb150/nav making directory /home/data/RR0913/proc/nb150/quality making directory /home/data/RR0913/proc/nb150/ping making directory /home/data/RR0913/proc/nb150/scan making directory /home/data/RR0913/proc/nb150/stick making directory /home/data/RR0913/proc/nb150/vector ** data type is uhdas copying additional files for data type uhdas file exists: not copying vmadcp.def to /home/data/RR0913/proc/nb150/load configbase RR0913 configpath /home/adcp/uhdas_tmp datatype uhdas demopath /home/currents/programs/adcp_templates/demo docpath /home/currents/programs/adcp_doc help 0 instclass nb pingtype nb procdir /home/data/RR0913/proc/nb150 uh_progs /home/currents/programs varvals 0 verbose 0 config files for raw processing are in /home/data/RR0913/proc/nb150/config ** UHDAS demo data are in /home/currents/programs/q_demos/uhdas/data (1) writing template text file for processing notes: /home/data/RR0913/proc/nb150/template_rpt.txt (2) creating local web page for documentation open this file in your web browser: /home/data/RR0913/proc/nb150/adcp_processing.html done. 2009/10/17 02:26:20 - Entering buildLoggers 2009/10/17 02:26:20 - Created output directory with mode 775 2009/10/17 02:26:20 - Created output directory with mode 775 2009/10/17 02:26:20 - Created output directory with mode 775 2009/10/17 02:26:20 - Created output directory with mode 775 2009/10/17 02:26:20 - Created output directory with mode 775 2009/10/17 02:26:20 - >>>> C_ss enabled <<<<< 2009/10/17 02:26:20 - Leaving buildLoggers 2009/10/17 02:26:20 - Start Cruise 2009/10/17 02:26:26 - enter StartLogging, resume = 2009/10/17 02:26:26 - 0 2009/10/17 02:26:26 - Commands for nb150: 2009/10/17 02:26:26 - ['Z', 'B009001', 'E0004020099', 'P00001', 'Q050', 'L3', 'I08', 'J080', 'FH00255', '?', 'F?'] 2009/10/17 02:26:28 - T10170226 2009/10/17 02:26:29 - Z 2009/10/17 02:26:30 - B009001 2009/10/17 02:26:31 - E0004020099 2009/10/17 02:26:32 - P00001 2009/10/17 02:26:32 - Q050 2009/10/17 02:26:33 - L3 2009/10/17 02:26:34 - I08 2009/10/17 02:26:34 - J080 2009/10/17 02:26:35 - FH00255 2009/10/17 02:26:36 - ? 2009/10/17 02:26:37 - F? 2009/10/17 02:26:37 - W064 2009/10/17 02:26:38 - Entering Loggers.start_logging 2009/10/17 02:26:38 - /usr/local/bin/ser_bin -y 2009 -P ttyS0 -b 19200 -d /home/data/RR0913/raw/nb150 -i /tmp/SerialLogger/inpipe.ttyS0 -o /tmp/SerialLogger/outpipe.ttyS0 -T 1255746398 -f rr -F -m 1 -H 2 -e raw -rlE -c -I 2> /tmp/stderr.ttyS0 & 2009/10/17 02:26:38 - /usr/local/bin/ser_asc -y 2009 -P ttyR0 -b 4800 -d /home/data/RR0913/raw/gpsnav -i /tmp/SerialLogger/inpipe.ttyR0 -o /tmp/SerialLogger/outpipe.ttyR0 -T 1255746398 -f rr -F -m 1 -H 2 -e gps -tc '$GPGGA' 2> /tmp/stderr.ttyR0 & 2009/10/17 02:26:38 - /usr/local/bin/ser_asc -y 2009 -P ttyR1 -b 9600 -d /home/data/RR0913/raw/gyro -i /tmp/SerialLogger/inpipe.ttyR1 -o /tmp/SerialLogger/outpipe.ttyR1 -T 1255746398 -f rr -F -m 1 -H 2 -e hnc -t -s2 '$HEHDT' 2> /tmp/stderr.ttyR1 & 2009/10/17 02:26:39 - /usr/local/bin/ser_asc -y 2009 -P ttyR2 -b 9600 -d /home/data/RR0913/raw/ashtech -i /tmp/SerialLogger/inpipe.ttyR2 -o /tmp/SerialLogger/outpipe.ttyR2 -T 1255746398 -f rr -F -m 1 -H 2 -e adu -tc '$GPGGA' '$PASHR,ATT' 2> /tmp/stderr.ttyR2 & 2009/10/17 02:26:39 - /usr/local/bin/ser_asc -y 2009 -P ttyR5 -b 9600 -d /home/data/RR0913/raw/phins -i /tmp/SerialLogger/inpipe.ttyR5 -o /tmp/SerialLogger/outpipe.ttyR5 -T 1255746398 -f rr -F -m 1 -H 2 -e hdg -tc -s5 '$HEHDT' 2> /tmp/stderr.ttyR5 & 2009/10/17 02:26:39 - Leaving Loggers.start_logging 2009/10/17 02:26:39 - Updated SVs_present from SVs and wrote cmds 2009/10/17 02:26:39 - 0 2009/10/17 02:26:39 - Running /home/currents/programs/uhdas/scripts/DAS_while_logging.py 2009/10/17 02:26:39 - Exiting StartLogging 2009/10/17 15:22:13 - Entering StopLogging 2009/10/17 15:22:21 - Removed /home/adcp/flags/DAS.logging 2009/10/17 15:22:21 - Exiting StopLogging 2009/10/19 09:10:04 - enter StartLogging, resume = 2009/10/19 09:10:04 - 0 2009/10/19 09:10:04 - Commands for nb150: 2009/10/19 09:10:04 - ['Z', 'B009001', 'E0004020099', 'P00001', 'Q050', 'L3', 'I08', 'J080', 'FH00255', '?', 'F?'] 2009/10/19 09:10:06 - T10190910 2009/10/19 09:10:11 - term 0 ADCP nb150 startup failure 2009/10/19 09:10:11 - Traceback (most recent call last): 2009/10/19 09:10:11 - File "/home/currents/programs/uhdas/uhdas/DAS.py", line 276, in StartLogging 2009/10/19 09:10:11 - term.start_binary(cmdlist) 2009/10/19 09:10:11 - File "/home/currents/programs/uhdas/serial/nb_term.py", line 164, in start_binary 2009/10/19 09:10:11 - self.set_clock() 2009/10/19 09:10:11 - File "/home/currents/programs/uhdas/serial/nb_term.py", line 47, in set_clock 2009/10/19 09:10:11 - self.send_commands(['T%s' % DateTime, ]) 2009/10/19 09:10:11 - File "/home/currents/programs/uhdas/serial/nb_term.py", line 88, in send_commands 2009/10/19 09:10:11 - self.send(cmd) 2009/10/19 09:10:11 - File "/home/currents/programs/uhdas/serial/tk_terminal.py", line 385, in send 2009/10/19 09:10:11 - self.waitfor(s[i]) 2009/10/19 09:10:11 - File "/home/currents/programs/uhdas/serial/tk_terminal.py", line 282, in waitfor 2009/10/19 09:10:11 - raise Timeout 2009/10/19 09:10:11 - Timeout