2018-07-31T16:27:44.433Z,1533054464.433 [Supervisor](DEBUG): Initializing supervisor.
2018-07-31T16:27:44.437Z,1533054464.437 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-07-31T16:27:44.437Z,1533054464.437 [SyncHandler](INFO): Protected caller Thread ID is 6622
2018-07-31T16:27:44.438Z,1533054464.438 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-07-31T16:27:44.438Z,1533054464.438 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-07-31T16:27:44.439Z,1533054464.439 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6623
2018-07-31T16:27:44.442Z,1533054464.442 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-07-31T16:27:44.454Z,1533054464.454 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-07-31T16:27:44.455Z,1533054464.455 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-07-31T16:27:44.456Z,1533054464.456 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6624
2018-07-31T16:27:44.457Z,1533054464.457 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-07-31T16:27:44.457Z,1533054464.457 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-07-31T16:27:44.458Z,1533054464.458 [logger ThreadHandler](INFO): Protected caller Thread ID is 6625
2018-07-31T16:27:44.460Z,1533054464.460 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-07-31T16:27:44.460Z,1533054464.460 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-07-31T16:27:44.462Z,1533054464.462 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-07-31T16:27:44.658Z,1533054464.658 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-07-31T16:27:44.658Z,1533054464.658 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-07-31T16:27:44.800Z,1533054464.800 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-07-31T16:27:44.800Z,1533054464.800 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-07-31T16:27:45.147Z,1533054465.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-07-31T16:27:45.147Z,1533054465.147 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-07-31T16:27:45.285Z,1533054465.285 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-07-31T16:27:45.286Z,1533054465.286 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-07-31T16:27:45.366Z,1533054465.366 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-07-31T16:27:45.569Z,1533054465.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-07-31T16:27:45.569Z,1533054465.569 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-07-31T16:27:45.667Z,1533054465.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-07-31T16:27:45.667Z,1533054465.667 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-07-31T16:27:46.010Z,1533054466.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-07-31T16:27:46.011Z,1533054466.011 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-07-31T16:27:46.453Z,1533054466.453 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-07-31T16:27:46.453Z,1533054466.453 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-07-31T16:27:46.834Z,1533054466.834 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-07-31T16:27:46.835Z,1533054466.835 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-07-31T16:27:47.339Z,1533054467.339 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-07-31T16:27:47.340Z,1533054467.340 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-07-31T16:27:47.547Z,1533054467.547 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-07-31T16:27:47.547Z,1533054467.547 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-07-31T16:27:47.645Z,1533054467.645 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-07-31T16:27:47.645Z,1533054467.645 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-07-31T16:27:48.150Z,1533054468.150 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-07-31T16:27:48.150Z,1533054468.150 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-07-31T16:27:48.256Z,1533054468.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-07-31T16:27:48.258Z,1533054468.258 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2018-07-31T16:27:48.259Z,1533054468.259 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2018-07-31T16:27:48.490Z,1533054468.490 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-07-31T16:27:48.491Z,1533054468.491 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2018-07-31T16:27:48.589Z,1533054468.589 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2018-07-31T16:27:48.682Z,1533054468.682 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2018-07-31T16:27:48.784Z,1533054468.784 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2018-07-31T16:27:48.869Z,1533054468.869 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2018-07-31T16:27:49.000Z,1533054469.000 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2018-07-31T16:27:49.168Z,1533054469.168 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2018-07-31T16:27:49.279Z,1533054469.279 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2018-07-31T16:27:49.363Z,1533054469.363 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2018-07-31T16:27:49.446Z,1533054469.446 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2018-07-31T16:27:49.634Z,1533054469.634 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2018-07-31T16:27:49.634Z,1533054469.634 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-07-31T16:27:49.642Z,1533054469.642 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-07-31T16:27:49.771Z,1533054469.771 [SBIT](DEBUG): Construct Startup Built In Test.
2018-07-31T16:27:49.802Z,1533054469.802 [SBIT] Loaded
2018-07-31T16:27:49.802Z,1533054469.802 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-07-31T16:27:49.803Z,1533054469.803 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-07-31T16:27:49.830Z,1533054469.830 [IBIT] Loaded
2018-07-31T16:27:49.831Z,1533054469.831 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-07-31T16:27:49.834Z,1533054469.834 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-07-31T16:27:50.002Z,1533054470.002 [CBIT] Loaded
2018-07-31T16:27:50.003Z,1533054470.003 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-07-31T16:27:50.003Z,1533054470.003 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-07-31T16:27:50.004Z,1533054470.004 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-07-31T16:27:50.072Z,1533054470.072 [VerticalControl](DEBUG): Construct VerticalControl.
2018-07-31T16:27:50.172Z,1533054470.172 [VerticalControl] Loaded
2018-07-31T16:27:50.172Z,1533054470.172 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-07-31T16:27:50.173Z,1533054470.173 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-07-31T16:27:50.234Z,1533054470.234 [HorizontalControl] Loaded
2018-07-31T16:27:50.235Z,1533054470.235 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-07-31T16:27:50.235Z,1533054470.235 [SpeedControl](DEBUG): Construct SpeedControl.
2018-07-31T16:27:50.241Z,1533054470.241 [SpeedControl] Loaded
2018-07-31T16:27:50.241Z,1533054470.241 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-07-31T16:27:50.242Z,1533054470.242 [LoopControl](DEBUG): Construct LoopControl.
2018-07-31T16:27:50.243Z,1533054470.243 [LoopControl] Loaded
2018-07-31T16:27:50.243Z,1533054470.243 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-07-31T16:27:50.243Z,1533054470.243 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-07-31T16:27:50.244Z,1533054470.244 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-07-31T16:27:50.286Z,1533054470.286 [DepthRateCalculator] Loaded
2018-07-31T16:27:50.286Z,1533054470.286 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-07-31T16:27:50.292Z,1533054470.292 [PitchRateCalculator] Loaded
2018-07-31T16:27:50.292Z,1533054470.292 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-07-31T16:27:50.308Z,1533054470.308 [SpeedCalculator] Loaded
2018-07-31T16:27:50.308Z,1533054470.308 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-07-31T16:27:50.330Z,1533054470.330 [TempGradientCalculator] Loaded
2018-07-31T16:27:50.330Z,1533054470.330 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-07-31T16:27:50.346Z,1533054470.346 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-07-31T16:27:50.346Z,1533054470.346 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-07-31T16:27:50.351Z,1533054470.351 [YawRateCalculator] Loaded
2018-07-31T16:27:50.352Z,1533054470.352 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-07-31T16:27:50.381Z,1533054470.381 [ElevatorOffsetCalculator] Loaded
2018-07-31T16:27:50.382Z,1533054470.382 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-07-31T16:27:50.382Z,1533054470.382 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-07-31T16:27:50.382Z,1533054470.382 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-07-31T16:27:50.472Z,1533054470.472 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-07-31T16:27:50.472Z,1533054470.472 [StratificationFrontDetector](DEBUG): (re)initializing
2018-07-31T16:27:50.472Z,1533054470.472 [StratificationFrontDetector] Loaded
2018-07-31T16:27:50.472Z,1533054470.472 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-07-31T16:27:50.473Z,1533054470.473 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-07-31T16:27:50.473Z,1533054470.473 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-07-31T16:27:50.722Z,1533054470.722 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-07-31T16:27:50.723Z,1533054470.723 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-07-31T16:27:50.872Z,1533054470.872 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-07-31T16:27:50.873Z,1533054470.873 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-07-31T16:27:50.927Z,1533054470.927 [DeadReckonUsingSpeedCalculator] Loaded
2018-07-31T16:27:50.928Z,1533054470.928 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-07-31T16:27:50.983Z,1533054470.983 [DeadReckonWithRespectToSeafloor] Loaded
2018-07-31T16:27:50.983Z,1533054470.983 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2018-07-31T16:27:50.999Z,1533054470.999 [NavChart] Loaded
2018-07-31T16:27:50.000Z,1533054471.000 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-07-31T16:27:51.004Z,1533054471.004 [UniversalFixResidualReporter] Loaded
2018-07-31T16:27:51.004Z,1533054471.004 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-07-31T16:27:51.004Z,1533054471.004 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-07-31T16:27:51.005Z,1533054471.005 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-07-31T16:27:51.019Z,1533054471.019 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-07-31T16:27:51.019Z,1533054471.019 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-07-31T16:27:51.180Z,1533054471.180 [Aanderaa_O2] Loaded
2018-07-31T16:27:51.180Z,1533054471.180 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-07-31T16:27:51.230Z,1533054471.230 [WetLabsBB2FL] Loaded
2018-07-31T16:27:51.230Z,1533054471.230 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-07-31T16:27:51.231Z,1533054471.231 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406D44E0
2018-07-31T16:27:51.232Z,1533054471.232 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6705
2018-07-31T16:27:51.232Z,1533054471.232 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-07-31T16:27:51.233Z,1533054471.233 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-07-31T16:27:51.530Z,1533054471.530 [AHRS_M2] Loaded
2018-07-31T16:27:51.530Z,1533054471.530 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-07-31T16:27:51.599Z,1533054471.599 [DataOverHttps] Loaded
2018-07-31T16:27:51.600Z,1533054471.600 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-07-31T16:27:51.613Z,1533054471.613 [Depth_Keller] Loaded
2018-07-31T16:27:51.614Z,1533054471.614 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-07-31T16:27:51.619Z,1533054471.619 [DropWeight] Loaded
2018-07-31T16:27:51.619Z,1533054471.619 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-07-31T16:27:51.710Z,1533054471.710 [NAL9602] Loaded
2018-07-31T16:27:51.711Z,1533054471.711 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-07-31T16:27:51.716Z,1533054471.716 [Onboard] Loaded
2018-07-31T16:27:51.716Z,1533054471.716 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-07-31T16:27:51.723Z,1533054471.723 [Radio_Surface] Loaded
2018-07-31T16:27:51.724Z,1533054471.724 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-07-31T16:27:51.725Z,1533054471.725 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092A4E0
2018-07-31T16:27:51.725Z,1533054471.725 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6706
2018-07-31T16:27:51.754Z,1533054471.754 [RDI_Pathfinder] Loaded
2018-07-31T16:27:51.754Z,1533054471.754 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2018-07-31T16:27:51.761Z,1533054471.761 [SCPI] Loaded
2018-07-31T16:27:51.761Z,1533054471.761 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-07-31T16:27:53.943Z,1533054473.943 [BPC1] Loaded
2018-07-31T16:27:53.943Z,1533054473.943 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-07-31T16:27:53.944Z,1533054473.944 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-07-31T16:27:53.944Z,1533054473.944 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-07-31T16:27:54.044Z,1533054474.044 [BuoyancyServo] Loaded
2018-07-31T16:27:54.044Z,1533054474.044 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-07-31T16:27:54.056Z,1533054474.056 [ElevatorServo] Loaded
2018-07-31T16:27:54.057Z,1533054474.057 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-07-31T16:27:54.068Z,1533054474.068 [MassServo] Loaded
2018-07-31T16:27:54.068Z,1533054474.068 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-07-31T16:27:54.079Z,1533054474.079 [RudderServo] Loaded
2018-07-31T16:27:54.080Z,1533054474.080 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-07-31T16:27:54.090Z,1533054474.090 [ThrusterServo] Loaded
2018-07-31T16:27:54.091Z,1533054474.091 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-07-31T16:27:54.091Z,1533054474.091 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-07-31T16:27:54.092Z,1533054474.092 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-07-31T16:27:54.194Z,1533054474.194 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-07-31T16:27:54.194Z,1533054474.194 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-07-31T16:27:54.220Z,1533054474.220 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-07-31T16:27:54.224Z,1533054474.224 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-07-31T16:27:54.225Z,1533054474.225 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-07-31T16:27:54.231Z,1533054474.231 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-07-31T16:27:54.232Z,1533054474.232 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409D34E0
2018-07-31T16:27:54.233Z,1533054474.233 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6707
2018-07-31T16:27:54.237Z,1533054474.237 [Supervisor](INFO): Main Thread ID is 6621
2018-07-31T16:27:54.238Z,1533054474.238 [Supervisor](DEBUG): Running supervisor.
2018-07-31T16:27:54.238Z,1533054474.238 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6708
2018-07-31T16:27:54.241Z,1533054474.241 [controlThread ThreadHandler](INFO): Handler Thread ID is 6709
2018-07-31T16:27:54.241Z,1533054474.241 [controlThread](DEBUG): Initializing ControlThread
2018-07-31T16:27:54.242Z,1533054474.242 [SBIT](INFO): Initialize SBIT Component.
2018-07-31T16:27:54.243Z,1533054474.243 [SBIT](IMPORTANT): git: 2018-07-30-16-g071d29f
2018-07-31T16:27:54.243Z,1533054474.243 [SBIT](INFO): git hash: 071d29fcbbf64566819d214a84fe2412bb17c3df
2018-07-31T16:27:54.243Z,1533054474.243 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-07-31T16:27:54.245Z,1533054474.245 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-07-31T16:27:54.246Z,1533054474.246 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2018-07-31T16:27:54.246Z,1533054474.246 [IBIT](INFO): Initialize IBIT Component.
2018-07-31T16:27:54.247Z,1533054474.247 [CBIT](DEBUG): Initialize CBIT Component.
2018-07-31T16:27:54.248Z,1533054474.248 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-07-31T16:27:54.249Z,1533054474.249 [logger ThreadHandler](INFO): Handler Thread ID is 6710
2018-07-31T16:27:54.273Z,1533054474.273 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6711
2018-07-31T16:27:54.293Z,1533054474.293 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6712
2018-07-31T16:27:54.299Z,1533054474.299 [Radio_Surface](INFO): Powering up
2018-07-31T16:27:54.317Z,1533054474.317 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6713
2018-07-31T16:27:54.321Z,1533054474.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-07-31T16:27:54.321Z,1533054474.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-07-31T16:27:54.321Z,1533054474.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-07-31T16:27:54.321Z,1533054474.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-07-31T16:27:54.321Z,1533054474.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-07-31T16:27:54.322Z,1533054474.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-07-31T16:27:54.322Z,1533054474.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-07-31T16:27:54.322Z,1533054474.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-07-31T16:27:54.322Z,1533054474.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-07-31T16:27:54.322Z,1533054474.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-07-31T16:27:54.322Z,1533054474.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-07-31T16:27:54.323Z,1533054474.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-07-31T16:27:54.323Z,1533054474.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-07-31T16:27:54.323Z,1533054474.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-07-31T16:27:54.323Z,1533054474.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-07-31T16:27:54.323Z,1533054474.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-07-31T16:27:54.353Z,1533054474.353 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-07-31T16:27:54.354Z,1533054474.354 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-07-31T16:27:54.355Z,1533054474.355 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-07-31T16:27:54.356Z,1533054474.356 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-07-31T16:27:54.356Z,1533054474.356 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-07-31T16:27:54.356Z,1533054474.356 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-07-31T16:27:54.357Z,1533054474.357 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-07-31T16:27:54.357Z,1533054474.357 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-07-31T16:27:54.358Z,1533054474.358 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-07-31T16:27:54.358Z,1533054474.358 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-07-31T16:27:54.359Z,1533054474.359 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-07-31T16:27:54.360Z,1533054474.360 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-07-31T16:27:54.360Z,1533054474.360 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:27:54.361Z,1533054474.361 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:27:54.361Z,1533054474.361 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-07-31T16:27:54.362Z,1533054474.362 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:27:54.362Z,1533054474.362 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:27:54.363Z,1533054474.363 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-07-31T16:27:54.363Z,1533054474.363 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:27:54.363Z,1533054474.363 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:27:54.364Z,1533054474.364 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-07-31T16:27:54.364Z,1533054474.364 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-07-31T16:27:54.373Z,1533054474.373 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-07-31T16:27:54.410Z,1533054474.410 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-07-31T16:27:54.455Z,1533054474.455 [MissionManager](DEBUG):
2018-07-31T16:27:54.456Z,1533054474.456 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-07-31T16:27:54.553Z,1533054474.553 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-07-31T16:27:54.554Z,1533054474.554 [Default:A.Wait](DEBUG): Construct Wait.
2018-07-31T16:27:54.556Z,1533054474.556 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-07-31T16:27:54.613Z,1533054474.613 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-07-31T16:27:54.616Z,1533054474.616 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-07-31T16:27:54.638Z,1533054474.638 [Default:E.Execute](DEBUG): Construct Execute.
2018-07-31T16:27:54.642Z,1533054474.642 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn 300
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2018-07-31T16:27:54.661Z,1533054474.661 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-07-31T16:27:54.704Z,1533054474.704 [AHRS_M2](INFO): Start
2018-07-31T16:27:54.704Z,1533054474.704 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-07-31T16:27:54.768Z,1533054474.768 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-07-31T16:27:54.802Z,1533054474.802 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2018-07-31T16:27:55.063Z,1533054475.063 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-07-31T16:27:55.173Z,1533054475.173 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:27:55.197Z,1533054475.197 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:27:55.209Z,1533054475.209 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:27:55.317Z,1533054475.317 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-07-31T16:27:55.325Z,1533054475.325 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-07-31T16:27:55.339Z,1533054475.339 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-07-31T16:27:55.345Z,1533054475.345 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-07-31T16:27:55.367Z,1533054475.367 [MassServo](DEBUG): Initializing EZServoServo.
2018-07-31T16:27:55.373Z,1533054475.373 [MassServo](DEBUG): Initializing MassServo.
2018-07-31T16:27:55.387Z,1533054475.387 [RudderServo](DEBUG): Initializing EZServoServo.
2018-07-31T16:27:55.397Z,1533054475.397 [RudderServo](DEBUG): Initializing RudderServo.
2018-07-31T16:27:55.410Z,1533054475.410 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-07-31T16:27:55.417Z,1533054475.417 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-07-31T16:27:55.565Z,1533054475.565 [AHRS_M2](INFO): Starting
2018-07-31T16:27:55.643Z,1533054475.643 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2018-07-31T16:27:55.643Z,1533054475.643 [DropWeight] Hardware Fault, FailCount= 1
2018-07-31T16:27:55.643Z,1533054475.643 [DropWeight](ERROR): Hardware Fault
2018-07-31T16:27:55.681Z,1533054475.681 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:27:55.682Z,1533054475.682 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:27:55.683Z,1533054475.683 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:27:55.701Z,1533054475.701 [CommandLine](FAULT): Scheduling is paused
2018-07-31T16:27:55.701Z,1533054475.701 [CBIT](INFO): Critical error at 20180731T162755
2018-07-31T16:27:55.701Z,1533054475.701 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-07-31T16:27:55.721Z,1533054475.721 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-07-31T16:27:55.721Z,1533054475.721 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-07-31T16:27:55.913Z,1533054475.913 [AHRS_M2](INFO): Starting
2018-07-31T16:27:59.954Z,1533054479.954 [Radio_Surface](INFO): Powering down
2018-07-31T16:28:04.985Z,1533054484.985 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:04.987Z,1533054484.987 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:04.987Z,1533054484.987 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:05.298Z,1533054485.298 [CBIT](INFO): Critical error at 20180731T162755
2018-07-31T16:28:05.309Z,1533054485.309 [AHRS_M2](INFO): Starting
2018-07-31T16:28:05.386Z,1533054485.386 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:05.388Z,1533054485.388 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:05.401Z,1533054485.401 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:05.710Z,1533054485.710 [AHRS_M2](INFO): Starting
2018-07-31T16:28:05.809Z,1533054485.809 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:05.810Z,1533054485.810 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:05.811Z,1533054485.811 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:06.053Z,1533054486.053 [Radio_Surface](INFO): Powering up
2018-07-31T16:28:06.229Z,1533054486.229 [Aanderaa_O2](INFO): Powering down
2018-07-31T16:28:06.297Z,1533054486.297 [AHRS_M2](INFO): Starting
2018-07-31T16:28:06.338Z,1533054486.338 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004018
2018-07-31T16:28:06.455Z,1533054486.455 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:06.456Z,1533054486.456 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:06.458Z,1533054486.458 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:06.510Z,1533054486.510 [AHRS_M2](INFO): Starting
2018-07-31T16:28:06.570Z,1533054486.570 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:06.572Z,1533054486.572 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:06.572Z,1533054486.572 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:06.910Z,1533054486.910 [AHRS_M2](INFO): Starting
2018-07-31T16:28:07.049Z,1533054487.049 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2018-07-31T16:28:07.077Z,1533054487.077 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:07.078Z,1533054487.078 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:07.079Z,1533054487.079 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:07.310Z,1533054487.310 [AHRS_M2](INFO): Starting
2018-07-31T16:28:07.637Z,1533054487.637 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2018-07-31T16:28:07.671Z,1533054487.671 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:07.672Z,1533054487.672 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:07.677Z,1533054487.677 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:07.876Z,1533054487.876 [AHRS_M2](INFO): Starting
2018-07-31T16:28:08.201Z,1533054488.201 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2018-07-31T16:28:08.248Z,1533054488.248 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:08.257Z,1533054488.257 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:08.258Z,1533054488.258 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:08.821Z,1533054488.821 [AHRS_M2](INFO): Starting
2018-07-31T16:28:09.141Z,1533054489.141 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2018-07-31T16:28:09.164Z,1533054489.164 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2018-07-31T16:28:09.175Z,1533054489.175 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:09.176Z,1533054489.176 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:09.185Z,1533054489.185 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:09.249Z,1533054489.249 [AHRS_M2](INFO): Starting
2018-07-31T16:28:09.574Z,1533054489.574 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:09.575Z,1533054489.575 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:09.576Z,1533054489.576 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:09.657Z,1533054489.657 [AHRS_M2](INFO): Starting
2018-07-31T16:28:09.747Z,1533054489.747 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:09.748Z,1533054489.748 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:09.749Z,1533054489.749 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.050Z,1533054490.050 [AHRS_M2](INFO): Starting
2018-07-31T16:28:10.107Z,1533054490.107 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.108Z,1533054490.108 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.129Z,1533054490.129 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.450Z,1533054490.450 [AHRS_M2](INFO): Starting
2018-07-31T16:28:10.534Z,1533054490.534 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.535Z,1533054490.535 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.536Z,1533054490.536 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.851Z,1533054490.851 [AHRS_M2](INFO): Starting
2018-07-31T16:28:10.906Z,1533054490.906 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.907Z,1533054490.907 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:10.908Z,1533054490.908 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:11.250Z,1533054491.250 [AHRS_M2](INFO): Starting
2018-07-31T16:28:11.347Z,1533054491.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:11.356Z,1533054491.356 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:11.357Z,1533054491.357 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:11.650Z,1533054491.650 [AHRS_M2](INFO): Starting
2018-07-31T16:28:11.707Z,1533054491.707 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:11.708Z,1533054491.708 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:11.721Z,1533054491.721 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:12.050Z,1533054492.050 [AHRS_M2](INFO): Starting
2018-07-31T16:28:12.082Z,1533054492.082 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:12.083Z,1533054492.083 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:12.084Z,1533054492.084 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:12.450Z,1533054492.450 [AHRS_M2](INFO): Starting
2018-07-31T16:28:12.524Z,1533054492.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:12.533Z,1533054492.533 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:12.534Z,1533054492.534 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-07-31T16:28:16.451Z,1533054496.451 [AHRS_M2](ERROR): SAPP frame error: SOH not found.
2018-07-31T16:28:18.097Z,1533054498.097 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2018-07-31T16:28:18.098Z,1533054498.098 [RDI_Pathfinder](ERROR): Failed to parse:
:BD, +0.00, +0
2018-07-31T16:28:18.911Z,1533054498.911 [SBIT](IMPORTANT): Beginning Startup BIT
2018-07-31T16:28:18.916Z,1533054498.916 [CBIT](IMPORTANT): Beginning ground fault scan
2018-07-31T16:28:21.782Z,1533054501.782 [NAL9602](INFO): Powering up NAL9602
2018-07-31T16:28:29.904Z,1533054509.904 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008765
CHAN A1 (24V): -0.012800
CHAN A2 (12V): -0.007139
CHAN A3 (5V): -0.001893
CHAN B0 (3.3V): 0.000384
CHAN B1 (3.15aV): 0.000242
CHAN B2 (3.15bV): -0.000142
CHAN B3 (GND): 0.002281
OPEN: 0.004938
Full Scale Calc: 4.765 mA, -1.589 mA
2018-07-31T16:28:32.982Z,1533054512.982 [NAL9602](INFO): NAL9602 initialized
2018-07-31T16:28:52.085Z,1533054532.085 [CommandLine](IMPORTANT): got command get platform_orientation degree
2018-07-31T16:28:52.086Z,1533054532.086 [CommandLine](IMPORTANT): platform_orientation 333.608077 arcdeg
2018-07-31T16:28:52.388Z,1533054532.388 [AHRS_M2](ERROR): SAPP frame error: SOH not found.
2018-07-31T16:29:15.209Z,1533054555.209 [SBIT](IMPORTANT): SBIT PASSED
2018-07-31T16:29:15.285Z,1533054555.285 [CommandLine](IMPORTANT): got command configSet list
2018-07-31T16:29:15.285Z,1533054555.285 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-07-31T16:29:15.286Z,1533054555.286 [CommandLine](IMPORTANT): AHRS_M2.readAccelerations=1 bool;
2018-07-31T16:29:15.286Z,1533054555.286 [CommandLine](IMPORTANT): AHRS_M2.readMagnetics=1 bool;
2018-07-31T16:29:15.287Z,1533054555.287 [CommandLine](IMPORTANT): DeadReckonWithRespectToSeafloor.loadAtStartup=1 bool;
2018-07-31T16:29:15.287Z,1533054555.287 [CommandLine](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;
2018-07-31T16:29:15.287Z,1533054555.287 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=160 cubic_centimeter;
2018-07-31T16:29:15.287Z,1533054555.287 [CommandLine](IMPORTANT): VerticalControl.massDefault=-1 millimeter;
2018-07-31T16:29:15.631Z,1533054555.631 [MissionManager](IMPORTANT): Started mission Startup
2018-07-31T16:29:15.632Z,1533054555.632 [Startup] Running Loop=1
2018-07-31T16:29:15.632Z,1533054555.632 [Startup](DEBUG): Aggregate::initialize Startup
2018-07-31T16:29:15.632Z,1533054555.632 [Startup:A.GoToSurface] Running Loop=1
2018-07-31T16:29:15.632Z,1533054555.632 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-07-31T16:29:15.637Z,1533054555.637 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-07-31T16:29:15.637Z,1533054555.637 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-07-31T16:29:15.638Z,1533054555.638 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-07-31T16:29:15.638Z,1533054555.638 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-07-31T16:29:15.638Z,1533054555.638 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-07-31T16:29:15.649Z,1533054555.649 [Startup:StartupSatComms] Running Loop=1
2018-07-31T16:29:15.649Z,1533054555.649 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-07-31T16:29:15.649Z,1533054555.649 [Startup:StartupSatComms:A] Running Loop=1
2018-07-31T16:29:15.979Z,1533054555.979 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-07-31T16:29:36.223Z,1533054576.223 [CommandLine](IMPORTANT): got command configSet AHRS_M2.readMagnetics 0.000000 bool
2018-07-31T16:29:36.394Z,1533054576.394 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.407630 seconds old.
2018-07-31T16:29:36.396Z,1533054576.396 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.407997 seconds old.
2018-07-31T16:29:36.397Z,1533054576.397 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.408652 seconds old.
2018-07-31T16:29:36.738Z,1533054576.738 [AHRS_M2](INFO): Starting
2018-07-31T16:29:36.837Z,1533054576.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.850074 seconds old.
2018-07-31T16:29:36.838Z,1533054576.838 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.850490 seconds old.
2018-07-31T16:29:36.839Z,1533054576.839 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.850844 seconds old.
2018-07-31T16:29:37.138Z,1533054577.138 [AHRS_M2](INFO): Starting
2018-07-31T16:29:37.234Z,1533054577.234 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.246892 seconds old.
2018-07-31T16:29:37.235Z,1533054577.235 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.247231 seconds old.
2018-07-31T16:29:37.236Z,1533054577.236 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 1.247559 seconds old.
2018-07-31T16:29:37.538Z,1533054577.538 [AHRS_M2](INFO): Starting
2018-07-31T16:29:37.620Z,1533054577.620 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.633042 seconds old.
2018-07-31T16:29:37.639Z,1533054577.639 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.651704 seconds old.
2018-07-31T16:29:37.641Z,1533054577.641 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 1.652153 seconds old.
2018-07-31T16:29:37.938Z,1533054577.938 [AHRS_M2](INFO): Starting
2018-07-31T16:29:38.057Z,1533054578.057 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.070561 seconds old.
2018-07-31T16:29:38.059Z,1533054578.059 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.070916 seconds old.
2018-07-31T16:29:38.060Z,1533054578.060 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 2.071245 seconds old.
2018-07-31T16:29:38.342Z,1533054578.342 [AHRS_M2](INFO): Starting
2018-07-31T16:29:38.440Z,1533054578.440 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.453520 seconds old.
2018-07-31T16:29:38.442Z,1533054578.442 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.454097 seconds old.
2018-07-31T16:29:38.443Z,1533054578.443 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 2.454438 seconds old.
2018-07-31T16:29:38.738Z,1533054578.738 [AHRS_M2](INFO): Starting
2018-07-31T16:29:38.813Z,1533054578.813 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.825711 seconds old.
2018-07-31T16:29:38.814Z,1533054578.814 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.826155 seconds old.
2018-07-31T16:29:38.815Z,1533054578.815 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 2.826494 seconds old.
2018-07-31T16:29:39.138Z,1533054579.138 [AHRS_M2](INFO): Starting
2018-07-31T16:29:39.209Z,1533054579.209 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.222672 seconds old.
2018-07-31T16:29:39.211Z,1533054579.211 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.223030 seconds old.
2018-07-31T16:29:39.212Z,1533054579.212 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 3.223364 seconds old.
2018-07-31T16:29:39.538Z,1533054579.538 [AHRS_M2](INFO): Starting
2018-07-31T16:29:39.598Z,1533054579.598 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.611355 seconds old.
2018-07-31T16:29:39.599Z,1533054579.599 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.611703 seconds old.
2018-07-31T16:29:39.601Z,1533054579.601 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 3.612194 seconds old.
2018-07-31T16:29:39.938Z,1533054579.938 [AHRS_M2](INFO): Starting
2018-07-31T16:29:40.005Z,1533054580.005 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.018596 seconds old.
2018-07-31T16:29:40.007Z,1533054580.007 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.018949 seconds old.
2018-07-31T16:29:40.008Z,1533054580.008 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 4.019319 seconds old.
2018-07-31T16:29:40.342Z,1533054580.342 [AHRS_M2](INFO): Starting
2018-07-31T16:29:40.412Z,1533054580.412 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.421534 seconds old.
2018-07-31T16:29:40.414Z,1533054580.414 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.426121 seconds old.
2018-07-31T16:29:40.415Z,1533054580.415 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 4.426483 seconds old.
2018-07-31T16:29:40.738Z,1533054580.738 [AHRS_M2](INFO): Starting
2018-07-31T16:29:40.788Z,1533054580.788 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.800928 seconds old.
2018-07-31T16:29:40.789Z,1533054580.789 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.801487 seconds old.
2018-07-31T16:29:40.790Z,1533054580.790 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 4.801840 seconds old.
2018-07-31T16:29:41.138Z,1533054581.138 [AHRS_M2](INFO): Starting
2018-07-31T16:29:52.981Z,1533054592.981 [CommandLine](IMPORTANT): got command failComponent
2018-07-31T16:29:52.982Z,1533054592.982 [CommandLine](IMPORTANT): Failed components:
2018-07-31T16:29:52.982Z,1533054592.982 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2018-07-31T16:30:15.959Z,1533054615.959 [Startup:StartupSatComms:A](INFO): Timed out from 2018-07-31T16:29:15.6Z
2018-07-31T16:30:15.959Z,1533054615.959 [Startup:StartupSatComms:A] Stopped
2018-07-31T16:30:15.959Z,1533054615.959 [Startup:StartupSatComms:B] Running Loop=1
2018-07-31T16:30:16.362Z,1533054616.362 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-07-31T16:30:17.983Z,1533054617.983 [CommandLine](IMPORTANT): got command configSet AHRS_M2.readAccelerations 0.000000 bool
2018-07-31T16:30:20.476Z,1533054620.476 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180730T215057/Courier0015.lzma
2018-07-31T16:30:20.574Z,1533054620.574 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.130813 seconds old.
2018-07-31T16:30:20.576Z,1533054620.576 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.131256 seconds old.
2018-07-31T16:30:20.577Z,1533054620.577 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.130813 seconds old.
2018-07-31T16:30:20.870Z,1533054620.870 [AHRS_M2](INFO): Starting
2018-07-31T16:30:20.974Z,1533054620.974 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.530191 seconds old.
2018-07-31T16:30:20.975Z,1533054620.975 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.530619 seconds old.
2018-07-31T16:30:20.976Z,1533054620.976 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.530004 seconds old.
2018-07-31T16:30:21.270Z,1533054621.270 [AHRS_M2](INFO): Starting
2018-07-31T16:30:21.303Z,1533054621.303 [DataOverHttps](INFO): Moved sent file to Logs/20180730T215057/Courier0015.lzma.bak
2018-07-31T16:30:21.304Z,1533054621.304 [DataOverHttps](INFO): SBD MOMSN=8388044
2018-07-31T16:30:21.402Z,1533054621.402 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.958362 seconds old.
2018-07-31T16:30:21.404Z,1533054621.404 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.958807 seconds old.
2018-07-31T16:30:21.417Z,1533054621.417 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.970921 seconds old.
2018-07-31T16:30:21.670Z,1533054621.670 [AHRS_M2](INFO): Starting
2018-07-31T16:30:21.769Z,1533054621.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.325666 seconds old.
2018-07-31T16:30:21.770Z,1533054621.770 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.326096 seconds old.
2018-07-31T16:30:21.772Z,1533054621.772 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 1.325479 seconds old.
2018-07-31T16:30:22.070Z,1533054622.070 [AHRS_M2](INFO): Starting
2018-07-31T16:30:22.170Z,1533054622.170 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.726501 seconds old.
2018-07-31T16:30:22.171Z,1533054622.171 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.726938 seconds old.
2018-07-31T16:30:22.173Z,1533054622.173 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 1.726290 seconds old.
2018-07-31T16:30:22.470Z,1533054622.470 [AHRS_M2](INFO): Starting
2018-07-31T16:30:25.974Z,1533054625.974 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.530077 seconds old.
2018-07-31T16:30:25.975Z,1533054625.975 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.530528 seconds old.
2018-07-31T16:30:25.976Z,1533054625.976 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 5.529898 seconds old.
2018-07-31T16:30:26.041Z,1533054626.041 [AHRS_M2](INFO): Starting
2018-07-31T16:30:26.170Z,1533054626.170 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.726542 seconds old.
2018-07-31T16:30:26.171Z,1533054626.171 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.726969 seconds old.
2018-07-31T16:30:26.181Z,1533054626.181 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 5.726322 seconds old.
2018-07-31T16:30:26.432Z,1533054626.432 [AHRS_M2](INFO): Starting
2018-07-31T16:30:26.518Z,1533054626.518 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.074842 seconds old.
2018-07-31T16:30:26.520Z,1533054626.520 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.075273 seconds old.
2018-07-31T16:30:26.522Z,1533054626.522 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 6.075727 seconds old.
2018-07-31T16:30:26.832Z,1533054626.832 [AHRS_M2](INFO): Starting
2018-07-31T16:30:26.922Z,1533054626.922 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.478178 seconds old.
2018-07-31T16:30:26.923Z,1533054626.923 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.478630 seconds old.
2018-07-31T16:30:26.924Z,1533054626.924 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 6.477996 seconds old.
2018-07-31T16:30:27.233Z,1533054627.233 [AHRS_M2](INFO): Starting
2018-07-31T16:30:27.266Z,1533054627.266 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.822571 seconds old.
2018-07-31T16:30:27.267Z,1533054627.267 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.822996 seconds old.
2018-07-31T16:30:27.269Z,1533054627.269 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 6.822342 seconds old.
2018-07-31T16:30:27.633Z,1533054627.633 [AHRS_M2](INFO): Starting
2018-07-31T16:30:32.382Z,1533054632.382 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20180731T162744/Courier0000.lzma
2018-07-31T16:30:33.167Z,1533054633.167 [DataOverHttps](INFO): Moved sent file to Logs/20180731T162744/Courier0000.lzma.bak
2018-07-31T16:30:33.167Z,1533054633.167 [DataOverHttps](INFO): SBD MOMSN=8388046
2018-07-31T16:30:42.209Z,1533054642.209 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20180730T215057/Express0016.lzma
2018-07-31T16:30:42.966Z,1533054642.966 [DataOverHttps](INFO): Moved sent file to Logs/20180730T215057/Express0016.lzma.bak
2018-07-31T16:30:42.966Z,1533054642.966 [DataOverHttps](INFO): SBD MOMSN=8388051
2018-07-31T16:30:52.907Z,1533054652.907 [DataOverHttps](INFO): Sending 911 bytes from file Logs/20180731T162744/Express0001.lzma
2018-07-31T16:30:53.042Z,1533054653.042 [CommandLine](IMPORTANT): got command configSet AHRS_M2.readMagnetics 1.000000 bool
2018-07-31T16:30:53.371Z,1533054653.371 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.352408 seconds old.
2018-07-31T16:30:53.377Z,1533054653.377 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.356989 seconds old.
2018-07-31T16:30:53.378Z,1533054653.378 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.356820 seconds old.
2018-07-31T16:30:53.698Z,1533054653.698 [AHRS_M2](INFO): Starting
2018-07-31T16:30:53.750Z,1533054653.750 [DataOverHttps](INFO): Moved sent file to Logs/20180731T162744/Express0001.lzma.bak
2018-07-31T16:30:53.751Z,1533054653.751 [DataOverHttps](INFO): SBD MOMSN=8388056
2018-07-31T16:30:53.877Z,1533054653.877 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.858440 seconds old.
2018-07-31T16:30:53.879Z,1533054653.879 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.859561 seconds old.
2018-07-31T16:30:53.881Z,1533054653.881 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.859499 seconds old.
2018-07-31T16:30:54.098Z,1533054654.098 [AHRS_M2](INFO): Starting
2018-07-31T16:30:54.222Z,1533054654.222 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.202690 seconds old.
2018-07-31T16:30:54.223Z,1533054654.223 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.203081 seconds old.
2018-07-31T16:30:54.224Z,1533054654.224 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 1.202851 seconds old.
2018-07-31T16:30:54.227Z,1533054654.227 [Startup:StartupSatComms:B] Stopped
2018-07-31T16:30:54.227Z,1533054654.227 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-07-31T16:30:54.227Z,1533054654.227 [Startup:StartupSatComms] Stopped
2018-07-31T16:30:54.227Z,1533054654.227 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-07-31T16:30:54.229Z,1533054654.229 [Startup](INFO): Completed Startup
2018-07-31T16:30:54.229Z,1533054654.229 [MissionManager](INFO): Startup is completed.
2018-07-31T16:30:54.229Z,1533054654.229 [MissionManager](INFO): Uninitializing Mission Startup
2018-07-31T16:30:54.229Z,1533054654.229 [Startup] Stopped
2018-07-31T16:30:54.229Z,1533054654.229 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-07-31T16:30:54.229Z,1533054654.229 [Startup:A.GoToSurface] Stopped
2018-07-31T16:30:54.229Z,1533054654.229 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-07-31T16:30:54.499Z,1533054654.499 [AHRS_M2](INFO): Starting
2018-07-31T16:30:54.578Z,1533054654.578 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.558893 seconds old.
2018-07-31T16:30:54.579Z,1533054654.579 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:30:54.579Z,1533054654.579 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2018-07-31T16:30:54.579Z,1533054654.579 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-07-31T16:30:54.581Z,1533054654.581 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.560529 seconds old.
2018-07-31T16:30:54.582Z,1533054654.582 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:30:54.582Z,1533054654.582 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-07-31T16:30:54.582Z,1533054654.582 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-07-31T16:30:54.583Z,1533054654.583 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 1.561741 seconds old.
2018-07-31T16:30:54.584Z,1533054654.584 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:30:54.584Z,1533054654.584 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2018-07-31T16:30:54.584Z,1533054654.584 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-07-31T16:30:54.586Z,1533054654.586 [MissionManager](IMPORTANT): Started mission Default
2018-07-31T16:30:54.587Z,1533054654.587 [Default] Running Loop=1
2018-07-31T16:30:54.587Z,1533054654.587 [Default](DEBUG): Aggregate::initialize Default
2018-07-31T16:30:54.587Z,1533054654.587 [Default:B.GoToSurface] Running Loop=1
2018-07-31T16:30:54.587Z,1533054654.587 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-07-31T16:30:54.587Z,1533054654.587 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-07-31T16:30:54.588Z,1533054654.588 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-07-31T16:30:54.588Z,1533054654.588 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-07-31T16:30:54.588Z,1533054654.588 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-07-31T16:30:54.589Z,1533054654.589 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-07-31T16:30:54.589Z,1533054654.589 [Default:A.Wait] Running Loop=1
2018-07-31T16:30:54.589Z,1533054654.589 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-07-31T16:30:54.648Z,1533054654.648 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-07-31T16:30:54.648Z,1533054654.648 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-07-31T16:30:54.653Z,1533054654.653 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-07-31T16:30:54.898Z,1533054654.898 [AHRS_M2](INFO): Starting
2018-07-31T16:30:57.803Z,1533054657.803 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-07-31T16:30:57.803Z,1533054657.803 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2018-07-31T16:30:57.804Z,1533054657.804 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-07-31T16:30:57.804Z,1533054657.804 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-07-31T16:30:57.805Z,1533054657.805 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-07-31T16:30:57.805Z,1533054657.805 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2018-07-31T16:30:57.812Z,1533054657.812 [AHRS_M2](INFO): Starting
2018-07-31T16:30:57.938Z,1533054657.938 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-07-31T16:30:57.938Z,1533054657.938 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:30:57.939Z,1533054657.939 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:30:57.939Z,1533054657.939 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-07-31T16:30:57.940Z,1533054657.940 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:30:57.940Z,1533054657.940 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:30:57.941Z,1533054657.941 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-07-31T16:30:57.941Z,1533054657.941 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:30:57.941Z,1533054657.941 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:30:58.215Z,1533054658.215 [AHRS_M2](INFO): Starting
2018-07-31T16:30:58.309Z,1533054658.309 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.290012 seconds old.
2018-07-31T16:30:58.310Z,1533054658.310 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.7 s old, using for 20.0 s.
2018-07-31T16:30:58.311Z,1533054658.311 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.290929 seconds old.
2018-07-31T16:30:58.312Z,1533054658.312 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 5.290691 seconds old.
2018-07-31T16:30:58.614Z,1533054658.614 [AHRS_M2](INFO): Starting
2018-07-31T16:30:58.730Z,1533054658.730 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.711322 seconds old.
2018-07-31T16:30:58.731Z,1533054658.731 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.2 s old, using for 20.0 s.
2018-07-31T16:30:58.732Z,1533054658.732 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.712216 seconds old.
2018-07-31T16:30:58.761Z,1533054658.761 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 5.740175 seconds old.
2018-07-31T16:30:59.014Z,1533054659.014 [AHRS_M2](INFO): Starting
2018-07-31T16:30:59.086Z,1533054659.086 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.067015 seconds old.
2018-07-31T16:30:59.086Z,1533054659.086 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.5 s old, using for 20.0 s.
2018-07-31T16:30:59.088Z,1533054659.088 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.067896 seconds old.
2018-07-31T16:30:59.090Z,1533054659.090 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 6.068705 seconds old.
2018-07-31T16:30:59.414Z,1533054659.414 [AHRS_M2](INFO): Starting
2018-07-31T16:30:59.480Z,1533054659.480 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.461211 seconds old.
2018-07-31T16:30:59.481Z,1533054659.481 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.9 s old, using for 20.0 s.
2018-07-31T16:30:59.482Z,1533054659.482 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.462331 seconds old.
2018-07-31T16:30:59.483Z,1533054659.483 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 6.462080 seconds old.
2018-07-31T16:30:59.814Z,1533054659.814 [AHRS_M2](INFO): Starting
2018-07-31T16:30:59.881Z,1533054659.881 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.862401 seconds old.
2018-07-31T16:30:59.882Z,1533054659.882 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.3 s old, using for 20.0 s.
2018-07-31T16:30:59.883Z,1533054659.883 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.863292 seconds old.
2018-07-31T16:30:59.884Z,1533054659.884 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 6.863047 seconds old.
2018-07-31T16:31:00.214Z,1533054660.214 [AHRS_M2](INFO): Starting
2018-07-31T16:31:00.291Z,1533054660.291 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.7 s old, using for 20.0 s.
2018-07-31T16:31:00.678Z,1533054660.678 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.1 s old, using for 20.0 s.
2018-07-31T16:31:01.065Z,1533054661.065 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.5 s old, using for 20.0 s.
2018-07-31T16:31:01.479Z,1533054661.479 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.9 s old, using for 20.0 s.
2018-07-31T16:31:01.863Z,1533054661.863 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.3 s old, using for 20.0 s.
2018-07-31T16:31:02.269Z,1533054662.269 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.7 s old, using for 20.0 s.
2018-07-31T16:31:02.697Z,1533054662.697 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.1 s old, using for 20.0 s.
2018-07-31T16:31:03.076Z,1533054663.076 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.5 s old, using for 20.0 s.
2018-07-31T16:31:03.496Z,1533054663.496 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.9 s old, using for 20.0 s.
2018-07-31T16:31:03.883Z,1533054663.883 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.3 s old, using for 20.0 s.
2018-07-31T16:31:04.277Z,1533054664.277 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.7 s old, using for 20.0 s.
2018-07-31T16:31:04.698Z,1533054664.698 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.1 s old, using for 20.0 s.
2018-07-31T16:31:05.082Z,1533054665.082 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.5 s old, using for 20.0 s.
2018-07-31T16:31:05.471Z,1533054665.471 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.9 s old, using for 20.0 s.
2018-07-31T16:31:05.883Z,1533054665.883 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.3 s old, using for 20.0 s.
2018-07-31T16:31:06.275Z,1533054666.275 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.7 s old, using for 20.0 s.
2018-07-31T16:31:06.688Z,1533054666.688 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.1 s old, using for 20.0 s.
2018-07-31T16:31:07.095Z,1533054667.095 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.5 s old, using for 20.0 s.
2018-07-31T16:31:07.501Z,1533054667.501 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.9 s old, using for 20.0 s.
2018-07-31T16:31:07.911Z,1533054667.911 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.3 s old, using for 20.0 s.
2018-07-31T16:31:07.915Z,1533054667.915 [Default:A.Wait](INFO): Done Waiting.
2018-07-31T16:31:07.916Z,1533054667.916 [Default:A.Wait] Stopped
2018-07-31T16:31:07.916Z,1533054667.916 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-07-31T16:31:08.275Z,1533054668.275 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.7 s old, using for 20.0 s.
2018-07-31T16:31:08.284Z,1533054668.284 [Default:CheckIn] Running Loop=1
2018-07-31T16:31:08.284Z,1533054668.284 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-07-31T16:31:08.284Z,1533054668.284 [Default:CheckIn:Read_GPS] Running Loop=1
2018-07-31T16:31:08.728Z,1533054668.728 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.1 s old, using for 20.0 s.
2018-07-31T16:31:08.745Z,1533054668.745 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-07-31T16:31:09.083Z,1533054669.083 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.5 s old, using for 20.0 s.
2018-07-31T16:31:09.492Z,1533054669.492 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.9 s old, using for 20.0 s.
2018-07-31T16:31:09.901Z,1533054669.901 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.3 s old, using for 20.0 s.
2018-07-31T16:31:10.276Z,1533054670.276 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.7 s old, using for 20.0 s.
2018-07-31T16:31:10.681Z,1533054670.681 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.1 s old, using for 20.0 s.
2018-07-31T16:31:11.053Z,1533054671.053 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.5 s old, using for 20.0 s.
2018-07-31T16:31:11.460Z,1533054671.460 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.9 s old, using for 20.0 s.
2018-07-31T16:31:11.863Z,1533054671.863 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.3 s old, using for 20.0 s.
2018-07-31T16:31:12.263Z,1533054672.263 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.7 s old, using for 20.0 s.
2018-07-31T16:31:12.699Z,1533054672.699 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.1 s old, using for 20.0 s.
2018-07-31T16:31:13.074Z,1533054673.074 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.5 s old, using for 20.0 s.
2018-07-31T16:31:13.488Z,1533054673.488 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.9 s old, using for 20.0 s.
2018-07-31T16:31:13.873Z,1533054673.873 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.3 s old, using for 20.0 s.
2018-07-31T16:31:14.275Z,1533054674.275 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.7 s old, using for 20.0 s.
2018-07-31T16:31:17.815Z,1533054677.815 [AHRS_M2](ERROR): SAPP frame error: SOH not found.
2018-07-31T16:31:23.883Z,1533054683.883 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 2.000000 count
2018-07-31T16:31:24.215Z,1533054684.215 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:24.216Z,1533054684.216 [AHRS_M2](INFO): Mx: -56.805733 uT, My: -23.860144 uT, Mz: -16.691444 uT
2018-07-31T16:31:24.217Z,1533054684.217 [AHRS_M2](INFO): PITCH: -1.785694 deg, ROLL: 11.327358 deg, YAW: 320.418599 deg, TEMP: 27.215422 C.
2018-07-31T16:31:24.616Z,1533054684.616 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:24.617Z,1533054684.617 [AHRS_M2](INFO): Mx: -56.865833 uT, My: -23.844128 uT, Mz: -16.670933 uT
2018-07-31T16:31:24.618Z,1533054684.618 [AHRS_M2](INFO): PITCH: -1.778188 deg, ROLL: 11.328954 deg, YAW: 320.438434 deg, TEMP: 27.203182 C.
2018-07-31T16:31:25.015Z,1533054685.015 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:25.016Z,1533054685.016 [AHRS_M2](INFO): Mx: -56.859627 uT, My: -23.855721 uT, Mz: -16.666468 uT
2018-07-31T16:31:25.017Z,1533054685.017 [AHRS_M2](INFO): PITCH: -1.783727 deg, ROLL: 11.327132 deg, YAW: 320.418408 deg, TEMP: 27.227663 C.
2018-07-31T16:31:25.415Z,1533054685.415 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:25.416Z,1533054685.416 [AHRS_M2](INFO): Mx: -56.899170 uT, My: -23.840303 uT, Mz: -16.674267 uT
2018-07-31T16:31:25.417Z,1533054685.417 [AHRS_M2](INFO): PITCH: -1.791817 deg, ROLL: 11.325996 deg, YAW: 320.401360 deg, TEMP: 27.218483 C.
2018-07-31T16:31:25.817Z,1533054685.817 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:25.817Z,1533054685.817 [AHRS_M2](INFO): Mx: -56.826202 uT, My: -23.859749 uT, Mz: -16.679008 uT
2018-07-31T16:31:25.818Z,1533054685.818 [AHRS_M2](INFO): PITCH: -1.792764 deg, ROLL: 11.326765 deg, YAW: 320.402180 deg, TEMP: 27.227663 C.
2018-07-31T16:31:26.215Z,1533054686.215 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:26.216Z,1533054686.216 [AHRS_M2](INFO): Mx: -56.818489 uT, My: -23.872728 uT, Mz: -16.671509 uT
2018-07-31T16:31:26.217Z,1533054686.217 [AHRS_M2](INFO): PITCH: -1.784333 deg, ROLL: 11.329441 deg, YAW: 320.426085 deg, TEMP: 27.206242 C.
2018-07-31T16:31:26.615Z,1533054686.615 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:26.615Z,1533054686.615 [AHRS_M2](ERROR): CRC does not match. Expected: 14276 got: 4487
2018-07-31T16:31:27.015Z,1533054687.015 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:27.016Z,1533054687.016 [AHRS_M2](INFO): Mx: -56.855736 uT, My: -23.868603 uT, Mz: -16.650787 uT
2018-07-31T16:31:27.018Z,1533054687.018 [AHRS_M2](INFO): PITCH: -1.780210 deg, ROLL: 11.330420 deg, YAW: 320.440647 deg, TEMP: 27.227663 C.
2018-07-31T16:31:27.415Z,1533054687.415 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:27.416Z,1533054687.416 [AHRS_M2](INFO): Mx: -56.855507 uT, My: -23.855892 uT, Mz: -16.674433 uT
2018-07-31T16:31:27.417Z,1533054687.417 [AHRS_M2](INFO): PITCH: -1.783888 deg, ROLL: 11.332209 deg, YAW: 320.435975 deg, TEMP: 27.224602 C.
2018-07-31T16:31:27.815Z,1533054687.815 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:27.816Z,1533054687.816 [AHRS_M2](INFO): Mx: -56.814056 uT, My: -23.847416 uT, Mz: -16.683176 uT
2018-07-31T16:31:27.817Z,1533054687.817 [AHRS_M2](INFO): PITCH: -1.780288 deg, ROLL: 11.326895 deg, YAW: 320.425703 deg, TEMP: 27.230722 C.
2018-07-31T16:31:28.215Z,1533054688.215 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:28.216Z,1533054688.216 [AHRS_M2](INFO): Mx: -56.847424 uT, My: -23.851717 uT, Mz: -16.654503 uT
2018-07-31T16:31:28.217Z,1533054688.217 [AHRS_M2](INFO): PITCH: -1.786761 deg, ROLL: 11.332811 deg, YAW: 320.428517 deg, TEMP: 27.233782 C.
2018-07-31T16:31:28.615Z,1533054688.615 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:28.616Z,1533054688.616 [AHRS_M2](INFO): Mx: -56.843102 uT, My: -23.818233 uT, Mz: -16.654329 uT
2018-07-31T16:31:28.617Z,1533054688.617 [AHRS_M2](INFO): PITCH: -1.786368 deg, ROLL: 11.325768 deg, YAW: 320.413490 deg, TEMP: 27.224602 C.
2018-07-31T16:31:29.015Z,1533054689.015 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:29.016Z,1533054689.016 [AHRS_M2](INFO): Mx: -56.854992 uT, My: -23.880680 uT, Mz: -16.694645 uT
2018-07-31T16:31:29.017Z,1533054689.017 [AHRS_M2](INFO): PITCH: -1.784444 deg, ROLL: 11.322351 deg, YAW: 320.403600 deg, TEMP: 27.239902 C.
2018-07-31T16:31:29.416Z,1533054689.416 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:29.417Z,1533054689.417 [AHRS_M2](INFO): Mx: -56.845959 uT, My: -23.897011 uT, Mz: -16.678812 uT
2018-07-31T16:31:29.418Z,1533054689.418 [AHRS_M2](INFO): PITCH: -1.786884 deg, ROLL: 11.326173 deg, YAW: 320.413354 deg, TEMP: 27.233782 C.
2018-07-31T16:31:29.815Z,1533054689.815 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:29.816Z,1533054689.816 [AHRS_M2](INFO): Mx: -56.846649 uT, My: -23.838974 uT, Mz: -16.654299 uT
2018-07-31T16:31:29.817Z,1533054689.817 [AHRS_M2](INFO): PITCH: -1.783202 deg, ROLL: 11.331367 deg, YAW: 320.433189 deg, TEMP: 27.224602 C.
2018-07-31T16:31:30.215Z,1533054690.215 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:30.216Z,1533054690.216 [AHRS_M2](INFO): Mx: -56.845562 uT, My: -23.871826 uT, Mz: -16.686306 uT
2018-07-31T16:31:30.217Z,1533054690.217 [AHRS_M2](INFO): PITCH: -1.791931 deg, ROLL: 11.320927 deg, YAW: 320.388109 deg, TEMP: 27.233782 C.
2018-07-31T16:31:30.616Z,1533054690.616 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:30.617Z,1533054690.617 [AHRS_M2](INFO): Mx: -56.805138 uT, My: -23.817822 uT, Mz: -16.654690 uT
2018-07-31T16:31:30.618Z,1533054690.618 [AHRS_M2](INFO): PITCH: -1.786149 deg, ROLL: 11.321178 deg, YAW: 320.396934 deg, TEMP: 27.233782 C.
2018-07-31T16:31:31.017Z,1533054691.017 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:31.018Z,1533054691.018 [AHRS_M2](INFO): Mx: -56.840740 uT, My: -23.858738 uT, Mz: -16.657986 uT
2018-07-31T16:31:31.019Z,1533054691.019 [AHRS_M2](INFO): PITCH: -1.786271 deg, ROLL: 11.319271 deg, YAW: 320.389994 deg, TEMP: 27.246021 C.
2018-07-31T16:31:31.415Z,1533054691.415 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:31.416Z,1533054691.416 [AHRS_M2](INFO): Mx: -56.842445 uT, My: -23.872002 uT, Mz: -16.666628 uT
2018-07-31T16:31:31.417Z,1533054691.417 [AHRS_M2](INFO): PITCH: -1.781155 deg, ROLL: 11.313584 deg, YAW: 320.386607 deg, TEMP: 27.239902 C.
2018-07-31T16:31:31.816Z,1533054691.816 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:31.816Z,1533054691.816 [AHRS_M2](INFO): Mx: -56.864044 uT, My: -23.818256 uT, Mz: -16.657978 uT
2018-07-31T16:31:31.818Z,1533054691.818 [AHRS_M2](INFO): PITCH: -1.792514 deg, ROLL: 11.319042 deg, YAW: 320.375487 deg, TEMP: 27.236843 C.
2018-07-31T16:31:32.215Z,1533054692.215 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:32.216Z,1533054692.216 [AHRS_M2](INFO): Mx: -56.822498 uT, My: -23.851564 uT, Mz: -16.655064 uT
2018-07-31T16:31:32.217Z,1533054692.217 [AHRS_M2](INFO): PITCH: -1.792250 deg, ROLL: 11.310844 deg, YAW: 320.348412 deg, TEMP: 27.242962 C.
2018-07-31T16:31:32.615Z,1533054692.615 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:32.616Z,1533054692.616 [AHRS_M2](INFO): Mx: -56.865540 uT, My: -23.829645 uT, Mz: -16.657125 uT
2018-07-31T16:31:32.617Z,1533054692.617 [AHRS_M2](INFO): PITCH: -1.798583 deg, ROLL: 11.316765 deg, YAW: 320.353931 deg, TEMP: 27.252142 C.
2018-07-31T16:31:33.016Z,1533054693.016 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:33.017Z,1533054693.017 [AHRS_M2](INFO): Mx: -56.816223 uT, My: -23.829576 uT, Mz: -16.677906 uT
2018-07-31T16:31:33.018Z,1533054693.018 [AHRS_M2](INFO): PITCH: -1.788157 deg, ROLL: 11.315804 deg, YAW: 320.372072 deg, TEMP: 27.236843 C.
2018-07-31T16:31:33.415Z,1533054693.415 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:33.416Z,1533054693.416 [AHRS_M2](INFO): Mx: -56.841927 uT, My: -23.846960 uT, Mz: -16.662218 uT
2018-07-31T16:31:33.417Z,1533054693.417 [AHRS_M2](INFO): PITCH: -1.784674 deg, ROLL: 11.319646 deg, YAW: 320.384448 deg, TEMP: 27.233782 C.
2018-07-31T16:31:33.815Z,1533054693.815 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:33.816Z,1533054693.816 [AHRS_M2](INFO): Mx: -56.871998 uT, My: -23.830706 uT, Mz: -16.625942 uT
2018-07-31T16:31:33.817Z,1533054693.817 [AHRS_M2](INFO): PITCH: -1.781132 deg, ROLL: 11.318811 deg, YAW: 320.389475 deg, TEMP: 27.242962 C.
2018-07-31T16:31:34.215Z,1533054694.215 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:34.218Z,1533054694.218 [AHRS_M2](INFO): Mx: -56.849274 uT, My: -23.842224 uT, Mz: -16.653664 uT
2018-07-31T16:31:34.221Z,1533054694.221 [AHRS_M2](INFO): PITCH: -1.773893 deg, ROLL: 11.318454 deg, YAW: 320.398710 deg, TEMP: 27.236843 C.
2018-07-31T16:31:34.615Z,1533054694.615 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:34.616Z,1533054694.616 [AHRS_M2](INFO): Mx: -56.796032 uT, My: -23.838392 uT, Mz: -16.678677 uT
2018-07-31T16:31:34.620Z,1533054694.620 [AHRS_M2](INFO): PITCH: -1.782926 deg, ROLL: 11.318166 deg, YAW: 320.384558 deg, TEMP: 27.224602 C.
2018-07-31T16:31:35.015Z,1533054695.015 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:35.018Z,1533054695.018 [AHRS_M2](INFO): Mx: -56.833961 uT, My: -23.809526 uT, Mz: -16.693867 uT
2018-07-31T16:31:35.020Z,1533054695.020 [AHRS_M2](INFO): PITCH: -1.783673 deg, ROLL: 11.314564 deg, YAW: 320.381990 deg, TEMP: 27.258263 C.
2018-07-31T16:31:35.422Z,1533054695.422 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:35.423Z,1533054695.423 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 1.
2018-07-31T16:31:35.424Z,1533054695.424 [AHRS_M2](INFO): Mx: -56.862785 uT, My: -23.847179 uT, Mz: -16.626163 uT
2018-07-31T16:31:35.426Z,1533054695.426 [AHRS_M2](INFO): PITCH: -1.780831 deg, ROLL: 11.316529 deg, YAW: 320.397672 deg, TEMP: 27.252142 C.
2018-07-31T16:31:36.217Z,1533054696.217 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:36.219Z,1533054696.219 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 1.
2018-07-31T16:31:36.219Z,1533054696.219 [AHRS_M2](INFO): Mx: -56.889294 uT, My: -23.805971 uT, Mz: -16.653488 uT
2018-07-31T16:31:36.221Z,1533054696.221 [AHRS_M2](INFO): PITCH: -1.779937 deg, ROLL: 11.321553 deg, YAW: 320.408600 deg, TEMP: 27.239902 C.
2018-07-31T16:31:36.618Z,1533054696.618 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:36.619Z,1533054696.619 [AHRS_M2](INFO): Mx: -56.841206 uT, My: -23.830034 uT, Mz: -16.669888 uT
2018-07-31T16:31:36.620Z,1533054696.620 [AHRS_M2](INFO): PITCH: -1.786815 deg, ROLL: 11.322938 deg, YAW: 320.402781 deg, TEMP: 27.255201 C.
2018-07-31T16:31:37.017Z,1533054697.017 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:37.018Z,1533054697.018 [AHRS_M2](INFO): Mx: -56.856453 uT, My: -23.835400 uT, Mz: -16.666620 uT
2018-07-31T16:31:37.019Z,1533054697.019 [AHRS_M2](INFO): PITCH: -1.786340 deg, ROLL: 11.321345 deg, YAW: 320.398163 deg, TEMP: 27.255201 C.
2018-07-31T16:31:37.417Z,1533054697.417 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:37.418Z,1533054697.418 [AHRS_M2](INFO): Mx: -56.853333 uT, My: -23.834246 uT, Mz: -16.697430 uT
2018-07-31T16:31:37.419Z,1533054697.419 [AHRS_M2](INFO): PITCH: -1.789076 deg, ROLL: 11.324428 deg, YAW: 320.399393 deg, TEMP: 27.252142 C.
2018-07-31T16:31:37.818Z,1533054697.818 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:31:37.819Z,1533054697.819 [AHRS_M2](INFO): Mx: -56.855186 uT, My: -23.858120 uT, Mz: -16.685127 uT
2018-07-31T16:31:37.820Z,1533054697.820 [AHRS_M2](INFO): PITCH: -1.782901 deg, ROLL: 11.329744 deg, YAW: 320.422670 deg, TEMP: 27.276623 C.
2018-07-31T16:31:37.942Z,1533054697.942 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 1.000000 count
2018-07-31T16:31:48.758Z,1533054708.758 [CommandLine](IMPORTANT): got command configSet AHRS_M2.readAccelerations 1.000000 bool
2018-07-31T16:31:49.058Z,1533054709.058 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.371714 seconds old.
2018-07-31T16:31:49.060Z,1533054709.060 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.372175 seconds old.
2018-07-31T16:31:49.061Z,1533054709.061 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.372724 seconds old.
2018-07-31T16:31:49.414Z,1533054709.414 [AHRS_M2](INFO): Starting
2018-07-31T16:31:49.519Z,1533054709.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.832332 seconds old.
2018-07-31T16:31:49.520Z,1533054709.520 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.832691 seconds old.
2018-07-31T16:31:49.522Z,1533054709.522 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 0.833276 seconds old.
2018-07-31T16:31:49.814Z,1533054709.814 [AHRS_M2](INFO): Starting
2018-07-31T16:31:49.894Z,1533054709.894 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.207192 seconds old.
2018-07-31T16:31:49.895Z,1533054709.895 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.207549 seconds old.
2018-07-31T16:31:49.896Z,1533054709.896 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 1.207889 seconds old.
2018-07-31T16:31:50.214Z,1533054710.214 [AHRS_M2](INFO): Starting
2018-07-31T16:31:50.299Z,1533054710.299 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.612673 seconds old.
2018-07-31T16:31:50.301Z,1533054710.301 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.613027 seconds old.
2018-07-31T16:31:50.302Z,1533054710.302 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 1.613450 seconds old.
2018-07-31T16:31:50.614Z,1533054710.614 [AHRS_M2](INFO): Starting
2018-07-31T16:31:50.723Z,1533054710.723 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.036191 seconds old.
2018-07-31T16:31:50.724Z,1533054710.724 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.036542 seconds old.
2018-07-31T16:31:50.725Z,1533054710.725 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 2.037090 seconds old.
2018-07-31T16:31:51.014Z,1533054711.014 [AHRS_M2](INFO): Starting
2018-07-31T16:31:51.082Z,1533054711.082 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.395515 seconds old.
2018-07-31T16:31:51.083Z,1533054711.083 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.395868 seconds old.
2018-07-31T16:31:51.103Z,1533054711.103 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 2.396195 seconds old.
2018-07-31T16:31:51.414Z,1533054711.414 [AHRS_M2](INFO): Starting
2018-07-31T16:31:51.510Z,1533054711.510 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.823641 seconds old.
2018-07-31T16:31:51.511Z,1533054711.511 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.824001 seconds old.
2018-07-31T16:31:51.513Z,1533054711.513 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 2.824408 seconds old.
2018-07-31T16:31:51.814Z,1533054711.814 [AHRS_M2](INFO): Starting
2018-07-31T16:31:51.883Z,1533054711.883 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.196538 seconds old.
2018-07-31T16:31:51.901Z,1533054711.901 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.196893 seconds old.
2018-07-31T16:31:51.902Z,1533054711.902 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 3.213514 seconds old.
2018-07-31T16:31:52.214Z,1533054712.214 [AHRS_M2](INFO): Starting
2018-07-31T16:31:52.278Z,1533054712.278 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.591467 seconds old.
2018-07-31T16:31:52.279Z,1533054712.279 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.591822 seconds old.
2018-07-31T16:31:52.280Z,1533054712.280 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 3.592147 seconds old.
2018-07-31T16:31:52.614Z,1533054712.614 [AHRS_M2](INFO): Starting
2018-07-31T16:31:52.695Z,1533054712.695 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.008933 seconds old.
2018-07-31T16:31:52.721Z,1533054712.721 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.033441 seconds old.
2018-07-31T16:31:52.722Z,1533054712.722 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 4.033867 seconds old.
2018-07-31T16:31:53.014Z,1533054713.014 [AHRS_M2](INFO): Starting
2018-07-31T16:31:53.062Z,1533054713.062 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.375636 seconds old.
2018-07-31T16:31:53.063Z,1533054713.063 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.376002 seconds old.
2018-07-31T16:31:53.069Z,1533054713.069 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 4.380530 seconds old.
2018-07-31T16:31:53.414Z,1533054713.414 [AHRS_M2](INFO): Starting
2018-07-31T16:31:53.472Z,1533054713.472 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.765762 seconds old.
2018-07-31T16:31:53.474Z,1533054713.474 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.786368 seconds old.
2018-07-31T16:31:53.475Z,1533054713.475 [DeadReckonWithRespectToSeafloor](DEBUG): Most recent orientation data is 4.786742 seconds old.
2018-07-31T16:31:53.814Z,1533054713.814 [AHRS_M2](INFO): Starting
2018-07-31T16:31:53.841Z,1533054713.841 [AHRS_M2](INFO): Data-stream active.
2018-07-31T16:32:07.350Z,1533054727.350 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 2.000000 count
2018-07-31T16:32:07.588Z,1533054727.588 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:07.589Z,1533054727.589 [AHRS_M2](INFO): Mx: -56.850410 uT, My: -23.868645 uT, Mz: -16.715496 uT
2018-07-31T16:32:07.590Z,1533054727.590 [AHRS_M2](INFO): Ax: -9.621619 m/s2, Ay: -1.933704 m/s2, Az: -0.306483 m/s2
2018-07-31T16:32:07.591Z,1533054727.591 [AHRS_M2](INFO): PITCH: -1.780577 deg, ROLL: 11.324425 deg, YAW: 320.417261 deg, TEMP: 27.304161 C.
2018-07-31T16:32:07.987Z,1533054727.987 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:07.993Z,1533054727.993 [AHRS_M2](INFO): Mx: -56.862373 uT, My: -23.782557 uT, Mz: -16.647551 uT
2018-07-31T16:32:07.993Z,1533054727.993 [AHRS_M2](INFO): Ax: -9.629197 m/s2, Ay: -1.929074 m/s2, Az: -0.308734 m/s2
2018-07-31T16:32:07.994Z,1533054727.994 [AHRS_M2](INFO): PITCH: -1.782114 deg, ROLL: 11.324981 deg, YAW: 320.417233 deg, TEMP: 27.310282 C.
2018-07-31T16:32:08.387Z,1533054728.387 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:08.388Z,1533054728.388 [AHRS_M2](INFO): Mx: -56.859112 uT, My: -23.847849 uT, Mz: -16.671249 uT
2018-07-31T16:32:08.389Z,1533054728.389 [AHRS_M2](INFO): Ax: -9.638900 m/s2, Ay: -1.918363 m/s2, Az: -0.295586 m/s2
2018-07-31T16:32:08.390Z,1533054728.390 [AHRS_M2](INFO): PITCH: -1.780382 deg, ROLL: 11.323608 deg, YAW: 320.417616 deg, TEMP: 27.316402 C.
2018-07-31T16:32:08.788Z,1533054728.788 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:08.790Z,1533054728.790 [AHRS_M2](INFO): Mx: -56.850700 uT, My: -23.835157 uT, Mz: -16.659218 uT
2018-07-31T16:32:08.790Z,1533054728.790 [AHRS_M2](INFO): Ax: -9.634435 m/s2, Ay: -1.923653 m/s2, Az: -0.306481 m/s2
2018-07-31T16:32:08.791Z,1533054728.791 [AHRS_M2](INFO): PITCH: -1.779117 deg, ROLL: 11.318635 deg, YAW: 320.408135 deg, TEMP: 27.307222 C.
2018-07-31T16:32:09.187Z,1533054729.187 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:09.188Z,1533054729.188 [AHRS_M2](INFO): Mx: -56.846092 uT, My: -23.847614 uT, Mz: -16.639235 uT
2018-07-31T16:32:09.189Z,1533054729.189 [AHRS_M2](INFO): Ax: -9.640522 m/s2, Ay: -1.915725 m/s2, Az: -0.315412 m/s2
2018-07-31T16:32:09.190Z,1533054729.190 [AHRS_M2](INFO): PITCH: -1.781331 deg, ROLL: 11.320423 deg, YAW: 320.409611 deg, TEMP: 27.334761 C.
2018-07-31T16:32:09.587Z,1533054729.587 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:09.588Z,1533054729.588 [AHRS_M2](INFO): Mx: -56.862103 uT, My: -23.855835 uT, Mz: -16.682842 uT
2018-07-31T16:32:09.589Z,1533054729.589 [AHRS_M2](INFO): Ax: -9.618171 m/s2, Ay: -1.937721 m/s2, Az: -0.296009 m/s2
2018-07-31T16:32:09.590Z,1533054729.590 [AHRS_M2](INFO): PITCH: -1.784671 deg, ROLL: 11.314601 deg, YAW: 320.386279 deg, TEMP: 27.319462 C.
2018-07-31T16:32:09.988Z,1533054729.988 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:09.989Z,1533054729.989 [AHRS_M2](INFO): Mx: -56.844994 uT, My: -23.822186 uT, Mz: -16.678583 uT
2018-07-31T16:32:09.989Z,1533054729.989 [AHRS_M2](INFO): Ax: -9.626063 m/s2, Ay: -1.951582 m/s2, Az: -0.310432 m/s2
2018-07-31T16:32:09.990Z,1533054729.990 [AHRS_M2](INFO): PITCH: -1.783743 deg, ROLL: 11.316664 deg, YAW: 320.393273 deg, TEMP: 27.322521 C.
2018-07-31T16:32:10.387Z,1533054730.387 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:10.388Z,1533054730.388 [AHRS_M2](INFO): Mx: -56.878490 uT, My: -23.830523 uT, Mz: -16.650324 uT
2018-07-31T16:32:10.389Z,1533054730.389 [AHRS_M2](INFO): Ax: -9.634116 m/s2, Ay: -1.927140 m/s2, Az: -0.314013 m/s2
2018-07-31T16:32:10.390Z,1533054730.390 [AHRS_M2](INFO): PITCH: -1.781590 deg, ROLL: 11.319780 deg, YAW: 320.404529 deg, TEMP: 27.334761 C.
2018-07-31T16:32:10.787Z,1533054730.787 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:10.788Z,1533054730.788 [AHRS_M2](INFO): Mx: -56.854790 uT, My: -23.843746 uT, Mz: -16.667212 uT
2018-07-31T16:32:10.789Z,1533054730.789 [AHRS_M2](INFO): Ax: -9.627262 m/s2, Ay: -1.934007 m/s2, Az: -0.304867 m/s2
2018-07-31T16:32:10.790Z,1533054730.790 [AHRS_M2](INFO): PITCH: -1.776843 deg, ROLL: 11.320235 deg, YAW: 320.415294 deg, TEMP: 27.325581 C.
2018-07-31T16:32:11.188Z,1533054731.188 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:11.189Z,1533054731.189 [AHRS_M2](INFO): Mx: -56.857128 uT, My: -23.838835 uT, Mz: -16.674482 uT
2018-07-31T16:32:11.189Z,1533054731.189 [AHRS_M2](INFO): Ax: -9.637578 m/s2, Ay: -1.938290 m/s2, Az: -0.297641 m/s2
2018-07-31T16:32:11.190Z,1533054731.190 [AHRS_M2](INFO): PITCH: -1.778306 deg, ROLL: 11.323240 deg, YAW: 320.421550 deg, TEMP: 27.316402 C.
2018-07-31T16:32:11.587Z,1533054731.587 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:11.588Z,1533054731.588 [AHRS_M2](INFO): Mx: -56.882275 uT, My: -23.830597 uT, Mz: -16.674175 uT
2018-07-31T16:32:11.589Z,1533054731.589 [AHRS_M2](INFO): Ax: -9.633473 m/s2, Ay: -1.913335 m/s2, Az: -0.304429 m/s2
2018-07-31T16:32:11.590Z,1533054731.590 [AHRS_M2](INFO): PITCH: -1.782255 deg, ROLL: 11.326296 deg, YAW: 320.417315 deg, TEMP: 27.331701 C.
2018-07-31T16:32:11.987Z,1533054731.987 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:11.988Z,1533054731.988 [AHRS_M2](INFO): Mx: -56.805866 uT, My: -23.858847 uT, Mz: -16.671169 uT
2018-07-31T16:32:11.989Z,1533054731.989 [AHRS_M2](INFO): Ax: -9.632303 m/s2, Ay: -1.918139 m/s2, Az: -0.311570 m/s2
2018-07-31T16:32:11.990Z,1533054731.990 [AHRS_M2](INFO): PITCH: -1.781784 deg, ROLL: 11.322416 deg, YAW: 320.410403 deg, TEMP: 27.325581 C.
2018-07-31T16:32:12.388Z,1533054732.388 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:12.389Z,1533054732.389 [AHRS_M2](INFO): Mx: -56.866657 uT, My: -23.843390 uT, Mz: -16.670902 uT
2018-07-31T16:32:12.389Z,1533054732.389 [AHRS_M2](INFO): Ax: -9.633422 m/s2, Ay: -1.937694 m/s2, Az: -0.315622 m/s2
2018-07-31T16:32:12.390Z,1533054732.390 [AHRS_M2](INFO): PITCH: -1.780653 deg, ROLL: 11.319168 deg, YAW: 320.401879 deg, TEMP: 27.325581 C.
2018-07-31T16:32:12.787Z,1533054732.787 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:12.788Z,1533054732.788 [AHRS_M2](INFO): Mx: -56.900269 uT, My: -23.826981 uT, Mz: -16.674267 uT
2018-07-31T16:32:12.789Z,1533054732.789 [AHRS_M2](INFO): Ax: -9.626681 m/s2, Ay: -1.928228 m/s2, Az: -0.322502 m/s2
2018-07-31T16:32:12.790Z,1533054732.790 [AHRS_M2](INFO): PITCH: -1.779901 deg, ROLL: 11.321646 deg, YAW: 320.404666 deg, TEMP: 27.334761 C.
2018-07-31T16:32:13.187Z,1533054733.187 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:13.188Z,1533054733.188 [AHRS_M2](INFO): Mx: -56.848064 uT, My: -23.876123 uT, Mz: -16.690853 uT
2018-07-31T16:32:13.189Z,1533054733.189 [AHRS_M2](INFO): Ax: -9.643248 m/s2, Ay: -1.924630 m/s2, Az: -0.307198 m/s2
2018-07-31T16:32:13.190Z,1533054733.190 [AHRS_M2](INFO): PITCH: -1.785917 deg, ROLL: 11.321961 deg, YAW: 320.391634 deg, TEMP: 27.331701 C.
2018-07-31T16:32:13.589Z,1533054733.589 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:13.590Z,1533054733.590 [AHRS_M2](INFO): Mx: -56.823341 uT, My: -23.867626 uT, Mz: -16.687267 uT
2018-07-31T16:32:13.590Z,1533054733.590 [AHRS_M2](INFO): Ax: -9.634280 m/s2, Ay: -1.925993 m/s2, Az: -0.304247 m/s2
2018-07-31T16:32:13.591Z,1533054733.591 [AHRS_M2](INFO): PITCH: -1.782727 deg, ROLL: 11.329845 deg, YAW: 320.417425 deg, TEMP: 27.322521 C.
2018-07-31T16:32:13.988Z,1533054733.988 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:13.989Z,1533054733.989 [AHRS_M2](INFO): Mx: -56.813305 uT, My: -23.871029 uT, Mz: -16.686800 uT
2018-07-31T16:32:13.989Z,1533054733.989 [AHRS_M2](INFO): Ax: -9.628934 m/s2, Ay: -1.920987 m/s2, Az: -0.302217 m/s2
2018-07-31T16:32:13.990Z,1533054733.990 [AHRS_M2](INFO): PITCH: -1.784830 deg, ROLL: 11.325261 deg, YAW: 320.403272 deg, TEMP: 27.334761 C.
2018-07-31T16:32:14.394Z,1533054734.394 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:14.395Z,1533054734.395 [AHRS_M2](INFO): Mx: -56.827381 uT, My: -23.842556 uT, Mz: -16.674902 uT
2018-07-31T16:32:14.397Z,1533054734.397 [AHRS_M2](INFO): Ax: -9.634718 m/s2, Ay: -1.917754 m/s2, Az: -0.313679 m/s2
2018-07-31T16:32:14.399Z,1533054734.399 [AHRS_M2](INFO): PITCH: -1.786259 deg, ROLL: 11.319631 deg, YAW: 320.390350 deg, TEMP: 27.347002 C.
2018-07-31T16:32:14.788Z,1533054734.788 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:14.789Z,1533054734.789 [AHRS_M2](INFO): Mx: -56.911755 uT, My: -23.860027 uT, Mz: -16.678242 uT
2018-07-31T16:32:14.790Z,1533054734.790 [AHRS_M2](INFO): Ax: -9.628568 m/s2, Ay: -1.939638 m/s2, Az: -0.297201 m/s2
2018-07-31T16:32:14.791Z,1533054734.791 [AHRS_M2](INFO): PITCH: -1.788828 deg, ROLL: 11.321925 deg, YAW: 320.385951 deg, TEMP: 27.325581 C.
2018-07-31T16:32:15.188Z,1533054735.188 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:15.189Z,1533054735.189 [AHRS_M2](INFO): Mx: -56.838737 uT, My: -23.850601 uT, Mz: -16.690235 uT
2018-07-31T16:32:15.189Z,1533054735.189 [AHRS_M2](INFO): Ax: -9.635486 m/s2, Ay: -1.931594 m/s2, Az: -0.308707 m/s2
2018-07-31T16:32:15.190Z,1533054735.190 [AHRS_M2](INFO): PITCH: -1.788070 deg, ROLL: 11.329246 deg, YAW: 320.408135 deg, TEMP: 27.334761 C.
2018-07-31T16:32:15.587Z,1533054735.587 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:15.588Z,1533054735.588 [AHRS_M2](INFO): Mx: -56.842274 uT, My: -23.879650 uT, Mz: -16.686565 uT
2018-07-31T16:32:15.589Z,1533054735.589 [AHRS_M2](INFO): Ax: -9.626882 m/s2, Ay: -1.938676 m/s2, Az: -0.313546 m/s2
2018-07-31T16:32:15.590Z,1533054735.590 [AHRS_M2](INFO): PITCH: -1.783348 deg, ROLL: 11.332336 deg, YAW: 320.428326 deg, TEMP: 27.331701 C.
2018-07-31T16:32:15.989Z,1533054735.989 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:15.990Z,1533054735.990 [AHRS_M2](INFO): Mx: -56.898426 uT, My: -23.834518 uT, Mz: -16.697775 uT
2018-07-31T16:32:15.991Z,1533054735.991 [AHRS_M2](INFO): Ax: -9.625010 m/s2, Ay: -1.930848 m/s2, Az: -0.306404 m/s2
2018-07-31T16:32:15.992Z,1533054735.992 [AHRS_M2](INFO): PITCH: -1.788149 deg, ROLL: 11.332611 deg, YAW: 320.418927 deg, TEMP: 27.337822 C.
2018-07-31T16:32:16.391Z,1533054736.391 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:16.392Z,1533054736.392 [AHRS_M2](INFO): Mx: -56.873436 uT, My: -23.830378 uT, Mz: -16.670063 uT
2018-07-31T16:32:16.393Z,1533054736.393 [AHRS_M2](INFO): Ax: -9.631119 m/s2, Ay: -1.935711 m/s2, Az: -0.312429 m/s2
2018-07-31T16:32:16.394Z,1533054736.394 [AHRS_M2](INFO): PITCH: -1.787346 deg, ROLL: 11.331015 deg, YAW: 320.415348 deg, TEMP: 27.347002 C.
2018-07-31T16:32:16.787Z,1533054736.787 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:16.788Z,1533054736.788 [AHRS_M2](INFO): Mx: -56.847633 uT, My: -23.875851 uT, Mz: -16.698629 uT
2018-07-31T16:32:16.789Z,1533054736.789 [AHRS_M2](INFO): Ax: -9.626768 m/s2, Ay: -1.928249 m/s2, Az: -0.310466 m/s2
2018-07-31T16:32:16.790Z,1533054736.790 [AHRS_M2](INFO): PITCH: -1.791417 deg, ROLL: 11.327718 deg, YAW: 320.400322 deg, TEMP: 27.340881 C.
2018-07-31T16:32:17.188Z,1533054737.188 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:17.189Z,1533054737.189 [AHRS_M2](INFO): Mx: -56.881493 uT, My: -23.875969 uT, Mz: -16.662281 uT
2018-07-31T16:32:17.190Z,1533054737.190 [AHRS_M2](INFO): Ax: -9.630772 m/s2, Ay: -1.929998 m/s2, Az: -0.303390 m/s2
2018-07-31T16:32:17.191Z,1533054737.191 [AHRS_M2](INFO): PITCH: -1.787512 deg, ROLL: 11.325230 deg, YAW: 320.407890 deg, TEMP: 27.331701 C.
2018-07-31T16:32:17.590Z,1533054737.590 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:17.591Z,1533054737.591 [AHRS_M2](INFO): Mx: -56.876453 uT, My: -23.867527 uT, Mz: -16.634220 uT
2018-07-31T16:32:17.591Z,1533054737.591 [AHRS_M2](INFO): Ax: -9.624659 m/s2, Ay: -1.922748 m/s2, Az: -0.316620 m/s2
2018-07-31T16:32:17.593Z,1533054737.593 [AHRS_M2](INFO): PITCH: -1.791950 deg, ROLL: 11.323040 deg, YAW: 320.397289 deg, TEMP: 27.331701 C.
2018-07-31T16:32:17.988Z,1533054737.988 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:17.989Z,1533054737.989 [AHRS_M2](INFO): Mx: -56.840965 uT, My: -23.866364 uT, Mz: -16.709850 uT
2018-07-31T16:32:17.989Z,1533054737.989 [AHRS_M2](INFO): Ax: -9.625826 m/s2, Ay: -1.930721 m/s2, Az: -0.304334 m/s2
2018-07-31T16:32:17.990Z,1533054737.990 [AHRS_M2](INFO): PITCH: -1.786497 deg, ROLL: 11.321845 deg, YAW: 320.398792 deg, TEMP: 27.353121 C.
2018-07-31T16:32:18.388Z,1533054738.388 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:18.389Z,1533054738.389 [AHRS_M2](INFO): Mx: -56.845905 uT, My: -23.784874 uT, Mz: -16.650484 uT
2018-07-31T16:32:18.390Z,1533054738.390 [AHRS_M2](INFO): Ax: -9.627044 m/s2, Ay: -1.937520 m/s2, Az: -0.299114 m/s2
2018-07-31T16:32:18.391Z,1533054738.391 [AHRS_M2](INFO): PITCH: -1.788984 deg, ROLL: 11.318939 deg, YAW: 320.384121 deg, TEMP: 27.350061 C.
2018-07-31T16:32:18.788Z,1533054738.788 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:18.789Z,1533054738.789 [AHRS_M2](INFO): Mx: -56.837872 uT, My: -23.870935 uT, Mz: -16.650272 uT
2018-07-31T16:32:18.790Z,1533054738.790 [AHRS_M2](INFO): Ax: -9.632921 m/s2, Ay: -1.920342 m/s2, Az: -0.314457 m/s2
2018-07-31T16:32:18.791Z,1533054738.791 [AHRS_M2](INFO): PITCH: -1.785436 deg, ROLL: 11.321021 deg, YAW: 320.399803 deg, TEMP: 27.347002 C.
2018-07-31T16:32:19.188Z,1533054739.188 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:19.189Z,1533054739.189 [AHRS_M2](INFO): Mx: -56.869129 uT, My: -23.850988 uT, Mz: -16.646219 uT
2018-07-31T16:32:19.189Z,1533054739.189 [AHRS_M2](INFO): Ax: -9.634360 m/s2, Ay: -1.924818 m/s2, Az: -0.301849 m/s2
2018-07-31T16:32:19.190Z,1533054739.190 [AHRS_M2](INFO): PITCH: -1.790258 deg, ROLL: 11.323941 deg, YAW: 320.399393 deg, TEMP: 27.334761 C.
2018-07-31T16:32:19.589Z,1533054739.589 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:19.590Z,1533054739.590 [AHRS_M2](INFO): Mx: -56.852669 uT, My: -23.842714 uT, Mz: -16.654621 uT
2018-07-31T16:32:19.591Z,1533054739.591 [AHRS_M2](INFO): Ax: -9.625742 m/s2, Ay: -1.931894 m/s2, Az: -0.306749 m/s2
2018-07-31T16:32:19.592Z,1533054739.592 [AHRS_M2](INFO): PITCH: -1.788728 deg, ROLL: 11.327340 deg, YAW: 320.412780 deg, TEMP: 27.343941 C.
2018-07-31T16:32:19.988Z,1533054739.988 [AHRS_M2](ERROR): Found valid termintation char ETX. Skip count: 0.
2018-07-31T16:32:19.989Z,1533054739.989 [AHRS_M2](INFO): Mx: -56.831360 uT, My: -23.821516 uT, Mz: -16.662243 uT
2018-07-31T16:32:19.989Z,1533054739.989 [AHRS_M2](INFO): Ax: -9.625413 m/s2, Ay: -1.924988 m/s2, Az: -0.302583 m/s2
2018-07-31T16:32:19.990Z,1533054739.990 [AHRS_M2](INFO): PITCH: -1.784236 deg, ROLL: 11.328856 deg, YAW: 320.428380 deg, TEMP: 27.347002 C.
2018-07-31T16:32:20.291Z,1533054740.291 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 1.000000 count
2018-07-31T16:33:36.126Z,1533054816.126 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-07-31T16:33:58.185Z,1533054838.185 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:33:58.185Z,1533054838.185 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2018-07-31T16:33:58.185Z,1533054838.185 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-07-31T16:33:58.187Z,1533054838.187 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:33:58.187Z,1533054838.187 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-07-31T16:33:58.187Z,1533054838.187 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-07-31T16:33:58.189Z,1533054838.189 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:33:58.189Z,1533054838.189 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2018-07-31T16:33:58.190Z,1533054838.190 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-07-31T16:33:58.203Z,1533054838.203 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-07-31T16:33:58.203Z,1533054838.203 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-07-31T16:33:58.203Z,1533054838.203 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-07-31T16:33:58.395Z,1533054838.395 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-07-31T16:33:58.395Z,1533054838.395 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2018-07-31T16:33:58.395Z,1533054838.395 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-07-31T16:33:58.395Z,1533054838.395 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-07-31T16:33:58.396Z,1533054838.396 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-07-31T16:33:58.396Z,1533054838.396 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2018-07-31T16:33:58.745Z,1533054838.745 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-07-31T16:33:58.746Z,1533054838.746 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:33:58.746Z,1533054838.746 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:33:58.747Z,1533054838.747 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-07-31T16:33:58.747Z,1533054838.747 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:33:58.747Z,1533054838.747 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:33:58.748Z,1533054838.748 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-07-31T16:33:58.748Z,1533054838.748 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:33:58.753Z,1533054838.753 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:33:59.139Z,1533054839.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.0 s old, using for 20.0 s.
2018-07-31T16:33:59.543Z,1533054839.543 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.4 s old, using for 20.0 s.
2018-07-31T16:33:59.935Z,1533054839.935 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.8 s old, using for 20.0 s.
2018-07-31T16:34:00.375Z,1533054840.375 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.2 s old, using for 20.0 s.
2018-07-31T16:34:00.747Z,1533054840.747 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.6 s old, using for 20.0 s.
2018-07-31T16:34:01.147Z,1533054841.147 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.0 s old, using for 20.0 s.
2018-07-31T16:34:01.542Z,1533054841.542 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.4 s old, using for 20.0 s.
2018-07-31T16:34:01.946Z,1533054841.946 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.8 s old, using for 20.0 s.
2018-07-31T16:34:02.362Z,1533054842.362 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.2 s old, using for 20.0 s.
2018-07-31T16:34:02.726Z,1533054842.726 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.5 s old, using for 20.0 s.
2018-07-31T16:34:03.131Z,1533054843.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.9 s old, using for 20.0 s.
2018-07-31T16:34:03.548Z,1533054843.548 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.4 s old, using for 20.0 s.
2018-07-31T16:34:03.934Z,1533054843.934 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.7 s old, using for 20.0 s.
2018-07-31T16:34:04.361Z,1533054844.361 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.2 s old, using for 20.0 s.
2018-07-31T16:34:04.749Z,1533054844.749 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.6 s old, using for 20.0 s.
2018-07-31T16:34:05.145Z,1533054845.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.0 s old, using for 20.0 s.
2018-07-31T16:34:05.568Z,1533054845.568 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.4 s old, using for 20.0 s.
2018-07-31T16:34:05.927Z,1533054845.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.7 s old, using for 20.0 s.
2018-07-31T16:34:06.355Z,1533054846.355 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.2 s old, using for 20.0 s.
2018-07-31T16:34:06.766Z,1533054846.766 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.6 s old, using for 20.0 s.
2018-07-31T16:34:07.151Z,1533054847.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.0 s old, using for 20.0 s.
2018-07-31T16:34:07.519Z,1533054847.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.3 s old, using for 20.0 s.
2018-07-31T16:34:07.953Z,1533054847.953 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.8 s old, using for 20.0 s.
2018-07-31T16:34:08.350Z,1533054848.350 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.2 s old, using for 20.0 s.
2018-07-31T16:34:08.757Z,1533054848.757 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.6 s old, using for 20.0 s.
2018-07-31T16:34:09.123Z,1533054849.123 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.9 s old, using for 20.0 s.
2018-07-31T16:34:09.550Z,1533054849.550 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.4 s old, using for 20.0 s.
2018-07-31T16:34:09.943Z,1533054849.943 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.8 s old, using for 20.0 s.
2018-07-31T16:34:10.378Z,1533054850.378 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.2 s old, using for 20.0 s.
2018-07-31T16:34:10.735Z,1533054850.735 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.6 s old, using for 20.0 s.
2018-07-31T16:34:11.119Z,1533054851.119 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.9 s old, using for 20.0 s.
2018-07-31T16:34:11.542Z,1533054851.542 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.4 s old, using for 20.0 s.
2018-07-31T16:34:11.931Z,1533054851.931 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.7 s old, using for 20.0 s.
2018-07-31T16:34:12.370Z,1533054852.370 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.2 s old, using for 20.0 s.
2018-07-31T16:34:12.738Z,1533054852.738 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.6 s old, using for 20.0 s.
2018-07-31T16:34:13.131Z,1533054853.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.9 s old, using for 20.0 s.
2018-07-31T16:34:13.554Z,1533054853.554 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.4 s old, using for 20.0 s.
2018-07-31T16:34:13.923Z,1533054853.923 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.7 s old, using for 20.0 s.
2018-07-31T16:34:14.371Z,1533054854.371 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.2 s old, using for 20.0 s.
2018-07-31T16:34:14.791Z,1533054854.791 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.6 s old, using for 20.0 s.
2018-07-31T16:34:15.139Z,1533054855.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.0 s old, using for 20.0 s.
2018-07-31T16:34:15.561Z,1533054855.561 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.4 s old, using for 20.0 s.
2018-07-31T16:34:15.935Z,1533054855.935 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.8 s old, using for 20.0 s.
2018-07-31T16:34:16.338Z,1533054856.338 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.2 s old, using for 20.0 s.
2018-07-31T16:34:16.760Z,1533054856.760 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.6 s old, using for 20.0 s.
2018-07-31T16:34:17.138Z,1533054857.138 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.0 s old, using for 20.0 s.
2018-07-31T16:34:17.531Z,1533054857.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.3 s old, using for 20.0 s.
2018-07-31T16:34:17.940Z,1533054857.940 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.8 s old, using for 20.0 s.
2018-07-31T16:34:59.643Z,1533054899.643 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,-32768,-32768,V
2018-07-31T16:36:08.561Z,1533054968.561 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-07-31T16:31:08.3Z
2018-07-31T16:36:08.561Z,1533054968.561 [Default:CheckIn:Read_GPS] Stopped
2018-07-31T16:36:08.561Z,1533054968.561 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-07-31T16:36:08.942Z,1533054968.942 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-07-31T16:36:13.097Z,1533054973.097 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20180731T162744/Courier0004.lzma
2018-07-31T16:36:13.878Z,1533054973.878 [DataOverHttps](INFO): Moved sent file to Logs/20180731T162744/Courier0004.lzma.bak
2018-07-31T16:36:13.879Z,1533054973.879 [DataOverHttps](INFO): SBD MOMSN=8388090
2018-07-31T16:36:22.888Z,1533054982.888 [DataOverHttps](INFO): Sending 302 bytes from file Logs/20180731T162744/Express0005.lzma
2018-07-31T16:36:23.667Z,1533054983.667 [DataOverHttps](INFO): Moved sent file to Logs/20180731T162744/Express0005.lzma.bak
2018-07-31T16:36:23.667Z,1533054983.667 [DataOverHttps](INFO): SBD MOMSN=8388092
2018-07-31T16:36:24.241Z,1533054984.241 [Default:CheckIn:Read_Iridium] Stopped
2018-07-31T16:36:24.241Z,1533054984.241 [Default:CheckIn:C.Wait] Running Loop=1
2018-07-31T16:36:24.241Z,1533054984.241 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-07-31T16:36:28.614Z,1533054988.614 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2018-07-31T16:36:58.999Z,1533055018.999 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:36:58.000Z,1533055019.000 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2018-07-31T16:36:58.000Z,1533055019.000 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-07-31T16:36:59.006Z,1533055019.006 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:36:59.006Z,1533055019.006 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-07-31T16:36:59.006Z,1533055019.006 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-07-31T16:36:59.008Z,1533055019.008 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:36:59.008Z,1533055019.008 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2018-07-31T16:36:59.013Z,1533055019.013 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-07-31T16:36:59.058Z,1533055019.058 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-07-31T16:36:59.058Z,1533055019.058 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-07-31T16:36:59.058Z,1533055019.058 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-07-31T16:36:59.444Z,1533055019.444 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-07-31T16:36:59.444Z,1533055019.444 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2018-07-31T16:36:59.448Z,1533055019.448 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-07-31T16:36:59.449Z,1533055019.449 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-07-31T16:36:59.449Z,1533055019.449 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-07-31T16:36:59.449Z,1533055019.449 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2018-07-31T16:36:59.810Z,1533055019.810 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-07-31T16:36:59.810Z,1533055019.810 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:36:59.811Z,1533055019.811 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:36:59.811Z,1533055019.811 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-07-31T16:36:59.811Z,1533055019.811 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:36:59.812Z,1533055019.812 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:36:59.813Z,1533055019.813 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-07-31T16:36:59.816Z,1533055019.816 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:36:59.816Z,1533055019.816 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:37:00.187Z,1533055020.187 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2018-07-31T16:37:00.631Z,1533055020.631 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2018-07-31T16:37:01.011Z,1533055021.011 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2018-07-31T16:37:01.428Z,1533055021.428 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2018-07-31T16:37:01.799Z,1533055021.799 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2018-07-31T16:37:02.202Z,1533055022.202 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2018-07-31T16:37:02.619Z,1533055022.619 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2018-07-31T16:37:02.995Z,1533055022.995 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2018-07-31T16:37:03.449Z,1533055023.449 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2018-07-31T16:37:03.807Z,1533055023.807 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2018-07-31T16:37:04.195Z,1533055024.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2018-07-31T16:37:04.611Z,1533055024.611 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2018-07-31T16:37:04.995Z,1533055024.995 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2018-07-31T16:37:05.399Z,1533055025.399 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2018-07-31T16:37:05.817Z,1533055025.817 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2018-07-31T16:37:06.195Z,1533055026.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2018-07-31T16:37:06.614Z,1533055026.614 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2018-07-31T16:37:07.030Z,1533055027.030 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2018-07-31T16:37:07.413Z,1533055027.413 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2018-07-31T16:37:07.806Z,1533055027.806 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2018-07-31T16:37:08.211Z,1533055028.211 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2018-07-31T16:37:08.614Z,1533055028.614 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-07-31T16:37:08.999Z,1533055028.999 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2018-07-31T16:37:09.437Z,1533055029.437 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2018-07-31T16:37:09.818Z,1533055029.818 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2018-07-31T16:37:10.217Z,1533055030.217 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2018-07-31T16:37:10.617Z,1533055030.617 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2018-07-31T16:37:11.009Z,1533055031.009 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2018-07-31T16:37:11.420Z,1533055031.420 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2018-07-31T16:37:11.819Z,1533055031.819 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2018-07-31T16:37:12.182Z,1533055032.182 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2018-07-31T16:37:12.619Z,1533055032.619 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2018-07-31T16:37:13.014Z,1533055033.014 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2018-07-31T16:37:13.431Z,1533055033.431 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2018-07-31T16:37:13.817Z,1533055033.817 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2018-07-31T16:37:14.202Z,1533055034.202 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2018-07-31T16:37:14.616Z,1533055034.616 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2018-07-31T16:37:14.991Z,1533055034.991 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2018-07-31T16:37:15.411Z,1533055035.411 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2018-07-31T16:37:15.836Z,1533055035.836 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2018-07-31T16:37:16.202Z,1533055036.202 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2018-07-31T16:37:16.600Z,1533055036.600 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2018-07-31T16:37:17.023Z,1533055037.023 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2018-07-31T16:37:17.404Z,1533055037.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2018-07-31T16:37:17.823Z,1533055037.823 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2018-07-31T16:37:18.187Z,1533055038.187 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2018-07-31T16:37:18.627Z,1533055038.627 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2018-07-31T16:38:34.399Z,1533055114.399 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-07-31T16:38:34.400Z,1533055114.400 [NAL9602] Data Fault, FailCount= 1
2018-07-31T16:38:34.400Z,1533055114.400 [NAL9602](ERROR): Data Fault
2018-07-31T16:38:34.500Z,1533055114.500 [CBIT](ERROR): Data Fault in component: NAL9602
2018-07-31T16:38:34.778Z,1533055114.778 [NAL9602](INFO): Powering down
2018-07-31T16:38:35.661Z,1533055115.661 [CBIT](INFO): Clearing failed state for component NAL9602
2018-07-31T16:38:35.661Z,1533055115.661 [NAL9602] No Fault, FailCount= 1
2018-07-31T16:39:04.782Z,1533055144.782 [NAL9602](INFO): Powering up NAL9602
2018-07-31T16:39:15.978Z,1533055155.978 [NAL9602](INFO): NAL9602 initialized
2018-07-31T16:40:00.139Z,1533055200.139 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:40:00.140Z,1533055200.140 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2018-07-31T16:40:00.140Z,1533055200.140 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-07-31T16:40:00.152Z,1533055200.152 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:40:00.152Z,1533055200.152 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-07-31T16:40:00.152Z,1533055200.152 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-07-31T16:40:00.154Z,1533055200.154 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-31T16:40:00.155Z,1533055200.155 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2018-07-31T16:40:00.155Z,1533055200.155 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-07-31T16:40:00.201Z,1533055200.201 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-07-31T16:40:00.201Z,1533055200.201 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-07-31T16:40:00.202Z,1533055200.202 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-07-31T16:40:00.568Z,1533055200.568 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-07-31T16:40:00.568Z,1533055200.568 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2018-07-31T16:40:00.568Z,1533055200.568 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-07-31T16:40:00.568Z,1533055200.568 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-07-31T16:40:00.573Z,1533055200.573 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-07-31T16:40:00.573Z,1533055200.573 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2018-07-31T16:40:00.922Z,1533055200.922 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-07-31T16:40:00.923Z,1533055200.923 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:40:00.923Z,1533055200.923 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:40:00.923Z,1533055200.923 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-07-31T16:40:00.924Z,1533055200.924 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:40:00.940Z,1533055200.940 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:40:00.941Z,1533055200.941 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-07-31T16:40:00.941Z,1533055200.941 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-07-31T16:40:00.942Z,1533055200.942 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-07-31T16:40:01.378Z,1533055201.378 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2018-07-31T16:40:01.731Z,1533055201.731 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2018-07-31T16:40:02.135Z,1533055202.135 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2018-07-31T16:40:02.554Z,1533055202.554 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2018-07-31T16:40:02.939Z,1533055202.939 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2018-07-31T16:40:03.359Z,1533055203.359 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2018-07-31T16:40:03.751Z,1533055203.751 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2018-07-31T16:40:04.127Z,1533055204.127 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2018-07-31T16:40:04.549Z,1533055204.549 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2018-07-31T16:40:04.935Z,1533055204.935 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2018-07-31T16:40:05.339Z,1533055205.339 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2018-07-31T16:40:05.755Z,1533055205.755 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2018-07-31T16:40:06.150Z,1533055206.150 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2018-07-31T16:40:06.519Z,1533055206.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2018-07-31T16:40:06.942Z,1533055206.942 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2018-07-31T16:40:07.344Z,1533055207.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2018-07-31T16:40:07.769Z,1533055207.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2018-07-31T16:40:08.141Z,1533055208.141 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2018-07-31T16:40:08.562Z,1533055208.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2018-07-31T16:40:08.927Z,1533055208.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2018-07-31T16:40:09.349Z,1533055209.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2018-07-31T16:40:09.745Z,1533055209.745 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-07-31T16:40:10.127Z,1533055210.127 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2018-07-31T16:40:10.561Z,1533055210.561 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2018-07-31T16:40:10.950Z,1533055210.950 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2018-07-31T16:40:11.371Z,1533055211.371 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2018-07-31T16:40:11.735Z,1533055211.735 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2018-07-31T16:40:12.144Z,1533055212.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2018-07-31T16:40:12.546Z,1533055212.546 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2018-07-31T16:40:12.935Z,1533055212.935 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2018-07-31T16:40:13.359Z,1533055213.359 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2018-07-31T16:40:13.757Z,1533055213.757 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2018-07-31T16:40:14.143Z,1533055214.143 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2018-07-31T16:40:14.544Z,1533055214.544 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2018-07-31T16:40:14.938Z,1533055214.938 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2018-07-31T16:40:15.327Z,1533055215.327 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2018-07-31T16:40:15.739Z,1533055215.739 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2018-07-31T16:40:16.123Z,1533055216.123 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2018-07-31T16:40:16.543Z,1533055216.543 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2018-07-31T16:40:16.965Z,1533055216.965 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2018-07-31T16:40:17.351Z,1533055217.351 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2018-07-31T16:40:17.751Z,1533055217.751 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2018-07-31T16:40:18.137Z,1533055218.137 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2018-07-31T16:40:18.544Z,1533055218.544 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2018-07-31T16:40:18.927Z,1533055218.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2018-07-31T16:40:19.386Z,1533055219.386 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2018-07-31T16:40:19.756Z,1533055219.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2018-07-31T16:41:24.594Z,1533055284.594 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-07-31T16:41:24.594Z,1533055284.594 [Default:CheckIn:C.Wait] Stopped
2018-07-31T16:41:24.594Z,1533055284.594 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-07-31T16:41:24.594Z,1533055284.594 [Default:CheckIn:D] Running Loop=1
2018-07-31T16:41:24.992Z,1533055284.992 [Default:CheckIn:D] Stopped
2018-07-31T16:41:24.993Z,1533055284.993 [Default:CheckIn:E] Running Loop=1
2018-07-31T16:41:25.390Z,1533055285.390 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.506728 min
2018-07-31T16:41:25.392Z,1533055285.392 [Default:CheckIn:E] Stopped
2018-07-31T16:41:25.392Z,1533055285.392 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-07-31T16:41:25.392Z,1533055285.392 [Default:CheckIn] Stopped
2018-07-31T16:41:25.392Z,1533055285.392 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-07-31T16:41:25.393Z,1533055285.393 [Default:CheckIn](INFO): Running loop #2
2018-07-31T16:41:25.393Z,1533055285.393 [Default:CheckIn] Running Loop=2
2018-07-31T16:41:25.393Z,1533055285.393 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-07-31T16:41:25.393Z,1533055285.393 [Default:CheckIn:Read_GPS] Running Loop=1
2018-07-31T16:41:57.063Z,1533055317.063 [RDI_Pathfinder](ERROR): only read 3 of 5 data items
2018-07-31T16:41:57.063Z,1533055317.063 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-32768,-3268,V
2018-07-31T16:42:29.621Z,1533055349.621 [CommandLine](IMPORTANT): got command quit
2018-07-31T16:42:30.628Z,1533055350.628 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-31T16:42:30.628Z,1533055350.628 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:30.799Z,1533055350.799 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2018-07-31T16:42:30.799Z,1533055350.799 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:30.800Z,1533055350.800 [CommandLine](INFO): Join timeout helper Thread ID is 6755
2018-07-31T16:42:30.801Z,1533055350.801 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-07-31T16:42:30.801Z,1533055350.801 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:30.802Z,1533055350.802 [NavChartDb](INFO): Join timeout helper Thread ID is 6756
2018-07-31T16:42:31.025Z,1533055351.025 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-31T16:42:31.025Z,1533055351.025 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.041Z,1533055351.041 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-07-31T16:42:31.041Z,1533055351.041 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.041Z,1533055351.041 [Radio_Surface](INFO): Join timeout helper Thread ID is 6757
2018-07-31T16:42:31.357Z,1533055351.357 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-31T16:42:31.357Z,1533055351.357 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.369Z,1533055351.369 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-07-31T16:42:31.369Z,1533055351.369 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.369Z,1533055351.369 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6758
2018-07-31T16:42:31.517Z,1533055351.517 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-31T16:42:31.517Z,1533055351.517 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.521Z,1533055351.521 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-07-31T16:42:31.521Z,1533055351.521 [logger ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.521Z,1533055351.521 [logger](INFO): Join timeout helper Thread ID is 6759
2018-07-31T16:42:31.545Z,1533055351.545 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-31T16:42:31.545Z,1533055351.545 [logger ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.546Z,1533055351.546 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-07-31T16:42:31.547Z,1533055351.547 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.547Z,1533055351.547 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-07-31T16:42:31.547Z,1533055351.547 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:31.547Z,1533055351.547 [controlThread](INFO): Join timeout helper Thread ID is 6760
2018-07-31T16:42:33.049Z,1533055353.049 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-31T16:42:33.049Z,1533055353.049 [controlThread](DEBUG): Uninitializing ControlThread
2018-07-31T16:42:33.049Z,1533055353.049 [Aanderaa_O2](INFO): Powering down
2018-07-31T16:42:33.050Z,1533055353.050 [AHRS_M2](INFO): Uninitializing.
2018-07-31T16:42:33.051Z,1533055353.051 [AHRS_M2](INFO): Powering down
2018-07-31T16:42:33.124Z,1533055353.124 [NAL9602](INFO): Powering down
2018-07-31T16:42:33.197Z,1533055353.197 [RDI_Pathfinder](INFO): Powering down
2018-07-31T16:42:33.198Z,1533055353.198 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-07-31T16:42:33.200Z,1533055353.200 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-07-31T16:42:33.201Z,1533055353.201 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-07-31T16:42:33.202Z,1533055353.202 [MissionManager](INFO): Uninitializing Mission Default
2018-07-31T16:42:33.202Z,1533055353.202 [Default] Stopped
2018-07-31T16:42:33.202Z,1533055353.202 [Default](DEBUG): Aggregate::uninitialize Default
2018-07-31T16:42:33.202Z,1533055353.202 [Default:B.GoToSurface] Stopped
2018-07-31T16:42:33.202Z,1533055353.202 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-07-31T16:42:33.202Z,1533055353.202 [Default:CheckIn] Stopped
2018-07-31T16:42:33.202Z,1533055353.202 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-07-31T16:42:33.202Z,1533055353.202 [Default:CheckIn:Read_GPS] Stopped
2018-07-31T16:42:33.206Z,1533055353.206 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-07-31T16:42:33.206Z,1533055353.206 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-07-31T16:42:33.207Z,1533055353.207 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-07-31T16:42:33.207Z,1533055353.207 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-07-31T16:42:33.207Z,1533055353.207 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-07-31T16:42:33.208Z,1533055353.208 [BuoyancyServo](INFO): Powering down
2018-07-31T16:42:33.221Z,1533055353.221 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-07-31T16:42:33.221Z,1533055353.221 [ElevatorServo](INFO): Powering down
2018-07-31T16:42:33.222Z,1533055353.222 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-07-31T16:42:33.222Z,1533055353.222 [MassServo](INFO): Powering down
2018-07-31T16:42:33.223Z,1533055353.223 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-07-31T16:42:33.223Z,1533055353.223 [RudderServo](INFO): Powering down
2018-07-31T16:42:33.224Z,1533055353.224 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-07-31T16:42:33.224Z,1533055353.224 [ThrusterServo](INFO): Powering down
2018-07-31T16:42:33.225Z,1533055353.225 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-07-31T16:42:33.226Z,1533055353.226 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-07-31T16:42:33.226Z,1533055353.226 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-07-31T16:42:33.227Z,1533055353.227 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:33.336Z,1533055353.336 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:33.484Z,1533055353.484 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:33.595Z,1533055353.595 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-07-31T16:42:33.708Z,1533055353.708 [logger ThreadHandler](INFO): Thread cancelled.