2016/12/04 03:59:56 - currents1665 3.13.0-24-generic #47-Ubuntu SMP Fri May 2 23:30:00 UTC 2014 x86_64
2016/12/04 03:59:56 - /dev/ttyUSB4
2016/12/04 03:59:56 - /dev/ttyUSB5
2016/12/04 03:59:56 - In CruiseSetup.init
2016/12/04 03:59:56 - Resuming Cruise
2016/12/04 03:59:57 - Entering buildLoggers
2016/12/04 03:59:57 - >>>> C_ss enabled <<<<<
2016/12/04 03:59:57 - Leaving buildLoggers
2016/12/04 03:59:57 - About to run mainloop
2016/12/04 04:00:07 - enter StartLogging, resume =
2016/12/04 04:00:07 - 0
2016/12/04 04:00:07 - term 0 ADCP wh300 startup failure
2016/12/04 04:00:07 - Traceback (most recent call last):
2016/12/04 04:00:07 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 356, in StartLogging
2016/12/04 04:00:07 -     term.start_binary(cmdlist)
2016/12/04 04:00:07 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 234, in start_binary
2016/12/04 04:00:07 -     self.wakeup()
2016/12/04 04:00:07 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
2016/12/04 04:00:07 -     self.slow_wakeup()
2016/12/04 04:00:07 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 111, in slow_wakeup
2016/12/04 04:00:07 -     self.change_baud(self.default_baud)
2016/12/04 04:00:07 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 527, in change_baud
2016/12/04 04:00:07 -     self.open_port(save=False)
2016/12/04 04:00:07 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/serialport.py", line 73, in open_port
2016/12/04 04:00:07 -     self.stream = open(self.__device, self.__mode, 0) # unbuffered
2016/12/04 04:00:07 - IOError: [Errno 2] No such file or directory: '/dev/ttyUSB4'
2016/12/04 04:00:50 - enter StartLogging, resume =
2016/12/04 04:00:50 - 0
2016/12/04 04:00:54 - term 1 ADCP os38 startup failure
2016/12/04 04:00:54 - Traceback (most recent call last):
2016/12/04 04:00:54 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 356, in StartLogging
2016/12/04 04:00:54 -     term.start_binary(cmdlist)
2016/12/04 04:00:54 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 234, in start_binary
2016/12/04 04:00:54 -     self.wakeup()
2016/12/04 04:00:54 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
2016/12/04 04:00:54 -     self.slow_wakeup()
2016/12/04 04:00:54 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 117, in slow_wakeup
2016/12/04 04:00:54 -     self.waitfor(timeout=2.5, quiet=0.5)
2016/12/04 04:00:54 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 286, in waitfor
2016/12/04 04:00:54 -     raise Timeout
2016/12/04 04:00:54 - Timeout
2016/12/04 04:00:59 -  An unexpected active lock file was found.
2016/12/04 04:00:59 - The lock file is /var/lock/LCK..ttyUSB4.
2016/12/04 04:00:59 - Lock is owned by this process, with pid = 12078.
2016/12/04 04:00:59 - <class 'uhdas.serial.sp_lock.LockedError'> Exception in Tk callback
  Function: <bound method StartStopControl.C_start of <pycurrents.system.startstop.StartStopControl instance at 0x7fe6ab3fb368>> (type: <type 'instancemethod'>)
  Args: ()
Traceback (innermost last):
  File "/usr/lib/python2.7/dist-packages/Pmw/Pmw_1_3/lib/PmwBase.py", line 1747, in __call__
    return apply(self.func, args)
  File "/usr/local/lib/python2.7/dist-packages/pycurrents/system/startstop.py", line 70, in C_start
    self.funcs[0](**kw)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 373, in StartLogging
    t.wakeup()
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
    self.slow_wakeup()
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 111, in slow_wakeup
    self.change_baud(self.default_baud)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 527, in change_baud
    self.open_port(save=False)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/serialport.py", line 72, in open_port
    sp_lock.lock_port(self.__device)  # Raises exception if locked.
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/sp_lock.py", line 74, in lock_port
    check_lock(device)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/sp_lock.py", line 71, in check_lock
    raise LockedError(status, device)
