2018-05-13T05:05:47.862Z,1526187947.862 [Supervisor](DEBUG): Initializing supervisor.
2018-05-13T05:05:47.864Z,1526187947.864 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-05-13T05:05:47.865Z,1526187947.865 [SyncHandler](INFO): Protected caller Thread ID is 8359
2018-05-13T05:05:47.865Z,1526187947.865 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-05-13T05:05:47.866Z,1526187947.866 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-05-13T05:05:47.866Z,1526187947.866 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8360
2018-05-13T05:05:47.869Z,1526187947.869 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-05-13T05:05:47.880Z,1526187947.880 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-05-13T05:05:47.881Z,1526187947.881 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-05-13T05:05:47.881Z,1526187947.881 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8361
2018-05-13T05:05:47.882Z,1526187947.882 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-05-13T05:05:47.883Z,1526187947.883 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-05-13T05:05:47.883Z,1526187947.883 [logger ThreadHandler](INFO): Protected caller Thread ID is 8362
2018-05-13T05:05:47.885Z,1526187947.885 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-05-13T05:05:47.885Z,1526187947.885 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-05-13T05:05:47.887Z,1526187947.887 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-05-13T05:05:47.980Z,1526187947.980 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-05-13T05:05:47.981Z,1526187947.981 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-05-13T05:05:48.077Z,1526187948.077 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-05-13T05:05:48.078Z,1526187948.078 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-05-13T05:05:48.266Z,1526187948.266 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-05-13T05:05:48.266Z,1526187948.266 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-05-13T05:05:48.565Z,1526187948.565 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-05-13T05:05:48.566Z,1526187948.566 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-05-13T05:05:48.878Z,1526187948.878 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-05-13T05:05:48.879Z,1526187948.879 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-05-13T05:05:49.312Z,1526187949.312 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-05-13T05:05:49.312Z,1526187949.312 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-05-13T05:05:49.657Z,1526187949.657 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-05-13T05:05:49.658Z,1526187949.658 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-05-13T05:05:50.075Z,1526187950.075 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-05-13T05:05:50.076Z,1526187950.076 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-05-13T05:05:50.154Z,1526187950.154 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-05-13T05:05:50.435Z,1526187950.435 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-05-13T05:05:50.435Z,1526187950.435 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-05-13T05:05:50.573Z,1526187950.573 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-05-13T05:05:50.573Z,1526187950.573 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-05-13T05:05:50.773Z,1526187950.773 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-05-13T05:05:50.774Z,1526187950.774 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-05-13T05:05:50.975Z,1526187950.975 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-05-13T05:05:50.975Z,1526187950.975 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-05-13T05:05:51.070Z,1526187951.070 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-05-13T05:05:51.070Z,1526187951.070 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-05-13T05:05:51.205Z,1526187951.205 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-05-13T05:05:51.207Z,1526187951.207 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2018-05-13T05:05:51.208Z,1526187951.208 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2018-05-13T05:05:51.434Z,1526187951.434 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-05-13T05:05:51.434Z,1526187951.434 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2018-05-13T05:05:51.510Z,1526187951.510 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2018-05-13T05:05:51.645Z,1526187951.645 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2018-05-13T05:05:51.735Z,1526187951.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2018-05-13T05:05:51.818Z,1526187951.818 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2018-05-13T05:05:51.950Z,1526187951.950 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2018-05-13T05:05:52.116Z,1526187952.116 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2018-05-13T05:05:52.210Z,1526187952.210 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2018-05-13T05:05:52.299Z,1526187952.299 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2018-05-13T05:05:52.392Z,1526187952.392 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2018-05-13T05:05:52.473Z,1526187952.473 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-05-13T05:05:52.485Z,1526187952.485 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-05-13T05:05:52.581Z,1526187952.581 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-05-13T05:05:52.581Z,1526187952.581 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-05-13T05:05:52.595Z,1526187952.595 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-05-13T05:05:52.595Z,1526187952.595 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-05-13T05:05:52.635Z,1526187952.635 [DepthRateCalculator] Loaded
2018-05-13T05:05:52.636Z,1526187952.636 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-05-13T05:05:52.641Z,1526187952.641 [PitchRateCalculator] Loaded
2018-05-13T05:05:52.641Z,1526187952.641 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-05-13T05:05:52.656Z,1526187952.656 [SpeedCalculator] Loaded
2018-05-13T05:05:52.657Z,1526187952.657 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-05-13T05:05:52.677Z,1526187952.677 [TempGradientCalculator] Loaded
2018-05-13T05:05:52.677Z,1526187952.677 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-05-13T05:05:52.692Z,1526187952.692 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-05-13T05:05:52.693Z,1526187952.693 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-05-13T05:05:52.698Z,1526187952.698 [YawRateCalculator] Loaded
2018-05-13T05:05:52.698Z,1526187952.698 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-05-13T05:05:52.736Z,1526187952.736 [ElevatorOffsetCalculator] Loaded
2018-05-13T05:05:52.737Z,1526187952.737 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-05-13T05:05:52.737Z,1526187952.737 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-05-13T05:05:52.738Z,1526187952.738 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-05-13T05:05:52.841Z,1526187952.841 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-05-13T05:05:52.842Z,1526187952.842 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-05-13T05:05:53.574Z,1526187953.574 [AHRS_M2] Loaded
2018-05-13T05:05:53.575Z,1526187953.575 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-05-13T05:05:53.617Z,1526187953.617 [AcousticModem_Benthos_ATM900] Loaded
2018-05-13T05:05:53.617Z,1526187953.617 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2018-05-13T05:05:53.686Z,1526187953.686 [DataOverHttps] Loaded
2018-05-13T05:05:53.687Z,1526187953.687 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-05-13T05:05:53.700Z,1526187953.700 [Depth_Keller] Loaded
2018-05-13T05:05:53.700Z,1526187953.700 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-05-13T05:05:53.700Z,1526187953.700 [Module Loader](CRITICAL): Could not find element GobyModem.loadAtStartup
2018-05-13T05:05:53.793Z,1526187953.793 [NAL9602] Loaded
2018-05-13T05:05:53.794Z,1526187953.794 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-05-13T05:05:53.809Z,1526187953.809 [Onboard] Loaded
2018-05-13T05:05:53.809Z,1526187953.809 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-05-13T05:05:53.819Z,1526187953.819 [Radio_Surface] Loaded
2018-05-13T05:05:53.819Z,1526187953.819 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-05-13T05:05:53.820Z,1526187953.820 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407B54E0
2018-05-13T05:05:53.821Z,1526187953.821 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8441
2018-05-13T05:05:53.821Z,1526187953.821 [Module Loader](CRITICAL): Could not find element RDI_Pathfinder.loadAtStartup
2018-05-13T05:05:55.526Z,1526187955.526 [BPC1] Loaded
2018-05-13T05:05:55.526Z,1526187955.526 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-05-13T05:05:55.527Z,1526187955.527 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-05-13T05:05:55.527Z,1526187955.527 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-05-13T05:05:55.652Z,1526187955.652 [SBIT](DEBUG): Construct Startup Built In Test.
2018-05-13T05:05:55.674Z,1526187955.674 [SBIT] Loaded
2018-05-13T05:05:55.675Z,1526187955.675 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-05-13T05:05:55.675Z,1526187955.675 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-05-13T05:05:55.686Z,1526187955.686 [IBIT] Loaded
2018-05-13T05:05:55.686Z,1526187955.686 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-05-13T05:05:55.690Z,1526187955.690 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-05-13T05:05:55.835Z,1526187955.835 [CBIT] Loaded
2018-05-13T05:05:55.835Z,1526187955.835 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-05-13T05:05:55.836Z,1526187955.836 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-05-13T05:05:55.836Z,1526187955.836 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-05-13T05:05:55.973Z,1526187955.973 [Aanderaa_O2] Loaded
2018-05-13T05:05:55.974Z,1526187955.974 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-05-13T05:05:56.090Z,1526187956.090 [CTD_Seabird] Loaded
2018-05-13T05:05:56.090Z,1526187956.090 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-05-13T05:05:56.091Z,1526187956.091 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408754E0
2018-05-13T05:05:56.091Z,1526187956.091 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8443
2018-05-13T05:05:56.107Z,1526187956.107 [ESPComponent] Loaded
2018-05-13T05:05:56.107Z,1526187956.107 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2018-05-13T05:05:56.121Z,1526187956.121 [PAR_Licor] Loaded
2018-05-13T05:05:56.121Z,1526187956.121 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-05-13T05:05:56.169Z,1526187956.169 [WetLabsBB2FL] Loaded
2018-05-13T05:05:56.170Z,1526187956.170 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-05-13T05:05:56.170Z,1526187956.170 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0
2018-05-13T05:05:56.171Z,1526187956.171 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8444
2018-05-13T05:05:56.171Z,1526187956.171 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-05-13T05:05:56.172Z,1526187956.172 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-05-13T05:05:56.403Z,1526187956.403 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-05-13T05:05:56.404Z,1526187956.404 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-05-13T05:05:56.470Z,1526187956.470 [VerticalControl](DEBUG): Construct VerticalControl.
2018-05-13T05:05:56.562Z,1526187956.562 [VerticalControl] Loaded
2018-05-13T05:05:56.562Z,1526187956.562 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-05-13T05:05:56.563Z,1526187956.563 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-05-13T05:05:56.622Z,1526187956.622 [HorizontalControl] Loaded
2018-05-13T05:05:56.622Z,1526187956.622 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-05-13T05:05:56.623Z,1526187956.623 [SpeedControl](DEBUG): Construct SpeedControl.
2018-05-13T05:05:56.628Z,1526187956.628 [SpeedControl] Loaded
2018-05-13T05:05:56.628Z,1526187956.628 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-05-13T05:05:56.629Z,1526187956.629 [LoopControl](DEBUG): Construct LoopControl.
2018-05-13T05:05:56.630Z,1526187956.630 [LoopControl] Loaded
2018-05-13T05:05:56.630Z,1526187956.630 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-05-13T05:05:56.630Z,1526187956.630 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-05-13T05:05:56.631Z,1526187956.631 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-05-13T05:05:56.711Z,1526187956.711 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-05-13T05:05:56.711Z,1526187956.711 [StratificationFrontDetector](DEBUG): (re)initializing
2018-05-13T05:05:56.712Z,1526187956.712 [StratificationFrontDetector] Loaded
2018-05-13T05:05:56.712Z,1526187956.712 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-05-13T05:05:56.712Z,1526187956.712 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-05-13T05:05:56.713Z,1526187956.713 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-05-13T05:05:56.808Z,1526187956.808 [BuoyancyServo] Loaded
2018-05-13T05:05:56.808Z,1526187956.808 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-05-13T05:05:56.819Z,1526187956.819 [ElevatorServo] Loaded
2018-05-13T05:05:56.819Z,1526187956.819 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-05-13T05:05:56.830Z,1526187956.830 [MassServo] Loaded
2018-05-13T05:05:56.830Z,1526187956.830 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-05-13T05:05:56.841Z,1526187956.841 [RudderServo] Loaded
2018-05-13T05:05:56.841Z,1526187956.841 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-05-13T05:05:56.851Z,1526187956.851 [ThrusterServo] Loaded
2018-05-13T05:05:56.852Z,1526187956.852 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-05-13T05:05:56.852Z,1526187956.852 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-05-13T05:05:56.853Z,1526187956.853 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-05-13T05:05:56.946Z,1526187956.946 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-05-13T05:05:56.947Z,1526187956.947 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-05-13T05:05:57.000Z,1526187957.000 [DeadReckonUsingSpeedCalculator] Loaded
2018-05-13T05:05:57.001Z,1526187957.001 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-05-13T05:05:57.016Z,1526187957.016 [NavChart] Loaded
2018-05-13T05:05:57.017Z,1526187957.017 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-05-13T05:05:57.020Z,1526187957.020 [UniversalFixResidualReporter] Loaded
2018-05-13T05:05:57.021Z,1526187957.021 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-05-13T05:05:57.021Z,1526187957.021 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-05-13T05:05:57.025Z,1526187957.025 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-05-13T05:05:57.026Z,1526187957.026 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-05-13T05:05:57.032Z,1526187957.032 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-05-13T05:05:57.033Z,1526187957.033 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409FE4E0
2018-05-13T05:05:57.034Z,1526187957.034 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8445
2018-05-13T05:05:57.038Z,1526187957.038 [Supervisor](INFO): Main Thread ID is 8358
2018-05-13T05:05:57.038Z,1526187957.038 [Supervisor](DEBUG): Running supervisor.
2018-05-13T05:05:57.039Z,1526187957.039 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8446
2018-05-13T05:05:57.041Z,1526187957.041 [controlThread ThreadHandler](INFO): Handler Thread ID is 8447
2018-05-13T05:05:57.042Z,1526187957.042 [controlThread](DEBUG): Initializing ControlThread
2018-05-13T05:05:57.042Z,1526187957.042 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-05-13T05:05:57.043Z,1526187957.043 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-05-13T05:05:57.043Z,1526187957.043 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-05-13T05:05:57.043Z,1526187957.043 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-05-13T05:05:57.044Z,1526187957.044 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-05-13T05:05:57.045Z,1526187957.045 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-05-13T05:05:57.045Z,1526187957.045 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-05-13T05:05:57.050Z,1526187957.050 [SBIT](INFO): Initialize SBIT Component.
2018-05-13T05:05:57.050Z,1526187957.050 [SBIT](IMPORTANT): git: 2018-03-26-61-g3a7ff4a
2018-05-13T05:05:57.050Z,1526187957.050 [SBIT](INFO): git hash: 3a7ff4a2c61851fe6454e78a1ec1c4bd5c76df54
2018-05-13T05:05:57.051Z,1526187957.051 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-05-13T05:05:57.052Z,1526187957.052 [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:05:57.053Z,1526187957.053 [SBIT](INFO): Beginning SBIT in 52.000000 seconds.
2018-05-13T05:05:57.054Z,1526187957.054 [IBIT](INFO): Initialize IBIT Component.
2018-05-13T05:05:57.054Z,1526187957.054 [CBIT](DEBUG): Initialize CBIT Component.
2018-05-13T05:05:57.055Z,1526187957.055 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2018-05-13T05:05:57.056Z,1526187957.056 [logger ThreadHandler](INFO): Handler Thread ID is 8448
2018-05-13T05:05:57.073Z,1526187957.073 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8449
2018-05-13T05:05:57.079Z,1526187957.079 [Radio_Surface](INFO): Powering up
2018-05-13T05:05:57.085Z,1526187957.085 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8450
2018-05-13T05:05:57.086Z,1526187957.086 [CTD_Seabird](INFO): Initializing
2018-05-13T05:05:57.086Z,1526187957.086 [CTD_Seabird](INFO): Checking LCM
2018-05-13T05:05:57.095Z,1526187957.095 [CTD_Seabird](INFO): LCM OK
2018-05-13T05:05:57.095Z,1526187957.095 [CTD_Seabird](INFO): Powering up
2018-05-13T05:05:57.101Z,1526187957.101 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8451
2018-05-13T05:05:57.102Z,1526187957.102 [WetLabsBB2FL](INFO): Powering down
2018-05-13T05:05:57.129Z,1526187957.129 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8452
2018-05-13T05:05:57.132Z,1526187957.132 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-05-13T05:05:57.132Z,1526187957.132 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-05-13T05:05:57.133Z,1526187957.133 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-05-13T05:05:57.133Z,1526187957.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-05-13T05:05:57.133Z,1526187957.133 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-05-13T05:05:57.133Z,1526187957.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-05-13T05:05:57.133Z,1526187957.133 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-05-13T05:05:57.134Z,1526187957.134 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-05-13T05:05:57.134Z,1526187957.134 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-05-13T05:05:57.134Z,1526187957.134 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-05-13T05:05:57.134Z,1526187957.134 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-05-13T05:05:57.134Z,1526187957.134 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-05-13T05:05:57.134Z,1526187957.134 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-05-13T05:05:57.135Z,1526187957.135 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-05-13T05:05:57.135Z,1526187957.135 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-05-13T05:05:57.135Z,1526187957.135 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-05-13T05:05:57.165Z,1526187957.165 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-05-13T05:05:57.167Z,1526187957.167 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-05-13T05:05:57.167Z,1526187957.167 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-05-13T05:05:57.168Z,1526187957.168 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-05-13T05:05:57.170Z,1526187957.170 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-05-13T05:05:57.171Z,1526187957.171 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-05-13T05:05:57.171Z,1526187957.171 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-05-13T05:05:57.171Z,1526187957.171 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-05-13T05:05:57.172Z,1526187957.172 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-05-13T05:05:57.172Z,1526187957.172 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-05-13T05:05:57.173Z,1526187957.173 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-05-13T05:05:57.173Z,1526187957.173 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-05-13T05:05:57.174Z,1526187957.174 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-05-13T05:05:57.201Z,1526187957.201 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-05-13T05:05:57.232Z,1526187957.232 [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:05:57.233Z,1526187957.233 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-05-13T05:05:57.302Z,1526187957.302 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-05-13T05:05:57.303Z,1526187957.303 [Default:A.Wait](DEBUG): Construct Wait.
2018-05-13T05:05:57.325Z,1526187957.325 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-05-13T05:05:57.356Z,1526187957.356 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-05-13T05:05:57.359Z,1526187957.359 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-05-13T05:05:57.376Z,1526187957.376 [Default:E.Execute](DEBUG): Construct Execute.
2018-05-13T05:05:57.380Z,1526187957.380 [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:05:57.393Z,1526187957.393 [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:05:57.410Z,1526187957.410 [AHRS_M2](INFO): Start
2018-05-13T05:05:57.410Z,1526187957.410 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-05-13T05:05:57.482Z,1526187957.482 [AcousticModem_Benthos_ATM900](INFO): Powering up
2018-05-13T05:05:57.482Z,1526187957.482 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2018-05-13T05:05:57.508Z,1526187957.508 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-05-13T05:05:57.823Z,1526187957.823 [ESPComponent](INFO): powering down ESP
2018-05-13T05:05:58.261Z,1526187958.261 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:05:58.285Z,1526187958.285 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:05:58.401Z,1526187958.401 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:05:58.409Z,1526187958.409 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-05-13T05:05:58.431Z,1526187958.431 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:05:58.437Z,1526187958.437 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-05-13T05:05:58.443Z,1526187958.443 [MassServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:05:58.449Z,1526187958.449 [MassServo](DEBUG): Initializing MassServo.
2018-05-13T05:05:58.455Z,1526187958.455 [RudderServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:05:58.461Z,1526187958.461 [RudderServo](DEBUG): Initializing RudderServo.
2018-05-13T05:05:58.485Z,1526187958.485 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-05-13T05:05:58.493Z,1526187958.493 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-05-13T05:05:58.539Z,1526187958.539 [CommandLine](FAULT): Scheduling is paused
2018-05-13T05:05:58.540Z,1526187958.540 [CBIT](INFO): Critical error at 20180513T050557
2018-05-13T05:05:58.540Z,1526187958.540 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-05-13T05:05:58.649Z,1526187958.649 [AHRS_M2](INFO): Starting
2018-05-13T05:05:58.801Z,1526187958.801 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:05:58.802Z,1526187958.802 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:05:59.001Z,1526187959.001 [AHRS_M2](INFO): Starting
2018-05-13T05:06:02.603Z,1526187962.603 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-13T05:06:02.721Z,1526187962.721 [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:06:02.794Z,1526187962.794 [CTD_Seabird](INFO): LCM subscribed to channel:ctd_t.seabird-gpctd
2018-05-13T05:06:03.195Z,1526187963.195 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-13T05:06:03.195Z,1526187963.195 [CTD_Seabird](INFO): Powering down
2018-05-13T05:06:07.832Z,1526187967.832 [Aanderaa_O2](FAULT): Timed out starting
2018-05-13T05:06:07.832Z,1526187967.832 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-05-13T05:06:07.832Z,1526187967.832 [Aanderaa_O2](ERROR): Communications Fault
2018-05-13T05:06:07.851Z,1526187967.851 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:07.852Z,1526187967.852 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:08.169Z,1526187968.169 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-05-13T05:06:08.175Z,1526187968.175 [AHRS_M2](INFO): Starting
2018-05-13T05:06:08.225Z,1526187968.225 [AHRS_M2](FAULT): Failed to initialize
2018-05-13T05:06:08.225Z,1526187968.225 [AHRS_M2] Communications Fault, FailCount= 1
2018-05-13T05:06:08.225Z,1526187968.225 [AHRS_M2](ERROR): Communications Fault
2018-05-13T05:06:08.226Z,1526187968.226 [AcousticModem_Benthos_ATM900](DEBUG): 
2018-05-13T05:06:08.228Z,1526187968.228 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2018-05-13T05:06:08.228Z,1526187968.228 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2018-05-13T05:06:08.229Z,1526187968.229 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2018-05-13T05:06:08.230Z,1526187968.230 [AcousticModem_Benthos_ATM900](DEBUG): Apr  6 2000 11:03:38 
2018-05-13T05:06:08.231Z,1526187968.231 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low
2018-05-13T05:06:08.393Z,1526187968.393 [Aanderaa_O2](INFO): Powering down
2018-05-13T05:06:08.485Z,1526187968.485 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:08.486Z,1526187968.486 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:08.513Z,1526187968.513 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-05-13T05:06:08.576Z,1526187968.576 [AHRS_M2](INFO): Stop
2018-05-13T05:06:08.601Z,1526187968.601 [AHRS_M2](INFO): uninitialize
2018-05-13T05:06:08.601Z,1526187968.601 [AHRS_M2](INFO): Powering down
2018-05-13T05:06:08.736Z,1526187968.736 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:08.749Z,1526187968.749 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:08.977Z,1526187968.977 [AHRS_M2](INFO): Stopping
2018-05-13T05:06:08.978Z,1526187968.978 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2018-05-13T05:06:08.985Z,1526187968.985 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004403
2018-05-13T05:06:09.029Z,1526187969.029 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:09.030Z,1526187969.030 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:09.048Z,1526187969.048 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-05-13T05:06:09.048Z,1526187969.048 [Aanderaa_O2] No Fault, FailCount= 1
2018-05-13T05:06:09.377Z,1526187969.377 [AHRS_M2](INFO): Stopping
2018-05-13T05:06:09.377Z,1526187969.377 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2018-05-13T05:06:09.378Z,1526187969.378 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2018-05-13T05:06:09.378Z,1526187969.378 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2018-05-13T05:06:09.448Z,1526187969.448 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:09.453Z,1526187969.453 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:09.777Z,1526187969.777 [AHRS_M2](INFO): Stopping
2018-05-13T05:06:09.778Z,1526187969.778 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2018-05-13T05:06:09.821Z,1526187969.821 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:09.833Z,1526187969.833 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:10.181Z,1526187970.181 [AHRS_M2](INFO): Stopped
2018-05-13T05:06:10.181Z,1526187970.181 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2018-05-13T05:06:10.182Z,1526187970.182 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2018-05-13T05:06:10.229Z,1526187970.229 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:10.230Z,1526187970.230 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:10.338Z,1526187970.338 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-05-13T05:06:10.338Z,1526187970.338 [AHRS_M2] No Fault, FailCount= 1
2018-05-13T05:06:10.577Z,1526187970.577 [AHRS_M2](INFO): Start
2018-05-13T05:06:10.577Z,1526187970.577 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-05-13T05:06:10.586Z,1526187970.586 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2018-05-13T05:06:10.625Z,1526187970.625 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:10.626Z,1526187970.626 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:10.977Z,1526187970.977 [AHRS_M2](INFO): Starting
2018-05-13T05:06:11.025Z,1526187971.025 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:11.026Z,1526187971.026 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:11.390Z,1526187971.390 [AHRS_M2](INFO): Starting
2018-05-13T05:06:11.514Z,1526187971.514 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:11.516Z,1526187971.516 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:11.793Z,1526187971.793 [AHRS_M2](INFO): Starting
2018-05-13T05:06:11.862Z,1526187971.862 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:11.863Z,1526187971.863 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:12.193Z,1526187972.193 [AHRS_M2](INFO): Starting
2018-05-13T05:06:12.273Z,1526187972.273 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:12.274Z,1526187972.274 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:12.593Z,1526187972.593 [AHRS_M2](INFO): Starting
2018-05-13T05:06:12.691Z,1526187972.691 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:12.692Z,1526187972.692 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:12.993Z,1526187972.993 [AHRS_M2](INFO): Starting
2018-05-13T05:06:13.050Z,1526187973.050 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:13.051Z,1526187973.051 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:13.393Z,1526187973.393 [AHRS_M2](INFO): Starting
2018-05-13T05:06:13.445Z,1526187973.445 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:13.446Z,1526187973.446 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:13.793Z,1526187973.793 [AHRS_M2](INFO): Starting
2018-05-13T05:06:13.873Z,1526187973.873 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:13.874Z,1526187973.874 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:14.193Z,1526187974.193 [AHRS_M2](INFO): Starting
2018-05-13T05:06:14.289Z,1526187974.289 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:14.290Z,1526187974.290 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-13T05:06:14.593Z,1526187974.593 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:14.603Z,1526187974.603 [AHRS_M2](ERROR): Tx (24): 0xa 0x1 0x14 0x69 0x0 0xc5 0x69 0xb3 0xc2 0xb2 0xcf 0x8a 0xc2 0x1b 0x24 0x27 0x43 0x22 0xd4 0xdb 0x41 0x6d 0x71 0x3
2018-05-13T05:06:14.605Z,1526187974.605 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xc5 0x69 0xb3 0xc2 0xb2 0xcf 0x8a 0xc2 0x1b 0x24 0x27 0x43 0x22 0xd4 0xdb 0x41 0x6d 0x71
2018-05-13T05:06:14.606Z,1526187974.606 [AHRS_M2](ERROR): extractFloat: 0xc5 0x69 0xb3 0xc2
2018-05-13T05:06:14.607Z,1526187974.607 [AHRS_M2](ERROR): extractFloat: 0xb2 0xcf 0x8a 0xc2
2018-05-13T05:06:14.607Z,1526187974.607 [AHRS_M2](ERROR): extractFloat: 0x1b 0x24 0x27 0x43
2018-05-13T05:06:14.608Z,1526187974.608 [AHRS_M2](ERROR): extractFloat: 0x22 0xd4 0xdb 0x41
2018-05-13T05:06:14.610Z,1526187974.610 [AHRS_M2](DEBUG): CRC match. PITCH: -89.706584 deg, ROLL: -69.405657 deg, YAW: 167.141040 deg, TEMP: 27.478580 C.
2018-05-13T05:06:14.993Z,1526187974.993 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:14.995Z,1526187974.995 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x12 0x68 0xb3 0xc2 0xfd 0xd 0x88 0xc2 0x98 0xbc 0x25 0x43 0x66 0xda 0xdb 0x41 0x7f 0x53 0x3
2018-05-13T05:06:14.996Z,1526187974.996 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x12 0x68 0xb3 0xc2 0xfd 0xd 0x88 0xc2 0x98 0xbc 0x25 0x43 0x66 0xda 0xdb 0x41 0x7f 0x53
2018-05-13T05:06:14.997Z,1526187974.997 [AHRS_M2](ERROR): extractFloat: 0x12 0x68 0xb3 0xc2
2018-05-13T05:06:14.998Z,1526187974.998 [AHRS_M2](ERROR): extractFloat: 0xfd 0xd 0x88 0xc2
2018-05-13T05:06:14.999Z,1526187974.999 [AHRS_M2](ERROR): extractFloat: 0x98 0xbc 0x25 0x43
2018-05-13T05:06:14.000Z,1526187975.000 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:15.001Z,1526187975.001 [AHRS_M2](DEBUG): CRC match. PITCH: -89.703265 deg, ROLL: -68.027318 deg, YAW: 165.736699 deg, TEMP: 27.481640 C.
2018-05-13T05:06:15.393Z,1526187975.393 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:15.406Z,1526187975.406 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0x4d 0x56 0x89 0xc2 0x28 0x62 0x26 0x43 0xde 0xcd 0xdb 0x41 0x32 0xaf 0x3
2018-05-13T05:06:15.408Z,1526187975.408 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0x4d 0x56 0x89 0xc2 0x28 0x62 0x26 0x43 0xde 0xcd 0xdb 0x41 0x32 0xaf
2018-05-13T05:06:15.408Z,1526187975.408 [AHRS_M2](ERROR): extractFloat: 0xba 0x66 0xb3 0xc2
2018-05-13T05:06:15.409Z,1526187975.409 [AHRS_M2](ERROR): extractFloat: 0x4d 0x56 0x89 0xc2
2018-05-13T05:06:15.410Z,1526187975.410 [AHRS_M2](ERROR): extractFloat: 0x28 0x62 0x26 0x43
2018-05-13T05:06:15.411Z,1526187975.411 [AHRS_M2](ERROR): extractFloat: 0xde 0xcd 0xdb 0x41
2018-05-13T05:06:15.412Z,1526187975.412 [AHRS_M2](DEBUG): CRC match. PITCH: -89.700635 deg, ROLL: -68.668557 deg, YAW: 166.383422 deg, TEMP: 27.475521 C.
2018-05-13T05:06:15.793Z,1526187975.793 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:15.795Z,1526187975.795 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0xbe 0x63 0xb3 0xc2 0x22 0x8f 0x8a 0xc2 0x3d 0x10 0x81 0x27 0x43 0x77 0xf3 0xdb 0x41 0xe8 0xed 0x3
2018-05-13T05:06:15.796Z,1526187975.796 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbe 0x63 0xb3 0xc2 0x22 0x8f 0x8a 0xc2 0x3d 0x1 0x27 0x43 0x77 0xf3 0xdb 0x41 0xe8 0xed
2018-05-13T05:06:15.797Z,1526187975.797 [AHRS_M2](ERROR): extractFloat: 0xbe 0x63 0xb3 0xc2
2018-05-13T05:06:15.798Z,1526187975.798 [AHRS_M2](ERROR): extractFloat: 0x22 0x8f 0x8a 0xc2
2018-05-13T05:06:15.799Z,1526187975.799 [AHRS_M2](ERROR): extractFloat: 0x3d 0x1 0x27 0x43
2018-05-13T05:06:15.799Z,1526187975.799 [AHRS_M2](ERROR): extractFloat: 0x77 0xf3 0xdb 0x41
2018-05-13T05:06:15.801Z,1526187975.801 [AHRS_M2](DEBUG): CRC match. PITCH: -89.694809 deg, ROLL: -69.279558 deg, YAW: 167.004832 deg, TEMP: 27.493879 C.
2018-05-13T05:06:16.193Z,1526187976.193 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:16.195Z,1526187976.195 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xc3 0x62 0xb3 0xc2 0x1f 0x54 0x87 0xc2 0x2 0x5e 0x25 0x43 0x66 0xda 0xdb 0x41 0x11 0xc4 0x3
2018-05-13T05:06:16.196Z,1526187976.196 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xc3 0x62 0xb3 0xc2 0x1f 0x54 0x87 0xc2 0x2 0x5e 0x25 0x43 0x66 0xda 0xdb 0x41 0x11 0xc4
2018-05-13T05:06:16.197Z,1526187976.197 [AHRS_M2](ERROR): extractFloat: 0xc3 0x62 0xb3 0xc2
2018-05-13T05:06:16.198Z,1526187976.198 [AHRS_M2](ERROR): extractFloat: 0x1f 0x54 0x87 0xc2
2018-05-13T05:06:16.199Z,1526187976.199 [AHRS_M2](ERROR): extractFloat: 0x2 0x5e 0x25 0x43
2018-05-13T05:06:16.200Z,1526187976.200 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:16.201Z,1526187976.201 [AHRS_M2](DEBUG): CRC match. PITCH: -89.692897 deg, ROLL: -67.664300 deg, YAW: 165.367213 deg, TEMP: 27.481640 C.
2018-05-13T05:06:16.593Z,1526187976.593 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:16.606Z,1526187976.606 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xda 0x5f 0xb3 0xc2 0x29 0x30 0x8a 0xc2 0x92 0xcf 0x26 0x43 0x99 0xc7 0xdb 0x41 0x4f 0x40 0x3
2018-05-13T05:06:16.608Z,1526187976.608 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xda 0x5f 0xb3 0xc2 0x29 0x30 0x8a 0xc2 0x92 0xcf 0x26 0x43 0x99 0xc7 0xdb 0x41 0x4f 0x40
2018-05-13T05:06:16.609Z,1526187976.609 [AHRS_M2](ERROR): extractFloat: 0xda 0x5f 0xb3 0xc2
2018-05-13T05:06:16.609Z,1526187976.609 [AHRS_M2](ERROR): extractFloat: 0x29 0x30 0x8a 0xc2
2018-05-13T05:06:16.610Z,1526187976.610 [AHRS_M2](ERROR): extractFloat: 0x92 0xcf 0x26 0x43
2018-05-13T05:06:16.611Z,1526187976.611 [AHRS_M2](ERROR): extractFloat: 0x99 0xc7 0xdb 0x41
2018-05-13T05:06:16.612Z,1526187976.612 [AHRS_M2](DEBUG): CRC match. PITCH: -89.687207 deg, ROLL: -69.094064 deg, YAW: 166.810828 deg, TEMP: 27.472460 C.
2018-05-13T05:06:16.993Z,1526187976.993 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:16.995Z,1526187976.995 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0xad 0xc5 0x8b 0xc2 0xc0 0x9e 0x27 0x43 0x66 0xda 0xdb 0x41 0xa7 0x61 0x3
2018-05-13T05:06:16.996Z,1526187976.996 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0xad 0xc5 0x8b 0xc2 0xc0 0x9e 0x27 0x43 0x66 0xda 0xdb 0x41 0xa7 0x61
2018-05-13T05:06:16.997Z,1526187976.997 [AHRS_M2](ERROR): extractFloat: 0x12 0x64 0xb3 0xc2
2018-05-13T05:06:16.998Z,1526187976.998 [AHRS_M2](ERROR): extractFloat: 0xad 0xc5 0x8b 0xc2
2018-05-13T05:06:16.998Z,1526187976.998 [AHRS_M2](ERROR): extractFloat: 0xc0 0x9e 0x27 0x43
2018-05-13T05:06:16.999Z,1526187976.999 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:17.001Z,1526187977.001 [AHRS_M2](DEBUG): CRC match. PITCH: -89.695451 deg, ROLL: -69.886086 deg, YAW: 167.620123 deg, TEMP: 27.481640 C.
2018-05-13T05:06:17.393Z,1526187977.393 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:17.395Z,1526187977.395 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0x2b 0x73 0x8b 0xc2 0xe 0x72 0x27 0x43 0xef 0xe6 0xdb 0x41 0xab 0x71 0x3
2018-05-13T05:06:17.396Z,1526187977.396 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0x2b 0x73 0x8b 0xc2 0xe 0x72 0x27 0x43 0xef 0xe6 0xdb 0x41 0xab 0x71
2018-05-13T05:06:17.397Z,1526187977.397 [AHRS_M2](ERROR): extractFloat: 0xc9 0x61 0xb3 0xc2
2018-05-13T05:06:17.398Z,1526187977.398 [AHRS_M2](ERROR): extractFloat: 0x2b 0x73 0x8b 0xc2
2018-05-13T05:06:17.398Z,1526187977.398 [AHRS_M2](ERROR): extractFloat: 0xe 0x72 0x27 0x43
2018-05-13T05:06:17.399Z,1526187977.399 [AHRS_M2](ERROR): extractFloat: 0xef 0xe6 0xdb 0x41
2018-05-13T05:06:17.401Z,1526187977.401 [AHRS_M2](DEBUG): CRC match. PITCH: -89.690984 deg, ROLL: -69.724934 deg, YAW: 167.445530 deg, TEMP: 27.487761 C.
2018-05-13T05:06:17.793Z,1526187977.793 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:17.795Z,1526187977.795 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0x89 0xb 0x89 0xc2 0xf4 0x39 0x26 0x43 0x66 0xda 0xdb 0x41 0x4 0xa1 0x3
2018-05-13T05:06:17.796Z,1526187977.796 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x17 0x63 0xb3 0xc2 0x89 0xb 0x89 0xc2 0xf4 0x39 0x26 0x43 0x66 0xda 0xdb 0x41 0x4 0xa1
2018-05-13T05:06:17.797Z,1526187977.797 [AHRS_M2](ERROR): extractFloat: 0x17 0x63 0xb3 0xc2
2018-05-13T05:06:17.798Z,1526187977.798 [AHRS_M2](ERROR): extractFloat: 0x89 0xb 0x89 0xc2
2018-05-13T05:06:17.799Z,1526187977.799 [AHRS_M2](ERROR): extractFloat: 0xf4 0x39 0x26 0x43
2018-05-13T05:06:17.800Z,1526187977.800 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:17.801Z,1526187977.801 [AHRS_M2](DEBUG): CRC match. PITCH: -89.693532 deg, ROLL: -68.522527 deg, YAW: 166.226382 deg, TEMP: 27.481640 C.
2018-05-13T05:06:18.193Z,1526187978.193 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:18.195Z,1526187978.195 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x36 0x5f 0xb3 0xc2 0xb9 0xed 0x8b 0xc2 0xe5 0xae 0x27 0x43 0x66 0xda 0xdb 0x41 0x2e 0x72 0x3
2018-05-13T05:06:18.196Z,1526187978.196 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x36 0x5f 0xb3 0xc2 0xb9 0xed 0x8b 0xc2 0xe5 0xae 0x27 0x43 0x66 0xda 0xdb 0x41 0x2e 0x72
2018-05-13T05:06:18.197Z,1526187978.197 [AHRS_M2](ERROR): extractFloat: 0x36 0x5f 0xb3 0xc2
2018-05-13T05:06:18.198Z,1526187978.198 [AHRS_M2](ERROR): extractFloat: 0xb9 0xed 0x8b 0xc2
2018-05-13T05:06:18.199Z,1526187978.199 [AHRS_M2](ERROR): extractFloat: 0xe5 0xae 0x27 0x43
2018-05-13T05:06:18.199Z,1526187978.199 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:18.201Z,1526187978.201 [AHRS_M2](DEBUG): CRC match. PITCH: -89.685957 deg, ROLL: -69.964305 deg, YAW: 167.683180 deg, TEMP: 27.481640 C.
2018-05-13T05:06:18.593Z,1526187978.593 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:18.595Z,1526187978.595 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x88 0x5f 0xb3 0xc2 0x83 0x3e 0x8c 0xc2 0x86 0xd8 0x27 0x43 0xcc 0xb4 0xdb 0x41 0x48 0xed 0x3
2018-05-13T05:06:18.596Z,1526187978.596 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x88 0x5f 0xb3 0xc2 0x83 0x3e 0x8c 0xc2 0x86 0xd8 0x27 0x43 0xcc 0xb4 0xdb 0x41 0x48 0xed
2018-05-13T05:06:18.598Z,1526187978.598 [AHRS_M2](ERROR): extractFloat: 0x88 0x5f 0xb3 0xc2
2018-05-13T05:06:18.599Z,1526187978.599 [AHRS_M2](ERROR): extractFloat: 0x83 0x3e 0x8c 0xc2
2018-05-13T05:06:18.600Z,1526187978.600 [AHRS_M2](ERROR): extractFloat: 0x86 0xd8 0x27 0x43
2018-05-13T05:06:18.600Z,1526187978.600 [AHRS_M2](ERROR): extractFloat: 0xcc 0xb4 0xdb 0x41
2018-05-13T05:06:18.602Z,1526187978.602 [AHRS_M2](DEBUG): CRC match. PITCH: -89.686586 deg, ROLL: -70.122096 deg, YAW: 167.845793 deg, TEMP: 27.463280 C.
2018-05-13T05:06:18.993Z,1526187978.993 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:18.995Z,1526187978.995 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0x70 0x6e 0x8a 0xc2 0x59 0xec 0x26 0x43 0x77 0xf3 0xdb 0x41 0x42 0xb7 0x3
2018-05-13T05:06:18.996Z,1526187978.996 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xc9 0x61 0xb3 0xc2 0x70 0x6e 0x8a 0xc2 0x59 0xec 0x26 0x43 0x77 0xf3 0xdb 0x41 0x42 0xb7
2018-05-13T05:06:18.997Z,1526187978.997 [AHRS_M2](ERROR): extractFloat: 0xc9 0x61 0xb3 0xc2
2018-05-13T05:06:18.998Z,1526187978.998 [AHRS_M2](ERROR): extractFloat: 0x70 0x6e 0x8a 0xc2
2018-05-13T05:06:18.999Z,1526187978.999 [AHRS_M2](ERROR): extractFloat: 0x59 0xec 0x26 0x43
2018-05-13T05:06:18.999Z,1526187978.999 [AHRS_M2](ERROR): extractFloat: 0x77 0xf3 0xdb 0x41
2018-05-13T05:06:19.001Z,1526187979.001 [AHRS_M2](DEBUG): CRC match. PITCH: -89.690984 deg, ROLL: -69.215696 deg, YAW: 166.923239 deg, TEMP: 27.493879 C.
2018-05-13T05:06:19.393Z,1526187979.393 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:19.395Z,1526187979.395 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x23 0x61 0xb3 0xc2 0xa9 0xe5 0x8b 0xc2 0x41 0xaa 0x27 0x43 0x33 0xed 0xdb 0x41 0x53 0xe9 0x3
2018-05-13T05:06:19.396Z,1526187979.396 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x23 0x61 0xb3 0xc2 0xa9 0xe5 0x8b 0xc2 0x41 0xaa 0x27 0x43 0x33 0xed 0xdb 0x41 0x53 0xe9
2018-05-13T05:06:19.397Z,1526187979.397 [AHRS_M2](ERROR): extractFloat: 0x23 0x61 0xb3 0xc2
2018-05-13T05:06:19.398Z,1526187979.398 [AHRS_M2](ERROR): extractFloat: 0xa9 0xe5 0x8b 0xc2
2018-05-13T05:06:19.399Z,1526187979.399 [AHRS_M2](ERROR): extractFloat: 0x41 0xaa 0x27 0x43
2018-05-13T05:06:19.399Z,1526187979.399 [AHRS_M2](ERROR): extractFloat: 0x33 0xed 0xdb 0x41
2018-05-13T05:06:19.401Z,1526187979.401 [AHRS_M2](DEBUG): CRC match. PITCH: -89.689721 deg, ROLL: -69.948555 deg, YAW: 167.665052 deg, TEMP: 27.490820 C.
2018-05-13T05:06:19.423Z,1526187979.423 [Aanderaa_O2](FAULT): Timed out starting
2018-05-13T05:06:19.423Z,1526187979.423 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-05-13T05:06:19.423Z,1526187979.423 [Aanderaa_O2](ERROR): Communications Fault
2018-05-13T05:06:19.561Z,1526187979.561 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-05-13T05:06:19.793Z,1526187979.793 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:19.795Z,1526187979.795 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x6a 0x63 0xb3 0xc2 0xdc 0xe8 0x8b 0xc2 0x1c 0xae 0x27 0x43 0x66 0xda 0xdb 0x41 0x5f 0xa5 0x3
2018-05-13T05:06:19.796Z,1526187979.796 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x6a 0x63 0xb3 0xc2 0xdc 0xe8 0x8b 0xc2 0x1c 0xae 0x27 0x43 0x66 0xda 0xdb 0x41 0x5f 0xa5
2018-05-13T05:06:19.797Z,1526187979.797 [AHRS_M2](ERROR): extractFloat: 0x6a 0x63 0xb3 0xc2
2018-05-13T05:06:19.798Z,1526187979.798 [AHRS_M2](ERROR): extractFloat: 0xdc 0xe8 0x8b 0xc2
2018-05-13T05:06:19.799Z,1526187979.799 [AHRS_M2](ERROR): extractFloat: 0x1c 0xae 0x27 0x43
2018-05-13T05:06:19.800Z,1526187979.800 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:19.801Z,1526187979.801 [AHRS_M2](DEBUG): CRC match. PITCH: -89.694167 deg, ROLL: -69.954804 deg, YAW: 167.680120 deg, TEMP: 27.481640 C.
2018-05-13T05:06:19.941Z,1526187979.941 [Aanderaa_O2](INFO): Powering down
2018-05-13T05:06:20.193Z,1526187980.193 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:20.195Z,1526187980.195 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x6f 0xec 0x8e 0xc2 0xc 0x36 0x29 0x43 0xef 0xe6 0xdb 0x41 0x61 0xf 0x3
2018-05-13T05:06:20.197Z,1526187980.197 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x6f 0xec 0x8e 0xc2 0xc 0x36 0x29 0x43 0xef 0xe6 0xdb 0x41 0x61 0xf
2018-05-13T05:06:20.197Z,1526187980.197 [AHRS_M2](ERROR): extractFloat: 0xbb 0x64 0xb3 0xc2
2018-05-13T05:06:20.198Z,1526187980.198 [AHRS_M2](ERROR): extractFloat: 0x6f 0xec 0x8e 0xc2
2018-05-13T05:06:20.199Z,1526187980.199 [AHRS_M2](ERROR): extractFloat: 0xc 0x36 0x29 0x43
2018-05-13T05:06:20.200Z,1526187980.200 [AHRS_M2](ERROR): extractFloat: 0xef 0xe6 0xdb 0x41
2018-05-13T05:06:20.201Z,1526187980.201 [AHRS_M2](DEBUG): CRC match. PITCH: -89.696742 deg, ROLL: -71.461783 deg, YAW: 169.211120 deg, TEMP: 27.487761 C.
2018-05-13T05:06:20.593Z,1526187980.593 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:20.595Z,1526187980.595 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0xa9 0x53 0x8e 0xc2 0xb9 0xe7 0x28 0x43 0xaa 0xe0 0xdb 0x41 0x2a 0xc6 0x3
2018-05-13T05:06:20.596Z,1526187980.596 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0xa9 0x53 0x8e 0xc2 0xb9 0xe7 0x28 0x43 0xaa 0xe0 0xdb 0x41 0x2a 0xc6
2018-05-13T05:06:20.597Z,1526187980.597 [AHRS_M2](ERROR): extractFloat: 0xba 0x66 0xb3 0xc2
2018-05-13T05:06:20.598Z,1526187980.598 [AHRS_M2](ERROR): extractFloat: 0xa9 0x53 0x8e 0xc2
2018-05-13T05:06:20.599Z,1526187980.599 [AHRS_M2](ERROR): extractFloat: 0xb9 0xe7 0x28 0x43
2018-05-13T05:06:20.599Z,1526187980.599 [AHRS_M2](ERROR): extractFloat: 0xaa 0xe0 0xdb 0x41
2018-05-13T05:06:20.601Z,1526187980.601 [AHRS_M2](DEBUG): CRC match. PITCH: -89.700635 deg, ROLL: -71.163399 deg, YAW: 168.905169 deg, TEMP: 27.484699 C.
2018-05-13T05:06:20.754Z,1526187980.754 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-05-13T05:06:20.754Z,1526187980.754 [Aanderaa_O2] No Fault, FailCount= 2
2018-05-13T05:06:20.993Z,1526187980.993 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:20.995Z,1526187980.995 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x31 0x6b 0x8c 0xc2 0xfd 0xf0 0x27 0x43 0xde 0xcd 0xdb 0x41 0x94 0xb3 0x3
2018-05-13T05:06:20.996Z,1526187980.996 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x31 0x6b 0x8c 0xc2 0xfd 0xf0 0x27 0x43 0xde 0xcd 0xdb 0x41 0x94 0xb3
2018-05-13T05:06:20.997Z,1526187980.997 [AHRS_M2](ERROR): extractFloat: 0xbb 0x64 0xb3 0xc2
2018-05-13T05:06:20.998Z,1526187980.998 [AHRS_M2](ERROR): extractFloat: 0x31 0x6b 0x8c 0xc2
2018-05-13T05:06:20.998Z,1526187980.998 [AHRS_M2](ERROR): extractFloat: 0xfd 0xf0 0x27 0x43
2018-05-13T05:06:20.999Z,1526187980.999 [AHRS_M2](ERROR): extractFloat: 0xde 0xcd 0xdb 0x41
2018-05-13T05:06:21.000Z,1526187981.000 [AHRS_M2](DEBUG): CRC match. PITCH: -89.696742 deg, ROLL: -70.209359 deg, YAW: 167.941361 deg, TEMP: 27.475521 C.
2018-05-13T05:06:21.393Z,1526187981.393 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:21.395Z,1526187981.395 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0x60 0xc3 0x8a 0xc2 0x27 0x1b 0x27 0x43 0x99 0xc7 0xdb 0x41 0x74 0xd6 0x3
2018-05-13T05:06:21.396Z,1526187981.396 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0x60 0xc3 0x8a 0xc2 0x27 0x1b 0x27 0x43 0x99 0xc7 0xdb 0x41 0x74 0xd6
2018-05-13T05:06:21.397Z,1526187981.397 [AHRS_M2](ERROR): extractFloat: 0x12 0x64 0xb3 0xc2
2018-05-13T05:06:21.398Z,1526187981.398 [AHRS_M2](ERROR): extractFloat: 0x60 0xc3 0x8a 0xc2
2018-05-13T05:06:21.399Z,1526187981.399 [AHRS_M2](ERROR): extractFloat: 0x27 0x1b 0x27 0x43
2018-05-13T05:06:21.399Z,1526187981.399 [AHRS_M2](ERROR): extractFloat: 0x99 0xc7 0xdb 0x41
2018-05-13T05:06:21.401Z,1526187981.401 [AHRS_M2](DEBUG): CRC match. PITCH: -89.695451 deg, ROLL: -69.381594 deg, YAW: 167.106070 deg, TEMP: 27.472460 C.
2018-05-13T05:06:21.793Z,1526187981.793 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:21.795Z,1526187981.795 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0x6b 0xad 0x8a 0xc2 0x9e 0x10 0x90 0x27 0x43 0x66 0xda 0xdb 0x41 0x26 0xe7 0x3
2018-05-13T05:06:21.796Z,1526187981.796 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xba 0x66 0xb3 0xc2 0x6b 0xad 0x8a 0xc2 0x9e 0x10 0x27 0x43 0x66 0xda 0xdb 0x41 0x26 0xe7
2018-05-13T05:06:21.797Z,1526187981.797 [AHRS_M2](ERROR): extractFloat: 0xba 0x66 0xb3 0xc2
2018-05-13T05:06:21.798Z,1526187981.798 [AHRS_M2](ERROR): extractFloat: 0x6b 0xad 0x8a 0xc2
2018-05-13T05:06:21.799Z,1526187981.799 [AHRS_M2](ERROR): extractFloat: 0x9e 0x10 0x27 0x43
2018-05-13T05:06:21.799Z,1526187981.799 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:21.801Z,1526187981.801 [AHRS_M2](DEBUG): CRC match. PITCH: -89.700635 deg, ROLL: -69.338708 deg, YAW: 167.064911 deg, TEMP: 27.481640 C.
2018-05-13T05:06:22.193Z,1526187982.193 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:22.195Z,1526187982.195 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xbf 0x68 0xb3 0xc2 0x76 0x3b 0x8d 0xc2 0xbc 0x5b 0x28 0x43 0x55 0xc1 0xdb 0x41 0x4f 0x56 0x3
2018-05-13T05:06:22.197Z,1526187982.197 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbf 0x68 0xb3 0xc2 0x76 0x3b 0x8d 0xc2 0xbc 0x5b 0x28 0x43 0x55 0xc1 0xdb 0x41 0x4f 0x56
2018-05-13T05:06:22.197Z,1526187982.197 [AHRS_M2](ERROR): extractFloat: 0xbf 0x68 0xb3 0xc2
2018-05-13T05:06:22.198Z,1526187982.198 [AHRS_M2](ERROR): extractFloat: 0x76 0x3b 0x8d 0xc2
2018-05-13T05:06:22.199Z,1526187982.199 [AHRS_M2](ERROR): extractFloat: 0xbc 0x5b 0x28 0x43
2018-05-13T05:06:22.200Z,1526187982.200 [AHRS_M2](ERROR): extractFloat: 0x55 0xc1 0xdb 0x41
2018-05-13T05:06:22.201Z,1526187982.201 [AHRS_M2](DEBUG): CRC match. PITCH: -89.704583 deg, ROLL: -70.616137 deg, YAW: 168.358344 deg, TEMP: 27.469400 C.
2018-05-13T05:06:22.593Z,1526187982.593 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:22.595Z,1526187982.595 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xbc 0x67 0xb3 0xc2 0x13 0x1b 0x8f 0xc2 0x2e 0x4e 0x29 0x43 0xaa 0xe0 0xdb 0x41 0x8f 0xc2 0x3
2018-05-13T05:06:22.596Z,1526187982.596 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbc 0x67 0xb3 0xc2 0x13 0x1b 0x8f 0xc2 0x2e 0x4e 0x29 0x43 0xaa 0xe0 0xdb 0x41 0x8f 0xc2
2018-05-13T05:06:22.597Z,1526187982.597 [AHRS_M2](ERROR): extractFloat: 0xbc 0x67 0xb3 0xc2
2018-05-13T05:06:22.598Z,1526187982.598 [AHRS_M2](ERROR): extractFloat: 0x13 0x1b 0x8f 0xc2
2018-05-13T05:06:22.599Z,1526187982.599 [AHRS_M2](ERROR): extractFloat: 0x2e 0x4e 0x29 0x43
2018-05-13T05:06:22.599Z,1526187982.599 [AHRS_M2](ERROR): extractFloat: 0xaa 0xe0 0xdb 0x41
2018-05-13T05:06:22.601Z,1526187982.601 [AHRS_M2](DEBUG): CRC match. PITCH: -89.702609 deg, ROLL: -71.552877 deg, YAW: 169.305390 deg, TEMP: 27.484699 C.
2018-05-13T05:06:22.993Z,1526187982.993 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:22.995Z,1526187982.995 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0x10 0x90 0x67 0xb3 0xc2 0xee 0x29 0x8d 0xc2 0xf2 0x51 0x28 0x43 0x55 0xc1 0xdb 0x41 0xcf 0xa3 0x3
2018-05-13T05:06:22.996Z,1526187982.996 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x10 0x67 0xb3 0xc2 0xee 0x29 0x8d 0xc2 0xf2 0x51 0x28 0x43 0x55 0xc1 0xdb 0x41 0xcf 0xa3
2018-05-13T05:06:22.997Z,1526187982.997 [AHRS_M2](ERROR): extractFloat: 0x10 0x67 0xb3 0xc2
2018-05-13T05:06:22.998Z,1526187982.998 [AHRS_M2](ERROR): extractFloat: 0xee 0x29 0x8d 0xc2
2018-05-13T05:06:22.999Z,1526187982.999 [AHRS_M2](ERROR): extractFloat: 0xf2 0x51 0x28 0x43
2018-05-13T05:06:22.000Z,1526187983.000 [AHRS_M2](ERROR): extractFloat: 0x55 0xc1 0xdb 0x41
2018-05-13T05:06:23.001Z,1526187983.001 [AHRS_M2](DEBUG): CRC match. PITCH: -89.701291 deg, ROLL: -70.581891 deg, YAW: 168.320095 deg, TEMP: 27.469400 C.
2018-05-13T05:06:23.394Z,1526187983.394 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:23.396Z,1526187983.396 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xba 0x65 0xb3 0xc2 0xd8 0x21 0x8f 0xc2 0xd1 0x4f 0x29 0x43 0xcc 0xb4 0xdb 0x41 0x46 0x67 0x3
2018-05-13T05:06:23.398Z,1526187983.398 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xba 0x65 0xb3 0xc2 0xd8 0x21 0x8f 0xc2 0xd1 0x4f 0x29 0x43 0xcc 0xb4 0xdb 0x41 0x46 0x67
2018-05-13T05:06:23.399Z,1526187983.399 [AHRS_M2](ERROR): extractFloat: 0xba 0x65 0xb3 0xc2
2018-05-13T05:06:23.399Z,1526187983.399 [AHRS_M2](ERROR): extractFloat: 0xd8 0x21 0x8f 0xc2
2018-05-13T05:06:23.400Z,1526187983.400 [AHRS_M2](ERROR): extractFloat: 0xd1 0x4f 0x29 0x43
2018-05-13T05:06:23.401Z,1526187983.401 [AHRS_M2](ERROR): extractFloat: 0xcc 0xb4 0xdb 0x41
2018-05-13T05:06:23.402Z,1526187983.402 [AHRS_M2](DEBUG): CRC match. PITCH: -89.698682 deg, ROLL: -71.566101 deg, YAW: 169.311783 deg, TEMP: 27.463280 C.
2018-05-13T05:06:23.793Z,1526187983.793 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:23.795Z,1526187983.795 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x10 0x86 0xc 0x8d 0xc2 0xaf 0x42 0x28 0x43 0x66 0xda 0xdb 0x41 0xcc 0xe8 0x3
2018-05-13T05:06:23.797Z,1526187983.797 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xbb 0x64 0xb3 0xc2 0x6 0xc 0x8d 0xc2 0xaf 0x42 0x28 0x43 0x66 0xda 0xdb 0x41 0xcc 0xe8
2018-05-13T05:06:23.797Z,1526187983.797 [AHRS_M2](ERROR): extractFloat: 0xbb 0x64 0xb3 0xc2
2018-05-13T05:06:23.798Z,1526187983.798 [AHRS_M2](ERROR): extractFloat: 0x6 0xc 0x8d 0xc2
2018-05-13T05:06:23.799Z,1526187983.799 [AHRS_M2](ERROR): extractFloat: 0xaf 0x42 0x28 0x43
2018-05-13T05:06:23.800Z,1526187983.800 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:23.801Z,1526187983.801 [AHRS_M2](DEBUG): CRC match. PITCH: -89.696742 deg, ROLL: -70.523486 deg, YAW: 168.260481 deg, TEMP: 27.481640 C.
2018-05-13T05:06:24.193Z,1526187984.193 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:24.195Z,1526187984.195 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0x73 0xa9 0x8b 0xc2 0x4d 0x8f 0x27 0x43 0xaa 0xe0 0xdb 0x41 0xf1 0xed 0x3
2018-05-13T05:06:24.196Z,1526187984.196 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x67 0x64 0xb3 0xc2 0x73 0xa9 0x8b 0xc2 0x4d 0x8f 0x27 0x43 0xaa 0xe0 0xdb 0x41 0xf1 0xed
2018-05-13T05:06:24.197Z,1526187984.197 [AHRS_M2](ERROR): extractFloat: 0x67 0x64 0xb3 0xc2
2018-05-13T05:06:24.198Z,1526187984.198 [AHRS_M2](ERROR): extractFloat: 0x73 0xa9 0x8b 0xc2
2018-05-13T05:06:24.199Z,1526187984.199 [AHRS_M2](ERROR): extractFloat: 0x4d 0x8f 0x27 0x43
2018-05-13T05:06:24.199Z,1526187984.199 [AHRS_M2](ERROR): extractFloat: 0xaa 0xe0 0xdb 0x41
2018-05-13T05:06:24.201Z,1526187984.201 [AHRS_M2](DEBUG): CRC match. PITCH: -89.696100 deg, ROLL: -69.830952 deg, YAW: 167.559772 deg, TEMP: 27.484699 C.
2018-05-13T05:06:24.361Z,1526187984.361 [CommandLine](IMPORTANT): got command quit
2018-05-13T05:06:24.593Z,1526187984.593 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:24.595Z,1526187984.595 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x66 0x67 0xb3 0xc2 0x2a 0xea 0x89 0xc2 0x22 0xae 0x26 0x43 0x22 0xd4 0xdb 0x41 0x2c 0x57 0x3
2018-05-13T05:06:24.597Z,1526187984.597 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x66 0x67 0xb3 0xc2 0x2a 0xea 0x89 0xc2 0x22 0xae 0x26 0x43 0x22 0xd4 0xdb 0x41 0x2c 0x57
2018-05-13T05:06:24.597Z,1526187984.597 [AHRS_M2](ERROR): extractFloat: 0x66 0x67 0xb3 0xc2
2018-05-13T05:06:24.598Z,1526187984.598 [AHRS_M2](ERROR): extractFloat: 0x2a 0xea 0x89 0xc2
2018-05-13T05:06:24.599Z,1526187984.599 [AHRS_M2](ERROR): extractFloat: 0x22 0xae 0x26 0x43
2018-05-13T05:06:24.600Z,1526187984.600 [AHRS_M2](ERROR): extractFloat: 0x22 0xd4 0xdb 0x41
2018-05-13T05:06:24.601Z,1526187984.601 [AHRS_M2](DEBUG): CRC match. PITCH: -89.701947 deg, ROLL: -68.957351 deg, YAW: 166.680207 deg, TEMP: 27.478580 C.
2018-05-13T05:06:24.993Z,1526187984.993 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:24.995Z,1526187984.995 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0xd1 0x60 0xb3 0xc2 0x21 0xa8 0x8b 0xc2 0x66 0x8f 0x27 0x43 0x55 0xc1 0xdb 0x41 0xa4 0xaa 0x3
2018-05-13T05:06:24.996Z,1526187984.996 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xd1 0x60 0xb3 0xc2 0x21 0xa8 0x8b 0xc2 0x66 0x8f 0x27 0x43 0x55 0xc1 0xdb 0x41 0xa4 0xaa
2018-05-13T05:06:24.997Z,1526187984.997 [AHRS_M2](ERROR): extractFloat: 0xd1 0x60 0xb3 0xc2
2018-05-13T05:06:24.998Z,1526187984.998 [AHRS_M2](ERROR): extractFloat: 0x21 0xa8 0x8b 0xc2
2018-05-13T05:06:24.999Z,1526187984.999 [AHRS_M2](ERROR): extractFloat: 0x66 0x8f 0x27 0x43
2018-05-13T05:06:24.999Z,1526187984.999 [AHRS_M2](ERROR): extractFloat: 0x55 0xc1 0xdb 0x41
2018-05-13T05:06:25.001Z,1526187985.001 [AHRS_M2](DEBUG): CRC match. PITCH: -89.689092 deg, ROLL: -69.828378 deg, YAW: 167.560154 deg, TEMP: 27.469400 C.
2018-05-13T05:06:25.393Z,1526187985.393 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:25.395Z,1526187985.395 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0xd1 0x60 0xb3 0xc2 0x73 0x36 0x8e 0xc2 0x53 0xdb 0x28 0x43 0x44 0x10 0x86 0xdc 0x41 0xb2 0x1e 0x3
2018-05-13T05:06:25.396Z,1526187985.396 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0xd1 0x60 0xb3 0xc2 0x73 0x36 0x8e 0xc2 0x53 0xdb 0x28 0x43 0x44 0x6 0xdc 0x41 0xb2 0x1e
2018-05-13T05:06:25.400Z,1526187985.400 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:06:25.400Z,1526187985.400 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:25.401Z,1526187985.401 [AHRS_M2](ERROR): extractFloat: 0xd1 0x60 0xb3 0xc2
2018-05-13T05:06:25.402Z,1526187985.402 [AHRS_M2](ERROR): extractFloat: 0x73 0x36 0x8e 0xc2
2018-05-13T05:06:25.403Z,1526187985.403 [AHRS_M2](ERROR): extractFloat: 0x53 0xdb 0x28 0x43
2018-05-13T05:06:25.404Z,1526187985.404 [AHRS_M2](ERROR): extractFloat: 0x44 0x6 0xdc 0x41
2018-05-13T05:06:25.405Z,1526187985.405 [AHRS_M2](DEBUG): CRC match. PITCH: -89.689092 deg, ROLL: -71.106347 deg, YAW: 168.856729 deg, TEMP: 27.503059 C.
2018-05-13T05:06:25.557Z,1526187985.557 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-05-13T05:06:25.557Z,1526187985.557 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:25.558Z,1526187985.558 [CommandLine](INFO): Join timeout helper Thread ID is 8470
2018-05-13T05:06:25.573Z,1526187985.573 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-05-13T05:06:25.573Z,1526187985.573 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:25.573Z,1526187985.573 [NavChartDb](INFO): Join timeout helper Thread ID is 8471
2018-05-13T05:06:25.709Z,1526187985.709 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:06:25.710Z,1526187985.710 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:25.729Z,1526187985.729 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-05-13T05:06:25.729Z,1526187985.729 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:25.729Z,1526187985.729 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8472
2018-05-13T05:06:25.793Z,1526187985.793 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:25.795Z,1526187985.795 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0x10 0x90 0x65 0xb3 0xc2 0xf1 0xb7 0x8d 0xc2 0x9b 0x9b 0x28 0x43 0x66 0xda 0xdb 0x41 0x7c 0x69 0x3
2018-05-13T05:06:25.796Z,1526187985.796 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x10 0x65 0xb3 0xc2 0xf1 0xb7 0x8d 0xc2 0x9b 0x9b 0x28 0x43 0x66 0xda 0xdb 0x41 0x7c 0x69
2018-05-13T05:06:25.797Z,1526187985.797 [AHRS_M2](ERROR): extractFloat: 0x10 0x65 0xb3 0xc2
2018-05-13T05:06:25.798Z,1526187985.798 [AHRS_M2](ERROR): extractFloat: 0xf1 0xb7 0x8d 0xc2
2018-05-13T05:06:25.798Z,1526187985.798 [AHRS_M2](ERROR): extractFloat: 0x9b 0x9b 0x28 0x43
2018-05-13T05:06:25.799Z,1526187985.799 [AHRS_M2](ERROR): extractFloat: 0x66 0xda 0xdb 0x41
2018-05-13T05:06:25.800Z,1526187985.800 [AHRS_M2](DEBUG): CRC match. PITCH: -89.697391 deg, ROLL: -70.859258 deg, YAW: 168.607837 deg, TEMP: 27.481640 C.
2018-05-13T05:06:25.913Z,1526187985.913 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:06:25.913Z,1526187985.913 [WetLabsBB2FL](INFO): Powering down
2018-05-13T05:06:25.914Z,1526187985.914 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:25.925Z,1526187985.925 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2018-05-13T05:06:25.925Z,1526187985.925 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:25.925Z,1526187985.925 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8473
2018-05-13T05:06:26.192Z,1526187986.192 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:26.195Z,1526187986.195 [AHRS_M2](ERROR): Tx (23): 0x1 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0xc7 0xc0 0x8c 0xc2 0x42 0x1e 0x28 0x43 0x33 0xed 0xdb 0x41 0x9 0xa1 0x3
2018-05-13T05:06:26.196Z,1526187986.196 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x12 0x64 0xb3 0xc2 0xc7 0xc0 0x8c 0xc2 0x42 0x1e 0x28 0x43 0x33 0xed 0xdb 0x41 0x9 0xa1
2018-05-13T05:06:26.197Z,1526187986.197 [AHRS_M2](ERROR): extractFloat: 0x12 0x64 0xb3 0xc2
2018-05-13T05:06:26.198Z,1526187986.198 [AHRS_M2](ERROR): extractFloat: 0xc7 0xc0 0x8c 0xc2
2018-05-13T05:06:26.198Z,1526187986.198 [AHRS_M2](ERROR): extractFloat: 0x42 0x1e 0x28 0x43
2018-05-13T05:06:26.199Z,1526187986.199 [AHRS_M2](ERROR): extractFloat: 0x33 0xed 0xdb 0x41
2018-05-13T05:06:26.200Z,1526187986.200 [AHRS_M2](DEBUG): CRC match. PITCH: -89.695451 deg, ROLL: -70.376521 deg, YAW: 168.118194 deg, TEMP: 27.490820 C.
2018-05-13T05:06:26.261Z,1526187986.261 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:06:26.394Z,1526187986.394 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-13T05:06:26.395Z,1526187986.395 [CTD_Seabird](INFO): Powering down
2018-05-13T05:06:26.396Z,1526187986.396 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:26.405Z,1526187986.405 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-05-13T05:06:26.405Z,1526187986.405 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:26.406Z,1526187986.406 [Radio_Surface](INFO): Join timeout helper Thread ID is 8475
2018-05-13T05:06:26.593Z,1526187986.593 [AHRS_M2](INFO): Runnable
2018-05-13T05:06:26.595Z,1526187986.595 [AHRS_M2](ERROR): Tx (24): 0x1 0x14 0x69 0x0 0x7f 0x60 0xb3 0xc2 0x10 0x83 0x1d 0x8c 0xc2 0xec 0xcb 0x27 0x43 0xcc 0xb4 0xdb 0x41 0xc6 0x65 0x3
2018-05-13T05:06:26.597Z,1526187986.597 [AHRS_M2](ERROR): Tx post-dle (21): 0x14 0x69 0x0 0x7f 0x60 0xb3 0xc2 0x3 0x1d 0x8c 0xc2 0xec 0xcb 0x27 0x43 0xcc 0xb4 0xdb 0x41 0xc6 0x65
2018-05-13T05:06:26.598Z,1526187986.598 [AHRS_M2](ERROR): extractFloat: 0x7f 0x60 0xb3 0xc2
2018-05-13T05:06:26.598Z,1526187986.598 [AHRS_M2](ERROR): extractFloat: 0x3 0x1d 0x8c 0xc2
2018-05-13T05:06:26.599Z,1526187986.599 [AHRS_M2](ERROR): extractFloat: 0xec 0xcb 0x27 0x43
2018-05-13T05:06:26.600Z,1526187986.600 [AHRS_M2](ERROR): extractFloat: 0xcc 0xb4 0xdb 0x41
2018-05-13T05:06:26.602Z,1526187986.602 [AHRS_M2](DEBUG): CRC match. PITCH: -89.688471 deg, ROLL: -70.056663 deg, YAW: 167.796574 deg, TEMP: 27.463280 C.
2018-05-13T05:06:26.609Z,1526187986.609 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:06:26.610Z,1526187986.610 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:26.630Z,1526187986.630 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-05-13T05:06:26.630Z,1526187986.630 [logger ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:26.630Z,1526187986.630 [logger](INFO): Join timeout helper Thread ID is 8476
2018-05-13T05:06:26.637Z,1526187986.637 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:06:26.637Z,1526187986.637 [logger ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:26.654Z,1526187986.654 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-05-13T05:06:26.654Z,1526187986.654 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:26.654Z,1526187986.654 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-05-13T05:06:26.654Z,1526187986.654 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:26.654Z,1526187986.654 [controlThread](INFO): Join timeout helper Thread ID is 8477
2018-05-13T05:06:26.695Z,1526187986.695 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-13T05:06:26.695Z,1526187986.695 [controlThread](DEBUG): Uninitializing ControlThread
2018-05-13T05:06:26.696Z,1526187986.696 [AHRS_M2](INFO): uninitialize
2018-05-13T05:06:26.696Z,1526187986.696 [AHRS_M2](INFO): Powering down
2018-05-13T05:06:26.765Z,1526187986.765 [AcousticModem_Benthos_ATM900](INFO): Powering down
2018-05-13T05:06:26.885Z,1526187986.885 [NAL9602](INFO): Powering down
2018-05-13T05:06:27.005Z,1526187987.005 [Aanderaa_O2](INFO): Powering down
2018-05-13T05:06:27.007Z,1526187987.007 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-05-13T05:06:27.009Z,1526187987.009 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-05-13T05:06:27.010Z,1526187987.010 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-05-13T05:06:27.010Z,1526187987.010 [MissionManager](INFO): Uninitializing Mission Default
2018-05-13T05:06:27.013Z,1526187987.013 [MissionManager](INFO): Uninitializing Mission Startup
2018-05-13T05:06:27.014Z,1526187987.014 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-05-13T05:06:27.014Z,1526187987.014 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-05-13T05:06:27.015Z,1526187987.015 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-05-13T05:06:27.015Z,1526187987.015 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-05-13T05:06:27.015Z,1526187987.015 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-05-13T05:06:27.015Z,1526187987.015 [BuoyancyServo](INFO): Powering down
2018-05-13T05:06:27.029Z,1526187987.029 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-05-13T05:06:27.029Z,1526187987.029 [ElevatorServo](INFO): Powering down
2018-05-13T05:06:27.049Z,1526187987.049 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-05-13T05:06:27.049Z,1526187987.049 [MassServo](INFO): Powering down
2018-05-13T05:06:27.050Z,1526187987.050 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-05-13T05:06:27.050Z,1526187987.050 [RudderServo](INFO): Powering down
2018-05-13T05:06:27.051Z,1526187987.051 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-05-13T05:06:27.051Z,1526187987.051 [ThrusterServo](INFO): Powering down
2018-05-13T05:06:27.052Z,1526187987.052 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-05-13T05:06:27.052Z,1526187987.052 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-05-13T05:06:27.053Z,1526187987.053 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-05-13T05:06:27.054Z,1526187987.054 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:27.138Z,1526187987.138 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:27.177Z,1526187987.177 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:27.181Z,1526187987.181 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:27.465Z,1526187987.465 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-13T05:06:27.509Z,1526187987.509 [logger ThreadHandler](INFO): Thread cancelled.