2010-02-04T21:42:48.259Z,1265319768.259 [Supervisor](DEBUG): Initializing supervisor. 2010-02-04T21:42:48.263Z,1265319768.263 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2010-02-04T21:42:48.264Z,1265319768.264 [SyncHandler](INFO): Protected caller Thread ID is 5213 2010-02-04T21:42:48.264Z,1265319768.264 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2010-02-04T21:42:48.265Z,1265319768.265 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2010-02-04T21:42:48.265Z,1265319768.265 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5214 2010-02-04T21:42:48.270Z,1265319768.270 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2010-02-04T21:42:48.288Z,1265319768.288 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2010-02-04T21:42:48.289Z,1265319768.289 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2010-02-04T21:42:48.289Z,1265319768.289 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 5215 2010-02-04T21:42:48.294Z,1265319768.294 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2010-02-04T21:42:48.295Z,1265319768.295 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2010-02-04T21:42:48.295Z,1265319768.295 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5216 2010-02-04T21:42:48.297Z,1265319768.297 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2010-02-04T21:42:48.298Z,1265319768.298 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2010-02-04T21:42:48.299Z,1265319768.299 [logger ThreadHandler](INFO): Protected caller Thread ID is 5217 2010-02-04T21:42:48.302Z,1265319768.302 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2010-02-04T21:42:48.303Z,1265319768.303 [Supervisor](INFO): Looking for Config files in directory: Config/ 2010-02-04T21:42:48.304Z,1265319768.304 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2010-02-04T21:42:48.397Z,1265319768.397 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2010-02-04T21:42:48.398Z,1265319768.398 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2010-02-04T21:42:48.606Z,1265319768.606 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2010-02-04T21:42:48.606Z,1265319768.606 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2010-02-04T21:42:48.851Z,1265319768.851 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2010-02-04T21:42:48.851Z,1265319768.851 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2010-02-04T21:42:48.956Z,1265319768.956 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2010-02-04T21:42:48.957Z,1265319768.957 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2010-02-04T21:42:49.615Z,1265319769.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2010-02-04T21:42:49.615Z,1265319769.615 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2010-02-04T21:42:50.147Z,1265319770.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2010-02-04T21:42:50.148Z,1265319770.148 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2010-02-04T21:42:50.616Z,1265319770.616 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2010-02-04T21:42:50.617Z,1265319770.617 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2010-02-04T21:42:50.999Z,1265319770.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2010-02-04T21:42:50.000Z,1265319771.000 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2010-02-04T21:42:51.310Z,1265319771.310 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2010-02-04T21:42:51.311Z,1265319771.311 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2010-02-04T21:42:51.667Z,1265319771.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2010-02-04T21:42:51.667Z,1265319771.667 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2010-02-04T21:42:51.883Z,1265319771.883 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2010-02-04T21:42:51.884Z,1265319771.884 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2010-02-04T21:42:52.019Z,1265319772.019 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2010-02-04T21:42:52.019Z,1265319772.019 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2010-02-04T21:42:52.098Z,1265319772.098 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2010-02-04T21:42:52.175Z,1265319772.175 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2010-02-04T21:42:52.358Z,1265319772.358 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2010-02-04T21:42:52.358Z,1265319772.358 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2010-02-04T21:42:52.574Z,1265319772.574 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2010-02-04T21:42:52.576Z,1265319772.576 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2010-02-04T21:42:52.577Z,1265319772.577 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2010-02-04T21:42:52.657Z,1265319772.657 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2010-02-04T21:42:52.914Z,1265319772.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2010-02-04T21:42:52.915Z,1265319772.915 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2010-02-04T21:42:53.029Z,1265319773.029 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2010-02-04T21:42:53.302Z,1265319773.302 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2010-02-04T21:42:53.761Z,1265319773.761 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2010-02-04T21:42:53.843Z,1265319773.843 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2010-02-04T21:42:53.984Z,1265319773.984 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2010-02-04T21:42:54.084Z,1265319774.084 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2010-02-04T21:42:54.233Z,1265319774.233 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2010-02-04T21:42:54.336Z,1265319774.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2010-02-04T21:42:54.431Z,1265319774.431 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2010-02-04T21:42:54.432Z,1265319774.432 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2010-02-04T21:42:54.449Z,1265319774.449 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2010-02-04T21:42:54.598Z,1265319774.598 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2010-02-04T21:42:54.599Z,1265319774.599 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2010-02-04T21:42:54.734Z,1265319774.734 [BuoyancyServo] Loaded 2010-02-04T21:42:54.734Z,1265319774.734 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2010-02-04T21:42:54.755Z,1265319774.755 [ElevatorServo] Loaded 2010-02-04T21:42:54.756Z,1265319774.756 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2010-02-04T21:42:54.776Z,1265319774.776 [MassServo] Loaded 2010-02-04T21:42:54.776Z,1265319774.776 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2010-02-04T21:42:54.797Z,1265319774.797 [RudderServo] Loaded 2010-02-04T21:42:54.797Z,1265319774.797 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2010-02-04T21:42:54.813Z,1265319774.813 [ThrusterHE] Loaded 2010-02-04T21:42:54.813Z,1265319774.813 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2010-02-04T21:42:54.814Z,1265319774.814 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2010-02-04T21:42:54.814Z,1265319774.814 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2010-02-04T21:42:54.958Z,1265319774.958 [SBIT](DEBUG): Construct Startup Built In Test. 2010-02-04T21:42:54.973Z,1265319774.973 [SBIT] Loaded 2010-02-04T21:42:54.973Z,1265319774.973 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2010-02-04T21:42:54.976Z,1265319774.976 [IBIT](DEBUG): Construct Initiated Built In Test. 2010-02-04T21:42:54.997Z,1265319774.997 [IBIT] Loaded 2010-02-04T21:42:54.997Z,1265319774.997 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2010-02-04T21:42:55.003Z,1265319775.003 [CBIT](DEBUG): Construct Continuous Built In Test. 2010-02-04T21:42:55.223Z,1265319775.223 [CBIT] Loaded 2010-02-04T21:42:55.223Z,1265319775.223 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2010-02-04T21:42:55.224Z,1265319775.224 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2010-02-04T21:42:55.224Z,1265319775.224 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2010-02-04T21:42:55.366Z,1265319775.366 [ESPComponent] Loaded 2010-02-04T21:42:55.366Z,1265319775.366 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2010-02-04T21:42:55.387Z,1265319775.387 [PAR_Licor] Loaded 2010-02-04T21:42:55.387Z,1265319775.387 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2010-02-04T21:42:55.388Z,1265319775.388 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2010-02-04T21:42:55.389Z,1265319775.389 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2010-02-04T21:42:55.439Z,1265319775.439 [DepthRateCalculator] Loaded 2010-02-04T21:42:55.439Z,1265319775.439 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2010-02-04T21:42:55.444Z,1265319775.444 [PitchRateCalculator] Loaded 2010-02-04T21:42:55.445Z,1265319775.445 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2010-02-04T21:42:55.455Z,1265319775.455 [SpeedCalculator] Loaded 2010-02-04T21:42:55.455Z,1265319775.455 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2010-02-04T21:42:55.471Z,1265319775.471 [VerticalHomogeneityIndexCalculator] Loaded 2010-02-04T21:42:55.471Z,1265319775.471 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread. 2010-02-04T21:42:55.476Z,1265319775.476 [YawRateCalculator] Loaded 2010-02-04T21:42:55.476Z,1265319775.476 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2010-02-04T21:42:55.496Z,1265319775.496 [ElevatorOffsetCalculator] Loaded 2010-02-04T21:42:55.496Z,1265319775.496 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2010-02-04T21:42:55.496Z,1265319775.496 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2010-02-04T21:42:55.497Z,1265319775.497 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2010-02-04T21:42:55.598Z,1265319775.598 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2010-02-04T21:42:55.598Z,1265319775.598 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2010-02-04T21:42:55.625Z,1265319775.625 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2010-02-04T21:42:55.626Z,1265319775.626 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2010-02-04T21:42:55.737Z,1265319775.737 [DeadReckonUsingMultipleVelocitySources] Loaded 2010-02-04T21:42:55.738Z,1265319775.738 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2010-02-04T21:42:55.752Z,1265319775.752 [NavChart] Loaded 2010-02-04T21:42:55.752Z,1265319775.752 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2010-02-04T21:42:55.758Z,1265319775.758 [UniversalFixResidualReporter] Loaded 2010-02-04T21:42:55.758Z,1265319775.758 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2010-02-04T21:42:55.759Z,1265319775.759 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2010-02-04T21:42:55.759Z,1265319775.759 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2010-02-04T21:42:56.159Z,1265319776.159 [BackseatComponent] Loaded 2010-02-04T21:42:56.159Z,1265319776.159 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2010-02-04T21:42:56.160Z,1265319776.160 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C44E0 2010-02-04T21:42:56.161Z,1265319776.161 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5300 2010-02-04T21:42:56.164Z,1265319776.164 [LcmUniversalReporter] Loaded 2010-02-04T21:42:56.164Z,1265319776.164 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2010-02-04T21:42:56.901Z,1265319776.901 [BPC1] Loaded 2010-02-04T21:42:56.901Z,1265319776.901 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2010-02-04T21:42:56.976Z,1265319776.976 [DataOverHttps] Loaded 2010-02-04T21:42:56.976Z,1265319776.976 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2010-02-04T21:42:56.977Z,1265319776.977 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F44E0 2010-02-04T21:42:56.978Z,1265319776.978 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5301 2010-02-04T21:42:56.999Z,1265319776.999 [Depth_Keller] Loaded 2010-02-04T21:42:56.999Z,1265319776.999 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2010-02-04T21:42:57.004Z,1265319777.004 [DropWeight] Loaded 2010-02-04T21:42:57.004Z,1265319777.004 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2010-02-04T21:42:57.044Z,1265319777.044 [DVL_micro] Loaded 2010-02-04T21:42:57.044Z,1265319777.044 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2010-02-04T21:42:57.105Z,1265319777.105 [NAL9602] Loaded 2010-02-04T21:42:57.105Z,1265319777.105 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2010-02-04T21:42:57.131Z,1265319777.131 [Onboard] Loaded 2010-02-04T21:42:57.132Z,1265319777.132 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2010-02-04T21:42:57.133Z,1265319777.133 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A244E0 2010-02-04T21:42:57.133Z,1265319777.133 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5302 2010-02-04T21:42:57.145Z,1265319777.145 [Power24vConverter] Loaded 2010-02-04T21:42:57.146Z,1265319777.146 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2010-02-04T21:42:57.159Z,1265319777.159 [Radio_Surface] Loaded 2010-02-04T21:42:57.159Z,1265319777.159 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2010-02-04T21:42:57.160Z,1265319777.160 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A544E0 2010-02-04T21:42:57.161Z,1265319777.161 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5303 2010-02-04T21:42:57.256Z,1265319777.256 [DAT] Loaded 2010-02-04T21:42:57.257Z,1265319777.257 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2010-02-04T21:42:57.258Z,1265319777.258 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A844E0 2010-02-04T21:42:57.258Z,1265319777.258 [DAT ThreadHandler](INFO): Protected caller Thread ID is 5304 2010-02-04T21:42:57.259Z,1265319777.259 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2010-02-04T21:42:57.259Z,1265319777.259 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2010-02-04T21:42:57.329Z,1265319777.329 [StratificationFrontDetector](IMPORTANT): thresholdVTHI set to: 0.050012 degC 2010-02-04T21:42:57.330Z,1265319777.330 [StratificationFrontDetector](INFO): (re)initializing 2010-02-04T21:42:57.330Z,1265319777.330 [StratificationFrontDetector] Loaded 2010-02-04T21:42:57.330Z,1265319777.330 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2010-02-04T21:42:57.331Z,1265319777.331 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2010-02-04T21:42:57.331Z,1265319777.331 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2010-02-04T21:42:57.382Z,1265319777.382 [VerticalControl](DEBUG): Construct VerticalControl. 2010-02-04T21:42:57.434Z,1265319777.434 [VerticalControl] Loaded 2010-02-04T21:42:57.434Z,1265319777.434 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2010-02-04T21:42:57.437Z,1265319777.437 [HorizontalControl](DEBUG): Construct HorizontalControl. 2010-02-04T21:42:57.475Z,1265319777.475 [HorizontalControl] Loaded 2010-02-04T21:42:57.475Z,1265319777.475 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2010-02-04T21:42:57.478Z,1265319777.478 [SpeedControl](DEBUG): Construct SpeedControl. 2010-02-04T21:42:57.480Z,1265319777.480 [SpeedControl] Loaded 2010-02-04T21:42:57.480Z,1265319777.480 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2010-02-04T21:42:57.483Z,1265319777.483 [LoopControl](DEBUG): Construct LoopControl. 2010-02-04T21:42:57.483Z,1265319777.483 [LoopControl] Loaded 2010-02-04T21:42:57.483Z,1265319777.483 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2010-02-04T21:42:57.484Z,1265319777.484 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2010-02-04T21:42:57.484Z,1265319777.484 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2010-02-04T21:42:57.495Z,1265319777.495 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2010-02-04T21:42:57.496Z,1265319777.496 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2010-02-04T21:42:57.805Z,1265319777.805 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2010-02-04T21:42:57.811Z,1265319777.811 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2010-02-04T21:42:57.814Z,1265319777.814 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2010-02-04T21:42:57.825Z,1265319777.825 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2010-02-04T21:42:57.826Z,1265319777.826 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B7E4E0 2010-02-04T21:42:57.827Z,1265319777.827 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5305 2010-02-04T21:42:57.831Z,1265319777.831 [Supervisor](INFO): Main Thread ID is 5212 2010-02-04T21:42:57.831Z,1265319777.831 [Supervisor](DEBUG): Running supervisor. 2010-02-04T21:42:57.832Z,1265319777.832 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5306 2010-02-04T21:42:57.832Z,1265319777.832 [CommandExec](INFO): Initializing the command executive. 2010-02-04T21:42:57.834Z,1265319777.834 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5307 2010-02-04T21:42:57.836Z,1265319777.836 [controlThread ThreadHandler](INFO): Handler Thread ID is 5308 2010-02-04T21:42:57.837Z,1265319777.837 [controlThread](DEBUG): Initializing ControlThread 2010-02-04T21:42:57.838Z,1265319777.838 [SBIT](INFO): Initialize SBIT Component. 2010-02-04T21:42:57.839Z,1265319777.839 [SBIT](IMPORTANT): git: 2023-03-31_A 2010-02-04T21:42:57.839Z,1265319777.839 [SBIT](INFO): git hash: af64d0505c79dd7b718d6df4bbafdde730718da9 2010-02-04T21:42:57.839Z,1265319777.839 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2010-02-04T21:42:57.841Z,1265319777.841 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2010-02-04T21:42:57.842Z,1265319777.842 [SBIT](INFO): Beginning SBIT in 145.000000 seconds. 2010-02-04T21:42:57.842Z,1265319777.842 [IBIT](INFO): Initialize IBIT Component. 2010-02-04T21:42:57.843Z,1265319777.843 [CBIT](DEBUG): Initialize CBIT Component. 2010-02-04T21:42:57.844Z,1265319777.844 [logger ThreadHandler](INFO): Handler Thread ID is 5309 2010-02-04T21:42:57.855Z,1265319777.855 [CBIT](DEBUG): Initialized mux pins. 2010-02-04T21:42:57.855Z,1265319777.855 [CBIT](DEBUG): Initializing the watchdog timer. 2010-02-04T21:42:57.864Z,1265319777.864 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 5310 2010-02-04T21:42:57.879Z,1265319777.879 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2010-02-04T21:42:57.879Z,1265319777.879 [CBIT](DEBUG): Initializing heartbeat. 2010-02-04T21:42:57.880Z,1265319777.880 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5311 2010-02-04T21:42:57.881Z,1265319777.881 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2010-02-04T21:42:57.892Z,1265319777.892 [Onboard ThreadHandler](INFO): Handler Thread ID is 5312 2010-02-04T21:42:57.915Z,1265319777.915 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5313 2010-02-04T21:42:57.932Z,1265319777.932 [DAT ThreadHandler](INFO): Handler Thread ID is 5314 2010-02-04T21:42:57.932Z,1265319777.932 [DAT](INFO): Powering up 2010-02-04T21:42:57.933Z,1265319777.933 [DAT](DEBUG): Initializing DAT. 2010-02-04T21:42:57.937Z,1265319777.937 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5316 2010-02-04T21:42:57.940Z,1265319777.940 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2010-02-04T21:42:57.940Z,1265319777.940 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2010-02-04T21:42:57.940Z,1265319777.940 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2010-02-04T21:42:57.940Z,1265319777.940 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2010-02-04T21:42:57.940Z,1265319777.940 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2010-02-04T21:42:57.940Z,1265319777.940 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2010-02-04T21:42:57.941Z,1265319777.941 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2010-02-04T21:42:57.941Z,1265319777.941 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2010-02-04T21:42:57.941Z,1265319777.941 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA69M.000 2010-02-04T21:42:57.941Z,1265319777.941 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA69M.000 2010-02-04T21:42:57.951Z,1265319777.951 [CBIT](DEBUG): Deactivating GF circuits. 2010-02-04T21:42:57.951Z,1265319777.951 [CBIT](DEBUG): Deactivating emergency mode. 2010-02-04T21:42:57.991Z,1265319777.991 [CBIT](DEBUG): Backplane powered. 2010-02-04T21:42:57.996Z,1265319777.996 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2010-02-04T21:42:57.996Z,1265319777.996 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2010-02-04T21:42:57.996Z,1265319777.996 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2010-02-04T21:42:57.997Z,1265319777.997 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing 2010-02-04T21:42:57.997Z,1265319777.997 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2010-02-04T21:42:57.998Z,1265319777.998 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2010-02-04T21:42:57.999Z,1265319777.999 [NavChart](DEBUG): Initialize NavChart Navigation. 2010-02-04T21:42:57.999Z,1265319777.999 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2010-02-04T21:42:58.009Z,1265319778.009 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2010-02-04T21:42:58.011Z,1265319778.011 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2010-02-04T21:42:58.012Z,1265319778.012 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2010-02-04T21:42:58.013Z,1265319778.013 [LoopControl](DEBUG): Initialize LoopControlComponent. 2010-02-04T21:42:58.014Z,1265319778.014 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2010-02-04T21:42:58.091Z,1265319778.091 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2010-02-04T21:42:58.127Z,1265319778.127 [MissionManager](DEBUG): 2010-02-04T21:42:58.128Z,1265319778.128 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2010-02-04T21:42:58.287Z,1265319778.287 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2010-02-04T21:42:58.288Z,1265319778.288 [Default:A.Wait](DEBUG): Construct Wait. 2010-02-04T21:42:58.304Z,1265319778.304 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2010-02-04T21:42:58.319Z,1265319778.319 [Radio_Surface](INFO): Powering up 2010-02-04T21:42:58.331Z,1265319778.331 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2010-02-04T21:42:58.333Z,1265319778.333 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2010-02-04T21:42:58.355Z,1265319778.355 [Default:E.Execute](DEBUG): Construct Execute. 2010-02-04T21:42:58.358Z,1265319778.358 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2010-02-04T21:42:58.364Z,1265319778.364 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2010-02-04T21:42:58.544Z,1265319778.544 [Power24vConverter](INFO): Powering up. 2010-02-04T21:42:58.644Z,1265319778.644 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2010-02-04T21:42:58.651Z,1265319778.651 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2010-02-04T21:42:58.653Z,1265319778.653 [ElevatorServo](DEBUG): Initializing EZServoServo. 2010-02-04T21:42:58.659Z,1265319778.659 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2010-02-04T21:42:58.660Z,1265319778.660 [MassServo](DEBUG): Initializing EZServoServo. 2010-02-04T21:42:58.667Z,1265319778.667 [MassServo](DEBUG): Initializing MassServo. 2010-02-04T21:42:58.668Z,1265319778.668 [RudderServo](DEBUG): Initializing EZServoServo. 2010-02-04T21:42:58.675Z,1265319778.675 [RudderServo](DEBUG): Initializing RudderServo. 2010-02-04T21:42:58.676Z,1265319778.676 [ThrusterHE](DEBUG): Initializing EZServoServo. 2010-02-04T21:42:58.683Z,1265319778.683 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2010-02-04T21:42:58.803Z,1265319778.803 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2010-02-04T21:42:58.803Z,1265319778.803 [DropWeight] Hardware Fault, FailCount= 1 2010-02-04T21:42:58.803Z,1265319778.803 [DropWeight](ERROR): Hardware Fault 2010-02-04T21:42:58.850Z,1265319778.850 [CommandExec](FAULT): Scheduling is paused 2010-02-04T21:42:58.850Z,1265319778.850 [CBIT](INFO): Critical error at 20100204T214258 2010-02-04T21:42:58.851Z,1265319778.851 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2010-02-04T21:42:58.857Z,1265319778.857 [CBIT](ERROR): Hardware Fault in component: DropWeight 2010-02-04T21:42:58.858Z,1265319778.858 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2010-02-04T21:42:59.201Z,1265319779.201 [CBIT](INFO): Critical error at 20100204T214258 2010-02-04T21:43:04.244Z,1265319784.244 [ThrusterHE](ERROR): Zero Speed Commanded. 2010-02-04T21:43:08.121Z,1265319788.121 [CommandExec](IMPORTANT): got command get depth 2010-02-04T21:43:08.121Z,1265319788.121 [CommandExec](IMPORTANT): depth -0.109283 m 2010-02-04T21:43:08.132Z,1265319788.132 [CBIT](CRITICAL): Environmental Failure. Press:14.839750 PSI. Humidity:29%. Temp:24 C. ABORTING MISSION 2010-02-04T21:43:08.550Z,1265319788.550 [CBIT](INFO): Critical error at 20100204T214308 2010-02-04T21:43:09.524Z,1265319789.524 [DAT](INFO): DAT read: 2010-02-04T21:43:09.525Z,1265319789.525 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2010-02-04T21:43:11.288Z,1265319791.288 [DAT](INFO): DAT read: MF Frequency Band 2010-02-04T21:43:11.289Z,1265319791.289 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2010-02-04T21:43:11.290Z,1265319791.290 [DAT](INFO): DAT read: Feb 4 2010 21:43:06 2010-02-04T21:43:12.159Z,1265319792.159 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005685 2010-02-04T21:43:12.296Z,1265319792.296 [DAT](INFO): DAT read: Features enabled [Bearing] 2010-02-04T21:43:12.297Z,1265319792.297 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2010-02-04T21:43:12.298Z,1265319792.298 [DAT](INFO): commRate: 1200 2010-02-04T21:43:14.363Z,1265319794.363 [DAT](INFO): entering command mode 2010-02-04T21:43:14.564Z,1265319794.564 [DAT](INFO): DAT read: 2010-02-04T21:43:14.564Z,1265319794.564 [DAT](INFO): DAT read: user:1> 2010-02-04T21:43:14.565Z,1265319794.565 [DAT](INFO): setting verbose to 3 2010-02-04T21:43:14.816Z,1265319794.816 [DAT](INFO): DAT read: user:1> 2010-02-04T21:43:14.817Z,1265319794.817 [DAT](INFO): DAT read: Verbose | 3 2010-02-04T21:43:14.817Z,1265319794.817 [DAT](INFO): set verbose to 3 2010-02-04T21:43:14.818Z,1265319794.818 [DAT](INFO): setting DatVerbose to 27440 2010-02-04T21:43:15.068Z,1265319795.068 [DAT](INFO): DAT read: user:2> 2010-02-04T21:43:15.069Z,1265319795.069 [DAT](INFO): DAT read: DatVerbose | 27440 2010-02-04T21:43:15.069Z,1265319795.069 [DAT](INFO): set DatVerbose to 27440 2010-02-04T21:43:15.070Z,1265319795.070 [DAT](INFO): setting transmit power to 8 2010-02-04T21:43:15.320Z,1265319795.320 [DAT](INFO): DAT read: user:3> 2010-02-04T21:43:15.321Z,1265319795.321 [DAT](INFO): DAT read: TxPower | 8 (Max) 2010-02-04T21:43:15.321Z,1265319795.321 [DAT](INFO): set transmit power to 8 2010-02-04T21:43:15.321Z,1265319795.321 [DAT](INFO): setting local address to 4 2010-02-04T21:43:15.572Z,1265319795.572 [DAT](INFO): DAT read: user:4> 2010-02-04T21:43:15.573Z,1265319795.573 [DAT](INFO): DAT read: LocalAddr | 4 2010-02-04T21:43:15.573Z,1265319795.573 [DAT](INFO): set local address to 4 2010-02-04T21:43:15.574Z,1265319795.574 [DAT](INFO): Setting time to: 21:43:15 And date to:2/4/2010 2010-02-04T21:43:15.824Z,1265319795.824 [DAT](INFO): DAT read: user:5> 2010-02-04T21:43:15.825Z,1265319795.825 [DAT](INFO): DAT read: Thu Feb 4, 2010 21:43:15 2010-02-04T21:43:15.825Z,1265319795.825 [DAT](INFO): Local DAT time set to Thu Feb 4, 2010 21:43:15 2010-02-04T21:43:24.313Z,1265319804.313 [CommandExec](IMPORTANT): got command get depth 2010-02-04T21:43:24.314Z,1265319804.314 [CommandExec](IMPORTANT): depth -0.105693 m 2010-02-04T21:43:27.465Z,1265319807.465 [NAL9602](INFO): Powering up NAL9602 2010-02-04T21:43:36.297Z,1265319816.297 [CommandExec](IMPORTANT): got command strobe off 2010-02-04T21:43:36.298Z,1265319816.298 [CommandExec](IMPORTANT): Deactivating strobe 2010-02-04T21:43:38.374Z,1265319818.374 [NAL9602](INFO): NAL9602 initialized 2010-02-04T21:43:55.160Z,1265319835.160 [CommandExec](IMPORTANT): got command strobe off 2010-02-04T21:43:55.161Z,1265319835.161 [CommandExec](IMPORTANT): Deactivating strobe 2010-02-04T21:44:58.054Z,1265319898.054 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T21:44:58.055Z,1265319898.055 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2010-02-04T21:44:58.055Z,1265319898.055 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T21:44:58.094Z,1265319898.094 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T21:44:58.409Z,1265319898.409 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T21:44:58.409Z,1265319898.409 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2010-02-04T21:45:23.438Z,1265319923.438 [SBIT](IMPORTANT): Beginning Startup BIT 2010-02-04T21:45:23.443Z,1265319923.443 [CBIT](IMPORTANT): Beginning ground fault scan 2010-02-04T21:45:26.040Z,1265319926.040 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.xml 2010-02-04T21:45:26.041Z,1265319926.041 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.xml 2010-02-04T21:45:26.172Z,1265319926.172 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2010-02-04T21:45:26.172Z,1265319926.172 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml 2010-02-04T21:45:26.518Z,1265319926.518 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool 2010-02-04T21:45:26.521Z,1265319926.521 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min 2010-02-04T21:45:26.523Z,1265319926.523 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool 2010-02-04T21:45:26.526Z,1265319926.526 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool 2010-02-04T21:45:26.528Z,1265319926.528 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool 2010-02-04T21:45:26.531Z,1265319926.531 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool 2010-02-04T21:45:26.533Z,1265319926.533 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DetectTrough = 0 bool 2010-02-04T21:45:26.536Z,1265319926.536 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count 2010-02-04T21:45:26.539Z,1265319926.539 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count 2010-02-04T21:45:26.542Z,1265319926.542 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 % 2010-02-04T21:45:26.545Z,1265319926.545 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool 2010-02-04T21:45:26.567Z,1265319926.567 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool 2010-02-04T21:45:26.570Z,1265319926.570 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool 2010-02-04T21:45:26.578Z,1265319926.578 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool 2010-02-04T21:45:26.597Z,1265319926.597 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2010-02-04T21:45:26.604Z,1265319926.604 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0 bool 2010-02-04T21:45:26.616Z,1265319926.616 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0 bool 2010-02-04T21:45:26.623Z,1265319926.623 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 0 bool 2010-02-04T21:45:26.627Z,1265319926.627 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 0 bool 2010-02-04T21:45:26.653Z,1265319926.653 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2010-02-04T21:45:26.672Z,1265319926.672 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0 bool 2010-02-04T21:45:26.684Z,1265319926.684 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count 2010-02-04T21:45:26.687Z,1265319926.687 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count 2010-02-04T21:45:26.698Z,1265319926.698 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakShallowBound = nan m 2010-02-04T21:45:26.712Z,1265319926.712 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDeepBound = nan m 2010-02-04T21:45:26.724Z,1265319926.724 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2010-02-04T21:45:26.729Z,1265319926.729 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = 0.000000 ug/l 2010-02-04T21:45:26.739Z,1265319926.739 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = 0.000000 m 2010-02-04T21:45:26.766Z,1265319926.766 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = 0.000000 degC 2010-02-04T21:45:26.770Z,1265319926.770 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg 2010-02-04T21:45:26.794Z,1265319926.794 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg 2010-02-04T21:45:26.802Z,1265319926.802 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = 0.000000 umol/l 2010-02-04T21:45:26.809Z,1265319926.809 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = 0.000000 m 2010-02-04T21:45:26.813Z,1265319926.813 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg 2010-02-04T21:45:26.828Z,1265319926.828 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg 2010-02-04T21:45:26.844Z,1265319926.844 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = 0.000000 kg/m3 2010-02-04T21:45:26.847Z,1265319926.847 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = 0.000000 m 2010-02-04T21:45:26.854Z,1265319926.854 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg 2010-02-04T21:45:26.861Z,1265319926.861 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg 2010-02-04T21:45:26.870Z,1265319926.870 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = 0.000000 ppb 2010-02-04T21:45:26.889Z,1265319926.889 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = 0.000000 m 2010-02-04T21:45:26.896Z,1265319926.896 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC 2010-02-04T21:45:26.908Z,1265319926.908 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg 2010-02-04T21:45:26.911Z,1265319926.911 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg 2010-02-04T21:45:26.918Z,1265319926.918 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchFDOMDistance = nan m 2010-02-04T21:45:26.922Z,1265319926.922 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = 0.000000 psu 2010-02-04T21:45:26.944Z,1265319926.944 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = 0.000000 m 2010-02-04T21:45:26.947Z,1265319926.947 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = 0.000000 degC 2010-02-04T21:45:26.961Z,1265319926.961 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg 2010-02-04T21:45:26.965Z,1265319926.965 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg 2010-02-04T21:45:26.973Z,1265319926.973 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = 0.000000 ug/l 2010-02-04T21:45:26.988Z,1265319926.988 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = 0.000000 m 2010-02-04T21:45:26.997Z,1265319926.997 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg 2010-02-04T21:45:27.004Z,1265319927.004 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg 2010-02-04T21:45:27.020Z,1265319927.020 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m 2010-02-04T21:45:27.027Z,1265319927.027 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = 0.000000 psu 2010-02-04T21:45:27.030Z,1265319927.030 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = 0.000000 m 2010-02-04T21:45:27.074Z,1265319927.074 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg 2010-02-04T21:45:27.086Z,1265319927.086 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg 2010-02-04T21:45:27.107Z,1265319927.107 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m 2010-02-04T21:45:27.110Z,1265319927.110 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = 0.000000 psu 2010-02-04T21:45:27.127Z,1265319927.127 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = 0.000000 m 2010-02-04T21:45:27.130Z,1265319927.130 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg 2010-02-04T21:45:27.138Z,1265319927.138 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg 2010-02-04T21:45:27.153Z,1265319927.153 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m 2010-02-04T21:45:27.254Z,1265319927.254 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:45:27.296Z,1265319927.296 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2010-02-04T21:45:27.336Z,1265319927.336 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:45:27.366Z,1265319927.366 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:45:27.390Z,1265319927.390 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2010-02-04T21:45:27.416Z,1265319927.416 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:45:27.458Z,1265319927.458 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:45:27.510Z,1265319927.510 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2010-02-04T21:45:27.588Z,1265319927.588 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Construct BackseatDriver. 2010-02-04T21:45:27.596Z,1265319927.596 [run_backseat_on_surface:C.GoToSurface](DEBUG): Construct GoToSurface. 2010-02-04T21:45:27.637Z,1265319927.637 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2010-02-04T21:45:27.648Z,1265319927.648 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2010-02-04T21:45:27.659Z,1265319927.659 [run_backseat_on_surface:F.Execute](DEBUG): Construct Execute. 2010-02-04T21:45:27.717Z,1265319927.717 [MissionManager](DEBUG): 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2010-02-04T21:45:27.729Z,1265319927.729 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.xml 2010-02-04T21:45:34.393Z,1265319934.393 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.017093 CHAN A1 (24V): -0.000511 CHAN A2 (12V): -0.005741 CHAN A3 (5V): -0.002796 CHAN B0 (3.3V): -0.001145 CHAN B1 (3.15aV): -0.001070 CHAN B2 (3.15bV): -0.001194 CHAN B3 (GND): 0.001412 OPEN: 0.006969 Full Scale: +/- 1 mA 2010-02-04T21:46:17.570Z,1265319977.570 [SBIT](IMPORTANT): SBIT PASSED 2010-02-04T21:46:17.570Z,1265319977.570 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2010-02-04T21:46:17.572Z,1265319977.572 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2010-02-04T21:46:17.579Z,1265319977.579 [SBIT](IMPORTANT): CBIT.gfScanTimeout=1 hour; 2010-02-04T21:46:17.579Z,1265319977.579 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2010-02-04T21:46:17.579Z,1265319977.579 [SBIT](IMPORTANT): Depth_Keller.offset=-0.8 decibar; 2010-02-04T21:46:17.579Z,1265319977.579 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=4 minute; 2010-02-04T21:46:17.580Z,1265319977.580 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2010-02-04T21:46:17.580Z,1265319977.580 [SBIT](IMPORTANT): ElevatorServo.offsetAngle=1 degree; 2010-02-04T21:46:17.580Z,1265319977.580 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_temperature_homogeneity_index 0.050000 celsius; 2010-02-04T21:46:17.580Z,1265319977.580 [SBIT](IMPORTANT): Express none WetLabsBB2FL.BackscatteringCoeff470nm; 2010-02-04T21:46:17.580Z,1265319977.580 [SBIT](IMPORTANT): Express none WetLabsBB2FL.BackscatteringCoeff650nm; 2010-02-04T21:46:17.580Z,1265319977.580 [SBIT](IMPORTANT): StratificationFrontDetector.loadAtStartup=1 bool; 2010-02-04T21:46:17.580Z,1265319977.580 [SBIT](IMPORTANT): StratificationFrontDetector.threshold_VTHI=0.05 celsius; 2010-02-04T21:46:17.580Z,1265319977.580 [SBIT](IMPORTANT): StratificationFrontDetector.verbosity=1 count; 2010-02-04T21:46:17.581Z,1265319977.581 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=155.681673 cubic_centimeter; 2010-02-04T21:46:17.581Z,1265319977.581 [SBIT](IMPORTANT): VerticalControl.massDefault=31.311287 millimeter; 2010-02-04T21:46:17.581Z,1265319977.581 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=15 meter; 2010-02-04T21:46:17.581Z,1265319977.581 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=20 meter; 2010-02-04T21:46:17.581Z,1265319977.581 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.loadAtStartup=1 bool; 2010-02-04T21:46:17.581Z,1265319977.581 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2010-02-04T21:46:17.968Z,1265319977.968 [MissionManager](IMPORTANT): Started mission Startup 2010-02-04T21:46:17.968Z,1265319977.968 [Startup] Running Loop=1 2010-02-04T21:46:17.968Z,1265319977.968 [Startup](DEBUG): Aggregate::initialize Startup 2010-02-04T21:46:17.968Z,1265319977.968 [Startup:A.GoToSurface] Running Loop=1 2010-02-04T21:46:17.969Z,1265319977.969 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2010-02-04T21:46:17.969Z,1265319977.969 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2010-02-04T21:46:17.970Z,1265319977.970 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2010-02-04T21:46:17.970Z,1265319977.970 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2010-02-04T21:46:17.970Z,1265319977.970 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2010-02-04T21:46:17.971Z,1265319977.971 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2010-02-04T21:46:17.973Z,1265319977.973 [Startup:StartupSatComms] Running Loop=1 2010-02-04T21:46:17.973Z,1265319977.973 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2010-02-04T21:46:17.973Z,1265319977.973 [Startup:StartupSatComms:A] Running Loop=1 2010-02-04T21:46:18.525Z,1265319978.525 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2010-02-04T21:46:59.184Z,1265320019.184 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T21:46:59.184Z,1265320019.184 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2010-02-04T21:46:59.184Z,1265320019.184 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T21:46:59.196Z,1265320019.196 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T21:46:59.621Z,1265320019.621 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T21:46:59.621Z,1265320019.621 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2010-02-04T21:47:18.157Z,1265320038.157 [Startup:StartupSatComms:A](INFO): Timed out from 2010-02-04T21:46:17.0Z 2010-02-04T21:47:18.157Z,1265320038.157 [Startup:StartupSatComms:A] Stopped 2010-02-04T21:47:18.157Z,1265320038.157 [Startup:StartupSatComms:B] Running Loop=1 2010-02-04T21:47:18.564Z,1265320038.564 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2010-02-04T21:47:25.179Z,1265320045.179 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20100204T203155/Courier0016.lzma 2010-02-04T21:47:26.181Z,1265320046.181 [DataOverHttps](INFO): Moved sent file to Logs/20100204T203155/Courier0016.lzma.bak 2010-02-04T21:47:26.181Z,1265320046.181 [DataOverHttps](INFO): SBD MOMSN=18031136 2010-02-04T21:47:44.619Z,1265320064.619 [DataOverHttps](INFO): Sending 316 bytes from file Logs/20100204T214248/Courier0000.lzma 2010-02-04T21:47:45.622Z,1265320065.622 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Courier0000.lzma.bak 2010-02-04T21:47:45.622Z,1265320065.622 [DataOverHttps](INFO): SBD MOMSN=18031139 2010-02-04T21:48:03.935Z,1265320083.935 [DataOverHttps](INFO): Sending 192 bytes from file Logs/20100204T203155/Express0017.lzma 2010-02-04T21:48:04.937Z,1265320084.937 [DataOverHttps](INFO): Moved sent file to Logs/20100204T203155/Express0017.lzma.bak 2010-02-04T21:48:04.937Z,1265320084.937 [DataOverHttps](INFO): SBD MOMSN=18031146 2010-02-04T21:48:13.194Z,1265320093.194 [DVL_micro](ERROR): only read 3 of 4 data items 2010-02-04T21:48:13.194Z,1265320093.194 [DVL_micro](ERROR): Failed to parse: :BI,+00133,+00098,-00306,+00BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00 2010-02-04T21:48:18.535Z,1265320098.535 [Startup:StartupSatComms:B](INFO): Timed out from 2010-02-04T21:47:18.2Z 2010-02-04T21:48:18.539Z,1265320098.539 [Startup:StartupSatComms:B] Stopped 2010-02-04T21:48:18.539Z,1265320098.539 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2010-02-04T21:48:18.540Z,1265320098.540 [Startup:StartupSatComms] Stopped 2010-02-04T21:48:18.540Z,1265320098.540 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2010-02-04T21:48:18.540Z,1265320098.540 [Startup](INFO): Completed Startup 2010-02-04T21:48:18.541Z,1265320098.541 [MissionManager](INFO): Startup is completed. 2010-02-04T21:48:18.541Z,1265320098.541 [MissionManager](INFO): Uninitializing Mission Startup 2010-02-04T21:48:18.541Z,1265320098.541 [Startup] Stopped 2010-02-04T21:48:18.541Z,1265320098.541 [Startup](DEBUG): Aggregate::uninitialize Startup 2010-02-04T21:48:18.541Z,1265320098.541 [Startup:A.GoToSurface] Stopped 2010-02-04T21:48:18.541Z,1265320098.541 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2010-02-04T21:48:18.841Z,1265320098.841 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2010-02-04T21:48:18.841Z,1265320098.841 [run_backseat_on_surface] Running Loop=1 2010-02-04T21:48:18.841Z,1265320098.841 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2010-02-04T21:48:18.841Z,1265320098.841 [run_backseat_on_surface:Science] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science](DEBUG): Aggregate::initialize run_backseat_on_surface:Science 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:A] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:B] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:C] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:D] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:E] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:F] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:Read_Oil] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:PeakDetectChl] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectChl 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:48:18.842Z,1265320098.842 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:48:18.853Z,1265320098.853 [run_backseat_on_surface:Science:HighestChlPeakReport] Running Loop=1 2010-02-04T21:48:18.853Z,1265320098.853 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestChlPeakReport 2010-02-04T21:48:18.854Z,1265320098.854 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2010-02-04T21:48:18.854Z,1265320098.854 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2010-02-04T21:48:18.854Z,1265320098.854 [run_backseat_on_surface:Science:PeakDetectNO3] Running Loop=1 2010-02-04T21:48:18.855Z,1265320098.855 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectNO3 2010-02-04T21:48:18.855Z,1265320098.855 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:48:18.855Z,1265320098.855 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:48:18.865Z,1265320098.865 [run_backseat_on_surface:Science:PeakDetectOil] Running Loop=1 2010-02-04T21:48:18.865Z,1265320098.865 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectOil 2010-02-04T21:48:18.865Z,1265320098.865 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:48:18.865Z,1265320098.865 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:48:18.867Z,1265320098.867 [run_backseat_on_surface:Science:HighestOilPeakReport] Running Loop=1 2010-02-04T21:48:18.880Z,1265320098.880 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestOilPeakReport 2010-02-04T21:48:18.880Z,1265320098.880 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2010-02-04T21:48:18.880Z,1265320098.880 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2010-02-04T21:48:18.880Z,1265320098.880 [run_backseat_on_surface:Science:PeakDetectFDOM] Running Loop=1 2010-02-04T21:48:18.880Z,1265320098.880 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectFDOM 2010-02-04T21:48:18.880Z,1265320098.880 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:48:18.881Z,1265320098.881 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:48:18.882Z,1265320098.882 [run_backseat_on_surface:Science:PeakDetectSalinity] Running Loop=1 2010-02-04T21:48:18.882Z,1265320098.882 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectSalinity 2010-02-04T21:48:18.883Z,1265320098.883 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:48:18.883Z,1265320098.883 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:48:18.892Z,1265320098.892 [run_backseat_on_surface:Science:HighestSaltPeakReport] Running Loop=1 2010-02-04T21:48:18.893Z,1265320098.893 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestSaltPeakReport 2010-02-04T21:48:18.893Z,1265320098.893 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2010-02-04T21:48:18.893Z,1265320098.893 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2010-02-04T21:48:18.893Z,1265320098.893 [run_backseat_on_surface:Science:OceanCurrent] Running Loop=1 2010-02-04T21:48:18.893Z,1265320098.893 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:OceanCurrent 2010-02-04T21:48:18.893Z,1265320098.893 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1 2010-02-04T21:48:18.894Z,1265320098.894 [run_backseat_on_surface:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2010-02-04T21:48:18.894Z,1265320098.894 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1 2010-02-04T21:48:18.894Z,1265320098.894 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Initialize. 2010-02-04T21:48:19.019Z,1265320099.019 [BackseatComponent](INFO): Powering up 2010-02-04T21:48:19.020Z,1265320099.020 [BackseatComponent](INFO): Subscribing to LCM channels. 2010-02-04T21:48:19.041Z,1265320099.041 [run_backseat_on_surface:C.GoToSurface] Running Loop=1 2010-02-04T21:48:19.041Z,1265320099.041 [run_backseat_on_surface:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2010-02-04T21:48:19.041Z,1265320099.041 [run_backseat_on_surface:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2010-02-04T21:48:19.041Z,1265320099.041 [run_backseat_on_surface:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2010-02-04T21:48:19.042Z,1265320099.042 [run_backseat_on_surface:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2010-02-04T21:48:19.042Z,1265320099.042 [run_backseat_on_surface:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2010-02-04T21:48:19.042Z,1265320099.042 [run_backseat_on_surface:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2010-02-04T21:48:19.052Z,1265320099.052 [run_backseat_on_surface:CheckIn] Running Loop=1 2010-02-04T21:48:19.052Z,1265320099.052 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2010-02-04T21:48:19.052Z,1265320099.052 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2010-02-04T21:48:19.052Z,1265320099.052 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1 2010-02-04T21:48:19.055Z,1265320099.055 [run_backseat_on_surface:Science] Running Loop=1 2010-02-04T21:48:19.056Z,1265320099.056 [run_backseat_on_surface:Science:HighestSaltPeakReport] Stopped 2010-02-04T21:48:19.056Z,1265320099.056 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestSaltPeakReport 2010-02-04T21:48:19.056Z,1265320099.056 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:PeakDetectSalinity] Stopped 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectSalinity 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:PeakDetectFDOM] Stopped 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectFDOM 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:HighestOilPeakReport] Stopped 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestOilPeakReport 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2010-02-04T21:48:19.057Z,1265320099.057 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectOil] Stopped 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectOil 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectNO3] Stopped 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectNO3 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:HighestChlPeakReport] Stopped 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestChlPeakReport 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2010-02-04T21:48:19.058Z,1265320099.058 [run_backseat_on_surface:Science:PeakDetectChl] Stopped 2010-02-04T21:48:19.059Z,1265320099.059 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectChl 2010-02-04T21:48:19.059Z,1265320099.059 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2010-02-04T21:48:19.059Z,1265320099.059 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:48:19.059Z,1265320099.059 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1 2010-02-04T21:48:19.067Z,1265320099.067 [run_backseat_on_surface:Science:Read_Oil] Stopped 2010-02-04T21:48:19.067Z,1265320099.067 [run_backseat_on_surface:Science:F] Stopped 2010-02-04T21:48:19.067Z,1265320099.067 [run_backseat_on_surface:Science:E] Stopped 2010-02-04T21:48:19.067Z,1265320099.067 [run_backseat_on_surface:Science:D] Stopped 2010-02-04T21:48:19.067Z,1265320099.067 [run_backseat_on_surface:Science:C] Stopped 2010-02-04T21:48:19.068Z,1265320099.068 [run_backseat_on_surface:Science:B] Stopped 2010-02-04T21:48:19.068Z,1265320099.068 [run_backseat_on_surface:Science:A] Stopped 2010-02-04T21:48:19.245Z,1265320099.245 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2010-02-04T21:48:20.921Z,1265320100.921 [DataOverHttps](INFO): Sending 1334 bytes from file Logs/20100204T214248/Express0001.lzma 2010-02-04T21:48:21.921Z,1265320101.921 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Express0001.lzma.bak 2010-02-04T21:48:21.921Z,1265320101.921 [DataOverHttps](INFO): SBD MOMSN=18031151 2010-02-04T21:48:42.240Z,1265320122.240 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2010-02-04T21:49:00.039Z,1265320140.039 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T21:49:00.040Z,1265320140.040 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2010-02-04T21:49:00.040Z,1265320140.040 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T21:49:00.069Z,1265320140.069 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T21:49:00.441Z,1265320140.441 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T21:49:00.441Z,1265320140.441 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2010-02-04T21:50:31.226Z,1265320231.226 [DataOverHttps](IMPORTANT): SBD MTMSN=20230404T215301 2010-02-04T21:50:37.798Z,1265320237.798 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2010-02-04T21:50:37.802Z,1265320237.802 [BPC1](INFO): Received data from all battery sticks. 2010-02-04T21:50:38.447Z,1265320238.447 [DataOverHttps](INFO): Received command: run Maintenance/run_backseat_on_surface.xml 2010-02-04T21:50:38.558Z,1265320238.558 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.xml 2010-02-04T21:50:38.558Z,1265320238.558 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2010-02-04T21:50:38.558Z,1265320238.558 [run_backseat_on_surface] Stopped 2010-02-04T21:50:38.559Z,1265320238.559 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2010-02-04T21:50:38.559Z,1265320238.559 [run_backseat_on_surface:Science] Stopped 2010-02-04T21:50:38.559Z,1265320238.559 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science 2010-02-04T21:50:38.559Z,1265320238.559 [run_backseat_on_surface:Science:OceanCurrent] Stopped 2010-02-04T21:50:38.559Z,1265320238.559 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent 2010-02-04T21:50:38.559Z,1265320238.559 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped 2010-02-04T21:50:38.559Z,1265320238.559 [run_backseat_on_surface:B.BackseatDriver] Stopped 2010-02-04T21:50:38.559Z,1265320238.559 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Uninitialize. 2010-02-04T21:50:38.560Z,1265320238.560 [run_backseat_on_surface:C.GoToSurface] Stopped 2010-02-04T21:50:38.560Z,1265320238.560 [run_backseat_on_surface:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2010-02-04T21:50:38.560Z,1265320238.560 [run_backseat_on_surface:CheckIn] Stopped 2010-02-04T21:50:38.560Z,1265320238.560 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2010-02-04T21:50:38.560Z,1265320238.560 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2010-02-04T21:50:38.665Z,1265320238.665 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.xml 2010-02-04T21:50:38.713Z,1265320238.713 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2010-02-04T21:50:38.714Z,1265320238.714 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml 2010-02-04T21:50:38.938Z,1265320238.938 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool 2010-02-04T21:50:38.940Z,1265320238.940 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min 2010-02-04T21:50:38.942Z,1265320238.942 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool 2010-02-04T21:50:38.944Z,1265320238.944 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool 2010-02-04T21:50:38.946Z,1265320238.946 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool 2010-02-04T21:50:38.948Z,1265320238.948 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool 2010-02-04T21:50:38.949Z,1265320238.949 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DetectTrough = 0 bool 2010-02-04T21:50:38.951Z,1265320238.951 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count 2010-02-04T21:50:38.953Z,1265320238.953 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count 2010-02-04T21:50:38.956Z,1265320238.956 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 % 2010-02-04T21:50:38.957Z,1265320238.957 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool 2010-02-04T21:50:38.959Z,1265320238.959 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool 2010-02-04T21:50:38.961Z,1265320238.961 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool 2010-02-04T21:50:38.963Z,1265320238.963 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool 2010-02-04T21:50:38.965Z,1265320238.965 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2010-02-04T21:50:38.967Z,1265320238.967 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0 bool 2010-02-04T21:50:38.970Z,1265320238.970 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0 bool 2010-02-04T21:50:38.972Z,1265320238.972 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 0 bool 2010-02-04T21:50:38.974Z,1265320238.974 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 0 bool 2010-02-04T21:50:38.977Z,1265320238.977 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2010-02-04T21:50:39.047Z,1265320239.047 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0 bool 2010-02-04T21:50:39.049Z,1265320239.049 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count 2010-02-04T21:50:39.056Z,1265320239.056 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count 2010-02-04T21:50:39.058Z,1265320239.058 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakShallowBound = nan m 2010-02-04T21:50:39.072Z,1265320239.072 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDeepBound = nan m 2010-02-04T21:50:39.074Z,1265320239.074 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2010-02-04T21:50:39.085Z,1265320239.085 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = 0.000000 ug/l 2010-02-04T21:50:39.087Z,1265320239.087 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = 0.000000 m 2010-02-04T21:50:39.101Z,1265320239.101 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = 0.000000 degC 2010-02-04T21:50:39.108Z,1265320239.108 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg 2010-02-04T21:50:39.110Z,1265320239.110 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg 2010-02-04T21:50:39.121Z,1265320239.121 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = 0.000000 umol/l 2010-02-04T21:50:39.123Z,1265320239.123 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = 0.000000 m 2010-02-04T21:50:39.129Z,1265320239.129 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg 2010-02-04T21:50:39.136Z,1265320239.136 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg 2010-02-04T21:50:39.138Z,1265320239.138 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = 0.000000 kg/m3 2010-02-04T21:50:39.144Z,1265320239.144 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = 0.000000 m 2010-02-04T21:50:39.146Z,1265320239.146 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg 2010-02-04T21:50:39.157Z,1265320239.157 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg 2010-02-04T21:50:39.159Z,1265320239.159 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = 0.000000 ppb 2010-02-04T21:50:39.165Z,1265320239.165 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = 0.000000 m 2010-02-04T21:50:39.172Z,1265320239.172 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC 2010-02-04T21:50:39.176Z,1265320239.176 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg 2010-02-04T21:50:39.178Z,1265320239.178 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg 2010-02-04T21:50:39.181Z,1265320239.181 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchFDOMDistance = nan m 2010-02-04T21:50:39.183Z,1265320239.183 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = 0.000000 psu 2010-02-04T21:50:39.197Z,1265320239.197 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = 0.000000 m 2010-02-04T21:50:39.204Z,1265320239.204 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = 0.000000 degC 2010-02-04T21:50:39.206Z,1265320239.206 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg 2010-02-04T21:50:39.216Z,1265320239.216 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg 2010-02-04T21:50:39.218Z,1265320239.218 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = 0.000000 ug/l 2010-02-04T21:50:39.220Z,1265320239.220 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = 0.000000 m 2010-02-04T21:50:39.223Z,1265320239.223 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg 2010-02-04T21:50:39.226Z,1265320239.226 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg 2010-02-04T21:50:39.241Z,1265320239.241 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m 2010-02-04T21:50:39.243Z,1265320239.243 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = 0.000000 psu 2010-02-04T21:50:39.253Z,1265320239.253 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = 0.000000 m 2010-02-04T21:50:39.259Z,1265320239.259 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg 2010-02-04T21:50:39.262Z,1265320239.262 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg 2010-02-04T21:50:39.268Z,1265320239.268 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m 2010-02-04T21:50:39.270Z,1265320239.270 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = 0.000000 psu 2010-02-04T21:50:39.281Z,1265320239.281 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = 0.000000 m 2010-02-04T21:50:39.283Z,1265320239.283 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg 2010-02-04T21:50:39.294Z,1265320239.294 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg 2010-02-04T21:50:39.308Z,1265320239.308 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m 2010-02-04T21:50:39.324Z,1265320239.324 [BackseatComponent](INFO): Sent LCM shutdown request. 2010-02-04T21:50:39.350Z,1265320239.350 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:50:39.378Z,1265320239.378 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2010-02-04T21:50:39.458Z,1265320239.458 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:50:39.486Z,1265320239.486 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:50:39.512Z,1265320239.512 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2010-02-04T21:50:39.544Z,1265320239.544 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:50:39.562Z,1265320239.562 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2010-02-04T21:50:39.590Z,1265320239.590 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2010-02-04T21:50:39.621Z,1265320239.621 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Construct BackseatDriver. 2010-02-04T21:50:39.628Z,1265320239.628 [run_backseat_on_surface:C.GoToSurface](DEBUG): Construct GoToSurface. 2010-02-04T21:50:39.636Z,1265320239.636 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2010-02-04T21:50:39.638Z,1265320239.638 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2010-02-04T21:50:39.655Z,1265320239.655 [run_backseat_on_surface:F.Execute](DEBUG): Construct Execute. 2010-02-04T21:50:39.685Z,1265320239.685 [MissionManager](DEBUG): 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2010-02-04T21:50:39.686Z,1265320239.686 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.xml 2010-02-04T21:50:39.844Z,1265320239.844 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2010-02-04T21:50:39.844Z,1265320239.844 [run_backseat_on_surface] Running Loop=1 2010-02-04T21:50:39.844Z,1265320239.844 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2010-02-04T21:50:39.844Z,1265320239.844 [run_backseat_on_surface:Science] Running Loop=1 2010-02-04T21:50:39.844Z,1265320239.844 [run_backseat_on_surface:Science](DEBUG): Aggregate::initialize run_backseat_on_surface:Science 2010-02-04T21:50:39.844Z,1265320239.844 [run_backseat_on_surface:Science:A] Running Loop=1 2010-02-04T21:50:39.844Z,1265320239.844 [run_backseat_on_surface:Science:B] Running Loop=1 2010-02-04T21:50:39.844Z,1265320239.844 [run_backseat_on_surface:Science:C] Running Loop=1 2010-02-04T21:50:39.845Z,1265320239.845 [run_backseat_on_surface:Science:D] Running Loop=1 2010-02-04T21:50:39.845Z,1265320239.845 [run_backseat_on_surface:Science:E] Running Loop=1 2010-02-04T21:50:39.845Z,1265320239.845 [run_backseat_on_surface:Science:F] Running Loop=1 2010-02-04T21:50:39.845Z,1265320239.845 [run_backseat_on_surface:Science:Read_Oil] Running Loop=1 2010-02-04T21:50:39.845Z,1265320239.845 [run_backseat_on_surface:Science:PeakDetectChl] Running Loop=1 2010-02-04T21:50:39.845Z,1265320239.845 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectChl 2010-02-04T21:50:39.845Z,1265320239.845 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:50:39.845Z,1265320239.845 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:50:39.846Z,1265320239.846 [run_backseat_on_surface:Science:HighestChlPeakReport] Running Loop=1 2010-02-04T21:50:39.847Z,1265320239.847 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestChlPeakReport 2010-02-04T21:50:39.847Z,1265320239.847 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2010-02-04T21:50:39.847Z,1265320239.847 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2010-02-04T21:50:39.867Z,1265320239.867 [run_backseat_on_surface:Science:PeakDetectNO3] Running Loop=1 2010-02-04T21:50:39.868Z,1265320239.868 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectNO3 2010-02-04T21:50:39.868Z,1265320239.868 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:50:39.868Z,1265320239.868 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:50:39.869Z,1265320239.869 [run_backseat_on_surface:Science:PeakDetectOil] Running Loop=1 2010-02-04T21:50:39.869Z,1265320239.869 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectOil 2010-02-04T21:50:39.869Z,1265320239.869 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:50:39.869Z,1265320239.869 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:50:39.870Z,1265320239.870 [run_backseat_on_surface:Science:HighestOilPeakReport] Running Loop=1 2010-02-04T21:50:39.870Z,1265320239.870 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestOilPeakReport 2010-02-04T21:50:39.870Z,1265320239.870 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2010-02-04T21:50:39.871Z,1265320239.871 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2010-02-04T21:50:39.875Z,1265320239.875 [run_backseat_on_surface:Science:PeakDetectFDOM] Running Loop=1 2010-02-04T21:50:39.875Z,1265320239.875 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectFDOM 2010-02-04T21:50:39.876Z,1265320239.875 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:50:39.876Z,1265320239.876 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:50:39.877Z,1265320239.877 [run_backseat_on_surface:Science:PeakDetectSalinity] Running Loop=1 2010-02-04T21:50:39.877Z,1265320239.877 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectSalinity 2010-02-04T21:50:39.877Z,1265320239.877 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2010-02-04T21:50:39.877Z,1265320239.877 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2010-02-04T21:50:39.878Z,1265320239.878 [run_backseat_on_surface:Science:HighestSaltPeakReport] Running Loop=1 2010-02-04T21:50:39.878Z,1265320239.878 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestSaltPeakReport 2010-02-04T21:50:39.878Z,1265320239.878 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2010-02-04T21:50:39.878Z,1265320239.878 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2010-02-04T21:50:39.880Z,1265320239.880 [run_backseat_on_surface:Science:OceanCurrent] Running Loop=1 2010-02-04T21:50:39.880Z,1265320239.880 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:OceanCurrent 2010-02-04T21:50:39.881Z,1265320239.881 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1 2010-02-04T21:50:39.881Z,1265320239.881 [run_backseat_on_surface:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2010-02-04T21:50:39.881Z,1265320239.881 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1 2010-02-04T21:50:39.881Z,1265320239.881 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Initialize. 2010-02-04T21:50:39.941Z,1265320239.941 [run_backseat_on_surface:C.GoToSurface] Running Loop=1 2010-02-04T21:50:39.941Z,1265320239.941 [run_backseat_on_surface:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2010-02-04T21:50:39.942Z,1265320239.942 [run_backseat_on_surface:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2010-02-04T21:50:39.942Z,1265320239.942 [run_backseat_on_surface:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2010-02-04T21:50:39.942Z,1265320239.942 [run_backseat_on_surface:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2010-02-04T21:50:39.942Z,1265320239.942 [run_backseat_on_surface:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2010-02-04T21:50:39.943Z,1265320239.943 [run_backseat_on_surface:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2010-02-04T21:50:39.948Z,1265320239.948 [run_backseat_on_surface:CheckIn] Running Loop=1 2010-02-04T21:50:39.948Z,1265320239.948 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2010-02-04T21:50:39.948Z,1265320239.948 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2010-02-04T21:50:39.948Z,1265320239.948 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1 2010-02-04T21:50:39.951Z,1265320239.951 [run_backseat_on_surface:Science] Running Loop=1 2010-02-04T21:50:39.952Z,1265320239.952 [run_backseat_on_surface:Science:HighestSaltPeakReport] Stopped 2010-02-04T21:50:39.952Z,1265320239.952 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestSaltPeakReport 2010-02-04T21:50:39.952Z,1265320239.952 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2010-02-04T21:50:39.952Z,1265320239.953 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:PeakDetectSalinity] Stopped 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectSalinity 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:PeakDetectFDOM] Stopped 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectFDOM 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:HighestOilPeakReport] Stopped 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestOilPeakReport 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2010-02-04T21:50:39.953Z,1265320239.953 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:PeakDetectOil] Stopped 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectOil 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:PeakDetectNO3] Stopped 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectNO3 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:HighestChlPeakReport] Stopped 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestChlPeakReport 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2010-02-04T21:50:39.954Z,1265320239.954 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2010-02-04T21:50:39.955Z,1265320239.955 [run_backseat_on_surface:Science:PeakDetectChl] Stopped 2010-02-04T21:50:39.955Z,1265320239.955 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectChl 2010-02-04T21:50:39.955Z,1265320239.955 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2010-02-04T21:50:39.955Z,1265320239.955 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2010-02-04T21:50:39.955Z,1265320239.955 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1 2010-02-04T21:50:39.959Z,1265320239.959 [run_backseat_on_surface:Science:Read_Oil] Stopped 2010-02-04T21:50:39.959Z,1265320239.959 [run_backseat_on_surface:Science:F] Stopped 2010-02-04T21:50:39.959Z,1265320239.959 [run_backseat_on_surface:Science:E] Stopped 2010-02-04T21:50:39.960Z,1265320239.960 [run_backseat_on_surface:Science:D] Stopped 2010-02-04T21:50:39.960Z,1265320239.960 [run_backseat_on_surface:Science:C] Stopped 2010-02-04T21:50:39.960Z,1265320239.960 [run_backseat_on_surface:Science:B] Stopped 2010-02-04T21:50:39.960Z,1265320239.960 [run_backseat_on_surface:Science:A] Stopped 2010-02-04T21:50:40.261Z,1265320240.261 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2010-02-04T21:50:54.420Z,1265320254.420 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec). 2010-02-04T21:50:54.421Z,1265320254.421 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2010-02-04T21:50:54.421Z,1265320254.421 [LcmUniversalReporter](INFO): Deactivating messaging. 2010-02-04T21:51:00.883Z,1265320260.883 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T21:51:00.883Z,1265320260.883 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2010-02-04T21:51:00.883Z,1265320260.883 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T21:51:00.897Z,1265320260.897 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T21:51:01.288Z,1265320261.288 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T21:51:01.288Z,1265320261.288 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2010-02-04T21:51:09.737Z,1265320269.737 [BackseatComponent](INFO): Powering up 2010-02-04T21:51:09.737Z,1265320269.737 [BackseatComponent](INFO): Subscribing to LCM channels. 2010-02-04T21:53:02.052Z,1265320382.052 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T21:53:02.052Z,1265320382.052 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2010-02-04T21:53:02.052Z,1265320382.052 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T21:53:02.065Z,1265320382.065 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T21:53:02.493Z,1265320382.493 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T21:53:02.493Z,1265320382.493 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2010-02-04T21:53:39.213Z,1265320419.213 [NAL9602](FAULT): GPS failed to acquire within timeout. 2010-02-04T21:53:39.213Z,1265320419.213 [NAL9602] Data Fault, FailCount= 1 2010-02-04T21:53:39.213Z,1265320419.213 [NAL9602](ERROR): Data Fault 2010-02-04T21:53:39.253Z,1265320419.253 [CBIT](ERROR): Data Fault in component: NAL9602 2010-02-04T21:53:39.619Z,1265320419.619 [NAL9602](INFO): Powering down 2010-02-04T21:53:40.445Z,1265320420.445 [CBIT](INFO): Clearing failed state for component NAL9602 2010-02-04T21:53:40.445Z,1265320420.445 [NAL9602] No Fault, FailCount= 1 2010-02-04T21:54:09.918Z,1265320449.918 [NAL9602](INFO): Powering up NAL9602 2010-02-04T21:54:20.828Z,1265320460.828 [NAL9602](INFO): NAL9602 initialized 2010-02-04T21:55:03.275Z,1265320503.275 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T21:55:03.275Z,1265320503.275 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2010-02-04T21:55:03.275Z,1265320503.275 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T21:55:03.289Z,1265320503.289 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T21:55:03.697Z,1265320503.697 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T21:55:03.697Z,1265320503.697 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2010-02-04T21:55:40.020Z,1265320540.020 [run_backseat_on_surface:CheckIn:Read_GPS](INFO): Timed out from 2010-02-04T21:50:39.9Z 2010-02-04T21:55:40.020Z,1265320540.020 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2010-02-04T21:55:40.021Z,1265320540.021 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1 2010-02-04T21:55:40.457Z,1265320540.457 [run_backseat_on_surface:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2010-02-04T21:55:41.584Z,1265320541.584 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20100204T214248/Courier0004.lzma 2010-02-04T21:55:42.389Z,1265320542.389 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Courier0004.lzma.bak 2010-02-04T21:55:42.389Z,1265320542.389 [DataOverHttps](INFO): SBD MOMSN=18031223 2010-02-04T21:55:57.899Z,1265320557.899 [DataOverHttps](INFO): Sending 422 bytes from file Logs/20100204T214248/Express0005.lzma 2010-02-04T21:55:58.901Z,1265320558.901 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Express0005.lzma.bak 2010-02-04T21:55:58.901Z,1265320558.901 [DataOverHttps](INFO): SBD MOMSN=18031225 2010-02-04T21:56:14.178Z,1265320574.178 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20100204T214248/Express0008.lzma 2010-02-04T21:56:15.181Z,1265320575.181 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Express0008.lzma.bak 2010-02-04T21:56:15.181Z,1265320575.181 [DataOverHttps](INFO): SBD MOMSN=18031238 2010-02-04T21:56:16.787Z,1265320576.787 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped 2010-02-04T21:56:16.788Z,1265320576.788 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1 2010-02-04T21:56:16.788Z,1265320576.788 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2010-02-04T21:56:25.059Z,1265320585.059 [BackseatComponent](FAULT): Failed to receive device response within the specified timeout. 2010-02-04T21:56:25.059Z,1265320585.059 [BackseatComponent] Communications Fault, FailCount= 1 2010-02-04T21:56:25.059Z,1265320585.059 [BackseatComponent](ERROR): Communications Fault 2010-02-04T21:56:25.285Z,1265320585.285 [CBIT](ERROR): Communications Fault in component: BackseatComponent 2010-02-04T21:56:25.465Z,1265320585.465 [BackseatComponent](INFO): Sent LCM shutdown request. 2010-02-04T21:56:40.816Z,1265320600.816 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec). 2010-02-04T21:56:40.817Z,1265320600.817 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2010-02-04T21:56:40.817Z,1265320600.817 [LcmUniversalReporter](INFO): Deactivating messaging. 2010-02-04T21:56:56.584Z,1265320616.584 [BackseatComponent](INFO): Powering up 2010-02-04T21:56:56.584Z,1265320616.584 [BackseatComponent](INFO): Subscribing to LCM channels. 2010-02-04T21:56:56.808Z,1265320616.808 [DVL_micro](ERROR): No DVL communication! Re-initializing 2010-02-04T21:56:56.809Z,1265320616.809 [DVL_micro] Communications Fault, FailCount= 1 2010-02-04T21:56:56.809Z,1265320616.809 [DVL_micro](ERROR): Communications Fault 2010-02-04T21:56:56.880Z,1265320616.880 [CBIT](INFO): Clearing failed state for component BackseatComponent 2010-02-04T21:56:56.880Z,1265320616.880 [BackseatComponent] No Fault, FailCount= 1 2010-02-04T21:56:56.880Z,1265320616.880 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T21:56:57.271Z,1265320617.271 [DVL_micro](INFO): Powering down 2010-02-04T21:56:58.062Z,1265320618.062 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T21:56:58.062Z,1265320618.062 [DVL_micro] No Fault, FailCount= 1 2010-02-04T21:57:04.111Z,1265320624.111 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T21:57:04.111Z,1265320624.111 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2010-02-04T21:57:04.111Z,1265320624.111 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T21:57:04.175Z,1265320624.175 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T21:57:04.520Z,1265320624.520 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T21:57:04.520Z,1265320624.520 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2010-02-04T21:57:15.773Z,1265320635.773 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T21:57:15.774Z,1265320635.774 [DVL_micro] Communications Fault, FailCount= 2 2010-02-04T21:57:15.774Z,1265320635.774 [DVL_micro](ERROR): Communications Fault 2010-02-04T21:57:15.793Z,1265320635.793 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T21:57:16.251Z,1265320636.251 [DVL_micro](INFO): Powering down 2010-02-04T21:57:17.033Z,1265320637.033 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T21:57:17.033Z,1265320637.033 [DVL_micro] No Fault, FailCount= 2 2010-02-04T21:57:34.761Z,1265320654.761 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T21:57:34.761Z,1265320654.761 [DVL_micro] Communications Fault, FailCount= 3 2010-02-04T21:57:34.761Z,1265320654.761 [DVL_micro](ERROR): Communications Fault 2010-02-04T21:57:34.781Z,1265320654.781 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T21:57:34.782Z,1265320654.782 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2010-02-04T21:57:35.239Z,1265320655.239 [DVL_micro](INFO): Powering down 2010-02-04T21:57:35.259Z,1265320655.259 [CBIT](INFO): Critical error at 20100204T215734 2010-02-04T21:57:35.259Z,1265320655.259 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2010-02-04T21:57:35.600Z,1265320655.600 [MissionManager](INFO): MissionManager is completed. 2010-02-04T21:57:35.600Z,1265320655.600 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface] Stopped 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:Science] Stopped 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:Science:OceanCurrent] Stopped 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:B.BackseatDriver] Stopped 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Uninitialize. 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:C.GoToSurface] Stopped 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2010-02-04T21:57:35.601Z,1265320655.601 [run_backseat_on_surface:CheckIn] Stopped 2010-02-04T21:57:35.602Z,1265320655.602 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2010-02-04T21:57:35.602Z,1265320655.602 [run_backseat_on_surface:CheckIn:C.Wait] Stopped 2010-02-04T21:57:35.602Z,1265320655.602 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2010-02-04T21:57:36.006Z,1265320656.006 [MissionManager](IMPORTANT): Started mission Default 2010-02-04T21:57:36.006Z,1265320656.006 [Default] Running Loop=1 2010-02-04T21:57:36.006Z,1265320656.006 [Default](DEBUG): Aggregate::initialize Default 2010-02-04T21:57:36.006Z,1265320656.006 [Default:B.GoToSurface] Running Loop=1 2010-02-04T21:57:36.006Z,1265320656.006 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2010-02-04T21:57:36.006Z,1265320656.006 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2010-02-04T21:57:36.007Z,1265320656.007 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2010-02-04T21:57:36.007Z,1265320656.007 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2010-02-04T21:57:36.007Z,1265320656.007 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2010-02-04T21:57:36.008Z,1265320656.008 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2010-02-04T21:57:36.008Z,1265320656.008 [Default:A.Wait] Running Loop=1 2010-02-04T21:57:36.008Z,1265320656.008 [Default:A.Wait](DEBUG): Initialize Wait Component. 2010-02-04T21:57:36.884Z,1265320656.884 [BackseatComponent](INFO): Sent LCM shutdown request. 2010-02-04T21:57:49.333Z,1265320669.333 [Default:A.Wait](INFO): Done Waiting. 2010-02-04T21:57:49.333Z,1265320669.333 [Default:A.Wait] Stopped 2010-02-04T21:57:49.333Z,1265320669.333 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2010-02-04T21:57:49.733Z,1265320669.733 [Default:CheckIn] Running Loop=1 2010-02-04T21:57:49.733Z,1265320669.733 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2010-02-04T21:57:49.733Z,1265320669.733 [Default:CheckIn:Read_GPS] Running Loop=1 2010-02-04T21:57:50.125Z,1265320670.125 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2010-02-04T21:57:51.987Z,1265320671.987 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec). 2010-02-04T21:57:51.988Z,1265320671.988 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2010-02-04T21:57:51.988Z,1265320671.988 [LcmUniversalReporter](INFO): Deactivating messaging. 2010-02-04T21:57:59.040Z,1265320679.040 [CBIT](INFO): Clearing failed state for component DropWeight 2010-02-04T21:57:59.040Z,1265320679.040 [DropWeight] No Fault, FailCount= 1 2010-02-04T21:59:05.272Z,1265320745.272 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T21:59:05.272Z,1265320745.272 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2010-02-04T21:59:05.272Z,1265320745.272 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T21:59:05.284Z,1265320745.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T21:59:05.687Z,1265320745.687 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T21:59:05.687Z,1265320745.687 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2010-02-04T22:00:35.001Z,1265320835.001 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:00:35.001Z,1265320835.001 [DVL_micro] No Fault, FailCount= 3 2010-02-04T22:00:52.729Z,1265320852.729 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:00:52.729Z,1265320852.729 [DVL_micro] Communications Fault, FailCount= 1 2010-02-04T22:00:52.729Z,1265320852.729 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:00:52.788Z,1265320852.788 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:00:53.219Z,1265320853.219 [DVL_micro](INFO): Powering down 2010-02-04T22:00:53.987Z,1265320853.987 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:00:53.987Z,1265320853.987 [DVL_micro] No Fault, FailCount= 1 2010-02-04T22:01:06.091Z,1265320866.091 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:01:06.091Z,1265320866.091 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2010-02-04T22:01:06.092Z,1265320866.092 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:01:06.102Z,1265320866.102 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:01:06.508Z,1265320866.508 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:01:06.508Z,1265320866.508 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2010-02-04T22:01:11.722Z,1265320871.722 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:01:11.722Z,1265320871.722 [DVL_micro] Communications Fault, FailCount= 2 2010-02-04T22:01:11.722Z,1265320871.722 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:01:11.781Z,1265320871.781 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:01:12.191Z,1265320872.191 [DVL_micro](INFO): Powering down 2010-02-04T22:01:12.959Z,1265320872.959 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:01:12.959Z,1265320872.959 [DVL_micro] No Fault, FailCount= 2 2010-02-04T22:01:30.712Z,1265320890.712 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:01:30.712Z,1265320890.712 [DVL_micro] Communications Fault, FailCount= 3 2010-02-04T22:01:30.712Z,1265320890.712 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:01:30.746Z,1265320890.746 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:01:30.746Z,1265320890.746 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2010-02-04T22:01:31.187Z,1265320891.187 [DVL_micro](INFO): Powering down 2010-02-04T22:01:31.202Z,1265320891.202 [CBIT](INFO): Critical error at 20100204T220130 2010-02-04T22:01:45.933Z,1265320905.933 [CommandExec](IMPORTANT): got command show variable heading 2010-02-04T22:01:45.942Z,1265320905.942 [CommandExec](IMPORTANT): LineCapture.kpHeadingTerminalGuidance (ratio) 2010-02-04T22:01:45.942Z,1265320905.942 [CommandExec](IMPORTANT): LineCapture.kiHeadingTerminalGuidance (reciprocal_second) 2010-02-04T22:01:45.943Z,1265320905.943 [CommandExec](IMPORTANT): LineCapture.kpHeadingFinalApproach (ratio) 2010-02-04T22:01:45.943Z,1265320905.943 [CommandExec](IMPORTANT): LineCapture.kiHeadingFinalApproach (reciprocal_second) 2010-02-04T22:01:45.956Z,1265320905.956 [CommandExec](IMPORTANT): Rowe_600.headingOffset (degree) 2010-02-04T22:01:45.971Z,1265320905.971 [CommandExec](IMPORTANT): HorizontalControl.kdHeading (second) 2010-02-04T22:01:45.972Z,1265320905.972 [CommandExec](IMPORTANT): HorizontalControl.kiHeading (reciprocal_second) 2010-02-04T22:01:45.972Z,1265320905.972 [CommandExec](IMPORTANT): HorizontalControl.kiwpHeading (radian_per_second_per_meter) 2010-02-04T22:01:45.972Z,1265320905.972 [CommandExec](IMPORTANT): HorizontalControl.kpHeading (none) 2010-02-04T22:01:45.973Z,1265320905.973 [CommandExec](IMPORTANT): HorizontalControl.kwpHeading (radian_per_meter) 2010-02-04T22:01:46.121Z,1265320906.121 [CommandExec](IMPORTANT): HorizontalControl.headingCmdInternal (radian) 2010-02-04T22:01:46.121Z,1265320906.121 [CommandExec](IMPORTANT): HorizontalControl.smoothHeadingCmdInternal (radian) 2010-02-04T22:01:46.122Z,1265320906.122 [CommandExec](IMPORTANT): HorizontalControl.headingIntegralInternal (radian) 2010-02-04T22:02:01.537Z,1265320921.537 [CommandExec](IMPORTANT): got command show variable platform 2010-02-04T22:02:01.540Z,1265320921.540 [CommandExec](IMPORTANT): platform_average_current (milliampere) 2010-02-04T22:02:01.540Z,1265320921.540 [CommandExec](IMPORTANT): platform_average_power (watt) 2010-02-04T22:02:01.541Z,1265320921.541 [CommandExec](IMPORTANT): platform_battery_charge (unknown) 2010-02-04T22:02:01.541Z,1265320921.541 [CommandExec](IMPORTANT): platform_battery_charge_usage (unknown) 2010-02-04T22:02:01.541Z,1265320921.541 [CommandExec](IMPORTANT): platform_battery_energy_usage (unknown) 2010-02-04T22:02:01.542Z,1265320921.542 [CommandExec](IMPORTANT): platform_battery_voltage (volt) 2010-02-04T22:02:01.542Z,1265320921.542 [CommandExec](IMPORTANT): platform_battery_fully_charged (unknown) 2010-02-04T22:02:01.542Z,1265320921.542 [CommandExec](IMPORTANT): platform_battery_discharging (unknown) 2010-02-04T22:02:01.543Z,1265320921.543 [CommandExec](IMPORTANT): platform_buoyancy_position (cubic_centimeter) 2010-02-04T22:02:01.543Z,1265320921.543 [CommandExec](IMPORTANT): platform_communications (bool) 2010-02-04T22:02:01.544Z,1265320921.544 [CommandExec](IMPORTANT): platform_conversation (unknown) 2010-02-04T22:02:01.544Z,1265320921.544 [CommandExec](IMPORTANT): platform_course (unknown) 2010-02-04T22:02:01.544Z,1265320921.544 [CommandExec](IMPORTANT): platform_distance_wrt_ground (unknown) 2010-02-04T22:02:01.545Z,1265320921.545 [CommandExec](IMPORTANT): platform_distance_wrt_sea_water (meter) 2010-02-04T22:02:01.545Z,1265320921.545 [CommandExec](IMPORTANT): platform_elevator_angle (radian) 2010-02-04T22:02:01.545Z,1265320921.545 [CommandExec](IMPORTANT): platform_fault (enum) 2010-02-04T22:02:01.546Z,1265320921.546 [CommandExec](IMPORTANT): platform_fault_leak (unknown) 2010-02-04T22:02:01.546Z,1265320921.546 [CommandExec](IMPORTANT): platform_magnetic_orientation (unknown) 2010-02-04T22:02:01.546Z,1265320921.546 [CommandExec](IMPORTANT): platform_mass_position (meter) 2010-02-04T22:02:01.548Z,1265320921.548 [CommandExec](IMPORTANT): platform_pitch_rate (unknown) 2010-02-04T22:02:01.548Z,1265320921.548 [CommandExec](IMPORTANT): platform_pressure (unknown) 2010-02-04T22:02:01.549Z,1265320921.549 [CommandExec](IMPORTANT): platform_propeller_rotation_rate (radian_per_second) 2010-02-04T22:02:01.549Z,1265320921.549 [CommandExec](IMPORTANT): platform_relative_humidity (unknown) 2010-02-04T22:02:01.550Z,1265320921.550 [CommandExec](IMPORTANT): platform_roll_rate (unknown) 2010-02-04T22:02:01.550Z,1265320921.550 [CommandExec](IMPORTANT): platform_rudder_angle (radian) 2010-02-04T22:02:01.550Z,1265320921.550 [CommandExec](IMPORTANT): platform_speed_wrt_ground (unknown) 2010-02-04T22:02:01.551Z,1265320921.551 [CommandExec](IMPORTANT): platform_speed_wrt_sea_water (meter_per_second) 2010-02-04T22:02:01.551Z,1265320921.551 [CommandExec](IMPORTANT): platform_temperature (unknown) 2010-02-04T22:02:01.552Z,1265320921.552 [CommandExec](IMPORTANT): platform_vehicle_power (unknown) 2010-02-04T22:02:01.552Z,1265320921.552 [CommandExec](IMPORTANT): platform_velocity_wrt_ground (unknown) 2010-02-04T22:02:01.552Z,1265320921.552 [CommandExec](IMPORTANT): platform_x_sea_water_velocity (unknown) 2010-02-04T22:02:01.553Z,1265320921.553 [CommandExec](IMPORTANT): platform_x_velocity_wrt_ground (unknown) 2010-02-04T22:02:01.553Z,1265320921.553 [CommandExec](IMPORTANT): platform_x_velocity_wrt_sea_water (meter_per_second) 2010-02-04T22:02:01.554Z,1265320921.554 [CommandExec](IMPORTANT): platform_x_velocity_current (unknown) 2010-02-04T22:02:01.554Z,1265320921.554 [CommandExec](IMPORTANT): platform_y_sea_water_velocity (unknown) 2010-02-04T22:02:01.554Z,1265320921.554 [CommandExec](IMPORTANT): platform_y_velocity_wrt_ground (unknown) 2010-02-04T22:02:01.555Z,1265320921.555 [CommandExec](IMPORTANT): platform_y_velocity_wrt_sea_water (unknown) 2010-02-04T22:02:01.555Z,1265320921.555 [CommandExec](IMPORTANT): platform_y_velocity_current (unknown) 2010-02-04T22:02:01.556Z,1265320921.556 [CommandExec](IMPORTANT): platform_yaw_angle (unknown) 2010-02-04T22:02:01.556Z,1265320921.556 [CommandExec](IMPORTANT): platform_yaw_rate (unknown) 2010-02-04T22:02:01.556Z,1265320921.556 [CommandExec](IMPORTANT): platform_z_sea_water_velocity (unknown) 2010-02-04T22:02:01.557Z,1265320921.557 [CommandExec](IMPORTANT): platform_z_velocity_wrt_ground (unknown) 2010-02-04T22:02:01.557Z,1265320921.557 [CommandExec](IMPORTANT): platform_z_velocity_wrt_sea_water (unknown) 2010-02-04T22:02:01.557Z,1265320921.557 [CommandExec](IMPORTANT): platform_z_velocity_current (unknown) 2010-02-04T22:02:01.560Z,1265320921.560 [CommandExec](IMPORTANT): CommandExec.platform_conversation (bool) 2010-02-04T22:02:01.560Z,1265320921.560 [CommandExec](IMPORTANT): LogSplitter.platform_communications (bool) 2010-02-04T22:02:01.574Z,1265320921.574 [CommandExec](IMPORTANT): NAL9602.power_platform_communications (watt) 2010-02-04T22:02:01.599Z,1265320921.599 [CommandExec](IMPORTANT): Vehicle.argoPlatform (none) 2010-02-04T22:02:01.677Z,1265320921.677 [CommandExec](IMPORTANT): BuoyancyServo.platform_buoyancy_position (cubic_centimeter) 2010-02-04T22:02:01.678Z,1265320921.678 [CommandExec](IMPORTANT): ElevatorServo.platform_elevator_angle (radian) 2010-02-04T22:02:01.678Z,1265320921.678 [CommandExec](IMPORTANT): MassServo.platform_mass_position (meter) 2010-02-04T22:02:01.683Z,1265320921.683 [CommandExec](IMPORTANT): RudderServo.platform_rudder_angle (radian) 2010-02-04T22:02:01.684Z,1265320921.684 [CommandExec](IMPORTANT): ThrusterHE.platform_propeller_rotation_rate (radian_per_second) 2010-02-04T22:02:01.694Z,1265320921.694 [CommandExec](IMPORTANT): CBIT.platform_fault (enum) 2010-02-04T22:02:01.695Z,1265320921.695 [CommandExec](IMPORTANT): CBIT.platform_fault_leak (enum) 2010-02-04T22:02:01.702Z,1265320921.702 [CommandExec](IMPORTANT): PitchRateCalculator.platform_pitch_rate (radian_per_second) 2010-02-04T22:02:01.703Z,1265320921.703 [CommandExec](IMPORTANT): SpeedCalculator.platform_speed_wrt_sea_water (meter_per_second) 2010-02-04T22:02:01.705Z,1265320921.705 [CommandExec](IMPORTANT): SpeedCalculator.platform_x_velocity_wrt_sea_water (meter_per_second) 2010-02-04T22:02:01.706Z,1265320921.706 [CommandExec](IMPORTANT): SpeedCalculator.platform_distance_wrt_sea_water (meter) 2010-02-04T22:02:01.706Z,1265320921.706 [CommandExec](IMPORTANT): YawRateCalculator.platform_yaw_rate (radian_per_second) 2010-02-04T22:02:01.716Z,1265320921.716 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources.platform_speed_wrt_ground (meter_per_second) 2010-02-04T22:02:01.716Z,1265320921.716 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources.platform_course (unspecified) 2010-02-04T22:02:01.719Z,1265320921.719 [CommandExec](IMPORTANT): BPC1.platform_battery_charge (ampere_hour) 2010-02-04T22:02:01.724Z,1265320921.724 [CommandExec](IMPORTANT): BPC1.platform_battery_voltage (volt) 2010-02-04T22:02:01.758Z,1265320921.758 [CommandExec](IMPORTANT): DataOverHttps.platform_communications (bool) 2010-02-04T22:02:01.764Z,1265320921.764 [CommandExec](IMPORTANT): DVL_micro.platform_velocity_wrt_ground (meter_per_second) 2010-02-04T22:02:01.764Z,1265320921.764 [CommandExec](IMPORTANT): DVL_micro.platform_x_velocity_wrt_ground (meter_per_second) 2010-02-04T22:02:01.765Z,1265320921.765 [CommandExec](IMPORTANT): DVL_micro.platform_y_velocity_wrt_ground (meter_per_second) 2010-02-04T22:02:01.765Z,1265320921.765 [CommandExec](IMPORTANT): DVL_micro.platform_z_velocity_wrt_ground (meter_per_second) 2010-02-04T22:02:01.766Z,1265320921.766 [CommandExec](IMPORTANT): NAL9602.platform_communications (bool) 2010-02-04T22:02:01.767Z,1265320921.767 [CommandExec](IMPORTANT): Onboard.platform_battery_voltage (volt) 2010-02-04T22:02:01.767Z,1265320921.767 [CommandExec](IMPORTANT): Onboard.platform_vehicle_power (watt) 2010-02-04T22:02:01.767Z,1265320921.767 [CommandExec](IMPORTANT): Onboard.platform_average_current (milliampere) 2010-02-04T22:02:01.768Z,1265320921.768 [CommandExec](IMPORTANT): Onboard.platform_average_power (watt) 2010-02-04T22:02:01.770Z,1265320921.770 [CommandExec](IMPORTANT): DAT.platform_communications (bool) 2010-02-04T22:02:28.119Z,1265320948.119 [CommandExec](IMPORTANT): got command get platform_orientation 2010-02-04T22:02:28.119Z,1265320948.119 [CommandExec](FAULT): Element has no value 2010-02-04T22:02:49.916Z,1265320969.916 [Default:CheckIn:Read_GPS](INFO): Timed out from 2010-02-04T21:57:49.7Z 2010-02-04T22:02:49.916Z,1265320969.916 [Default:CheckIn:Read_GPS] Stopped 2010-02-04T22:02:49.917Z,1265320969.917 [Default:CheckIn:Read_Iridium] Running Loop=1 2010-02-04T22:02:50.318Z,1265320970.318 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2010-02-04T22:02:57.263Z,1265320977.263 [DataOverHttps](INFO): Sending 97 bytes from file Logs/20100204T214248/Courier0010.lzma 2010-02-04T22:02:58.265Z,1265320978.265 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Courier0010.lzma.bak 2010-02-04T22:02:58.265Z,1265320978.265 [DataOverHttps](INFO): SBD MOMSN=18031286 2010-02-04T22:03:07.273Z,1265320987.273 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:03:07.273Z,1265320987.273 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2010-02-04T22:03:07.273Z,1265320987.273 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:03:07.284Z,1265320987.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:03:07.693Z,1265320987.693 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:03:07.693Z,1265320987.693 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2010-02-04T22:03:13.409Z,1265320993.409 [DataOverHttps](INFO): Sending 1465 bytes from file Logs/20100204T214248/Express0011.lzma 2010-02-04T22:03:14.409Z,1265320994.409 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Express0011.lzma.bak 2010-02-04T22:03:14.409Z,1265320994.409 [DataOverHttps](INFO): SBD MOMSN=18031290 2010-02-04T22:03:15.780Z,1265320995.780 [Default:CheckIn:Read_Iridium] Stopped 2010-02-04T22:03:15.781Z,1265320995.781 [Default:CheckIn:C.Wait] Running Loop=1 2010-02-04T22:03:15.781Z,1265320995.781 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2010-02-04T22:04:22.009Z,1265321062.009 [NAL9602](FAULT): GPS failed to acquire within timeout. 2010-02-04T22:04:22.009Z,1265321062.009 [NAL9602] Data Fault, FailCount= 2 2010-02-04T22:04:22.009Z,1265321062.009 [NAL9602](ERROR): Data Fault 2010-02-04T22:04:22.054Z,1265321062.054 [CBIT](ERROR): Data Fault in component: NAL9602 2010-02-04T22:04:22.414Z,1265321062.414 [NAL9602](INFO): Powering down 2010-02-04T22:04:23.238Z,1265321063.238 [CBIT](INFO): Clearing failed state for component NAL9602 2010-02-04T22:04:23.238Z,1265321063.238 [NAL9602] No Fault, FailCount= 2 2010-02-04T22:04:30.912Z,1265321070.912 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:04:30.912Z,1265321070.912 [DVL_micro] No Fault, FailCount= 3 2010-02-04T22:04:48.674Z,1265321088.674 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:04:48.674Z,1265321088.674 [DVL_micro] Communications Fault, FailCount= 1 2010-02-04T22:04:48.674Z,1265321088.674 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:04:48.714Z,1265321088.714 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:04:49.143Z,1265321089.143 [DVL_micro](INFO): Powering down 2010-02-04T22:04:49.905Z,1265321089.905 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:04:49.905Z,1265321089.905 [DVL_micro] No Fault, FailCount= 1 2010-02-04T22:04:52.714Z,1265321092.714 [NAL9602](INFO): Powering up NAL9602 2010-02-04T22:05:03.622Z,1265321103.622 [NAL9602](INFO): NAL9602 initialized 2010-02-04T22:05:07.662Z,1265321107.662 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:05:07.662Z,1265321107.662 [DVL_micro] Communications Fault, FailCount= 2 2010-02-04T22:05:07.662Z,1265321107.662 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:05:07.679Z,1265321107.679 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:05:08.135Z,1265321108.135 [DVL_micro](INFO): Powering down 2010-02-04T22:05:08.147Z,1265321108.147 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:05:08.148Z,1265321108.148 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2010-02-04T22:05:08.148Z,1265321108.148 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:05:08.158Z,1265321108.158 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:05:08.496Z,1265321108.496 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:05:08.496Z,1265321108.496 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2010-02-04T22:05:08.890Z,1265321108.890 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:05:08.890Z,1265321108.890 [DVL_micro] No Fault, FailCount= 2 2010-02-04T22:05:26.652Z,1265321126.652 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:05:26.652Z,1265321126.652 [DVL_micro] Communications Fault, FailCount= 3 2010-02-04T22:05:26.652Z,1265321126.652 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:05:26.669Z,1265321126.669 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:05:26.669Z,1265321126.669 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2010-02-04T22:05:27.127Z,1265321127.127 [DVL_micro](INFO): Powering down 2010-02-04T22:05:27.148Z,1265321127.148 [CBIT](INFO): Critical error at 20100204T220526 2010-02-04T22:07:09.284Z,1265321229.284 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:07:09.284Z,1265321229.284 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2010-02-04T22:07:09.284Z,1265321229.284 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:07:09.295Z,1265321229.295 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:07:09.710Z,1265321229.710 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:07:09.710Z,1265321229.710 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2010-02-04T22:08:16.368Z,1265321296.368 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2010-02-04T22:08:16.369Z,1265321296.369 [Default:CheckIn:C.Wait] Stopped 2010-02-04T22:08:16.369Z,1265321296.369 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2010-02-04T22:08:16.369Z,1265321296.369 [Default:CheckIn:D] Running Loop=1 2010-02-04T22:08:16.759Z,1265321296.759 [Default:CheckIn:D] Stopped 2010-02-04T22:08:16.759Z,1265321296.759 [Default:CheckIn:E] Running Loop=1 2010-02-04T22:08:17.157Z,1265321297.157 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.679218 min 2010-02-04T22:08:17.157Z,1265321297.157 [Default:CheckIn:E] Stopped 2010-02-04T22:08:17.157Z,1265321297.157 [Default:CheckIn](INFO): Completed Default:CheckIn 2010-02-04T22:08:17.157Z,1265321297.157 [Default:CheckIn] Stopped 2010-02-04T22:08:17.157Z,1265321297.157 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2010-02-04T22:08:17.157Z,1265321297.157 [Default:CheckIn](INFO): Running loop #2 2010-02-04T22:08:17.157Z,1265321297.157 [Default:CheckIn] Running Loop=2 2010-02-04T22:08:17.157Z,1265321297.157 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2010-02-04T22:08:17.158Z,1265321297.158 [Default:CheckIn:Read_GPS] Running Loop=1 2010-02-04T22:08:26.861Z,1265321306.861 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:08:26.862Z,1265321306.862 [DVL_micro] No Fault, FailCount= 3 2010-02-04T22:08:44.623Z,1265321324.623 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:08:44.623Z,1265321324.623 [DVL_micro] Communications Fault, FailCount= 1 2010-02-04T22:08:44.623Z,1265321324.623 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:08:44.658Z,1265321324.658 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:08:45.099Z,1265321325.099 [DVL_micro](INFO): Powering down 2010-02-04T22:08:45.849Z,1265321325.849 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:08:45.849Z,1265321325.849 [DVL_micro] No Fault, FailCount= 1 2010-02-04T22:09:03.610Z,1265321343.610 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:09:03.610Z,1265321343.610 [DVL_micro] Communications Fault, FailCount= 2 2010-02-04T22:09:03.610Z,1265321343.610 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:09:03.627Z,1265321343.627 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:09:04.087Z,1265321344.087 [DVL_micro](INFO): Powering down 2010-02-04T22:09:04.861Z,1265321344.861 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:09:04.861Z,1265321344.861 [DVL_micro] No Fault, FailCount= 2 2010-02-04T22:09:10.497Z,1265321350.497 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:09:10.497Z,1265321350.497 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2010-02-04T22:09:10.497Z,1265321350.497 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:09:10.508Z,1265321350.508 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:09:10.917Z,1265321350.917 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:09:10.917Z,1265321350.917 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2010-02-04T22:09:22.593Z,1265321362.593 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:09:22.593Z,1265321362.593 [DVL_micro] Communications Fault, FailCount= 3 2010-02-04T22:09:22.593Z,1265321362.593 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:09:22.645Z,1265321362.645 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:09:22.646Z,1265321362.646 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2010-02-04T22:09:23.071Z,1265321363.071 [DVL_micro](INFO): Powering down 2010-02-04T22:09:23.100Z,1265321363.100 [CBIT](INFO): Critical error at 20100204T220922 2010-02-04T22:11:11.684Z,1265321471.684 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:11:11.684Z,1265321471.684 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2010-02-04T22:11:11.684Z,1265321471.684 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:11:11.695Z,1265321471.695 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:11:12.100Z,1265321472.100 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:11:12.100Z,1265321472.100 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2010-02-04T22:12:22.831Z,1265321542.831 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:12:22.831Z,1265321542.831 [DVL_micro] No Fault, FailCount= 3 2010-02-04T22:12:40.558Z,1265321560.558 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:12:40.558Z,1265321560.558 [DVL_micro] Communications Fault, FailCount= 1 2010-02-04T22:12:40.558Z,1265321560.558 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:12:40.606Z,1265321560.606 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:12:41.031Z,1265321561.031 [DVL_micro](INFO): Powering down 2010-02-04T22:12:41.789Z,1265321561.789 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:12:41.789Z,1265321561.789 [DVL_micro] No Fault, FailCount= 1 2010-02-04T22:12:59.546Z,1265321579.546 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:12:59.546Z,1265321579.546 [DVL_micro] Communications Fault, FailCount= 2 2010-02-04T22:12:59.546Z,1265321579.546 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:12:59.563Z,1265321579.563 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:13:00.019Z,1265321580.019 [DVL_micro](INFO): Powering down 2010-02-04T22:13:00.793Z,1265321580.793 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:13:00.793Z,1265321580.793 [DVL_micro] No Fault, FailCount= 2 2010-02-04T22:13:12.883Z,1265321592.883 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:13:12.884Z,1265321592.884 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2010-02-04T22:13:12.884Z,1265321592.884 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:13:12.894Z,1265321592.894 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:13:13.297Z,1265321593.297 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:13:13.297Z,1265321593.297 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2010-02-04T22:13:17.350Z,1265321597.350 [Default:CheckIn:Read_GPS](INFO): Timed out from 2010-02-04T22:08:17.2Z 2010-02-04T22:13:17.350Z,1265321597.350 [Default:CheckIn:Read_GPS] Stopped 2010-02-04T22:13:17.350Z,1265321597.350 [Default:CheckIn:Read_Iridium] Running Loop=1 2010-02-04T22:13:18.545Z,1265321598.545 [DVL_micro](FAULT): Failed to initialize within timeout. 2010-02-04T22:13:18.545Z,1265321598.545 [DVL_micro] Communications Fault, FailCount= 3 2010-02-04T22:13:18.545Z,1265321598.545 [DVL_micro](ERROR): Communications Fault 2010-02-04T22:13:18.570Z,1265321598.570 [CBIT](ERROR): Communications Fault in component: DVL_micro 2010-02-04T22:13:18.571Z,1265321598.571 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2010-02-04T22:13:19.011Z,1265321599.011 [DVL_micro](INFO): Powering down 2010-02-04T22:13:19.031Z,1265321599.031 [CBIT](INFO): Critical error at 20100204T221318 2010-02-04T22:13:24.247Z,1265321604.247 [DataOverHttps](INFO): Sending 97 bytes from file Logs/20100204T214248/Courier0013.lzma 2010-02-04T22:13:25.249Z,1265321605.249 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Courier0013.lzma.bak 2010-02-04T22:13:25.249Z,1265321605.249 [DataOverHttps](INFO): SBD MOMSN=18031425 2010-02-04T22:13:40.467Z,1265321620.467 [DataOverHttps](INFO): Sending 343 bytes from file Logs/20100204T214248/Express0014.lzma 2010-02-04T22:13:41.469Z,1265321621.469 [DataOverHttps](INFO): Moved sent file to Logs/20100204T214248/Express0014.lzma.bak 2010-02-04T22:13:41.469Z,1265321621.469 [DataOverHttps](INFO): SBD MOMSN=18031429 2010-02-04T22:13:42.804Z,1265321622.804 [Default:CheckIn:Read_Iridium] Stopped 2010-02-04T22:13:42.804Z,1265321622.804 [Default:CheckIn:C.Wait] Running Loop=1 2010-02-04T22:13:42.804Z,1265321622.804 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2010-02-04T22:15:04.786Z,1265321704.786 [NAL9602](FAULT): GPS failed to acquire within timeout. 2010-02-04T22:15:04.787Z,1265321704.787 [NAL9602] Data Fault, FailCount= 3 2010-02-04T22:15:04.787Z,1265321704.787 [NAL9602](ERROR): Data Fault 2010-02-04T22:15:04.802Z,1265321704.802 [CBIT](ERROR): Data Fault in component: NAL9602 2010-02-04T22:15:05.193Z,1265321705.193 [NAL9602](INFO): Powering down 2010-02-04T22:15:06.019Z,1265321706.019 [CBIT](INFO): Clearing failed state for component NAL9602 2010-02-04T22:15:06.019Z,1265321706.019 [NAL9602] No Fault, FailCount= 3 2010-02-04T22:15:14.084Z,1265321714.084 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:15:14.084Z,1265321714.084 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2010-02-04T22:15:14.084Z,1265321714.084 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:15:14.094Z,1265321714.094 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:15:14.514Z,1265321714.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:15:14.515Z,1265321714.515 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2010-02-04T22:15:35.490Z,1265321735.490 [NAL9602](INFO): Powering up NAL9602 2010-02-04T22:15:46.397Z,1265321746.397 [NAL9602](INFO): NAL9602 initialized 2010-02-04T22:16:18.762Z,1265321778.762 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:16:18.762Z,1265321778.762 [DVL_micro] No Fault, FailCount= 3 2010-02-04T22:16:34.070Z,1265321794.070 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2010-02-04T22:16:34.070Z,1265321794.070 [DVL_micro] Data Fault, FailCount= 1 2010-02-04T22:16:34.070Z,1265321794.070 [DVL_micro](ERROR): Data Fault 2010-02-04T22:16:34.085Z,1265321794.085 [CBIT](ERROR): Data Fault in component: DVL_micro 2010-02-04T22:16:34.548Z,1265321794.548 [DVL_micro](INFO): Powering down 2010-02-04T22:16:35.323Z,1265321795.323 [CBIT](INFO): Clearing failed state for component DVL_micro 2010-02-04T22:16:35.323Z,1265321795.323 [DVL_micro] No Fault, FailCount= 1 2010-02-04T22:16:53.471Z,1265321813.471 [DVL_micro](INFO): Failure count cleared after critical for DVL_micro 2010-02-04T22:17:04.886Z,1265321824.886 [CommandExec](IMPORTANT): got command get 2010-02-04T22:17:04.886Z,1265321824.886 [CommandExec](FAULT): Incomplete syntax. Try: help get 2010-02-04T22:17:10.089Z,1265321830.089 [CommandExec](IMPORTANT): got command show variable par 2010-02-04T22:17:10.130Z,1265321830.130 [CommandExec](IMPORTANT): PAR_Licor.loadControl (none) 2010-02-04T22:17:10.130Z,1265321830.130 [CommandExec](IMPORTANT): PAR_Licor.ad (none) 2010-02-04T22:17:10.131Z,1265321830.131 [CommandExec](IMPORTANT): PAR_Licor.adRes (bit) 2010-02-04T22:17:10.131Z,1265321830.131 [CommandExec](IMPORTANT): PAR_Licor.adTimeout (millisecond) 2010-02-04T22:17:10.131Z,1265321830.131 [CommandExec](IMPORTANT): PAR_Licor.adVref (volt) 2010-02-04T22:17:10.148Z,1265321830.148 [CommandExec](IMPORTANT): PAR_Licor.loadAtStartup (bool) 2010-02-04T22:17:10.148Z,1265321830.148 [CommandExec](IMPORTANT): PAR_Licor.simulateHardware (bool) 2010-02-04T22:17:10.148Z,1265321830.148 [CommandExec](IMPORTANT): PAR_Licor.adcCal (microampere_per_count) 2010-02-04T22:17:10.149Z,1265321830.149 [CommandExec](IMPORTANT): PAR_Licor.darkCount (count) 2010-02-04T22:17:10.149Z,1265321830.149 [CommandExec](IMPORTANT): PAR_Licor.maxBound (micromole_per_second_per_square_meter) 2010-02-04T22:17:10.149Z,1265321830.149 [CommandExec](IMPORTANT): PAR_Licor.maxValidPitch (degree) 2010-02-04T22:17:10.150Z,1265321830.150 [CommandExec](IMPORTANT): PAR_Licor.minBound (micromole_per_second_per_square_meter) 2010-02-04T22:17:10.150Z,1265321830.150 [CommandExec](IMPORTANT): PAR_Licor.minValidPitch (degree) 2010-02-04T22:17:10.150Z,1265321830.150 [CommandExec](IMPORTANT): PAR_Licor.multiplier (micromole_per_second_per_square_meter_per_microampere) 2010-02-04T22:17:10.151Z,1265321830.151 [CommandExec](IMPORTANT): PAR_Licor.parCal (none) 2010-02-04T22:17:10.188Z,1265321830.188 [CommandExec](IMPORTANT): PAR_Licor.serial (none) 2010-02-04T22:17:10.246Z,1265321830.246 [CommandExec](IMPORTANT): PAR_Licor.enableBroadcast (bool) 2010-02-04T22:17:10.247Z,1265321830.247 [CommandExec](IMPORTANT): PAR_Licor.component_voltage (volt) 2010-02-04T22:17:10.251Z,1265321830.251 [CommandExec](IMPORTANT): PAR_Licor.component_avgVoltage (volt) 2010-02-04T22:17:10.252Z,1265321830.252 [CommandExec](IMPORTANT): PAR_Licor.component_current (milliampere) 2010-02-04T22:17:10.252Z,1265321830.252 [CommandExec](IMPORTANT): PAR_Licor.component_avgCurrent (milliampere) 2010-02-04T22:17:10.252Z,1265321830.252 [CommandExec](IMPORTANT): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water (micromole_per_second_per_square_meter) 2010-02-04T22:17:10.253Z,1265321830.253 [CommandExec](IMPORTANT): PAR_Licor.adcCount (count) 2010-02-04T22:17:15.307Z,1265321835.307 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2010-02-04T22:17:15.307Z,1265321835.307 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2010-02-04T22:17:15.307Z,1265321835.307 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2010-02-04T22:17:15.343Z,1265321835.343 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2010-02-04T22:17:15.714Z,1265321835.714 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2010-02-04T22:17:15.714Z,1265321835.714 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2010-02-04T22:17:26.282Z,1265321846.282 [CommandExec](IMPORTANT): got command get PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 2010-02-04T22:17:26.283Z,1265321846.283 [CommandExec](IMPORTANT): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 10.076454 umol/s/m2 2010-02-04T22:17:38.460Z,1265321858.460 [CommandExec](IMPORTANT): got command quit 2010-02-04T22:17:39.464Z,1265321859.464 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:39.464Z,1265321859.464 [CommandExec](INFO): Uninitializing the command executive. 2010-02-04T22:17:39.464Z,1265321859.464 [CommandExec](INFO): Uninitializing the command scheduler. 2010-02-04T22:17:39.464Z,1265321859.464 [CommandExec ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:39.627Z,1265321859.627 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2010-02-04T22:17:39.627Z,1265321859.627 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2010-02-04T22:17:39.628Z,1265321859.628 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:39.628Z,1265321859.628 [NavChartDb](INFO): Join timeout helper Thread ID is 5405 2010-02-04T22:17:39.652Z,1265321859.652 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:39.652Z,1265321859.652 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:39.667Z,1265321859.667 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2010-02-04T22:17:39.667Z,1265321859.667 [DAT ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:39.668Z,1265321859.668 [DAT](INFO): Join timeout helper Thread ID is 5406 2010-02-04T22:17:39.688Z,1265321859.688 [DAT](INFO): Powering down 2010-02-04T22:17:39.764Z,1265321859.764 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:39.764Z,1265321859.764 [DAT](INFO): Powering down 2010-02-04T22:17:39.765Z,1265321859.765 [DAT ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:39.783Z,1265321859.783 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2010-02-04T22:17:39.783Z,1265321859.783 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:39.784Z,1265321859.784 [Radio_Surface](INFO): Join timeout helper Thread ID is 5409 2010-02-04T22:17:39.863Z,1265321859.863 [Radio_Surface](INFO): Powering down 2010-02-04T22:17:39.864Z,1265321859.864 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:39.865Z,1265321859.865 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:39.871Z,1265321859.871 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2010-02-04T22:17:39.871Z,1265321859.871 [Onboard ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:39.872Z,1265321859.872 [Onboard](INFO): Join timeout helper Thread ID is 5410 2010-02-04T22:17:40.136Z,1265321860.136 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2010-02-04T22:17:44.587Z,1265321864.587 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:44.588Z,1265321864.588 [Onboard ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:44.608Z,1265321864.608 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2010-02-04T22:17:44.608Z,1265321864.608 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:44.609Z,1265321864.609 [DataOverHttps](INFO): Join timeout helper Thread ID is 5411 2010-02-04T22:17:45.155Z,1265321865.155 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:45.156Z,1265321865.156 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.168Z,1265321865.168 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2010-02-04T22:17:45.168Z,1265321865.168 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.169Z,1265321865.169 [BackseatComponent](INFO): Join timeout helper Thread ID is 5412 2010-02-04T22:17:45.320Z,1265321865.320 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:45.320Z,1265321865.320 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.324Z,1265321865.324 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2010-02-04T22:17:45.324Z,1265321865.324 [logger ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.325Z,1265321865.325 [logger](INFO): Join timeout helper Thread ID is 5413 2010-02-04T22:17:45.339Z,1265321865.339 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:45.340Z,1265321865.340 [logger ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.344Z,1265321865.344 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2010-02-04T22:17:45.344Z,1265321865.344 [CommandLine ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.344Z,1265321865.344 [CommandLine](INFO): Join timeout helper Thread ID is 5414 2010-02-04T22:17:45.427Z,1265321865.427 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:45.428Z,1265321865.428 [CommandLine ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.444Z,1265321865.444 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2010-02-04T22:17:45.444Z,1265321865.444 [CommandExec ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.444Z,1265321865.444 [CommandExec](INFO): Join timeout helper Thread ID is 5415 2010-02-04T22:17:45.445Z,1265321865.445 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2010-02-04T22:17:45.446Z,1265321865.446 [controlThread ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.446Z,1265321865.446 [controlThread](INFO): Join timeout helper Thread ID is 5416 2010-02-04T22:17:45.563Z,1265321865.563 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2010-02-04T22:17:45.564Z,1265321865.564 [controlThread](DEBUG): Uninitializing ControlThread 2010-02-04T22:17:45.635Z,1265321865.635 [DVL_micro](INFO): Powering down 2010-02-04T22:17:45.636Z,1265321865.636 [NAL9602](INFO): Powering down 2010-02-04T22:17:45.638Z,1265321865.638 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2010-02-04T22:17:45.639Z,1265321865.639 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2010-02-04T22:17:45.639Z,1265321865.639 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2010-02-04T22:17:45.640Z,1265321865.640 [MissionManager](INFO): Uninitializing Mission Default 2010-02-04T22:17:45.640Z,1265321865.640 [Default] Stopped 2010-02-04T22:17:45.640Z,1265321865.640 [Default](DEBUG): Aggregate::uninitialize Default 2010-02-04T22:17:45.640Z,1265321865.640 [Default:B.GoToSurface] Stopped 2010-02-04T22:17:45.640Z,1265321865.640 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2010-02-04T22:17:45.640Z,1265321865.640 [Default:CheckIn] Stopped 2010-02-04T22:17:45.641Z,1265321865.641 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2010-02-04T22:17:45.641Z,1265321865.641 [Default:CheckIn:C.Wait] Stopped 2010-02-04T22:17:45.641Z,1265321865.641 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2010-02-04T22:17:45.644Z,1265321865.644 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2010-02-04T22:17:45.644Z,1265321865.644 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2010-02-04T22:17:45.644Z,1265321865.644 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2010-02-04T22:17:45.644Z,1265321865.644 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2010-02-04T22:17:45.645Z,1265321865.645 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2010-02-04T22:17:45.645Z,1265321865.645 [BuoyancyServo](INFO): Powering down 2010-02-04T22:17:45.659Z,1265321865.659 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2010-02-04T22:17:45.660Z,1265321865.660 [ElevatorServo](INFO): Powering down 2010-02-04T22:17:45.660Z,1265321865.660 [MassServo](DEBUG): Uninitialize Mass Servo. 2010-02-04T22:17:45.661Z,1265321865.661 [MassServo](INFO): Powering down 2010-02-04T22:17:45.661Z,1265321865.661 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2010-02-04T22:17:45.661Z,1265321865.661 [RudderServo](INFO): Powering down 2010-02-04T22:17:45.662Z,1265321865.662 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2010-02-04T22:17:45.662Z,1265321865.662 [ThrusterHE](INFO): Powering down 2010-02-04T22:17:45.663Z,1265321865.663 [SBIT](DEBUG): Uninitialize SBIT Component. 2010-02-04T22:17:45.664Z,1265321865.664 [IBIT](DEBUG): Uninitialize IBIT Component. 2010-02-04T22:17:45.664Z,1265321865.664 [CBIT](DEBUG): Uninitialize CBIT Component. 2010-02-04T22:17:45.664Z,1265321865.664 [CBIT](DEBUG): Powering off loads. 2010-02-04T22:17:45.675Z,1265321865.675 [CBIT](DEBUG): Disabling WDT. 2010-02-04T22:17:45.687Z,1265321865.687 [CBIT](DEBUG): Opening all GF detection circuits. 2010-02-04T22:17:45.688Z,1265321865.688 [controlThread ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.787Z,1265321865.787 [DAT ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.792Z,1265321865.792 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.794Z,1265321865.794 [Onboard ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.801Z,1265321865.801 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.846Z,1265321865.846 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.902Z,1265321865.902 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2010-02-04T22:17:45.961Z,1265321865.961 [logger ThreadHandler](INFO): Thread cancelled.