2016-08-26T23:10:22.301Z,1472253022.301 [Supervisor](DEBUG): Initializing supervisor.
2016-08-26T23:10:22.304Z,1472253022.304 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2016-08-26T23:10:22.305Z,1472253022.305 [SyncHandler](INFO): Protected caller Thread ID is 3006
2016-08-26T23:10:22.306Z,1472253022.306 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-08-26T23:10:22.307Z,1472253022.307 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2016-08-26T23:10:22.308Z,1472253022.308 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3007
2016-08-26T23:10:22.311Z,1472253022.311 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-08-26T23:10:22.323Z,1472253022.323 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-08-26T23:10:22.324Z,1472253022.324 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2016-08-26T23:10:22.325Z,1472253022.325 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3008
2016-08-26T23:10:22.325Z,1472253022.325 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-08-26T23:10:22.326Z,1472253022.326 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2016-08-26T23:10:22.327Z,1472253022.327 [logger ThreadHandler](INFO): Protected caller Thread ID is 3009
2016-08-26T23:10:22.329Z,1472253022.329 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-08-26T23:10:22.329Z,1472253022.329 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-08-26T23:10:22.332Z,1472253022.332 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-08-26T23:10:22.879Z,1472253022.879 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-08-26T23:10:22.881Z,1472253022.881 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-08-26T23:10:23.059Z,1472253023.059 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-08-26T23:10:23.059Z,1472253023.059 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-08-26T23:10:23.193Z,1472253023.193 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-08-26T23:10:23.194Z,1472253023.194 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-08-26T23:10:23.332Z,1472253023.332 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-08-26T23:10:23.334Z,1472253023.334 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-08-26T23:10:23.425Z,1472253023.425 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-08-26T23:10:23.626Z,1472253023.626 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-08-26T23:10:23.627Z,1472253023.627 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-08-26T23:10:23.718Z,1472253023.718 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-08-26T23:10:23.720Z,1472253023.720 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-08-26T23:10:24.010Z,1472253024.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-08-26T23:10:24.011Z,1472253024.011 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-08-26T23:10:24.372Z,1472253024.372 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-08-26T23:10:24.372Z,1472253024.372 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-08-26T23:10:24.695Z,1472253024.695 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-08-26T23:10:24.696Z,1472253024.696 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-08-26T23:10:25.263Z,1472253025.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-08-26T23:10:25.264Z,1472253025.264 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-08-26T23:10:25.483Z,1472253025.483 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-08-26T23:10:25.484Z,1472253025.484 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-08-26T23:10:25.594Z,1472253025.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-08-26T23:10:25.594Z,1472253025.594 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-08-26T23:10:26.054Z,1472253026.054 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-08-26T23:10:26.054Z,1472253026.054 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-08-26T23:10:26.171Z,1472253026.171 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-08-26T23:10:26.173Z,1472253026.173 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2016-08-26T23:10:26.174Z,1472253026.174 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2016-08-26T23:10:26.424Z,1472253026.424 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-08-26T23:10:26.425Z,1472253026.425 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2016-08-26T23:10:26.550Z,1472253026.550 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2016-08-26T23:10:26.655Z,1472253026.655 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2016-08-26T23:10:26.758Z,1472253026.758 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2016-08-26T23:10:26.854Z,1472253026.854 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2016-08-26T23:10:27.010Z,1472253027.010 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2016-08-26T23:10:27.177Z,1472253027.177 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2016-08-26T23:10:27.286Z,1472253027.286 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2016-08-26T23:10:27.374Z,1472253027.374 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2016-08-26T23:10:27.470Z,1472253027.470 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2016-08-26T23:10:27.670Z,1472253027.670 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2016-08-26T23:10:27.670Z,1472253027.670 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2016-08-26T23:10:27.677Z,1472253027.677 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-08-26T23:10:27.816Z,1472253027.816 [SBIT](DEBUG): Construct Startup Built In Test.
2016-08-26T23:10:27.848Z,1472253027.848 [SBIT] Loaded
2016-08-26T23:10:27.848Z,1472253027.848 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-08-26T23:10:27.849Z,1472253027.849 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-08-26T23:10:27.878Z,1472253027.878 [IBIT] Loaded
2016-08-26T23:10:27.878Z,1472253027.878 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-08-26T23:10:27.881Z,1472253027.881 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-08-26T23:10:28.023Z,1472253028.023 [CBIT] Loaded
2016-08-26T23:10:28.023Z,1472253028.023 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-08-26T23:10:28.024Z,1472253028.024 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-08-26T23:10:28.024Z,1472253028.024 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-08-26T23:10:28.083Z,1472253028.083 [VerticalControl](DEBUG): Construct VerticalControl.
2016-08-26T23:10:28.187Z,1472253028.187 [VerticalControl] Loaded
2016-08-26T23:10:28.187Z,1472253028.187 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-08-26T23:10:28.188Z,1472253028.188 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-08-26T23:10:28.252Z,1472253028.252 [HorizontalControl] Loaded
2016-08-26T23:10:28.252Z,1472253028.252 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-08-26T23:10:28.253Z,1472253028.253 [SpeedControl](DEBUG): Construct SpeedControl.
2016-08-26T23:10:28.259Z,1472253028.259 [SpeedControl] Loaded
2016-08-26T23:10:28.259Z,1472253028.259 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-08-26T23:10:28.259Z,1472253028.259 [LoopControl](DEBUG): Construct LoopControl.
2016-08-26T23:10:28.260Z,1472253028.260 [LoopControl] Loaded
2016-08-26T23:10:28.260Z,1472253028.260 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-08-26T23:10:28.261Z,1472253028.261 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-08-26T23:10:28.261Z,1472253028.261 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-08-26T23:10:28.296Z,1472253028.296 [DepthRateCalculator] Loaded
2016-08-26T23:10:28.296Z,1472253028.296 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-08-26T23:10:28.301Z,1472253028.301 [PitchRateCalculator] Loaded
2016-08-26T23:10:28.302Z,1472253028.302 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-08-26T23:10:28.313Z,1472253028.313 [SpeedCalculator] Loaded
2016-08-26T23:10:28.313Z,1472253028.313 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-08-26T23:10:28.330Z,1472253028.330 [TempGradientCalculator] Loaded
2016-08-26T23:10:28.330Z,1472253028.330 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-08-26T23:10:28.348Z,1472253028.348 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-08-26T23:10:28.348Z,1472253028.348 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-08-26T23:10:28.353Z,1472253028.353 [YawRateCalculator] Loaded
2016-08-26T23:10:28.353Z,1472253028.353 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-08-26T23:10:28.354Z,1472253028.354 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-08-26T23:10:28.354Z,1472253028.354 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-08-26T23:10:28.460Z,1472253028.460 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-08-26T23:10:28.460Z,1472253028.460 [StratificationFrontDetector](DEBUG): (re)initializing
2016-08-26T23:10:28.460Z,1472253028.460 [StratificationFrontDetector] Loaded
2016-08-26T23:10:28.460Z,1472253028.460 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-08-26T23:10:28.461Z,1472253028.461 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-08-26T23:10:28.461Z,1472253028.461 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-08-26T23:10:28.712Z,1472253028.712 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-08-26T23:10:28.713Z,1472253028.713 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-08-26T23:10:28.822Z,1472253028.822 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-08-26T23:10:28.822Z,1472253028.822 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-08-26T23:10:28.879Z,1472253028.879 [DeadReckonUsingSpeedCalculator] Loaded
2016-08-26T23:10:28.879Z,1472253028.879 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-08-26T23:10:28.896Z,1472253028.896 [NavChart] Loaded
2016-08-26T23:10:28.897Z,1472253028.897 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-08-26T23:10:28.901Z,1472253028.901 [UniversalFixResidualReporter] Loaded
2016-08-26T23:10:28.901Z,1472253028.901 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-08-26T23:10:28.902Z,1472253028.902 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-08-26T23:10:28.902Z,1472253028.902 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-08-26T23:10:28.914Z,1472253028.914 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-08-26T23:10:28.915Z,1472253028.915 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-08-26T23:10:29.129Z,1472253029.129 [Aanderaa_O2] Loaded
2016-08-26T23:10:29.130Z,1472253029.130 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2016-08-26T23:10:29.207Z,1472253029.207 [CTD_NeilBrown] Loaded
2016-08-26T23:10:29.208Z,1472253029.208 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2016-08-26T23:10:29.209Z,1472253029.209 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4059E4E0
2016-08-26T23:10:29.209Z,1472253029.209 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 3088
2016-08-26T23:10:29.225Z,1472253029.225 [PAR_Licor] Loaded
2016-08-26T23:10:29.225Z,1472253029.225 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2016-08-26T23:10:29.276Z,1472253029.276 [WetLabsBB2FL] Loaded
2016-08-26T23:10:29.276Z,1472253029.276 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2016-08-26T23:10:29.277Z,1472253029.277 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 405CE4E0
2016-08-26T23:10:29.278Z,1472253029.278 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3089
2016-08-26T23:10:29.278Z,1472253029.278 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-08-26T23:10:29.279Z,1472253029.279 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-08-26T23:10:29.778Z,1472253029.778 [AcousticModem_Benthos_ATM900] Loaded
2016-08-26T23:10:29.778Z,1472253029.778 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2016-08-26T23:10:29.853Z,1472253029.853 [DataOverHttps] Loaded
2016-08-26T23:10:29.853Z,1472253029.853 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-08-26T23:10:29.867Z,1472253029.867 [Depth_Keller] Loaded
2016-08-26T23:10:29.867Z,1472253029.867 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-08-26T23:10:29.872Z,1472253029.872 [DropWeight] Loaded
2016-08-26T23:10:29.873Z,1472253029.873 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2016-08-26T23:10:29.967Z,1472253029.967 [NAL9602] Loaded
2016-08-26T23:10:29.968Z,1472253029.968 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-08-26T23:10:30.011Z,1472253030.011 [Onboard] Loaded
2016-08-26T23:10:30.011Z,1472253030.011 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-08-26T23:10:30.018Z,1472253030.018 [Radio_Surface] Loaded
2016-08-26T23:10:30.019Z,1472253030.019 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-08-26T23:10:30.020Z,1472253030.020 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409E74E0
2016-08-26T23:10:30.020Z,1472253030.020 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3090
2016-08-26T23:10:30.070Z,1472253030.070 [PNI_TCM] Loaded
2016-08-26T23:10:30.070Z,1472253030.070 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2016-08-26T23:10:31.955Z,1472253031.955 [BPC1] Loaded
2016-08-26T23:10:31.955Z,1472253031.955 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-08-26T23:10:31.955Z,1472253031.955 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-08-26T23:10:31.956Z,1472253031.956 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-08-26T23:10:32.071Z,1472253032.071 [BuoyancyServo] Loaded
2016-08-26T23:10:32.071Z,1472253032.071 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-08-26T23:10:32.084Z,1472253032.084 [ElevatorServo] Loaded
2016-08-26T23:10:32.084Z,1472253032.084 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-08-26T23:10:32.096Z,1472253032.096 [MassServo] Loaded
2016-08-26T23:10:32.097Z,1472253032.097 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-08-26T23:10:32.109Z,1472253032.109 [RudderServo] Loaded
2016-08-26T23:10:32.109Z,1472253032.109 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-08-26T23:10:32.120Z,1472253032.120 [ThrusterServo] Loaded
2016-08-26T23:10:32.121Z,1472253032.121 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-08-26T23:10:32.121Z,1472253032.121 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-08-26T23:10:32.122Z,1472253032.122 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-08-26T23:10:32.244Z,1472253032.244 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-08-26T23:10:32.245Z,1472253032.245 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-08-26T23:10:32.280Z,1472253032.280 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-08-26T23:10:32.284Z,1472253032.284 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-08-26T23:10:32.285Z,1472253032.285 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-08-26T23:10:32.292Z,1472253032.292 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-08-26T23:10:32.293Z,1472253032.293 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A954E0
2016-08-26T23:10:32.293Z,1472253032.293 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3091
2016-08-26T23:10:32.298Z,1472253032.298 [Supervisor](INFO): Main Thread ID is 1982
2016-08-26T23:10:32.298Z,1472253032.298 [Supervisor](DEBUG): Running supervisor.
2016-08-26T23:10:32.299Z,1472253032.299 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3092
2016-08-26T23:10:32.302Z,1472253032.302 [controlThread ThreadHandler](INFO): Handler Thread ID is 3093
2016-08-26T23:10:32.302Z,1472253032.302 [controlThread](DEBUG): Initializing ControlThread
2016-08-26T23:10:32.303Z,1472253032.303 [SBIT](INFO): Initialize SBIT Component.
2016-08-26T23:10:32.304Z,1472253032.304 [SBIT](IMPORTANT): git: 2015-11-13-11-g036008f
2016-08-26T23:10:32.304Z,1472253032.304 [SBIT](INFO): git hash: 036008fb27dd1443c9c6898c567944386f491f02
2016-08-26T23:10:32.304Z,1472253032.304 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2016-08-26T23:10:32.304Z,1472253032.304 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2016-08-26T23:10:32.305Z,1472253032.305 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2016-08-26T23:10:32.306Z,1472253032.306 [IBIT](INFO): Initialize IBIT Component.
2016-08-26T23:10:32.307Z,1472253032.307 [CBIT](DEBUG): Initialize CBIT Component.
2016-08-26T23:10:32.307Z,1472253032.307 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2016-08-26T23:10:32.308Z,1472253032.308 [logger ThreadHandler](INFO): Handler Thread ID is 3094
2016-08-26T23:10:32.327Z,1472253032.327 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 3095
2016-08-26T23:10:32.328Z,1472253032.328 [CTD_NeilBrown](INFO): Powering down
2016-08-26T23:10:32.331Z,1472253032.331 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-08-26T23:10:32.333Z,1472253032.333 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-08-26T23:10:32.334Z,1472253032.334 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-08-26T23:10:32.334Z,1472253032.334 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-08-26T23:10:32.335Z,1472253032.335 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-08-26T23:10:32.335Z,1472253032.335 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-08-26T23:10:32.335Z,1472253032.335 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-08-26T23:10:32.336Z,1472253032.336 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-08-26T23:10:32.336Z,1472253032.336 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-08-26T23:10:32.337Z,1472253032.337 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-08-26T23:10:32.337Z,1472253032.337 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-08-26T23:10:32.338Z,1472253032.338 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:10:32.338Z,1472253032.338 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:10:32.343Z,1472253032.343 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-08-26T23:10:32.347Z,1472253032.347 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:10:32.347Z,1472253032.347 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:10:32.348Z,1472253032.348 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-08-26T23:10:32.348Z,1472253032.348 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-08-26T23:10:32.373Z,1472253032.373 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2016-08-26T23:10:32.373Z,1472253032.373 [DropWeight] Hardware Fault, FailCount= 1
2016-08-26T23:10:32.373Z,1472253032.373 [DropWeight](ERROR): Hardware Fault
2016-08-26T23:10:32.380Z,1472253032.380 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3096
2016-08-26T23:10:32.381Z,1472253032.381 [WetLabsBB2FL](INFO): Powering down
2016-08-26T23:10:32.387Z,1472253032.387 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-08-26T23:10:32.408Z,1472253032.408 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3097
2016-08-26T23:10:32.414Z,1472253032.414 [Radio_Surface](INFO): Powering up
2016-08-26T23:10:32.424Z,1472253032.424 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3098
2016-08-26T23:10:32.429Z,1472253032.429 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-08-26T23:10:32.436Z,1472253032.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-08-26T23:10:32.436Z,1472253032.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-08-26T23:10:32.436Z,1472253032.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-08-26T23:10:32.436Z,1472253032.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-08-26T23:10:32.437Z,1472253032.437 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-08-26T23:10:32.437Z,1472253032.437 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-08-26T23:10:32.437Z,1472253032.437 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-08-26T23:10:32.437Z,1472253032.437 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-08-26T23:10:32.441Z,1472253032.441 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-08-26T23:10:32.498Z,1472253032.498 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2016-08-26T23:10:32.499Z,1472253032.499 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-08-26T23:10:32.562Z,1472253032.562 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-08-26T23:10:32.579Z,1472253032.579 [Default:A.Wait](DEBUG): Construct Wait.
2016-08-26T23:10:32.581Z,1472253032.581 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2016-08-26T23:10:32.611Z,1472253032.611 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-08-26T23:10:32.614Z,1472253032.614 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-08-26T23:10:32.635Z,1472253032.635 [Default:E.Execute](DEBUG): Construct Execute.
2016-08-26T23:10:32.639Z,1472253032.639 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Guidance="Tethys/Guidance"
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Sequence/>
	<Description>Wait a moment to see if the scheduler starts a new mission before starting to actually run Default.
        </Description>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Sequence/>
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Sequence/>
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn 300</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2016-08-26T23:10:32.651Z,1472253032.651 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2016-08-26T23:10:32.732Z,1472253032.732 [AcousticModem_Benthos_ATM900](INFO): Powering up
2016-08-26T23:10:32.732Z,1472253032.732 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2016-08-26T23:10:33.157Z,1472253033.157 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:33.181Z,1472253033.181 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:33.291Z,1472253033.291 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-08-26T23:10:33.297Z,1472253033.297 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-08-26T23:10:33.319Z,1472253033.319 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-08-26T23:10:33.325Z,1472253033.325 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-08-26T23:10:33.337Z,1472253033.337 [MassServo](DEBUG): Initializing EZServoServo.
2016-08-26T23:10:33.345Z,1472253033.345 [MassServo](DEBUG): Initializing MassServo.
2016-08-26T23:10:33.374Z,1472253033.374 [RudderServo](DEBUG): Initializing EZServoServo.
2016-08-26T23:10:33.377Z,1472253033.377 [RudderServo](DEBUG): Initializing RudderServo.
2016-08-26T23:10:33.398Z,1472253033.398 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-08-26T23:10:33.409Z,1472253033.409 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-08-26T23:10:33.453Z,1472253033.453 [CommandLine](FAULT): Scheduling is paused
2016-08-26T23:10:33.455Z,1472253033.455 [CBIT](ERROR): Hardware Fault in component: DropWeight
2016-08-26T23:10:33.456Z,1472253033.456 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2016-08-26T23:10:33.685Z,1472253033.685 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:33.686Z,1472253033.686 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:34.042Z,1472253034.042 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:34.043Z,1472253034.043 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:34.566Z,1472253034.566 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:34.575Z,1472253034.575 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:34.912Z,1472253034.912 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:34.913Z,1472253034.913 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:35.249Z,1472253035.249 [NAL9602](INFO): Powering up NAL9602
2016-08-26T23:10:35.291Z,1472253035.291 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:35.292Z,1472253035.292 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:35.689Z,1472253035.689 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:35.690Z,1472253035.690 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:36.124Z,1472253036.124 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:36.126Z,1472253036.126 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-08-26T23:10:40.561Z,1472253040.561 [AcousticModem_Benthos_ATM900](DEBUG): 
2016-08-26T23:10:41.776Z,1472253041.776 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2016-08-26T23:10:41.776Z,1472253041.776 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2016-08-26T23:10:41.777Z,1472253041.777 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2016-08-26T23:10:42.164Z,1472253042.164 [AcousticModem_Benthos_ATM900](DEBUG): Aug 26 2016 23:01:13 
2016-08-26T23:10:42.959Z,1472253042.959 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:10:42.959Z,1472253042.959 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-08-26T23:10:42.959Z,1472253042.959 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:10:42.964Z,1472253042.964 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2016-08-26T23:10:43.088Z,1472253043.088 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:10:43.476Z,1472253043.476 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:10:43.529Z,1472253043.529 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2016-08-26T23:10:43.530Z,1472253043.530 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2016-08-26T23:10:43.530Z,1472253043.530 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2016-08-26T23:10:43.762Z,1472253043.762 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2016-08-26T23:10:44.162Z,1472253044.162 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2016-08-26T23:10:44.163Z,1472253044.163 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2016-08-26T23:10:44.349Z,1472253044.349 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:10:44.349Z,1472253044.349 [Aanderaa_O2] No Fault, FailCount= 1
2016-08-26T23:10:44.576Z,1472253044.576 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2016-08-26T23:10:46.166Z,1472253046.166 [NAL9602](INFO): NAL9602 initialized
2016-08-26T23:10:54.957Z,1472253054.957 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:10:54.958Z,1472253054.958 [Aanderaa_O2] Communications Fault, FailCount= 2
2016-08-26T23:10:54.958Z,1472253054.958 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:10:55.162Z,1472253055.162 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:10:55.475Z,1472253055.475 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:10:56.267Z,1472253056.267 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:10:56.267Z,1472253056.267 [Aanderaa_O2] No Fault, FailCount= 2
2016-08-26T23:11:06.956Z,1472253066.956 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:11:06.956Z,1472253066.956 [Aanderaa_O2] Communications Fault, FailCount= 3
2016-08-26T23:11:06.956Z,1472253066.956 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:11:07.104Z,1472253067.104 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:11:07.104Z,1472253067.104 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2016-08-26T23:11:07.477Z,1472253067.477 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:11:09.830Z,1472253069.830 [CommandLine](IMPORTANT): got command show best platform_pitch_angle
2016-08-26T23:11:09.830Z,1472253069.830 [CommandLine](IMPORTANT): platform_pitch_angle best is PNI_TCM.platform_pitch_angle
2016-08-26T23:11:15.375Z,1472253075.375 [CommandLine](IMPORTANT): got command get platform_pitch_angle degree
2016-08-26T23:11:15.375Z,1472253075.375 [CommandLine](IMPORTANT): platform_pitch_angle 85.965335 arcdeg
2016-08-26T23:11:35.831Z,1472253095.831 [SBIT](IMPORTANT): Beginning Startup BIT
2016-08-26T23:11:35.833Z,1472253095.833 [CBIT](IMPORTANT): Beginning GF scan
2016-08-26T23:12:02.556Z,1472253122.556 [CBIT](IMPORTANT): No ground fault detected
2016-08-26T23:12:08.870Z,1472253128.870 [BPC1](ERROR): Failed to parse message.
2016-08-26T23:12:08.870Z,1472253128.870 [BPC1](ERROR): Failed to parse bank B battery data
2016-08-26T23:12:08.870Z,1472253128.870 [BPC1] Data Fault, FailCount= 1
2016-08-26T23:12:08.870Z,1472253128.870 [BPC1](ERROR): Data Fault
2016-08-26T23:12:08.922Z,1472253128.922 [CBIT](ERROR): Data Fault in component: BPC1
2016-08-26T23:12:10.081Z,1472253130.081 [CBIT](INFO): Clearing failed state for component BPC1
2016-08-26T23:12:10.081Z,1472253130.081 [BPC1] No Fault, FailCount= 1
2016-08-26T23:12:26.596Z,1472253146.596 [BPC1](ERROR): Failed to receive battery data
2016-08-26T23:12:26.596Z,1472253146.596 [BPC1] Communications Fault, FailCount= 2
2016-08-26T23:12:26.596Z,1472253146.596 [BPC1](ERROR): Communications Fault
2016-08-26T23:12:26.644Z,1472253146.644 [CBIT](ERROR): Communications Fault in component: BPC1
2016-08-26T23:12:27.840Z,1472253147.840 [CBIT](INFO): Clearing failed state for component BPC1
2016-08-26T23:12:27.840Z,1472253147.840 [BPC1] No Fault, FailCount= 2
2016-08-26T23:12:29.831Z,1472253149.831 [SBIT](IMPORTANT): SBIT PASSED
2016-08-26T23:12:30.227Z,1472253150.227 [MissionManager](IMPORTANT): Started mission Startup
2016-08-26T23:12:30.227Z,1472253150.227 [Startup] Running Loop=1
2016-08-26T23:12:30.227Z,1472253150.227 [Startup](DEBUG): Aggregate::initialize Startup
2016-08-26T23:12:30.227Z,1472253150.227 [Startup:A.GoToSurface] Running Loop=1
2016-08-26T23:12:30.227Z,1472253150.227 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-08-26T23:12:30.228Z,1472253150.228 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-08-26T23:12:30.228Z,1472253150.228 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-08-26T23:12:30.229Z,1472253150.229 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-08-26T23:12:30.229Z,1472253150.229 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-08-26T23:12:30.230Z,1472253150.230 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-08-26T23:12:30.235Z,1472253150.235 [Startup:StartupSatComms] Running Loop=1
2016-08-26T23:12:30.236Z,1472253150.236 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2016-08-26T23:12:30.236Z,1472253150.236 [Startup:StartupSatComms:A] Running Loop=1
2016-08-26T23:12:30.626Z,1472253150.626 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2016-08-26T23:12:37.466Z,1472253157.466 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:12:37.467Z,1472253157.467 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:12:37.468Z,1472253157.468 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:12:37.471Z,1472253157.471 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004606
2016-08-26T23:13:30.306Z,1472253210.306 [Startup:StartupSatComms:A](INFO): Timed out from 2016-08-26T23:12:30.2Z
2016-08-26T23:13:30.306Z,1472253210.306 [Startup:StartupSatComms:A] Stopped
2016-08-26T23:13:30.306Z,1472253210.306 [Startup:StartupSatComms:B] Running Loop=1
2016-08-26T23:13:30.705Z,1472253210.705 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-08-26T23:13:35.037Z,1472253215.037 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:13:35.037Z,1472253215.037 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2016-08-26T23:13:35.037Z,1472253215.037 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-08-26T23:13:35.039Z,1472253215.039 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:13:35.039Z,1472253215.039 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2016-08-26T23:13:35.039Z,1472253215.039 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-08-26T23:13:35.051Z,1472253215.051 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-08-26T23:13:35.051Z,1472253215.051 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-08-26T23:13:35.113Z,1472253215.113 [DataOverHttps](INFO): Sending 629 bytes from file Logs/20160826T181404/Courier0036.lzma
2016-08-26T23:13:35.210Z,1472253215.210 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-08-26T23:13:35.210Z,1472253215.210 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2016-08-26T23:13:35.215Z,1472253215.215 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-08-26T23:13:35.215Z,1472253215.215 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2016-08-26T23:13:35.512Z,1472253215.512 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-08-26T23:13:35.512Z,1472253215.512 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:13:35.513Z,1472253215.513 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:13:35.513Z,1472253215.513 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-08-26T23:13:35.514Z,1472253215.514 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:13:35.514Z,1472253215.514 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:13:35.862Z,1472253215.862 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4424872&filename=Logs%2F20160826T181404%2FCourier0036.lzma, 1
2016-08-26T23:13:35.862Z,1472253215.862 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4424872&filename=Logs%2F20160826T181404%2FCourier0036.lzma, key = 6, value = makai
2016-08-26T23:13:35.863Z,1472253215.863 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4424872&filename=Logs%2F20160826T181404%2FCourier0036.lzma, key = 0, value = true
2016-08-26T23:13:35.864Z,1472253215.864 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T181404%2FCourier0036.lzma, key = 4, value = 4424872
2016-08-26T23:13:35.864Z,1472253215.864 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T181404%2FCourier0036.lzma
2016-08-26T23:13:35.865Z,1472253215.865 [DataOverHttps](INFO): Moved sent file to Logs/20160826T181404/Courier0036.lzma.bak
2016-08-26T23:13:35.865Z,1472253215.865 [DataOverHttps](INFO): SBD MOMSN=4424872
2016-08-26T23:13:35.929Z,1472253215.929 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.9 s old, using for 20.0 s.
2016-08-26T23:13:36.855Z,1472253216.855 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.8 s old, using for 20.0 s.
2016-08-26T23:13:36.967Z,1472253216.967 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.9 s old, using for 20.0 s.
2016-08-26T23:13:36.980Z,1472253216.980 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:13:36.980Z,1472253216.980 [Aanderaa_O2] No Fault, FailCount= 3
2016-08-26T23:13:40.228Z,1472253220.228 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2016-08-26T23:13:40.360Z,1472253220.360 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.3 s old, using for 20.0 s.
2016-08-26T23:13:40.713Z,1472253220.713 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.7 s old, using for 20.0 s.
2016-08-26T23:13:41.066Z,1472253221.066 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:13:41.066Z,1472253221.066 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:13:41.067Z,1472253221.067 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:13:41.150Z,1472253221.150 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.1 s old, using for 20.0 s.
2016-08-26T23:13:41.507Z,1472253221.507 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.5 s old, using for 20.0 s.
2016-08-26T23:13:41.948Z,1472253221.948 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.9 s old, using for 20.0 s.
2016-08-26T23:13:45.132Z,1472253225.132 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.1 s old, using for 20.0 s.
2016-08-26T23:13:45.224Z,1472253225.224 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20160826T231022/Courier0000.lzma
2016-08-26T23:13:45.309Z,1472253225.309 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.3 s old, using for 20.0 s.
2016-08-26T23:13:45.673Z,1472253225.673 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.6 s old, using for 20.0 s.
2016-08-26T23:13:45.982Z,1472253225.982 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4424905&filename=Logs%2F20160826T231022%2FCourier0000.lzma, 1
2016-08-26T23:13:45.982Z,1472253225.982 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4424905&filename=Logs%2F20160826T231022%2FCourier0000.lzma, key = 6, value = makai
2016-08-26T23:13:45.983Z,1472253225.983 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4424905&filename=Logs%2F20160826T231022%2FCourier0000.lzma, key = 0, value = true
2016-08-26T23:13:45.983Z,1472253225.983 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T231022%2FCourier0000.lzma, key = 4, value = 4424905
2016-08-26T23:13:45.984Z,1472253225.984 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T231022%2FCourier0000.lzma
2016-08-26T23:13:45.984Z,1472253225.984 [DataOverHttps](INFO): Moved sent file to Logs/20160826T231022/Courier0000.lzma.bak
2016-08-26T23:13:45.985Z,1472253225.985 [DataOverHttps](INFO): SBD MOMSN=4424905
2016-08-26T23:13:46.082Z,1472253226.082 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.0 s old, using for 20.0 s.
2016-08-26T23:13:48.867Z,1472253228.867 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.8 s old, using for 20.0 s.
2016-08-26T23:13:48.938Z,1472253228.938 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:13:48.939Z,1472253228.939 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-08-26T23:13:48.939Z,1472253228.939 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:13:49.070Z,1472253229.070 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2016-08-26T23:13:49.100Z,1472253229.100 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:13:49.453Z,1472253229.453 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:13:57.330Z,1472253237.330 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:13:57.330Z,1472253237.330 [Aanderaa_O2] No Fault, FailCount= 1
2016-08-26T23:13:57.556Z,1472253237.556 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:13:57.556Z,1472253237.556 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:13:57.557Z,1472253237.557 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:14:03.838Z,1472253243.838 [DataOverHttps](INFO): Sending 567 bytes from file Logs/20160826T181404/Express0033.lzma
2016-08-26T23:14:04.598Z,1472253244.598 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4424911&filename=Logs%2F20160826T181404%2FExpress0033.lzma, 1
2016-08-26T23:14:04.598Z,1472253244.598 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4424911&filename=Logs%2F20160826T181404%2FExpress0033.lzma, key = 6, value = makai
2016-08-26T23:14:04.599Z,1472253244.599 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4424911&filename=Logs%2F20160826T181404%2FExpress0033.lzma, key = 0, value = true
2016-08-26T23:14:04.599Z,1472253244.599 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T181404%2FExpress0033.lzma, key = 4, value = 4424911
2016-08-26T23:14:04.600Z,1472253244.600 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T181404%2FExpress0033.lzma
2016-08-26T23:14:04.601Z,1472253244.601 [DataOverHttps](INFO): Moved sent file to Logs/20160826T181404/Express0033.lzma.bak
2016-08-26T23:14:04.601Z,1472253244.601 [DataOverHttps](INFO): SBD MOMSN=4424911
2016-08-26T23:14:10.193Z,1472253250.193 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:14:10.193Z,1472253250.193 [Aanderaa_O2] Communications Fault, FailCount= 2
2016-08-26T23:14:10.193Z,1472253250.193 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:14:10.340Z,1472253250.340 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:14:10.718Z,1472253250.718 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:14:11.000Z,1472253251.000 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:14:11.001Z,1472253251.001 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:14:11.001Z,1472253251.001 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:14:11.645Z,1472253251.645 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:14:11.645Z,1472253251.645 [Aanderaa_O2] No Fault, FailCount= 2
2016-08-26T23:14:19.736Z,1472253259.736 [DataOverHttps](INFO): Sending 1534 bytes from file Logs/20160826T181404/Express0037.lzma
2016-08-26T23:14:20.519Z,1472253260.519 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4424963&filename=Logs%2F20160826T181404%2FExpress0037.lzma, 1
2016-08-26T23:14:20.520Z,1472253260.520 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4424963&filename=Logs%2F20160826T181404%2FExpress0037.lzma, key = 6, value = makai
2016-08-26T23:14:20.520Z,1472253260.520 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4424963&filename=Logs%2F20160826T181404%2FExpress0037.lzma, key = 0, value = true
2016-08-26T23:14:20.521Z,1472253260.521 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T181404%2FExpress0037.lzma, key = 4, value = 4424963
2016-08-26T23:14:20.521Z,1472253260.521 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T181404%2FExpress0037.lzma
2016-08-26T23:14:20.522Z,1472253260.522 [DataOverHttps](INFO): Moved sent file to Logs/20160826T181404/Express0037.lzma.bak
2016-08-26T23:14:20.522Z,1472253260.522 [DataOverHttps](INFO): SBD MOMSN=4424963
2016-08-26T23:14:24.174Z,1472253264.174 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:14:24.174Z,1472253264.174 [Aanderaa_O2] Communications Fault, FailCount= 3
2016-08-26T23:14:24.183Z,1472253264.183 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:14:24.313Z,1472253264.313 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:14:24.314Z,1472253264.314 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2016-08-26T23:14:24.692Z,1472253264.692 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:14:32.140Z,1472253272.140 [Startup:StartupSatComms:B](INFO): Timed out from 2016-08-26T23:13:30.3Z
2016-08-26T23:14:32.140Z,1472253272.140 [Startup:StartupSatComms:B] Stopped
2016-08-26T23:14:32.140Z,1472253272.140 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2016-08-26T23:14:32.140Z,1472253272.140 [Startup:StartupSatComms] Stopped
2016-08-26T23:14:32.140Z,1472253272.140 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2016-08-26T23:14:32.141Z,1472253272.141 [Startup](INFO): Completed Startup
2016-08-26T23:14:32.141Z,1472253272.141 [Startup] Stopped
2016-08-26T23:14:32.141Z,1472253272.141 [Startup](DEBUG): Aggregate::uninitialize Startup
2016-08-26T23:14:32.142Z,1472253272.142 [Startup:A.GoToSurface] Stopped
2016-08-26T23:14:32.142Z,1472253272.142 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2016-08-26T23:14:32.308Z,1472253272.308 [MissionManager](IMPORTANT): Started mission Default
2016-08-26T23:14:32.309Z,1472253272.309 [Default] Running Loop=1
2016-08-26T23:14:32.309Z,1472253272.309 [Default](DEBUG): Aggregate::initialize Default
2016-08-26T23:14:32.309Z,1472253272.309 [Default:B.GoToSurface] Running Loop=1
2016-08-26T23:14:32.309Z,1472253272.309 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2016-08-26T23:14:32.309Z,1472253272.309 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2016-08-26T23:14:32.310Z,1472253272.310 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2016-08-26T23:14:32.310Z,1472253272.310 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2016-08-26T23:14:32.310Z,1472253272.310 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2016-08-26T23:14:32.311Z,1472253272.311 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2016-08-26T23:14:32.315Z,1472253272.315 [Default:A.Wait] Running Loop=1
2016-08-26T23:14:32.315Z,1472253272.315 [Default:A.Wait](DEBUG): Initialize Wait Component.
2016-08-26T23:14:33.031Z,1472253273.031 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:14:33.031Z,1472253273.031 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:14:33.032Z,1472253273.032 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:14:41.808Z,1472253281.808 [DataOverHttps](INFO): Sending 645 bytes from file Logs/20160826T231022/Express0001.lzma
2016-08-26T23:14:42.566Z,1472253282.566 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4425168&filename=Logs%2F20160826T231022%2FExpress0001.lzma, 1
2016-08-26T23:14:42.566Z,1472253282.566 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4425168&filename=Logs%2F20160826T231022%2FExpress0001.lzma, key = 6, value = makai
2016-08-26T23:14:42.567Z,1472253282.567 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4425168&filename=Logs%2F20160826T231022%2FExpress0001.lzma, key = 0, value = true
2016-08-26T23:14:42.567Z,1472253282.567 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T231022%2FExpress0001.lzma, key = 4, value = 4425168
2016-08-26T23:14:42.568Z,1472253282.568 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T231022%2FExpress0001.lzma
2016-08-26T23:14:42.568Z,1472253282.568 [DataOverHttps](INFO): Moved sent file to Logs/20160826T231022/Express0001.lzma.bak
2016-08-26T23:14:42.569Z,1472253282.569 [DataOverHttps](INFO): SBD MOMSN=4425168
2016-08-26T23:14:45.453Z,1472253285.453 [Default:A.Wait](INFO): Done Waiting.
2016-08-26T23:14:45.454Z,1472253285.454 [Default:A.Wait] Stopped
2016-08-26T23:14:45.454Z,1472253285.454 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2016-08-26T23:14:45.897Z,1472253285.897 [Default:CheckIn] Running Loop=1
2016-08-26T23:14:45.897Z,1472253285.897 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-08-26T23:14:45.897Z,1472253285.897 [Default:CheckIn:Read_GPS] Running Loop=1
2016-08-26T23:14:46.301Z,1472253286.301 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2016-08-26T23:15:42.883Z,1472253342.883 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:15:42.883Z,1472253342.883 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:15:42.884Z,1472253342.884 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:15:49.685Z,1472253349.685 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2016-08-26T23:16:09.313Z,1472253369.313 [BPC1](ERROR): Failed to parse message.
2016-08-26T23:16:09.332Z,1472253369.332 [BPC1](ERROR): Failed to parse bank A battery data
2016-08-26T23:16:09.332Z,1472253369.332 [BPC1] Data Fault, FailCount= 1
2016-08-26T23:16:09.332Z,1472253369.332 [BPC1](ERROR): Data Fault
2016-08-26T23:16:09.352Z,1472253369.352 [CBIT](ERROR): Data Fault in component: BPC1
2016-08-26T23:16:10.548Z,1472253370.548 [CBIT](INFO): Clearing failed state for component BPC1
2016-08-26T23:16:10.548Z,1472253370.548 [BPC1] No Fault, FailCount= 1
2016-08-26T23:16:21.324Z,1472253381.324 [BPC1](ERROR): Failed to parse message.
2016-08-26T23:16:21.324Z,1472253381.324 [BPC1](ERROR): Failed to parse bank A battery data
2016-08-26T23:16:21.347Z,1472253381.347 [BPC1] Data Fault, FailCount= 2
2016-08-26T23:16:21.347Z,1472253381.347 [BPC1](ERROR): Data Fault
2016-08-26T23:16:21.368Z,1472253381.368 [CBIT](ERROR): Data Fault in component: BPC1
2016-08-26T23:16:22.554Z,1472253382.554 [CBIT](INFO): Clearing failed state for component BPC1
2016-08-26T23:16:22.554Z,1472253382.554 [BPC1] No Fault, FailCount= 2
2016-08-26T23:16:37.773Z,1472253397.773 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:16:37.773Z,1472253397.773 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2016-08-26T23:16:37.773Z,1472253397.773 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-08-26T23:16:37.775Z,1472253397.775 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:16:37.775Z,1472253397.775 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2016-08-26T23:16:37.775Z,1472253397.775 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-08-26T23:16:37.799Z,1472253397.799 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-08-26T23:16:37.799Z,1472253397.799 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-08-26T23:16:37.891Z,1472253397.891 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-08-26T23:16:37.891Z,1472253397.891 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2016-08-26T23:16:37.891Z,1472253397.891 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-08-26T23:16:37.891Z,1472253397.891 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2016-08-26T23:16:38.264Z,1472253398.264 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-08-26T23:16:38.264Z,1472253398.264 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:16:38.265Z,1472253398.265 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:16:38.265Z,1472253398.265 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-08-26T23:16:38.265Z,1472253398.265 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:16:38.266Z,1472253398.266 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:16:38.609Z,1472253398.609 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:16:38.610Z,1472253398.610 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:16:38.610Z,1472253398.610 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:16:38.689Z,1472253398.689 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.9 s old, using for 20.0 s.
2016-08-26T23:16:39.070Z,1472253399.070 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.3 s old, using for 20.0 s.
2016-08-26T23:16:39.482Z,1472253399.482 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.7 s old, using for 20.0 s.
2016-08-26T23:16:39.874Z,1472253399.874 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.1 s old, using for 20.0 s.
2016-08-26T23:16:40.243Z,1472253400.243 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.5 s old, using for 20.0 s.
2016-08-26T23:16:40.674Z,1472253400.674 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.9 s old, using for 20.0 s.
2016-08-26T23:16:41.075Z,1472253401.075 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.3 s old, using for 20.0 s.
2016-08-26T23:16:41.473Z,1472253401.473 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.7 s old, using for 20.0 s.
2016-08-26T23:16:41.842Z,1472253401.842 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.1 s old, using for 20.0 s.
2016-08-26T23:16:42.246Z,1472253402.246 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.5 s old, using for 20.0 s.
2016-08-26T23:16:42.636Z,1472253402.636 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.9 s old, using for 20.0 s.
2016-08-26T23:16:43.048Z,1472253403.048 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.3 s old, using for 20.0 s.
2016-08-26T23:16:43.437Z,1472253403.437 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.7 s old, using for 20.0 s.
2016-08-26T23:16:43.857Z,1472253403.857 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.1 s old, using for 20.0 s.
2016-08-26T23:16:44.257Z,1472253404.257 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.5 s old, using for 20.0 s.
2016-08-26T23:16:44.656Z,1472253404.656 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.9 s old, using for 20.0 s.
2016-08-26T23:16:45.040Z,1472253405.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.3 s old, using for 20.0 s.
2016-08-26T23:16:45.448Z,1472253405.448 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.7 s old, using for 20.0 s.
2016-08-26T23:16:45.845Z,1472253405.845 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.1 s old, using for 20.0 s.
2016-08-26T23:16:46.241Z,1472253406.241 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.5 s old, using for 20.0 s.
2016-08-26T23:16:46.654Z,1472253406.654 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.9 s old, using for 20.0 s.
2016-08-26T23:16:47.057Z,1472253407.057 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.3 s old, using for 20.0 s.
2016-08-26T23:16:47.459Z,1472253407.459 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.7 s old, using for 20.0 s.
2016-08-26T23:16:47.843Z,1472253407.843 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.1 s old, using for 20.0 s.
2016-08-26T23:16:48.248Z,1472253408.248 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.5 s old, using for 20.0 s.
2016-08-26T23:16:48.640Z,1472253408.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.9 s old, using for 20.0 s.
2016-08-26T23:16:49.049Z,1472253409.049 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.3 s old, using for 20.0 s.
2016-08-26T23:16:49.442Z,1472253409.442 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.7 s old, using for 20.0 s.
2016-08-26T23:16:49.854Z,1472253409.854 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.1 s old, using for 20.0 s.
2016-08-26T23:16:50.296Z,1472253410.296 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.5 s old, using for 20.0 s.
2016-08-26T23:16:50.659Z,1472253410.659 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.9 s old, using for 20.0 s.
2016-08-26T23:16:51.040Z,1472253411.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.3 s old, using for 20.0 s.
2016-08-26T23:16:51.441Z,1472253411.441 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.7 s old, using for 20.0 s.
2016-08-26T23:16:51.862Z,1472253411.862 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.1 s old, using for 20.0 s.
2016-08-26T23:16:52.243Z,1472253412.243 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.5 s old, using for 20.0 s.
2016-08-26T23:16:52.659Z,1472253412.659 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.9 s old, using for 20.0 s.
2016-08-26T23:16:53.091Z,1472253413.091 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.3 s old, using for 20.0 s.
2016-08-26T23:16:53.460Z,1472253413.460 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.7 s old, using for 20.0 s.
2016-08-26T23:16:53.884Z,1472253413.884 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.1 s old, using for 20.0 s.
2016-08-26T23:16:54.285Z,1472253414.285 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.5 s old, using for 20.0 s.
2016-08-26T23:16:54.297Z,1472253414.297 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:16:54.297Z,1472253414.297 [Aanderaa_O2] No Fault, FailCount= 3
2016-08-26T23:16:54.643Z,1472253414.643 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.9 s old, using for 20.0 s.
2016-08-26T23:16:55.051Z,1472253415.051 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.3 s old, using for 20.0 s.
2016-08-26T23:16:55.447Z,1472253415.447 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.7 s old, using for 20.0 s.
2016-08-26T23:16:55.855Z,1472253415.855 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.1 s old, using for 20.0 s.
2016-08-26T23:16:56.264Z,1472253416.264 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.5 s old, using for 20.0 s.
2016-08-26T23:16:56.661Z,1472253416.661 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.9 s old, using for 20.0 s.
2016-08-26T23:16:57.042Z,1472253417.042 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.3 s old, using for 20.0 s.
2016-08-26T23:16:57.446Z,1472253417.446 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.7 s old, using for 20.0 s.
2016-08-26T23:17:05.007Z,1472253425.007 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:17:05.007Z,1472253425.007 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-08-26T23:17:05.007Z,1472253425.007 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:17:05.097Z,1472253425.097 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:17:05.525Z,1472253425.525 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:17:06.314Z,1472253426.314 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:17:06.314Z,1472253426.314 [Aanderaa_O2] No Fault, FailCount= 1
2016-08-26T23:17:16.610Z,1472253436.610 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:17:16.610Z,1472253436.610 [Aanderaa_O2] Communications Fault, FailCount= 2
2016-08-26T23:17:16.610Z,1472253436.610 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:17:16.697Z,1472253436.697 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:17:17.123Z,1472253437.123 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:17:17.859Z,1472253437.859 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:17:17.859Z,1472253437.859 [Aanderaa_O2] No Fault, FailCount= 2
2016-08-26T23:17:28.608Z,1472253448.608 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:17:28.608Z,1472253448.608 [Aanderaa_O2] Communications Fault, FailCount= 3
2016-08-26T23:17:28.608Z,1472253448.608 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:17:28.694Z,1472253448.694 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:17:28.694Z,1472253448.694 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2016-08-26T23:17:29.125Z,1472253449.125 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:17:38.719Z,1472253458.719 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:17:38.719Z,1472253458.719 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:17:38.719Z,1472253458.719 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:18:38.804Z,1472253518.804 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:18:38.804Z,1472253518.804 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:18:38.805Z,1472253518.805 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:19:38.595Z,1472253578.595 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:19:38.595Z,1472253578.595 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2016-08-26T23:19:38.595Z,1472253578.595 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-08-26T23:19:38.597Z,1472253578.597 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:19:38.597Z,1472253578.597 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2016-08-26T23:19:38.597Z,1472253578.597 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-08-26T23:19:38.608Z,1472253578.608 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-08-26T23:19:38.609Z,1472253578.609 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-08-26T23:19:38.929Z,1472253578.929 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:19:38.929Z,1472253578.929 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:19:38.930Z,1472253578.930 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:19:39.026Z,1472253579.026 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-08-26T23:19:39.027Z,1472253579.027 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2016-08-26T23:19:39.027Z,1472253579.027 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-08-26T23:19:39.027Z,1472253579.027 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2016-08-26T23:19:39.372Z,1472253579.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-08-26T23:19:39.373Z,1472253579.373 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:19:39.373Z,1472253579.373 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:19:39.373Z,1472253579.373 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-08-26T23:19:39.374Z,1472253579.374 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:19:39.374Z,1472253579.374 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:19:39.809Z,1472253579.809 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2016-08-26T23:19:40.202Z,1472253580.202 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2016-08-26T23:19:40.566Z,1472253580.566 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2016-08-26T23:19:40.966Z,1472253580.966 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2016-08-26T23:19:41.365Z,1472253581.365 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2016-08-26T23:19:41.773Z,1472253581.773 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2016-08-26T23:19:42.181Z,1472253582.181 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2016-08-26T23:19:42.570Z,1472253582.570 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2016-08-26T23:19:42.963Z,1472253582.963 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2016-08-26T23:19:43.375Z,1472253583.375 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2016-08-26T23:19:43.769Z,1472253583.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2016-08-26T23:19:44.165Z,1472253584.165 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2016-08-26T23:19:44.604Z,1472253584.604 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2016-08-26T23:19:45.002Z,1472253585.002 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2016-08-26T23:19:45.375Z,1472253585.375 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2016-08-26T23:19:45.763Z,1472253585.763 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2016-08-26T23:19:46.168Z,1472253586.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2016-08-26T23:19:46.171Z,1472253586.171 [Default:CheckIn:Read_GPS](INFO): Timed out from 2016-08-26T23:14:45.9Z
2016-08-26T23:19:46.171Z,1472253586.171 [Default:CheckIn:Read_GPS] Stopped
2016-08-26T23:19:46.171Z,1472253586.171 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-08-26T23:19:46.564Z,1472253586.564 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2016-08-26T23:19:46.568Z,1472253586.568 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2016-08-26T23:19:47.517Z,1472253587.517 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.9 s old, using for 20.0 s.
2016-08-26T23:19:47.619Z,1472253587.619 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.0 s old, using for 20.0 s.
2016-08-26T23:19:50.860Z,1472253590.860 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.3 s old, using for 20.0 s.
2016-08-26T23:19:50.926Z,1472253590.926 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20160826T231022/Courier0004.lzma
2016-08-26T23:19:50.978Z,1472253590.978 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2016-08-26T23:19:51.328Z,1472253591.328 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.7 s old, using for 20.0 s.
2016-08-26T23:19:51.685Z,1472253591.685 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4425188&filename=Logs%2F20160826T231022%2FCourier0004.lzma, 1
2016-08-26T23:19:51.685Z,1472253591.685 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4425188&filename=Logs%2F20160826T231022%2FCourier0004.lzma, key = 6, value = makai
2016-08-26T23:19:51.686Z,1472253591.686 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4425188&filename=Logs%2F20160826T231022%2FCourier0004.lzma, key = 0, value = true
2016-08-26T23:19:51.686Z,1472253591.686 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T231022%2FCourier0004.lzma, key = 4, value = 4425188
2016-08-26T23:19:51.687Z,1472253591.687 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T231022%2FCourier0004.lzma
2016-08-26T23:19:51.687Z,1472253591.687 [DataOverHttps](INFO): Moved sent file to Logs/20160826T231022/Courier0004.lzma.bak
2016-08-26T23:19:51.688Z,1472253591.688 [DataOverHttps](INFO): SBD MOMSN=4425188
2016-08-26T23:19:51.741Z,1472253591.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.1 s old, using for 20.0 s.
2016-08-26T23:19:53.242Z,1472253593.242 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.6 s old, using for 20.0 s.
2016-08-26T23:19:53.343Z,1472253593.343 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.7 s old, using for 20.0 s.
2016-08-26T23:19:56.580Z,1472253596.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2016-08-26T23:19:56.719Z,1472253596.719 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.1 s old, using for 20.0 s.
2016-08-26T23:19:57.084Z,1472253597.084 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.5 s old, using for 20.0 s.
2016-08-26T23:19:57.404Z,1472253597.404 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:19:57.405Z,1472253597.405 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:19:57.405Z,1472253597.405 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:19:57.474Z,1472253597.474 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.9 s old, using for 20.0 s.
2016-08-26T23:19:57.835Z,1472253597.835 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2016-08-26T23:19:58.239Z,1472253598.239 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2016-08-26T23:20:01.479Z,1472253601.479 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:20:01.479Z,1472253601.479 [Aanderaa_O2] No Fault, FailCount= 3
2016-08-26T23:20:01.556Z,1472253601.556 [DataOverHttps](INFO): Sending 522 bytes from file Logs/20160826T231022/Express0005.lzma
2016-08-26T23:20:02.293Z,1472253602.293 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4425190&filename=Logs%2F20160826T231022%2FExpress0005.lzma, 1
2016-08-26T23:20:02.294Z,1472253602.294 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4425190&filename=Logs%2F20160826T231022%2FExpress0005.lzma, key = 6, value = makai
2016-08-26T23:20:02.294Z,1472253602.294 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4425190&filename=Logs%2F20160826T231022%2FExpress0005.lzma, key = 0, value = true
2016-08-26T23:20:02.295Z,1472253602.295 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T231022%2FExpress0005.lzma, key = 4, value = 4425190
2016-08-26T23:20:02.295Z,1472253602.295 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T231022%2FExpress0005.lzma
2016-08-26T23:20:02.297Z,1472253602.297 [DataOverHttps](INFO): Moved sent file to Logs/20160826T231022/Express0005.lzma.bak
2016-08-26T23:20:02.297Z,1472253602.297 [DataOverHttps](INFO): SBD MOMSN=4425190
2016-08-26T23:20:03.833Z,1472253603.833 [Default:CheckIn:Read_Iridium] Stopped
2016-08-26T23:20:03.833Z,1472253603.833 [Default:CheckIn:C.Wait] Running Loop=1
2016-08-26T23:20:03.833Z,1472253603.833 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-08-26T23:20:07.958Z,1472253607.958 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:20:07.958Z,1472253607.958 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:20:07.959Z,1472253607.959 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:20:11.553Z,1472253611.553 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:20:11.553Z,1472253611.553 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-08-26T23:20:11.553Z,1472253611.553 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:20:11.647Z,1472253611.647 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:20:12.074Z,1472253612.074 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:20:12.832Z,1472253612.832 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:20:12.832Z,1472253612.832 [Aanderaa_O2] No Fault, FailCount= 1
2016-08-26T23:20:23.551Z,1472253623.551 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:20:23.551Z,1472253623.551 [Aanderaa_O2] Communications Fault, FailCount= 2
2016-08-26T23:20:23.551Z,1472253623.551 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:20:23.612Z,1472253623.612 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:20:24.073Z,1472253624.073 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:20:24.809Z,1472253624.809 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:20:24.809Z,1472253624.809 [Aanderaa_O2] No Fault, FailCount= 2
2016-08-26T23:20:32.410Z,1472253632.410 [CBIT](DEBUG): EFC running - data check-sum false
2016-08-26T23:20:35.554Z,1472253635.554 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:20:35.554Z,1472253635.554 [Aanderaa_O2] Communications Fault, FailCount= 3
2016-08-26T23:20:35.554Z,1472253635.554 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:20:35.621Z,1472253635.621 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:20:35.621Z,1472253635.621 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2016-08-26T23:20:36.067Z,1472253636.067 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:20:48.765Z,1472253648.765 [NAL9602](FAULT): GPS failed to acquire within timeout.
2016-08-26T23:20:48.765Z,1472253648.765 [NAL9602] Data Fault, FailCount= 1
2016-08-26T23:20:48.765Z,1472253648.765 [NAL9602](ERROR): Data Fault
2016-08-26T23:20:48.822Z,1472253648.822 [CBIT](ERROR): Data Fault in component: NAL9602
2016-08-26T23:20:49.165Z,1472253649.165 [NAL9602](INFO): Powering down
2016-08-26T23:20:50.018Z,1472253650.018 [CBIT](INFO): Clearing failed state for component NAL9602
2016-08-26T23:20:50.018Z,1472253650.018 [NAL9602] No Fault, FailCount= 1
2016-08-26T23:20:54.369Z,1472253654.369 [NAL9602](INFO): Powering up NAL9602
2016-08-26T23:21:08.126Z,1472253668.126 [NAL9602](INFO): NAL9602 initialized
2016-08-26T23:21:08.524Z,1472253668.524 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:21:08.524Z,1472253668.524 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:21:08.525Z,1472253668.525 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:22:08.623Z,1472253728.623 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:22:08.624Z,1472253728.624 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:22:08.624Z,1472253728.624 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:22:39.467Z,1472253759.467 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:22:39.467Z,1472253759.467 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2016-08-26T23:22:39.467Z,1472253759.467 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-08-26T23:22:39.469Z,1472253759.469 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:22:39.469Z,1472253759.469 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2016-08-26T23:22:39.469Z,1472253759.469 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-08-26T23:22:39.480Z,1472253759.480 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-08-26T23:22:39.481Z,1472253759.481 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-08-26T23:22:39.875Z,1472253759.875 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-08-26T23:22:39.875Z,1472253759.875 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2016-08-26T23:22:39.875Z,1472253759.875 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-08-26T23:22:39.876Z,1472253759.876 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2016-08-26T23:22:40.261Z,1472253760.261 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-08-26T23:22:40.261Z,1472253760.261 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:22:40.262Z,1472253760.262 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:22:40.262Z,1472253760.262 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-08-26T23:22:40.263Z,1472253760.263 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:22:40.263Z,1472253760.263 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:22:40.672Z,1472253760.672 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2016-08-26T23:22:41.073Z,1472253761.073 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2016-08-26T23:22:41.470Z,1472253761.470 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2016-08-26T23:22:41.867Z,1472253761.867 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2016-08-26T23:22:42.269Z,1472253762.269 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2016-08-26T23:22:42.676Z,1472253762.676 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2016-08-26T23:22:43.072Z,1472253763.072 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2016-08-26T23:22:43.469Z,1472253763.469 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2016-08-26T23:22:43.847Z,1472253763.847 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2016-08-26T23:22:44.247Z,1472253764.247 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2016-08-26T23:22:44.671Z,1472253764.671 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2016-08-26T23:22:45.076Z,1472253765.076 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2016-08-26T23:22:45.471Z,1472253765.471 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2016-08-26T23:22:45.867Z,1472253765.867 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2016-08-26T23:22:46.247Z,1472253766.247 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2016-08-26T23:22:46.673Z,1472253766.673 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2016-08-26T23:22:47.077Z,1472253767.077 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2016-08-26T23:22:47.471Z,1472253767.471 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2016-08-26T23:22:47.849Z,1472253767.849 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2016-08-26T23:22:48.246Z,1472253768.246 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2016-08-26T23:22:48.673Z,1472253768.673 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2016-08-26T23:22:49.073Z,1472253769.073 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2016-08-26T23:22:49.475Z,1472253769.475 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2016-08-26T23:22:49.912Z,1472253769.912 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2016-08-26T23:22:50.248Z,1472253770.248 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2016-08-26T23:22:50.681Z,1472253770.681 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2016-08-26T23:22:51.126Z,1472253771.126 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.7 s old, using for 20.0 s.
2016-08-26T23:22:51.477Z,1472253771.477 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2016-08-26T23:22:51.891Z,1472253771.891 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2016-08-26T23:22:52.287Z,1472253772.287 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2016-08-26T23:22:52.678Z,1472253772.678 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2016-08-26T23:22:53.084Z,1472253773.084 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2016-08-26T23:22:53.484Z,1472253773.484 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2016-08-26T23:22:53.846Z,1472253773.846 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2016-08-26T23:22:54.256Z,1472253774.256 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2016-08-26T23:22:54.652Z,1472253774.652 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2016-08-26T23:22:55.052Z,1472253775.052 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2016-08-26T23:22:55.446Z,1472253775.446 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2016-08-26T23:22:55.883Z,1472253775.883 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2016-08-26T23:22:56.283Z,1472253776.283 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2016-08-26T23:22:56.687Z,1472253776.687 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2016-08-26T23:22:57.051Z,1472253777.051 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2016-08-26T23:22:57.451Z,1472253777.451 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2016-08-26T23:22:57.846Z,1472253777.846 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2016-08-26T23:22:58.253Z,1472253778.253 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2016-08-26T23:22:58.660Z,1472253778.660 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2016-08-26T23:22:59.085Z,1472253779.085 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2016-08-26T23:22:59.463Z,1472253779.463 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s.
2016-08-26T23:23:07.907Z,1472253787.907 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:23:07.907Z,1472253787.907 [Aanderaa_O2] No Fault, FailCount= 3
2016-08-26T23:23:08.722Z,1472253788.722 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:23:08.723Z,1472253788.723 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:23:08.723Z,1472253788.723 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:23:17.913Z,1472253797.913 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:23:17.913Z,1472253797.913 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-08-26T23:23:17.913Z,1472253797.913 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:23:17.994Z,1472253797.994 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:23:18.431Z,1472253798.431 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:23:19.165Z,1472253799.165 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:23:19.165Z,1472253799.165 [Aanderaa_O2] No Fault, FailCount= 1
2016-08-26T23:23:29.916Z,1472253809.916 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:23:29.916Z,1472253809.916 [Aanderaa_O2] Communications Fault, FailCount= 2
2016-08-26T23:23:29.916Z,1472253809.916 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:23:29.992Z,1472253809.992 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:23:30.431Z,1472253810.431 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:23:31.166Z,1472253811.166 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:23:31.167Z,1472253811.167 [Aanderaa_O2] No Fault, FailCount= 2
2016-08-26T23:23:41.914Z,1472253821.914 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:23:41.914Z,1472253821.914 [Aanderaa_O2] Communications Fault, FailCount= 3
2016-08-26T23:23:41.915Z,1472253821.915 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:23:41.982Z,1472253821.982 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:23:41.982Z,1472253821.982 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2016-08-26T23:23:42.432Z,1472253822.432 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:24:08.827Z,1472253848.827 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:24:08.828Z,1472253848.828 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:24:08.828Z,1472253848.828 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:24:24.048Z,1472253864.048 [BPC1](ERROR): Failed to receive battery data
2016-08-26T23:24:24.048Z,1472253864.048 [BPC1] Communications Fault, FailCount= 1
2016-08-26T23:24:24.068Z,1472253864.068 [BPC1](ERROR): Communications Fault
2016-08-26T23:24:24.088Z,1472253864.088 [CBIT](ERROR): Communications Fault in component: BPC1
2016-08-26T23:24:25.292Z,1472253865.292 [CBIT](INFO): Clearing failed state for component BPC1
2016-08-26T23:24:25.292Z,1472253865.292 [BPC1] No Fault, FailCount= 1
2016-08-26T23:25:04.076Z,1472253904.076 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2016-08-26T23:25:04.077Z,1472253904.077 [Default:CheckIn:C.Wait] Stopped
2016-08-26T23:25:04.077Z,1472253904.077 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2016-08-26T23:25:04.077Z,1472253904.077 [Default:CheckIn:D] Running Loop=1
2016-08-26T23:25:04.477Z,1472253904.477 [Default:CheckIn:D] Stopped
2016-08-26T23:25:04.477Z,1472253904.477 [Default:CheckIn:E] Running Loop=1
2016-08-26T23:25:04.865Z,1472253904.865 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.536108 min 
2016-08-26T23:25:04.867Z,1472253904.867 [Default:CheckIn:E] Stopped
2016-08-26T23:25:04.867Z,1472253904.867 [Default:CheckIn](INFO): Completed Default:CheckIn
2016-08-26T23:25:04.867Z,1472253904.867 [Default:CheckIn] Stopped
2016-08-26T23:25:04.867Z,1472253904.867 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-08-26T23:25:04.868Z,1472253904.868 [Default:CheckIn](INFO): Running loop #2
2016-08-26T23:25:04.868Z,1472253904.868 [Default:CheckIn] Running Loop=2
2016-08-26T23:25:04.868Z,1472253904.868 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2016-08-26T23:25:04.868Z,1472253904.868 [Default:CheckIn:Read_GPS] Running Loop=1
2016-08-26T23:25:08.895Z,1472253908.895 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:25:08.895Z,1472253908.895 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:25:08.896Z,1472253908.896 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:25:32.552Z,1472253932.552 [CBIT](INFO): Clearing failed state for component DropWeight
2016-08-26T23:25:32.552Z,1472253932.552 [DropWeight] No Fault, FailCount= 1
2016-08-26T23:25:32.892Z,1472253932.892 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2016-08-26T23:25:32.893Z,1472253932.893 [DropWeight] Hardware Fault, FailCount= 1
2016-08-26T23:25:32.893Z,1472253932.893 [DropWeight](ERROR): Hardware Fault
2016-08-26T23:25:32.972Z,1472253932.972 [CBIT](ERROR): Hardware Fault in component: DropWeight
2016-08-26T23:25:32.973Z,1472253932.973 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2016-08-26T23:25:40.522Z,1472253940.522 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:25:40.522Z,1472253940.522 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2016-08-26T23:25:40.522Z,1472253940.522 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-08-26T23:25:40.524Z,1472253940.524 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:25:40.524Z,1472253940.524 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2016-08-26T23:25:40.524Z,1472253940.524 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-08-26T23:25:40.552Z,1472253940.552 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-08-26T23:25:40.552Z,1472253940.552 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-08-26T23:25:40.969Z,1472253940.969 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-08-26T23:25:40.969Z,1472253940.969 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2016-08-26T23:25:40.970Z,1472253940.970 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-08-26T23:25:40.970Z,1472253940.970 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2016-08-26T23:25:41.357Z,1472253941.357 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-08-26T23:25:41.357Z,1472253941.357 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:25:41.357Z,1472253941.357 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:25:41.358Z,1472253941.358 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-08-26T23:25:41.358Z,1472253941.358 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:25:41.359Z,1472253941.359 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:25:41.756Z,1472253941.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2016-08-26T23:25:42.119Z,1472253942.119 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2016-08-26T23:25:42.524Z,1472253942.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2016-08-26T23:25:42.972Z,1472253942.972 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.5 s old, using for 20.0 s.
2016-08-26T23:25:43.322Z,1472253943.322 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2016-08-26T23:25:43.785Z,1472253943.785 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.3 s old, using for 20.0 s.
2016-08-26T23:25:44.139Z,1472253944.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2016-08-26T23:25:44.571Z,1472253944.571 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2016-08-26T23:25:44.924Z,1472253944.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2016-08-26T23:25:45.364Z,1472253945.364 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2016-08-26T23:25:45.736Z,1472253945.736 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2016-08-26T23:25:46.169Z,1472253946.169 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2016-08-26T23:25:46.525Z,1472253946.525 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2016-08-26T23:25:46.939Z,1472253946.939 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2016-08-26T23:25:47.335Z,1472253947.335 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2016-08-26T23:25:47.727Z,1472253947.727 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2016-08-26T23:25:48.124Z,1472253948.124 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2016-08-26T23:25:48.526Z,1472253948.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2016-08-26T23:25:48.926Z,1472253948.926 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2016-08-26T23:25:49.327Z,1472253949.327 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2016-08-26T23:25:49.731Z,1472253949.731 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2016-08-26T23:25:50.144Z,1472253950.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2016-08-26T23:25:50.527Z,1472253950.527 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2016-08-26T23:25:50.931Z,1472253950.931 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2016-08-26T23:25:51.325Z,1472253951.325 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2016-08-26T23:25:51.726Z,1472253951.726 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2016-08-26T23:25:52.127Z,1472253952.127 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2016-08-26T23:25:52.523Z,1472253952.523 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2016-08-26T23:25:52.936Z,1472253952.936 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2016-08-26T23:25:53.337Z,1472253953.337 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2016-08-26T23:25:53.746Z,1472253953.746 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2016-08-26T23:25:54.126Z,1472253954.126 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2016-08-26T23:25:54.529Z,1472253954.529 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2016-08-26T23:25:54.924Z,1472253954.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2016-08-26T23:25:55.324Z,1472253955.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2016-08-26T23:25:55.729Z,1472253955.729 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2016-08-26T23:25:56.134Z,1472253956.134 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2016-08-26T23:25:56.530Z,1472253956.530 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2016-08-26T23:25:56.979Z,1472253956.979 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.5 s old, using for 20.0 s.
2016-08-26T23:25:57.327Z,1472253957.327 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2016-08-26T23:25:57.723Z,1472253957.723 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2016-08-26T23:25:58.145Z,1472253958.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2016-08-26T23:25:58.527Z,1472253958.527 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2016-08-26T23:25:58.973Z,1472253958.973 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.5 s old, using for 20.0 s.
2016-08-26T23:25:59.337Z,1472253959.337 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2016-08-26T23:25:59.774Z,1472253959.774 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.3 s old, using for 20.0 s.
2016-08-26T23:26:00.168Z,1472253960.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2016-08-26T23:26:08.998Z,1472253968.998 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:26:08.998Z,1472253968.998 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:26:08.999Z,1472253968.999 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:26:12.301Z,1472253972.301 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:26:12.302Z,1472253972.302 [Aanderaa_O2] No Fault, FailCount= 3
2016-08-26T23:26:13.489Z,1472253973.489 [CBIT](CRITICAL): Environmental Failure. Press:14.982194 PSI. Humidity:34%. Temp:23 C. ABORTING MISSION
2016-08-26T23:26:22.996Z,1472253982.996 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:26:22.996Z,1472253982.996 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-08-26T23:26:22.996Z,1472253982.996 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:26:23.090Z,1472253983.090 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:26:23.514Z,1472253983.514 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:26:24.247Z,1472253984.247 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:26:24.248Z,1472253984.248 [Aanderaa_O2] No Fault, FailCount= 1
2016-08-26T23:26:34.995Z,1472253994.995 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:26:34.995Z,1472253994.995 [Aanderaa_O2] Communications Fault, FailCount= 2
2016-08-26T23:26:34.995Z,1472253994.995 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:26:35.085Z,1472253995.085 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:26:35.512Z,1472253995.512 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:26:36.250Z,1472253996.250 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:26:36.250Z,1472253996.250 [Aanderaa_O2] No Fault, FailCount= 2
2016-08-26T23:26:46.997Z,1472254006.997 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:26:46.997Z,1472254006.997 [Aanderaa_O2] Communications Fault, FailCount= 3
2016-08-26T23:26:46.997Z,1472254006.997 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:26:47.099Z,1472254007.099 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:26:47.100Z,1472254007.100 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2016-08-26T23:26:47.511Z,1472254007.511 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:27:09.105Z,1472254029.105 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:27:09.106Z,1472254029.106 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:27:09.106Z,1472254029.106 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:28:09.248Z,1472254089.248 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:28:09.248Z,1472254089.248 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:28:09.249Z,1472254089.249 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:28:41.778Z,1472254121.778 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:28:41.778Z,1472254121.778 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2016-08-26T23:28:41.779Z,1472254121.779 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-08-26T23:28:41.781Z,1472254121.781 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:28:41.781Z,1472254121.781 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2016-08-26T23:28:41.781Z,1472254121.781 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-08-26T23:28:41.818Z,1472254121.818 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-08-26T23:28:41.818Z,1472254121.818 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-08-26T23:28:42.146Z,1472254122.146 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-08-26T23:28:42.147Z,1472254122.147 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2016-08-26T23:28:42.147Z,1472254122.147 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-08-26T23:28:42.147Z,1472254122.147 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2016-08-26T23:28:42.552Z,1472254122.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-08-26T23:28:42.553Z,1472254122.553 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:28:42.557Z,1472254122.557 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:28:42.558Z,1472254122.558 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-08-26T23:28:42.558Z,1472254122.558 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:28:42.559Z,1472254122.559 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:28:42.978Z,1472254122.978 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2016-08-26T23:28:43.314Z,1472254123.314 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.5 s old, using for 20.0 s.
2016-08-26T23:28:43.748Z,1472254123.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2016-08-26T23:28:44.155Z,1472254124.155 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2016-08-26T23:28:44.522Z,1472254124.522 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.7 s old, using for 20.0 s.
2016-08-26T23:28:44.922Z,1472254124.922 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.1 s old, using for 20.0 s.
2016-08-26T23:28:45.352Z,1472254125.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2016-08-26T23:28:45.744Z,1472254125.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2016-08-26T23:28:46.353Z,1472254126.353 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.6 s old, using for 20.0 s.
2016-08-26T23:28:46.595Z,1472254126.595 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2016-08-26T23:28:46.957Z,1472254126.957 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2016-08-26T23:28:47.400Z,1472254127.400 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2016-08-26T23:28:47.853Z,1472254127.853 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.1 s old, using for 20.0 s.
2016-08-26T23:28:48.166Z,1472254128.166 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2016-08-26T23:28:48.626Z,1472254128.626 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2016-08-26T23:28:48.977Z,1472254128.977 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2016-08-26T23:28:49.318Z,1472254129.318 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.5 s old, using for 20.0 s.
2016-08-26T23:28:49.812Z,1472254129.812 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2016-08-26T23:28:50.202Z,1472254130.202 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2016-08-26T23:28:50.549Z,1472254130.549 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2016-08-26T23:28:51.071Z,1472254131.071 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.3 s old, using for 20.0 s.
2016-08-26T23:28:51.324Z,1472254131.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.5 s old, using for 20.0 s.
2016-08-26T23:28:51.766Z,1472254131.766 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2016-08-26T23:28:52.173Z,1472254132.173 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2016-08-26T23:28:52.542Z,1472254132.542 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2016-08-26T23:28:52.971Z,1472254132.971 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2016-08-26T23:28:53.386Z,1472254133.386 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2016-08-26T23:28:53.737Z,1472254133.737 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2016-08-26T23:28:54.138Z,1472254134.138 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2016-08-26T23:28:54.568Z,1472254134.568 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2016-08-26T23:28:54.979Z,1472254134.979 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2016-08-26T23:28:55.338Z,1472254135.338 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2016-08-26T23:28:55.750Z,1472254135.750 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2016-08-26T23:28:56.120Z,1472254136.120 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.3 s old, using for 20.0 s.
2016-08-26T23:28:56.534Z,1472254136.534 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2016-08-26T23:28:56.994Z,1472254136.994 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2016-08-26T23:28:57.341Z,1472254137.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2016-08-26T23:28:57.756Z,1472254137.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2016-08-26T23:28:58.151Z,1472254138.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2016-08-26T23:28:58.540Z,1472254138.540 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2016-08-26T23:28:58.958Z,1472254138.958 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2016-08-26T23:28:59.350Z,1472254139.350 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2016-08-26T23:28:59.749Z,1472254139.749 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2016-08-26T23:29:00.185Z,1472254140.185 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2016-08-26T23:29:00.554Z,1472254140.554 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2016-08-26T23:29:00.941Z,1472254140.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2016-08-26T23:29:01.341Z,1472254141.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2016-08-26T23:29:01.776Z,1472254141.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s.
2016-08-26T23:29:09.754Z,1472254149.754 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:29:09.754Z,1472254149.754 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:29:09.755Z,1472254149.755 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:29:17.012Z,1472254157.012 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:29:17.013Z,1472254157.013 [Aanderaa_O2] No Fault, FailCount= 3
2016-08-26T23:29:27.751Z,1472254167.751 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:29:27.751Z,1472254167.751 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-08-26T23:29:27.751Z,1472254167.751 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:29:27.832Z,1472254167.832 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:29:28.268Z,1472254168.268 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:29:29.017Z,1472254169.017 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:29:29.017Z,1472254169.017 [Aanderaa_O2] No Fault, FailCount= 1
2016-08-26T23:29:39.749Z,1472254179.749 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:29:39.749Z,1472254179.749 [Aanderaa_O2] Communications Fault, FailCount= 2
2016-08-26T23:29:39.749Z,1472254179.749 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:29:39.840Z,1472254179.840 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:29:40.268Z,1472254180.268 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:29:41.087Z,1472254181.087 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:29:41.087Z,1472254181.087 [Aanderaa_O2] No Fault, FailCount= 2
2016-08-26T23:29:51.752Z,1472254191.752 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:29:51.752Z,1472254191.752 [Aanderaa_O2] Communications Fault, FailCount= 3
2016-08-26T23:29:51.752Z,1472254191.752 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:29:51.818Z,1472254191.818 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:29:51.819Z,1472254191.819 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2016-08-26T23:29:52.266Z,1472254192.266 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:30:05.005Z,1472254205.005 [Default:CheckIn:Read_GPS](INFO): Timed out from 2016-08-26T23:25:04.9Z
2016-08-26T23:30:05.005Z,1472254205.005 [Default:CheckIn:Read_GPS] Stopped
2016-08-26T23:30:05.005Z,1472254205.005 [Default:CheckIn:Read_Iridium] Running Loop=1
2016-08-26T23:30:09.349Z,1472254209.349 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20160826T231022/Courier0008.lzma
2016-08-26T23:30:10.111Z,1472254210.111 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4425267&filename=Logs%2F20160826T231022%2FCourier0008.lzma, 1
2016-08-26T23:30:10.112Z,1472254210.112 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4425267&filename=Logs%2F20160826T231022%2FCourier0008.lzma, key = 6, value = makai
2016-08-26T23:30:10.112Z,1472254210.112 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4425267&filename=Logs%2F20160826T231022%2FCourier0008.lzma, key = 0, value = true
2016-08-26T23:30:10.113Z,1472254210.113 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T231022%2FCourier0008.lzma, key = 4, value = 4425267
2016-08-26T23:30:10.113Z,1472254210.113 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T231022%2FCourier0008.lzma
2016-08-26T23:30:10.114Z,1472254210.114 [DataOverHttps](INFO): Moved sent file to Logs/20160826T231022/Courier0008.lzma.bak
2016-08-26T23:30:10.114Z,1472254210.114 [DataOverHttps](INFO): SBD MOMSN=4425267
2016-08-26T23:30:15.768Z,1472254215.768 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:30:15.769Z,1472254215.769 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:30:15.769Z,1472254215.769 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:30:19.890Z,1472254219.890 [DataOverHttps](INFO): Sending 417 bytes from file Logs/20160826T231022/Express0009.lzma
2016-08-26T23:30:20.628Z,1472254220.628 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=true&momsn=4425272&filename=Logs%2F20160826T231022%2FExpress0009.lzma, 1
2016-08-26T23:30:20.628Z,1472254220.628 [DataOverHttps](DEBUG): ParseDataRead( data = busy=true&momsn=4425272&filename=Logs%2F20160826T231022%2FExpress0009.lzma, key = 6, value = makai
2016-08-26T23:30:20.629Z,1472254220.629 [DataOverHttps](DEBUG): ParseDataRead( data = momsn=4425272&filename=Logs%2F20160826T231022%2FExpress0009.lzma, key = 0, value = true
2016-08-26T23:30:20.637Z,1472254220.637 [DataOverHttps](DEBUG): ParseDataRead( data = filename=Logs%2F20160826T231022%2FExpress0009.lzma, key = 4, value = 4425272
2016-08-26T23:30:20.638Z,1472254220.638 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 2, value = Logs%2F20160826T231022%2FExpress0009.lzma
2016-08-26T23:30:20.638Z,1472254220.638 [DataOverHttps](INFO): Moved sent file to Logs/20160826T231022/Express0009.lzma.bak
2016-08-26T23:30:20.638Z,1472254220.638 [DataOverHttps](INFO): SBD MOMSN=4425272
2016-08-26T23:30:22.172Z,1472254222.172 [Default:CheckIn:Read_Iridium] Stopped
2016-08-26T23:30:22.172Z,1472254222.172 [Default:CheckIn:C.Wait] Running Loop=1
2016-08-26T23:30:22.172Z,1472254222.172 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2016-08-26T23:30:26.977Z,1472254226.977 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:30:26.978Z,1472254226.978 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:30:26.978Z,1472254226.978 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:30:32.629Z,1472254232.629 [CBIT](DEBUG): EFC running - data check-sum false
2016-08-26T23:31:10.609Z,1472254270.609 [NAL9602](FAULT): GPS failed to acquire within timeout.
2016-08-26T23:31:10.609Z,1472254270.609 [NAL9602] Data Fault, FailCount= 2
2016-08-26T23:31:10.609Z,1472254270.609 [NAL9602](ERROR): Data Fault
2016-08-26T23:31:10.731Z,1472254270.731 [CBIT](ERROR): Data Fault in component: NAL9602
2016-08-26T23:31:10.977Z,1472254270.977 [NAL9602](INFO): Powering down
2016-08-26T23:31:11.913Z,1472254271.913 [CBIT](INFO): Clearing failed state for component NAL9602
2016-08-26T23:31:11.913Z,1472254271.913 [NAL9602] No Fault, FailCount= 2
2016-08-26T23:31:16.181Z,1472254276.181 [NAL9602](INFO): Powering up NAL9602
2016-08-26T23:31:30.306Z,1472254290.306 [BPC1](ERROR): Failed to receive battery data
2016-08-26T23:31:30.306Z,1472254290.306 [BPC1] Communications Fault, FailCount= 1
2016-08-26T23:31:30.306Z,1472254290.306 [BPC1](ERROR): Communications Fault
2016-08-26T23:31:30.421Z,1472254290.421 [CBIT](ERROR): Communications Fault in component: BPC1
2016-08-26T23:31:30.844Z,1472254290.844 [NAL9602](INFO): NAL9602 initialized
2016-08-26T23:31:31.241Z,1472254291.241 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:31:31.241Z,1472254291.241 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:31:31.242Z,1472254291.242 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:31:31.396Z,1472254291.396 [CBIT](INFO): Clearing failed state for component BPC1
2016-08-26T23:31:31.396Z,1472254291.396 [BPC1] No Fault, FailCount= 1
2016-08-26T23:31:42.915Z,1472254302.915 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:31:42.915Z,1472254302.915 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2016-08-26T23:31:42.915Z,1472254302.915 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2016-08-26T23:31:42.941Z,1472254302.941 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-08-26T23:31:42.941Z,1472254302.941 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2016-08-26T23:31:42.941Z,1472254302.941 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2016-08-26T23:31:42.985Z,1472254302.985 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2016-08-26T23:31:42.985Z,1472254302.985 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2016-08-26T23:31:43.462Z,1472254303.462 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2016-08-26T23:31:43.462Z,1472254303.462 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2016-08-26T23:31:43.463Z,1472254303.463 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2016-08-26T23:31:43.463Z,1472254303.463 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2016-08-26T23:31:43.700Z,1472254303.700 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-08-26T23:31:43.701Z,1472254303.701 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:31:43.701Z,1472254303.701 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:31:43.701Z,1472254303.701 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-08-26T23:31:43.707Z,1472254303.707 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-08-26T23:31:43.707Z,1472254303.707 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-08-26T23:31:44.169Z,1472254304.169 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.3 s old, using for 20.0 s.
2016-08-26T23:31:44.547Z,1472254304.547 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2016-08-26T23:31:44.977Z,1472254304.977 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.1 s old, using for 20.0 s.
2016-08-26T23:31:45.321Z,1472254305.321 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2016-08-26T23:31:45.810Z,1472254305.810 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.9 s old, using for 20.0 s.
2016-08-26T23:31:46.183Z,1472254306.183 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.3 s old, using for 20.0 s.
2016-08-26T23:31:46.528Z,1472254306.528 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2016-08-26T23:31:46.926Z,1472254306.926 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2016-08-26T23:31:47.302Z,1472254307.302 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2016-08-26T23:31:47.716Z,1472254307.716 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2016-08-26T23:31:48.142Z,1472254308.142 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2016-08-26T23:31:48.501Z,1472254308.501 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2016-08-26T23:31:48.917Z,1472254308.917 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2016-08-26T23:31:49.316Z,1472254309.316 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2016-08-26T23:31:49.694Z,1472254309.694 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2016-08-26T23:31:50.129Z,1472254310.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2016-08-26T23:31:50.544Z,1472254310.544 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2016-08-26T23:31:50.941Z,1472254310.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2016-08-26T23:31:51.301Z,1472254311.301 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2016-08-26T23:31:51.733Z,1472254311.733 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2016-08-26T23:31:52.130Z,1472254312.130 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2016-08-26T23:31:52.519Z,1472254312.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2016-08-26T23:31:52.930Z,1472254312.930 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2016-08-26T23:31:53.333Z,1472254313.333 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2016-08-26T23:31:53.733Z,1472254313.733 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2016-08-26T23:31:54.101Z,1472254314.101 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2016-08-26T23:31:54.511Z,1472254314.511 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2016-08-26T23:31:54.925Z,1472254314.925 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2016-08-26T23:31:55.350Z,1472254315.350 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2016-08-26T23:31:55.785Z,1472254315.785 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.9 s old, using for 20.0 s.
2016-08-26T23:31:56.134Z,1472254316.134 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2016-08-26T23:31:56.549Z,1472254316.549 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2016-08-26T23:31:56.912Z,1472254316.912 [BPC1](ERROR): Failed to parse bank A battery data
2016-08-26T23:31:56.912Z,1472254316.912 [BPC1] Data Fault, FailCount= 1
2016-08-26T23:31:56.912Z,1472254316.912 [BPC1](ERROR): Data Fault
2016-08-26T23:31:56.948Z,1472254316.948 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2016-08-26T23:31:56.982Z,1472254316.982 [CBIT](ERROR): Data Fault in component: BPC1
2016-08-26T23:31:57.310Z,1472254317.310 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2016-08-26T23:31:57.709Z,1472254317.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2016-08-26T23:31:58.112Z,1472254318.112 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2016-08-26T23:31:58.150Z,1472254318.150 [CBIT](INFO): Clearing failed state for component BPC1
2016-08-26T23:31:58.151Z,1472254318.151 [BPC1] No Fault, FailCount= 1
2016-08-26T23:31:58.611Z,1472254318.611 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.7 s old, using for 20.0 s.
2016-08-26T23:31:58.960Z,1472254318.960 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.1 s old, using for 20.0 s.
2016-08-26T23:31:59.355Z,1472254319.355 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2016-08-26T23:31:59.680Z,1472254319.680 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2016-08-26T23:32:00.115Z,1472254320.115 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2016-08-26T23:32:00.587Z,1472254320.587 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.7 s old, using for 20.0 s.
2016-08-26T23:32:00.928Z,1472254320.928 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2016-08-26T23:32:01.317Z,1472254321.317 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2016-08-26T23:32:01.772Z,1472254321.772 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.9 s old, using for 20.0 s.
2016-08-26T23:32:02.137Z,1472254322.137 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2016-08-26T23:32:02.519Z,1472254322.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2016-08-26T23:32:02.897Z,1472254322.897 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s.
2016-08-26T23:32:22.086Z,1472254342.086 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:32:22.086Z,1472254342.086 [Aanderaa_O2] No Fault, FailCount= 3
2016-08-26T23:32:28.312Z,1472254348.312 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=makai&busy=false, 1
2016-08-26T23:32:28.313Z,1472254348.313 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = makai
2016-08-26T23:32:28.313Z,1472254348.313 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-08-26T23:32:32.706Z,1472254352.706 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:32:32.706Z,1472254352.706 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-08-26T23:32:32.706Z,1472254352.706 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:32:32.819Z,1472254352.819 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:32:33.223Z,1472254353.223 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:32:33.965Z,1472254353.965 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:32:33.965Z,1472254353.965 [Aanderaa_O2] No Fault, FailCount= 1
2016-08-26T23:32:44.708Z,1472254364.708 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:32:44.708Z,1472254364.708 [Aanderaa_O2] Communications Fault, FailCount= 2
2016-08-26T23:32:44.708Z,1472254364.708 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:32:44.815Z,1472254364.815 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:32:45.222Z,1472254365.222 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:32:46.006Z,1472254366.006 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2016-08-26T23:32:46.006Z,1472254366.006 [Aanderaa_O2] No Fault, FailCount= 2
2016-08-26T23:32:46.564Z,1472254366.564 [CommandLine](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2016-08-26T23:32:46.565Z,1472254366.565 [CommandLine](IMPORTANT): Onboard.Pressure 7.017062 psi
2016-08-26T23:32:55.003Z,1472254375.003 [CommandLine](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2016-08-26T23:32:55.003Z,1472254375.003 [CommandLine](IMPORTANT): Onboard.Pressure 7.548070 psi
2016-08-26T23:32:56.685Z,1472254376.685 [CommandLine](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2016-08-26T23:32:56.686Z,1472254376.686 [CommandLine](IMPORTANT): Onboard.Pressure 7.017062 psi
2016-08-26T23:32:56.707Z,1472254376.707 [Aanderaa_O2](FAULT): Timed out starting
2016-08-26T23:32:56.707Z,1472254376.707 [Aanderaa_O2] Communications Fault, FailCount= 3
2016-08-26T23:32:56.707Z,1472254376.707 [Aanderaa_O2](ERROR): Communications Fault
2016-08-26T23:32:56.833Z,1472254376.833 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2016-08-26T23:32:56.834Z,1472254376.834 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2016-08-26T23:32:57.224Z,1472254377.224 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:32:59.004Z,1472254379.004 [CommandLine](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2016-08-26T23:32:59.004Z,1472254379.004 [CommandLine](IMPORTANT): Onboard.Pressure 7.017062 psi
2016-08-26T23:33:00.940Z,1472254380.940 [CommandLine](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2016-08-26T23:33:00.940Z,1472254380.940 [CommandLine](IMPORTANT): Onboard.Pressure 7.017062 psi
2016-08-26T23:33:21.661Z,1472254401.661 [CommandLine](IMPORTANT): got command restart application
2016-08-26T23:33:22.670Z,1472254402.670 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2016-08-26T23:33:22.671Z,1472254402.671 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:22.756Z,1472254402.756 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2016-08-26T23:33:22.756Z,1472254402.756 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:22.756Z,1472254402.756 [CommandLine](INFO): Join timeout helper Thread ID is 3226
2016-08-26T23:33:22.776Z,1472254402.776 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2016-08-26T23:33:22.776Z,1472254402.776 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:22.776Z,1472254402.776 [NavChartDb](INFO): Join timeout helper Thread ID is 3227
2016-08-26T23:33:23.148Z,1472254403.148 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2016-08-26T23:33:23.149Z,1472254403.149 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.164Z,1472254403.164 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2016-08-26T23:33:23.164Z,1472254403.164 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.165Z,1472254403.165 [Radio_Surface](INFO): Join timeout helper Thread ID is 3228
2016-08-26T23:33:23.305Z,1472254403.305 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2016-08-26T23:33:23.305Z,1472254403.305 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.312Z,1472254403.312 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2016-08-26T23:33:23.313Z,1472254403.313 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.313Z,1472254403.313 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3229
2016-08-26T23:33:23.485Z,1472254403.485 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2016-08-26T23:33:23.485Z,1472254403.485 [WetLabsBB2FL](INFO): Powering down
2016-08-26T23:33:23.486Z,1472254403.486 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.493Z,1472254403.493 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2016-08-26T23:33:23.493Z,1472254403.493 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.493Z,1472254403.493 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 3230
2016-08-26T23:33:23.529Z,1472254403.529 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2016-08-26T23:33:23.530Z,1472254403.530 [CTD_NeilBrown](INFO): Powering down
2016-08-26T23:33:23.530Z,1472254403.530 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.542Z,1472254403.542 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2016-08-26T23:33:23.542Z,1472254403.542 [logger ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.543Z,1472254403.543 [logger](INFO): Join timeout helper Thread ID is 3231
2016-08-26T23:33:23.570Z,1472254403.570 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2016-08-26T23:33:23.571Z,1472254403.571 [logger ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.590Z,1472254403.590 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2016-08-26T23:33:23.590Z,1472254403.590 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.590Z,1472254403.590 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2016-08-26T23:33:23.590Z,1472254403.590 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:23.591Z,1472254403.591 [controlThread](INFO): Join timeout helper Thread ID is 3232
2016-08-26T23:33:26.337Z,1472254406.337 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2016-08-26T23:33:26.337Z,1472254406.337 [controlThread](DEBUG): Uninitializing ControlThread
2016-08-26T23:33:26.337Z,1472254406.337 [Aanderaa_O2](INFO): Powering down
2016-08-26T23:33:26.338Z,1472254406.338 [AcousticModem_Benthos_ATM900](INFO): Powering down
2016-08-26T23:33:26.460Z,1472254406.460 [NAL9602](INFO): Powering down
2016-08-26T23:33:26.462Z,1472254406.462 [PNI_TCM](INFO): Powering down
2016-08-26T23:33:26.551Z,1472254406.551 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-08-26T23:33:26.552Z,1472254406.552 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2016-08-26T23:33:26.553Z,1472254406.553 [Default] Stopped
2016-08-26T23:33:26.553Z,1472254406.553 [Default](DEBUG): Aggregate::uninitialize Default
2016-08-26T23:33:26.553Z,1472254406.553 [Default:B.GoToSurface] Stopped
2016-08-26T23:33:26.553Z,1472254406.553 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2016-08-26T23:33:26.553Z,1472254406.553 [Default:CheckIn] Stopped
2016-08-26T23:33:26.553Z,1472254406.553 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2016-08-26T23:33:26.553Z,1472254406.553 [Default:CheckIn:C.Wait] Stopped
2016-08-26T23:33:26.553Z,1472254406.553 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2016-08-26T23:33:26.556Z,1472254406.556 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2016-08-26T23:33:26.556Z,1472254406.556 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2016-08-26T23:33:26.556Z,1472254406.556 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2016-08-26T23:33:26.557Z,1472254406.557 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2016-08-26T23:33:26.557Z,1472254406.557 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-08-26T23:33:26.557Z,1472254406.557 [BuoyancyServo](INFO): Powering down
2016-08-26T23:33:26.570Z,1472254406.570 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2016-08-26T23:33:26.570Z,1472254406.570 [ElevatorServo](INFO): Powering down
2016-08-26T23:33:26.571Z,1472254406.571 [MassServo](DEBUG): Uninitialize Mass Servo.
2016-08-26T23:33:26.571Z,1472254406.571 [MassServo](INFO): Powering down
2016-08-26T23:33:26.571Z,1472254406.571 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2016-08-26T23:33:26.572Z,1472254406.572 [RudderServo](INFO): Powering down
2016-08-26T23:33:26.572Z,1472254406.572 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2016-08-26T23:33:26.572Z,1472254406.572 [ThrusterServo](INFO): Powering down
2016-08-26T23:33:26.573Z,1472254406.573 [SBIT](DEBUG): Uninitialize SBIT Component.
2016-08-26T23:33:26.574Z,1472254406.574 [IBIT](DEBUG): Uninitialize IBIT Component.
2016-08-26T23:33:26.574Z,1472254406.574 [CBIT](DEBUG): Uninitialize CBIT Component.
2016-08-26T23:33:26.606Z,1472254406.606 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:26.692Z,1472254406.692 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:26.696Z,1472254406.696 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:26.763Z,1472254406.763 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:26.821Z,1472254406.821 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-08-26T23:33:26.871Z,1472254406.871 [logger ThreadHandler](INFO): Thread cancelled.