2018-05-13T05:01:58.126Z,1526187718.126 [Supervisor](DEBUG): Initializing supervisor.
2018-05-13T05:01:58.131Z,1526187718.131 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-05-13T05:01:58.131Z,1526187718.131 [SyncHandler](INFO): Protected caller Thread ID is 7136
2018-05-13T05:01:58.132Z,1526187718.132 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-05-13T05:01:58.133Z,1526187718.133 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-05-13T05:01:58.133Z,1526187718.133 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7137
2018-05-13T05:01:58.139Z,1526187718.139 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-05-13T05:01:58.157Z,1526187718.157 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-05-13T05:01:58.158Z,1526187718.158 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-05-13T05:01:58.158Z,1526187718.158 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7138
2018-05-13T05:01:58.159Z,1526187718.159 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-05-13T05:01:58.160Z,1526187718.160 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-05-13T05:01:58.160Z,1526187718.160 [logger ThreadHandler](INFO): Protected caller Thread ID is 7139
2018-05-13T05:01:58.164Z,1526187718.164 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-05-13T05:01:58.165Z,1526187718.165 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-05-13T05:01:58.166Z,1526187718.166 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-05-13T05:01:58.351Z,1526187718.351 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-05-13T05:01:58.351Z,1526187718.351 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-05-13T05:01:58.475Z,1526187718.475 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-05-13T05:01:58.475Z,1526187718.475 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-05-13T05:01:58.727Z,1526187718.727 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-05-13T05:01:58.728Z,1526187718.728 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-05-13T05:01:59.025Z,1526187719.025 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-05-13T05:01:59.026Z,1526187719.026 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-05-13T05:01:59.337Z,1526187719.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-05-13T05:01:59.338Z,1526187719.338 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-05-13T05:01:59.772Z,1526187719.772 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-05-13T05:01:59.773Z,1526187719.773 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-05-13T05:02:00.117Z,1526187720.117 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-05-13T05:02:00.117Z,1526187720.117 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-05-13T05:02:00.534Z,1526187720.534 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-05-13T05:02:00.534Z,1526187720.534 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-05-13T05:02:00.613Z,1526187720.613 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-05-13T05:02:00.893Z,1526187720.893 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-05-13T05:02:00.893Z,1526187720.893 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-05-13T05:02:01.030Z,1526187721.030 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-05-13T05:02:01.031Z,1526187721.031 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-05-13T05:02:01.231Z,1526187721.231 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-05-13T05:02:01.231Z,1526187721.231 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-05-13T05:02:01.503Z,1526187721.503 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-05-13T05:02:01.503Z,1526187721.503 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-05-13T05:02:01.601Z,1526187721.601 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-05-13T05:02:01.601Z,1526187721.601 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-05-13T05:02:01.735Z,1526187721.735 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-05-13T05:02:01.737Z,1526187721.737 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2018-05-13T05:02:01.738Z,1526187721.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2018-05-13T05:02:01.964Z,1526187721.964 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-05-13T05:02:01.965Z,1526187721.965 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2018-05-13T05:02:02.040Z,1526187722.040 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2018-05-13T05:02:02.175Z,1526187722.175 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2018-05-13T05:02:02.265Z,1526187722.265 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2018-05-13T05:02:02.347Z,1526187722.347 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2018-05-13T05:02:02.479Z,1526187722.479 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2018-05-13T05:02:02.645Z,1526187722.645 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2018-05-13T05:02:02.739Z,1526187722.739 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2018-05-13T05:02:02.829Z,1526187722.829 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2018-05-13T05:02:02.922Z,1526187722.922 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2018-05-13T05:02:03.003Z,1526187723.003 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2018-05-13T05:02:03.004Z,1526187723.004 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-05-13T05:02:03.015Z,1526187723.015 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-05-13T05:02:03.114Z,1526187723.114 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-05-13T05:02:03.114Z,1526187723.114 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-05-13T05:02:03.148Z,1526187723.148 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-05-13T05:02:03.148Z,1526187723.148 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-05-13T05:02:03.220Z,1526187723.220 [DepthRateCalculator] Loaded
2018-05-13T05:02:03.220Z,1526187723.220 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-05-13T05:02:03.226Z,1526187723.226 [PitchRateCalculator] Loaded
2018-05-13T05:02:03.226Z,1526187723.226 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-05-13T05:02:03.316Z,1526187723.316 [SpeedCalculator] Loaded
2018-05-13T05:02:03.317Z,1526187723.317 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-05-13T05:02:03.416Z,1526187723.416 [TempGradientCalculator] Loaded
2018-05-13T05:02:03.416Z,1526187723.416 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-05-13T05:02:03.440Z,1526187723.440 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-05-13T05:02:03.440Z,1526187723.440 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-05-13T05:02:03.446Z,1526187723.446 [YawRateCalculator] Loaded
2018-05-13T05:02:03.446Z,1526187723.446 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-05-13T05:02:03.565Z,1526187723.565 [ElevatorOffsetCalculator] Loaded
2018-05-13T05:02:03.566Z,1526187723.566 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-05-13T05:02:03.566Z,1526187723.566 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-05-13T05:02:03.567Z,1526187723.567 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-05-13T05:02:03.599Z,1526187723.599 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-05-13T05:02:03.599Z,1526187723.599 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-05-13T05:02:04.061Z,1526187724.061 [AHRS_M2] Loaded
2018-05-13T05:02:04.061Z,1526187724.061 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-05-13T05:02:04.104Z,1526187724.104 [AcousticModem_Benthos_ATM900] Loaded
2018-05-13T05:02:04.104Z,1526187724.104 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2018-05-13T05:02:04.175Z,1526187724.175 [DataOverHttps] Loaded
2018-05-13T05:02:04.176Z,1526187724.176 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-05-13T05:02:04.189Z,1526187724.189 [Depth_Keller] Loaded
2018-05-13T05:02:04.189Z,1526187724.189 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-05-13T05:02:04.189Z,1526187724.189 [Module Loader](CRITICAL): Could not find element GobyModem.loadAtStartup
2018-05-13T05:02:04.284Z,1526187724.284 [NAL9602] Loaded
2018-05-13T05:02:04.284Z,1526187724.284 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-05-13T05:02:04.299Z,1526187724.299 [Onboard] Loaded
2018-05-13T05:02:04.300Z,1526187724.300 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-05-13T05:02:04.310Z,1526187724.310 [Radio_Surface] Loaded
2018-05-13T05:02:04.310Z,1526187724.310 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-05-13T05:02:04.311Z,1526187724.311 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407B54E0
2018-05-13T05:02:04.311Z,1526187724.311 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7219
2018-05-13T05:02:04.312Z,1526187724.312 [Module Loader](CRITICAL): Could not find element RDI_Pathfinder.loadAtStartup
2018-05-13T05:02:06.031Z,1526187726.031 [BPC1] Loaded
2018-05-13T05:02:06.031Z,1526187726.031 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-05-13T05:02:06.032Z,1526187726.032 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-05-13T05:02:06.032Z,1526187726.032 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-05-13T05:02:06.161Z,1526187726.161 [SBIT](DEBUG): Construct Startup Built In Test.
2018-05-13T05:02:06.184Z,1526187726.184 [SBIT] Loaded
2018-05-13T05:02:06.184Z,1526187726.184 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-05-13T05:02:06.185Z,1526187726.185 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-05-13T05:02:06.196Z,1526187726.196 [IBIT] Loaded
2018-05-13T05:02:06.196Z,1526187726.196 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-05-13T05:02:06.199Z,1526187726.199 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-05-13T05:02:06.347Z,1526187726.347 [CBIT] Loaded
2018-05-13T05:02:06.347Z,1526187726.347 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-05-13T05:02:06.347Z,1526187726.347 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-05-13T05:02:06.348Z,1526187726.348 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-05-13T05:02:06.493Z,1526187726.493 [Aanderaa_O2] Loaded
2018-05-13T05:02:06.493Z,1526187726.493 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-05-13T05:02:06.540Z,1526187726.540 [CTD_Seabird] Loaded
2018-05-13T05:02:06.540Z,1526187726.540 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-05-13T05:02:06.541Z,1526187726.541 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408754E0
2018-05-13T05:02:06.542Z,1526187726.542 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7220
2018-05-13T05:02:06.558Z,1526187726.558 [ESPComponent] Loaded
2018-05-13T05:02:06.558Z,1526187726.558 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2018-05-13T05:02:06.572Z,1526187726.572 [PAR_Licor] Loaded
2018-05-13T05:02:06.573Z,1526187726.573 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-05-13T05:02:06.621Z,1526187726.621 [WetLabsBB2FL] Loaded
2018-05-13T05:02:06.621Z,1526187726.621 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-05-13T05:02:06.622Z,1526187726.622 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0
2018-05-13T05:02:06.622Z,1526187726.622 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7221
2018-05-13T05:02:06.623Z,1526187726.623 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-05-13T05:02:06.624Z,1526187726.624 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-05-13T05:02:06.861Z,1526187726.861 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-05-13T05:02:06.861Z,1526187726.861 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-05-13T05:02:06.931Z,1526187726.931 [VerticalControl](DEBUG): Construct VerticalControl.
2018-05-13T05:02:07.024Z,1526187727.024 [VerticalControl] Loaded
2018-05-13T05:02:07.025Z,1526187727.025 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-05-13T05:02:07.025Z,1526187727.025 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-05-13T05:02:07.086Z,1526187727.086 [HorizontalControl] Loaded
2018-05-13T05:02:07.086Z,1526187727.086 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-05-13T05:02:07.087Z,1526187727.087 [SpeedControl](DEBUG): Construct SpeedControl.
2018-05-13T05:02:07.092Z,1526187727.092 [SpeedControl] Loaded
2018-05-13T05:02:07.093Z,1526187727.093 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-05-13T05:02:07.093Z,1526187727.093 [LoopControl](DEBUG): Construct LoopControl.
2018-05-13T05:02:07.094Z,1526187727.094 [LoopControl] Loaded
2018-05-13T05:02:07.094Z,1526187727.094 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-05-13T05:02:07.095Z,1526187727.095 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-05-13T05:02:07.095Z,1526187727.095 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-05-13T05:02:07.177Z,1526187727.177 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-05-13T05:02:07.177Z,1526187727.177 [StratificationFrontDetector](DEBUG): (re)initializing
2018-05-13T05:02:07.177Z,1526187727.177 [StratificationFrontDetector] Loaded
2018-05-13T05:02:07.178Z,1526187727.178 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-05-13T05:02:07.178Z,1526187727.178 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-05-13T05:02:07.179Z,1526187727.179 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-05-13T05:02:07.276Z,1526187727.276 [BuoyancyServo] Loaded
2018-05-13T05:02:07.276Z,1526187727.276 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-05-13T05:02:07.287Z,1526187727.287 [ElevatorServo] Loaded
2018-05-13T05:02:07.288Z,1526187727.288 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-05-13T05:02:07.298Z,1526187727.298 [MassServo] Loaded
2018-05-13T05:02:07.299Z,1526187727.299 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-05-13T05:02:07.309Z,1526187727.309 [RudderServo] Loaded
2018-05-13T05:02:07.310Z,1526187727.310 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-05-13T05:02:07.320Z,1526187727.320 [ThrusterServo] Loaded
2018-05-13T05:02:07.321Z,1526187727.321 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-05-13T05:02:07.321Z,1526187727.321 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-05-13T05:02:07.322Z,1526187727.322 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-05-13T05:02:07.417Z,1526187727.417 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-05-13T05:02:07.418Z,1526187727.418 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-05-13T05:02:07.472Z,1526187727.472 [DeadReckonUsingSpeedCalculator] Loaded
2018-05-13T05:02:07.472Z,1526187727.472 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-05-13T05:02:07.488Z,1526187727.488 [NavChart] Loaded
2018-05-13T05:02:07.489Z,1526187727.489 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-05-13T05:02:07.493Z,1526187727.493 [UniversalFixResidualReporter] Loaded
2018-05-13T05:02:07.493Z,1526187727.493 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-05-13T05:02:07.493Z,1526187727.493 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-05-13T05:02:07.497Z,1526187727.497 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-05-13T05:02:07.498Z,1526187727.498 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-05-13T05:02:07.505Z,1526187727.505 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-05-13T05:02:07.506Z,1526187727.506 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409FE4E0
2018-05-13T05:02:07.506Z,1526187727.506 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7222
2018-05-13T05:02:07.511Z,1526187727.511 [Supervisor](INFO): Main Thread ID is 7135
2018-05-13T05:02:07.511Z,1526187727.511 [Supervisor](DEBUG): Running supervisor.
2018-05-13T05:02:07.512Z,1526187727.512 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7223
2018-05-13T05:02:07.515Z,1526187727.515 [controlThread ThreadHandler](INFO): Handler Thread ID is 7224
2018-05-13T05:02:07.515Z,1526187727.515 [controlThread](DEBUG): Initializing ControlThread
2018-05-13T05:02:07.516Z,1526187727.516 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-05-13T05:02:07.516Z,1526187727.516 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-05-13T05:02:07.517Z,1526187727.517 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-05-13T05:02:07.517Z,1526187727.517 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-05-13T05:02:07.518Z,1526187727.518 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-05-13T05:02:07.518Z,1526187727.518 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-05-13T05:02:07.519Z,1526187727.519 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-05-13T05:02:07.522Z,1526187727.522 [SBIT](INFO): Initialize SBIT Component.
2018-05-13T05:02:07.522Z,1526187727.522 [SBIT](IMPORTANT): git: 2018-03-26-61-g3a7ff4a
2018-05-13T05:02:07.523Z,1526187727.523 [SBIT](INFO): git hash: 3a7ff4a2c61851fe6454e78a1ec1c4bd5c76df54
2018-05-13T05:02:07.523Z,1526187727.523 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-05-13T05:02:07.524Z,1526187727.524 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #16 PREEMPT Thu Apr 12 16:20:47 PDT 2018
2018-05-13T05:02:07.525Z,1526187727.525 [SBIT](INFO): Beginning SBIT in 52.000000 seconds.
2018-05-13T05:02:07.526Z,1526187727.526 [IBIT](INFO): Initialize IBIT Component.
2018-05-13T05:02:07.527Z,1526187727.527 [CBIT](DEBUG): Initialize CBIT Component.
2018-05-13T05:02:07.527Z,1526187727.527 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2018-05-13T05:02:07.528Z,1526187727.528 [logger ThreadHandler](INFO): Handler Thread ID is 7225
2018-05-13T05:02:07.545Z,1526187727.545 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7226
2018-05-13T05:02:07.551Z,1526187727.551 [Radio_Surface](INFO): Powering up
2018-05-13T05:02:07.557Z,1526187727.557 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7227
2018-05-13T05:02:07.558Z,1526187727.558 [CTD_Seabird](INFO): Initializing
2018-05-13T05:02:07.558Z,1526187727.558 [CTD_Seabird](INFO): Checking LCM
2018-05-13T05:02:07.567Z,1526187727.567 [CTD_Seabird](INFO): LCM OK
2018-05-13T05:02:07.567Z,1526187727.567 [CTD_Seabird](INFO): Powering up
2018-05-13T05:02:07.573Z,1526187727.573 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7228
2018-05-13T05:02:07.574Z,1526187727.574 [WetLabsBB2FL](INFO): Powering down
2018-05-13T05:02:07.601Z,1526187727.601 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7229
2018-05-13T05:02:07.604Z,1526187727.604 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-05-13T05:02:07.605Z,1526187727.605 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-05-13T05:02:07.605Z,1526187727.605 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-05-13T05:02:07.605Z,1526187727.605 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-05-13T05:02:07.605Z,1526187727.605 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-05-13T05:02:07.605Z,1526187727.605 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-05-13T05:02:07.606Z,1526187727.606 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-05-13T05:02:07.606Z,1526187727.606 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-05-13T05:02:07.606Z,1526187727.606 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-05-13T05:02:07.606Z,1526187727.606 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-05-13T05:02:07.606Z,1526187727.606 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-05-13T05:02:07.606Z,1526187727.606 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-05-13T05:02:07.607Z,1526187727.607 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-05-13T05:02:07.607Z,1526187727.607 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-05-13T05:02:07.607Z,1526187727.607 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-05-13T05:02:07.607Z,1526187727.607 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-05-13T05:02:07.637Z,1526187727.637 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-05-13T05:02:07.639Z,1526187727.639 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-05-13T05:02:07.639Z,1526187727.639 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-05-13T05:02:07.640Z,1526187727.640 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-05-13T05:02:07.642Z,1526187727.642 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-05-13T05:02:07.643Z,1526187727.643 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-05-13T05:02:07.643Z,1526187727.643 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-05-13T05:02:07.643Z,1526187727.643 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-05-13T05:02:07.644Z,1526187727.644 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-05-13T05:02:07.644Z,1526187727.644 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-05-13T05:02:07.645Z,1526187727.645 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-05-13T05:02:07.645Z,1526187727.645 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-05-13T05:02:07.646Z,1526187727.646 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-05-13T05:02:07.670Z,1526187727.670 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-05-13T05:02:07.705Z,1526187727.705 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2018-05-13T05:02:07.706Z,1526187727.706 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-05-13T05:02:07.784Z,1526187727.784 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-05-13T05:02:07.801Z,1526187727.801 [Default:A.Wait](DEBUG): Construct Wait.
2018-05-13T05:02:07.803Z,1526187727.803 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-05-13T05:02:07.845Z,1526187727.845 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-05-13T05:02:07.848Z,1526187727.848 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-05-13T05:02:07.872Z,1526187727.872 [Default:E.Execute](DEBUG): Construct Execute.
2018-05-13T05:02:07.895Z,1526187727.895 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Guidance="Tethys/Guidance"
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2018-05-13T05:02:07.900Z,1526187727.900 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,NAL9602,Onboard,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-05-13T05:02:07.931Z,1526187727.931 [AHRS_M2](INFO): Start
2018-05-13T05:02:07.931Z,1526187727.931 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-05-13T05:02:07.981Z,1526187727.981 [AcousticModem_Benthos_ATM900](INFO): Powering up
2018-05-13T05:02:07.981Z,1526187727.981 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2018-05-13T05:02:08.007Z,1526187728.007 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-05-13T05:02:08.320Z,1526187728.320 [ESPComponent](INFO): powering down ESP
2018-05-13T05:02:08.873Z,1526187728.873 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:08.897Z,1526187728.897 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:09.003Z,1526187729.003 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:02:09.009Z,1526187729.009 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-05-13T05:02:09.027Z,1526187729.027 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:02:09.033Z,1526187729.033 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-05-13T05:02:09.055Z,1526187729.055 [MassServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:02:09.061Z,1526187729.061 [MassServo](DEBUG): Initializing MassServo.
2018-05-13T05:02:09.073Z,1526187729.073 [RudderServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:02:09.077Z,1526187729.077 [RudderServo](DEBUG): Initializing RudderServo.
2018-05-13T05:02:09.102Z,1526187729.102 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:02:09.109Z,1526187729.109 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-05-13T05:02:09.126Z,1526187729.126 [CommandLine](FAULT): Scheduling is paused
2018-05-13T05:02:09.126Z,1526187729.126 [CBIT](INFO): Critical error at 20180513T050207
2018-05-13T05:02:09.127Z,1526187729.127 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-05-13T05:02:09.225Z,1526187729.225 [AHRS_M2](INFO): Starting
2018-05-13T05:02:09.339Z,1526187729.339 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:09.340Z,1526187729.340 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:09.581Z,1526187729.581 [AHRS_M2](INFO): Starting
2018-05-13T05:02:13.087Z,1526187733.087 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-13T05:02:13.216Z,1526187733.216 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null &
2018-05-13T05:02:13.278Z,1526187733.278 [CTD_Seabird](INFO): LCM subscribed to channel:ctd_t.seabird-gpctd
2018-05-13T05:02:13.753Z,1526187733.753 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-13T05:02:13.754Z,1526187733.754 [CTD_Seabird](INFO): Powering down
2018-05-13T05:02:18.291Z,1526187738.291 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:18.292Z,1526187738.292 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:18.602Z,1526187738.602 [AHRS_M2](INFO): Starting
2018-05-13T05:02:18.625Z,1526187738.625 [AHRS_M2](FAULT): Failed to initialize
2018-05-13T05:02:18.625Z,1526187738.625 [AHRS_M2] Communications Fault, FailCount= 1
2018-05-13T05:02:18.625Z,1526187738.625 [AHRS_M2](ERROR): Communications Fault
2018-05-13T05:02:18.629Z,1526187738.629 [AcousticModem_Benthos_ATM900](DEBUG): 
2018-05-13T05:02:18.635Z,1526187738.635 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2018-05-13T05:02:18.636Z,1526187738.636 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2018-05-13T05:02:18.636Z,1526187738.636 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2018-05-13T05:02:18.649Z,1526187738.649 [AcousticModem_Benthos_ATM900](DEBUG): Apr  6 2000 10:59:48 
2018-05-13T05:02:18.653Z,1526187738.653 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low
2018-05-13T05:02:18.682Z,1526187738.682 [Aanderaa_O2](FAULT): Timed out starting
2018-05-13T05:02:18.682Z,1526187738.682 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-05-13T05:02:18.682Z,1526187738.682 [Aanderaa_O2](ERROR): Communications Fault
2018-05-13T05:02:18.690Z,1526187738.690 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:18.691Z,1526187738.691 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:18.723Z,1526187738.723 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-05-13T05:02:18.723Z,1526187738.723 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-05-13T05:02:19.005Z,1526187739.005 [AHRS_M2](INFO): Stop
2018-05-13T05:02:19.029Z,1526187739.029 [AHRS_M2](INFO): uninitialize
2018-05-13T05:02:19.029Z,1526187739.029 [AHRS_M2](INFO): Powering down
2018-05-13T05:02:19.253Z,1526187739.253 [Aanderaa_O2](INFO): Powering down
2018-05-13T05:02:19.303Z,1526187739.303 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:19.304Z,1526187739.304 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:19.405Z,1526187739.405 [AHRS_M2](INFO): Stopping
2018-05-13T05:02:19.406Z,1526187739.406 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2018-05-13T05:02:19.413Z,1526187739.413 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005519
2018-05-13T05:02:19.462Z,1526187739.462 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:19.463Z,1526187739.463 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:19.805Z,1526187739.805 [AHRS_M2](INFO): Stopping
2018-05-13T05:02:19.805Z,1526187739.805 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2018-05-13T05:02:19.806Z,1526187739.806 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2018-05-13T05:02:19.806Z,1526187739.806 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2018-05-13T05:02:19.884Z,1526187739.884 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:19.886Z,1526187739.886 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:19.993Z,1526187739.993 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-05-13T05:02:19.993Z,1526187739.993 [Aanderaa_O2] No Fault, FailCount= 1
2018-05-13T05:02:20.205Z,1526187740.205 [AHRS_M2](INFO): Stopping
2018-05-13T05:02:20.205Z,1526187740.205 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2018-05-13T05:02:20.290Z,1526187740.290 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:20.292Z,1526187740.292 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:20.605Z,1526187740.605 [AHRS_M2](INFO): Stopped
2018-05-13T05:02:20.606Z,1526187740.606 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2018-05-13T05:02:20.607Z,1526187740.607 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2018-05-13T05:02:20.677Z,1526187740.677 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:20.678Z,1526187740.678 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:20.786Z,1526187740.786 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-05-13T05:02:20.786Z,1526187740.786 [AHRS_M2] No Fault, FailCount= 1
2018-05-13T05:02:21.005Z,1526187741.005 [AHRS_M2](INFO): Start
2018-05-13T05:02:21.005Z,1526187741.005 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-05-13T05:02:21.014Z,1526187741.014 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2018-05-13T05:02:21.053Z,1526187741.053 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:21.054Z,1526187741.054 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:21.405Z,1526187741.405 [AHRS_M2](INFO): Starting
2018-05-13T05:02:21.438Z,1526187741.438 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:21.439Z,1526187741.439 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:21.802Z,1526187741.802 [AHRS_M2](INFO): Starting
2018-05-13T05:02:21.884Z,1526187741.884 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:21.893Z,1526187741.893 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:22.205Z,1526187742.205 [AHRS_M2](INFO): Starting
2018-05-13T05:02:22.283Z,1526187742.283 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:22.284Z,1526187742.284 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:22.605Z,1526187742.605 [AHRS_M2](INFO): Starting
2018-05-13T05:02:22.662Z,1526187742.662 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:22.663Z,1526187742.663 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:23.006Z,1526187743.006 [AHRS_M2](INFO): Starting
2018-05-13T05:02:23.095Z,1526187743.095 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:23.096Z,1526187743.096 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:23.405Z,1526187743.405 [AHRS_M2](INFO): Starting
2018-05-13T05:02:23.474Z,1526187743.474 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:23.475Z,1526187743.475 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:23.805Z,1526187743.805 [AHRS_M2](INFO): Starting
2018-05-13T05:02:23.866Z,1526187743.866 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:23.867Z,1526187743.867 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:24.205Z,1526187744.205 [AHRS_M2](INFO): Starting
2018-05-13T05:02:24.258Z,1526187744.258 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:24.259Z,1526187744.259 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:24.605Z,1526187744.605 [AHRS_M2](INFO): Starting
2018-05-13T05:02:24.644Z,1526187744.644 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:24.653Z,1526187744.653 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:25.005Z,1526187745.005 [AHRS_M2](INFO): Starting
2018-05-13T05:02:25.105Z,1526187745.105 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:25.106Z,1526187745.106 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:02:25.405Z,1526187745.405 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:25.433Z,1526187745.433 [AHRS_M2](ERROR): Tx (24): 0xa 0x1 0x14 0x69 0x0 0x77 0x61 0xb3 0xc2 0xad 0xe5 0x8c 0xc2 0x6d 0x2e 0x28 0x43 0xaa 0x82 0xdb 0x41 0x2a 0x66 0x3
2018-05-13T05:02:25.435Z,1526187745.435 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x77 0x61 0xb3 0xc2 0xad 0xe5 0x8c 0xc2 0x6d 0x2e 0x28 0x43 0xaa 0x82 0xdb 0x41 0x2a 0x66
2018-05-13T05:02:25.436Z,1526187745.436 [AHRS_M2](ERROR): extractFloat: 0x77 0x61 0xb3 0xc2
2018-05-13T05:02:25.437Z,1526187745.437 [AHRS_M2](ERROR): extractFloat: 0xad 0xe5 0x8c 0xc2
2018-05-13T05:02:25.438Z,1526187745.438 [AHRS_M2](ERROR): extractFloat: 0x6d 0x2e 0x28 0x43
2018-05-13T05:02:25.439Z,1526187745.439 [AHRS_M2](ERROR): extractFloat: 0xaa 0x82 0xdb 0x41
2018-05-13T05:02:25.440Z,1526187745.440 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027321 deg, ROLL: -0.021460 deg, YAW: 0.051231 deg, TEMP: 27.438801 C.
2018-05-13T05:02:25.805Z,1526187745.805 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:25.830Z,1526187745.830 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0xa1 0x7a 0x8c 0xc2 0xf2 0xf9 0x27 0x43 0xee 0x88 0xdb 0x41 0x30 0x9d 0x3
2018-05-13T05:02:25.832Z,1526187745.832 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0xa1 0x7a 0x8c 0xc2 0xf2 0xf9 0x27 0x43 0xee 0x88 0xdb 0x41 0x30 0x9d
2018-05-13T05:02:25.833Z,1526187745.833 [AHRS_M2](ERROR): extractFloat: 0xc9 0x61 0xb3 0xc2
2018-05-13T05:02:25.833Z,1526187745.833 [AHRS_M2](ERROR): extractFloat: 0xa1 0x7a 0x8c 0xc2
2018-05-13T05:02:25.834Z,1526187745.834 [AHRS_M2](ERROR): extractFloat: 0xf2 0xf9 0x27 0x43
2018-05-13T05:02:25.835Z,1526187745.835 [AHRS_M2](ERROR): extractFloat: 0xee 0x88 0xdb 0x41
2018-05-13T05:02:25.836Z,1526187745.836 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027321 deg, ROLL: -0.021396 deg, YAW: 0.051169 deg, TEMP: 27.441860 C.
2018-05-13T05:02:26.205Z,1526187746.205 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:26.230Z,1526187746.230 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0x1c 0x62 0xb3 0xc2 0xe9 0x25 0x8d 0xc2 0x33 0x50 0x28 0x43 0x10 0x90 0x5d 0xdb 0x41 0xbb 0x5a 0x3
2018-05-13T05:02:26.232Z,1526187746.232 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x1c 0x62 0xb3 0xc2 0xe9 0x25 0x8d 0xc2 0x33 0x50 0x28 0x43 0x10 0x5d 0xdb 0x41 0xbb 0x5a
2018-05-13T05:02:26.232Z,1526187746.232 [AHRS_M2](ERROR): extractFloat: 0x1c 0x62 0xb3 0xc2
2018-05-13T05:02:26.233Z,1526187746.233 [AHRS_M2](ERROR): extractFloat: 0xe9 0x25 0x8d 0xc2
2018-05-13T05:02:26.234Z,1526187746.234 [AHRS_M2](ERROR): extractFloat: 0x33 0x50 0x28 0x43
2018-05-13T05:02:26.235Z,1526187746.235 [AHRS_M2](ERROR): extractFloat: 0x10 0x5d 0xdb 0x41
2018-05-13T05:02:26.236Z,1526187746.236 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021498 deg, YAW: 0.051271 deg, TEMP: 27.420441 C.
2018-05-13T05:02:26.605Z,1526187746.605 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:26.630Z,1526187746.630 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0xca 0x6e 0x8f 0xc2 0x87 0x79 0x29 0x43 0x66 0x7c 0xdb 0x41 0x36 0x6b 0x3
2018-05-13T05:02:26.632Z,1526187746.632 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0xca 0x6e 0x8f 0xc2 0x87 0x79 0x29 0x43 0x66 0x7c 0xdb 0x41 0x36 0x6b
2018-05-13T05:02:26.633Z,1526187746.633 [AHRS_M2](ERROR): extractFloat: 0x67 0x64 0xb3 0xc2
2018-05-13T05:02:26.633Z,1526187746.633 [AHRS_M2](ERROR): extractFloat: 0xca 0x6e 0x8f 0xc2
2018-05-13T05:02:26.634Z,1526187746.634 [AHRS_M2](ERROR): extractFloat: 0x87 0x79 0x29 0x43
2018-05-13T05:02:26.635Z,1526187746.635 [AHRS_M2](ERROR): extractFloat: 0x66 0x7c 0xdb 0x41
2018-05-13T05:02:26.636Z,1526187746.636 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021846 deg, YAW: 0.051625 deg, TEMP: 27.435741 C.
2018-05-13T05:02:27.005Z,1526187747.005 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:27.030Z,1526187747.030 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0x23 0xf0 0x8f 0xc2 0x0 0xbb 0x29 0x43 0x66 0x7c 0xdb 0x41 0x47 0x8c 0x3
2018-05-13T05:02:27.032Z,1526187747.032 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0x23 0xf0 0x8f 0xc2 0x0 0xbb 0x29 0x43 0x66 0x7c 0xdb 0x41 0x47 0x8c
2018-05-13T05:02:27.033Z,1526187747.033 [AHRS_M2](ERROR): extractFloat: 0xba 0x66 0xb3 0xc2
2018-05-13T05:02:27.033Z,1526187747.033 [AHRS_M2](ERROR): extractFloat: 0x23 0xf0 0x8f 0xc2
2018-05-13T05:02:27.034Z,1526187747.034 [AHRS_M2](ERROR): extractFloat: 0x0 0xbb 0x29 0x43
2018-05-13T05:02:27.035Z,1526187747.035 [AHRS_M2](ERROR): extractFloat: 0x66 0x7c 0xdb 0x41
2018-05-13T05:02:27.036Z,1526187747.036 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027324 deg, ROLL: -0.021923 deg, YAW: 0.051703 deg, TEMP: 27.435741 C.
2018-05-13T05:02:27.405Z,1526187747.405 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:27.463Z,1526187747.463 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x9f 0x3c 0x8c 0xc2 0xa0 0xda 0x27 0x43 0x77 0x95 0xdb 0x41 0x96 0xa7 0x3
2018-05-13T05:02:27.465Z,1526187747.465 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x9f 0x3c 0x8c 0xc2 0xa0 0xda 0x27 0x43 0x77 0x95 0xdb 0x41 0x96 0xa7
2018-05-13T05:02:27.465Z,1526187747.465 [AHRS_M2](ERROR): extractFloat: 0xbb 0x64 0xb3 0xc2
2018-05-13T05:02:27.466Z,1526187747.466 [AHRS_M2](ERROR): extractFloat: 0x9f 0x3c 0x8c 0xc2
2018-05-13T05:02:27.467Z,1526187747.467 [AHRS_M2](ERROR): extractFloat: 0xa0 0xda 0x27 0x43
2018-05-13T05:02:27.468Z,1526187747.468 [AHRS_M2](ERROR): extractFloat: 0x77 0x95 0xdb 0x41
2018-05-13T05:02:27.485Z,1526187747.485 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021359 deg, YAW: 0.051131 deg, TEMP: 27.447981 C.
2018-05-13T05:02:27.805Z,1526187747.805 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:27.830Z,1526187747.830 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0xa3 0x10 0x96 0x8c 0xc2 0x54 0xc6 0x27 0x43 0x77 0x95 0xdb 0x41 0x60 0x98 0x3
2018-05-13T05:02:27.832Z,1526187747.832 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0xa3 0x16 0x8c 0xc2 0x54 0xc6 0x27 0x43 0x77 0x95 0xdb 0x41 0x60 0x98
2018-05-13T05:02:27.833Z,1526187747.833 [AHRS_M2](ERROR): extractFloat: 0x67 0x64 0xb3 0xc2
2018-05-13T05:02:27.834Z,1526187747.834 [AHRS_M2](ERROR): extractFloat: 0xa3 0x16 0x8c 0xc2
2018-05-13T05:02:27.834Z,1526187747.834 [AHRS_M2](ERROR): extractFloat: 0x54 0xc6 0x27 0x43
2018-05-13T05:02:27.835Z,1526187747.835 [AHRS_M2](ERROR): extractFloat: 0x77 0x95 0xdb 0x41
2018-05-13T05:02:27.836Z,1526187747.836 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021337 deg, YAW: 0.051107 deg, TEMP: 27.447981 C.
2018-05-13T05:02:28.205Z,1526187748.205 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:28.230Z,1526187748.230 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0x36 0x8f 0x8a 0xc2 0xa6 0x0 0x27 0x43 0xee 0x88 0xdb 0x41 0x7 0xe6 0x3
2018-05-13T05:02:28.232Z,1526187748.232 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0x36 0x8f 0x8a 0xc2 0xa6 0x0 0x27 0x43 0xee 0x88 0xdb 0x41 0x7 0xe6
2018-05-13T05:02:28.233Z,1526187748.233 [AHRS_M2](ERROR): extractFloat: 0x67 0x64 0xb3 0xc2
2018-05-13T05:02:28.233Z,1526187748.233 [AHRS_M2](ERROR): extractFloat: 0x36 0x8f 0x8a 0xc2
2018-05-13T05:02:28.234Z,1526187748.234 [AHRS_M2](ERROR): extractFloat: 0xa6 0x0 0x27 0x43
2018-05-13T05:02:28.235Z,1526187748.235 [AHRS_M2](ERROR): extractFloat: 0xee 0x88 0xdb 0x41
2018-05-13T05:02:28.236Z,1526187748.236 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021104 deg, YAW: 0.050872 deg, TEMP: 27.441860 C.
2018-05-13T05:02:28.605Z,1526187748.605 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:28.630Z,1526187748.630 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x1c 0x62 0xb3 0xc2 0x9e 0xab 0x8a 0xc2 0x47 0xf 0x27 0x43 0xbb 0x9b 0xdb 0x41 0x8b 0xa9 0x3
2018-05-13T05:02:28.632Z,1526187748.632 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x1c 0x62 0xb3 0xc2 0x9e 0xab 0x8a 0xc2 0x47 0xf 0x27 0x43 0xbb 0x9b 0xdb 0x41 0x8b 0xa9
2018-05-13T05:02:28.632Z,1526187748.632 [AHRS_M2](ERROR): extractFloat: 0x1c 0x62 0xb3 0xc2
2018-05-13T05:02:28.633Z,1526187748.633 [AHRS_M2](ERROR): extractFloat: 0x9e 0xab 0x8a 0xc2
2018-05-13T05:02:28.634Z,1526187748.634 [AHRS_M2](ERROR): extractFloat: 0x47 0xf 0x27 0x43
2018-05-13T05:02:28.635Z,1526187748.635 [AHRS_M2](ERROR): extractFloat: 0xbb 0x9b 0xdb 0x41
2018-05-13T05:02:28.636Z,1526187748.636 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021121 deg, YAW: 0.050889 deg, TEMP: 27.451040 C.
2018-05-13T05:02:29.005Z,1526187749.005 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:29.030Z,1526187749.030 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x6f 0x62 0xb3 0xc2 0xa2 0x5d 0x8a 0xc2 0x43 0xe9 0x26 0x43 0x21 0x76 0xdb 0x41 0xb9 0xcd 0x3
2018-05-13T05:02:29.032Z,1526187749.032 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x6f 0x62 0xb3 0xc2 0xa2 0x5d 0x8a 0xc2 0x43 0xe9 0x26 0x43 0x21 0x76 0xdb 0x41 0xb9 0xcd
2018-05-13T05:02:29.033Z,1526187749.033 [AHRS_M2](ERROR): extractFloat: 0x6f 0x62 0xb3 0xc2
2018-05-13T05:02:29.033Z,1526187749.033 [AHRS_M2](ERROR): extractFloat: 0xa2 0x5d 0x8a 0xc2
2018-05-13T05:02:29.034Z,1526187749.034 [AHRS_M2](ERROR): extractFloat: 0x43 0xe9 0x26 0x43
2018-05-13T05:02:29.035Z,1526187749.035 [AHRS_M2](ERROR): extractFloat: 0x21 0x76 0xdb 0x41
2018-05-13T05:02:29.036Z,1526187749.036 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021074 deg, YAW: 0.050844 deg, TEMP: 27.432680 C.
2018-05-13T05:02:29.405Z,1526187749.405 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:29.430Z,1526187749.430 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0x53 0x3a 0x89 0xc2 0xc0 0x56 0x26 0x43 0x77 0x95 0xdb 0x41 0x2 0xf0 0x3
2018-05-13T05:02:29.432Z,1526187749.432 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0x53 0x3a 0x89 0xc2 0xc0 0x56 0x26 0x43 0x77 0x95 0xdb 0x41 0x2 0xf0
2018-05-13T05:02:29.433Z,1526187749.433 [AHRS_M2](ERROR): extractFloat: 0x12 0x64 0xb3 0xc2
2018-05-13T05:02:29.433Z,1526187749.433 [AHRS_M2](ERROR): extractFloat: 0x53 0x3a 0x89 0xc2
2018-05-13T05:02:29.434Z,1526187749.434 [AHRS_M2](ERROR): extractFloat: 0xc0 0x56 0x26 0x43
2018-05-13T05:02:29.435Z,1526187749.435 [AHRS_M2](ERROR): extractFloat: 0x77 0x95 0xdb 0x41
2018-05-13T05:02:29.436Z,1526187749.436 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.020901 deg, YAW: 0.050670 deg, TEMP: 27.447981 C.
2018-05-13T05:02:29.805Z,1526187749.805 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:29.830Z,1526187749.830 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0xbe 0x63 0xb3 0xc2 0x24 0x2d 0x8c 0xc2 0x1b 0xd5 0x27 0x43 0xee 0x88 0xdb 0x41 0x75 0x10 0x95 0x3
2018-05-13T05:02:29.832Z,1526187749.832 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbe 0x63 0xb3 0xc2 0x24 0x2d 0x8c 0xc2 0x1b 0xd5 0x27 0x43 0xee 0x88 0xdb 0x41 0x75 0x15
2018-05-13T05:02:29.833Z,1526187749.833 [AHRS_M2](ERROR): extractFloat: 0xbe 0x63 0xb3 0xc2
2018-05-13T05:02:29.833Z,1526187749.833 [AHRS_M2](ERROR): extractFloat: 0x24 0x2d 0x8c 0xc2
2018-05-13T05:02:29.834Z,1526187749.834 [AHRS_M2](ERROR): extractFloat: 0x1b 0xd5 0x27 0x43
2018-05-13T05:02:29.835Z,1526187749.835 [AHRS_M2](ERROR): extractFloat: 0xee 0x88 0xdb 0x41
2018-05-13T05:02:29.836Z,1526187749.836 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021350 deg, YAW: 0.051125 deg, TEMP: 27.441860 C.
2018-05-13T05:02:30.205Z,1526187750.205 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:30.231Z,1526187750.231 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0xc5 0x66 0x8e 0xc2 0xc3 0xf3 0x28 0x43 0xaa 0x82 0xdb 0x41 0x99 0x8d 0x3
2018-05-13T05:02:30.232Z,1526187750.232 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0xc5 0x66 0x8e 0xc2 0xc3 0xf3 0x28 0x43 0xaa 0x82 0xdb 0x41 0x99 0x8d
2018-05-13T05:02:30.233Z,1526187750.233 [AHRS_M2](ERROR): extractFloat: 0x17 0x63 0xb3 0xc2
2018-05-13T05:02:30.234Z,1526187750.234 [AHRS_M2](ERROR): extractFloat: 0xc5 0x66 0x8e 0xc2
2018-05-13T05:02:30.234Z,1526187750.234 [AHRS_M2](ERROR): extractFloat: 0xc3 0xf3 0x28 0x43
2018-05-13T05:02:30.235Z,1526187750.235 [AHRS_M2](ERROR): extractFloat: 0xaa 0x82 0xdb 0x41
2018-05-13T05:02:30.236Z,1526187750.236 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021689 deg, YAW: 0.051466 deg, TEMP: 27.438801 C.
2018-05-13T05:02:30.268Z,1526187750.268 [Aanderaa_O2](FAULT): Timed out starting
2018-05-13T05:02:30.269Z,1526187750.269 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-05-13T05:02:30.269Z,1526187750.269 [Aanderaa_O2](ERROR): Communications Fault
2018-05-13T05:02:30.343Z,1526187750.343 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-05-13T05:02:30.605Z,1526187750.605 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:30.631Z,1526187750.631 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x65 0x65 0xb3 0xc2 0xeb 0x27 0x8d 0xc2 0x1e 0x51 0x28 0x43 0xdd 0x6f 0xdb 0x41 0x81 0x89 0x3
2018-05-13T05:02:30.632Z,1526187750.632 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x65 0x65 0xb3 0xc2 0xeb 0x27 0x8d 0xc2 0x1e 0x51 0x28 0x43 0xdd 0x6f 0xdb 0x41 0x81 0x89
2018-05-13T05:02:30.633Z,1526187750.633 [AHRS_M2](ERROR): extractFloat: 0x65 0x65 0xb3 0xc2
2018-05-13T05:02:30.633Z,1526187750.633 [AHRS_M2](ERROR): extractFloat: 0xeb 0x27 0x8d 0xc2
2018-05-13T05:02:30.634Z,1526187750.634 [AHRS_M2](ERROR): extractFloat: 0x1e 0x51 0x28 0x43
2018-05-13T05:02:30.635Z,1526187750.635 [AHRS_M2](ERROR): extractFloat: 0xdd 0x6f 0xdb 0x41
2018-05-13T05:02:30.636Z,1526187750.636 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027324 deg, ROLL: -0.021499 deg, YAW: 0.051272 deg, TEMP: 27.429621 C.
2018-05-13T05:02:30.785Z,1526187750.785 [Aanderaa_O2](INFO): Powering down
2018-05-13T05:02:31.005Z,1526187751.005 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:31.031Z,1526187751.031 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x6a 0x63 0xb3 0xc2 0x9c 0xea 0x8d 0xc2 0xf9 0xb1 0x28 0x43 0x87 0x50 0xdb 0x41 0x1f 0x3a 0x3
2018-05-13T05:02:31.032Z,1526187751.032 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x6a 0x63 0xb3 0xc2 0x9c 0xea 0x8d 0xc2 0xf9 0xb1 0x28 0x43 0x87 0x50 0xdb 0x41 0x1f 0x3a
2018-05-13T05:02:31.033Z,1526187751.033 [AHRS_M2](ERROR): extractFloat: 0x6a 0x63 0xb3 0xc2
2018-05-13T05:02:31.033Z,1526187751.033 [AHRS_M2](ERROR): extractFloat: 0x9c 0xea 0x8d 0xc2
2018-05-13T05:02:31.034Z,1526187751.034 [AHRS_M2](ERROR): extractFloat: 0xf9 0xb1 0x28 0x43
2018-05-13T05:02:31.035Z,1526187751.035 [AHRS_M2](ERROR): extractFloat: 0x87 0x50 0xdb 0x41
2018-05-13T05:02:31.036Z,1526187751.036 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021615 deg, YAW: 0.051387 deg, TEMP: 27.414320 C.
2018-05-13T05:02:31.405Z,1526187751.405 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:31.435Z,1526187751.435 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x6f 0x62 0xb3 0xc2 0xd5 0x4b 0x8d 0xc2 0x63 0x61 0x28 0x43 0x66 0x7c 0xdb 0x41 0xb6 0xea 0x3
2018-05-13T05:02:31.436Z,1526187751.436 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x6f 0x62 0xb3 0xc2 0xd5 0x4b 0x8d 0xc2 0x63 0x61 0x28 0x43 0x66 0x7c 0xdb 0x41 0xb6 0xea
2018-05-13T05:02:31.437Z,1526187751.437 [AHRS_M2](ERROR): extractFloat: 0x6f 0x62 0xb3 0xc2
2018-05-13T05:02:31.438Z,1526187751.438 [AHRS_M2](ERROR): extractFloat: 0xd5 0x4b 0x8d 0xc2
2018-05-13T05:02:31.438Z,1526187751.438 [AHRS_M2](ERROR): extractFloat: 0x63 0x61 0x28 0x43
2018-05-13T05:02:31.439Z,1526187751.439 [AHRS_M2](ERROR): extractFloat: 0x66 0x7c 0xdb 0x41
2018-05-13T05:02:31.440Z,1526187751.440 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021521 deg, YAW: 0.051292 deg, TEMP: 27.435741 C.
2018-05-13T05:02:31.562Z,1526187751.562 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-05-13T05:02:31.562Z,1526187751.562 [Aanderaa_O2] No Fault, FailCount= 2
2018-05-13T05:02:31.805Z,1526187751.805 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:31.831Z,1526187751.831 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0x97 0x51 0x8d 0xc2 0x5e 0x64 0x28 0x43 0x99 0x69 0xdb 0x41 0xb6 0x41 0x3
2018-05-13T05:02:31.833Z,1526187751.833 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0x97 0x51 0x8d 0xc2 0x5e 0x64 0x28 0x43 0x99 0x69 0xdb 0x41 0xb6 0x41
2018-05-13T05:02:31.833Z,1526187751.833 [AHRS_M2](ERROR): extractFloat: 0x12 0x64 0xb3 0xc2
2018-05-13T05:02:31.834Z,1526187751.834 [AHRS_M2](ERROR): extractFloat: 0x97 0x51 0x8d 0xc2
2018-05-13T05:02:31.835Z,1526187751.835 [AHRS_M2](ERROR): extractFloat: 0x5e 0x64 0x28 0x43
2018-05-13T05:02:31.836Z,1526187751.836 [AHRS_M2](ERROR): extractFloat: 0x99 0x69 0xdb 0x41
2018-05-13T05:02:31.837Z,1526187751.837 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021524 deg, YAW: 0.051295 deg, TEMP: 27.426561 C.
2018-05-13T05:02:32.205Z,1526187752.205 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:32.230Z,1526187752.230 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0x4d 0xec 0x8e 0xc2 0xde 0x34 0x29 0x43 0xee 0x88 0xdb 0x41 0xc3 0xc6 0x3
2018-05-13T05:02:32.232Z,1526187752.232 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0x4d 0xec 0x8e 0xc2 0xde 0x34 0x29 0x43 0xee 0x88 0xdb 0x41 0xc3 0xc6
2018-05-13T05:02:32.233Z,1526187752.233 [AHRS_M2](ERROR): extractFloat: 0xba 0x66 0xb3 0xc2
2018-05-13T05:02:32.233Z,1526187752.233 [AHRS_M2](ERROR): extractFloat: 0x4d 0xec 0x8e 0xc2
2018-05-13T05:02:32.234Z,1526187752.234 [AHRS_M2](ERROR): extractFloat: 0xde 0x34 0x29 0x43
2018-05-13T05:02:32.235Z,1526187752.235 [AHRS_M2](ERROR): extractFloat: 0xee 0x88 0xdb 0x41
2018-05-13T05:02:32.236Z,1526187752.236 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027324 deg, ROLL: -0.021768 deg, YAW: 0.051543 deg, TEMP: 27.441860 C.
2018-05-13T05:02:32.634Z,1526187752.634 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:32.636Z,1526187752.636 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0xdc 0x21 0x8e 0xc2 0x76 0xcd 0x28 0x43 0x44 0xa8 0xdb 0x41 0xb5 0x98 0x3
2018-05-13T05:02:32.637Z,1526187752.637 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0xdc 0x21 0x8e 0xc2 0x76 0xcd 0x28 0x43 0x44 0xa8 0xdb 0x41 0xb5 0x98
2018-05-13T05:02:32.638Z,1526187752.638 [AHRS_M2](ERROR): extractFloat: 0x67 0x64 0xb3 0xc2
2018-05-13T05:02:32.639Z,1526187752.639 [AHRS_M2](ERROR): extractFloat: 0xdc 0x21 0x8e 0xc2
2018-05-13T05:02:32.640Z,1526187752.640 [AHRS_M2](ERROR): extractFloat: 0x76 0xcd 0x28 0x43
2018-05-13T05:02:32.641Z,1526187752.641 [AHRS_M2](ERROR): extractFloat: 0x44 0xa8 0xdb 0x41
2018-05-13T05:02:32.642Z,1526187752.642 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021648 deg, YAW: 0.051420 deg, TEMP: 27.457161 C.
2018-05-13T05:02:33.005Z,1526187753.005 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:33.030Z,1526187753.030 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0x81 0x48 0x8d 0xc2 0xa5 0x5f 0x28 0x43 0xaa 0x82 0xdb 0x41 0xa 0x60 0x3
2018-05-13T05:02:33.032Z,1526187753.032 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0x81 0x48 0x8d 0xc2 0xa5 0x5f 0x28 0x43 0xaa 0x82 0xdb 0x41 0xa 0x60
2018-05-13T05:02:33.032Z,1526187753.032 [AHRS_M2](ERROR): extractFloat: 0x67 0x64 0xb3 0xc2
2018-05-13T05:02:33.034Z,1526187753.034 [AHRS_M2](ERROR): extractFloat: 0x81 0x48 0x8d 0xc2
2018-05-13T05:02:33.035Z,1526187753.035 [AHRS_M2](ERROR): extractFloat: 0xa5 0x5f 0x28 0x43
2018-05-13T05:02:33.035Z,1526187753.035 [AHRS_M2](ERROR): extractFloat: 0xaa 0x82 0xdb 0x41
2018-05-13T05:02:33.037Z,1526187753.037 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021519 deg, YAW: 0.051290 deg, TEMP: 27.438801 C.
2018-05-13T05:02:33.405Z,1526187753.405 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:33.430Z,1526187753.430 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0xcd 0x31 0x8d 0xc2 0xfb 0x53 0x28 0x43 0x21 0x76 0xdb 0x41 0x3a 0x62 0x3
2018-05-13T05:02:33.432Z,1526187753.432 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0xcd 0x31 0x8d 0xc2 0xfb 0x53 0x28 0x43 0x21 0x76 0xdb 0x41 0x3a 0x62
2018-05-13T05:02:33.433Z,1526187753.433 [AHRS_M2](ERROR): extractFloat: 0x12 0x64 0xb3 0xc2
2018-05-13T05:02:33.433Z,1526187753.433 [AHRS_M2](ERROR): extractFloat: 0xcd 0x31 0x8d 0xc2
2018-05-13T05:02:33.434Z,1526187753.434 [AHRS_M2](ERROR): extractFloat: 0xfb 0x53 0x28 0x43
2018-05-13T05:02:33.435Z,1526187753.435 [AHRS_M2](ERROR): extractFloat: 0x21 0x76 0xdb 0x41
2018-05-13T05:02:33.436Z,1526187753.436 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021505 deg, YAW: 0.051276 deg, TEMP: 27.432680 C.
2018-05-13T05:02:33.805Z,1526187753.805 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:33.831Z,1526187753.831 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xbf 0x68 0xb3 0xc2 0xe4 0x35 0x8d 0xc2 0xc6 0x56 0x28 0x43 0x21 0x76 0xdb 0x41 0xbf 0xa6 0x3
2018-05-13T05:02:33.832Z,1526187753.832 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbf 0x68 0xb3 0xc2 0xe4 0x35 0x8d 0xc2 0xc6 0x56 0x28 0x43 0x21 0x76 0xdb 0x41 0xbf 0xa6
2018-05-13T05:02:33.833Z,1526187753.833 [AHRS_M2](ERROR): extractFloat: 0xbf 0x68 0xb3 0xc2
2018-05-13T05:02:33.834Z,1526187753.834 [AHRS_M2](ERROR): extractFloat: 0xe4 0x35 0x8d 0xc2
2018-05-13T05:02:33.834Z,1526187753.834 [AHRS_M2](ERROR): extractFloat: 0xc6 0x56 0x28 0x43
2018-05-13T05:02:33.835Z,1526187753.835 [AHRS_M2](ERROR): extractFloat: 0x21 0x76 0xdb 0x41
2018-05-13T05:02:33.836Z,1526187753.836 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027326 deg, ROLL: -0.021508 deg, YAW: 0.051279 deg, TEMP: 27.432680 C.
2018-05-13T05:02:34.205Z,1526187754.205 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:34.231Z,1526187754.231 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x7c 0x6b 0xb3 0xc2 0x3e 0xa5 0x8c 0xc2 0xc6 0xd 0x28 0x43 0x32 0x8f 0xdb 0x41 0x82 0xb6 0x3
2018-05-13T05:02:34.232Z,1526187754.232 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x7c 0x6b 0xb3 0xc2 0x3e 0xa5 0x8c 0xc2 0xc6 0xd 0x28 0x43 0x32 0x8f 0xdb 0x41 0x82 0xb6
2018-05-13T05:02:34.233Z,1526187754.233 [AHRS_M2](ERROR): extractFloat: 0x7c 0x6b 0xb3 0xc2
2018-05-13T05:02:34.234Z,1526187754.234 [AHRS_M2](ERROR): extractFloat: 0x3e 0xa5 0x8c 0xc2
2018-05-13T05:02:34.234Z,1526187754.234 [AHRS_M2](ERROR): extractFloat: 0xc6 0xd 0x28 0x43
2018-05-13T05:02:34.235Z,1526187754.235 [AHRS_M2](ERROR): extractFloat: 0x32 0x8f 0xdb 0x41
2018-05-13T05:02:34.236Z,1526187754.236 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027327 deg, ROLL: -0.021422 deg, YAW: 0.051192 deg, TEMP: 27.444920 C.
2018-05-13T05:02:34.606Z,1526187754.606 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:34.638Z,1526187754.638 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xf 0x66 0xb3 0xc2 0x5 0xd7 0x8e 0xc2 0xd6 0x28 0x29 0x43 0xff 0xa1 0xdb 0x41 0x6b 0xa 0x3
2018-05-13T05:02:34.640Z,1526187754.640 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xf 0x66 0xb3 0xc2 0x5 0xd7 0x8e 0xc2 0xd6 0x28 0x29 0x43 0xff 0xa1 0xdb 0x41 0x6b 0xa
2018-05-13T05:02:34.645Z,1526187754.645 [AHRS_M2](ERROR): extractFloat: 0xf 0x66 0xb3 0xc2
2018-05-13T05:02:34.646Z,1526187754.646 [AHRS_M2](ERROR): extractFloat: 0x5 0xd7 0x8e 0xc2
2018-05-13T05:02:34.647Z,1526187754.647 [AHRS_M2](ERROR): extractFloat: 0xd6 0x28 0x29 0x43
2018-05-13T05:02:34.647Z,1526187754.647 [AHRS_M2](ERROR): extractFloat: 0xff 0xa1 0xdb 0x41
2018-05-13T05:02:34.653Z,1526187754.653 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027324 deg, ROLL: -0.021756 deg, YAW: 0.051529 deg, TEMP: 27.454100 C.
2018-05-13T05:02:35.004Z,1526187755.004 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:35.031Z,1526187755.031 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xbf 0x68 0xb3 0xc2 0x40 0xe2 0x90 0xc2 0x49 0x35 0x2a 0x43 0xaa 0x82 0xdb 0x41 0xe3 0xf 0x3
2018-05-13T05:02:35.032Z,1526187755.032 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbf 0x68 0xb3 0xc2 0x40 0xe2 0x90 0xc2 0x49 0x35 0x2a 0x43 0xaa 0x82 0xdb 0x41 0xe3 0xf
2018-05-13T05:02:35.033Z,1526187755.033 [AHRS_M2](ERROR): extractFloat: 0xbf 0x68 0xb3 0xc2
2018-05-13T05:02:35.034Z,1526187755.034 [AHRS_M2](ERROR): extractFloat: 0x40 0xe2 0x90 0xc2
2018-05-13T05:02:35.035Z,1526187755.035 [AHRS_M2](ERROR): extractFloat: 0x49 0x35 0x2a 0x43
2018-05-13T05:02:35.035Z,1526187755.035 [AHRS_M2](ERROR): extractFloat: 0xaa 0x82 0xdb 0x41
2018-05-13T05:02:35.037Z,1526187755.037 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027326 deg, ROLL: -0.022067 deg, YAW: 0.051848 deg, TEMP: 27.438801 C.
2018-05-13T05:02:35.405Z,1526187755.405 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:35.431Z,1526187755.431 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0xb0 0xaf 0x8f 0xc2 0xf5 0x98 0x29 0x43 0x77 0x95 0xdb 0x41 0xdc 0x21 0x3
2018-05-13T05:02:35.432Z,1526187755.432 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0xb0 0xaf 0x8f 0xc2 0xf5 0x98 0x29 0x43 0x77 0x95 0xdb 0x41 0xdc 0x21
2018-05-13T05:02:35.433Z,1526187755.433 [AHRS_M2](ERROR): extractFloat: 0xc9 0x61 0xb3 0xc2
2018-05-13T05:02:35.434Z,1526187755.434 [AHRS_M2](ERROR): extractFloat: 0xb0 0xaf 0x8f 0xc2
2018-05-13T05:02:35.435Z,1526187755.435 [AHRS_M2](ERROR): extractFloat: 0xf5 0x98 0x29 0x43
2018-05-13T05:02:35.435Z,1526187755.435 [AHRS_M2](ERROR): extractFloat: 0x77 0x95 0xdb 0x41
2018-05-13T05:02:35.436Z,1526187755.436 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027321 deg, ROLL: -0.021885 deg, YAW: 0.051662 deg, TEMP: 27.447981 C.
2018-05-13T05:02:35.799Z,1526187755.799 [CommandLine](IMPORTANT): got command quit
2018-05-13T05:02:35.805Z,1526187755.805 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:35.831Z,1526187755.831 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0x0 0xa3 0x8d 0xc2 0xa6 0x90 0x28 0x43 0xff 0xa1 0xdb 0x41 0xad 0x5 0x3
2018-05-13T05:02:35.832Z,1526187755.832 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0x0 0xa3 0x8d 0xc2 0xa6 0x90 0x28 0x43 0xff 0xa1 0xdb 0x41 0xad 0x5
2018-05-13T05:02:35.833Z,1526187755.833 [AHRS_M2](ERROR): extractFloat: 0x17 0x63 0xb3 0xc2
2018-05-13T05:02:35.834Z,1526187755.834 [AHRS_M2](ERROR): extractFloat: 0x0 0xa3 0x8d 0xc2
2018-05-13T05:02:35.834Z,1526187755.834 [AHRS_M2](ERROR): extractFloat: 0xa6 0x90 0x28 0x43
2018-05-13T05:02:35.835Z,1526187755.835 [AHRS_M2](ERROR): extractFloat: 0xff 0xa1 0xdb 0x41
2018-05-13T05:02:35.836Z,1526187755.836 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021573 deg, YAW: 0.051348 deg, TEMP: 27.454100 C.
2018-05-13T05:02:36.205Z,1526187756.205 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:36.231Z,1526187756.231 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0x10 0x90 0x65 0xb3 0xc2 0xcd 0x75 0x8c 0xc2 0xc3 0xf9 0x27 0x43 0x77 0x95 0xdb 0x41 0xae 0xa7 0x3
2018-05-13T05:02:36.232Z,1526187756.232 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x10 0x65 0xb3 0xc2 0xcd 0x75 0x8c 0xc2 0xc3 0xf9 0x27 0x43 0x77 0x95 0xdb 0x41 0xae 0xa7
2018-05-13T05:02:36.233Z,1526187756.233 [AHRS_M2](ERROR): extractFloat: 0x10 0x65 0xb3 0xc2
2018-05-13T05:02:36.234Z,1526187756.234 [AHRS_M2](ERROR): extractFloat: 0xcd 0x75 0x8c 0xc2
2018-05-13T05:02:36.235Z,1526187756.235 [AHRS_M2](ERROR): extractFloat: 0xc3 0xf9 0x27 0x43
2018-05-13T05:02:36.235Z,1526187756.235 [AHRS_M2](ERROR): extractFloat: 0x77 0x95 0xdb 0x41
2018-05-13T05:02:36.237Z,1526187756.237 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021393 deg, YAW: 0.051168 deg, TEMP: 27.447981 C.
2018-05-13T05:02:36.604Z,1526187756.604 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:36.631Z,1526187756.631 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x56 0x5 0x8c 0xc2 0xfe 0xbf 0x27 0x43 0xaa 0x82 0xdb 0x41 0xb4 0xa5 0x3
2018-05-13T05:02:36.632Z,1526187756.632 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x56 0x5 0x8c 0xc2 0xfe 0xbf 0x27 0x43 0xaa 0x82 0xdb 0x41 0xb4 0xa5
2018-05-13T05:02:36.633Z,1526187756.633 [AHRS_M2](ERROR): extractFloat: 0xbb 0x64 0xb3 0xc2
2018-05-13T05:02:36.634Z,1526187756.634 [AHRS_M2](ERROR): extractFloat: 0x56 0x5 0x8c 0xc2
2018-05-13T05:02:36.635Z,1526187756.635 [AHRS_M2](ERROR): extractFloat: 0xfe 0xbf 0x27 0x43
2018-05-13T05:02:36.636Z,1526187756.636 [AHRS_M2](ERROR): extractFloat: 0xaa 0x82 0xdb 0x41
2018-05-13T05:02:36.649Z,1526187756.649 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027323 deg, ROLL: -0.021326 deg, YAW: 0.051100 deg, TEMP: 27.438801 C.
2018-05-13T05:02:36.804Z,1526187756.804 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:02:36.805Z,1526187756.805 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:36.849Z,1526187756.849 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-05-13T05:02:36.849Z,1526187756.849 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:36.849Z,1526187756.849 [CommandLine](INFO): Join timeout helper Thread ID is 7247
2018-05-13T05:02:36.867Z,1526187756.867 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-05-13T05:02:36.867Z,1526187756.867 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:36.867Z,1526187756.867 [NavChartDb](INFO): Join timeout helper Thread ID is 7248
2018-05-13T05:02:37.007Z,1526187757.007 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:37.034Z,1526187757.034 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x6a 0x63 0xb3 0xc2 0xb4 0x12 0x8b 0xc2 0x0 0x44 0x27 0x43 0xbb 0x9b 0xdb 0x41 0xbb 0x5e 0x3
2018-05-13T05:02:37.036Z,1526187757.036 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x6a 0x63 0xb3 0xc2 0xb4 0x12 0x8b 0xc2 0x0 0x44 0x27 0x43 0xbb 0x9b 0xdb 0x41 0xbb 0x5e
2018-05-13T05:02:37.037Z,1526187757.037 [AHRS_M2](ERROR): extractFloat: 0x6a 0x63 0xb3 0xc2
2018-05-13T05:02:37.037Z,1526187757.037 [AHRS_M2](ERROR): extractFloat: 0xb4 0x12 0x8b 0xc2
2018-05-13T05:02:37.038Z,1526187757.038 [AHRS_M2](ERROR): extractFloat: 0x0 0x44 0x27 0x43
2018-05-13T05:02:37.039Z,1526187757.039 [AHRS_M2](ERROR): extractFloat: 0xbb 0x9b 0xdb 0x41
2018-05-13T05:02:37.040Z,1526187757.040 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021182 deg, YAW: 0.050952 deg, TEMP: 27.451040 C.
2018-05-13T05:02:37.405Z,1526187757.405 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:37.431Z,1526187757.431 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0x5e 0xa7 0x89 0xc2 0x10 0x95 0x8a 0x26 0x43 0xaa 0x82 0xdb 0x41 0x8a 0xa7 0x3
2018-05-13T05:02:37.433Z,1526187757.433 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0x5e 0xa7 0x89 0xc2 0x15 0x8a 0x26 0x43 0xaa 0x82 0xdb 0x41 0x8a 0xa7
2018-05-13T05:02:37.434Z,1526187757.434 [AHRS_M2](ERROR): extractFloat: 0x17 0x63 0xb3 0xc2
2018-05-13T05:02:37.435Z,1526187757.435 [AHRS_M2](ERROR): extractFloat: 0x5e 0xa7 0x89 0xc2
2018-05-13T05:02:37.435Z,1526187757.435 [AHRS_M2](ERROR): extractFloat: 0x15 0x8a 0x26 0x43
2018-05-13T05:02:37.436Z,1526187757.436 [AHRS_M2](ERROR): extractFloat: 0xaa 0x82 0xdb 0x41
2018-05-13T05:02:37.437Z,1526187757.437 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.020966 deg, YAW: 0.050731 deg, TEMP: 27.438801 C.
2018-05-13T05:02:37.804Z,1526187757.804 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:37.831Z,1526187757.831 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x6a 0x63 0xb3 0xc2 0x4b 0x4b 0x8a 0xc2 0x8a 0xdd 0x26 0x43 0xee 0x88 0xdb 0x41 0xcf 0x98 0x3
2018-05-13T05:02:37.833Z,1526187757.833 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x6a 0x63 0xb3 0xc2 0x4b 0x4b 0x8a 0xc2 0x8a 0xdd 0x26 0x43 0xee 0x88 0xdb 0x41 0xcf 0x98
2018-05-13T05:02:37.833Z,1526187757.833 [AHRS_M2](ERROR): extractFloat: 0x6a 0x63 0xb3 0xc2
2018-05-13T05:02:37.834Z,1526187757.834 [AHRS_M2](ERROR): extractFloat: 0x4b 0x4b 0x8a 0xc2
2018-05-13T05:02:37.835Z,1526187757.835 [AHRS_M2](ERROR): extractFloat: 0x8a 0xdd 0x26 0x43
2018-05-13T05:02:37.836Z,1526187757.836 [AHRS_M2](ERROR): extractFloat: 0xee 0x88 0xdb 0x41
2018-05-13T05:02:37.837Z,1526187757.837 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.021063 deg, YAW: 0.050830 deg, TEMP: 27.441860 C.
2018-05-13T05:02:38.200Z,1526187758.200 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:02:38.200Z,1526187758.200 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:38.205Z,1526187758.205 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:38.213Z,1526187758.213 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-05-13T05:02:38.213Z,1526187758.213 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:38.214Z,1526187758.214 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7249
2018-05-13T05:02:38.231Z,1526187758.231 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0x60 0x3d 0x89 0xc2 0x6b 0x55 0x26 0x43 0xdd 0x6f 0xdb 0x41 0x9 0xc9 0x3
2018-05-13T05:02:38.233Z,1526187758.233 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0x60 0x3d 0x89 0xc2 0x6b 0x55 0x26 0x43 0xdd 0x6f 0xdb 0x41 0x9 0xc9
2018-05-13T05:02:38.233Z,1526187758.233 [AHRS_M2](ERROR): extractFloat: 0x17 0x63 0xb3 0xc2
2018-05-13T05:02:38.234Z,1526187758.234 [AHRS_M2](ERROR): extractFloat: 0x60 0x3d 0x89 0xc2
2018-05-13T05:02:38.235Z,1526187758.235 [AHRS_M2](ERROR): extractFloat: 0x6b 0x55 0x26 0x43
2018-05-13T05:02:38.236Z,1526187758.236 [AHRS_M2](ERROR): extractFloat: 0xdd 0x6f 0xdb 0x41
2018-05-13T05:02:38.237Z,1526187758.237 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027322 deg, ROLL: -0.020903 deg, YAW: 0.050668 deg, TEMP: 27.429621 C.
2018-05-13T05:02:38.417Z,1526187758.417 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:02:38.417Z,1526187758.417 [WetLabsBB2FL](INFO): Powering down
2018-05-13T05:02:38.418Z,1526187758.418 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:38.437Z,1526187758.437 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2018-05-13T05:02:38.437Z,1526187758.437 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:38.437Z,1526187758.437 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7250
2018-05-13T05:02:38.605Z,1526187758.605 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:38.632Z,1526187758.632 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x65 0x65 0xb3 0xc2 0xb9 0xb1 0x8b 0xc2 0xf7 0x93 0x27 0x43 0x21 0x76 0xdb 0x41 0xc4 0xe7 0x3
2018-05-13T05:02:38.633Z,1526187758.633 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x65 0x65 0xb3 0xc2 0xb9 0xb1 0x8b 0xc2 0xf7 0x93 0x27 0x43 0x21 0x76 0xdb 0x41 0xc4 0xe7
2018-05-13T05:02:38.634Z,1526187758.634 [AHRS_M2](ERROR): extractFloat: 0x65 0x65 0xb3 0xc2
2018-05-13T05:02:38.635Z,1526187758.635 [AHRS_M2](ERROR): extractFloat: 0xb9 0xb1 0x8b 0xc2
2018-05-13T05:02:38.635Z,1526187758.635 [AHRS_M2](ERROR): extractFloat: 0xf7 0x93 0x27 0x43
2018-05-13T05:02:38.636Z,1526187758.636 [AHRS_M2](ERROR): extractFloat: 0x21 0x76 0xdb 0x41
2018-05-13T05:02:38.637Z,1526187758.637 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027324 deg, ROLL: -0.021277 deg, YAW: 0.051047 deg, TEMP: 27.432680 C.
2018-05-13T05:02:38.825Z,1526187758.825 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:02:38.912Z,1526187758.912 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-13T05:02:38.912Z,1526187758.912 [CTD_Seabird](INFO): Powering down
2018-05-13T05:02:38.913Z,1526187758.913 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:38.917Z,1526187758.917 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-05-13T05:02:38.917Z,1526187758.917 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:38.918Z,1526187758.918 [Radio_Surface](INFO): Join timeout helper Thread ID is 7252
2018-05-13T05:02:39.005Z,1526187759.005 [AHRS_M2](INFO): Runnable
2018-05-13T05:02:39.032Z,1526187759.032 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0x80 0x10 0x81 0x8c 0xc2 0xcf 0xbb 0x27 0x43 0xee 0x88 0xdb 0x41 0x91 0x19 0x3
2018-05-13T05:02:39.034Z,1526187759.034 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0x80 0x1 0x8c 0xc2 0xcf 0xbb 0x27 0x43 0xee 0x88 0xdb 0x41 0x91 0x19
2018-05-13T05:02:39.035Z,1526187759.035 [AHRS_M2](ERROR): extractFloat: 0xc9 0x61 0xb3 0xc2
2018-05-13T05:02:39.035Z,1526187759.035 [AHRS_M2](ERROR): extractFloat: 0x80 0x1 0x8c 0xc2
2018-05-13T05:02:39.036Z,1526187759.036 [AHRS_M2](ERROR): extractFloat: 0xcf 0xbb 0x27 0x43
2018-05-13T05:02:39.037Z,1526187759.037 [AHRS_M2](ERROR): extractFloat: 0xee 0x88 0xdb 0x41
2018-05-13T05:02:39.039Z,1526187759.039 [AHRS_M2](DEBUG): CRC match. PITCH: -0.027321 deg, ROLL: -0.021324 deg, YAW: 0.051095 deg, TEMP: 27.441860 C.
2018-05-13T05:02:39.097Z,1526187759.097 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:02:39.097Z,1526187759.097 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.118Z,1526187759.118 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-05-13T05:02:39.118Z,1526187759.118 [logger ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.118Z,1526187759.118 [logger](INFO): Join timeout helper Thread ID is 7253
2018-05-13T05:02:39.134Z,1526187759.134 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:02:39.135Z,1526187759.135 [logger ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.146Z,1526187759.146 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-05-13T05:02:39.146Z,1526187759.146 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.146Z,1526187759.146 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-05-13T05:02:39.146Z,1526187759.146 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.147Z,1526187759.147 [controlThread](INFO): Join timeout helper Thread ID is 7254
2018-05-13T05:02:39.156Z,1526187759.156 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:02:39.156Z,1526187759.156 [controlThread](DEBUG): Uninitializing ControlThread
2018-05-13T05:02:39.156Z,1526187759.156 [AHRS_M2](INFO): uninitialize
2018-05-13T05:02:39.156Z,1526187759.156 [AHRS_M2](INFO): Powering down
2018-05-13T05:02:39.229Z,1526187759.229 [AcousticModem_Benthos_ATM900](INFO): Powering down
2018-05-13T05:02:39.349Z,1526187759.349 [NAL9602](INFO): Powering down
2018-05-13T05:02:39.469Z,1526187759.469 [Aanderaa_O2](INFO): Powering down
2018-05-13T05:02:39.472Z,1526187759.472 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-05-13T05:02:39.473Z,1526187759.473 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-05-13T05:02:39.474Z,1526187759.474 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-05-13T05:02:39.474Z,1526187759.474 [MissionManager](INFO): Uninitializing Mission Default
2018-05-13T05:02:39.477Z,1526187759.477 [MissionManager](INFO): Uninitializing Mission Startup
2018-05-13T05:02:39.478Z,1526187759.478 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-05-13T05:02:39.478Z,1526187759.478 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-05-13T05:02:39.479Z,1526187759.479 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-05-13T05:02:39.479Z,1526187759.479 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-05-13T05:02:39.479Z,1526187759.479 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-05-13T05:02:39.479Z,1526187759.479 [BuoyancyServo](INFO): Powering down
2018-05-13T05:02:39.493Z,1526187759.493 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-05-13T05:02:39.493Z,1526187759.493 [ElevatorServo](INFO): Powering down
2018-05-13T05:02:39.513Z,1526187759.513 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-05-13T05:02:39.513Z,1526187759.513 [MassServo](INFO): Powering down
2018-05-13T05:02:39.514Z,1526187759.514 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-05-13T05:02:39.514Z,1526187759.514 [RudderServo](INFO): Powering down
2018-05-13T05:02:39.515Z,1526187759.515 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-05-13T05:02:39.515Z,1526187759.515 [ThrusterServo](INFO): Powering down
2018-05-13T05:02:39.516Z,1526187759.516 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-05-13T05:02:39.516Z,1526187759.516 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-05-13T05:02:39.516Z,1526187759.516 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-05-13T05:02:39.517Z,1526187759.517 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.606Z,1526187759.606 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.646Z,1526187759.646 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.650Z,1526187759.650 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:39.933Z,1526187759.933 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:02:40.054Z,1526187760.054 [logger ThreadHandler](INFO): Thread cancelled.