2018-08-21T21:32:08.080Z,1534887128.080 [Supervisor](DEBUG): Initializing supervisor.
2018-08-21T21:32:08.083Z,1534887128.083 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-08-21T21:32:08.084Z,1534887128.084 [SyncHandler](INFO): Protected caller Thread ID is 8133
2018-08-21T21:32:08.085Z,1534887128.085 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-08-21T21:32:08.086Z,1534887128.086 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-08-21T21:32:08.086Z,1534887128.086 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8134
2018-08-21T21:32:08.089Z,1534887128.089 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-08-21T21:32:08.101Z,1534887128.101 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-08-21T21:32:08.102Z,1534887128.102 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-08-21T21:32:08.103Z,1534887128.103 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8135
2018-08-21T21:32:08.103Z,1534887128.103 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-08-21T21:32:08.104Z,1534887128.104 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-08-21T21:32:08.105Z,1534887128.105 [logger ThreadHandler](INFO): Protected caller Thread ID is 8136
2018-08-21T21:32:08.107Z,1534887128.107 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-08-21T21:32:08.107Z,1534887128.107 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-08-21T21:32:08.109Z,1534887128.109 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-08-21T21:32:08.303Z,1534887128.303 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-08-21T21:32:08.303Z,1534887128.303 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-08-21T21:32:08.445Z,1534887128.445 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-08-21T21:32:08.445Z,1534887128.445 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-08-21T21:32:08.789Z,1534887128.789 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-08-21T21:32:08.789Z,1534887128.789 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-08-21T21:32:08.927Z,1534887128.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-08-21T21:32:08.927Z,1534887128.927 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-08-21T21:32:09.007Z,1534887129.007 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-08-21T21:32:09.208Z,1534887129.208 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-08-21T21:32:09.209Z,1534887129.209 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-08-21T21:32:09.307Z,1534887129.307 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-08-21T21:32:09.307Z,1534887129.307 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-08-21T21:32:09.647Z,1534887129.647 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-08-21T21:32:09.647Z,1534887129.647 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-08-21T21:32:10.083Z,1534887130.083 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-08-21T21:32:10.084Z,1534887130.084 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-08-21T21:32:10.387Z,1534887130.387 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-08-21T21:32:10.388Z,1534887130.388 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-08-21T21:32:10.893Z,1534887130.893 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-08-21T21:32:10.893Z,1534887130.893 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-08-21T21:32:11.100Z,1534887131.100 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-08-21T21:32:11.101Z,1534887131.101 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-08-21T21:32:11.199Z,1534887131.199 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-08-21T21:32:11.199Z,1534887131.199 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-08-21T21:32:11.692Z,1534887131.692 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-08-21T21:32:11.692Z,1534887131.692 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-08-21T21:32:11.799Z,1534887131.799 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-08-21T21:32:11.801Z,1534887131.801 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2018-08-21T21:32:11.801Z,1534887131.801 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2018-08-21T21:32:12.034Z,1534887132.034 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-08-21T21:32:12.035Z,1534887132.035 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2018-08-21T21:32:12.133Z,1534887132.133 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2018-08-21T21:32:12.234Z,1534887132.234 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2018-08-21T21:32:12.340Z,1534887132.340 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2018-08-21T21:32:12.425Z,1534887132.425 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2018-08-21T21:32:12.559Z,1534887132.559 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2018-08-21T21:32:12.723Z,1534887132.723 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2018-08-21T21:32:12.833Z,1534887132.833 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2018-08-21T21:32:12.917Z,1534887132.917 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2018-08-21T21:32:13.001Z,1534887133.001 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2018-08-21T21:32:13.238Z,1534887133.238 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2018-08-21T21:32:13.239Z,1534887133.239 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-08-21T21:32:13.244Z,1534887133.244 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-08-21T21:32:13.372Z,1534887133.372 [SBIT](DEBUG): Construct Startup Built In Test.
2018-08-21T21:32:13.402Z,1534887133.402 [SBIT] Loaded
2018-08-21T21:32:13.402Z,1534887133.402 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-08-21T21:32:13.403Z,1534887133.403 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-08-21T21:32:13.430Z,1534887133.430 [IBIT] Loaded
2018-08-21T21:32:13.430Z,1534887133.430 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-08-21T21:32:13.433Z,1534887133.433 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-08-21T21:32:13.616Z,1534887133.616 [CBIT] Loaded
2018-08-21T21:32:13.617Z,1534887133.617 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-08-21T21:32:13.617Z,1534887133.617 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-08-21T21:32:13.618Z,1534887133.618 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-08-21T21:32:13.684Z,1534887133.684 [VerticalControl](DEBUG): Construct VerticalControl.
2018-08-21T21:32:13.784Z,1534887133.784 [VerticalControl] Loaded
2018-08-21T21:32:13.784Z,1534887133.784 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-08-21T21:32:13.785Z,1534887133.785 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-08-21T21:32:13.845Z,1534887133.845 [HorizontalControl] Loaded
2018-08-21T21:32:13.846Z,1534887133.846 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-08-21T21:32:13.846Z,1534887133.846 [SpeedControl](DEBUG): Construct SpeedControl.
2018-08-21T21:32:13.852Z,1534887133.852 [SpeedControl] Loaded
2018-08-21T21:32:13.852Z,1534887133.852 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-08-21T21:32:13.853Z,1534887133.853 [LoopControl](DEBUG): Construct LoopControl.
2018-08-21T21:32:13.853Z,1534887133.853 [LoopControl] Loaded
2018-08-21T21:32:13.854Z,1534887133.854 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-08-21T21:32:13.854Z,1534887133.854 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-08-21T21:32:13.855Z,1534887133.855 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-08-21T21:32:13.896Z,1534887133.896 [DepthRateCalculator] Loaded
2018-08-21T21:32:13.896Z,1534887133.896 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-08-21T21:32:13.901Z,1534887133.901 [PitchRateCalculator] Loaded
2018-08-21T21:32:13.901Z,1534887133.901 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-08-21T21:32:13.918Z,1534887133.918 [SpeedCalculator] Loaded
2018-08-21T21:32:13.918Z,1534887133.918 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-08-21T21:32:13.940Z,1534887133.940 [TempGradientCalculator] Loaded
2018-08-21T21:32:13.940Z,1534887133.940 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-08-21T21:32:13.956Z,1534887133.956 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-08-21T21:32:13.956Z,1534887133.956 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-08-21T21:32:13.961Z,1534887133.961 [YawRateCalculator] Loaded
2018-08-21T21:32:13.961Z,1534887133.961 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-08-21T21:32:13.991Z,1534887133.991 [ElevatorOffsetCalculator] Loaded
2018-08-21T21:32:13.991Z,1534887133.991 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-08-21T21:32:13.991Z,1534887133.991 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-08-21T21:32:13.992Z,1534887133.992 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-08-21T21:32:14.075Z,1534887134.075 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-08-21T21:32:14.075Z,1534887134.075 [StratificationFrontDetector](DEBUG): (re)initializing
2018-08-21T21:32:14.076Z,1534887134.076 [StratificationFrontDetector] Loaded
2018-08-21T21:32:14.076Z,1534887134.076 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-08-21T21:32:14.076Z,1534887134.076 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-08-21T21:32:14.077Z,1534887134.077 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-08-21T21:32:14.322Z,1534887134.322 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-08-21T21:32:14.323Z,1534887134.323 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-08-21T21:32:14.419Z,1534887134.419 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-08-21T21:32:14.419Z,1534887134.419 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-08-21T21:32:14.474Z,1534887134.474 [DeadReckonUsingSpeedCalculator] Loaded
2018-08-21T21:32:14.474Z,1534887134.474 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-08-21T21:32:14.491Z,1534887134.491 [NavChart] Loaded
2018-08-21T21:32:14.491Z,1534887134.491 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-08-21T21:32:14.495Z,1534887134.495 [UniversalFixResidualReporter] Loaded
2018-08-21T21:32:14.495Z,1534887134.495 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-08-21T21:32:14.496Z,1534887134.496 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-08-21T21:32:14.496Z,1534887134.496 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-08-21T21:32:14.509Z,1534887134.509 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-08-21T21:32:14.510Z,1534887134.510 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-08-21T21:32:14.665Z,1534887134.665 [Aanderaa_O2] Loaded
2018-08-21T21:32:14.666Z,1534887134.666 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-08-21T21:32:14.711Z,1534887134.711 [WetLabsSeaOWL_UV_A] Loaded
2018-08-21T21:32:14.711Z,1534887134.711 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2018-08-21T21:32:14.712Z,1534887134.712 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 406D54E0
2018-08-21T21:32:14.713Z,1534887134.713 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 8215
2018-08-21T21:32:14.713Z,1534887134.713 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-08-21T21:32:14.714Z,1534887134.714 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-08-21T21:32:15.026Z,1534887135.026 [AHRS_M2] Loaded
2018-08-21T21:32:15.027Z,1534887135.027 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-08-21T21:32:15.095Z,1534887135.095 [DataOverHttps] Loaded
2018-08-21T21:32:15.096Z,1534887135.096 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-08-21T21:32:15.109Z,1534887135.109 [Depth_Keller] Loaded
2018-08-21T21:32:15.109Z,1534887135.109 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-08-21T21:32:15.114Z,1534887135.114 [DropWeight] Loaded
2018-08-21T21:32:15.114Z,1534887135.114 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-08-21T21:32:15.207Z,1534887135.207 [NAL9602] Loaded
2018-08-21T21:32:15.207Z,1534887135.207 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-08-21T21:32:15.213Z,1534887135.213 [Onboard] Loaded
2018-08-21T21:32:15.213Z,1534887135.213 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-08-21T21:32:15.220Z,1534887135.220 [Radio_Surface] Loaded
2018-08-21T21:32:15.220Z,1534887135.220 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-08-21T21:32:15.221Z,1534887135.221 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092C4E0
2018-08-21T21:32:15.221Z,1534887135.221 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8216
2018-08-21T21:32:15.250Z,1534887135.250 [RDI_Pathfinder] Loaded
2018-08-21T21:32:15.251Z,1534887135.251 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2018-08-21T21:32:15.257Z,1534887135.257 [SCPI] Loaded
2018-08-21T21:32:15.257Z,1534887135.257 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-08-21T21:32:17.230Z,1534887137.230 [BPC1] Loaded
2018-08-21T21:32:17.231Z,1534887137.231 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-08-21T21:32:17.231Z,1534887137.231 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-08-21T21:32:17.232Z,1534887137.232 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-08-21T21:32:17.330Z,1534887137.330 [BuoyancyServo] Loaded
2018-08-21T21:32:17.330Z,1534887137.330 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-08-21T21:32:17.342Z,1534887137.342 [ElevatorServo] Loaded
2018-08-21T21:32:17.342Z,1534887137.342 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-08-21T21:32:17.353Z,1534887137.353 [MassServo] Loaded
2018-08-21T21:32:17.354Z,1534887137.354 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-08-21T21:32:17.365Z,1534887137.365 [RudderServo] Loaded
2018-08-21T21:32:17.365Z,1534887137.365 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-08-21T21:32:17.376Z,1534887137.376 [ThrusterServo] Loaded
2018-08-21T21:32:17.376Z,1534887137.376 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-08-21T21:32:17.377Z,1534887137.377 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-08-21T21:32:17.377Z,1534887137.377 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-08-21T21:32:17.478Z,1534887137.478 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-08-21T21:32:17.479Z,1534887137.479 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-08-21T21:32:17.503Z,1534887137.503 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-08-21T21:32:17.507Z,1534887137.507 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-08-21T21:32:17.508Z,1534887137.508 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-08-21T21:32:17.514Z,1534887137.514 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-08-21T21:32:17.515Z,1534887137.515 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409D54E0
2018-08-21T21:32:17.516Z,1534887137.516 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8217
2018-08-21T21:32:17.618Z,1534887137.618 [Supervisor](INFO): Main Thread ID is 8009
2018-08-21T21:32:17.618Z,1534887137.618 [Supervisor](DEBUG): Running supervisor.
2018-08-21T21:32:17.619Z,1534887137.619 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8218
2018-08-21T21:32:17.622Z,1534887137.622 [controlThread ThreadHandler](INFO): Handler Thread ID is 8219
2018-08-21T21:32:17.622Z,1534887137.622 [controlThread](DEBUG): Initializing ControlThread
2018-08-21T21:32:17.623Z,1534887137.623 [SBIT](INFO): Initialize SBIT Component.
2018-08-21T21:32:17.624Z,1534887137.624 [SBIT](IMPORTANT): git: 2018-08-21
2018-08-21T21:32:17.624Z,1534887137.624 [SBIT](INFO): git hash: d4ab0a1cfab12a66871bdda78458a7e977097781
2018-08-21T21:32:17.624Z,1534887137.624 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-08-21T21:32:17.626Z,1534887137.626 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-08-21T21:32:17.627Z,1534887137.627 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2018-08-21T21:32:17.627Z,1534887137.627 [IBIT](INFO): Initialize IBIT Component.
2018-08-21T21:32:17.628Z,1534887137.628 [CBIT](DEBUG): Initialize CBIT Component.
2018-08-21T21:32:17.629Z,1534887137.629 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-08-21T21:32:17.639Z,1534887137.639 [logger ThreadHandler](INFO): Handler Thread ID is 8220
2018-08-21T21:32:17.667Z,1534887137.667 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 8221
2018-08-21T21:32:17.668Z,1534887137.668 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-08-21T21:32:17.688Z,1534887137.688 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8222
2018-08-21T21:32:17.694Z,1534887137.694 [Radio_Surface](INFO): Powering up
2018-08-21T21:32:17.695Z,1534887137.695 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8223
2018-08-21T21:32:17.699Z,1534887137.699 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-08-21T21:32:17.699Z,1534887137.699 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-08-21T21:32:17.699Z,1534887137.699 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-08-21T21:32:17.699Z,1534887137.699 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-08-21T21:32:17.700Z,1534887137.700 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-08-21T21:32:17.700Z,1534887137.700 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-08-21T21:32:17.700Z,1534887137.700 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-08-21T21:32:17.700Z,1534887137.700 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-08-21T21:32:17.700Z,1534887137.700 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-08-21T21:32:17.700Z,1534887137.700 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-08-21T21:32:17.701Z,1534887137.701 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-08-21T21:32:17.701Z,1534887137.701 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-08-21T21:32:17.701Z,1534887137.701 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-08-21T21:32:17.701Z,1534887137.701 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-08-21T21:32:17.701Z,1534887137.701 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-08-21T21:32:17.702Z,1534887137.702 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-08-21T21:32:17.734Z,1534887137.734 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-08-21T21:32:17.736Z,1534887137.736 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-08-21T21:32:17.737Z,1534887137.737 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-08-21T21:32:17.737Z,1534887137.737 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-08-21T21:32:17.738Z,1534887137.738 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-08-21T21:32:17.738Z,1534887137.738 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-08-21T21:32:17.738Z,1534887137.738 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-08-21T21:32:17.739Z,1534887137.739 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-08-21T21:32:17.739Z,1534887137.739 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-08-21T21:32:17.740Z,1534887137.740 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-08-21T21:32:17.740Z,1534887137.740 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-08-21T21:32:17.741Z,1534887137.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-08-21T21:32:17.742Z,1534887137.742 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:32:17.742Z,1534887137.742 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:32:17.743Z,1534887137.743 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-08-21T21:32:17.743Z,1534887137.743 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:32:17.744Z,1534887137.744 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:32:17.744Z,1534887137.744 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-08-21T21:32:17.744Z,1534887137.744 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-08-21T21:32:17.751Z,1534887137.751 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-08-21T21:32:17.791Z,1534887137.791 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-08-21T21:32:17.851Z,1534887137.851 [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-08-21T21:32:17.852Z,1534887137.852 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-08-21T21:32:17.960Z,1534887137.960 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-08-21T21:32:17.961Z,1534887137.961 [Default:A.Wait](DEBUG): Construct Wait.
2018-08-21T21:32:17.963Z,1534887137.963 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-08-21T21:32:17.993Z,1534887137.993 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-08-21T21:32:18.016Z,1534887138.016 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-08-21T21:32:18.023Z,1534887138.023 [Default:E.Execute](DEBUG): Construct Execute.
2018-08-21T21:32:18.051Z,1534887138.051 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <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">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <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-08-21T21:32:18.056Z,1534887138.056 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-08-21T21:32:18.101Z,1534887138.101 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-08-21T21:32:18.167Z,1534887138.167 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-08-21T21:32:18.199Z,1534887138.199 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2018-08-21T21:32:18.421Z,1534887138.421 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-08-21T21:32:18.555Z,1534887138.555 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:18.571Z,1534887138.571 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:18.699Z,1534887138.699 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-08-21T21:32:18.707Z,1534887138.707 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-08-21T21:32:18.721Z,1534887138.721 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-08-21T21:32:18.723Z,1534887138.723 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-08-21T21:32:18.729Z,1534887138.729 [MassServo](DEBUG): Initializing EZServoServo.
2018-08-21T21:32:18.735Z,1534887138.735 [MassServo](DEBUG): Initializing MassServo.
2018-08-21T21:32:18.741Z,1534887138.741 [RudderServo](DEBUG): Initializing EZServoServo.
2018-08-21T21:32:18.747Z,1534887138.747 [RudderServo](DEBUG): Initializing RudderServo.
2018-08-21T21:32:18.752Z,1534887138.752 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-08-21T21:32:18.759Z,1534887138.759 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-08-21T21:32:18.949Z,1534887138.949 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2018-08-21T21:32:18.949Z,1534887138.949 [DropWeight] Hardware Fault, FailCount= 1
2018-08-21T21:32:18.949Z,1534887138.949 [DropWeight](ERROR): Hardware Fault
2018-08-21T21:32:19.003Z,1534887139.003 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-08-21T21:32:19.006Z,1534887139.006 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:19.008Z,1534887139.008 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:19.029Z,1534887139.029 [CommandLine](FAULT): Scheduling is paused
2018-08-21T21:32:19.030Z,1534887139.030 [CBIT](INFO): Critical error at 20180821T213218
2018-08-21T21:32:19.030Z,1534887139.030 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-08-21T21:32:19.033Z,1534887139.033 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-08-21T21:32:19.033Z,1534887139.033 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-08-21T21:32:19.302Z,1534887139.302 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:19.303Z,1534887139.303 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:19.646Z,1534887139.646 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2018-08-21T21:32:19.647Z,1534887139.647 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2018-08-21T21:32:19.647Z,1534887139.647 [BuoyancyServo] Communications Fault, FailCount= 1
2018-08-21T21:32:19.647Z,1534887139.647 [BuoyancyServo](ERROR): Communications Fault
2018-08-21T21:32:19.852Z,1534887139.852 [CBIT](INFO): Critical error at 20180821T213219
2018-08-21T21:32:19.855Z,1534887139.855 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2018-08-21T21:32:19.903Z,1534887139.903 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:19.904Z,1534887139.904 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:19.920Z,1534887139.920 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-08-21T21:32:19.922Z,1534887139.922 [BuoyancyServo](INFO): Powering down
2018-08-21T21:32:20.292Z,1534887140.292 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:20.293Z,1534887140.293 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:20.691Z,1534887140.691 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:20.692Z,1534887140.692 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:21.091Z,1534887141.091 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:21.092Z,1534887141.092 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:21.531Z,1534887141.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:21.532Z,1534887141.532 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-08-21T21:32:22.041Z,1534887142.041 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2018-08-21T21:32:22.041Z,1534887142.041 [BuoyancyServo] No Fault, FailCount= 1
2018-08-21T21:32:22.335Z,1534887142.335 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-08-21T21:32:22.455Z,1534887142.455 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-08-21T21:32:28.328Z,1534887148.328 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:32:28.328Z,1534887148.328 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-08-21T21:32:28.328Z,1534887148.328 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:32:28.394Z,1534887148.394 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:32:28.846Z,1534887148.846 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:32:29.598Z,1534887149.598 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:32:29.598Z,1534887149.598 [Aanderaa_O2] No Fault, FailCount= 1
2018-08-21T21:32:40.328Z,1534887160.328 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:32:40.328Z,1534887160.328 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-08-21T21:32:40.328Z,1534887160.328 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:32:40.417Z,1534887160.417 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:32:40.846Z,1534887160.846 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:32:40.873Z,1534887160.873 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:32:40.874Z,1534887160.874 [RDI_Pathfinder] Communications Fault, FailCount= 1
2018-08-21T21:32:40.874Z,1534887160.874 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:32:40.928Z,1534887160.928 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:32:41.234Z,1534887161.234 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:32:41.593Z,1534887161.593 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:32:41.593Z,1534887161.593 [Aanderaa_O2] No Fault, FailCount= 2
2018-08-21T21:32:42.053Z,1534887162.053 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:32:42.053Z,1534887162.053 [RDI_Pathfinder] No Fault, FailCount= 1
2018-08-21T21:32:42.411Z,1534887162.411 [SBIT](IMPORTANT): Beginning Startup BIT
2018-08-21T21:32:42.418Z,1534887162.418 [CBIT](IMPORTANT): Beginning ground fault scan
2018-08-21T21:32:45.252Z,1534887165.252 [NAL9602](INFO): Powering up NAL9602
2018-08-21T21:32:52.043Z,1534887172.043 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:32:52.043Z,1534887172.043 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-08-21T21:32:52.044Z,1534887172.044 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:32:52.240Z,1534887172.240 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:32:52.240Z,1534887172.240 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-08-21T21:32:52.563Z,1534887172.563 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:32:53.440Z,1534887173.440 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008736
CHAN A1 (24V): -0.012634
CHAN A2 (12V): -0.007217
CHAN A3 (5V): -0.002046
CHAN B0 (3.3V): 0.000123
CHAN B1 (3.15aV): 0.000025
CHAN B2 (3.15bV): -0.000235
CHAN B3 (GND): 0.002147
OPEN: 0.004703
Full Scale Calc: 4.765 mA, -1.589 mA
2018-08-21T21:32:55.911Z,1534887175.911 [CommandLine](IMPORTANT): got command failComponent
2018-08-21T21:32:55.911Z,1534887175.911 [CommandLine](IMPORTANT): Failed components:
2018-08-21T21:32:55.912Z,1534887175.912 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault
2018-08-21T21:32:55.912Z,1534887175.912 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2018-08-21T21:32:56.464Z,1534887176.464 [NAL9602](INFO): NAL9602 initialized
2018-08-21T21:33:04.670Z,1534887184.670 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:33:04.670Z,1534887184.670 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-08-21T21:33:04.670Z,1534887184.670 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:33:04.753Z,1534887184.753 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:33:05.131Z,1534887185.131 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:33:05.964Z,1534887185.964 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:33:05.964Z,1534887185.964 [RDI_Pathfinder] No Fault, FailCount= 2
2018-08-21T21:33:15.465Z,1534887195.465 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 2.000000 count
2018-08-21T21:33:15.829Z,1534887195.829 [AHRS_M2](INFO): PITCH: 89.040183 deg, ROLL: 37.822009 deg, YAW: 287.438321 deg.
2018-08-21T21:33:16.229Z,1534887196.229 [AHRS_M2](INFO): PITCH: 89.036522 deg, ROLL: 37.759263 deg, YAW: 287.371521 deg.
2018-08-21T21:33:16.629Z,1534887196.629 [AHRS_M2](INFO): PITCH: 89.042226 deg, ROLL: 37.506771 deg, YAW: 287.126618 deg.
2018-08-21T21:33:17.029Z,1534887197.029 [AHRS_M2](INFO): PITCH: 89.040388 deg, ROLL: 37.403328 deg, YAW: 287.017827 deg.
2018-08-21T21:33:17.429Z,1534887197.429 [AHRS_M2](INFO): PITCH: 89.039978 deg, ROLL: 37.614210 deg, YAW: 287.224754 deg.
2018-08-21T21:33:17.829Z,1534887197.829 [AHRS_M2](INFO): PITCH: 89.033893 deg, ROLL: 37.295374 deg, YAW: 286.881524 deg.
2018-08-21T21:33:18.229Z,1534887198.229 [AHRS_M2](INFO): PITCH: 89.040805 deg, ROLL: 37.431182 deg, YAW: 287.034329 deg.
2018-08-21T21:33:18.629Z,1534887198.629 [AHRS_M2](INFO): PITCH: 89.037745 deg, ROLL: 37.364365 deg, YAW: 286.953077 deg.
2018-08-21T21:33:19.029Z,1534887199.029 [AHRS_M2](INFO): PITCH: 89.033278 deg, ROLL: 37.910463 deg, YAW: 287.494028 deg.
2018-08-21T21:33:19.429Z,1534887199.429 [AHRS_M2](INFO): PITCH: 89.034897 deg, ROLL: 37.541872 deg, YAW: 287.122083 deg.
2018-08-21T21:33:19.829Z,1534887199.829 [AHRS_M2](INFO): PITCH: 89.036119 deg, ROLL: 37.787335 deg, YAW: 287.382176 deg.
2018-08-21T21:33:20.229Z,1534887200.229 [AHRS_M2](INFO): PITCH: 89.033681 deg, ROLL: 37.252019 deg, YAW: 286.837728 deg.
2018-08-21T21:33:20.629Z,1534887200.629 [AHRS_M2](INFO): PITCH: 89.028231 deg, ROLL: 36.933579 deg, YAW: 286.507448 deg.
2018-08-21T21:33:21.029Z,1534887201.029 [AHRS_M2](INFO): PITCH: 89.036925 deg, ROLL: 36.853816 deg, YAW: 286.454965 deg.
2018-08-21T21:33:21.429Z,1534887201.429 [AHRS_M2](INFO): PITCH: 89.031256 deg, ROLL: 37.079690 deg, YAW: 286.666045 deg.
2018-08-21T21:33:21.829Z,1534887201.829 [AHRS_M2](INFO): PITCH: 89.035307 deg, ROLL: 37.059660 deg, YAW: 286.663968 deg.
2018-08-21T21:33:22.229Z,1534887202.229 [AHRS_M2](INFO): PITCH: 89.032472 deg, ROLL: 37.454240 deg, YAW: 287.054737 deg.
2018-08-21T21:33:22.629Z,1534887202.629 [AHRS_M2](INFO): PITCH: 89.034897 deg, ROLL: 37.322698 deg, YAW: 286.926685 deg.
2018-08-21T21:33:23.029Z,1534887203.029 [AHRS_M2](INFO): PITCH: 89.036522 deg, ROLL: 37.549446 deg, YAW: 287.163064 deg.
2018-08-21T21:33:23.429Z,1534887203.429 [AHRS_M2](INFO): PITCH: 89.042642 deg, ROLL: 37.521473 deg, YAW: 287.151371 deg.
2018-08-21T21:33:23.829Z,1534887203.829 [AHRS_M2](INFO): PITCH: 89.034897 deg, ROLL: 37.477989 deg, YAW: 287.095363 deg.
2018-08-21T21:33:24.229Z,1534887204.229 [AHRS_M2](INFO): PITCH: 89.037950 deg, ROLL: 37.538812 deg, YAW: 287.165058 deg.
2018-08-21T21:33:24.629Z,1534887204.629 [AHRS_M2](INFO): PITCH: 89.036925 deg, ROLL: 37.173827 deg, YAW: 286.793605 deg.
2018-08-21T21:33:25.148Z,1534887205.148 [AHRS_M2](INFO): PITCH: 89.043653 deg, ROLL: 37.180271 deg, YAW: 286.813030 deg.
2018-08-21T21:33:25.549Z,1534887205.549 [AHRS_M2](INFO): PITCH: 89.036522 deg, ROLL: 37.262753 deg, YAW: 286.885458 deg.
2018-08-21T21:33:25.949Z,1534887205.949 [AHRS_M2](INFO): PITCH: 89.036727 deg, ROLL: 37.045399 deg, YAW: 286.665307 deg.
2018-08-21T21:33:26.349Z,1534887206.349 [AHRS_M2](INFO): PITCH: 89.031051 deg, ROLL: 37.629954 deg, YAW: 287.241447 deg.
2018-08-21T21:33:26.749Z,1534887206.749 [AHRS_M2](INFO): PITCH: 89.034091 deg, ROLL: 37.705605 deg, YAW: 287.330212 deg.
2018-08-21T21:33:27.149Z,1534887207.149 [AHRS_M2](INFO): PITCH: 89.033073 deg, ROLL: 37.847857 deg, YAW: 287.475887 deg.
2018-08-21T21:33:27.549Z,1534887207.549 [AHRS_M2](INFO): PITCH: 89.032875 deg, ROLL: 38.247181 deg, YAW: 287.876491 deg.
2018-08-21T21:33:27.949Z,1534887207.949 [AHRS_M2](INFO): PITCH: 89.028231 deg, ROLL: 37.801006 deg, YAW: 287.412694 deg.
2018-08-21T21:33:28.349Z,1534887208.349 [AHRS_M2](INFO): PITCH: 89.034897 deg, ROLL: 37.705042 deg, YAW: 287.337589 deg.
2018-08-21T21:33:28.749Z,1534887208.749 [AHRS_M2](INFO): PITCH: 89.045087 deg, ROLL: 37.831168 deg, YAW: 287.496186 deg.
2018-08-21T21:33:28.773Z,1534887208.773 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:33:28.773Z,1534887208.773 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-08-21T21:33:28.773Z,1534887208.773 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:33:28.873Z,1534887208.873 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:33:28.874Z,1534887208.874 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:33:29.149Z,1534887209.149 [AHRS_M2](INFO): PITCH: 89.038353 deg, ROLL: 37.752484 deg, YAW: 287.393132 deg.
2018-08-21T21:33:29.239Z,1534887209.239 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:33:29.310Z,1534887209.310 [CBIT](INFO): Critical error at 20180821T213328
2018-08-21T21:33:29.549Z,1534887209.549 [AHRS_M2](INFO): PITCH: 89.032274 deg, ROLL: 37.685364 deg, YAW: 287.308301 deg.
2018-08-21T21:33:29.949Z,1534887209.949 [AHRS_M2](INFO): PITCH: 89.043250 deg, ROLL: 37.528744 deg, YAW: 287.182544 deg.
2018-08-21T21:33:30.349Z,1534887210.349 [AHRS_M2](INFO): PITCH: 89.046740 deg, ROLL: 37.403700 deg, YAW: 287.065802 deg.
2018-08-21T21:33:30.751Z,1534887210.751 [AHRS_M2](INFO): PITCH: 89.032875 deg, ROLL: 37.566863 deg, YAW: 287.194893 deg.
2018-08-21T21:33:31.152Z,1534887211.152 [AHRS_M2](INFO): PITCH: 89.035307 deg, ROLL: 37.554931 deg, YAW: 287.194456 deg.
2018-08-21T21:33:31.549Z,1534887211.549 [AHRS_M2](INFO): PITCH: 89.033681 deg, ROLL: 37.690425 deg, YAW: 287.333300 deg.
2018-08-21T21:33:31.949Z,1534887211.949 [AHRS_M2](INFO): PITCH: 89.025621 deg, ROLL: 37.825028 deg, YAW: 287.450861 deg.
2018-08-21T21:33:32.349Z,1534887212.349 [AHRS_M2](INFO): PITCH: 89.030648 deg, ROLL: 37.858127 deg, YAW: 287.496541 deg.
2018-08-21T21:33:32.749Z,1534887212.749 [AHRS_M2](INFO): PITCH: 89.033073 deg, ROLL: 37.420663 deg, YAW: 287.060010 deg.
2018-08-21T21:33:33.149Z,1534887213.149 [AHRS_M2](INFO): PITCH: 89.027425 deg, ROLL: 37.653043 deg, YAW: 287.269396 deg.
2018-08-21T21:33:33.549Z,1534887213.549 [AHRS_M2](INFO): PITCH: 89.028429 deg, ROLL: 37.917887 deg, YAW: 287.540937 deg.
2018-08-21T21:33:33.949Z,1534887213.949 [AHRS_M2](INFO): PITCH: 89.032670 deg, ROLL: 37.281170 deg, YAW: 286.905457 deg.
2018-08-21T21:33:34.349Z,1534887214.349 [AHRS_M2](INFO): PITCH: 89.034296 deg, ROLL: 37.398407 deg, YAW: 287.031405 deg.
2018-08-21T21:33:34.749Z,1534887214.749 [AHRS_M2](INFO): PITCH: 89.033476 deg, ROLL: 37.289469 deg, YAW: 286.916713 deg.
2018-08-21T21:33:35.149Z,1534887215.149 [AHRS_M2](INFO): PITCH: 89.033893 deg, ROLL: 37.764420 deg, YAW: 287.396984 deg.
2018-08-21T21:33:35.549Z,1534887215.549 [AHRS_M2](INFO): PITCH: 89.029849 deg, ROLL: 37.750531 deg, YAW: 287.371958 deg.
2018-08-21T21:33:35.949Z,1534887215.949 [AHRS_M2](INFO): PITCH: 89.033893 deg, ROLL: 37.453598 deg, YAW: 287.076457 deg.
2018-08-21T21:33:36.349Z,1534887216.349 [AHRS_M2](INFO): PITCH: 89.032274 deg, ROLL: 37.470168 deg, YAW: 287.086019 deg.
2018-08-21T21:33:36.434Z,1534887216.434 [SBIT](IMPORTANT): SBIT PASSED
2018-08-21T21:33:36.495Z,1534887216.495 [CommandLine](IMPORTANT): got command configSet list
2018-08-21T21:33:36.495Z,1534887216.495 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-08-21T21:33:36.496Z,1534887216.496 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=1 bool;

2018-08-21T21:33:36.496Z,1534887216.496 [CommandLine](IMPORTANT): Radio_Surface.loadAtStartup=1 bool;

2018-08-21T21:33:36.496Z,1534887216.496 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=160 cubic_centimeter;

2018-08-21T21:33:36.496Z,1534887216.496 [CommandLine](IMPORTANT): VerticalControl.massDefault=-1 millimeter;

2018-08-21T21:33:36.749Z,1534887216.749 [AHRS_M2](INFO): PITCH: 89.032472 deg, ROLL: 37.810127 deg, YAW: 287.424769 deg.
2018-08-21T21:33:36.815Z,1534887216.815 [MissionManager](IMPORTANT): Started mission Startup
2018-08-21T21:33:36.815Z,1534887216.815 [Startup] Running Loop=1
2018-08-21T21:33:36.815Z,1534887216.815 [Startup](DEBUG): Aggregate::initialize Startup
2018-08-21T21:33:36.816Z,1534887216.816 [Startup:A.GoToSurface] Running Loop=1
2018-08-21T21:33:36.816Z,1534887216.816 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-08-21T21:33:36.816Z,1534887216.816 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-08-21T21:33:36.817Z,1534887216.817 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-08-21T21:33:36.817Z,1534887216.817 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-08-21T21:33:36.817Z,1534887216.817 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-08-21T21:33:36.818Z,1534887216.818 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-08-21T21:33:36.836Z,1534887216.836 [Startup:StartupSatComms] Running Loop=1
2018-08-21T21:33:36.836Z,1534887216.836 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-08-21T21:33:36.836Z,1534887216.836 [Startup:StartupSatComms:A] Running Loop=1
2018-08-21T21:33:37.149Z,1534887217.149 [AHRS_M2](INFO): PITCH: 89.021605 deg, ROLL: 37.705824 deg, YAW: 287.283822 deg.
2018-08-21T21:33:37.208Z,1534887217.208 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-08-21T21:33:37.549Z,1534887217.549 [AHRS_M2](INFO): PITCH: 89.031659 deg, ROLL: 37.779412 deg, YAW: 287.391520 deg.
2018-08-21T21:33:37.949Z,1534887217.949 [AHRS_M2](INFO): PITCH: 89.037547 deg, ROLL: 37.736522 deg, YAW: 287.372341 deg.
2018-08-21T21:33:38.349Z,1534887218.349 [AHRS_M2](INFO): PITCH: 89.038148 deg, ROLL: 37.191176 deg, YAW: 286.823986 deg.
2018-08-21T21:33:38.749Z,1534887218.749 [AHRS_M2](INFO): PITCH: 89.032670 deg, ROLL: 37.718675 deg, YAW: 287.349965 deg.
2018-08-21T21:33:39.149Z,1534887219.149 [AHRS_M2](INFO): PITCH: 89.033278 deg, ROLL: 37.583249 deg, YAW: 287.220984 deg.
2018-08-21T21:33:39.549Z,1534887219.549 [AHRS_M2](INFO): PITCH: 89.032875 deg, ROLL: 37.834812 deg, YAW: 287.470450 deg.
2018-08-21T21:33:39.949Z,1534887219.949 [AHRS_M2](INFO): PITCH: 89.030252 deg, ROLL: 37.522583 deg, YAW: 287.144896 deg.
2018-08-21T21:33:40.349Z,1534887220.349 [AHRS_M2](INFO): PITCH: 89.033278 deg, ROLL: 37.592787 deg, YAW: 287.227104 deg.
2018-08-21T21:33:40.749Z,1534887220.749 [AHRS_M2](INFO): PITCH: 89.041816 deg, ROLL: 37.795169 deg, YAW: 287.454440 deg.
2018-08-21T21:33:41.149Z,1534887221.149 [AHRS_M2](INFO): PITCH: 89.041406 deg, ROLL: 37.479621 deg, YAW: 287.133558 deg.
2018-08-21T21:33:41.549Z,1534887221.549 [AHRS_M2](INFO): PITCH: 89.033893 deg, ROLL: 37.448964 deg, YAW: 287.075610 deg.
2018-08-21T21:33:41.949Z,1534887221.949 [AHRS_M2](INFO): PITCH: 89.037547 deg, ROLL: 37.519619 deg, YAW: 287.151671 deg.
2018-08-21T21:33:42.349Z,1534887222.349 [AHRS_M2](INFO): PITCH: 89.032472 deg, ROLL: 37.794121 deg, YAW: 287.410590 deg.
2018-08-21T21:33:42.749Z,1534887222.749 [AHRS_M2](INFO): PITCH: 89.037130 deg, ROLL: 37.876114 deg, YAW: 287.513753 deg.
2018-08-21T21:33:43.149Z,1534887223.149 [AHRS_M2](INFO): PITCH: 89.031871 deg, ROLL: 37.330764 deg, YAW: 286.953104 deg.
2018-08-21T21:33:43.549Z,1534887223.549 [AHRS_M2](INFO): PITCH: 89.027022 deg, ROLL: 38.006953 deg, YAW: 287.626287 deg.
2018-08-21T21:33:43.949Z,1534887223.949 [AHRS_M2](INFO): PITCH: 89.027636 deg, ROLL: 37.759410 deg, YAW: 287.378406 deg.
2018-08-21T21:33:44.349Z,1534887224.349 [AHRS_M2](INFO): PITCH: 89.024412 deg, ROLL: 37.323763 deg, YAW: 286.932805 deg.
2018-08-21T21:33:44.749Z,1534887224.749 [AHRS_M2](INFO): PITCH: 89.028231 deg, ROLL: 37.762139 deg, YAW: 287.385810 deg.
2018-08-21T21:33:45.149Z,1534887225.149 [AHRS_M2](INFO): PITCH: 89.035716 deg, ROLL: 37.750039 deg, YAW: 287.394416 deg.
2018-08-21T21:33:45.549Z,1534887225.549 [AHRS_M2](INFO): PITCH: 89.035921 deg, ROLL: 38.050953 deg, YAW: 287.697758 deg.
2018-08-21T21:33:45.949Z,1534887225.949 [AHRS_M2](INFO): PITCH: 89.035307 deg, ROLL: 38.001731 deg, YAW: 287.640740 deg.
2018-08-21T21:33:46.349Z,1534887226.349 [AHRS_M2](INFO): PITCH: 89.040593 deg, ROLL: 37.820554 deg, YAW: 287.471625 deg.
2018-08-21T21:33:46.749Z,1534887226.749 [AHRS_M2](INFO): PITCH: 89.034692 deg, ROLL: 37.669029 deg, YAW: 287.303219 deg.
2018-08-21T21:33:47.149Z,1534887227.149 [AHRS_M2](INFO): PITCH: 89.036119 deg, ROLL: 38.164300 deg, YAW: 287.811140 deg.
2018-08-21T21:33:47.549Z,1534887227.549 [AHRS_M2](INFO): PITCH: 89.033476 deg, ROLL: 37.979643 deg, YAW: 287.617162 deg.
2018-08-21T21:33:47.949Z,1534887227.949 [AHRS_M2](INFO): PITCH: 89.032875 deg, ROLL: 37.795682 deg, YAW: 287.424688 deg.
2018-08-21T21:33:48.349Z,1534887228.349 [AHRS_M2](INFO): PITCH: 89.031256 deg, ROLL: 37.737212 deg, YAW: 287.366221 deg.
2018-08-21T21:33:48.749Z,1534887228.749 [AHRS_M2](INFO): PITCH: 89.029439 deg, ROLL: 37.554135 deg, YAW: 287.177216 deg.
2018-08-21T21:33:49.149Z,1534887229.149 [AHRS_M2](INFO): PITCH: 89.036317 deg, ROLL: 37.910985 deg, YAW: 287.558614 deg.
2018-08-21T21:33:49.549Z,1534887229.549 [AHRS_M2](INFO): PITCH: 89.035307 deg, ROLL: 37.392646 deg, YAW: 287.028017 deg.
2018-08-21T21:33:49.949Z,1534887229.949 [AHRS_M2](INFO): PITCH: 89.046522 deg, ROLL: 37.197384 deg, YAW: 286.864202 deg.
2018-08-21T21:33:50.349Z,1534887230.349 [AHRS_M2](INFO): PITCH: 89.041611 deg, ROLL: 37.277038 deg, YAW: 286.933897 deg.
2018-08-21T21:33:50.749Z,1534887230.749 [AHRS_M2](INFO): PITCH: 89.041816 deg, ROLL: 37.607298 deg, YAW: 287.266227 deg.
2018-08-21T21:33:51.149Z,1534887231.149 [AHRS_M2](INFO): PITCH: 89.031871 deg, ROLL: 37.674343 deg, YAW: 287.300924 deg.
2018-08-21T21:33:51.549Z,1534887231.549 [AHRS_M2](INFO): PITCH: 89.038558 deg, ROLL: 37.843141 deg, YAW: 287.490722 deg.
2018-08-21T21:33:51.949Z,1534887231.949 [AHRS_M2](INFO): PITCH: 89.034897 deg, ROLL: 37.239834 deg, YAW: 286.872043 deg.
2018-08-21T21:33:52.349Z,1534887232.349 [AHRS_M2](INFO): PITCH: 89.031256 deg, ROLL: 37.194400 deg, YAW: 286.822101 deg.
2018-08-21T21:33:52.749Z,1534887232.749 [AHRS_M2](INFO): PITCH: 89.030450 deg, ROLL: 37.262025 deg, YAW: 286.894064 deg.
2018-08-21T21:33:53.149Z,1534887233.149 [AHRS_M2](INFO): PITCH: 89.036119 deg, ROLL: 37.340798 deg, YAW: 286.991080 deg.
2018-08-21T21:33:53.549Z,1534887233.549 [AHRS_M2](INFO): PITCH: 89.032875 deg, ROLL: 37.719802 deg, YAW: 287.364937 deg.
2018-08-21T21:33:53.951Z,1534887233.951 [AHRS_M2](INFO): PITCH: 89.032472 deg, ROLL: 37.733056 deg, YAW: 287.384062 deg.
2018-08-21T21:33:54.349Z,1534887234.349 [AHRS_M2](INFO): PITCH: 89.032472 deg, ROLL: 37.789145 deg, YAW: 287.430807 deg.
2018-08-21T21:33:54.749Z,1534887234.749 [AHRS_M2](INFO): PITCH: 89.034296 deg, ROLL: 37.919691 deg, YAW: 287.567329 deg.
2018-08-21T21:33:55.149Z,1534887235.149 [AHRS_M2](INFO): PITCH: 89.035716 deg, ROLL: 38.155223 deg, YAW: 287.811003 deg.
2018-08-21T21:33:55.549Z,1534887235.549 [AHRS_M2](INFO): PITCH: 89.043653 deg, ROLL: 37.558377 deg, YAW: 287.225000 deg.
2018-08-21T21:33:55.949Z,1534887235.949 [AHRS_M2](INFO): PITCH: 89.043250 deg, ROLL: 37.579113 deg, YAW: 287.242868 deg.
2018-08-21T21:33:56.349Z,1534887236.349 [AHRS_M2](INFO): PITCH: 89.044883 deg, ROLL: 37.968089 deg, YAW: 287.639456 deg.
2018-08-21T21:33:56.749Z,1534887236.749 [AHRS_M2](INFO): PITCH: 89.043858 deg, ROLL: 37.865001 deg, YAW: 287.526075 deg.
2018-08-21T21:33:57.149Z,1534887237.149 [AHRS_M2](INFO): PITCH: 89.034897 deg, ROLL: 37.829092 deg, YAW: 287.459412 deg.
2018-08-21T21:33:57.549Z,1534887237.549 [AHRS_M2](INFO): PITCH: 89.039172 deg, ROLL: 37.591701 deg, YAW: 287.236967 deg.
2018-08-21T21:33:57.949Z,1534887237.949 [AHRS_M2](INFO): PITCH: 89.037745 deg, ROLL: 37.339473 deg, YAW: 286.989249 deg.
2018-08-21T21:33:58.349Z,1534887238.349 [AHRS_M2](INFO): PITCH: 89.039575 deg, ROLL: 37.238502 deg, YAW: 286.890130 deg.
2018-08-21T21:33:58.749Z,1534887238.749 [AHRS_M2](INFO): PITCH: 89.046317 deg, ROLL: 37.321349 deg, YAW: 286.990479 deg.
2018-08-21T21:33:59.149Z,1534887239.149 [AHRS_M2](INFO): PITCH: 89.045292 deg, ROLL: 37.570374 deg, YAW: 287.236502 deg.
2018-08-21T21:33:59.549Z,1534887239.549 [AHRS_M2](INFO): PITCH: 89.043653 deg, ROLL: 37.660102 deg, YAW: 287.323082 deg.
2018-08-21T21:33:59.949Z,1534887239.949 [AHRS_M2](INFO): PITCH: 89.046740 deg, ROLL: 37.516289 deg, YAW: 287.195193 deg.
2018-08-21T21:34:00.349Z,1534887240.349 [AHRS_M2](INFO): PITCH: 89.043448 deg, ROLL: 37.785375 deg, YAW: 287.462554 deg.
2018-08-21T21:34:00.749Z,1534887240.749 [AHRS_M2](INFO): PITCH: 89.038148 deg, ROLL: 37.545867 deg, YAW: 287.204537 deg.
2018-08-21T21:34:01.149Z,1534887241.149 [AHRS_M2](INFO): PITCH: 89.039774 deg, ROLL: 37.700848 deg, YAW: 287.365538 deg.
2018-08-21T21:34:01.549Z,1534887241.549 [AHRS_M2](INFO): PITCH: 89.042437 deg, ROLL: 37.827118 deg, YAW: 287.501732 deg.
2018-08-21T21:34:01.949Z,1534887241.949 [AHRS_M2](INFO): PITCH: 89.038353 deg, ROLL: 37.722588 deg, YAW: 287.383488 deg.
2018-08-21T21:34:02.349Z,1534887242.349 [AHRS_M2](INFO): PITCH: 89.038353 deg, ROLL: 37.656868 deg, YAW: 287.315760 deg.
2018-08-21T21:34:02.749Z,1534887242.749 [AHRS_M2](INFO): PITCH: 89.036119 deg, ROLL: 37.808379 deg, YAW: 287.463756 deg.
2018-08-21T21:34:03.149Z,1534887243.149 [AHRS_M2](INFO): PITCH: 89.036119 deg, ROLL: 37.486199 deg, YAW: 287.140169 deg.
2018-08-21T21:34:03.549Z,1534887243.549 [AHRS_M2](INFO): PITCH: 89.034692 deg, ROLL: 37.873669 deg, YAW: 287.523370 deg.
2018-08-21T21:34:03.949Z,1534887243.949 [AHRS_M2](INFO): PITCH: 89.037950 deg, ROLL: 37.578734 deg, YAW: 287.233633 deg.
2018-08-21T21:34:04.349Z,1534887244.349 [AHRS_M2](INFO): PITCH: 89.045907 deg, ROLL: 37.423682 deg, YAW: 287.095609 deg.
2018-08-21T21:34:04.749Z,1534887244.749 [AHRS_M2](INFO): PITCH: 89.041816 deg, ROLL: 37.214248 deg, YAW: 286.875349 deg.
2018-08-21T21:34:05.149Z,1534887245.149 [AHRS_M2](INFO): PITCH: 89.043045 deg, ROLL: 37.429594 deg, YAW: 287.098505 deg.
2018-08-21T21:34:05.549Z,1534887245.549 [AHRS_M2](INFO): PITCH: 89.039575 deg, ROLL: 37.272510 deg, YAW: 286.932122 deg.
2018-08-21T21:34:05.949Z,1534887245.949 [AHRS_M2](INFO): PITCH: 89.027022 deg, ROLL: 37.267780 deg, YAW: 286.890539 deg.
2018-08-21T21:34:06.349Z,1534887246.349 [AHRS_M2](INFO): PITCH: 89.031871 deg, ROLL: 37.409325 deg, YAW: 287.039082 deg.
2018-08-21T21:34:06.749Z,1534887246.749 [AHRS_M2](INFO): PITCH: 89.031454 deg, ROLL: 37.609156 deg, YAW: 287.244862 deg.
2018-08-21T21:34:07.149Z,1534887247.149 [AHRS_M2](INFO): PITCH: 89.029439 deg, ROLL: 37.722428 deg, YAW: 287.351987 deg.
2018-08-21T21:34:07.549Z,1534887247.549 [AHRS_M2](INFO): PITCH: 89.033073 deg, ROLL: 38.163877 deg, YAW: 287.805839 deg.
2018-08-21T21:34:07.949Z,1534887247.949 [AHRS_M2](INFO): PITCH: 89.036925 deg, ROLL: 38.203167 deg, YAW: 287.855017 deg.
2018-08-21T21:34:08.349Z,1534887248.349 [AHRS_M2](INFO): PITCH: 89.038961 deg, ROLL: 38.075644 deg, YAW: 287.730735 deg.
2018-08-21T21:34:08.749Z,1534887248.749 [AHRS_M2](INFO): PITCH: 89.040805 deg, ROLL: 37.910139 deg, YAW: 287.558231 deg.
2018-08-21T21:34:09.149Z,1534887249.149 [AHRS_M2](INFO): PITCH: 89.042021 deg, ROLL: 37.690664 deg, YAW: 287.341769 deg.
2018-08-21T21:34:09.549Z,1534887249.549 [AHRS_M2](INFO): PITCH: 89.032472 deg, ROLL: 37.306828 deg, YAW: 286.924472 deg.
2018-08-21T21:34:09.951Z,1534887249.951 [AHRS_M2](INFO): PITCH: 89.031256 deg, ROLL: 37.733465 deg, YAW: 287.353107 deg.
2018-08-21T21:34:10.349Z,1534887250.349 [AHRS_M2](INFO): PITCH: 89.034296 deg, ROLL: 38.015098 deg, YAW: 287.653034 deg.
2018-08-21T21:34:10.749Z,1534887250.749 [AHRS_M2](INFO): PITCH: 89.039377 deg, ROLL: 37.850296 deg, YAW: 287.514108 deg.
2018-08-21T21:34:11.149Z,1534887251.149 [AHRS_M2](INFO): PITCH: 89.040805 deg, ROLL: 38.048535 deg, YAW: 287.725243 deg.
2018-08-21T21:34:11.549Z,1534887251.549 [AHRS_M2](INFO): PITCH: 89.039575 deg, ROLL: 37.587357 deg, YAW: 287.246939 deg.
2018-08-21T21:34:11.949Z,1534887251.949 [AHRS_M2](INFO): PITCH: 89.039575 deg, ROLL: 37.265563 deg, YAW: 286.914882 deg.
2018-08-21T21:34:12.349Z,1534887252.349 [AHRS_M2](INFO): PITCH: 89.037950 deg, ROLL: 37.180459 deg, YAW: 286.824450 deg.
2018-08-21T21:34:12.749Z,1534887252.749 [AHRS_M2](INFO): PITCH: 89.034494 deg, ROLL: 37.186036 deg, YAW: 286.823822 deg.
2018-08-21T21:34:13.149Z,1534887253.149 [AHRS_M2](INFO): PITCH: 89.034494 deg, ROLL: 37.256042 deg, YAW: 286.897178 deg.
2018-08-21T21:34:13.549Z,1534887253.549 [AHRS_M2](INFO): PITCH: 89.040805 deg, ROLL: 37.686300 deg, YAW: 287.347616 deg.
2018-08-21T21:34:13.949Z,1534887253.949 [AHRS_M2](INFO): PITCH: 89.034494 deg, ROLL: 37.453339 deg, YAW: 287.092440 deg.
2018-08-21T21:34:14.349Z,1534887254.349 [AHRS_M2](INFO): PITCH: 89.041816 deg, ROLL: 37.941598 deg, YAW: 287.603994 deg.
2018-08-21T21:34:14.749Z,1534887254.749 [AHRS_M2](INFO): PITCH: 89.029036 deg, ROLL: 37.859496 deg, YAW: 287.480968 deg.
2018-08-21T21:34:15.151Z,1534887255.151 [AHRS_M2](INFO): PITCH: 89.030252 deg, ROLL: 37.783971 deg, YAW: 287.408732 deg.
2018-08-21T21:34:15.549Z,1534887255.549 [AHRS_M2](INFO): PITCH: 89.042226 deg, ROLL: 37.414342 deg, YAW: 287.071922 deg.
2018-08-21T21:34:15.949Z,1534887255.949 [AHRS_M2](INFO): PITCH: 89.043448 deg, ROLL: 37.653200 deg, YAW: 287.322672 deg.
2018-08-21T21:34:16.349Z,1534887256.349 [AHRS_M2](INFO): PITCH: 89.034091 deg, ROLL: 37.382978 deg, YAW: 287.022471 deg.
2018-08-21T21:34:16.749Z,1534887256.749 [AHRS_M2](INFO): PITCH: 89.044678 deg, ROLL: 37.692737 deg, YAW: 287.368625 deg.
2018-08-21T21:34:17.149Z,1534887257.149 [AHRS_M2](INFO): PITCH: 89.040805 deg, ROLL: 37.256032 deg, YAW: 286.918188 deg.
2018-08-21T21:34:17.549Z,1534887257.549 [AHRS_M2](INFO): PITCH: 89.037745 deg, ROLL: 36.949910 deg, YAW: 286.599573 deg.
2018-08-21T21:34:17.949Z,1534887257.949 [AHRS_M2](INFO): PITCH: 89.035921 deg, ROLL: 37.179681 deg, YAW: 286.824696 deg.
2018-08-21T21:34:18.349Z,1534887258.349 [AHRS_M2](INFO): PITCH: 89.036119 deg, ROLL: 37.509941 deg, YAW: 287.164075 deg.
2018-08-21T21:34:18.749Z,1534887258.749 [AHRS_M2](INFO): PITCH: 89.038353 deg, ROLL: 37.797266 deg, YAW: 287.460942 deg.
2018-08-21T21:34:19.149Z,1534887259.149 [AHRS_M2](INFO): PITCH: 89.033073 deg, ROLL: 37.667998 deg, YAW: 287.314558 deg.
2018-08-21T21:34:19.549Z,1534887259.549 [AHRS_M2](INFO): PITCH: 89.039377 deg, ROLL: 37.787656 deg, YAW: 287.458155 deg.
2018-08-21T21:34:19.949Z,1534887259.949 [AHRS_M2](INFO): PITCH: 89.041816 deg, ROLL: 37.688393 deg, YAW: 287.366276 deg.
2018-08-21T21:34:20.349Z,1534887260.349 [AHRS_M2](INFO): PITCH: 89.031454 deg, ROLL: 37.406914 deg, YAW: 287.053043 deg.
2018-08-21T21:34:20.749Z,1534887260.749 [AHRS_M2](INFO): PITCH: 89.035102 deg, ROLL: 37.110395 deg, YAW: 286.754619 deg.
2018-08-21T21:34:21.149Z,1534887261.149 [AHRS_M2](INFO): PITCH: 89.036317 deg, ROLL: 37.158760 deg, YAW: 286.803523 deg.
2018-08-21T21:34:21.549Z,1534887261.549 [AHRS_M2](INFO): PITCH: 89.036522 deg, ROLL: 37.034700 deg, YAW: 286.680825 deg.
2018-08-21T21:34:21.594Z,1534887261.594 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 1.000000 count
2018-08-21T21:34:37.195Z,1534887277.195 [Startup:StartupSatComms:A](INFO): Timed out from 2018-08-21T21:33:36.8Z
2018-08-21T21:34:37.196Z,1534887277.196 [Startup:StartupSatComms:A] Stopped
2018-08-21T21:34:37.196Z,1534887277.196 [Startup:StartupSatComms:B] Running Loop=1
2018-08-21T21:34:37.601Z,1534887277.601 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-08-21T21:35:18.001Z,1534887318.001 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:35:18.002Z,1534887318.002 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2018-08-21T21:35:18.002Z,1534887318.002 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-08-21T21:35:18.008Z,1534887318.008 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:35:18.008Z,1534887318.008 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-08-21T21:35:18.008Z,1534887318.008 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-08-21T21:35:18.038Z,1534887318.038 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-08-21T21:35:18.038Z,1534887318.038 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-08-21T21:35:18.413Z,1534887318.413 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-08-21T21:35:18.414Z,1534887318.414 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2018-08-21T21:35:18.414Z,1534887318.414 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-08-21T21:35:18.414Z,1534887318.414 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-08-21T21:35:18.818Z,1534887318.818 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-08-21T21:35:18.818Z,1534887318.818 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:35:18.819Z,1534887318.819 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:35:18.819Z,1534887318.819 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-08-21T21:35:18.819Z,1534887318.819 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:35:18.820Z,1534887318.820 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:35:21.925Z,1534887321.925 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.9 s old, using for 20.0 s.
2018-08-21T21:35:22.036Z,1534887322.036 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2018-08-21T21:35:22.063Z,1534887322.063 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:35:22.063Z,1534887322.063 [Aanderaa_O2] No Fault, FailCount= 3
2018-08-21T21:35:22.429Z,1534887322.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2018-08-21T21:35:22.768Z,1534887322.768 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003942
2018-08-21T21:35:22.837Z,1534887322.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2018-08-21T21:35:23.194Z,1534887323.194 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2018-08-21T21:35:23.594Z,1534887323.594 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2018-08-21T21:35:26.701Z,1534887326.701 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.7 s old, using for 20.0 s.
2018-08-21T21:35:26.778Z,1534887326.778 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180821T212912/Courier0004.lzma
2018-08-21T21:35:26.861Z,1534887326.861 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.9 s old, using for 20.0 s.
2018-08-21T21:35:27.209Z,1534887327.209 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2018-08-21T21:35:27.552Z,1534887327.552 [DataOverHttps](INFO): Moved sent file to Logs/20180821T212912/Courier0004.lzma.bak
2018-08-21T21:35:27.552Z,1534887327.552 [DataOverHttps](INFO): SBD MOMSN=8432640
2018-08-21T21:35:27.631Z,1534887327.631 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-08-21T21:35:28.009Z,1534887328.009 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2018-08-21T21:35:28.409Z,1534887328.409 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2018-08-21T21:35:31.505Z,1534887331.505 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.5 s old, using for 20.0 s.
2018-08-21T21:35:31.633Z,1534887331.633 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2018-08-21T21:35:31.975Z,1534887331.975 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2018-08-21T21:35:32.382Z,1534887332.382 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2018-08-21T21:35:32.727Z,1534887332.727 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:35:32.728Z,1534887332.728 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-08-21T21:35:32.728Z,1534887332.728 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:35:32.790Z,1534887332.790 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2018-08-21T21:35:32.821Z,1534887332.821 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:35:33.247Z,1534887333.247 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:35:33.289Z,1534887333.289 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.3 s old, using for 20.0 s.
2018-08-21T21:35:36.289Z,1534887336.289 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.3 s old, using for 20.0 s.
2018-08-21T21:35:36.419Z,1534887336.419 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2018-08-21T21:35:36.434Z,1534887336.434 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:35:36.434Z,1534887336.434 [Aanderaa_O2] No Fault, FailCount= 1
2018-08-21T21:35:36.745Z,1534887336.745 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20180821T213208/Courier0000.lzma
2018-08-21T21:35:36.797Z,1534887336.797 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2018-08-21T21:35:37.193Z,1534887337.193 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2018-08-21T21:35:37.541Z,1534887337.541 [DataOverHttps](INFO): Moved sent file to Logs/20180821T213208/Courier0000.lzma.bak
2018-08-21T21:35:37.541Z,1534887337.541 [DataOverHttps](INFO): SBD MOMSN=8432642
2018-08-21T21:35:37.605Z,1534887337.605 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2018-08-21T21:35:37.612Z,1534887337.612 [Startup:StartupSatComms:B](INFO): Timed out from 2018-08-21T21:34:37.2Z
2018-08-21T21:35:37.613Z,1534887337.613 [Startup:StartupSatComms:B] Stopped
2018-08-21T21:35:37.613Z,1534887337.613 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-08-21T21:35:37.613Z,1534887337.613 [Startup:StartupSatComms] Stopped
2018-08-21T21:35:37.613Z,1534887337.613 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-08-21T21:35:37.614Z,1534887337.614 [Startup](INFO): Completed Startup
2018-08-21T21:35:37.618Z,1534887337.618 [MissionManager](INFO): Startup is completed.
2018-08-21T21:35:37.619Z,1534887337.619 [MissionManager](INFO): Uninitializing Mission Startup
2018-08-21T21:35:37.619Z,1534887337.619 [Startup] Stopped
2018-08-21T21:35:37.619Z,1534887337.619 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-08-21T21:35:37.619Z,1534887337.619 [Startup:A.GoToSurface] Stopped
2018-08-21T21:35:37.619Z,1534887337.619 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-08-21T21:35:37.985Z,1534887337.985 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s.
2018-08-21T21:35:37.992Z,1534887337.992 [MissionManager](IMPORTANT): Started mission Default
2018-08-21T21:35:37.992Z,1534887337.992 [Default] Running Loop=1
2018-08-21T21:35:37.992Z,1534887337.992 [Default](DEBUG): Aggregate::initialize Default
2018-08-21T21:35:37.992Z,1534887337.992 [Default:B.GoToSurface] Running Loop=1
2018-08-21T21:35:37.992Z,1534887337.992 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-08-21T21:35:37.993Z,1534887337.993 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-08-21T21:35:37.993Z,1534887337.993 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-08-21T21:35:37.993Z,1534887337.993 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-08-21T21:35:37.994Z,1534887337.994 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-08-21T21:35:37.998Z,1534887337.998 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-08-21T21:35:37.999Z,1534887337.999 [Default:A.Wait] Running Loop=1
2018-08-21T21:35:37.999Z,1534887337.999 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-08-21T21:35:46.745Z,1534887346.745 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:35:46.746Z,1534887346.746 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-08-21T21:35:46.746Z,1534887346.746 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:35:46.842Z,1534887346.842 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:35:47.263Z,1534887347.263 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:35:48.022Z,1534887348.022 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:35:48.022Z,1534887348.022 [Aanderaa_O2] No Fault, FailCount= 2
2018-08-21T21:35:51.200Z,1534887351.200 [Default:A.Wait](INFO): Done Waiting.
2018-08-21T21:35:51.200Z,1534887351.200 [Default:A.Wait] Stopped
2018-08-21T21:35:51.200Z,1534887351.200 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-08-21T21:35:51.608Z,1534887351.608 [Default:CheckIn] Running Loop=1
2018-08-21T21:35:51.608Z,1534887351.608 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-21T21:35:51.609Z,1534887351.609 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-21T21:35:52.003Z,1534887352.003 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-08-21T21:35:58.743Z,1534887358.743 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:35:58.744Z,1534887358.744 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-08-21T21:35:58.744Z,1534887358.744 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:35:58.830Z,1534887358.830 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:35:58.830Z,1534887358.830 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-08-21T21:35:59.263Z,1534887359.263 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:36:28.828Z,1534887388.828 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:36:28.828Z,1534887388.828 [RDI_Pathfinder] No Fault, FailCount= 3
2018-08-21T21:36:43.663Z,1534887403.663 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-08-21T21:36:43.663Z,1534887403.663 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-08-21T21:36:43.663Z,1534887403.663 [RDI_Pathfinder](ERROR): Data Fault
2018-08-21T21:36:43.724Z,1534887403.724 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-08-21T21:36:44.095Z,1534887404.095 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:36:44.843Z,1534887404.843 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:36:44.843Z,1534887404.843 [RDI_Pathfinder] No Fault, FailCount= 1
2018-08-21T21:37:07.608Z,1534887427.608 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:37:07.608Z,1534887427.608 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-08-21T21:37:07.608Z,1534887427.608 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:37:07.656Z,1534887427.656 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:37:08.078Z,1534887428.078 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:37:08.839Z,1534887428.839 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:37:08.839Z,1534887428.839 [RDI_Pathfinder] No Fault, FailCount= 2
2018-08-21T21:37:32.000Z,1534887452.000 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:37:32.000Z,1534887452.000 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-08-21T21:37:32.000Z,1534887452.000 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:37:32.059Z,1534887452.059 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:37:32.060Z,1534887452.060 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:37:32.479Z,1534887452.479 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:37:32.504Z,1534887452.504 [CBIT](INFO): Critical error at 20180821T213732
2018-08-21T21:37:59.948Z,1534887479.948 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-08-21T21:38:19.201Z,1534887499.201 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:38:19.202Z,1534887499.202 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2018-08-21T21:38:19.202Z,1534887499.202 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-08-21T21:38:19.208Z,1534887499.208 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:38:19.208Z,1534887499.208 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-08-21T21:38:19.208Z,1534887499.208 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-08-21T21:38:19.238Z,1534887499.238 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-08-21T21:38:19.238Z,1534887499.238 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-08-21T21:38:19.620Z,1534887499.620 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-08-21T21:38:19.620Z,1534887499.620 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2018-08-21T21:38:19.621Z,1534887499.621 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-08-21T21:38:19.621Z,1534887499.621 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-08-21T21:38:19.996Z,1534887499.996 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-08-21T21:38:19.997Z,1534887499.997 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:38:19.997Z,1534887499.997 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:38:19.997Z,1534887499.997 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-08-21T21:38:19.998Z,1534887499.998 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:38:20.002Z,1534887500.002 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:38:20.377Z,1534887500.377 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2018-08-21T21:38:20.807Z,1534887500.807 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2018-08-21T21:38:21.199Z,1534887501.199 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2018-08-21T21:38:21.585Z,1534887501.585 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2018-08-21T21:38:22.003Z,1534887502.003 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2018-08-21T21:38:22.408Z,1534887502.408 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2018-08-21T21:38:22.789Z,1534887502.789 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2018-08-21T21:38:23.185Z,1534887503.185 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2018-08-21T21:38:23.577Z,1534887503.577 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2018-08-21T21:38:23.985Z,1534887503.985 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2018-08-21T21:38:24.380Z,1534887504.380 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2018-08-21T21:38:24.785Z,1534887504.785 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2018-08-21T21:38:25.190Z,1534887505.190 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2018-08-21T21:38:25.586Z,1534887505.586 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2018-08-21T21:38:26.001Z,1534887506.001 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2018-08-21T21:38:26.388Z,1534887506.388 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2018-08-21T21:38:26.785Z,1534887506.785 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2018-08-21T21:38:27.189Z,1534887507.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2018-08-21T21:38:27.589Z,1534887507.589 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2018-08-21T21:38:27.995Z,1534887507.995 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2018-08-21T21:38:28.401Z,1534887508.401 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2018-08-21T21:38:28.801Z,1534887508.801 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-08-21T21:38:28.831Z,1534887508.831 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:38:28.832Z,1534887508.832 [Aanderaa_O2] No Fault, FailCount= 3
2018-08-21T21:38:29.188Z,1534887509.188 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2018-08-21T21:38:29.601Z,1534887509.601 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2018-08-21T21:38:29.993Z,1534887509.993 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2018-08-21T21:38:30.391Z,1534887510.391 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2018-08-21T21:38:30.801Z,1534887510.801 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2018-08-21T21:38:31.204Z,1534887511.204 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2018-08-21T21:38:31.608Z,1534887511.608 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2018-08-21T21:38:32.013Z,1534887512.013 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2018-08-21T21:38:32.395Z,1534887512.395 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2018-08-21T21:38:32.785Z,1534887512.785 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2018-08-21T21:38:33.181Z,1534887513.181 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2018-08-21T21:38:33.585Z,1534887513.585 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2018-08-21T21:38:33.990Z,1534887513.990 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2018-08-21T21:38:34.407Z,1534887514.407 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2018-08-21T21:38:34.793Z,1534887514.793 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2018-08-21T21:38:35.184Z,1534887515.184 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2018-08-21T21:38:35.580Z,1534887515.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2018-08-21T21:38:35.981Z,1534887515.981 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2018-08-21T21:38:36.388Z,1534887516.388 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2018-08-21T21:38:36.781Z,1534887516.781 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2018-08-21T21:38:37.189Z,1534887517.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2018-08-21T21:38:37.601Z,1534887517.601 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2018-08-21T21:38:37.996Z,1534887517.996 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2018-08-21T21:38:38.393Z,1534887518.393 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2018-08-21T21:38:38.797Z,1534887518.797 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2018-08-21T21:38:41.958Z,1534887521.958 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:38:41.958Z,1534887521.958 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-08-21T21:38:41.958Z,1534887521.958 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:38:42.075Z,1534887522.075 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:38:42.479Z,1534887522.479 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:38:43.236Z,1534887523.236 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:38:43.236Z,1534887523.236 [Aanderaa_O2] No Fault, FailCount= 1
2018-08-21T21:38:53.959Z,1534887533.959 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:38:53.960Z,1534887533.960 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-08-21T21:38:53.960Z,1534887533.960 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:38:54.059Z,1534887534.059 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:38:54.478Z,1534887534.478 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:38:55.246Z,1534887535.246 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:38:55.250Z,1534887535.250 [Aanderaa_O2] No Fault, FailCount= 2
2018-08-21T21:39:05.959Z,1534887545.959 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:39:05.959Z,1534887545.959 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-08-21T21:39:05.960Z,1534887545.960 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:39:06.056Z,1534887546.056 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:39:06.057Z,1534887546.057 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-08-21T21:39:06.478Z,1534887546.478 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:40:32.048Z,1534887632.048 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:40:32.048Z,1534887632.048 [RDI_Pathfinder] No Fault, FailCount= 3
2018-08-21T21:40:45.148Z,1534887645.148 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-08-21T21:40:45.148Z,1534887645.148 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-08-21T21:40:45.148Z,1534887645.148 [RDI_Pathfinder](ERROR): Data Fault
2018-08-21T21:40:45.206Z,1534887645.206 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-08-21T21:40:45.619Z,1534887645.619 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:40:46.363Z,1534887646.363 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:40:46.363Z,1534887646.363 [RDI_Pathfinder] No Fault, FailCount= 1
2018-08-21T21:40:51.967Z,1534887651.967 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-08-21T21:35:51.6Z
2018-08-21T21:40:51.968Z,1534887651.968 [Default:CheckIn:Read_GPS] Stopped
2018-08-21T21:40:51.968Z,1534887651.968 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-21T21:40:52.343Z,1534887652.343 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-08-21T21:40:56.305Z,1534887656.305 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20180821T213208/Courier0004.lzma
2018-08-21T21:40:57.091Z,1534887657.091 [DataOverHttps](INFO): Moved sent file to Logs/20180821T213208/Courier0004.lzma.bak
2018-08-21T21:40:57.092Z,1534887657.092 [DataOverHttps](INFO): SBD MOMSN=8432764
2018-08-21T21:41:05.845Z,1534887665.845 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20180821T212912/Express0005.lzma
2018-08-21T21:41:06.644Z,1534887666.644 [DataOverHttps](INFO): Moved sent file to Logs/20180821T212912/Express0005.lzma.bak
2018-08-21T21:41:06.644Z,1534887666.644 [DataOverHttps](INFO): SBD MOMSN=8432769
2018-08-21T21:41:11.039Z,1534887671.039 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:41:11.039Z,1534887671.039 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-08-21T21:41:11.039Z,1534887671.039 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:41:11.108Z,1534887671.108 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:41:11.522Z,1534887671.522 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:41:12.279Z,1534887672.279 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:41:12.279Z,1534887672.279 [RDI_Pathfinder] No Fault, FailCount= 2
2018-08-21T21:41:15.403Z,1534887675.403 [DataOverHttps](INFO): Sending 894 bytes from file Logs/20180821T213208/Express0001.lzma
2018-08-21T21:41:16.159Z,1534887676.159 [DataOverHttps](INFO): Moved sent file to Logs/20180821T213208/Express0001.lzma.bak
2018-08-21T21:41:16.160Z,1534887676.160 [DataOverHttps](INFO): SBD MOMSN=8432775
2018-08-21T21:41:20.069Z,1534887680.069 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:41:20.069Z,1534887680.069 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2018-08-21T21:41:20.069Z,1534887680.069 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-08-21T21:41:20.071Z,1534887680.071 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:41:20.071Z,1534887680.071 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-08-21T21:41:20.072Z,1534887680.072 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-08-21T21:41:20.118Z,1534887680.118 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-08-21T21:41:20.118Z,1534887680.118 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-08-21T21:41:20.256Z,1534887680.256 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-08-21T21:41:20.256Z,1534887680.256 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2018-08-21T21:41:20.257Z,1534887680.257 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-08-21T21:41:20.257Z,1534887680.257 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-08-21T21:41:20.592Z,1534887680.592 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-08-21T21:41:20.593Z,1534887680.593 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:41:20.593Z,1534887680.593 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:41:20.593Z,1534887680.593 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-08-21T21:41:20.594Z,1534887680.594 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:41:20.610Z,1534887680.610 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:41:20.997Z,1534887680.997 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.9 s old, using for 20.0 s.
2018-08-21T21:41:21.393Z,1534887681.393 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.3 s old, using for 20.0 s.
2018-08-21T21:41:21.789Z,1534887681.789 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.7 s old, using for 20.0 s.
2018-08-21T21:41:24.868Z,1534887684.868 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2018-08-21T21:41:24.939Z,1534887684.939 [DataOverHttps](INFO): Sending 322 bytes from file Logs/20180821T213208/Express0005.lzma
2018-08-21T21:41:24.999Z,1534887684.999 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.9 s old, using for 20.0 s.
2018-08-21T21:41:25.371Z,1534887685.371 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.3 s old, using for 20.0 s.
2018-08-21T21:41:25.716Z,1534887685.716 [DataOverHttps](INFO): Moved sent file to Logs/20180821T213208/Express0005.lzma.bak
2018-08-21T21:41:25.716Z,1534887685.716 [DataOverHttps](INFO): SBD MOMSN=8432803
2018-08-21T21:41:25.799Z,1534887685.799 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.7 s old, using for 20.0 s.
2018-08-21T21:41:26.167Z,1534887686.167 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.1 s old, using for 20.0 s.
2018-08-21T21:41:26.172Z,1534887686.172 [Default:CheckIn:Read_Iridium] Stopped
2018-08-21T21:41:26.172Z,1534887686.172 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-21T21:41:26.173Z,1534887686.173 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-21T21:41:26.565Z,1534887686.565 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.5 s old, using for 20.0 s.
2018-08-21T21:41:29.642Z,1534887689.642 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-08-21T21:41:29.769Z,1534887689.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.7 s old, using for 20.0 s.
2018-08-21T21:41:30.173Z,1534887690.173 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.1 s old, using for 20.0 s.
2018-08-21T21:41:30.574Z,1534887690.574 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.5 s old, using for 20.0 s.
2018-08-21T21:41:30.958Z,1534887690.958 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.9 s old, using for 20.0 s.
2018-08-21T21:41:31.349Z,1534887691.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.3 s old, using for 20.0 s.
2018-08-21T21:41:31.756Z,1534887691.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.7 s old, using for 20.0 s.
2018-08-21T21:41:32.153Z,1534887692.153 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.1 s old, using for 20.0 s.
2018-08-21T21:41:32.553Z,1534887692.553 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.5 s old, using for 20.0 s.
2018-08-21T21:41:32.973Z,1534887692.973 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.9 s old, using for 20.0 s.
2018-08-21T21:41:33.361Z,1534887693.361 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.3 s old, using for 20.0 s.
2018-08-21T21:41:33.761Z,1534887693.761 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.7 s old, using for 20.0 s.
2018-08-21T21:41:34.150Z,1534887694.150 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.1 s old, using for 20.0 s.
2018-08-21T21:41:34.557Z,1534887694.557 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.5 s old, using for 20.0 s.
2018-08-21T21:41:34.945Z,1534887694.945 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.9 s old, using for 20.0 s.
2018-08-21T21:41:35.346Z,1534887695.346 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.3 s old, using for 20.0 s.
2018-08-21T21:41:35.745Z,1534887695.745 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.7 s old, using for 20.0 s.
2018-08-21T21:41:36.152Z,1534887696.152 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.1 s old, using for 20.0 s.
2018-08-21T21:41:36.179Z,1534887696.179 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:41:36.179Z,1534887696.179 [Aanderaa_O2] No Fault, FailCount= 3
2018-08-21T21:41:36.577Z,1534887696.577 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.5 s old, using for 20.0 s.
2018-08-21T21:41:36.985Z,1534887696.985 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.9 s old, using for 20.0 s.
2018-08-21T21:41:37.392Z,1534887697.392 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.3 s old, using for 20.0 s.
2018-08-21T21:41:37.773Z,1534887697.773 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.7 s old, using for 20.0 s.
2018-08-21T21:41:38.157Z,1534887698.157 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.1 s old, using for 20.0 s.
2018-08-21T21:41:38.557Z,1534887698.557 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.5 s old, using for 20.0 s.
2018-08-21T21:41:38.981Z,1534887698.981 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.9 s old, using for 20.0 s.
2018-08-21T21:41:39.373Z,1534887699.373 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.3 s old, using for 20.0 s.
2018-08-21T21:41:39.744Z,1534887699.744 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:41:39.744Z,1534887699.744 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-08-21T21:41:39.745Z,1534887699.745 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:41:39.789Z,1534887699.789 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.7 s old, using for 20.0 s.
2018-08-21T21:41:39.852Z,1534887699.852 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:41:39.852Z,1534887699.852 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:41:40.212Z,1534887700.212 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:41:40.274Z,1534887700.274 [CBIT](INFO): Critical error at 20180821T214139
2018-08-21T21:41:46.907Z,1534887706.907 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:41:46.908Z,1534887706.908 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-08-21T21:41:46.908Z,1534887706.908 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:41:46.000Z,1534887707.000 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:41:47.426Z,1534887707.426 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:41:48.167Z,1534887708.167 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:41:48.167Z,1534887708.167 [Aanderaa_O2] No Fault, FailCount= 1
2018-08-21T21:41:58.907Z,1534887718.907 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:41:58.908Z,1534887718.908 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-08-21T21:41:58.908Z,1534887718.908 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:41:58.990Z,1534887718.990 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:41:59.427Z,1534887719.427 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:42:00.176Z,1534887720.176 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:42:00.176Z,1534887720.176 [Aanderaa_O2] No Fault, FailCount= 2
2018-08-21T21:42:10.907Z,1534887730.907 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:42:10.908Z,1534887730.908 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-08-21T21:42:10.908Z,1534887730.908 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:42:10.996Z,1534887730.996 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:42:10.997Z,1534887730.997 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-08-21T21:42:11.426Z,1534887731.426 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:42:45.735Z,1534887765.735 [BPC1](ERROR): Bank A: No match for stick 1 serial number:1717 in the onboard configuration file.
2018-08-21T21:42:45.735Z,1534887765.735 [BPC1](ERROR): Failed to parse Bank A battery data
2018-08-21T21:42:58.920Z,1534887778.920 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-08-21T21:42:58.920Z,1534887778.920 [NAL9602] Data Fault, FailCount= 1
2018-08-21T21:42:58.920Z,1534887778.920 [NAL9602](ERROR): Data Fault
2018-08-21T21:42:59.006Z,1534887779.006 [CBIT](ERROR): Data Fault in component: NAL9602
2018-08-21T21:42:59.316Z,1534887779.316 [NAL9602](INFO): Powering down
2018-08-21T21:43:00.185Z,1534887780.185 [CBIT](INFO): Clearing failed state for component NAL9602
2018-08-21T21:43:00.185Z,1534887780.185 [NAL9602] No Fault, FailCount= 1
2018-08-21T21:43:30.009Z,1534887810.009 [NAL9602](INFO): Powering up NAL9602
2018-08-21T21:43:40.912Z,1534887820.912 [NAL9602](INFO): NAL9602 initialized
2018-08-21T21:44:20.941Z,1534887860.941 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:44:20.942Z,1534887860.942 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2018-08-21T21:44:20.942Z,1534887860.942 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-08-21T21:44:20.944Z,1534887860.944 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:44:20.944Z,1534887860.944 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-08-21T21:44:20.944Z,1534887860.944 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-08-21T21:44:20.958Z,1534887860.958 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-08-21T21:44:20.966Z,1534887860.966 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-08-21T21:44:21.370Z,1534887861.370 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-08-21T21:44:21.370Z,1534887861.370 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2018-08-21T21:44:21.375Z,1534887861.375 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-08-21T21:44:21.375Z,1534887861.375 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-08-21T21:44:21.748Z,1534887861.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-08-21T21:44:21.749Z,1534887861.749 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:44:21.749Z,1534887861.749 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:44:21.750Z,1534887861.750 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-08-21T21:44:21.751Z,1534887861.751 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:44:21.751Z,1534887861.751 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:44:22.149Z,1534887862.149 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2018-08-21T21:44:22.529Z,1534887862.529 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2018-08-21T21:44:22.929Z,1534887862.929 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2018-08-21T21:44:23.329Z,1534887863.329 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2018-08-21T21:44:23.755Z,1534887863.755 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2018-08-21T21:44:24.139Z,1534887864.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2018-08-21T21:44:24.555Z,1534887864.555 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2018-08-21T21:44:24.953Z,1534887864.953 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2018-08-21T21:44:25.341Z,1534887865.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2018-08-21T21:44:25.737Z,1534887865.737 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2018-08-21T21:44:26.141Z,1534887866.141 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2018-08-21T21:44:26.533Z,1534887866.533 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2018-08-21T21:44:26.953Z,1534887866.953 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2018-08-21T21:44:27.349Z,1534887867.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2018-08-21T21:44:30.438Z,1534887870.438 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.5 s old, using for 20.0 s.
2018-08-21T21:44:30.553Z,1534887870.553 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-08-21T21:44:30.906Z,1534887870.906 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2018-08-21T21:44:31.316Z,1534887871.316 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2018-08-21T21:44:31.713Z,1534887871.713 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2018-08-21T21:44:32.116Z,1534887872.116 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2018-08-21T21:44:32.513Z,1534887872.513 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2018-08-21T21:44:32.909Z,1534887872.909 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2018-08-21T21:44:33.312Z,1534887873.312 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2018-08-21T21:44:33.712Z,1534887873.712 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2018-08-21T21:44:34.112Z,1534887874.112 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2018-08-21T21:44:34.512Z,1534887874.512 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2018-08-21T21:44:34.917Z,1534887874.917 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2018-08-21T21:44:35.317Z,1534887875.317 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2018-08-21T21:44:35.720Z,1534887875.720 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2018-08-21T21:44:36.120Z,1534887876.120 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2018-08-21T21:44:36.513Z,1534887876.513 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2018-08-21T21:44:36.916Z,1534887876.916 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2018-08-21T21:44:37.315Z,1534887877.315 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2018-08-21T21:44:37.735Z,1534887877.735 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2018-08-21T21:44:38.140Z,1534887878.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2018-08-21T21:44:38.525Z,1534887878.525 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2018-08-21T21:44:38.901Z,1534887878.901 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2018-08-21T21:44:39.304Z,1534887879.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2018-08-21T21:44:39.700Z,1534887879.700 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2018-08-21T21:44:39.748Z,1534887879.748 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:44:39.748Z,1534887879.748 [RDI_Pathfinder] No Fault, FailCount= 3
2018-08-21T21:44:40.103Z,1534887880.103 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2018-08-21T21:44:40.500Z,1534887880.500 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2018-08-21T21:44:40.924Z,1534887880.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s.
2018-08-21T21:44:40.938Z,1534887880.938 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:44:40.938Z,1534887880.938 [Aanderaa_O2] No Fault, FailCount= 3
2018-08-21T21:44:51.663Z,1534887891.663 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:44:51.664Z,1534887891.664 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-08-21T21:44:51.664Z,1534887891.664 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:44:51.759Z,1534887891.759 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:44:52.182Z,1534887892.182 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:44:52.503Z,1534887892.503 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-08-21T21:44:52.503Z,1534887892.503 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-08-21T21:44:52.503Z,1534887892.503 [RDI_Pathfinder](ERROR): Data Fault
2018-08-21T21:44:52.527Z,1534887892.527 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-08-21T21:44:52.982Z,1534887892.982 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:44:53.034Z,1534887893.034 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:44:53.034Z,1534887893.034 [Aanderaa_O2] No Fault, FailCount= 1
2018-08-21T21:44:53.746Z,1534887893.746 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:44:53.746Z,1534887893.746 [RDI_Pathfinder] No Fault, FailCount= 1
2018-08-21T21:45:03.665Z,1534887903.665 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:45:03.665Z,1534887903.665 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-08-21T21:45:03.665Z,1534887903.665 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:45:03.755Z,1534887903.755 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:45:04.178Z,1534887904.178 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:45:04.947Z,1534887904.947 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:45:04.947Z,1534887904.947 [Aanderaa_O2] No Fault, FailCount= 2
2018-08-21T21:45:15.663Z,1534887915.663 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:45:15.663Z,1534887915.663 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-08-21T21:45:15.664Z,1534887915.664 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:45:15.770Z,1534887915.770 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:45:15.771Z,1534887915.771 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-08-21T21:45:16.183Z,1534887916.183 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:45:16.916Z,1534887916.916 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:45:16.917Z,1534887916.917 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-08-21T21:45:16.917Z,1534887916.917 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:45:16.939Z,1534887916.939 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:45:17.387Z,1534887917.387 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:45:18.130Z,1534887918.130 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-08-21T21:45:18.130Z,1534887918.130 [RDI_Pathfinder] No Fault, FailCount= 2
2018-08-21T21:45:40.916Z,1534887940.916 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-08-21T21:45:40.916Z,1534887940.916 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-08-21T21:45:40.916Z,1534887940.916 [RDI_Pathfinder](ERROR): Communications Fault
2018-08-21T21:45:40.975Z,1534887940.975 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:45:40.975Z,1534887940.975 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-08-21T21:45:41.383Z,1534887941.383 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:45:41.424Z,1534887941.424 [CBIT](INFO): Critical error at 20180821T214540
2018-08-21T21:46:26.959Z,1534887986.959 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-21T21:46:26.959Z,1534887986.959 [Default:CheckIn:C.Wait] Stopped
2018-08-21T21:46:26.959Z,1534887986.959 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-21T21:46:26.959Z,1534887986.959 [Default:CheckIn:D] Running Loop=1
2018-08-21T21:46:27.346Z,1534887987.346 [Default:CheckIn:D] Stopped
2018-08-21T21:46:27.346Z,1534887987.346 [Default:CheckIn:E] Running Loop=1
2018-08-21T21:46:27.740Z,1534887987.740 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.822529 min 
2018-08-21T21:46:27.743Z,1534887987.743 [Default:CheckIn:E] Stopped
2018-08-21T21:46:27.743Z,1534887987.743 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-21T21:46:27.743Z,1534887987.743 [Default:CheckIn] Stopped
2018-08-21T21:46:27.743Z,1534887987.743 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-21T21:46:27.744Z,1534887987.744 [Default:CheckIn](INFO): Running loop #2
2018-08-21T21:46:27.744Z,1534887987.744 [Default:CheckIn] Running Loop=2
2018-08-21T21:46:27.744Z,1534887987.744 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-21T21:46:27.744Z,1534887987.744 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-21T21:46:37.480Z,1534887997.480 [CommandLine](IMPORTANT): got command show variable AHRS_M2
2018-08-21T21:46:37.608Z,1534887997.608 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup (bool)
2018-08-21T21:46:37.608Z,1534887997.608 [CommandLine](IMPORTANT): AHRS_M2.simulateHardware (bool)
2018-08-21T21:46:37.609Z,1534887997.609 [CommandLine](IMPORTANT): AHRS_M2.power (watt)
2018-08-21T21:46:37.609Z,1534887997.609 [CommandLine](IMPORTANT): AHRS_M2.magDeviation (degree)
2018-08-21T21:46:37.609Z,1534887997.609 [CommandLine](IMPORTANT): AHRS_M2.minNumPointsCal (count)
2018-08-21T21:46:37.610Z,1534887997.610 [CommandLine](IMPORTANT): AHRS_M2.readAccelerations (bool)
2018-08-21T21:46:37.610Z,1534887997.610 [CommandLine](IMPORTANT): AHRS_M2.readMagnetics (bool)
2018-08-21T21:46:37.611Z,1534887997.611 [CommandLine](IMPORTANT): AHRS_M2.verbosity (count)
2018-08-21T21:46:37.636Z,1534887997.636 [CommandLine](IMPORTANT): AHRS_M2.loadControl (none)
2018-08-21T21:46:37.637Z,1534887997.637 [CommandLine](IMPORTANT): AHRS_M2.uart (none)
2018-08-21T21:46:37.637Z,1534887997.637 [CommandLine](IMPORTANT): AHRS_M2.baud (bit_per_second)
2018-08-21T21:46:37.767Z,1534887997.767 [CommandLine](IMPORTANT): AHRS_M2.platform_magnetic_orientation (radian)
2018-08-21T21:46:37.768Z,1534887997.768 [CommandLine](IMPORTANT): AHRS_M2.platform_orientation (radian)
2018-08-21T21:46:37.768Z,1534887997.768 [CommandLine](IMPORTANT): AHRS_M2.platform_pitch_angle (radian)
2018-08-21T21:46:37.768Z,1534887997.768 [CommandLine](IMPORTANT): AHRS_M2.platform_roll_angle (radian)
2018-08-21T21:46:37.769Z,1534887997.769 [CommandLine](IMPORTANT): AHRS_M2.platform_orientation_matrix (none)
2018-08-21T21:46:37.769Z,1534887997.769 [CommandLine](IMPORTANT): AHRS_M2.CompassCalState (count)
2018-08-21T21:46:37.770Z,1534887997.770 [CommandLine](IMPORTANT): AHRS_M2.CompassOrientation (radian)
2018-08-21T21:46:37.770Z,1534887997.770 [CommandLine](IMPORTANT): AHRS_M2.CompassOrientationError (radian)
2018-08-21T21:46:37.770Z,1534887997.770 [CommandLine](IMPORTANT): AHRS_M2.CompassTemperature (celsius)
2018-08-21T21:46:37.771Z,1534887997.771 [CommandLine](IMPORTANT): AHRS_M2.Mx (milligauss)
2018-08-21T21:46:37.771Z,1534887997.771 [CommandLine](IMPORTANT): AHRS_M2.My (milligauss)
2018-08-21T21:46:37.772Z,1534887997.772 [CommandLine](IMPORTANT): AHRS_M2.Mz (milligauss)
2018-08-21T21:46:37.772Z,1534887997.772 [CommandLine](IMPORTANT): AHRS_M2.Ax (meter_per_second_squared)
2018-08-21T21:46:37.772Z,1534887997.772 [CommandLine](IMPORTANT): AHRS_M2.Ay (meter_per_second_squared)
2018-08-21T21:46:37.773Z,1534887997.773 [CommandLine](IMPORTANT): AHRS_M2.Az (meter_per_second_squared)
2018-08-21T21:46:37.773Z,1534887997.773 [CommandLine](IMPORTANT): AHRS_M2.NumPointsCal (count)
2018-08-21T21:46:37.842Z,1534887997.842 [CommandLine](IMPORTANT): AHRS_M2.durationOfLastRun (second)
2018-08-21T21:46:37.856Z,1534887997.856 [CommandLine](IMPORTANT): AHRS_M2.component_voltage (volt)
2018-08-21T21:46:37.856Z,1534887997.856 [CommandLine](IMPORTANT): AHRS_M2.component_avgVoltage (volt)
2018-08-21T21:46:37.857Z,1534887997.857 [CommandLine](IMPORTANT): AHRS_M2.component_current (milliampere)
2018-08-21T21:46:37.858Z,1534887997.858 [CommandLine](IMPORTANT): AHRS_M2.component_avgCurrent (milliampere)
2018-08-21T21:47:05.496Z,1534888025.496 [CommandLine](IMPORTANT): got command configSet AHRS_M2.readMagnetics 1.000000 bool
2018-08-21T21:47:19.327Z,1534888039.327 [CBIT](INFO): Clearing failed state for component DropWeight
2018-08-21T21:47:19.327Z,1534888039.327 [DropWeight] No Fault, FailCount= 1
2018-08-21T21:47:22.089Z,1534888042.089 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:47:22.089Z,1534888042.089 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2018-08-21T21:47:22.089Z,1534888042.089 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-08-21T21:47:22.091Z,1534888042.091 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-08-21T21:47:22.091Z,1534888042.091 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-08-21T21:47:22.091Z,1534888042.091 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-08-21T21:47:22.126Z,1534888042.126 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-08-21T21:47:22.126Z,1534888042.126 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-08-21T21:47:22.521Z,1534888042.521 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-08-21T21:47:22.521Z,1534888042.521 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2018-08-21T21:47:22.521Z,1534888042.521 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-08-21T21:47:22.521Z,1534888042.521 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-08-21T21:47:22.907Z,1534888042.907 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-08-21T21:47:22.908Z,1534888042.908 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:47:22.908Z,1534888042.908 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:47:22.908Z,1534888042.908 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-08-21T21:47:22.909Z,1534888042.909 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-08-21T21:47:22.909Z,1534888042.909 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-08-21T21:47:23.312Z,1534888043.312 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2018-08-21T21:47:23.724Z,1534888043.724 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2018-08-21T21:47:24.134Z,1534888044.134 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2018-08-21T21:47:24.528Z,1534888044.528 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2018-08-21T21:47:24.886Z,1534888044.886 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2018-08-21T21:47:25.297Z,1534888045.297 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2018-08-21T21:47:25.693Z,1534888045.693 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2018-08-21T21:47:25.928Z,1534888045.928 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 2.000000 count
2018-08-21T21:47:26.058Z,1534888046.058 [AHRS_M2](INFO): PITCH: 89.037130 deg, ROLL: 37.778879 deg, YAW: 287.467199 deg.
2018-08-21T21:47:26.058Z,1534888046.058 [AHRS_M2](INFO): Mx: 18.018347 uT, My: 2.906977 uT, Mz: 0.000000 uT
2018-08-21T21:47:26.127Z,1534888046.127 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2018-08-21T21:47:26.457Z,1534888046.457 [AHRS_M2](INFO): PITCH: 89.031871 deg, ROLL: 37.979960 deg, YAW: 287.651013 deg.
2018-08-21T21:47:26.458Z,1534888046.458 [AHRS_M2](INFO): Mx: 18.018343 uT, My: 2.907895 uT, Mz: 222.943085 uT
2018-08-21T21:47:26.519Z,1534888046.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2018-08-21T21:47:26.857Z,1534888046.857 [AHRS_M2](INFO): PITCH: 89.032274 deg, ROLL: 37.944928 deg, YAW: 287.613447 deg.
2018-08-21T21:47:26.858Z,1534888046.858 [AHRS_M2](INFO): Mx: 18.018341 uT, My: 2.907895 uT, Mz: 223.289261 uT
2018-08-21T21:47:26.927Z,1534888046.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2018-08-21T21:47:27.257Z,1534888047.257 [AHRS_M2](INFO): PITCH: 89.031659 deg, ROLL: 38.012018 deg, YAW: 287.687021 deg.
2018-08-21T21:47:27.258Z,1534888047.258 [AHRS_M2](INFO): Mx: 18.018337 uT, My: 2.908201 uT, Mz: 0.000000 uT
2018-08-21T21:47:27.309Z,1534888047.309 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2018-08-21T21:47:27.657Z,1534888047.657 [AHRS_M2](INFO): PITCH: 89.029235 deg, ROLL: 38.196784 deg, YAW: 287.864934 deg.
2018-08-21T21:47:27.658Z,1534888047.658 [AHRS_M2](INFO): Mx: 18.018333 uT, My: 2.908201 uT, Mz: 222.426361 uT
2018-08-21T21:47:27.709Z,1534888047.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2018-08-21T21:47:28.057Z,1534888048.057 [AHRS_M2](INFO): PITCH: 89.041010 deg, ROLL: 38.445916 deg, YAW: 288.151037 deg.
2018-08-21T21:47:28.058Z,1534888048.058 [AHRS_M2](INFO): Mx: 18.018330 uT, My: 2.908507 uT, Mz: 222.812134 uT
2018-08-21T21:47:28.125Z,1534888048.125 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2018-08-21T21:47:28.457Z,1534888048.457 [AHRS_M2](INFO): PITCH: 89.040388 deg, ROLL: 38.250770 deg, YAW: 287.947880 deg.
2018-08-21T21:47:28.458Z,1534888048.458 [AHRS_M2](INFO): Mx: 18.018333 uT, My: 2.908813 uT, Mz: 0.000000 uT
2018-08-21T21:47:31.206Z,1534888051.206 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.1 s old, using for 20.0 s.
2018-08-21T21:47:31.248Z,1534888051.248 [AHRS_M2](INFO): PITCH: 89.036727 deg, ROLL: 38.211203 deg, YAW: 287.914549 deg.
2018-08-21T21:47:31.249Z,1534888051.249 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.906977 uT, Mz: 223.151276 uT
2018-08-21T21:47:31.337Z,1534888051.337 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2018-08-21T21:47:31.635Z,1534888051.635 [AHRS_M2](INFO): PITCH: 89.027226 deg, ROLL: 37.999081 deg, YAW: 287.664345 deg.
2018-08-21T21:47:31.635Z,1534888051.635 [AHRS_M2](INFO): Mx: 18.018332 uT, My: 2.908813 uT, Mz: 222.491730 uT
2018-08-21T21:47:31.713Z,1534888051.713 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-08-21T21:47:32.033Z,1534888052.033 [AHRS_M2](INFO): PITCH: 89.034091 deg, ROLL: 37.878515 deg, YAW: 287.553150 deg.
2018-08-21T21:47:32.034Z,1534888052.034 [AHRS_M2](INFO): Mx: 18.018332 uT, My: 2.908507 uT, Mz: 0.000000 uT
2018-08-21T21:47:32.099Z,1534888052.099 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2018-08-21T21:47:32.433Z,1534888052.433 [AHRS_M2](INFO): PITCH: 89.036317 deg, ROLL: 37.649024 deg, YAW: 287.332097 deg.
2018-08-21T21:47:32.434Z,1534888052.434 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.908507 uT, Mz: 223.303986 uT
2018-08-21T21:47:32.497Z,1534888052.497 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2018-08-21T21:47:32.833Z,1534888052.833 [AHRS_M2](INFO): PITCH: 89.029439 deg, ROLL: 37.772766 deg, YAW: 287.438239 deg.
2018-08-21T21:47:32.834Z,1534888052.834 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.907589 uT, Mz: 223.994049 uT
2018-08-21T21:47:32.885Z,1534888052.885 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2018-08-21T21:47:33.233Z,1534888053.233 [AHRS_M2](INFO): PITCH: 89.034091 deg, ROLL: 37.869461 deg, YAW: 287.549024 deg.
2018-08-21T21:47:33.234Z,1534888053.234 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.907895 uT, Mz: 0.000000 uT
2018-08-21T21:47:33.292Z,1534888053.292 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2018-08-21T21:47:33.633Z,1534888053.633 [AHRS_M2](INFO): PITCH: 89.036727 deg, ROLL: 37.667428 deg, YAW: 287.352725 deg.
2018-08-21T21:47:33.634Z,1534888053.634 [AHRS_M2](INFO): Mx: 18.018347 uT, My: 2.908813 uT, Mz: 222.513718 uT
2018-08-21T21:47:33.709Z,1534888053.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2018-08-21T21:47:34.033Z,1534888054.033 [AHRS_M2](INFO): PITCH: 89.038353 deg, ROLL: 37.914995 deg, YAW: 287.615304 deg.
2018-08-21T21:47:34.034Z,1534888054.034 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.908201 uT, Mz: 222.828522 uT
2018-08-21T21:47:34.109Z,1534888054.109 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2018-08-21T21:47:34.433Z,1534888054.433 [AHRS_M2](INFO): PITCH: 89.036522 deg, ROLL: 37.908844 deg, YAW: 287.604403 deg.
2018-08-21T21:47:34.434Z,1534888054.434 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.910037 uT, Mz: 0.000000 uT
2018-08-21T21:47:34.500Z,1534888054.500 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2018-08-21T21:47:34.833Z,1534888054.833 [AHRS_M2](INFO): PITCH: 89.034692 deg, ROLL: 38.278839 deg, YAW: 287.981567 deg.
2018-08-21T21:47:34.834Z,1534888054.834 [AHRS_M2](INFO): Mx: 18.018339 uT, My: 2.909425 uT, Mz: 222.422195 uT
2018-08-21T21:47:34.897Z,1534888054.897 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2018-08-21T21:47:35.233Z,1534888055.233 [AHRS_M2](INFO): PITCH: 89.034296 deg, ROLL: 38.421412 deg, YAW: 288.130137 deg.
2018-08-21T21:47:35.234Z,1534888055.234 [AHRS_M2](INFO): Mx: 18.018339 uT, My: 2.909425 uT, Mz: 223.265228 uT
2018-08-21T21:47:35.301Z,1534888055.301 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2018-08-21T21:47:35.633Z,1534888055.633 [AHRS_M2](INFO): PITCH: 89.033073 deg, ROLL: 37.885266 deg, YAW: 287.591426 deg.
2018-08-21T21:47:35.634Z,1534888055.634 [AHRS_M2](INFO): Mx: 18.018337 uT, My: 2.909119 uT, Mz: 0.000000 uT
2018-08-21T21:47:35.693Z,1534888055.693 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2018-08-21T21:47:36.033Z,1534888056.033 [AHRS_M2](INFO): PITCH: 89.032069 deg, ROLL: 37.719341 deg, YAW: 287.419606 deg.
2018-08-21T21:47:36.034Z,1534888056.034 [AHRS_M2](INFO): Mx: 18.018335 uT, My: 2.906671 uT, Mz: 223.131073 uT
2018-08-21T21:47:36.097Z,1534888056.097 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2018-08-21T21:47:36.433Z,1534888056.433 [AHRS_M2](INFO): PITCH: 89.037130 deg, ROLL: 37.752184 deg, YAW: 287.464111 deg.
2018-08-21T21:47:36.434Z,1534888056.434 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.906671 uT, Mz: 223.410843 uT
2018-08-21T21:47:36.497Z,1534888056.497 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2018-08-21T21:47:36.833Z,1534888056.833 [AHRS_M2](INFO): PITCH: 89.033681 deg, ROLL: 37.598965 deg, YAW: 287.304340 deg.
2018-08-21T21:47:36.834Z,1534888056.834 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.908813 uT, Mz: 0.000000 uT
2018-08-21T21:47:36.896Z,1534888056.896 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2018-08-21T21:47:37.234Z,1534888057.234 [AHRS_M2](INFO): PITCH: 89.032274 deg, ROLL: 38.057766 deg, YAW: 287.762563 deg.
2018-08-21T21:47:37.235Z,1534888057.235 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.909425 uT, Mz: 222.562103 uT
2018-08-21T21:47:37.290Z,1534888057.290 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2018-08-21T21:47:37.635Z,1534888057.635 [AHRS_M2](INFO): PITCH: 89.028832 deg, ROLL: 38.234204 deg, YAW: 287.929575 deg.
2018-08-21T21:47:37.635Z,1534888057.635 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.908813 uT, Mz: 223.921783 uT
2018-08-21T21:47:37.709Z,1534888057.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2018-08-21T21:47:38.034Z,1534888058.034 [AHRS_M2](INFO): PITCH: 89.028832 deg, ROLL: 38.490042 deg, YAW: 288.183440 deg.
2018-08-21T21:47:38.036Z,1534888058.036 [AHRS_M2](INFO): Mx: 18.018347 uT, My: 2.908813 uT, Mz: 0.000000 uT
2018-08-21T21:47:38.119Z,1534888058.119 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2018-08-21T21:47:38.435Z,1534888058.435 [AHRS_M2](INFO): PITCH: 89.029036 deg, ROLL: 38.647918 deg, YAW: 288.334414 deg.
2018-08-21T21:47:38.436Z,1534888058.436 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.908201 uT, Mz: 223.138397 uT
2018-08-21T21:47:38.505Z,1534888058.505 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2018-08-21T21:47:38.833Z,1534888058.833 [AHRS_M2](INFO): PITCH: 89.029439 deg, ROLL: 38.444334 deg, YAW: 288.137978 deg.
2018-08-21T21:47:38.834Z,1534888058.834 [AHRS_M2](INFO): Mx: 18.018347 uT, My: 2.907895 uT, Mz: 223.448288 uT
2018-08-21T21:47:38.889Z,1534888058.889 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2018-08-21T21:47:39.233Z,1534888059.233 [AHRS_M2](INFO): PITCH: 89.040593 deg, ROLL: 38.387944 deg, YAW: 288.113116 deg.
2018-08-21T21:47:39.234Z,1534888059.234 [AHRS_M2](INFO): Mx: 18.018341 uT, My: 2.907283 uT, Mz: 0.000000 uT
2018-08-21T21:47:39.296Z,1534888059.296 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2018-08-21T21:47:39.633Z,1534888059.633 [AHRS_M2](INFO): PITCH: 89.043250 deg, ROLL: 38.042060 deg, YAW: 287.773929 deg.
2018-08-21T21:47:39.634Z,1534888059.634 [AHRS_M2](INFO): Mx: 18.018339 uT, My: 2.907895 uT, Mz: 223.912064 uT
2018-08-21T21:47:39.701Z,1534888059.701 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2018-08-21T21:47:40.033Z,1534888060.033 [AHRS_M2](INFO): PITCH: 89.035505 deg, ROLL: 38.106602 deg, YAW: 287.809500 deg.
2018-08-21T21:47:40.034Z,1534888060.034 [AHRS_M2](INFO): Mx: 18.018335 uT, My: 2.909425 uT, Mz: 223.232010 uT
2018-08-21T21:47:40.101Z,1534888060.101 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2018-08-21T21:47:40.433Z,1534888060.433 [AHRS_M2](INFO): PITCH: 89.032069 deg, ROLL: 38.108689 deg, YAW: 287.809746 deg.
2018-08-21T21:47:40.434Z,1534888060.434 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.909425 uT, Mz: 0.000000 uT
2018-08-21T21:47:40.497Z,1534888060.497 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2018-08-21T21:47:40.834Z,1534888060.834 [AHRS_M2](INFO): PITCH: 89.031051 deg, ROLL: 38.300286 deg, YAW: 287.994680 deg.
2018-08-21T21:47:40.835Z,1534888060.835 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.910343 uT, Mz: 223.515259 uT
2018-08-21T21:47:40.877Z,1534888060.877 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2018-08-21T21:47:41.233Z,1534888061.233 [AHRS_M2](INFO): PITCH: 89.031454 deg, ROLL: 38.209803 deg, YAW: 287.904795 deg.
2018-08-21T21:47:41.234Z,1534888061.234 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.909119 uT, Mz: 222.751007 uT
2018-08-21T21:47:41.281Z,1534888061.281 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2018-08-21T21:47:41.633Z,1534888061.633 [AHRS_M2](INFO): PITCH: 89.026216 deg, ROLL: 38.503480 deg, YAW: 288.192811 deg.
2018-08-21T21:47:41.634Z,1534888061.634 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.909731 uT, Mz: 0.000000 uT
2018-08-21T21:47:41.685Z,1534888061.685 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2018-08-21T21:47:42.033Z,1534888062.033 [AHRS_M2](INFO): PITCH: 89.024009 deg, ROLL: 38.658382 deg, YAW: 288.336600 deg.
2018-08-21T21:47:42.034Z,1534888062.034 [AHRS_M2](INFO): Mx: 18.018347 uT, My: 2.907283 uT, Mz: 222.779510 uT
2018-08-21T21:47:42.433Z,1534888062.433 [AHRS_M2](INFO): PITCH: 89.027636 deg, ROLL: 38.257949 deg, YAW: 287.932198 deg.
2018-08-21T21:47:42.434Z,1534888062.434 [AHRS_M2](INFO): Mx: 18.018343 uT, My: 2.907895 uT, Mz: 223.462082 uT
2018-08-21T21:47:42.833Z,1534888062.833 [AHRS_M2](INFO): PITCH: 89.029439 deg, ROLL: 38.076361 deg, YAW: 287.751116 deg.
2018-08-21T21:47:42.834Z,1534888062.834 [AHRS_M2](INFO): Mx: 18.018337 uT, My: 2.909119 uT, Mz: 0.000000 uT
2018-08-21T21:47:43.233Z,1534888063.233 [AHRS_M2](INFO): PITCH: 89.031871 deg, ROLL: 37.914988 deg, YAW: 287.602546 deg.
2018-08-21T21:47:43.234Z,1534888063.234 [AHRS_M2](INFO): Mx: 18.018335 uT, My: 2.908507 uT, Mz: 223.301788 uT
2018-08-21T21:47:43.633Z,1534888063.633 [AHRS_M2](INFO): PITCH: 89.025819 deg, ROLL: 38.187144 deg, YAW: 287.867174 deg.
2018-08-21T21:47:43.634Z,1534888063.634 [AHRS_M2](INFO): Mx: 18.018337 uT, My: 2.907283 uT, Mz: 223.119949 uT
2018-08-21T21:47:44.033Z,1534888064.033 [AHRS_M2](INFO): PITCH: 89.026018 deg, ROLL: 38.152586 deg, YAW: 287.835291 deg.
2018-08-21T21:47:44.034Z,1534888064.034 [AHRS_M2](INFO): Mx: 18.018351 uT, My: 2.910343 uT, Mz: 0.000000 uT
2018-08-21T21:47:44.433Z,1534888064.433 [AHRS_M2](INFO): PITCH: 89.028429 deg, ROLL: 37.859592 deg, YAW: 287.535828 deg.
2018-08-21T21:47:44.434Z,1534888064.434 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.906059 uT, Mz: 222.503418 uT
2018-08-21T21:47:44.833Z,1534888064.833 [AHRS_M2](INFO): PITCH: 89.028832 deg, ROLL: 37.811412 deg, YAW: 287.485230 deg.
2018-08-21T21:47:44.834Z,1534888064.834 [AHRS_M2](INFO): Mx: 18.018351 uT, My: 2.908201 uT, Mz: 222.974777 uT
2018-08-21T21:47:45.233Z,1534888065.233 [AHRS_M2](INFO): PITCH: 89.021605 deg, ROLL: 38.290734 deg, YAW: 287.949547 deg.
2018-08-21T21:47:45.234Z,1534888065.234 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.907589 uT, Mz: 0.000000 uT
2018-08-21T21:47:45.633Z,1534888065.633 [AHRS_M2](INFO): PITCH: 89.022418 deg, ROLL: 37.822610 deg, YAW: 287.474466 deg.
2018-08-21T21:47:45.634Z,1534888065.634 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.908813 uT, Mz: 223.812103 uT
2018-08-21T21:47:45.703Z,1534888065.703 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:47:45.703Z,1534888065.703 [Aanderaa_O2] No Fault, FailCount= 3
2018-08-21T21:47:46.035Z,1534888066.035 [AHRS_M2](INFO): PITCH: 89.029036 deg, ROLL: 37.576955 deg, YAW: 287.243797 deg.
2018-08-21T21:47:46.035Z,1534888066.035 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.907283 uT, Mz: 223.249725 uT
2018-08-21T21:47:46.434Z,1534888066.434 [AHRS_M2](INFO): PITCH: 89.026216 deg, ROLL: 38.036705 deg, YAW: 287.705272 deg.
2018-08-21T21:47:46.437Z,1534888066.437 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.908507 uT, Mz: 0.000000 uT
2018-08-21T21:47:46.833Z,1534888066.833 [AHRS_M2](INFO): PITCH: 89.028832 deg, ROLL: 37.867221 deg, YAW: 287.533807 deg.
2018-08-21T21:47:46.834Z,1534888066.834 [AHRS_M2](INFO): Mx: 18.018339 uT, My: 2.908813 uT, Mz: 222.593658 uT
2018-08-21T21:47:47.233Z,1534888067.233 [AHRS_M2](INFO): PITCH: 89.024412 deg, ROLL: 37.974855 deg, YAW: 287.635139 deg.
2018-08-21T21:47:47.234Z,1534888067.234 [AHRS_M2](INFO): Mx: 18.018337 uT, My: 2.909119 uT, Mz: 222.460724 uT
2018-08-21T21:47:47.634Z,1534888067.634 [AHRS_M2](INFO): PITCH: 89.035307 deg, ROLL: 38.477505 deg, YAW: 288.175052 deg.
2018-08-21T21:47:47.634Z,1534888067.634 [AHRS_M2](INFO): Mx: 18.018335 uT, My: 2.907895 uT, Mz: 0.000000 uT
2018-08-21T21:47:48.034Z,1534888068.034 [AHRS_M2](INFO): PITCH: 89.034494 deg, ROLL: 38.121997 deg, YAW: 287.822286 deg.
2018-08-21T21:47:48.034Z,1534888068.034 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.909425 uT, Mz: 222.434235 uT
2018-08-21T21:47:48.433Z,1534888068.433 [AHRS_M2](INFO): PITCH: 89.028231 deg, ROLL: 38.044041 deg, YAW: 287.730571 deg.
2018-08-21T21:47:48.434Z,1534888068.434 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.907283 uT, Mz: 222.597626 uT
2018-08-21T21:47:48.834Z,1534888068.834 [AHRS_M2](INFO): PITCH: 89.027834 deg, ROLL: 37.813908 deg, YAW: 287.498781 deg.
2018-08-21T21:47:48.834Z,1534888068.834 [AHRS_M2](INFO): Mx: 18.018351 uT, My: 2.908507 uT, Mz: 0.000000 uT
2018-08-21T21:47:49.233Z,1534888069.233 [AHRS_M2](INFO): PITCH: 89.036522 deg, ROLL: 38.136792 deg, YAW: 287.843843 deg.
2018-08-21T21:47:49.234Z,1534888069.234 [AHRS_M2](INFO): Mx: 18.018351 uT, My: 2.911261 uT, Mz: 223.152130 uT
2018-08-21T21:47:49.633Z,1534888069.633 [AHRS_M2](INFO): PITCH: 89.037950 deg, ROLL: 37.904609 deg, YAW: 287.611398 deg.
2018-08-21T21:47:49.634Z,1534888069.634 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.908813 uT, Mz: 222.940475 uT
2018-08-21T21:47:50.034Z,1534888070.034 [AHRS_M2](INFO): PITCH: 89.037335 deg, ROLL: 37.825874 deg, YAW: 287.530009 deg.
2018-08-21T21:47:50.035Z,1534888070.035 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.909731 uT, Mz: 0.000000 uT
2018-08-21T21:47:50.433Z,1534888070.433 [AHRS_M2](INFO): PITCH: 89.034296 deg, ROLL: 37.889412 deg, YAW: 287.584131 deg.
2018-08-21T21:47:50.434Z,1534888070.434 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.907895 uT, Mz: 222.460358 uT
2018-08-21T21:47:50.833Z,1534888070.833 [AHRS_M2](INFO): PITCH: 89.031659 deg, ROLL: 37.910275 deg, YAW: 287.593448 deg.
2018-08-21T21:47:50.834Z,1534888070.834 [AHRS_M2](INFO): Mx: 18.018343 uT, My: 2.908201 uT, Mz: 223.086456 uT
2018-08-21T21:47:51.234Z,1534888071.234 [AHRS_M2](INFO): PITCH: 89.030450 deg, ROLL: 37.801631 deg, YAW: 287.479438 deg.
2018-08-21T21:47:51.235Z,1534888071.235 [AHRS_M2](INFO): Mx: 18.018339 uT, My: 2.908507 uT, Mz: 0.000000 uT
2018-08-21T21:47:51.635Z,1534888071.635 [AHRS_M2](INFO): PITCH: 89.034692 deg, ROLL: 37.940007 deg, YAW: 287.628227 deg.
2018-08-21T21:47:51.636Z,1534888071.636 [AHRS_M2](INFO): Mx: 18.018333 uT, My: 2.908507 uT, Mz: 222.980865 uT
2018-08-21T21:47:52.035Z,1534888072.035 [AHRS_M2](INFO): PITCH: 89.035921 deg, ROLL: 38.233586 deg, YAW: 287.928045 deg.
2018-08-21T21:47:52.036Z,1534888072.036 [AHRS_M2](INFO): Mx: 18.018353 uT, My: 2.909731 uT, Mz: 223.015228 uT
2018-08-21T21:47:52.436Z,1534888072.436 [AHRS_M2](INFO): PITCH: 89.032670 deg, ROLL: 37.993989 deg, YAW: 287.689262 deg.
2018-08-21T21:47:52.436Z,1534888072.436 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.909731 uT, Mz: 0.000000 uT
2018-08-21T21:47:52.835Z,1534888072.835 [AHRS_M2](INFO): PITCH: 89.029235 deg, ROLL: 37.922341 deg, YAW: 287.599704 deg.
2018-08-21T21:47:52.836Z,1534888072.836 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.906977 uT, Mz: 222.870163 uT
2018-08-21T21:47:53.235Z,1534888073.235 [AHRS_M2](INFO): PITCH: 89.034897 deg, ROLL: 38.010809 deg, YAW: 287.711555 deg.
2018-08-21T21:47:53.236Z,1534888073.236 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.909119 uT, Mz: 223.149002 uT
2018-08-21T21:47:53.636Z,1534888073.636 [AHRS_M2](INFO): PITCH: 89.037547 deg, ROLL: 38.113480 deg, YAW: 287.819281 deg.
2018-08-21T21:47:53.636Z,1534888073.636 [AHRS_M2](INFO): Mx: 18.018345 uT, My: 2.909119 uT, Mz: 0.000000 uT
2018-08-21T21:47:54.036Z,1534888074.036 [AHRS_M2](INFO): PITCH: 89.029638 deg, ROLL: 38.252867 deg, YAW: 287.939547 deg.
2018-08-21T21:47:54.036Z,1534888074.036 [AHRS_M2](INFO): Mx: 18.018343 uT, My: 2.907283 uT, Mz: 223.969315 uT
2018-08-21T21:47:54.834Z,1534888074.834 [AHRS_M2](INFO): PITCH: 89.026421 deg, ROLL: 37.808010 deg, YAW: 287.473564 deg.
2018-08-21T21:47:54.836Z,1534888074.836 [AHRS_M2](INFO): Mx: 18.018337 uT, My: 2.909119 uT, Mz: 0.000000 uT
2018-08-21T21:47:55.233Z,1534888075.233 [AHRS_M2](INFO): PITCH: 89.026823 deg, ROLL: 37.480516 deg, YAW: 287.144896 deg.
2018-08-21T21:47:55.234Z,1534888075.234 [AHRS_M2](INFO): Mx: 18.018335 uT, My: 2.909425 uT, Mz: 223.513016 uT
2018-08-21T21:47:55.635Z,1534888075.635 [AHRS_M2](INFO): PITCH: 89.031871 deg, ROLL: 37.483460 deg, YAW: 287.163146 deg.
2018-08-21T21:47:55.635Z,1534888075.635 [AHRS_M2](INFO): Mx: 18.018335 uT, My: 2.908201 uT, Mz: 223.898407 uT
2018-08-21T21:47:56.034Z,1534888076.034 [AHRS_M2](INFO): PITCH: 89.036727 deg, ROLL: 37.592808 deg, YAW: 287.281090 deg.
2018-08-21T21:47:56.035Z,1534888076.035 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.908813 uT, Mz: 0.000000 uT
2018-08-21T21:47:56.431Z,1534888076.431 [Aanderaa_O2](FAULT): Timed out starting
2018-08-21T21:47:56.431Z,1534888076.431 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-08-21T21:47:56.432Z,1534888076.432 [Aanderaa_O2](ERROR): Communications Fault
2018-08-21T21:47:56.434Z,1534888076.434 [AHRS_M2](INFO): PITCH: 89.037745 deg, ROLL: 37.519841 deg, YAW: 287.203854 deg.
2018-08-21T21:47:56.435Z,1534888076.435 [AHRS_M2](INFO): Mx: 18.018347 uT, My: 2.908507 uT, Mz: 222.746735 uT
2018-08-21T21:47:56.526Z,1534888076.526 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-08-21T21:47:56.951Z,1534888076.951 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:47:56.954Z,1534888076.954 [AHRS_M2](INFO): PITCH: 89.031256 deg, ROLL: 37.612892 deg, YAW: 287.281800 deg.
2018-08-21T21:47:56.955Z,1534888076.955 [AHRS_M2](INFO): Mx: 18.018349 uT, My: 2.910343 uT, Mz: 0.000000 uT
2018-08-21T21:47:57.633Z,1534888077.633 [AHRS_M2](INFO): PITCH: 89.028032 deg, ROLL: 37.895870 deg, YAW: 287.561756 deg.
2018-08-21T21:47:57.634Z,1534888077.634 [AHRS_M2](INFO): Mx: 18.018347 uT, My: 2.909425 uT, Mz: 223.419586 uT
2018-08-21T21:47:57.745Z,1534888077.745 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-08-21T21:47:57.746Z,1534888077.746 [Aanderaa_O2] No Fault, FailCount= 1
2018-08-21T21:47:58.037Z,1534888078.037 [AHRS_M2](INFO): PITCH: 89.032274 deg, ROLL: 38.181977 deg, YAW: 287.874278 deg.
2018-08-21T21:47:58.038Z,1534888078.038 [AHRS_M2](INFO): Mx: 18.018347 uT, My: 2.908507 uT, Mz: 0.000000 uT
2018-08-21T21:47:58.063Z,1534888078.063 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 1.000000 count
2018-08-21T21:48:05.400Z,1534888085.400 [CommandLine](IMPORTANT): got command quit
2018-08-21T21:48:06.409Z,1534888086.409 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-21T21:48:06.410Z,1534888086.410 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:06.478Z,1534888086.478 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-08-21T21:48:06.479Z,1534888086.479 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:06.479Z,1534888086.479 [CommandLine](INFO): Join timeout helper Thread ID is 8283
2018-08-21T21:48:06.480Z,1534888086.480 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-08-21T21:48:06.481Z,1534888086.481 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:06.484Z,1534888086.484 [NavChartDb](INFO): Join timeout helper Thread ID is 8284
2018-08-21T21:48:06.546Z,1534888086.546 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-21T21:48:06.547Z,1534888086.547 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:06.554Z,1534888086.554 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-08-21T21:48:06.554Z,1534888086.554 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:06.555Z,1534888086.555 [Radio_Surface](INFO): Join timeout helper Thread ID is 8285
2018-08-21T21:48:06.715Z,1534888086.715 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-21T21:48:06.715Z,1534888086.715 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:06.726Z,1534888086.726 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2018-08-21T21:48:06.727Z,1534888086.727 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:06.727Z,1534888086.727 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 8286
2018-08-21T21:48:07.127Z,1534888087.127 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-21T21:48:07.127Z,1534888087.127 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-08-21T21:48:07.128Z,1534888087.128 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.134Z,1534888087.134 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-08-21T21:48:07.134Z,1534888087.134 [logger ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.135Z,1534888087.135 [logger](INFO): Join timeout helper Thread ID is 8287
2018-08-21T21:48:07.174Z,1534888087.174 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-21T21:48:07.175Z,1534888087.175 [logger ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.195Z,1534888087.195 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-08-21T21:48:07.195Z,1534888087.195 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.195Z,1534888087.195 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-08-21T21:48:07.196Z,1534888087.196 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.196Z,1534888087.196 [controlThread](INFO): Join timeout helper Thread ID is 8288
2018-08-21T21:48:07.227Z,1534888087.227 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-21T21:48:07.227Z,1534888087.227 [controlThread](DEBUG): Uninitializing ControlThread
2018-08-21T21:48:07.346Z,1534888087.346 [Aanderaa_O2](INFO): Powering down
2018-08-21T21:48:07.347Z,1534888087.347 [AHRS_M2](INFO): Powering down
2018-08-21T21:48:07.419Z,1534888087.419 [NAL9602](INFO): Powering down
2018-08-21T21:48:07.421Z,1534888087.421 [RDI_Pathfinder](INFO): Powering down
2018-08-21T21:48:07.423Z,1534888087.423 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-08-21T21:48:07.424Z,1534888087.424 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-08-21T21:48:07.425Z,1534888087.425 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-08-21T21:48:07.425Z,1534888087.425 [MissionManager](INFO): Uninitializing Mission Default
2018-08-21T21:48:07.425Z,1534888087.425 [Default] Stopped
2018-08-21T21:48:07.425Z,1534888087.425 [Default](DEBUG): Aggregate::uninitialize Default
2018-08-21T21:48:07.425Z,1534888087.425 [Default:B.GoToSurface] Stopped
2018-08-21T21:48:07.426Z,1534888087.426 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-08-21T21:48:07.426Z,1534888087.426 [Default:CheckIn] Stopped
2018-08-21T21:48:07.426Z,1534888087.426 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-21T21:48:07.426Z,1534888087.426 [Default:CheckIn:Read_GPS] Stopped
2018-08-21T21:48:07.429Z,1534888087.429 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-08-21T21:48:07.430Z,1534888087.430 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-08-21T21:48:07.430Z,1534888087.430 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-08-21T21:48:07.431Z,1534888087.431 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-08-21T21:48:07.431Z,1534888087.431 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-08-21T21:48:07.431Z,1534888087.431 [BuoyancyServo](INFO): Powering down
2018-08-21T21:48:07.442Z,1534888087.442 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-08-21T21:48:07.443Z,1534888087.443 [ElevatorServo](INFO): Powering down
2018-08-21T21:48:07.444Z,1534888087.444 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-08-21T21:48:07.444Z,1534888087.444 [MassServo](INFO): Powering down
2018-08-21T21:48:07.445Z,1534888087.445 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-08-21T21:48:07.445Z,1534888087.445 [RudderServo](INFO): Powering down
2018-08-21T21:48:07.446Z,1534888087.446 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-08-21T21:48:07.446Z,1534888087.446 [ThrusterServo](INFO): Powering down
2018-08-21T21:48:07.447Z,1534888087.447 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-08-21T21:48:07.447Z,1534888087.447 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-08-21T21:48:07.447Z,1534888087.447 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-08-21T21:48:07.448Z,1534888087.448 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.502Z,1534888087.502 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.561Z,1534888087.561 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.603Z,1534888087.603 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-08-21T21:48:07.658Z,1534888087.658 [logger ThreadHandler](INFO): Thread cancelled.