Supervisor::createCoreTasks() Supervisor::createTask() - eventLogServer Supervisor::createTask() - workSite Supervisor::createTask() - vehicleConfigurationServer Supervisor::createTask() - externalCommsServer S: Initializing worksiteServer upervisor: WorkSite::WorkSite -- Adding attributes ::: WorkSite::WorkSite -- Loading parameters from file /home/dorado1/auv-qnx-dev/auv/altex/onboard/config/i2map_dmo1/workSite.cfg createTask() - navigationServer : Using default vehicle config file "/home/dorado1/auv-qnx-dev/auv/altex/onboard/config/i2map_dmo1/vehicle.cfg" : starting LC: layeredControlServer -plan Transect7Short.cfg -abort abortMplan.cfg Supervisor::createTask() - layeredControlServer -plan Transect7Short.cfg -abort abortMplan.cfg Supervisor::createTask() - dynamicControlServer : Creating NavigationServer... : *** NavigationServer::NavigationServer()... : layeredControlServer - creating non dynamic version : WorkSite::WorkSite -- Finished loading parameters : WorkSite::WorkSite -- Starting Depth is 0.000000 meters : 0: 1 600674.187500E 4067388.750000N 73.699997 m 10.000000 ms channel:2 : 1: 2 600531.687500E 4065156.000000N 73.199997 m 10.000000 ms channel:4 : 2: 3 598447.000000E 4067412.250000N 91.400002 m 10.000000 ms channel:5 : 3: 4 600848.125000E 4069389.500000N 80.199997 m 10.000000 ms channel:6 : 4: 5 602732.187500E 4067093.000000N 57.299999 m 10.000000 ms channel:7 : WorkSite server: 0x232bc : *** NavigationServer::NavigationServer() - DONE : Done creating NavigationServer... : Navigation::Navigation - Setting start depth to 0.0 meters. : Navigation::Navigation _logOnly = 0 : Navigation - Using only the Dvl to compute altitude. : Navigation/EchoSounder:: epoch = (1516733619,392276863) : Navigation: Opening Acoustic Modem Interface: : Supervisor::createTasks() - spawning newTailConeServer -dev /dev/ser3 Supervisor::createTask() - newTailConeServer -dev /dev/ser3 : Supervisor::createTasks() - spawning m3dmgx1Server -dev /dev/ser5 -useForNav Supervisor::createTask() - m3dmgx1Server -dev /dev/ser5 -useForNav : Supervisor::createTasks() - spawning gpsServer -r ashtech -dev /dev/ser7 Supervisor::createTask() - gpsServer -r ashtech -dev /dev/ser7 : Preparing to fork : I'm the child...forking : Supervisor::createTasks() - spawning parosciServer -dev /dev/ser9 Supervisor::createTask() - parosciServer -dev /dev/ser9 : SerialDevice: done... : Attributes::parse() - Couldn't open CrossbowConstants attributes file "/home/dorado1/auv-qnx-dev/auv/altex/onboard/config/i2map_dmo1/crossbow.cfg" : Supervisor::createTasks() - spawning dvlServer -dev /dev/ser6 : VehicleConstants -- Caught exception while loading vehicle constants Supervisor::createTask() - dvlServer -dev /dev/ser6 : SerialDevice: done... : TailConeServer -- Maximum Elevator Actuator Excursion is 0 Counts : Supervisor::createTasks() - spawning newBattServer -dev tcp:134.89.32.121:10003 -n newBatt1 : TailConeServer:: -- Minimum Elevator Actuator Excursion is 0 Counts Su: TailConeServer -- Maximum Rudder Actuator Excursion is 0 Counts perv: TailConeServer -- Minimum Rudder Actuator Excursion is 0 Counts is: SerialDevice: done... or::createT: SerialDevice: done... a: Crossbow.cc: In getSerialNumber() sk() - newBattServer -dev tcp:134.89.32.121:10003 -n newBatt1 : Supervisor::createTasks() - spawning carlServer Supervisor::createTask() - carlServer : Supervisor::createTasks() - spawning seabird25pServer -n seabird25p -dev udp:134.89.32.55:54125 Supervisor::createTask() - seabird25pServer -n seabird25p -dev udp:134.89.32.55:54125 : SerialDevice: done... : Parosci::reson host is NULL : Supervisor::createTasks() - spawning dropWeightServer -dev /dev/ser13 Supervisor::createTask() - dropWeightServer -dev /dev/ser13 : SerialDevice: done... : SerialDevice: done... : NewBattServer: servicename=NewBattIFServer : NewBattServer::spawnAuxTasks - execlp(newBattDriver newBattDriver -dev tcp:134.89.32.121:10003 -n newBatt1 : SerialDevice: done... : carlServer - initializing... : SerialDevice: done... : Gps: initializing : SerialDevice: done... : Gps: done initializing... : **** EventTriggers::add() - attaching proxy : seabird25pDriver RUNNING... : Seabird/seabird25p -- Loading CTD constants from /home/dorado1/auv-qnx-dev/auv/altex/onboard/config/i2map_dmo1/seabird25p.cfg : SerialDevice: done... : SerialDeviceDriver::initialize() : Starting DVL Initialization. : SerialDevice: done... : DropWeight::initialize - Resetting counters. : **** EventTriggers::add() - attaching proxy : SerialDevice: done... : Battery newBatt1 initializing. : carlServer - running... : CARLServer::initialize() - spawning aux tasks... : CARLServer::spawnAuxTasks() - modtronix -o -h 134.89.32.55 -p 54123 28.00 : CTD/seabird25p -- Calibration constants: Temp Sensor T_coefs= G T_a = 3.681213e-003 T_b = 6.042327e-004 T_c = 1.655279e-005 T_d = 2.244365e-006 T_f0 = 3304.265000 T_g = 4.308463e-003 T_h = 6.275372e-004 T_i = 1.868106e-005 T_j = 1.194381e-006 T_gf0 = 1000.000000 Conductivity Sensor T_coefs= G C_a = 1.220927e-006 C_b = 4.572136e-001 C_c = -4.124703 C_d = -7.815561e-005 C_m = 5.200 EPS = -9.570000e-008 C_g = -9.935951e+000 C_h = 1.350244e+000 C_i = -0.002942 C_j = 2.721038e-004 C_pcor = 0.000 C_tcor = 0.000 Oxygen Sensor SOc = 3.937000e-001 BOc = 0.000000e+000 Voff = -5.300000e-001 TCor = 0.000000e+000 PCor = 1.350000e-004 Pressure Sensor P_A0 = 3.858592e+000 P_A1 = 5.549117e-004 P_A2 = -6.304879e-013 PT_A0 = -6.313844e+001 PT_A1 = 5.355101e+001 PT_A2 = -5.212054e-001 PTC_A0 = 8.409078e+006 PTC_A1 = 5.389669e+002 PTC_A2 = -9.456861e+000 PTC_B0 = 2.525163e+001 PTC_B1 = 2.125000e-003 PTC_B2 = 0.000000e+000 : modtronix ... : Seabird/seabird25p::Seabird() - create interface to depth sensor... : Modtronix - Host ip is now 134.89.32.55... : Seabird/seabird25p -- DepthSensor server is not running. Using default pres of 10.100000 : Modtronix - Host port is now 54123... : Seabird/seabird25p::Seabird() - create interface to worksite... : Modtronix - Period is 2000... : Seabird25p.cc -- Worksite server is not running. Using default lat of 45.000000 : Modtronix - Using 28.00 for voltage limit... : Seabird/seabird25p -- constructing Log... : Modtronix - Powering-up components... : modtronix host ip is 134.89.32.55... : Seabird25Log.cc -- beginning constructor... : modtronix host port is 54123... : Seabird25Log.cc -- constructor succeeded : PeriodicTask::run() (newBatt1) - sampleInterval=10000, maxInterval=10000 : modtronix host period is 2000... : Seabird/seabird25p -- constructor succeeded : Modtronix - Opening Interface to servers... : seabird25pDriver -- constructor succeeded : Modtronix - Interface opened to CARLServer OK : Seabird/seabird25p:initializing Seabird... : Modtronix - Interface opened to LayeredControlServer OK : Seabird/seabird25p: sending CRLF... : Modtronix - Interface opened to NewBattServer OK : modtronix We are ready to receive mod datagrams from 134.89.32.55 on port 54123 sockfd 8... : modtronix We are ready to send/receive ez datagrams from 134.89.32.55 on port 54126 sockfd 9... : EZ17::EZ17() - comms on 9 : Creating transect log: /home/dorado1/auv-qnx-dev/auv/altex/onboard/logs/latest/transects.csv : Setting power to 1... : Modtronix::set_pin() - b0=1 : modtronix running... : PeriodicTask::run() (modtronix) - sampleInterval=2000, maxInterval=2000 : SerialDevice: done... : DynamicControlServer::DynamicControl() - status 1 from _tailCone->initialize() : PeriodicTask::run() (layeredControl) - sampleInterval=2000, maxInterval=0 : Crossbow.cc: device->read succeeded : m3dmgx1: Serial Number is 6548 : PeriodicTask::run() (crossbow) - sampleInterval=200, maxInterval=200 : CR1 [Parameters set to FACTORY defaults] > : PD5 > : BK1 > : TP00:01.00 > : TE00:00:0.00 > : BP001 > : CF11010 > : CB611 > : SerialDevice: done... : Dvl::initialize - Baud rate set to 38400. : EX10011 > : EZ0111101 > : Dvl::initialize - Error. EC speed of sound is set in worksite.cfg. : EA+04500 > : WP0000 > : WN50 > : Dvl::initialize - The number of cells is 50. : WV210 > : Dvl::initialize - 14 valid commands read in from dvl.cfg. : EC1500 > : > : Dvl::initialize() - The DVL is initialized. : **** EventTriggers::add() - attaching proxy : no response to address set : SerialDevice: done... : 3 Modules found : PeriodicTask::run() (tailConeDriver) - sampleInterval=200, maxInterval=200 : header is 01/23, : Dvl record header not found. Resynchronize. : Modtronix - voltage is 0.00 : EventService::processEvent() - unknown event, code=40080, pid=15 : gpsDriver::readRecord() - serial device timed out : **** EventTriggers::add() - attaching proxy : SerialDevice::confirm() - Timed Out : Seabird/seabird25p::initialize() - confirm() timed out; sleep a bit : Dvl:: Serial resynchronization completed. : **** EventTriggers::add() - attaching proxy : Modtronix - voltage is 0.00 : Parosci: unable to open edgetechFSDW interface : Parosci.cc -- parsed PR (100) and TempInterval (100) : SerialDevice: done... : Parosci.cc -- Serial # is 121194 : Parosci::init() - mode set okay : Parosci.cc -- PI reply = 100 : Parosci.cc -- units = 3 : dvlSOS = 1500.000000 : Modtronix - voltage is 0.00 : Parosci.cc -- Initial pressure = 0.071023 : Parosci.cc -- Parosci initial pressure period = 30.262348 : Parosci.cc -- Parosci initial temp period = 5.819930 : initial pressure is 1.029190 : Parosci.cc -- Paroscientific configured. : Parosci::units are wrong *0001MD=2 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 0.00 : Seabird/seabird25p::initialize() - starting logging... : dvlSOS = 1500.000000 : Ctd/seabird25p:initialize() - ready! : **** EventTriggers::add() - attaching proxy : Modtronix - voltage is 0.00 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 0.00 : dvlSOS = 1500.000000 : Seabird/seabird25p: error record length (2) incorrect (is not 62) : Seabird/seabird25p: error sscanfing 2 bytes in reply: : Seabird/seabird25p: error sscanf'ing conductivity data string : Seabird/seabird25p: error sscanf'ing pressure data string : Seabird/seabird25p: error sscanf'ing pressure temperature data string : Modtronix - voltage is 0.00 : newBatt::Average voltage = 32.50 V, Total current = -3.84 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.3 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.40 A Charge Current = 0.00 A : newBatt:: There are 55 packs of 2.9 A-h cells. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : Navigation: navigation: unable to open modem interface : Navigation::connectSensors core - connecting to Nav->DepthSensor at t = 20198. : Navigation::connectSensors core - connecting to Nav->TailCone at t = 20198. : Navigation::connectSensors core - connecting to Nav->Ahrs at t = 20198. : ahrs if is Nav->Ahrs : Navigation::connectSensors core - connecting to Nav->Dvl at t = 20198. : Navigation::connectSensors aux - connecting to Nav->Gps at t = 20198. : Navigation::connectSensors aux - connecting to Nav->EchoSounder at t = 20198. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : newBatt::Average voltage = 32.50 V, Total current = -3.89 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.3 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.50 A Charge Current = 0.00 A : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : Navigation: Server for aux sensor "Nav->EchoSounder" not found : Navigation::connectSensors aux - connecting to Nav->Velocimeter at t = 30297. : Navigation: Server for aux sensor "Nav->Velocimeter" not found : Navigation::connectSensors aux - connecting to Nav->Usbl at t = 30297. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : dvlSOS = 1500.000000 : Modtronix - voltage is 32.50 : newBatt::Average voltage = 32.49 V, Total current = -3.97 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.3 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.50 A Charge Current = 0.00 A : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.49 : dvlSOS = 1500.000000 : Modtronix - voltage is 32.49 : Navigation: Server for aux sensor "Nav->Usbl" not found : Navigation::Navigation(). _es->valid() = 0 at t = 40397. : PeriodicTask::run() (navigation) - sampleInterval=200, maxInterval=200 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : **** EventTriggers::add() - attaching proxy : CARL - Id:99, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:0, record:-1, homeIris:1, fstop:-1, auto-iris:-1.00 : CARL Behavior 99: Home the iris motor : CARLServer::iris_control - home : CARL Behavior 99: Turning lights off : CARLServer::camera_lights_off : CARL Behavior 99: Setting brightness to 0 : CARLServer::light_level 0 : LayeredControl::execute() -- (t = 0.000000) Behavior CARL:99 has changed to state Active : LayeredControl::execute() -- (t = 0.000000) Behavior getgps:-1 has changed to state Active : LayeredControl::execute() -- (t = 0.000000) Behavior depthEnvelope:-1 has changed to state Active : LayeredControl::execute() -- (t = 0.000000) Behavior missionTimer:-1 has changed to state Active : **** EventTriggers::add() - attaching proxy : *** Mission started *** : **** EventTriggers::add() - attaching proxy : CARL::done() - 99 all done! : LayeredControl::execute() -- (t = 0.199986) Behavior CARL:99 has changed to state Finished : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.49 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::msg_handler() - EZ17 message: 18 0 0.000000 : Modtronix::EZ17Handler() - got message 18 0 0.000000 : EZ17::read_position() - position is 660 : Modtronix::set_pin() - b2=1 : Modtronix::light_power[0] = 0 : Modtronix::set_pin() - b3=1 : Modtronix::light_power[1] = 0 : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::light_level(0) - w2=0 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.49 V, Total current = -4.00 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : EZ17::read_position() - position is 0 : Modtronix - voltage is 32.49 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 0 : EZ17::read_position() - position is 660 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 660 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 660 : EZ17::save_position() - Saving the position: 660 : Modtronix - voltage is 32.49 : Behavior getgps - Timed out! : LayeredControl::execute() -- (t = 10.199301) Behavior getgps:-1 has changed to state Finished : CARL - Id:101, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:1, brightness:0, record:1, homeIris:-1, fstop:561, auto-iris:-1.00 : CARL Behavior 101: set the fstop to 561 : CARLServer::iris_control - fstop 561 : CARL Behavior 101: Turning lights on : CARLServer::camera_lights_on : CARL Behavior 101: Setting brightness to 0 : CARLServer::light_level 0 : CARL Behavior 101: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : CARL Behavior 101: action! : CARLServer::start_recording()... : CARL Behavior 101: resetting record : LayeredControl::execute() -- (t = 10.199301) Behavior CARL:101 has changed to state Active : LayeredControl::execute() -- (t = 10.199301) Behavior setpoint:-1 has changed to state Active : DynamicControlServer::Begin horizontal mode 1 at t = 10.19 sec. : DynamicControlServer::Begin vertical mode 1 at t = 10.19 sec. : CARL::done() - 101 all done! : LayeredControl::execute() -- (t = 10.399288) Behavior CARL:101 has changed to state Finished : dvlSOS = 1500.000000 : Modtronix - voltage is 32.49 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::msg_handler() - EZ17 message: 19 561 0.000000 : Modtronix::EZ17Handler() - got message 19 561 0.000000 : EZ17::read_position() - position is 660 : Modtronix - voltage is 32.49 : Modtronix::set_pin() - b2=0 : Modtronix::light_power[0] = 1 : Modtronix::set_pin() - b3=0 : Modtronix::light_power[1] = 1 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b4=0 : Modtronix::light_power[2] = 1 : Modtronix::set_pin() - b5=0 : Modtronix::light_power[3] = 1 : Modtronix::light_level(0) - w2=0 : Modtronix::clipname(_000m_F561) - : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} --:--:--","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:54:29:57","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F561) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185433Z_000m_F561 : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185433Z_000m_F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:54:29:57","last_config_update":"0"}] : 32 i2MAP_20180123T185433Z_000m_F561 : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:54:29:57","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:54:29:57","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733674 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.49 V, Total current = -4.25 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.00 A Charge Current = 0.00 A : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 318 : Modtronix - voltage is 32.49 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.49 : Behavior setpoint - Timed out! : LayeredControl::execute() -- (t = 20.398603) Behavior setpoint:-1 has changed to state Finished : LayeredControl::execute() -- (t = 20.398603) Behavior descend:-1 has changed to state Active : dvlSOS = 1500.000000 : gpsDriver::readRecord() - serial device timed out : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : EZ17::read_position() - position is 200 : EZ17::save_position() - Saving the position: 200 : Modtronix - voltage is 32.49 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : gpsDriver::readRecord() - serial device timed out : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.49 : newBatt::Average voltage = 32.46 V, Total current = -5.35 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 5.00 A Charge Current = 0.00 A : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : gpsDriver::readRecord() - serial device timed out : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.46 : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Behavior descend - Timed out! : LayeredControl::execute() -- (t = 30.597904) Behavior descend:-1 has changed to state Finished : Waypoint Initialization: Begin waypoint control at t= 30.60 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061593.3 , 585008.1 (wplog) The bearing to the next w.p. is 160.5 Degrees. : LayeredControl::execute() -- (t = 30.597904) Behavior waypoint:-1 has changed to state Active : DynamicControlServer::Begin horizontal mode 3 at t = 30.59 sec. : DynamicControlServer::Begin vertical mode 2 at t = 30.59 sec. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.46 V, Total current = -4.91 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.50 A Charge Current = 0.00 A : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 40.797205) Behavior waypoint:-1 has changed to state Finished : LayeredControl::execute() -- (t = 40.797205) Behavior descend:-1 has changed to state Active : DynamicControlServer::Begin horizontal mode 0 at t = 40.79 sec. : DynamicControlServer::Begin vertical mode 1 at t = 40.79 sec. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : newBatt::Average voltage = 32.46 V, Total current = -5.10 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 5.20 A Charge Current = 0.00 A : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.46 : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EventService::processEvent() - unknown event, code=40080, pid=15 : Behavior descend - Timed out! : LayeredControl::execute() -- (t = 50.996506) Behavior descend:-1 has changed to state Finished : Waypoint Initialization: Begin waypoint control at t= 51.00 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061552.0 , 584878.4 (wplog) The bearing to the next w.p. is 177.6 Degrees. : LayeredControl::execute() -- (t = 50.996506) Behavior waypoint:-1 has changed to state Active : DynamicControlServer::Begin horizontal mode 3 at t = 50.99 sec. : DynamicControlServer::Begin vertical mode 2 at t = 50.99 sec. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.46 V, Total current = -4.99 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.70 A Charge Current = 0.00 A : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.46 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 61.195808) Behavior waypoint:-1 has changed to state Finished : CARL - Id:104, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:1, brightness:0, record:1, homeIris:-1, fstop:31, auto-iris:-1.00 : CARL Behavior 104: set the fstop to 31 : CARLServer::iris_control - fstop 31 : CARL Behavior 104: Turning lights on : Modtronix::msg_handler() - EZ17 message: 19 31 0.000000 : CARLServer::camera_lights_on : CARL Behavior 104: Setting brightness to 0 : CARLServer::light_level 0 : CARL Behavior 104: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : CARL Behavior 104: action! : CARLServer::start_recording()... : CARL Behavior 104: resetting record : LayeredControl::execute() -- (t = 61.195808) Behavior CARL:104 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 61.20 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061548.9 , 584558.2 (wplog) The bearing to the next w.p. is 212.9 Degrees. : LayeredControl::execute() -- (t = 61.195808) Behavior waypoint:-1 has changed to state Active : Modtronix::EZ17Handler() - got message 19 31 0.000000 : CARL::done() - 104 all done! : LayeredControl::execute() -- (t = 61.395794) Behavior CARL:104 has changed to state Finished : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.46 : Modtronix::set_pin() - b2=0 : Modtronix::light_power[0] = 1 : Modtronix::set_pin() - b3=0 : dvlSOS = 1500.000000 : Modtronix::light_power[1] = 1 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b4=0 : Modtronix::light_power[2] = 1 : Modtronix::set_pin() - b5=0 : Modtronix::light_power[3] = 1 : Modtronix::light_level(0) - w2=0 : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}9:26","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:19:56","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:19:56","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733723, duration of 49 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.45 V, Total current = -5.19 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.50 A Charge Current = 0.00 A : gpsDriver::readRecord() - serial device timed out : Modtronix::clipname(_000m_F031) - : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:19:56","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F031) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185525Z_000m_F031 : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185525Z_000m_F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:19:56","last_config_update":"0"}] : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:19:56","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:19:56","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733725 : 32 i2MAP_20180123T185525Z_000m_F031 : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}mmand"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:19:56","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:19:56","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733725 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 15 : EZ17::read_position() - position is 15 : EZ17::save_position() - Saving the position: 15 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.45 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 71.395109) Behavior waypoint:-1 has changed to state Finished : CARL - Id:106, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:-1, brightness:-1, record:-1, homeIris:-1, fstop:561, auto-iris:-1.00 : CARL Behavior 106: set the fstop to 561 : CARLServer::iris_control - fstop 561 : CARL Behavior 106: Setting clipname : Modtronix::msg_handler() - EZ17 message: 19 561 0.000000 : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : LayeredControl::execute() -- (t = 71.395109) Behavior CARL:106 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 71.40 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061549.2 , 584251.2 (wplog) The bearing to the next w.p. is 232.6 Degrees. : LayeredControl::execute() -- (t = 71.395109) Behavior waypoint:-1 has changed to state Active : Modtronix::EZ17Handler() - got message 19 561 0.000000 : CARL::done() - 106 all done! : LayeredControl::execute() -- (t = 71.595095) Behavior CARL:106 has changed to state Finished : EZ17::read_position() - position is 15 : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}0:00","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:30:01","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:30:01","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733732, duration of 7 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : Modtronix::clipname(_000m_F561) - : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:30:01","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F561) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185533Z_000m_F561 : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185533Z_000m_F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:30:01","last_config_update":"0"}] : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:30:01","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:30:01","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733733 : 32 i2MAP_20180123T185533Z_000m_F561 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.45 V, Total current = -5.00 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.60 A Charge Current = 0.00 A : EZ17::read_position() - position is 197 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : gpsDriver::readRecord() - serial device timed out : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : EZ17::read_position() - position is 200 : EZ17::save_position() - Saving the position: 200 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 81.594410) Behavior waypoint:-1 has changed to state Finished : CARL - Id:108, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:0, homeIris:1, fstop:-1, auto-iris:-1.00 : CARL Behavior 108: Home the iris motor : CARLServer::iris_control - home : CARL Behavior 108: Turning lights off : Modtronix::msg_handler() - EZ17 message: 18 0 0.000000 : CARLServer::camera_lights_off : CARL Behavior 108: cut! : CARLServer::stop_recording()... : CARL Behavior 108: resetting record : LayeredControl::execute() -- (t = 81.594410) Behavior CARL:108 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 81.59 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061604.4 , 584107.2 (wplog) The bearing to the next w.p. is 241.4 Degrees. : LayeredControl::execute() -- (t = 81.594410) Behavior waypoint:-1 has changed to state Active : Modtronix::EZ17Handler() - got message 18 0 0.000000 : CARL::done() - 108 all done! : LayeredControl::execute() -- (t = 81.794397) Behavior CARL:108 has changed to state Finished : EZ17::read_position() - 6 bytes read from EZ17, expecting 8 : EZ17::read_position() - 4 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : EZ17::read_position() - position is 200 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b2=1 : Modtronix::light_power[0] = 0 : Modtronix::set_pin() - b3=1 : Modtronix::light_power[1] = 0 : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::msg_handler() - cut : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}9:06","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:39:13","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:39:13","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733743, duration of 10 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.45 V, Total current = -5.02 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.60 A Charge Current = 0.00 A : EZ17::read_position() - position is 345 : Modtronix - voltage is 32.45 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 467 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 594 : gpsDriver::readRecord() - serial device timed out : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 709 : Modtronix - voltage is 32.45 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 91.793712) Behavior waypoint:-1 has changed to state Finished : CARL - Id:110, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:1, homeIris:-1, fstop:31, auto-iris:-1.00 : CARL Behavior 110: set the fstop to 31 : CARLServer::iris_control - fstop 31 : CARL Behavior 110: Turning lights off : Modtronix::msg_handler() - saving EZ17 message : CARLServer::camera_lights_off : CARL Behavior 110: Setting clipname : Modtronix::set_pin() - b2=1 : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : CARL Behavior 110: action! : CARLServer::start_recording()... : CARL Behavior 110: resetting record : LayeredControl::execute() -- (t = 91.793712) Behavior CARL:110 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 91.79 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061605.8 , 584247.3 (wplog) The bearing to the next w.p. is 236.3 Degrees. : LayeredControl::execute() -- (t = 91.793712) Behavior waypoint:-1 has changed to state Active : Modtronix::light_power[0] = 0 : Modtronix::set_pin() - b3=1 : Modtronix::light_power[1] = 0 : CARL::done() - 110 all done! : LayeredControl::execute() -- (t = 91.993698) Behavior CARL:110 has changed to state Finished : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::clipname(_000m_F031) - : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} 55:42:25","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:50:36","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F031) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185552Z_000m_F031 : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185552Z_000m_F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:50:36","last_config_update":"0"}] : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : 32 i2MAP_20180123T185552Z_000m_F031 : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:50:36","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:55:50:36","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733752 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 0 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.45 V, Total current = -4.40 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.80 A Charge Current = 0.00 A : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 0 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 660 : dvlSOS = 1500.000000 : EZ17::read_position() - position is 660 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 660 : EZ17::save_position() - Saving the position: 660 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 31 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 660 : gpsDriver::readRecord() - serial device timed out : Modtronix - voltage is 32.45 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 101.993013) Behavior waypoint:-1 has changed to state Finished : Waypoint Initialization: Begin waypoint control at t= 101.99 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061608.9 , 584557.6 (wplog) The bearing to the next w.p. is 216.7 Degrees. : LayeredControl::execute() -- (t = 101.993013) Behavior waypoint:-1 has changed to state Active : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 556 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.45 V, Total current = -4.14 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.70 A Charge Current = 0.00 A : EZ17::read_position() - position is 429 : Modtronix - voltage is 32.45 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 306 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 178 : Modtronix - voltage is 32.45 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 54 : Modtronix - voltage is 32.45 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 112.192314) Behavior waypoint:-1 has changed to state Finished : CARL - Id:107, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:-1, brightness:-1, record:-1, homeIris:-1, fstop:561, auto-iris:-1.00 : CARL Behavior 107: set the fstop to 561 : CARLServer::iris_control - fstop 561 : CARL Behavior 107: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : LayeredControl::execute() -- (t = 112.192314) Behavior CARL:107 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 112.19 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061611.8 , 584857.8 (wplog) The bearing to the next w.p. is 180.2 Degrees. : LayeredControl::execute() -- (t = 112.192314) Behavior waypoint:-1 has changed to state Active : CARL::done() - 107 all done! : LayeredControl::execute() -- (t = 112.392301) Behavior CARL:107 has changed to state Finished : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.45 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}2:16","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:12:35","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:12:35","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733773, duration of 21 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::clipname(_000m_F561) - : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:12:35","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F561) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185614Z_000m_F561 : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185614Z_000m_F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:12:35","last_config_update":"0"}] : newBatt::Average voltage = 32.45 V, Total current = -4.20 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.90 A Charge Current = 0.00 A : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:12:35","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:12:35","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733775 : 32 i2MAP_20180123T185614Z_000m_F561 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 15 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 15 : EZ17::save_position() - Saving the position: 15 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 561 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 122.391616) Behavior waypoint:-1 has changed to state Finished : CARL - Id:108, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:0, homeIris:1, fstop:-1, auto-iris:-1.00 : CARL Behavior 108: Home the iris motor : CARLServer::iris_control - home : CARL Behavior 108: Turning lights off : CARLServer::camera_lights_off : CARL Behavior 108: cut! : CARLServer::stop_recording()... : CARL Behavior 108: resetting record : LayeredControl::execute() -- (t = 122.391616) Behavior CARL:108 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 122.39 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061543.4 , 585018.6 (wplog) The bearing to the next w.p. is 161.3 Degrees. : LayeredControl::execute() -- (t = 122.391616) Behavior waypoint:-1 has changed to state Active : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : CARL::done() - 108 all done! : LayeredControl::execute() -- (t = 122.591602) Behavior CARL:108 has changed to state Finished : EZ17::read_position() - position is 199 : Modtronix - voltage is 32.45 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::set_pin() - b2=1 : Modtronix::light_power[0] = 0 : Modtronix::set_pin() - b3=1 : Modtronix::light_power[1] = 0 : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::msg_handler() - cut : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}2:17","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:22:36","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:22:36","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733783, duration of 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.45 V, Total current = -4.15 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.70 A Charge Current = 0.00 A : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : EZ17::read_position() - position is 200 : EZ17::save_position() - Saving the position: 200 : Modtronix - There is a saved msg for the EZ17 : gpsDriver::readRecord() - serial device timed out : Modtronix::EZ17Handler() - got message 18 0 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 132.590917) Behavior waypoint:-1 has changed to state Finished : CARL - Id:110, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:1, brightness:-1, record:1, homeIris:-1, fstop:31, auto-iris:-1.00 : CARL Behavior 110: set the fstop to 31 : CARLServer::iris_control - fstop 31 : CARL Behavior 110: Turning lights on : Modtronix::msg_handler() - saving EZ17 message : CARLServer::camera_lights_on : CARL Behavior 110: Setting clipname : Modtronix - voltage is 32.45 : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : Modtronix::set_pin() - b2=0 : CARL Behavior 110: action! : CARLServer::start_recording()... : CARL Behavior 110: resetting record : LayeredControl::execute() -- (t = 132.590917) Behavior CARL:110 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 132.59 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061542.0 , 584878.5 (wplog) The bearing to the next w.p. is 177.7 Degrees. : LayeredControl::execute() -- (t = 132.590917) Behavior waypoint:-1 has changed to state Active : Modtronix::light_power[0] = 1 : CARL::done() - 110 all done! : LayeredControl::execute() -- (t = 132.790903) Behavior CARL:110 has changed to state Finished : Modtronix::set_pin() - b3=0 : Modtronix::light_power[1] = 1 : Modtronix::set_pin() - b4=0 : Modtronix::light_power[2] = 1 : gpsDriver::readRecord() - serial device timed out : Modtronix::set_pin() - b5=0 : Modtronix::light_power[3] = 1 : dvlSOS = 1500.000000 : Modtronix::clipname(_000m_F031) - : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} 56:23:08","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:31:34","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F031) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185634Z_000m_F031 : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185634Z_000m_F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:31:34","last_config_update":"0"}] : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.45 V, Total current = -4.22 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : 32 i2MAP_20180123T185634Z_000m_F031 : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:31:34","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:31:34","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733795 : EZ17::read_position() - position is 457 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 639 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 0 : Modtronix - voltage is 32.45 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 142.790218) Behavior waypoint:-1 has changed to state Finished : Waypoint Initialization: Begin waypoint control at t= 142.79 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061538.9 , 584558.3 (wplog) The bearing to the next w.p. is 212.4 Degrees. : LayeredControl::execute() -- (t = 142.790218) Behavior waypoint:-1 has changed to state Active : EZ17::read_position() - position is 0 : EZ17::read_position() - position is 660 : EZ17::read_position() - position is 660 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.45 V, Total current = -4.94 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.80 A Charge Current = 0.00 A : EZ17::read_position() - position is 660 : EZ17::save_position() - Saving the position: 660 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 31 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Navigation:: deltaT = 2.01 is impermissible. : EZ17::read_position() - position is 660 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 547 : Modtronix - voltage is 32.45 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 422 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 152.799533) Behavior waypoint:-1 has changed to state Finished : CARL - Id:113, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:-1, brightness:-1, record:-1, homeIris:-1, fstop:561, auto-iris:-1.00 : CARL Behavior 113: set the fstop to 561 : CARLServer::iris_control - fstop 561 : CARL Behavior 113: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : LayeredControl::execute() -- (t = 152.799533) Behavior CARL:113 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 152.80 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061539.3 , 584261.3 (wplog) The bearing to the next w.p. is 231.6 Degrees. : LayeredControl::execute() -- (t = 152.799533) Behavior waypoint:-1 has changed to state Active : CARL::done() - 113 all done! : LayeredControl::execute() -- (t = 152.999519) Behavior CARL:113 has changed to state Finished : EZ17::read_position() - position is 300 : Modtronix - voltage is 32.45 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}2:15","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:52:33","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:52:33","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733813, duration of 18 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::clipname(_000m_F561) - : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:52:33","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F561) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185654Z_000m_F561 : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185654Z_000m_F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:52:33","last_config_update":"0"}] : newBatt::Average voltage = 32.45 V, Total current = -4.94 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.80 A Charge Current = 0.00 A : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:52:33","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:56:52:33","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733815 : 32 i2MAP_20180123T185654Z_000m_F561 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 45 : Modtronix - voltage is 32.45 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 15 : EZ17::read_position() - position is 15 : EZ17::save_position() - Saving the position: 15 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 561 0.000000 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 162.998834) Behavior waypoint:-1 has changed to state Finished : CARL - Id:108, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:0, homeIris:1, fstop:-1, auto-iris:-1.00 : CARL Behavior 108: Home the iris motor : CARLServer::iris_control - home : CARL Behavior 108: Turning lights off : CARLServer::camera_lights_off : CARL Behavior 108: cut! : CARLServer::stop_recording()... : CARL Behavior 108: resetting record : LayeredControl::execute() -- (t = 162.998834) Behavior CARL:108 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 163.00 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061594.6 , 584117.3 (wplog) The bearing to the next w.p. is 240.5 Degrees. : LayeredControl::execute() -- (t = 162.998834) Behavior waypoint:-1 has changed to state Active : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : CARL::done() - 108 all done! : LayeredControl::execute() -- (t = 163.198820) Behavior CARL:108 has changed to state Finished : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.45 : dvlSOS = 1500.000000 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::set_pin() - b2=1 : Modtronix::light_power[0] = 0 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b3=1 : Modtronix::light_power[1] = 0 : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : newBatt::Average voltage = 32.45 V, Total current = -5.03 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.80 A Charge Current = 0.00 A : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::msg_handler() - cut : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}3:21","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:03:43","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:03:43","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733825, duration of 10 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.45 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : EZ17::read_position() - position is 200 : EZ17::save_position() - Saving the position: 200 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 18 0 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 173.198135) Behavior waypoint:-1 has changed to state Finished : CARL - Id:110, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:1, homeIris:-1, fstop:31, auto-iris:-1.00 : CARL Behavior 110: set the fstop to 31 : CARLServer::iris_control - fstop 31 : CARL Behavior 110: Turning lights off : CARLServer::camera_lights_off : CARL Behavior 110: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : CARL Behavior 110: action! : CARLServer::start_recording()... : CARL Behavior 110: resetting record : LayeredControl::execute() -- (t = 173.198135) Behavior CARL:110 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 173.20 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061595.9 , 584257.4 (wplog) The bearing to the next w.p. is 235.2 Degrees. : LayeredControl::execute() -- (t = 173.198135) Behavior waypoint:-1 has changed to state Active : CARL::done() - 110 all done! : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : LayeredControl::execute() -- (t = 173.398121) Behavior CARL:110 has changed to state Finished : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.45 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::set_pin() - b2=1 : Modtronix::light_power[0] = 0 : gpsDriver::readRecord() - serial device timed out : Modtronix::set_pin() - b3=1 : dvlSOS = 1500.000000 : Modtronix::light_power[1] = 0 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : newBatt::Average voltage = 32.44 V, Total current = -4.25 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : Modtronix::clipname(_000m_F031) - : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} 57:04:12","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:13:35","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F031) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185714Z_000m_F031 : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185714Z_000m_F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:13:35","last_config_update":"0"}] : 32 i2MAP_20180123T185714Z_000m_F031 : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:13:35","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:13:35","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733835 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 386 : Modtronix - voltage is 32.44 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 511 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 638 : Modtronix - voltage is 32.44 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 0 : Modtronix - voltage is 32.44 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 183.397436) Behavior waypoint:-1 has changed to state Finished : Waypoint Initialization: Begin waypoint control at t= 183.40 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061599.0 , 584567.7 (wplog) The bearing to the next w.p. is 215.1 Degrees. : LayeredControl::execute() -- (t = 183.397436) Behavior waypoint:-1 has changed to state Active : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.44 V, Total current = -4.13 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.00 A Charge Current = 0.00 A : EZ17::read_position() - position is 0 : EZ17::read_position() - position is 660 : EZ17::read_position() - position is 660 : dvlSOS = 1500.000000 : gpsDriver::readRecord() - serial device timed out : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 660 : EZ17::save_position() - Saving the position: 660 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 31 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 660 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : gpsDriver::readRecord() - serial device timed out : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 556 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 428 : Modtronix - voltage is 32.44 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 193.596738) Behavior waypoint:-1 has changed to state Finished : CARL - Id:119, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:-1, brightness:-1, record:-1, homeIris:-1, fstop:561, auto-iris:-1.00 : CARL Behavior 119: set the fstop to 561 : CARLServer::iris_control - fstop 561 : CARL Behavior 119: Setting clipname : Modtronix::msg_handler() - saving EZ17 message : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : LayeredControl::execute() -- (t = 193.596738) Behavior CARL:119 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 193.60 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061602.0 , 584867.9 (wplog) The bearing to the next w.p. is 178.8 Degrees. : Modtronix::cut() - : LayeredControl::execute() -- (t = 193.596738) Behavior waypoint:-1 has changed to state Active : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}2:17","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:32:36","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:32:36","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733853, duration of 18 : CARL::done() - 119 all done! : LayeredControl::execute() -- (t = 193.796724) Behavior CARL:119 has changed to state Finished : Modtronix::clipname(_000m_F561) - : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:32:36","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F561) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185733Z_000m_F561 : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185733Z_000m_F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:32:36","last_config_update":"0"}] : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:32:36","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:32:36","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733854 : 32 i2MAP_20180123T185733Z_000m_F561 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : newBatt::Average voltage = 32.44 V, Total current = -4.28 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : EZ17::read_position() - position is 269 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 178 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 52 : Modtronix - voltage is 32.44 : EventService::processEvent() - unknown event, code=40080, pid=15 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 15 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 203.796039) Behavior waypoint:-1 has changed to state Finished : CARL - Id:108, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:0, homeIris:1, fstop:-1, auto-iris:-1.00 : CARL Behavior 108: Home the iris motor : CARLServer::iris_control - home : CARL Behavior 108: Turning lights off : CARLServer::camera_lights_off : CARL Behavior 108: cut! : CARLServer::stop_recording()... : CARL Behavior 108: resetting record : LayeredControl::execute() -- (t = 203.796039) Behavior CARL:108 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 203.80 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061536.8 , 585022.1 (wplog) The bearing to the next w.p. is 161.2 Degrees. : LayeredControl::execute() -- (t = 203.796039) Behavior waypoint:-1 has changed to state Active : EZ17::read_position() - position is 15 : EZ17::save_position() - Saving the position: 15 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 561 0.000000 : CARL::done() - 108 all done! : LayeredControl::execute() -- (t = 203.996025) Behavior CARL:108 has changed to state Finished : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : newBatt::Average voltage = 32.44 V, Total current = -4.33 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.44 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::set_pin() - b2=1 : Modtronix::light_power[0] = 0 : dvlSOS = 1500.000000 : Modtronix::set_pin() - b3=1 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::light_power[1] = 0 : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : gpsDriver::readRecord() - serial device timed out : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::msg_handler() - cut : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}5:19","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:45:39","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - , return 28 : Modtronix end_clip @ 1516733867, duration of 13 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : EZ17::read_position() - position is 200 : EZ17::save_position() - Saving the position: 200 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 18 0 0.000000 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 213.995340) Behavior waypoint:-1 has changed to state Finished : CARL - Id:110, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:1, brightness:-1, record:1, homeIris:-1, fstop:31, auto-iris:-1.00 : CARL Behavior 110: set the fstop to 31 : CARLServer::iris_control - fstop 31 : CARL Behavior 110: Turning lights on : CARLServer::camera_lights_on : CARL Behavior 110: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : CARL Behavior 110: action! : CARLServer::start_recording()... : CARL Behavior 110: resetting record : LayeredControl::execute() -- (t = 213.995340) Behavior CARL:110 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 214.00 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061535.4 , 584881.9 (wplog) The bearing to the next w.p. is 177.3 Degrees. : LayeredControl::execute() -- (t = 213.995340) Behavior waypoint:-1 has changed to state Active : CARL::done() - 110 all done! : LayeredControl::execute() -- (t = 214.195327) Behavior CARL:110 has changed to state Finished : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : gpsDriver::readRecord() - serial device timed out : newBatt::Average voltage = 32.44 V, Total current = -4.11 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.90 A Charge Current = 0.00 A : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.44 : Modtronix::msg_handler() - saving EZ17 message : Modtronix - voltage is 32.44 : Modtronix::set_pin() - b2=0 : Modtronix::light_power[0] = 1 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b3=0 : Modtronix::light_power[1] = 1 : Modtronix::set_pin() - b4=0 : Modtronix::light_power[2] = 1 : Modtronix::set_pin() - b5=0 : Modtronix::light_power[3] = 1 : Modtronix::clipname(_000m_F031) - : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} 57:46:11","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:55:31","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F031) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185758Z_000m_F031 : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185758Z_000m_F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:55:31","last_config_update":"0"}] : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : 32 i2MAP_20180123T185758Z_000m_F031 : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:55:31","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:55:31","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733878 : Modtronix::action() - Aja not recording! Press record again : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:55:31","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:57:55:31","last_config_update":"0"}], return 0 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 513 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 638 : Modtronix - voltage is 32.44 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 224.194642) Behavior waypoint:-1 has changed to state Finished : Waypoint Initialization: Begin waypoint control at t= 224.19 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061532.4 , 584571.7 (wplog) The bearing to the next w.p. is 210.9 Degrees. : LayeredControl::execute() -- (t = 224.194642) Behavior waypoint:-1 has changed to state Active : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.44 V, Total current = -4.08 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : EZ17::read_position() - position is 0 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 0 : EZ17::read_position() - position is 660 : EZ17::read_position() - position is 660 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 660 : EZ17::save_position() - Saving the position: 660 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 31 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 660 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 552 : Modtronix - voltage is 32.44 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 234.393943) Behavior waypoint:-1 has changed to state Finished : CARL - Id:124, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:-1, brightness:-1, record:-1, homeIris:-1, fstop:561, auto-iris:-1.00 : CARL Behavior 124: set the fstop to 561 : CARLServer::iris_control - fstop 561 : CARL Behavior 124: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : LayeredControl::execute() -- (t = 234.393943) Behavior CARL:124 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 234.39 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061529.3 , 584261.4 (wplog) The bearing to the next w.p. is 231.0 Degrees. : LayeredControl::execute() -- (t = 234.393943) Behavior waypoint:-1 has changed to state Active : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : CARL::done() - 124 all done! : LayeredControl::execute() -- (t = 234.593929) Behavior CARL:124 has changed to state Finished : newBatt::Average voltage = 32.44 V, Total current = -4.86 A : newBatt::Env:20.9 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.60 A Charge Current = 0.00 A : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 427 : Modtronix - voltage is 32.44 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}4:16","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:14:34","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:14:34","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733895, duration of 17 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::clipname(_000m_F561) - : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:14:34","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F561) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185816Z_000m_F561 : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185816Z_000m_F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:14:34","last_config_update":"0"}] : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:14:34","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:14:34","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733897 : 32 i2MAP_20180123T185816Z_000m_F561 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 176 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 55 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 15 : gpsDriver::readRecord() - serial device timed out : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 244.593244) Behavior waypoint:-1 has changed to state Finished : CARL - Id:108, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:0, homeIris:1, fstop:-1, auto-iris:-1.00 : CARL Behavior 108: Home the iris motor : CARLServer::iris_control - home : CARL Behavior 108: Turning lights off : CARLServer::camera_lights_off : CARL Behavior 108: cut! : CARLServer::stop_recording()... : CARL Behavior 108: resetting record : LayeredControl::execute() -- (t = 244.593244) Behavior CARL:108 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 244.59 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061587.8 , 584120.7 (wplog) The bearing to the next w.p. is 240.0 Degrees. : LayeredControl::execute() -- (t = 244.593244) Behavior waypoint:-1 has changed to state Active : CARL::done() - 108 all done! : LayeredControl::execute() -- (t = 244.793231) Behavior CARL:108 has changed to state Finished : newBatt::Average voltage = 32.44 V, Total current = -5.00 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.1 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.90 A Charge Current = 0.00 A : EZ17::read_position() - position is 15 : EZ17::read_position() - position is 15 : EZ17::save_position() - Saving the position: 15 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 561 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.44 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::set_pin() - b2=1 : Modtronix::light_power[0] = 0 : Modtronix::set_pin() - b3=1 : dvlSOS = 1500.000000 : Modtronix::light_power[1] = 0 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::msg_handler() - cut : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}7:16","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:27:34","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:27:34","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733908, duration of 11 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 254.792546) Behavior waypoint:-1 has changed to state Finished : CARL - Id:110, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:1, homeIris:-1, fstop:31, auto-iris:-1.00 : CARL Behavior 110: set the fstop to 31 : CARLServer::iris_control - fstop 31 : CARL Behavior 110: Turning lights off : CARLServer::camera_lights_off : CARL Behavior 110: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : CARL Behavior 110: action! : CARLServer::start_recording()... : CARL Behavior 110: resetting record : LayeredControl::execute() -- (t = 254.792546) Behavior CARL:110 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 254.79 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061585.9 , 584267.5 (wplog) The bearing to the next w.p. is 234.1 Degrees. : LayeredControl::execute() -- (t = 254.792546) Behavior waypoint:-1 has changed to state Active : newBatt::Average voltage = 32.43 V, Total current = -4.58 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : CARL::done() - 110 all done! : LayeredControl::execute() -- (t = 254.992532) Behavior CARL:110 has changed to state Finished : EZ17::read_position() - position is 200 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 200 : EZ17::save_position() - Saving the position: 200 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 18 0 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 200 : Modtronix - voltage is 32.43 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::set_pin() - b2=1 : Modtronix::light_power[0] = 0 : Modtronix::set_pin() - b3=1 : dvlSOS = 1500.000000 : Modtronix::light_power[1] = 0 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::clipname(_000m_F031) - : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} 58:28:08","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:37:35","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F031) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185838Z_000m_F031 : KiPro::set_clip_name(_000m_F031) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185838Z_000m_F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:37:35","last_config_update":"0"}] : 32 i2MAP_20180123T185838Z_000m_F031 : gpsDriver::readRecord() - serial device timed out : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F031","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:37:35","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:37:35","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733919 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 388 : Modtronix - voltage is 32.43 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 511 : Modtronix - voltage is 32.43 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.44 V, Total current = -4.14 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.1 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.10 A Charge Current = 0.00 A : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 264.991847) Behavior waypoint:-1 has changed to state Finished : Waypoint Initialization: Begin waypoint control at t= 264.99 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061588.9 , 584567.8 (wplog) The bearing to the next w.p. is 214.5 Degrees. : LayeredControl::execute() -- (t = 264.991847) Behavior waypoint:-1 has changed to state Active : EZ17::read_position() - position is 637 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 0 : Modtronix - voltage is 32.44 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 0 : EZ17::read_position() - position is 660 : EZ17::read_position() - position is 660 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 660 : EZ17::save_position() - Saving the position: 660 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 19 31 0.000000 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 660 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.44 V, Total current = -4.31 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 275.191148) Behavior waypoint:-1 has changed to state Finished : CARL - Id:110, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:-1, brightness:-1, record:1, homeIris:-1, fstop:561, auto-iris:-1.00 : CARL Behavior 110: set the fstop to 561 : CARLServer::iris_control - fstop 561 : CARL Behavior 110: Setting clipname : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : CARL Behavior 110: action! : CARLServer::start_recording()... : CARL Behavior 110: resetting record : LayeredControl::execute() -- (t = 275.191148) Behavior CARL:110 has changed to state Active : Waypoint Initialization: Begin waypoint control at t= 275.19 (wplog) The current location (N,E) = 4062013.7 , 584859.3 (wplog) The next waypoint = 4061592.0 , 584878.0 (wplog) The bearing to the next w.p. is 177.5 Degrees. : LayeredControl::execute() -- (t = 275.191148) Behavior waypoint:-1 has changed to state Active : EZ17::read_position() - position is 549 : Modtronix - voltage is 32.44 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}4:17","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:54:36","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:54:36","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733935, duration of 16 : CARL::done() - 110 all done! : LayeredControl::execute() -- (t = 275.391135) Behavior CARL:110 has changed to state Finished : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::clipname(_000m_F561) - : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:54:36","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F561) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185856Z_000m_F561 : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185856Z_000m_F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:54:36","last_config_update":"0"}] : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:54:36","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:54:36","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733937 : 32 i2MAP_20180123T185856Z_000m_F561 : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}mmand"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:54:36","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:58:54:36","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733937 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 302 : Modtronix - voltage is 32.44 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 175 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 51 : Modtronix - voltage is 32.44 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.44 V, Total current = -4.39 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.00 A Charge Current = 0.00 A : EZ17::read_position() - position is 15 : Modtronix - voltage is 32.44 : Behavior waypoint - Timed out! : LayeredControl::execute() -- (t = 285.390450) Behavior waypoint:-1 has changed to state Finished : CARL - Id:110, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:-1, brightness:-1, record:1, homeIris:-1, fstop:561, auto-iris:-1.00 : CARL Behavior 110: set the fstop to 561 : CARLServer::iris_control - fstop 561 : CARL Behavior 110: Setting clipname : Modtronix::msg_handler() - saving EZ17 message : CARLServer::set_clipname() - using depth: 0 from _navIF? 1 : CARL Behavior 110: action! : CARLServer::start_recording()... : CARL Behavior 110: resetting record : LayeredControl::execute() -- (t = 285.390450) Behavior CARL:110 has changed to state Active : LayeredControl::execute() -- (t = 285.390450) Behavior ascend:-1 has changed to state Finished : LayeredControl::execute() -- (t = 285.390450) Behavior ascend:-1 has changed to state Finished : LayeredControl::execute() -- (t = 285.390450) Behavior getgps:-1 has changed to state Active : DynamicControlServer::Begin horizontal mode 0 at t = 285.38 sec. : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}4:16","last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733945, duration of 8 : CARL::done() - 110 all done! : LayeredControl::execute() -- (t = 285.590436) Behavior CARL:110 has changed to state Finished : CARL - Id:108, Duration:1.000000, cameraSwitch:-1, recorderSwitch:-1, lightSwitch:0, brightness:-1, record:0, homeIris:1, fstop:-1, auto-iris:-1.00 : CARL Behavior 108: Home the iris motor : CARLServer::iris_control - home : CARL Behavior 108: Turning lights off : CARLServer::camera_lights_off : CARL Behavior 108: cut! : CARLServer::stop_recording()... : CARL Behavior 108: resetting record : LayeredControl::execute() -- (t = 285.590436) Behavior CARL:108 has changed to state Active : CARL::done() - 108 all done! : LayeredControl::execute() -- (t = 285.790422) Behavior CARL:108 has changed to state Finished : Modtronix::clipname(_000m_F561) - : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318832650","name":"eParamID_UseCustomClipName","value":"1","value_name":"ON"} Command"} "last_config_update":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}] : KiPro::set_clip_name(_000m_F561) url - http://134.89.32.54/config?action=set¶mid=eParamID_CustomClipName&value=i2MAP_20180123T185905Z_000m_F561 : KiPro::set_clip_name(_000m_F561) response - {"paramid":"318898186","name":"eParamID_CustomClipName","value":"i2MAP_20180123T185905Z_000m_F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}] : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} _F561","value_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733946 : 32 i2MAP_20180123T185905Z_000m_F561 : Modtronix::action() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}mmand"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}] : KiPro::record_button(1) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=3 : KiPro::record_button(1) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"3","value_name":"Record Command"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}], return 0 : Modtronix start_clip @ 1516733946 : Modtronix::msg_handler() - saving EZ17 message : Modtronix::set_pin() - b2=1 : dvlSOS = 1500.000000 : Modtronix::light_power[0] = 0 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b3=1 : Modtronix::light_power[1] = 0 : Modtronix::set_pin() - b4=1 : Modtronix::light_power[2] = 0 : Modtronix::set_pin() - b5=1 : Modtronix::light_power[3] = 0 : Modtronix::msg_handler() - cut : Modtronix::cut() - : KiPro::record_mode() url - http://134.89.32.54/config?action=set¶mid=eParamID_MediaState&value=0 : KiPro::record_mode() response - {"paramid":"201392128","name":"eParamID_MediaState","value":"0","value_name":"Record-Play"} "}mmand"} lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}] : KiPro::record_button(0) url - http://134.89.32.54/config?action=set¶mid=eParamID_TransportCommand&value=4 : KiPro::record_button(0) response - {"paramid":"2097217546","name":"eParamID_TransportCommand","value":"4","value_name":"Stop Command"} } lue_name":""} ate":"0"},{"param_id":"eParamID_InputTimecode","param_type":"12","int_value":"0","str_value":"18:59:04:34","last_config_update":"0"}], return 0 : Modtronix end_clip @ 1516733947, duration of 1 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 15 : EZ17::read_position() - position is 15 : EZ17::save_position() - Saving the position: 15 : Modtronix - There is a saved msg for the EZ17 : Modtronix::EZ17Handler() - got message 18 0 0.000000 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - 0 bytes read from EZ17, expecting 8 : EZ17::read_position() - position is 15 : gpsDriver::readRecord() - serial device timed out : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Navigation:: deltaT = 2.01 is impermissible. : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.44 V, Total current = -4.24 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.60 A Charge Current = 0.00 A : EZ17::read_position() - position is 201 : Modtronix - voltage is 32.44 : Behavior getgps - Timed out! : LayeredControl::execute() -- (t = 295.399764) Behavior getgps:-1 has changed to state Finished : Stack empty after processing. Aborting. : *** LayeredControl - initiating mission abort... *** : Initiating Mission Abort! : **** EventTriggers::add() - attaching proxy : LayeredControl::execute() -- (t = 295.599750) Behavior setpoint:-1 has changed to state Active : LayeredControl::execute() -- (t = 295.599750) Behavior depthEnvelope:-1 has changed to state Active : LayeredControl::execute() -- (t = 295.599750) Behavior missionTimer:-1 has changed to state Active : DynamicControlServer::Begin horizontal mode 1 at t = 295.59 sec. : DynamicControlServer::Begin vertical mode 1 at t = 295.59 sec. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 328 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 451 : Modtronix - voltage is 32.44 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 581 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 704 : Modtronix - voltage is 32.44 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.44 V, Total current = -4.16 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.1 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.90 A Charge Current = 0.00 A : EZ17::read_position() - position is 0 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 0 : EZ17::read_position() - position is 660 : gpsDriver::readRecord() - serial device timed out : EZ17::read_position() - position is 660 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : EZ17::read_position() - position is 660 : EZ17::save_position() - Saving the position: 660 : Modtronix - voltage is 32.44 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.44 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.44 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.44 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.43 V, Total current = -4.51 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.30 A Charge Current = 0.00 A : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b0=0 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.43 V, Total current = -4.55 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.1 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.90 A Charge Current = 0.00 A : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.43 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.43 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.43 V, Total current = -4.62 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 4.00 A Charge Current = 0.00 A : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b7=0 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b7=1 : gpsDriver::readRecord() - serial device timed out : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.43 V, Total current = -4.41 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 3.90 A Charge Current = 0.00 A : dvlSOS = 1500.000000 : Modtronix - voltage is 32.43 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix::set_pin() - b1=0 : dvlSOS = 1500.000000 : gpsDriver::readRecord() - serial device timed out : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.43 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.43 : dvlSOS = 1500.000000 : gpsDriver::readRecord() - serial device timed out : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : Modtronix - voltage is 32.43 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : newBatt::Average voltage = 32.43 V, Total current = -4.21 A : newBatt::Env:21.0 C, 22.5 C, 10.1 %rH : newBatt::packsOnline = 55 : newBatt::Charge = 0.8 V, Disch = 32.2 V : newBatt::Aux Current = 0.00 A, Discharge Current = 1.80 A Charge Current = 0.00 A : Modtronix - voltage is 32.43 : dvlSOS = 1500.000000 : Navigation:: Error - _dvl->valid is true, but neither water mass nor bottom referenced velocities are valid. : gpsDriver::readRecord() - serial device timed out : Modtronix - voltage is 32.43 : **** SharedData destructor for object ParosciOutput_ShmemName **** : TaskServer::signalHandler() for task AhrsIFServer - exit() on signal 2 : TaskServer::signalHandler() for task GpsIFServer - exit() on signal 2 : TaskServer::signalHandler() for task DepthSensorIFServer - exit() on signal 2 : TaskServer::signalHandler() for task DvlIFServer - exit() on signal 2 : TaskServer::signalHandler() for task WorkSiteIFServer - exit() on signal 2 : TaskServer::signalHandler() for task NavigationIFServer - exit() on signal 2 : TaskServer::signalHandler() for task DynamicControlIFServer - exit() on signal 2 : **** SharedData destructor for object LayeredControlOutput_ShmemName **** : TaskServer::signalHandler() for task TailConeIFServer - exit() on signal 2 : TaskServer::signalHandler() for task VehicleConfigurationIFServer - exit() on signal 2 //1/home/dorado1/auv-qnx-dev/auv/altex/onboard/bin/dvl terminated (SIGSEGV) at 0007:00024CBF. : TaskServer::signalHandler() for task LayeredControlIFServer - exit() on signal 2 : TaskServer::signalHandler() for task NewBattIFServer - exit() on signal 2 : TaskServer::signalHandler() for task seabird25p - exit() on signal 2 : TaskServer::signalHandler() for task DropWeightIFServer - exit() on signal 2 : **** SharedData destructor for object GpsOutput_ShmemName **** : DropWeight Destructor Executing. : **** SharedData destructor for object ModtronixOutput_ShmemName **** : **** SharedData destructor for object seabird25pSeabirdOutput_ShmemName **** : destroying segment ParosciOutput_ShmemName : TaskServer::signalHandler() for task ExternalCommsIFServer - exit() on signal 2 : TaskServer::signalHandler() for task CARL_IFServer - exit() on signal 2 : **** SharedData destructor for object newBatt1 **** : Supervisor::signalHandler - caught signal 2 : TaskServer::signalHandler() for task EventLogIFServer - exit() on signal 2 : **** SharedData destructor for object m3dmgx1 **** : **** SharedData destructor for object GpsOutput_ShmemName **** : **** SharedData destructor for object ParosciOutput_ShmemName **** : **** SharedData destructor for object DvlOutput_ShmemName **** : NavigationOutput::~NavigationOutput() : DynamicControlServer::Destructor. Difference between clock time and accumulated sample periods is -0.21, at t=357.19. : destroying segment LayeredControlOutput_ShmemName : **** SharedData destructor for object TailConeInput_ShmemName **** : **** SharedData destructor for object LayeredControlInput_ShmemName **** : destroying segment GpsOutput_ShmemName : **** SharedData destructor for object m3dmgx1Cmd **** : **** SharedData destructor for object seabird25pSeabirdOutput_ShmemName **** : **** SharedData destructor for object dropWeightOutput **** : destroying segment ModtronixOutput_ShmemName : destroying segment seabird25pSeabirdOutput_ShmemName : destroying prot sem ParosciOutput_ShmemName_prot : Supervisor::signalHandler - setting exit flag [1] : destroying segment newBatt1 : destroying segment m3dmgx1 : NavigationOutput::~NavigationOutput() : destroying segment GpsOutput_ShmemName : **** SharedData destructor for object dropWeightOutput **** : destroying segment ParosciOutput_ShmemName : destroying segment DvlOutput_ShmemName : **** SharedData destructor for object navigationOutput **** //1/home/dorado1/auv-qnx-dev/auv/altex/onboard/bin/newBattServer terminated (SIGSEGV) at 0007:000201F7. : TaskServer::signalHandler() for task DvlIFServer - exit() on signal 18 : destroying prot sem LayeredControlOutput_ShmemName_prot : destroying segment TailConeInput_ShmemName : destroying segment LayeredControlInput_ShmemName : destroying prot sem GpsOutput_ShmemName_prot : destroying segment m3dmgx1Cmd : destroying segment seabird25pSeabirdOutput_ShmemName : destroying segment dropWeightOutput : destroying prot sem m3dmgx1Cmd_prot : destroying prot sem ModtronixOutput_ShmemName_prot : destroying prot sem seabird25pSeabirdOutput_ShmemName_prot : destroying notify sem ParosciOutput_ShmemName_notify : Supervisor::run - caught stop signal - exiting run loop : destroying prot sem newBatt1_prot : destroying prot sem m3dmgx1_prot : **** SharedData destructor for object navigationOutput **** : destroying prot sem GpsOutput_ShmemName_prot : destroying segment dropWeightOutput : destroying prot sem ParosciOutput_ShmemName_prot : destroying segment navigationOutput : destroying notify sem LayeredControlOutput_ShmemName_notify : destroying prot sem TailConeInput_ShmemName_prot : destroying prot sem LayeredControlInput_ShmemName_prot : destroying notify sem GpsOutput_ShmemName_notify : destroying prot sem seabird25pSeabirdOutput_ShmemName_prot : destroying prot sem dropWeightOutput_prot : destroying notify sem m3dmgx1Cmd_notify : destroying notify sem ModtronixOutput_ShmemName_notify : destroying notify sem seabird25pSeabirdOutput_ShmemName_notify : Supervisor::run - calling shutdown/exit : destroying notify sem newBatt1_notify : destroying notify sem m3dmgx1_notify : destroying segment navigationOutput : destroying notify sem GpsOutput_ShmemName_notify : destroying prot sem dropWeightOutput_prot : TaskServer::signalHandler() for task DepthSensorIFServer - exit() on signal 18 : destroying prot sem navigationOutput_prot : **** SharedData destructor for object LayeredControlInput_ShmemName **** : destroying notify sem TailConeInput_ShmemName_notify : destroying notify sem LayeredControlInput_ShmemName_notify : destroying notify sem seabird25pSeabirdOutput_ShmemName_notify : TaskServer::signalHandler() for task GpsIFServer - exit() on signal 18 : destroying notify sem dropWeightOutput_notify : **** SharedData destructor for object m3dmgx1 **** : Supervisor::shutdown - signaling processes : **** SharedData destructor for object m3dmgx1Cmd **** : destroying prot sem navigationOutput_prot : destroying notify sem dropWeightOutput_notify : destroying notify sem navigationOutput_notify : destroying segment LayeredControlInput_ShmemName : **** SharedData destructor for object TailConeOutput_ShmemName **** : TaskServer::signalHandler() for task seabird25p - exit() on signal 18 : **** SharedData destructor for object LayeredControlOutput_ShmemName **** : destroying segment m3dmgx1 : TaskServer::signalHandler() for task AhrsIFServer - exit() on signal 2 : TaskServer::signalHandler() for task seabird25p - exit() on signal 2 : Supervisor::signalHandler - caught signal 2 : destroying notify sem navigationOutput_notify : failed to unlink queue NavigationInput : destroying prot sem LayeredControlInput_ShmemName_prot : destroying segment TailConeOutput_ShmemName : destroying segment LayeredControlOutput_ShmemName : Supervisor::signalHandler possible duplicate signal[2] : TaskServer::signalHandler() for task NavigationIFServer - exit() on signal 2 : destroying notify sem LayeredControlInput_ShmemName_notify : destroying prot sem TailConeOutput_ShmemName_prot : destroying prot sem LayeredControlOutput_ShmemName_prot : Supervisor::signalHandler - setting exit flag [2] : TaskServer::signalHandler() for task LayeredControlIFServer - exit() on signal 2 : destroying notify sem TailConeOutput_ShmemName_notify : Supervisor::shutdown - cleaning up : Supervisor::shutdown - deleting output : **** SharedData destructor for object SupervisorOutout **** : destroying segment SupervisorOutout : destroying prot sem SupervisorOutout_prot : destroying notify sem SupervisorOutout_notify : Supervisor::shutdown - done : Supervisor::~Supervisor - dtor : StepGetStat (2) failed to read chars, rcvd=3, want=8 : StepGetStat (2) 9c 5d 5d 00 05 00 00 : StepGetStat (2) failed to read chars, rcvd=2, want=8 : StepGetStat (2) 18 18 00 00 05 00 00 : **** SharedData destructor for object TailConeInput_ShmemName **** : destroying segment TailConeInput_ShmemName : destroying prot sem TailConeInput_ShmemName_prot : destroying notify sem TailConeInput_ShmemName_notify : **** SharedData destructor for object TailConeOutput_ShmemName **** : destroying segment TailConeOutput_ShmemName : destroying prot sem TailConeOutput_ShmemName_prot : destroying notify sem TailConeOutput_ShmemName_notify