<class 'uhdas.serial.sp_lock.LockedError'>: (1, '/dev/ttyUSB4')
2016/12/04 04:01:06 - Ready to destroy_loggers.
2016/12/04 04:01:06 - After destroy_loggers.
2016/12/04 04:01:06 - cp -au /home/adcp/log/* /home/data/EX1608_01/raw/log/
2016/12/04 04:01:06 - End Cruise
2016/12/04 04:01:27 - adcptree.py /home/data/EX1608_02/proc/wh300 -d uhdas --configpath /home/data/EX1608_02/raw/config --cruisename EX1608_02
2016/12/04 04:01:27 - 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/EX1608_02/proc/wh300/adcpdb
making directory /home/data/EX1608_02/proc/wh300/cal
making directory /home/data/EX1608_02/proc/wh300/cal/watertrk
making directory /home/data/EX1608_02/proc/wh300/cal/botmtrk
making directory /home/data/EX1608_02/proc/wh300/cal/heading
making directory /home/data/EX1608_02/proc/wh300/cal/rotate
making directory /home/data/EX1608_02/proc/wh300/contour
making directory /home/data/EX1608_02/proc/wh300/edit
making directory /home/data/EX1608_02/proc/wh300/grid
making directory /home/data/EX1608_02/proc/wh300/load
making directory /home/data/EX1608_02/proc/wh300/nav
making directory /home/data/EX1608_02/proc/wh300/quality
making directory /home/data/EX1608_02/proc/wh300/ping
making directory /home/data/EX1608_02/proc/wh300/scan
making directory /home/data/EX1608_02/proc/wh300/stick
making directory /home/data/EX1608_02/proc/wh300/vector
- copying additional files for data type uhdas

- config files for raw processing are in /home/data/EX1608_02/proc/wh300/config
copying config files using this wildcard expansion: /home/data/EX1608_02/raw/config/EX1608_02*
2016/12/04 04:01:27 - adcptree.py /home/data/EX1608_02/proc/os38bb -d uhdas --configpath /home/data/EX1608_02/raw/config --cruisename EX1608_02
2016/12/04 04:01:27 - 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/EX1608_02/proc/os38bb/adcpdb
making directory /home/data/EX1608_02/proc/os38bb/cal
making directory /home/data/EX1608_02/proc/os38bb/cal/watertrk
making directory /home/data/EX1608_02/proc/os38bb/cal/botmtrk
making directory /home/data/EX1608_02/proc/os38bb/cal/heading
making directory /home/data/EX1608_02/proc/os38bb/cal/rotate
making directory /home/data/EX1608_02/proc/os38bb/contour
making directory /home/data/EX1608_02/proc/os38bb/edit
making directory /home/data/EX1608_02/proc/os38bb/grid
making directory /home/data/EX1608_02/proc/os38bb/load
making directory /home/data/EX1608_02/proc/os38bb/nav
making directory /home/data/EX1608_02/proc/os38bb/quality
making directory /home/data/EX1608_02/proc/os38bb/ping
making directory /home/data/EX1608_02/proc/os38bb/scan
making directory /home/data/EX1608_02/proc/os38bb/stick
making directory /home/data/EX1608_02/proc/os38bb/vector
- copying additional files for data type uhdas

- config files for raw processing are in /home/data/EX1608_02/proc/os38bb/config
copying config files using this wildcard expansion: /home/data/EX1608_02/raw/config/EX1608_02*
2016/12/04 04:01:27 - adcptree.py /home/data/EX1608_02/proc/os38nb -d uhdas --configpath /home/data/EX1608_02/raw/config --cruisename EX1608_02
2016/12/04 04:01:27 - 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/EX1608_02/proc/os38nb/adcpdb
making directory /home/data/EX1608_02/proc/os38nb/cal
making directory /home/data/EX1608_02/proc/os38nb/cal/watertrk
making directory /home/data/EX1608_02/proc/os38nb/cal/botmtrk
making directory /home/data/EX1608_02/proc/os38nb/cal/heading
making directory /home/data/EX1608_02/proc/os38nb/cal/rotate
making directory /home/data/EX1608_02/proc/os38nb/contour
making directory /home/data/EX1608_02/proc/os38nb/edit
making directory /home/data/EX1608_02/proc/os38nb/grid
making directory /home/data/EX1608_02/proc/os38nb/load
making directory /home/data/EX1608_02/proc/os38nb/nav
making directory /home/data/EX1608_02/proc/os38nb/quality
making directory /home/data/EX1608_02/proc/os38nb/ping
making directory /home/data/EX1608_02/proc/os38nb/scan
making directory /home/data/EX1608_02/proc/os38nb/stick
making directory /home/data/EX1608_02/proc/os38nb/vector
- copying additional files for data type uhdas

- config files for raw processing are in /home/data/EX1608_02/proc/os38nb/config
copying config files using this wildcard expansion: /home/data/EX1608_02/raw/config/EX1608_02*
2016/12/04 04:01:28 - Entering buildLoggers
2016/12/04 04:01:28 - Created output directory </home/data/EX1608_02/raw/wh300> with mode 775
2016/12/04 04:01:28 - Created output directory </home/data/EX1608_02/raw/os38> with mode 775
2016/12/04 04:01:28 - Created output directory </home/data/EX1608_02/raw/cnav> with mode 775
2016/12/04 04:01:28 - Created output directory </home/data/EX1608_02/raw/posmv> with mode 775
2016/12/04 04:01:28 - Created output directory </home/data/EX1608_02/raw/gyro> with mode 775
2016/12/04 04:01:28 - >>>> C_ss enabled <<<<<
2016/12/04 04:01:28 - Leaving buildLoggers
2016/12/04 04:01:28 - Start Cruise
2016/12/04 04:01:37 - enter StartLogging, resume =
2016/12/04 04:01:37 - 0
2016/12/04 04:01:41 - term 1 ADCP os38 startup failure
2016/12/04 04:01:41 - Traceback (most recent call last):
2016/12/04 04:01:41 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 356, in StartLogging
2016/12/04 04:01:41 -     term.start_binary(cmdlist)
2016/12/04 04:01:41 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 234, in start_binary
2016/12/04 04:01:41 -     self.wakeup()
2016/12/04 04:01:41 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
2016/12/04 04:01:41 -     self.slow_wakeup()
2016/12/04 04:01:41 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 117, in slow_wakeup
2016/12/04 04:01:41 -     self.waitfor(timeout=2.5, quiet=0.5)
2016/12/04 04:01:41 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 286, in waitfor
2016/12/04 04:01:41 -     raise Timeout
2016/12/04 04:01:41 - Timeout
2016/12/04 04:01:59 -  An unexpected active lock file was found.
2016/12/04 04:01:59 - The lock file is /var/lock/LCK..ttyUSB4.
2016/12/04 04:01:59 - Lock is owned by this process, with pid = 12078.
2016/12/04 04:01:59 - <class 'uhdas.serial.sp_lock.LockedError'> Exception in Tk callback
  Function: <bound method StartStopControl.C_start of <pycurrents.system.startstop.StartStopControl instance at 0x7fe6ab3fb368>> (type: <type 'instancemethod'>)
  Args: ()
Traceback (innermost last):
  File "/usr/lib/python2.7/dist-packages/Pmw/Pmw_1_3/lib/PmwBase.py", line 1747, in __call__
    return apply(self.func, args)
  File "/usr/local/lib/python2.7/dist-packages/pycurrents/system/startstop.py", line 70, in C_start
    self.funcs[0](**kw)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 373, in StartLogging
    t.wakeup()
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
    self.slow_wakeup()
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 111, in slow_wakeup
    self.change_baud(self.default_baud)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 527, in change_baud
    self.open_port(save=False)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/serialport.py", line 72, in open_port
    sp_lock.lock_port(self.__device)  # Raises exception if locked.
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/sp_lock.py", line 74, in lock_port
    check_lock(device)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/sp_lock.py", line 71, in check_lock
    raise LockedError(status, device)
<class 'uhdas.serial.sp_lock.LockedError'>: (1, '/dev/ttyUSB4')
2016/12/04 04:02:53 - enter StartLogging, resume =
2016/12/04 04:02:53 - 0
2016/12/04 04:02:57 - term 1 ADCP os38 startup failure
2016/12/04 04:02:57 - Traceback (most recent call last):
2016/12/04 04:02:57 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 356, in StartLogging
2016/12/04 04:02:57 -     term.start_binary(cmdlist)
2016/12/04 04:02:57 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 234, in start_binary
2016/12/04 04:02:57 -     self.wakeup()
2016/12/04 04:02:57 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
2016/12/04 04:02:57 -     self.slow_wakeup()
2016/12/04 04:02:57 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 117, in slow_wakeup
2016/12/04 04:02:57 -     self.waitfor(timeout=2.5, quiet=0.5)
2016/12/04 04:02:57 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 286, in waitfor
2016/12/04 04:02:57 -     raise Timeout
2016/12/04 04:02:57 - Timeout
2016/12/04 04:03:17 -  An unexpected active lock file was found.
2016/12/04 04:03:17 - The lock file is /var/lock/LCK..ttyUSB4.
2016/12/04 04:03:17 - Lock is owned by this process, with pid = 12078.
2016/12/04 04:03:17 - <class 'uhdas.serial.sp_lock.LockedError'> Exception in Tk callback
  Function: <bound method StartStopControl.C_start of <pycurrents.system.startstop.StartStopControl instance at 0x7fe6ab3fb368>> (type: <type 'instancemethod'>)
  Args: ()
Traceback (innermost last):
  File "/usr/lib/python2.7/dist-packages/Pmw/Pmw_1_3/lib/PmwBase.py", line 1747, in __call__
    return apply(self.func, args)
  File "/usr/local/lib/python2.7/dist-packages/pycurrents/system/startstop.py", line 70, in C_start
    self.funcs[0](**kw)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 373, in StartLogging
    t.wakeup()
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
    self.slow_wakeup()
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 111, in slow_wakeup
    self.change_baud(self.default_baud)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 527, in change_baud
    self.open_port(save=False)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/serialport.py", line 72, in open_port
    sp_lock.lock_port(self.__device)  # Raises exception if locked.
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/sp_lock.py", line 74, in lock_port
    check_lock(device)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/sp_lock.py", line 71, in check_lock
    raise LockedError(status, device)
<class 'uhdas.serial.sp_lock.LockedError'>: (1, '/dev/ttyUSB4')
2016/12/04 04:03:31 - enter StartLogging, resume =
2016/12/04 04:03:31 - 0
2016/12/04 04:03:34 - term 1 ADCP os38 startup failure
2016/12/04 04:03:34 - Traceback (most recent call last):
2016/12/04 04:03:34 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 356, in StartLogging
2016/12/04 04:03:34 -     term.start_binary(cmdlist)
2016/12/04 04:03:34 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 234, in start_binary
2016/12/04 04:03:34 -     self.wakeup()
2016/12/04 04:03:34 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
2016/12/04 04:03:34 -     self.slow_wakeup()
2016/12/04 04:03:34 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 117, in slow_wakeup
2016/12/04 04:03:34 -     self.waitfor(timeout=2.5, quiet=0.5)
2016/12/04 04:03:34 -   File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 286, in waitfor
2016/12/04 04:03:34 -     raise Timeout
2016/12/04 04:03:34 - Timeout
2016/12/04 04:03:42 -  An unexpected active lock file was found.
2016/12/04 04:03:42 - The lock file is /var/lock/LCK..ttyUSB4.
2016/12/04 04:03:42 - Lock is owned by this process, with pid = 12078.
2016/12/04 04:03:42 - <class 'uhdas.serial.sp_lock.LockedError'> Exception in Tk callback
  Function: <bound method StartStopControl.C_start of <pycurrents.system.startstop.StartStopControl instance at 0x7fe6ab3fb368>> (type: <type 'instancemethod'>)
  Args: ()
Traceback (innermost last):
  File "/usr/lib/python2.7/dist-packages/Pmw/Pmw_1_3/lib/PmwBase.py", line 1747, in __call__
    return apply(self.func, args)
  File "/usr/local/lib/python2.7/dist-packages/pycurrents/system/startstop.py", line 70, in C_start
    self.funcs[0](**kw)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/uhdas/DAS.py", line 373, in StartLogging
    t.wakeup()
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 155, in wakeup
    self.slow_wakeup()
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/oswh_term.py", line 111, in slow_wakeup
    self.change_baud(self.default_baud)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/tk_terminal.py", line 527, in change_baud
    self.open_port(save=False)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/serialport.py", line 72, in open_port
    sp_lock.lock_port(self.__device)  # Raises exception if locked.
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/sp_lock.py", line 74, in lock_port
    check_lock(device)
  File "/usr/local/lib/python2.7/dist-packages/uhdas/serial/sp_lock.py", line 71, in check_lock
    raise LockedError(status, device)
<class 'uhdas.serial.sp_lock.LockedError'>: (1, '/dev/ttyUSB4')
2016/12/04 04:04:22 - Ready to destroy_loggers.
2016/12/04 04:04:22 - After destroy_loggers.
2016/12/04 04:04:22 - cp -au /home/adcp/log/* /home/data/EX1608_02/raw/log/