2019-07-23T20:36:57.639Z,1563914217.639 [Supervisor](DEBUG): Initializing supervisor.
2019-07-23T20:36:57.643Z,1563914217.643 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-07-23T20:36:57.643Z,1563914217.643 [SyncHandler](INFO): Protected caller Thread ID is 1295
2019-07-23T20:36:57.643Z,1563914217.643 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-07-23T20:36:57.644Z,1563914217.644 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-07-23T20:36:57.645Z,1563914217.645 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1296
2019-07-23T20:36:57.649Z,1563914217.649 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-07-23T20:36:57.662Z,1563914217.662 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-07-23T20:36:57.663Z,1563914217.663 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-07-23T20:36:57.664Z,1563914217.664 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1297
2019-07-23T20:36:57.665Z,1563914217.665 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-07-23T20:36:57.666Z,1563914217.666 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-07-23T20:36:57.666Z,1563914217.666 [logger ThreadHandler](INFO): Protected caller Thread ID is 1298
2019-07-23T20:36:57.668Z,1563914217.668 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-07-23T20:36:57.669Z,1563914217.669 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-07-23T20:36:57.670Z,1563914217.670 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-07-23T20:36:57.872Z,1563914217.872 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-07-23T20:36:57.873Z,1563914217.873 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-07-23T20:36:57.953Z,1563914217.953 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-07-23T20:36:58.390Z,1563914218.390 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-07-23T20:36:58.391Z,1563914218.391 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-07-23T20:36:58.725Z,1563914218.725 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-07-23T20:36:58.726Z,1563914218.726 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-07-23T20:36:58.822Z,1563914218.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-07-23T20:36:58.822Z,1563914218.822 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-07-23T20:36:59.122Z,1563914219.122 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-07-23T20:36:59.122Z,1563914219.122 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-07-23T20:36:59.363Z,1563914219.363 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-07-23T20:36:59.364Z,1563914219.364 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-07-23T20:37:00.001Z,1563914220.001 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-07-23T20:37:00.002Z,1563914220.002 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-07-23T20:37:00.107Z,1563914220.107 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-07-23T20:37:00.107Z,1563914220.107 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-07-23T20:37:00.207Z,1563914220.207 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-07-23T20:37:00.208Z,1563914220.208 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-07-23T20:37:00.812Z,1563914220.812 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-07-23T20:37:00.813Z,1563914220.813 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-07-23T20:37:01.204Z,1563914221.204 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-07-23T20:37:01.205Z,1563914221.205 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-07-23T20:37:01.399Z,1563914221.399 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-07-23T20:37:01.400Z,1563914221.400 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-07-23T20:37:01.546Z,1563914221.546 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-07-23T20:37:01.547Z,1563914221.547 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-07-23T20:37:01.696Z,1563914221.696 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-07-23T20:37:01.698Z,1563914221.698 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2019-07-23T20:37:01.699Z,1563914221.699 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2019-07-23T20:37:01.790Z,1563914221.790 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2019-07-23T20:37:01.876Z,1563914221.876 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2019-07-23T20:37:01.978Z,1563914221.978 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2019-07-23T20:37:02.061Z,1563914222.061 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2019-07-23T20:37:02.156Z,1563914222.156 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2019-07-23T20:37:02.258Z,1563914222.258 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2019-07-23T20:37:02.475Z,1563914222.475 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2019-07-23T20:37:02.551Z,1563914222.551 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2019-07-23T20:37:02.724Z,1563914222.724 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2019-07-23T20:37:02.861Z,1563914222.861 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2019-07-23T20:37:02.983Z,1563914222.983 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2019-07-23T20:37:03.218Z,1563914223.218 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-07-23T20:37:03.219Z,1563914223.219 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2019-07-23T20:37:03.220Z,1563914223.220 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-07-23T20:37:03.241Z,1563914223.241 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-07-23T20:37:03.307Z,1563914223.307 [VerticalControl](DEBUG): Construct VerticalControl.
2019-07-23T20:37:03.419Z,1563914223.419 [VerticalControl] Loaded
2019-07-23T20:37:03.419Z,1563914223.419 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-07-23T20:37:03.420Z,1563914223.420 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-07-23T20:37:03.489Z,1563914223.489 [HorizontalControl] Loaded
2019-07-23T20:37:03.489Z,1563914223.489 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-07-23T20:37:03.490Z,1563914223.490 [SpeedControl](DEBUG): Construct SpeedControl.
2019-07-23T20:37:03.496Z,1563914223.496 [SpeedControl] Loaded
2019-07-23T20:37:03.496Z,1563914223.496 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-07-23T20:37:03.497Z,1563914223.497 [LoopControl](DEBUG): Construct LoopControl.
2019-07-23T20:37:03.497Z,1563914223.497 [LoopControl] Loaded
2019-07-23T20:37:03.497Z,1563914223.497 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-07-23T20:37:03.498Z,1563914223.498 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-07-23T20:37:03.498Z,1563914223.498 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-07-23T20:37:03.511Z,1563914223.511 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-07-23T20:37:03.512Z,1563914223.512 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-07-23T20:37:03.610Z,1563914223.610 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-07-23T20:37:03.610Z,1563914223.610 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-07-23T20:37:03.735Z,1563914223.735 [BuoyancyServo] Loaded
2019-07-23T20:37:03.735Z,1563914223.735 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-07-23T20:37:03.746Z,1563914223.746 [ElevatorServo] Loaded
2019-07-23T20:37:03.746Z,1563914223.746 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-07-23T20:37:03.758Z,1563914223.758 [MassServo] Loaded
2019-07-23T20:37:03.758Z,1563914223.758 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-07-23T20:37:03.769Z,1563914223.769 [RudderServo] Loaded
2019-07-23T20:37:03.769Z,1563914223.769 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-07-23T20:37:03.780Z,1563914223.780 [ThrusterServo] Loaded
2019-07-23T20:37:03.781Z,1563914223.781 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-07-23T20:37:03.781Z,1563914223.781 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-07-23T20:37:03.782Z,1563914223.782 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-07-23T20:37:03.890Z,1563914223.890 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-07-23T20:37:03.890Z,1563914223.890 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-07-23T20:37:03.911Z,1563914223.911 [NavChart] Loaded
2019-07-23T20:37:03.911Z,1563914223.911 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-07-23T20:37:03.915Z,1563914223.915 [UniversalFixResidualReporter] Loaded
2019-07-23T20:37:03.915Z,1563914223.915 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-07-23T20:37:03.916Z,1563914223.916 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-07-23T20:37:03.916Z,1563914223.916 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-07-23T20:37:03.986Z,1563914223.986 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-07-23T20:37:03.987Z,1563914223.987 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-07-23T20:37:04.326Z,1563914224.326 [DataOverHttps] Loaded
2019-07-23T20:37:04.326Z,1563914224.326 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-07-23T20:37:04.327Z,1563914224.327 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087D4E0
2019-07-23T20:37:04.328Z,1563914224.328 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1380
2019-07-23T20:37:04.341Z,1563914224.341 [Depth_Keller] Loaded
2019-07-23T20:37:04.341Z,1563914224.341 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-07-23T20:37:04.438Z,1563914224.438 [NAL9602] Loaded
2019-07-23T20:37:04.438Z,1563914224.438 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-07-23T20:37:04.454Z,1563914224.454 [Onboard] Loaded
2019-07-23T20:37:04.455Z,1563914224.455 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-07-23T20:37:04.458Z,1563914224.458 [Radio_Surface] Loaded
2019-07-23T20:37:04.458Z,1563914224.458 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-07-23T20:37:04.459Z,1563914224.459 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408AD4E0
2019-07-23T20:37:04.460Z,1563914224.460 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1381
2019-07-23T20:37:06.482Z,1563914226.482 [BPC1] Loaded
2019-07-23T20:37:06.483Z,1563914226.483 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-07-23T20:37:06.483Z,1563914226.483 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-07-23T20:37:06.484Z,1563914226.484 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-07-23T20:37:06.524Z,1563914226.524 [DepthRateCalculator] Loaded
2019-07-23T20:37:06.524Z,1563914226.524 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-07-23T20:37:06.530Z,1563914226.530 [PitchRateCalculator] Loaded
2019-07-23T20:37:06.530Z,1563914226.530 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-07-23T20:37:06.542Z,1563914226.542 [SpeedCalculator] Loaded
2019-07-23T20:37:06.542Z,1563914226.542 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-07-23T20:37:06.564Z,1563914226.564 [TempGradientCalculator] Loaded
2019-07-23T20:37:06.564Z,1563914226.564 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-07-23T20:37:06.569Z,1563914226.569 [YawRateCalculator] Loaded
2019-07-23T20:37:06.569Z,1563914226.569 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-07-23T20:37:06.599Z,1563914226.599 [ElevatorOffsetCalculator] Loaded
2019-07-23T20:37:06.600Z,1563914226.600 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-07-23T20:37:06.600Z,1563914226.600 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-07-23T20:37:06.601Z,1563914226.601 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-07-23T20:37:06.794Z,1563914226.794 [ESPComponent] Loaded
2019-07-23T20:37:06.795Z,1563914226.795 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-07-23T20:37:06.809Z,1563914226.809 [PAR_Licor] Loaded
2019-07-23T20:37:06.810Z,1563914226.810 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-07-23T20:37:06.810Z,1563914226.810 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-07-23T20:37:06.811Z,1563914226.811 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-07-23T20:37:06.843Z,1563914226.843 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-07-23T20:37:06.843Z,1563914226.843 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-07-23T20:37:07.134Z,1563914227.134 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-07-23T20:37:07.134Z,1563914227.134 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-07-23T20:37:07.267Z,1563914227.267 [SBIT](DEBUG): Construct Startup Built In Test.
2019-07-23T20:37:07.278Z,1563914227.278 [SBIT] Loaded
2019-07-23T20:37:07.278Z,1563914227.278 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-07-23T20:37:07.279Z,1563914227.279 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-07-23T20:37:07.291Z,1563914227.291 [IBIT] Loaded
2019-07-23T20:37:07.291Z,1563914227.291 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-07-23T20:37:07.294Z,1563914227.294 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-07-23T20:37:07.433Z,1563914227.433 [CBIT] Loaded
2019-07-23T20:37:07.433Z,1563914227.433 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-07-23T20:37:07.433Z,1563914227.433 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-07-23T20:37:07.437Z,1563914227.437 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-07-23T20:37:07.438Z,1563914227.438 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-07-23T20:37:07.445Z,1563914227.445 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-07-23T20:37:07.446Z,1563914227.446 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A7E4E0
2019-07-23T20:37:07.447Z,1563914227.447 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1382
2019-07-23T20:37:07.451Z,1563914227.451 [Supervisor](INFO): Main Thread ID is 802
2019-07-23T20:37:07.452Z,1563914227.452 [Supervisor](DEBUG): Running supervisor.
2019-07-23T20:37:07.452Z,1563914227.452 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1383
2019-07-23T20:37:07.455Z,1563914227.455 [controlThread ThreadHandler](INFO): Handler Thread ID is 1384
2019-07-23T20:37:07.455Z,1563914227.455 [controlThread](DEBUG): Initializing ControlThread
2019-07-23T20:37:07.456Z,1563914227.456 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-07-23T20:37:07.458Z,1563914227.458 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-07-23T20:37:07.458Z,1563914227.458 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-07-23T20:37:07.459Z,1563914227.459 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-07-23T20:37:07.461Z,1563914227.461 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-07-23T20:37:07.461Z,1563914227.461 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-07-23T20:37:07.466Z,1563914227.466 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-07-23T20:37:07.466Z,1563914227.466 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-07-23T20:37:07.466Z,1563914227.466 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-07-23T20:37:07.467Z,1563914227.467 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-07-23T20:37:07.467Z,1563914227.467 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-07-23T20:37:07.467Z,1563914227.467 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-07-23T20:37:07.469Z,1563914227.469 [SBIT](INFO): Initialize SBIT Component.
2019-07-23T20:37:07.469Z,1563914227.469 [SBIT](IMPORTANT): git: 2019-07-16
2019-07-23T20:37:07.470Z,1563914227.470 [SBIT](INFO): git hash: 5dde538a58d6fd4f55501de4ce986b4d4d3b120b
2019-07-23T20:37:07.470Z,1563914227.470 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-07-23T20:37:07.471Z,1563914227.471 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2019-07-23T20:37:07.472Z,1563914227.472 [SBIT](INFO): Beginning SBIT in 29.000000 seconds.
2019-07-23T20:37:07.473Z,1563914227.473 [IBIT](INFO): Initialize IBIT Component.
2019-07-23T20:37:07.474Z,1563914227.474 [CBIT](DEBUG): Initialize CBIT Component.
2019-07-23T20:37:07.475Z,1563914227.475 [logger ThreadHandler](INFO): Handler Thread ID is 1385
2019-07-23T20:37:07.485Z,1563914227.485 [CBIT](DEBUG): Initialized mux pins.
2019-07-23T20:37:07.485Z,1563914227.485 [CBIT](DEBUG): Initializing the watchdog timer.
2019-07-23T20:37:07.493Z,1563914227.493 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1386
2019-07-23T20:37:07.494Z,1563914227.494 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-07-23T20:37:07.505Z,1563914227.505 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1387
2019-07-23T20:37:07.509Z,1563914227.509 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-07-23T20:37:07.509Z,1563914227.509 [CBIT](DEBUG): Initializing heartbeat.
2019-07-23T20:37:07.517Z,1563914227.517 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1388
2019-07-23T20:37:07.521Z,1563914227.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-07-23T20:37:07.521Z,1563914227.521 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-07-23T20:37:07.521Z,1563914227.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-07-23T20:37:07.521Z,1563914227.521 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-07-23T20:37:07.521Z,1563914227.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-07-23T20:37:07.521Z,1563914227.521 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-07-23T20:37:07.522Z,1563914227.522 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-07-23T20:37:07.522Z,1563914227.522 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-07-23T20:37:07.522Z,1563914227.522 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-07-23T20:37:07.522Z,1563914227.522 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-07-23T20:37:07.522Z,1563914227.522 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-07-23T20:37:07.522Z,1563914227.522 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-07-23T20:37:07.523Z,1563914227.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-07-23T20:37:07.523Z,1563914227.523 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-07-23T20:37:07.523Z,1563914227.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-07-23T20:37:07.523Z,1563914227.523 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-07-23T20:37:07.581Z,1563914227.581 [CBIT](DEBUG): Deactivating GF circuits.
2019-07-23T20:37:07.581Z,1563914227.581 [CBIT](DEBUG): Deactivating emergency mode.
2019-07-23T20:37:07.617Z,1563914227.617 [CBIT](DEBUG): Backplane powered.
2019-07-23T20:37:07.618Z,1563914227.618 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-07-23T20:37:07.629Z,1563914227.629 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-07-23T20:37:07.640Z,1563914227.640 [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>


2019-07-23T20:37:07.642Z,1563914227.642 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-07-23T20:37:07.682Z,1563914227.682 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-07-23T20:37:07.683Z,1563914227.683 [Default:A.Wait](DEBUG): Construct Wait.
2019-07-23T20:37:07.685Z,1563914227.685 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-07-23T20:37:07.708Z,1563914227.708 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-07-23T20:37:07.711Z,1563914227.711 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-07-23T20:37:07.729Z,1563914227.729 [Default:E.Execute](DEBUG): Construct Execute.
2019-07-23T20:37:07.732Z,1563914227.732 [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 on</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>


2019-07-23T20:37:07.749Z,1563914227.749 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,NAL9602,Onboard,BPC1,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-07-23T20:37:07.756Z,1563914227.756 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2019-07-23T20:37:07.909Z,1563914227.909 [Radio_Surface](INFO): Powering up
2019-07-23T20:37:07.913Z,1563914227.913 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-07-23T20:37:07.937Z,1563914227.937 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-07-23T20:37:07.949Z,1563914227.949 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-07-23T20:37:07.950Z,1563914227.950 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-07-23T20:37:07.957Z,1563914227.957 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-07-23T20:37:07.958Z,1563914227.958 [MassServo](DEBUG): Initializing EZServoServo.
2019-07-23T20:37:07.965Z,1563914227.965 [MassServo](DEBUG): Initializing MassServo.
2019-07-23T20:37:07.966Z,1563914227.966 [RudderServo](DEBUG): Initializing EZServoServo.
2019-07-23T20:37:07.973Z,1563914227.973 [RudderServo](DEBUG): Initializing RudderServo.
2019-07-23T20:37:07.974Z,1563914227.974 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-07-23T20:37:08.009Z,1563914228.009 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-07-23T20:37:08.929Z,1563914228.929 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2019-07-23T20:37:08.929Z,1563914228.929 [RudderServo](FAULT): Rudder failed to initialize
2019-07-23T20:37:08.929Z,1563914228.929 [RudderServo] Communications Fault, FailCount= 1
2019-07-23T20:37:08.929Z,1563914228.929 [RudderServo](ERROR): Communications Fault
2019-07-23T20:37:09.032Z,1563914229.032 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-07-23T20:37:09.222Z,1563914229.222 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-07-23T20:37:09.222Z,1563914229.222 [RudderServo](INFO): Powering down
2019-07-23T20:37:09.907Z,1563914229.907 [RudderServo](DEBUG): Initializing EZServoServo.
2019-07-23T20:37:10.026Z,1563914230.026 [RudderServo](DEBUG): Initializing RudderServo.
2019-07-23T20:37:10.030Z,1563914230.030 [CBIT](INFO): Clearing failed state for component RudderServo
2019-07-23T20:37:10.030Z,1563914230.030 [RudderServo] No Fault, FailCount= 1
2019-07-23T20:37:17.698Z,1563914237.698 [CBIT](CRITICAL): Environmental Failure. Press:14.718242 PSI. Humidity:37%. Temp:26 C. ABORTING MISSION
2019-07-23T20:37:17.698Z,1563914237.698 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals
2019-07-23T20:37:18.081Z,1563914238.081 [CommandLine](FAULT): Scheduling is paused
2019-07-23T20:37:18.081Z,1563914238.081 [CBIT](INFO): Critical error at 20190723T203717
2019-07-23T20:37:34.491Z,1563914254.491 [NAL9602](INFO): Powering up NAL9602
2019-07-23T20:37:36.966Z,1563914256.966 [SBIT](IMPORTANT): Beginning Startup BIT
2019-07-23T20:37:36.970Z,1563914256.970 [CBIT](IMPORTANT): Beginning ground fault scan
2019-07-23T20:37:45.622Z,1563914265.622 [NAL9602](INFO): NAL9602 initialized
2019-07-23T20:37:46.441Z,1563914266.441 [NAL9602](DEBUG): Fix Requested
2019-07-23T20:37:47.734Z,1563914267.734 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.014907
CHAN A1 (24V): -0.198817
CHAN A2 (12V): -0.002135
CHAN A3 (5V): -0.001118
CHAN B0 (3.3V): -0.000328
CHAN B1 (3.15aV): 0.000267
CHAN B2 (3.15bV): -0.000443
CHAN B3 (GND): 0.000162
OPEN: -0.000456
Full Scale Calc: 4.765 mA, -1.589 mA
2019-07-23T20:38:30.414Z,1563914310.414 [SBIT](IMPORTANT): SBIT PASSED
2019-07-23T20:38:30.462Z,1563914310.462 [CommandLine](IMPORTANT): got command configSet list
2019-07-23T20:38:30.463Z,1563914310.463 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-07-23T20:38:30.463Z,1563914310.463 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2019-07-23T20:38:30.464Z,1563914310.464 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool;

2019-07-23T20:38:30.464Z,1563914310.464 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=0 count;

2019-07-23T20:38:30.464Z,1563914310.464 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=6 hour;

2019-07-23T20:38:30.464Z,1563914310.464 [CommandLine](IMPORTANT): CBIT.abortDepth=296 meter;

2019-07-23T20:38:30.464Z,1563914310.464 [CommandLine](IMPORTANT): CBIT.gf24Offset=172 microampere;

2019-07-23T20:38:30.464Z,1563914310.464 [CommandLine](IMPORTANT): CBIT.stopDepth=288 meter;

2019-07-23T20:38:30.464Z,1563914310.464 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;

2019-07-23T20:38:30.464Z,1563914310.464 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2019-07-23T20:38:30.465Z,1563914310.465 [CommandLine](IMPORTANT): DAT.ignoreElevationAngle=1 bool;

2019-07-23T20:38:30.465Z,1563914310.465 [CommandLine](IMPORTANT): DAT.loadAtStartup=0 bool;

2019-07-23T20:38:30.465Z,1563914310.465 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2019-07-23T20:38:30.465Z,1563914310.465 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-07-23T20:38:30.465Z,1563914310.465 [CommandLine](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2019-07-23T20:38:30.465Z,1563914310.465 [CommandLine](IMPORTANT): Express linearApproximation DAT.range 5.000000 meter;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): Express linearApproximation acoustic_contact_range 10.000000 meter;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): Express linearApproximation depth 5.000000 meter;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): Express linearApproximation latitude 0.005000 degree;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): Express linearApproximation longitude 0.005000 degree;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): NAL9602.fastGPSFix=1 bool;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=274 cubic_centimeter;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): VerticalControl.massDefault=-2.3 millimeter;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitAft=-31 millimeter;

2019-07-23T20:38:30.466Z,1563914310.466 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitFwd=30 millimeter;

2019-07-23T20:38:30.467Z,1563914310.467 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;

2019-07-23T20:38:30.757Z,1563914310.757 [MissionManager](IMPORTANT): Started mission Startup
2019-07-23T20:38:30.757Z,1563914310.757 [Startup] Running Loop=1
2019-07-23T20:38:30.758Z,1563914310.758 [Startup](DEBUG): Aggregate::initialize Startup
2019-07-23T20:38:30.758Z,1563914310.758 [Startup:A.GoToSurface] Running Loop=1
2019-07-23T20:38:30.758Z,1563914310.758 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-07-23T20:38:30.758Z,1563914310.758 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-07-23T20:38:30.759Z,1563914310.759 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-07-23T20:38:30.759Z,1563914310.759 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-07-23T20:38:30.759Z,1563914310.759 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-07-23T20:38:30.760Z,1563914310.760 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-07-23T20:38:30.765Z,1563914310.765 [Startup:StartupSatComms] Running Loop=1
2019-07-23T20:38:30.765Z,1563914310.765 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-07-23T20:38:30.765Z,1563914310.765 [Startup:StartupSatComms:A] Running Loop=1
2019-07-23T20:38:31.180Z,1563914311.180 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-07-23T20:39:07.552Z,1563914347.552 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:39:07.552Z,1563914347.552 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-07-23T20:39:07.552Z,1563914347.552 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:39:07.564Z,1563914347.564 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:39:08.008Z,1563914348.008 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:39:08.008Z,1563914348.008 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-07-23T20:39:30.974Z,1563914370.974 [Startup:StartupSatComms:A](INFO): Timed out from 2019-07-23T20:38:30.8Z
2019-07-23T20:39:30.975Z,1563914370.975 [Startup:StartupSatComms:A] Stopped
2019-07-23T20:39:30.975Z,1563914370.975 [Startup:StartupSatComms:B] Running Loop=1
2019-07-23T20:39:31.383Z,1563914371.383 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-07-23T20:39:41.535Z,1563914381.535 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004835
2019-07-23T20:39:45.375Z,1563914385.375 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T202012/Courier0010.lzma
2019-07-23T20:39:45.526Z,1563914385.526 [DataOverHttps](INFO): Moved sent file to Logs/20190723T202012/Courier0010.lzma.bak
2019-07-23T20:39:45.527Z,1563914385.527 [DataOverHttps](INFO): SBD MOMSN=11466273
2019-07-23T20:39:53.028Z,1563914393.028 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20190723T203657/Courier0000.lzma
2019-07-23T20:39:53.130Z,1563914393.130 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0000.lzma.bak
2019-07-23T20:39:53.130Z,1563914393.130 [DataOverHttps](INFO): SBD MOMSN=11466275
2019-07-23T20:40:00.749Z,1563914400.749 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20190723T202012/Express0011.lzma
2019-07-23T20:40:00.851Z,1563914400.851 [DataOverHttps](INFO): Moved sent file to Logs/20190723T202012/Express0011.lzma.bak
2019-07-23T20:40:00.851Z,1563914400.851 [DataOverHttps](INFO): SBD MOMSN=11466279
2019-07-23T20:40:08.677Z,1563914408.677 [DataOverHttps](INFO): Sending 547 bytes from file Logs/20190723T203657/Express0001.lzma
2019-07-23T20:40:08.778Z,1563914408.778 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0001.lzma.bak
2019-07-23T20:40:08.778Z,1563914408.778 [DataOverHttps](INFO): SBD MOMSN=11466283
2019-07-23T20:40:09.769Z,1563914409.769 [Startup:StartupSatComms:B] Stopped
2019-07-23T20:40:09.770Z,1563914409.770 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-07-23T20:40:09.770Z,1563914409.770 [Startup:StartupSatComms] Stopped
2019-07-23T20:40:09.770Z,1563914409.770 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-07-23T20:40:09.770Z,1563914409.770 [Startup](INFO): Completed Startup
2019-07-23T20:40:09.771Z,1563914409.771 [MissionManager](INFO): Startup is completed.
2019-07-23T20:40:09.771Z,1563914409.771 [MissionManager](INFO): Uninitializing Mission Startup
2019-07-23T20:40:09.771Z,1563914409.771 [Startup] Stopped
2019-07-23T20:40:09.771Z,1563914409.771 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-07-23T20:40:09.771Z,1563914409.771 [Startup:A.GoToSurface] Stopped
2019-07-23T20:40:09.771Z,1563914409.771 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-07-23T20:40:10.185Z,1563914410.185 [MissionManager](IMPORTANT): Started mission Default
2019-07-23T20:40:10.185Z,1563914410.185 [Default] Running Loop=1
2019-07-23T20:40:10.185Z,1563914410.185 [Default](DEBUG): Aggregate::initialize Default
2019-07-23T20:40:10.185Z,1563914410.185 [Default:B.GoToSurface] Running Loop=1
2019-07-23T20:40:10.185Z,1563914410.185 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-07-23T20:40:10.185Z,1563914410.185 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-07-23T20:40:10.186Z,1563914410.186 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-07-23T20:40:10.186Z,1563914410.186 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-07-23T20:40:10.186Z,1563914410.186 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-07-23T20:40:10.187Z,1563914410.187 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-07-23T20:40:10.187Z,1563914410.187 [Default:A.Wait] Running Loop=1
2019-07-23T20:40:10.187Z,1563914410.187 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-07-23T20:40:23.510Z,1563914423.510 [Default:A.Wait](INFO): Done Waiting.
2019-07-23T20:40:23.510Z,1563914423.510 [Default:A.Wait] Stopped
2019-07-23T20:40:23.510Z,1563914423.510 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T20:40:23.903Z,1563914423.903 [Default:CheckIn] Running Loop=1
2019-07-23T20:40:23.903Z,1563914423.903 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T20:40:23.903Z,1563914423.903 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T20:40:24.319Z,1563914424.319 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-07-23T20:40:32.255Z,1563914432.255 [CommandLine](IMPORTANT): got command maintain sensor NAL9602.latitude_fix 36.797001 degree
2019-07-23T20:40:32.257Z,1563914432.257 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.latitude_fix" handled in the control thread.
2019-07-23T20:40:32.258Z,1563914432.258 [CommandLine](IMPORTANT): got command maintain sensor NAL9602.longitude_fix -121.847000 degree
2019-07-23T20:40:32.259Z,1563914432.259 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.longitude_fix" handled in the control thread.
2019-07-23T20:40:32.423Z,1563914432.423 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,NAL9602,Onboard,BPC1,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-07-23T20:40:32.804Z,1563914432.804 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:32.804Z,1563914432.804 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-07-23T20:40:32.804Z,1563914432.804 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:32.814Z,1563914432.814 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:33.228Z,1563914433.228 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:33.228Z,1563914433.228 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-07-23T20:40:34.024Z,1563914434.024 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:34.024Z,1563914434.024 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-07-23T20:40:34.024Z,1563914434.024 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:34.034Z,1563914434.034 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:34.431Z,1563914434.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:34.431Z,1563914434.431 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-07-23T20:40:35.242Z,1563914435.242 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:35.242Z,1563914435.242 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-07-23T20:40:35.242Z,1563914435.242 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:35.252Z,1563914435.252 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:35.644Z,1563914435.644 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:35.644Z,1563914435.644 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-07-23T20:40:36.457Z,1563914436.457 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:36.458Z,1563914436.458 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-07-23T20:40:36.458Z,1563914436.458 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:36.467Z,1563914436.467 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:36.862Z,1563914436.862 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:36.862Z,1563914436.862 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-07-23T20:40:37.669Z,1563914437.669 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:37.669Z,1563914437.669 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-07-23T20:40:37.669Z,1563914437.669 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:37.703Z,1563914437.703 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:38.091Z,1563914438.091 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:38.091Z,1563914438.091 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-07-23T20:40:38.875Z,1563914438.875 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:38.875Z,1563914438.875 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-07-23T20:40:38.875Z,1563914438.875 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:38.885Z,1563914438.885 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:39.276Z,1563914439.276 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:39.277Z,1563914439.277 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-07-23T20:40:40.090Z,1563914440.090 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:40.090Z,1563914440.090 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-07-23T20:40:40.090Z,1563914440.090 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:40.100Z,1563914440.100 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:40.498Z,1563914440.498 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:40.498Z,1563914440.498 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-07-23T20:40:41.313Z,1563914441.313 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:41.313Z,1563914441.313 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-07-23T20:40:41.313Z,1563914441.313 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:41.324Z,1563914441.324 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:41.735Z,1563914441.735 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:41.735Z,1563914441.735 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-07-23T20:40:42.529Z,1563914442.529 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:42.529Z,1563914442.529 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2019-07-23T20:40:42.529Z,1563914442.529 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:42.547Z,1563914442.547 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:42.942Z,1563914442.942 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:42.942Z,1563914442.942 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2019-07-23T20:40:43.723Z,1563914443.723 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:43.723Z,1563914443.723 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2019-07-23T20:40:43.723Z,1563914443.723 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:43.749Z,1563914443.749 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:44.169Z,1563914444.169 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:44.169Z,1563914444.169 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2019-07-23T20:40:44.934Z,1563914444.934 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2019-07-23T20:40:44.935Z,1563914444.935 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2019-07-23T20:40:44.935Z,1563914444.935 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:40:44.957Z,1563914444.957 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:45.381Z,1563914445.381 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:40:45.381Z,1563914445.381 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2019-07-23T20:40:46.127Z,1563914446.127 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1563914368.000000 second
2019-07-23T20:40:46.156Z,1563914446.156 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T20:40:46.156Z,1563914446.156 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T20:40:46.592Z,1563914446.592 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-07-23T20:40:49.901Z,1563914449.901 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0004.lzma
2019-07-23T20:40:50.010Z,1563914450.010 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0004.lzma.bak
2019-07-23T20:40:50.010Z,1563914450.010 [DataOverHttps](INFO): SBD MOMSN=11466293
2019-07-23T20:40:58.346Z,1563914458.346 [DataOverHttps](INFO): Sending 759 bytes from file Logs/20190723T203657/Express0005.lzma
2019-07-23T20:40:58.498Z,1563914458.498 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0005.lzma.bak
2019-07-23T20:40:58.498Z,1563914458.498 [DataOverHttps](INFO): SBD MOMSN=11466295
2019-07-23T20:40:59.678Z,1563914459.678 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T20:40:59.679Z,1563914459.679 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T20:40:59.679Z,1563914459.679 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T20:42:46.023Z,1563914566.023 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:42:46.023Z,1563914566.023 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-07-23T20:42:46.023Z,1563914566.023 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:42:46.033Z,1563914566.033 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:42:46.387Z,1563914566.387 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:42:46.387Z,1563914566.387 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-07-23T20:42:48.774Z,1563914568.774 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T20:43:19.474Z,1563914599.474 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T20:44:38.719Z,1563914678.719 [BPC1](ERROR): Battery stick #61 (s/n: 027F) reported OVER_TEMP_ALARM. Status code: 0x1717.
2019-07-23T20:44:38.720Z,1563914678.720 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 6.
2019-07-23T20:44:38.723Z,1563914678.723 [BPC1](INFO): Received data from all battery sticks.
2019-07-23T20:44:46.797Z,1563914686.797 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:44:46.797Z,1563914686.797 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-07-23T20:44:46.797Z,1563914686.797 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:44:46.807Z,1563914686.807 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:44:47.250Z,1563914687.250 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:44:47.250Z,1563914687.250 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-07-23T20:46:00.355Z,1563914760.355 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T20:46:00.355Z,1563914760.355 [Default:CheckIn:C.Wait] Stopped
2019-07-23T20:46:00.355Z,1563914760.355 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T20:46:00.355Z,1563914760.355 [Default:CheckIn:D] Running Loop=1
2019-07-23T20:46:00.759Z,1563914760.759 [Default:CheckIn:D] Stopped
2019-07-23T20:46:00.759Z,1563914760.759 [Default:CheckIn:E] Running Loop=1
2019-07-23T20:46:01.171Z,1563914761.171 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 5.842906 min 
2019-07-23T20:46:01.171Z,1563914761.171 [Default:CheckIn:E] Stopped
2019-07-23T20:46:01.171Z,1563914761.171 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T20:46:01.171Z,1563914761.171 [Default:CheckIn] Stopped
2019-07-23T20:46:01.172Z,1563914761.172 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T20:46:01.172Z,1563914761.172 [Default:CheckIn](INFO): Running loop #2
2019-07-23T20:46:01.172Z,1563914761.172 [Default:CheckIn] Running Loop=2
2019-07-23T20:46:01.172Z,1563914761.172 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T20:46:01.172Z,1563914761.172 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T20:46:02.777Z,1563914762.777 [NAL9602](DEBUG): Fix Requested
2019-07-23T20:46:47.661Z,1563914807.661 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:46:47.661Z,1563914807.661 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-07-23T20:46:47.661Z,1563914807.661 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:46:47.672Z,1563914807.672 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:46:48.075Z,1563914808.075 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:46:48.075Z,1563914808.075 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-07-23T20:48:48.522Z,1563914928.522 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:48:48.522Z,1563914928.522 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-07-23T20:48:48.522Z,1563914928.522 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:48:48.533Z,1563914928.533 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:48:48.925Z,1563914928.925 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:48:48.925Z,1563914928.925 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-07-23T20:50:49.345Z,1563915049.345 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:50:49.345Z,1563915049.345 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-07-23T20:50:49.345Z,1563915049.345 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:50:49.356Z,1563915049.356 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:50:49.764Z,1563915049.764 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:50:49.765Z,1563915049.765 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-07-23T20:51:01.472Z,1563915061.472 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T20:46:01.2Z
2019-07-23T20:51:01.472Z,1563915061.472 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T20:51:01.472Z,1563915061.472 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T20:51:05.278Z,1563915065.278 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T20:51:05.968Z,1563915065.968 [DataOverHttps](INFO): Sending 237 bytes from file Logs/20190723T203657/Courier0007.lzma
2019-07-23T20:51:06.074Z,1563915066.074 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0007.lzma.bak
2019-07-23T20:51:06.074Z,1563915066.074 [DataOverHttps](INFO): SBD MOMSN=11466361
2019-07-23T20:51:13.786Z,1563915073.786 [DataOverHttps](INFO): Sending 545 bytes from file Logs/20190723T203657/Express0008.lzma
2019-07-23T20:51:13.894Z,1563915073.894 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0008.lzma.bak
2019-07-23T20:51:13.894Z,1563915073.894 [DataOverHttps](INFO): SBD MOMSN=11466363
2019-07-23T20:51:15.002Z,1563915075.002 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T20:51:15.003Z,1563915075.003 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T20:51:15.003Z,1563915075.003 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T20:51:36.021Z,1563915096.021 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T20:52:50.416Z,1563915170.416 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:52:50.416Z,1563915170.416 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-07-23T20:52:50.417Z,1563915170.417 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:52:50.427Z,1563915170.427 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:52:50.850Z,1563915170.850 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:52:50.850Z,1563915170.850 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-07-23T20:54:51.258Z,1563915291.258 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:54:51.258Z,1563915291.258 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-07-23T20:54:51.258Z,1563915291.258 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:54:51.268Z,1563915291.268 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:54:51.669Z,1563915291.669 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:54:51.669Z,1563915291.669 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-07-23T20:56:15.712Z,1563915375.712 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T20:56:15.713Z,1563915375.713 [Default:CheckIn:C.Wait] Stopped
2019-07-23T20:56:15.713Z,1563915375.713 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T20:56:15.713Z,1563915375.713 [Default:CheckIn:D] Running Loop=1
2019-07-23T20:56:16.114Z,1563915376.114 [Default:CheckIn:D] Stopped
2019-07-23T20:56:16.114Z,1563915376.114 [Default:CheckIn:E] Running Loop=1
2019-07-23T20:56:16.514Z,1563915376.514 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.098812 min 
2019-07-23T20:56:16.515Z,1563915376.515 [Default:CheckIn:E] Stopped
2019-07-23T20:56:16.515Z,1563915376.515 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T20:56:16.515Z,1563915376.515 [Default:CheckIn] Stopped
2019-07-23T20:56:16.515Z,1563915376.515 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T20:56:16.515Z,1563915376.515 [Default:CheckIn](INFO): Running loop #3
2019-07-23T20:56:16.515Z,1563915376.515 [Default:CheckIn] Running Loop=3
2019-07-23T20:56:16.515Z,1563915376.515 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T20:56:16.515Z,1563915376.515 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T20:56:18.114Z,1563915378.114 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T20:56:18.114Z,1563915378.114 [NAL9602] Data Fault, FailCount= 1
2019-07-23T20:56:18.115Z,1563915378.115 [NAL9602](ERROR): Data Fault
2019-07-23T20:56:18.146Z,1563915378.146 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T20:56:18.516Z,1563915378.516 [NAL9602](INFO): Powering down
2019-07-23T20:56:19.356Z,1563915379.356 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T20:56:19.356Z,1563915379.356 [NAL9602] No Fault, FailCount= 1
2019-07-23T20:56:48.836Z,1563915408.836 [NAL9602](INFO): Powering up NAL9602
2019-07-23T20:56:52.093Z,1563915412.093 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:56:52.093Z,1563915412.093 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-07-23T20:56:52.093Z,1563915412.093 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:56:52.112Z,1563915412.112 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:56:52.517Z,1563915412.517 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:56:52.517Z,1563915412.517 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-07-23T20:56:59.744Z,1563915419.744 [NAL9602](INFO): NAL9602 initialized
2019-07-23T20:57:00.557Z,1563915420.557 [NAL9602](DEBUG): Fix Requested
2019-07-23T20:58:53.352Z,1563915533.352 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T20:58:53.353Z,1563915533.353 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-07-23T20:58:53.353Z,1563915533.353 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T20:58:53.374Z,1563915533.374 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T20:58:53.726Z,1563915533.726 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T20:58:53.726Z,1563915533.726 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-07-23T21:00:54.526Z,1563915654.526 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:00:54.526Z,1563915654.526 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2019-07-23T21:00:54.526Z,1563915654.526 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:00:54.537Z,1563915654.537 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:00:54.923Z,1563915654.923 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:00:54.923Z,1563915654.923 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2019-07-23T21:01:16.734Z,1563915676.734 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T20:56:16.5Z
2019-07-23T21:01:16.734Z,1563915676.734 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T21:01:16.734Z,1563915676.734 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T21:01:21.188Z,1563915681.188 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0010.lzma
2019-07-23T21:01:21.290Z,1563915681.290 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0010.lzma.bak
2019-07-23T21:01:21.290Z,1563915681.290 [DataOverHttps](INFO): SBD MOMSN=11466385
2019-07-23T21:01:29.168Z,1563915689.168 [DataOverHttps](INFO): Sending 284 bytes from file Logs/20190723T203657/Express0011.lzma
2019-07-23T21:01:29.270Z,1563915689.270 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0011.lzma.bak
2019-07-23T21:01:29.270Z,1563915689.270 [DataOverHttps](INFO): SBD MOMSN=11466391
2019-07-23T21:01:30.562Z,1563915690.562 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T21:01:30.562Z,1563915690.562 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T21:01:30.562Z,1563915690.562 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T21:02:03.246Z,1563915723.246 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T21:02:33.969Z,1563915753.969 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T21:02:55.410Z,1563915775.410 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:02:55.410Z,1563915775.410 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2019-07-23T21:02:55.410Z,1563915775.410 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:02:55.421Z,1563915775.421 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:02:55.822Z,1563915775.822 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:02:55.822Z,1563915775.822 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2019-07-23T21:04:56.625Z,1563915896.625 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:04:56.625Z,1563915896.625 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2019-07-23T21:04:56.625Z,1563915896.625 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:04:56.636Z,1563915896.636 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:04:57.046Z,1563915897.046 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:04:57.046Z,1563915897.046 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2019-07-23T21:06:31.201Z,1563915991.201 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T21:06:31.201Z,1563915991.201 [Default:CheckIn:C.Wait] Stopped
2019-07-23T21:06:31.201Z,1563915991.201 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T21:06:31.201Z,1563915991.201 [Default:CheckIn:D] Running Loop=1
2019-07-23T21:06:31.596Z,1563915991.596 [Default:CheckIn:D] Stopped
2019-07-23T21:06:31.596Z,1563915991.596 [Default:CheckIn:E] Running Loop=1
2019-07-23T21:06:32.004Z,1563915992.004 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 26.356852 min 
2019-07-23T21:06:32.004Z,1563915992.004 [Default:CheckIn:E] Stopped
2019-07-23T21:06:32.004Z,1563915992.004 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T21:06:32.004Z,1563915992.004 [Default:CheckIn] Stopped
2019-07-23T21:06:32.004Z,1563915992.004 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T21:06:32.005Z,1563915992.005 [Default:CheckIn](INFO): Running loop #4
2019-07-23T21:06:32.005Z,1563915992.005 [Default:CheckIn] Running Loop=4
2019-07-23T21:06:32.005Z,1563915992.005 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T21:06:32.005Z,1563915992.005 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T21:06:33.605Z,1563915993.605 [NAL9602](DEBUG): Fix Requested
2019-07-23T21:06:57.871Z,1563916017.871 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:06:57.871Z,1563916017.871 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2019-07-23T21:06:57.871Z,1563916017.871 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:06:57.882Z,1563916017.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:06:58.294Z,1563916018.294 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:06:58.294Z,1563916018.294 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2019-07-23T21:08:58.705Z,1563916138.705 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:08:58.706Z,1563916138.706 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2019-07-23T21:08:58.706Z,1563916138.706 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:08:58.717Z,1563916138.717 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:08:59.120Z,1563916139.120 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:08:59.120Z,1563916139.120 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2019-07-23T21:10:59.569Z,1563916259.569 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:10:59.570Z,1563916259.570 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2019-07-23T21:10:59.570Z,1563916259.570 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:10:59.581Z,1563916259.581 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:10:59.975Z,1563916259.975 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:10:59.975Z,1563916259.975 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2019-07-23T21:11:32.316Z,1563916292.316 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T21:06:32.0Z
2019-07-23T21:11:32.316Z,1563916292.316 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T21:11:32.316Z,1563916292.316 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T21:11:36.014Z,1563916296.014 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T21:11:36.776Z,1563916296.776 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0013.lzma
2019-07-23T21:11:36.878Z,1563916296.878 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0013.lzma.bak
2019-07-23T21:11:36.878Z,1563916296.878 [DataOverHttps](INFO): SBD MOMSN=11466408
2019-07-23T21:11:44.693Z,1563916304.693 [DataOverHttps](INFO): Sending 265 bytes from file Logs/20190723T203657/Express0014.lzma
2019-07-23T21:11:44.806Z,1563916304.806 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0014.lzma.bak
2019-07-23T21:11:44.806Z,1563916304.806 [DataOverHttps](INFO): SBD MOMSN=11466410
2019-07-23T21:11:45.782Z,1563916305.782 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T21:11:45.782Z,1563916305.782 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T21:11:45.782Z,1563916305.782 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T21:12:06.717Z,1563916326.717 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T21:13:00.502Z,1563916380.502 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:13:00.502Z,1563916380.502 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2019-07-23T21:13:00.502Z,1563916380.502 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:13:00.512Z,1563916380.512 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:13:00.927Z,1563916380.927 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:13:00.927Z,1563916380.927 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2019-07-23T21:15:01.357Z,1563916501.357 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:15:01.357Z,1563916501.357 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2019-07-23T21:15:01.357Z,1563916501.357 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:15:01.368Z,1563916501.368 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:15:01.734Z,1563916501.734 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:15:01.734Z,1563916501.734 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2019-07-23T21:16:46.423Z,1563916606.423 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T21:16:46.424Z,1563916606.424 [Default:CheckIn:C.Wait] Stopped
2019-07-23T21:16:46.424Z,1563916606.424 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T21:16:46.424Z,1563916606.424 [Default:CheckIn:D] Running Loop=1
2019-07-23T21:16:46.823Z,1563916606.823 [Default:CheckIn:D] Stopped
2019-07-23T21:16:46.823Z,1563916606.823 [Default:CheckIn:E] Running Loop=1
2019-07-23T21:16:47.234Z,1563916607.234 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.610640 min 
2019-07-23T21:16:47.234Z,1563916607.234 [Default:CheckIn:E] Stopped
2019-07-23T21:16:47.234Z,1563916607.234 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T21:16:47.234Z,1563916607.234 [Default:CheckIn] Stopped
2019-07-23T21:16:47.234Z,1563916607.234 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T21:16:47.235Z,1563916607.235 [Default:CheckIn](INFO): Running loop #5
2019-07-23T21:16:47.235Z,1563916607.235 [Default:CheckIn] Running Loop=5
2019-07-23T21:16:47.235Z,1563916607.235 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T21:16:47.235Z,1563916607.235 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T21:16:48.822Z,1563916608.822 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T21:16:48.822Z,1563916608.822 [NAL9602] Data Fault, FailCount= 2
2019-07-23T21:16:48.822Z,1563916608.822 [NAL9602](ERROR): Data Fault
2019-07-23T21:16:48.860Z,1563916608.860 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T21:16:49.237Z,1563916609.237 [NAL9602](INFO): Powering down
2019-07-23T21:16:50.068Z,1563916610.068 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T21:16:50.068Z,1563916610.068 [NAL9602] No Fault, FailCount= 2
2019-07-23T21:17:02.177Z,1563916622.177 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:17:02.178Z,1563916622.178 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2019-07-23T21:17:02.178Z,1563916622.178 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:17:02.188Z,1563916622.188 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:17:02.587Z,1563916622.587 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:17:02.587Z,1563916622.587 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2019-07-23T21:17:19.526Z,1563916639.526 [NAL9602](INFO): Powering up NAL9602
2019-07-23T21:17:30.458Z,1563916650.458 [NAL9602](INFO): NAL9602 initialized
2019-07-23T21:17:31.281Z,1563916651.281 [NAL9602](DEBUG): Fix Requested
2019-07-23T21:19:03.045Z,1563916743.045 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:19:03.046Z,1563916743.046 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2019-07-23T21:19:03.046Z,1563916743.046 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:19:03.056Z,1563916743.056 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:19:03.462Z,1563916743.462 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:19:03.462Z,1563916743.462 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2019-07-23T21:21:03.906Z,1563916863.906 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:21:03.906Z,1563916863.906 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2019-07-23T21:21:03.906Z,1563916863.906 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:21:03.917Z,1563916863.917 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:21:03.917Z,1563916863.917 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:21:47.558Z,1563916907.558 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T21:16:47.2Z
2019-07-23T21:21:47.558Z,1563916907.558 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T21:21:47.558Z,1563916907.558 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T21:21:51.968Z,1563916911.968 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0016.lzma
2019-07-23T21:21:52.071Z,1563916912.071 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0016.lzma.bak
2019-07-23T21:21:52.071Z,1563916912.071 [DataOverHttps](INFO): SBD MOMSN=11466437
2019-07-23T21:21:59.944Z,1563916919.944 [DataOverHttps](INFO): Sending 344 bytes from file Logs/20190723T203657/Express0017.lzma
2019-07-23T21:22:00.046Z,1563916920.046 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0017.lzma.bak
2019-07-23T21:22:00.046Z,1563916920.046 [DataOverHttps](INFO): SBD MOMSN=11466439
2019-07-23T21:22:00.989Z,1563916920.989 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T21:22:00.989Z,1563916920.989 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T21:22:00.990Z,1563916920.990 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T21:22:33.686Z,1563916953.686 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T21:23:04.391Z,1563916984.391 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T21:27:01.642Z,1563917221.642 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T21:27:01.642Z,1563917221.642 [Default:CheckIn:C.Wait] Stopped
2019-07-23T21:27:01.642Z,1563917221.642 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T21:27:01.642Z,1563917221.642 [Default:CheckIn:D] Running Loop=1
2019-07-23T21:27:02.055Z,1563917222.055 [Default:CheckIn:D] Stopped
2019-07-23T21:27:02.055Z,1563917222.055 [Default:CheckIn:E] Running Loop=1
2019-07-23T21:27:02.454Z,1563917222.454 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.864494 min 
2019-07-23T21:27:02.454Z,1563917222.454 [Default:CheckIn:E] Stopped
2019-07-23T21:27:02.454Z,1563917222.454 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T21:27:02.455Z,1563917222.455 [Default:CheckIn] Stopped
2019-07-23T21:27:02.455Z,1563917222.455 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T21:27:02.455Z,1563917222.455 [Default:CheckIn](INFO): Running loop #6
2019-07-23T21:27:02.455Z,1563917222.455 [Default:CheckIn] Running Loop=6
2019-07-23T21:27:02.455Z,1563917222.455 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T21:27:02.455Z,1563917222.455 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T21:27:04.061Z,1563917224.061 [NAL9602](DEBUG): Fix Requested
2019-07-23T21:32:02.730Z,1563917522.730 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T21:27:02.5Z
2019-07-23T21:32:02.731Z,1563917522.731 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T21:32:02.731Z,1563917522.731 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T21:32:06.806Z,1563917526.806 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T21:32:07.376Z,1563917527.376 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0019.lzma
2019-07-23T21:32:07.478Z,1563917527.478 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0019.lzma.bak
2019-07-23T21:32:07.478Z,1563917527.478 [DataOverHttps](INFO): SBD MOMSN=11466472
2019-07-23T21:32:15.224Z,1563917535.224 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20190723T203657/Express0020.lzma
2019-07-23T21:32:15.326Z,1563917535.326 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0020.lzma.bak
2019-07-23T21:32:15.326Z,1563917535.326 [DataOverHttps](INFO): SBD MOMSN=11466474
2019-07-23T21:32:16.557Z,1563917536.557 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T21:32:16.557Z,1563917536.557 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T21:32:16.557Z,1563917536.557 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T21:32:37.506Z,1563917557.506 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T21:36:04.056Z,1563917764.056 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:36:04.056Z,1563917764.056 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2019-07-23T21:37:17.187Z,1563917837.187 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T21:37:17.188Z,1563917837.188 [Default:CheckIn:C.Wait] Stopped
2019-07-23T21:37:17.188Z,1563917837.188 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T21:37:17.188Z,1563917837.188 [Default:CheckIn:D] Running Loop=1
2019-07-23T21:37:17.592Z,1563917837.592 [Default:CheckIn:D] Stopped
2019-07-23T21:37:17.593Z,1563917837.593 [Default:CheckIn:E] Running Loop=1
2019-07-23T21:37:18.004Z,1563917838.004 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.123458 min 
2019-07-23T21:37:18.005Z,1563917838.005 [Default:CheckIn:E] Stopped
2019-07-23T21:37:18.005Z,1563917838.005 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T21:37:18.005Z,1563917838.005 [Default:CheckIn] Stopped
2019-07-23T21:37:18.006Z,1563917838.006 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T21:37:18.006Z,1563917838.006 [Default:CheckIn](INFO): Running loop #7
2019-07-23T21:37:18.006Z,1563917838.006 [Default:CheckIn] Running Loop=7
2019-07-23T21:37:18.006Z,1563917838.006 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T21:37:18.006Z,1563917838.006 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T21:37:19.594Z,1563917839.594 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T21:37:19.594Z,1563917839.594 [NAL9602] Data Fault, FailCount= 3
2019-07-23T21:37:19.594Z,1563917839.594 [NAL9602](ERROR): Data Fault
2019-07-23T21:37:19.633Z,1563917839.633 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T21:37:19.994Z,1563917839.994 [NAL9602](INFO): Powering down
2019-07-23T21:37:20.867Z,1563917840.867 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T21:37:20.867Z,1563917840.867 [NAL9602] No Fault, FailCount= 3
2019-07-23T21:37:50.302Z,1563917870.302 [NAL9602](INFO): Powering up NAL9602
2019-07-23T21:38:01.214Z,1563917881.214 [NAL9602](INFO): NAL9602 initialized
2019-07-23T21:38:02.029Z,1563917882.029 [NAL9602](DEBUG): Fix Requested
2019-07-23T21:38:04.477Z,1563917884.477 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:38:04.477Z,1563917884.477 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-07-23T21:38:04.477Z,1563917884.477 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:38:04.487Z,1563917884.487 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:38:04.891Z,1563917884.891 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:38:04.891Z,1563917884.891 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-07-23T21:40:05.330Z,1563918005.330 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:40:05.330Z,1563918005.330 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-07-23T21:40:05.330Z,1563918005.330 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:40:05.341Z,1563918005.341 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:40:05.787Z,1563918005.787 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:40:05.787Z,1563918005.787 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-07-23T21:42:06.217Z,1563918126.217 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:42:06.217Z,1563918126.217 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-07-23T21:42:06.217Z,1563918126.217 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:42:06.232Z,1563918126.232 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:42:06.614Z,1563918126.614 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:42:06.614Z,1563918126.614 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-07-23T21:42:18.333Z,1563918138.333 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T21:37:18.0Z
2019-07-23T21:42:18.333Z,1563918138.333 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T21:42:18.333Z,1563918138.333 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T21:42:23.112Z,1563918143.112 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0022.lzma
2019-07-23T21:42:23.216Z,1563918143.216 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0022.lzma.bak
2019-07-23T21:42:23.216Z,1563918143.216 [DataOverHttps](INFO): SBD MOMSN=11466485
2019-07-23T21:42:31.364Z,1563918151.364 [DataOverHttps](INFO): Sending 270 bytes from file Logs/20190723T203657/Express0023.lzma
2019-07-23T21:42:31.466Z,1563918151.466 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0023.lzma.bak
2019-07-23T21:42:31.466Z,1563918151.466 [DataOverHttps](INFO): SBD MOMSN=11466487
2019-07-23T21:42:32.555Z,1563918152.555 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T21:42:32.555Z,1563918152.555 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T21:42:32.555Z,1563918152.555 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T21:43:04.838Z,1563918184.838 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T21:43:35.554Z,1563918215.554 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T21:44:07.134Z,1563918247.134 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:44:07.134Z,1563918247.134 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-07-23T21:44:07.134Z,1563918247.134 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:44:07.144Z,1563918247.144 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:44:07.581Z,1563918247.581 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:44:07.581Z,1563918247.581 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-07-23T21:46:07.972Z,1563918367.972 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:46:07.972Z,1563918367.972 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-07-23T21:46:07.973Z,1563918367.973 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:46:07.983Z,1563918367.983 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:46:08.368Z,1563918368.368 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:46:08.368Z,1563918368.368 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-07-23T21:47:33.212Z,1563918453.212 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T21:47:33.212Z,1563918453.212 [Default:CheckIn:C.Wait] Stopped
2019-07-23T21:47:33.212Z,1563918453.212 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T21:47:33.212Z,1563918453.212 [Default:CheckIn:D] Running Loop=1
2019-07-23T21:47:33.620Z,1563918453.620 [Default:CheckIn:D] Stopped
2019-07-23T21:47:33.620Z,1563918453.620 [Default:CheckIn:E] Running Loop=1
2019-07-23T21:47:34.032Z,1563918454.032 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.390576 min 
2019-07-23T21:47:34.032Z,1563918454.032 [Default:CheckIn:E] Stopped
2019-07-23T21:47:34.033Z,1563918454.033 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T21:47:34.033Z,1563918454.033 [Default:CheckIn] Stopped
2019-07-23T21:47:34.033Z,1563918454.033 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T21:47:34.033Z,1563918454.033 [Default:CheckIn](INFO): Running loop #8
2019-07-23T21:47:34.033Z,1563918454.033 [Default:CheckIn] Running Loop=8
2019-07-23T21:47:34.033Z,1563918454.033 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T21:47:34.033Z,1563918454.033 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T21:47:35.629Z,1563918455.629 [NAL9602](DEBUG): Fix Requested
2019-07-23T21:48:08.816Z,1563918488.816 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:48:08.816Z,1563918488.816 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-07-23T21:48:08.817Z,1563918488.817 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:48:08.827Z,1563918488.827 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:48:09.222Z,1563918489.222 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:48:09.222Z,1563918489.222 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-07-23T21:50:09.661Z,1563918609.661 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:50:09.661Z,1563918609.661 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-07-23T21:50:09.661Z,1563918609.661 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:50:09.676Z,1563918609.676 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:50:10.169Z,1563918610.169 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:50:10.169Z,1563918610.169 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-07-23T21:52:10.553Z,1563918730.553 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:52:10.553Z,1563918730.553 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-07-23T21:52:10.553Z,1563918730.553 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:52:10.587Z,1563918730.587 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:52:10.931Z,1563918730.931 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:52:10.931Z,1563918730.931 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-07-23T21:52:34.365Z,1563918754.365 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T21:47:34.0Z
2019-07-23T21:52:34.365Z,1563918754.365 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T21:52:34.365Z,1563918754.365 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T21:52:38.462Z,1563918758.462 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T21:52:39.008Z,1563918759.008 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0025.lzma
2019-07-23T21:52:39.110Z,1563918759.110 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0025.lzma.bak
2019-07-23T21:52:39.110Z,1563918759.110 [DataOverHttps](INFO): SBD MOMSN=11466503
2019-07-23T21:52:46.766Z,1563918766.766 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20190723T203657/Express0026.lzma
2019-07-23T21:52:46.868Z,1563918766.868 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0026.lzma.bak
2019-07-23T21:52:46.868Z,1563918766.868 [DataOverHttps](INFO): SBD MOMSN=11466505
2019-07-23T21:52:47.806Z,1563918767.806 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T21:52:47.806Z,1563918767.806 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T21:52:47.806Z,1563918767.806 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T21:53:09.184Z,1563918789.184 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T21:54:11.420Z,1563918851.420 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:54:11.420Z,1563918851.420 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-07-23T21:54:11.420Z,1563918851.420 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:54:11.431Z,1563918851.431 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:54:11.838Z,1563918851.838 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:54:11.838Z,1563918851.838 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-07-23T21:56:12.660Z,1563918972.660 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:56:12.660Z,1563918972.660 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2019-07-23T21:56:12.660Z,1563918972.660 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:56:12.671Z,1563918972.671 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:56:13.050Z,1563918973.050 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:56:13.050Z,1563918973.050 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2019-07-23T21:57:48.391Z,1563919068.391 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T21:57:48.391Z,1563919068.391 [Default:CheckIn:C.Wait] Stopped
2019-07-23T21:57:48.391Z,1563919068.391 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T21:57:48.391Z,1563919068.391 [Default:CheckIn:D] Running Loop=1
2019-07-23T21:57:48.805Z,1563919068.805 [Default:CheckIn:D] Stopped
2019-07-23T21:57:48.805Z,1563919068.805 [Default:CheckIn:E] Running Loop=1
2019-07-23T21:57:49.199Z,1563919069.199 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.643660 min 
2019-07-23T21:57:49.199Z,1563919069.199 [Default:CheckIn:E] Stopped
2019-07-23T21:57:49.199Z,1563919069.199 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T21:57:49.199Z,1563919069.199 [Default:CheckIn] Stopped
2019-07-23T21:57:49.199Z,1563919069.199 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T21:57:49.199Z,1563919069.199 [Default:CheckIn](INFO): Running loop #9
2019-07-23T21:57:49.199Z,1563919069.199 [Default:CheckIn] Running Loop=9
2019-07-23T21:57:49.200Z,1563919069.200 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T21:57:49.200Z,1563919069.200 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T21:57:50.790Z,1563919070.790 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T21:57:50.790Z,1563919070.790 [NAL9602] Data Fault, FailCount= 4
2019-07-23T21:57:50.790Z,1563919070.790 [NAL9602](ERROR): Data Fault
2019-07-23T21:57:50.828Z,1563919070.828 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T21:57:51.193Z,1563919071.193 [NAL9602](INFO): Powering down
2019-07-23T21:57:52.070Z,1563919072.070 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T21:57:52.070Z,1563919072.070 [NAL9602] No Fault, FailCount= 4
2019-07-23T21:58:13.858Z,1563919093.858 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T21:58:13.858Z,1563919093.858 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2019-07-23T21:58:13.858Z,1563919093.858 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T21:58:13.869Z,1563919093.869 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T21:58:14.274Z,1563919094.274 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T21:58:14.274Z,1563919094.274 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2019-07-23T21:58:21.502Z,1563919101.502 [NAL9602](INFO): Powering up NAL9602
2019-07-23T21:58:32.410Z,1563919112.410 [NAL9602](INFO): NAL9602 initialized
2019-07-23T21:58:33.227Z,1563919113.227 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:00:15.118Z,1563919215.118 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:00:15.118Z,1563919215.118 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2019-07-23T22:00:15.118Z,1563919215.118 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:00:15.129Z,1563919215.129 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:00:15.527Z,1563919215.527 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:00:15.527Z,1563919215.527 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2019-07-23T22:02:16.354Z,1563919336.354 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:02:16.354Z,1563919336.354 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2019-07-23T22:02:16.354Z,1563919336.354 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:02:16.365Z,1563919336.365 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:02:16.751Z,1563919336.751 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:02:16.751Z,1563919336.751 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2019-07-23T22:02:49.472Z,1563919369.472 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T21:57:49.2Z
2019-07-23T22:02:49.472Z,1563919369.472 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T22:02:49.472Z,1563919369.472 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T22:02:53.862Z,1563919373.862 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0028.lzma
2019-07-23T22:02:54.178Z,1563919374.178 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0028.lzma.bak
2019-07-23T22:02:54.178Z,1563919374.178 [DataOverHttps](INFO): SBD MOMSN=11466545
2019-07-23T22:03:01.910Z,1563919381.910 [DataOverHttps](INFO): Sending 284 bytes from file Logs/20190723T203657/Express0029.lzma
2019-07-23T22:03:02.006Z,1563919382.006 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0029.lzma.bak
2019-07-23T22:03:02.006Z,1563919382.006 [DataOverHttps](INFO): SBD MOMSN=11466547
2019-07-23T22:03:03.323Z,1563919383.323 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T22:03:03.323Z,1563919383.323 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T22:03:03.323Z,1563919383.323 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T22:03:35.998Z,1563919415.998 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T22:04:06.718Z,1563919446.718 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T22:04:17.248Z,1563919457.248 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:04:17.249Z,1563919457.249 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2019-07-23T22:04:17.249Z,1563919457.249 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:04:17.259Z,1563919457.259 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:04:17.667Z,1563919457.667 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:04:17.667Z,1563919457.667 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2019-07-23T22:06:18.141Z,1563919578.141 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:06:18.141Z,1563919578.141 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2019-07-23T22:06:18.141Z,1563919578.141 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:06:18.194Z,1563919578.194 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:06:18.613Z,1563919578.613 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:06:18.613Z,1563919578.613 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2019-07-23T22:08:03.968Z,1563919683.968 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T22:08:03.968Z,1563919683.968 [Default:CheckIn:C.Wait] Stopped
2019-07-23T22:08:03.968Z,1563919683.968 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T22:08:03.968Z,1563919683.968 [Default:CheckIn:D] Running Loop=1
2019-07-23T22:08:04.376Z,1563919684.376 [Default:CheckIn:D] Stopped
2019-07-23T22:08:04.376Z,1563919684.376 [Default:CheckIn:E] Running Loop=1
2019-07-23T22:08:04.773Z,1563919684.773 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 87.903182 min 
2019-07-23T22:08:04.773Z,1563919684.773 [Default:CheckIn:E] Stopped
2019-07-23T22:08:04.773Z,1563919684.773 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T22:08:04.773Z,1563919684.773 [Default:CheckIn] Stopped
2019-07-23T22:08:04.773Z,1563919684.773 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T22:08:04.773Z,1563919684.773 [Default:CheckIn](INFO): Running loop #10
2019-07-23T22:08:04.773Z,1563919684.773 [Default:CheckIn] Running Loop=10
2019-07-23T22:08:04.774Z,1563919684.774 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T22:08:04.774Z,1563919684.774 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T22:08:06.377Z,1563919686.377 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:08:18.934Z,1563919698.934 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:08:18.934Z,1563919698.934 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2019-07-23T22:08:18.934Z,1563919698.934 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:08:18.945Z,1563919698.945 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:08:19.350Z,1563919699.350 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:08:19.350Z,1563919699.350 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2019-07-23T22:08:37.494Z,1563919717.494 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-07-23T22:08:37.577Z,1563919717.577 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-07-23T22:08:37.577Z,1563919717.577 [NAL9602] Data Fault, FailCount= 5
2019-07-23T22:08:37.577Z,1563919717.577 [NAL9602](ERROR): Data Fault
2019-07-23T22:08:37.607Z,1563919717.607 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T22:08:37.608Z,1563919717.608 [CBIT](CRITICAL): Data Fault in component: NAL9602
2019-07-23T22:08:37.898Z,1563919717.898 [NAL9602](INFO): Powering down
2019-07-23T22:08:38.009Z,1563919718.009 [CBIT](INFO): Critical error at 20190723T220837
2019-07-23T22:10:19.784Z,1563919819.784 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:10:19.785Z,1563919819.785 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2019-07-23T22:10:19.785Z,1563919819.785 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:10:19.795Z,1563919819.795 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:10:20.175Z,1563919820.175 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:10:20.175Z,1563919820.175 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2019-07-23T22:10:37.995Z,1563919837.995 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T22:10:37.995Z,1563919837.995 [NAL9602] No Fault, FailCount= 5
2019-07-23T22:10:38.338Z,1563919838.338 [NAL9602](INFO): Powering up NAL9602
2019-07-23T22:10:49.246Z,1563919849.246 [NAL9602](INFO): NAL9602 initialized
2019-07-23T22:10:50.051Z,1563919850.051 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T22:10:50.051Z,1563919850.051 [NAL9602] Data Fault, FailCount= 1
2019-07-23T22:10:50.051Z,1563919850.051 [NAL9602](ERROR): Data Fault
2019-07-23T22:10:50.082Z,1563919850.082 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T22:10:50.462Z,1563919850.462 [NAL9602](INFO): Powering down
2019-07-23T22:10:51.300Z,1563919851.300 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T22:10:51.301Z,1563919851.301 [NAL9602] No Fault, FailCount= 1
2019-07-23T22:11:20.774Z,1563919880.774 [NAL9602](INFO): Powering up NAL9602
2019-07-23T22:11:31.682Z,1563919891.682 [NAL9602](INFO): NAL9602 initialized
2019-07-23T22:11:32.497Z,1563919892.497 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:12:20.597Z,1563919940.597 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:12:20.598Z,1563919940.598 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2019-07-23T22:12:20.598Z,1563919940.598 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:12:20.609Z,1563919940.609 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:12:21.007Z,1563919941.007 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:12:21.007Z,1563919941.007 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2019-07-23T22:13:05.075Z,1563919985.075 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T22:08:04.8Z
2019-07-23T22:13:05.076Z,1563919985.076 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T22:13:05.076Z,1563919985.076 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T22:13:08.766Z,1563919988.766 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T22:13:09.512Z,1563919989.512 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20190723T203657/Courier0031.lzma
2019-07-23T22:13:09.614Z,1563919989.614 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0031.lzma.bak
2019-07-23T22:13:09.614Z,1563919989.614 [DataOverHttps](INFO): SBD MOMSN=11466601
2019-07-23T22:13:18.440Z,1563919998.440 [DataOverHttps](INFO): Sending 313 bytes from file Logs/20190723T203657/Express0032.lzma
2019-07-23T22:13:18.542Z,1563919998.542 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0032.lzma.bak
2019-07-23T22:13:18.542Z,1563919998.542 [DataOverHttps](INFO): SBD MOMSN=11466604
2019-07-23T22:13:19.738Z,1563919999.738 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T22:13:19.738Z,1563919999.738 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T22:13:19.738Z,1563919999.738 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T22:13:39.489Z,1563920019.489 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T22:14:21.549Z,1563920061.549 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:14:21.550Z,1563920061.550 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2019-07-23T22:14:21.550Z,1563920061.550 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:14:21.560Z,1563920061.560 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:14:21.963Z,1563920061.963 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:14:21.963Z,1563920061.963 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2019-07-23T22:16:22.370Z,1563920182.370 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:16:22.370Z,1563920182.370 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2019-07-23T22:16:22.370Z,1563920182.370 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:16:22.380Z,1563920182.380 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:16:22.381Z,1563920182.381 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:18:20.390Z,1563920300.390 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T22:18:20.390Z,1563920300.390 [Default:CheckIn:C.Wait] Stopped
2019-07-23T22:18:20.390Z,1563920300.390 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T22:18:20.390Z,1563920300.390 [Default:CheckIn:D] Running Loop=1
2019-07-23T22:18:20.790Z,1563920300.790 [Default:CheckIn:D] Stopped
2019-07-23T22:18:20.790Z,1563920300.790 [Default:CheckIn:E] Running Loop=1
2019-07-23T22:18:21.195Z,1563920301.195 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 98.176750 min 
2019-07-23T22:18:21.195Z,1563920301.195 [Default:CheckIn:E] Stopped
2019-07-23T22:18:21.195Z,1563920301.195 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T22:18:21.195Z,1563920301.195 [Default:CheckIn] Stopped
2019-07-23T22:18:21.195Z,1563920301.195 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T22:18:21.195Z,1563920301.195 [Default:CheckIn](INFO): Running loop #11
2019-07-23T22:18:21.195Z,1563920301.195 [Default:CheckIn] Running Loop=11
2019-07-23T22:18:21.195Z,1563920301.195 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T22:18:21.196Z,1563920301.196 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T22:18:22.801Z,1563920302.801 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:18:53.907Z,1563920333.907 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-07-23T22:18:53.981Z,1563920333.981 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-07-23T22:18:53.981Z,1563920333.981 [NAL9602] Data Fault, FailCount= 2
2019-07-23T22:18:53.981Z,1563920333.981 [NAL9602](ERROR): Data Fault
2019-07-23T22:18:54.039Z,1563920334.039 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T22:18:54.314Z,1563920334.314 [NAL9602](INFO): Powering down
2019-07-23T22:18:55.180Z,1563920335.180 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T22:18:55.181Z,1563920335.181 [NAL9602] No Fault, FailCount= 2
2019-07-23T22:19:24.614Z,1563920364.614 [NAL9602](INFO): Powering up NAL9602
2019-07-23T22:19:35.542Z,1563920375.542 [NAL9602](INFO): NAL9602 initialized
2019-07-23T22:19:36.361Z,1563920376.361 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:23:21.491Z,1563920601.491 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T22:18:21.2Z
2019-07-23T22:23:21.491Z,1563920601.491 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T22:23:21.491Z,1563920601.491 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T22:23:25.836Z,1563920605.836 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0034.lzma
2019-07-23T22:23:25.938Z,1563920605.938 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0034.lzma.bak
2019-07-23T22:23:25.938Z,1563920605.938 [DataOverHttps](INFO): SBD MOMSN=11466622
2019-07-23T22:23:26.002Z,1563920606.002 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T22:23:33.912Z,1563920613.912 [DataOverHttps](INFO): Sending 335 bytes from file Logs/20190723T203657/Express0035.lzma
2019-07-23T22:23:34.014Z,1563920614.014 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0035.lzma.bak
2019-07-23T22:23:34.014Z,1563920614.014 [DataOverHttps](INFO): SBD MOMSN=11466624
2019-07-23T22:23:35.341Z,1563920615.341 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T22:23:35.341Z,1563920615.341 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T22:23:35.341Z,1563920615.341 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T22:23:56.690Z,1563920636.690 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T22:28:36.006Z,1563920916.006 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T22:28:36.007Z,1563920916.007 [Default:CheckIn:C.Wait] Stopped
2019-07-23T22:28:36.007Z,1563920916.007 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T22:28:36.007Z,1563920916.007 [Default:CheckIn:D] Running Loop=1
2019-07-23T22:28:36.410Z,1563920916.410 [Default:CheckIn:D] Stopped
2019-07-23T22:28:36.410Z,1563920916.410 [Default:CheckIn:E] Running Loop=1
2019-07-23T22:28:36.811Z,1563920916.811 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 108.437077 min 
2019-07-23T22:28:36.811Z,1563920916.811 [Default:CheckIn:E] Stopped
2019-07-23T22:28:36.811Z,1563920916.811 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T22:28:36.811Z,1563920916.811 [Default:CheckIn] Stopped
2019-07-23T22:28:36.811Z,1563920916.811 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T22:28:36.812Z,1563920916.812 [Default:CheckIn](INFO): Running loop #12
2019-07-23T22:28:36.812Z,1563920916.812 [Default:CheckIn] Running Loop=12
2019-07-23T22:28:36.812Z,1563920916.812 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T22:28:36.812Z,1563920916.812 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T22:28:38.406Z,1563920918.406 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T22:28:38.406Z,1563920918.406 [NAL9602] Data Fault, FailCount= 3
2019-07-23T22:28:38.406Z,1563920918.406 [NAL9602](ERROR): Data Fault
2019-07-23T22:28:38.442Z,1563920918.442 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T22:28:38.810Z,1563920918.810 [NAL9602](INFO): Powering down
2019-07-23T22:28:39.658Z,1563920919.658 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T22:28:39.658Z,1563920919.658 [NAL9602] No Fault, FailCount= 3
2019-07-23T22:29:09.126Z,1563920949.126 [NAL9602](INFO): Powering up NAL9602
2019-07-23T22:29:20.034Z,1563920960.034 [NAL9602](INFO): NAL9602 initialized
2019-07-23T22:29:20.857Z,1563920960.857 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:31:22.516Z,1563921082.516 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:31:22.516Z,1563921082.516 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2019-07-23T22:33:22.946Z,1563921202.946 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:33:22.946Z,1563921202.946 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-07-23T22:33:22.947Z,1563921202.947 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:33:22.957Z,1563921202.957 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:33:23.360Z,1563921203.360 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:33:23.360Z,1563921203.360 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-07-23T22:33:37.085Z,1563921217.085 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T22:28:36.8Z
2019-07-23T22:33:37.085Z,1563921217.085 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T22:33:37.085Z,1563921217.085 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T22:33:41.552Z,1563921221.552 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0037.lzma
2019-07-23T22:33:41.654Z,1563921221.654 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0037.lzma.bak
2019-07-23T22:33:41.654Z,1563921221.654 [DataOverHttps](INFO): SBD MOMSN=11466657
2019-07-23T22:33:49.416Z,1563921229.416 [DataOverHttps](INFO): Sending 261 bytes from file Logs/20190723T203657/Express0038.lzma
2019-07-23T22:33:49.518Z,1563921229.518 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0038.lzma.bak
2019-07-23T22:33:49.518Z,1563921229.518 [DataOverHttps](INFO): SBD MOMSN=11466659
2019-07-23T22:33:50.535Z,1563921230.535 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T22:33:50.535Z,1563921230.535 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T22:33:50.535Z,1563921230.535 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T22:34:23.642Z,1563921263.642 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T22:34:54.354Z,1563921294.354 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T22:35:23.863Z,1563921323.863 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:35:23.863Z,1563921323.863 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-07-23T22:35:23.863Z,1563921323.863 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:35:23.906Z,1563921323.906 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:35:24.279Z,1563921324.279 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:35:24.279Z,1563921324.279 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-07-23T22:37:24.714Z,1563921444.714 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:37:24.714Z,1563921444.714 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-07-23T22:37:24.714Z,1563921444.714 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:37:24.725Z,1563921444.725 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:37:25.173Z,1563921445.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:37:25.173Z,1563921445.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-07-23T22:38:51.184Z,1563921531.184 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T22:38:51.184Z,1563921531.184 [Default:CheckIn:C.Wait] Stopped
2019-07-23T22:38:51.184Z,1563921531.184 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T22:38:51.184Z,1563921531.184 [Default:CheckIn:D] Running Loop=1
2019-07-23T22:38:51.588Z,1563921531.588 [Default:CheckIn:D] Stopped
2019-07-23T22:38:51.588Z,1563921531.588 [Default:CheckIn:E] Running Loop=1
2019-07-23T22:38:52.004Z,1563921532.004 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 118.690047 min 
2019-07-23T22:38:52.004Z,1563921532.004 [Default:CheckIn:E] Stopped
2019-07-23T22:38:52.004Z,1563921532.004 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T22:38:52.004Z,1563921532.004 [Default:CheckIn] Stopped
2019-07-23T22:38:52.005Z,1563921532.005 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T22:38:52.005Z,1563921532.005 [Default:CheckIn](INFO): Running loop #13
2019-07-23T22:38:52.005Z,1563921532.005 [Default:CheckIn] Running Loop=13
2019-07-23T22:38:52.005Z,1563921532.005 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T22:38:52.005Z,1563921532.005 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T22:38:53.605Z,1563921533.605 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:39:24.698Z,1563921564.698 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-07-23T22:39:24.781Z,1563921564.781 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-07-23T22:39:24.781Z,1563921564.781 [NAL9602] Data Fault, FailCount= 4
2019-07-23T22:39:24.781Z,1563921564.781 [NAL9602](ERROR): Data Fault
2019-07-23T22:39:24.816Z,1563921564.816 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T22:39:25.102Z,1563921565.102 [NAL9602](INFO): Powering down
2019-07-23T22:39:25.996Z,1563921565.996 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:39:25.997Z,1563921565.997 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-07-23T22:39:25.997Z,1563921565.997 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:39:26.007Z,1563921566.007 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:39:26.007Z,1563921566.007 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T22:39:26.007Z,1563921566.007 [NAL9602] No Fault, FailCount= 4
2019-07-23T22:39:26.373Z,1563921566.373 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:39:26.373Z,1563921566.373 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-07-23T22:39:55.422Z,1563921595.422 [NAL9602](INFO): Powering up NAL9602
2019-07-23T22:40:06.334Z,1563921606.334 [NAL9602](INFO): NAL9602 initialized
2019-07-23T22:40:07.138Z,1563921607.138 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T22:40:07.138Z,1563921607.138 [NAL9602] Data Fault, FailCount= 5
2019-07-23T22:40:07.138Z,1563921607.138 [NAL9602](ERROR): Data Fault
2019-07-23T22:40:07.177Z,1563921607.177 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T22:40:07.178Z,1563921607.178 [CBIT](CRITICAL): Data Fault in component: NAL9602
2019-07-23T22:40:07.542Z,1563921607.542 [NAL9602](INFO): Powering down
2019-07-23T22:40:07.578Z,1563921607.578 [CBIT](INFO): Critical error at 20190723T224007
2019-07-23T22:41:26.788Z,1563921686.788 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:41:26.788Z,1563921686.788 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-07-23T22:41:26.801Z,1563921686.801 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:41:26.819Z,1563921686.819 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:41:27.221Z,1563921687.221 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:41:27.221Z,1563921687.221 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-07-23T22:42:07.203Z,1563921727.203 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T22:42:07.203Z,1563921727.203 [NAL9602] No Fault, FailCount= 5
2019-07-23T22:42:07.574Z,1563921727.574 [NAL9602](INFO): Powering up NAL9602
2019-07-23T22:42:18.486Z,1563921738.486 [NAL9602](INFO): NAL9602 initialized
2019-07-23T22:42:19.305Z,1563921739.305 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:43:27.617Z,1563921807.617 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:43:27.617Z,1563921807.617 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-07-23T22:43:27.617Z,1563921807.617 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:43:27.632Z,1563921807.632 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:43:28.053Z,1563921808.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:43:28.053Z,1563921808.053 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-07-23T22:43:52.284Z,1563921832.284 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T22:38:52.0Z
2019-07-23T22:43:52.284Z,1563921832.284 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T22:43:52.284Z,1563921832.284 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T22:43:56.402Z,1563921836.402 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T22:43:56.980Z,1563921836.980 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20190723T203657/Courier0040.lzma
2019-07-23T22:43:57.082Z,1563921837.082 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0040.lzma.bak
2019-07-23T22:43:57.082Z,1563921837.082 [DataOverHttps](INFO): SBD MOMSN=11466675
2019-07-23T22:44:04.904Z,1563921844.904 [DataOverHttps](INFO): Sending 317 bytes from file Logs/20190723T203657/Express0041.lzma
2019-07-23T22:44:05.006Z,1563921845.006 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0041.lzma.bak
2019-07-23T22:44:05.006Z,1563921845.006 [DataOverHttps](INFO): SBD MOMSN=11466678
2019-07-23T22:44:06.150Z,1563921846.150 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T22:44:06.150Z,1563921846.150 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T22:44:06.150Z,1563921846.150 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T22:44:27.125Z,1563921867.125 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T22:45:28.578Z,1563921928.578 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:45:28.578Z,1563921928.578 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-07-23T22:45:28.578Z,1563921928.578 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:45:28.589Z,1563921928.589 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:45:28.986Z,1563921928.986 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:45:28.986Z,1563921928.986 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-07-23T22:47:29.442Z,1563922049.442 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:47:29.442Z,1563922049.442 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-07-23T22:47:29.442Z,1563922049.442 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:47:29.453Z,1563922049.453 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:47:29.850Z,1563922049.850 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:47:29.851Z,1563922049.851 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-07-23T22:49:06.827Z,1563922146.827 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T22:49:06.828Z,1563922146.828 [Default:CheckIn:C.Wait] Stopped
2019-07-23T22:49:06.828Z,1563922146.828 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T22:49:06.828Z,1563922146.828 [Default:CheckIn:D] Running Loop=1
2019-07-23T22:49:07.228Z,1563922147.228 [Default:CheckIn:D] Stopped
2019-07-23T22:49:07.228Z,1563922147.228 [Default:CheckIn:E] Running Loop=1
2019-07-23T22:49:07.641Z,1563922147.641 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 128.950724 min 
2019-07-23T22:49:07.641Z,1563922147.641 [Default:CheckIn:E] Stopped
2019-07-23T22:49:07.641Z,1563922147.641 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T22:49:07.641Z,1563922147.641 [Default:CheckIn] Stopped
2019-07-23T22:49:07.642Z,1563922147.642 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T22:49:07.642Z,1563922147.642 [Default:CheckIn](INFO): Running loop #14
2019-07-23T22:49:07.642Z,1563922147.642 [Default:CheckIn] Running Loop=14
2019-07-23T22:49:07.642Z,1563922147.642 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T22:49:07.642Z,1563922147.642 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T22:49:09.241Z,1563922149.241 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:49:30.257Z,1563922170.257 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:49:30.257Z,1563922170.257 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-07-23T22:49:30.257Z,1563922170.257 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:49:30.269Z,1563922170.269 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:49:30.675Z,1563922170.675 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:49:30.675Z,1563922170.675 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-07-23T22:49:40.338Z,1563922180.338 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-07-23T22:49:40.421Z,1563922180.421 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-07-23T22:49:40.421Z,1563922180.421 [NAL9602] Data Fault, FailCount= 1
2019-07-23T22:49:40.421Z,1563922180.421 [NAL9602](ERROR): Data Fault
2019-07-23T22:49:40.486Z,1563922180.486 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T22:49:40.738Z,1563922180.738 [NAL9602](INFO): Powering down
2019-07-23T22:49:41.596Z,1563922181.596 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T22:49:41.596Z,1563922181.596 [NAL9602] No Fault, FailCount= 1
2019-07-23T22:50:11.058Z,1563922211.058 [NAL9602](INFO): Powering up NAL9602
2019-07-23T22:50:21.966Z,1563922221.966 [NAL9602](INFO): NAL9602 initialized
2019-07-23T22:50:22.797Z,1563922222.797 [NAL9602](DEBUG): Fix Requested
2019-07-23T22:51:31.105Z,1563922291.105 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:51:31.106Z,1563922291.106 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2019-07-23T22:51:31.106Z,1563922291.106 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:51:31.116Z,1563922291.116 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:51:31.519Z,1563922291.519 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:51:31.519Z,1563922291.519 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2019-07-23T22:53:31.919Z,1563922411.919 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:53:31.919Z,1563922411.919 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2019-07-23T22:53:31.919Z,1563922411.919 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:53:31.930Z,1563922411.930 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:53:32.368Z,1563922412.368 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:53:32.369Z,1563922412.369 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2019-07-23T22:54:07.900Z,1563922447.900 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T22:49:07.6Z
2019-07-23T22:54:07.900Z,1563922447.900 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T22:54:07.901Z,1563922447.901 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T22:54:11.582Z,1563922451.582 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T22:54:12.344Z,1563922452.344 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0043.lzma
2019-07-23T22:54:12.446Z,1563922452.446 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0043.lzma.bak
2019-07-23T22:54:12.446Z,1563922452.446 [DataOverHttps](INFO): SBD MOMSN=11466702
2019-07-23T22:54:20.452Z,1563922460.452 [DataOverHttps](INFO): Sending 297 bytes from file Logs/20190723T203657/Express0044.lzma
2019-07-23T22:54:20.554Z,1563922460.554 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0044.lzma.bak
2019-07-23T22:54:20.554Z,1563922460.554 [DataOverHttps](INFO): SBD MOMSN=11466704
2019-07-23T22:54:21.744Z,1563922461.744 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T22:54:21.744Z,1563922461.744 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T22:54:21.744Z,1563922461.744 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T22:54:42.309Z,1563922482.309 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T22:55:32.846Z,1563922532.846 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:55:32.846Z,1563922532.846 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2019-07-23T22:55:32.846Z,1563922532.846 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:55:32.857Z,1563922532.857 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:55:33.288Z,1563922533.288 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:55:33.288Z,1563922533.288 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2019-07-23T22:57:34.101Z,1563922654.101 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:57:34.101Z,1563922654.101 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2019-07-23T22:57:34.101Z,1563922654.101 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:57:34.112Z,1563922654.112 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:57:34.515Z,1563922654.515 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:57:34.515Z,1563922654.515 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2019-07-23T22:59:22.408Z,1563922762.408 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T22:59:22.408Z,1563922762.408 [Default:CheckIn:C.Wait] Stopped
2019-07-23T22:59:22.408Z,1563922762.408 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T22:59:22.408Z,1563922762.408 [Default:CheckIn:D] Running Loop=1
2019-07-23T22:59:22.805Z,1563922762.805 [Default:CheckIn:D] Stopped
2019-07-23T22:59:22.805Z,1563922762.805 [Default:CheckIn:E] Running Loop=1
2019-07-23T22:59:23.208Z,1563922763.208 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 139.210335 min 
2019-07-23T22:59:23.208Z,1563922763.208 [Default:CheckIn:E] Stopped
2019-07-23T22:59:23.208Z,1563922763.208 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T22:59:23.208Z,1563922763.208 [Default:CheckIn] Stopped
2019-07-23T22:59:23.208Z,1563922763.208 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T22:59:23.209Z,1563922763.209 [Default:CheckIn](INFO): Running loop #15
2019-07-23T22:59:23.209Z,1563922763.209 [Default:CheckIn] Running Loop=15
2019-07-23T22:59:23.209Z,1563922763.209 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T22:59:23.209Z,1563922763.209 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T22:59:24.806Z,1563922764.806 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T22:59:24.806Z,1563922764.806 [NAL9602] Data Fault, FailCount= 2
2019-07-23T22:59:24.806Z,1563922764.806 [NAL9602](ERROR): Data Fault
2019-07-23T22:59:24.848Z,1563922764.848 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T22:59:25.206Z,1563922765.206 [NAL9602](INFO): Powering down
2019-07-23T22:59:26.069Z,1563922766.069 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T22:59:26.069Z,1563922766.069 [NAL9602] No Fault, FailCount= 2
2019-07-23T22:59:34.941Z,1563922774.941 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T22:59:34.941Z,1563922774.941 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2019-07-23T22:59:34.941Z,1563922774.941 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T22:59:34.952Z,1563922774.952 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T22:59:35.355Z,1563922775.355 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T22:59:35.355Z,1563922775.355 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2019-07-23T22:59:55.526Z,1563922795.526 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:00:06.438Z,1563922806.438 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:00:07.261Z,1563922807.261 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:01:35.782Z,1563922895.782 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:01:35.782Z,1563922895.782 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2019-07-23T23:01:35.782Z,1563922895.782 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:01:35.793Z,1563922895.793 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:01:36.223Z,1563922896.223 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:01:36.223Z,1563922896.223 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2019-07-23T23:03:36.625Z,1563923016.625 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:03:36.625Z,1563923016.625 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2019-07-23T23:03:36.626Z,1563923016.626 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:03:36.688Z,1563923016.688 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:03:37.047Z,1563923017.047 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:03:37.047Z,1563923017.047 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2019-07-23T23:04:23.512Z,1563923063.512 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T22:59:23.2Z
2019-07-23T23:04:23.512Z,1563923063.512 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T23:04:23.533Z,1563923063.533 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T23:04:28.160Z,1563923068.160 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0046.lzma
2019-07-23T23:04:28.262Z,1563923068.262 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0046.lzma.bak
2019-07-23T23:04:28.262Z,1563923068.262 [DataOverHttps](INFO): SBD MOMSN=11466731
2019-07-23T23:04:36.048Z,1563923076.048 [DataOverHttps](INFO): Sending 287 bytes from file Logs/20190723T203657/Express0047.lzma
2019-07-23T23:04:36.154Z,1563923076.154 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0047.lzma.bak
2019-07-23T23:04:36.154Z,1563923076.154 [DataOverHttps](INFO): SBD MOMSN=11466733
2019-07-23T23:04:37.007Z,1563923077.007 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T23:04:37.007Z,1563923077.007 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T23:04:37.007Z,1563923077.007 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T23:05:09.682Z,1563923109.682 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T23:05:37.589Z,1563923137.589 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:05:37.589Z,1563923137.589 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2019-07-23T23:05:37.589Z,1563923137.589 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:05:37.641Z,1563923137.641 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:05:38.029Z,1563923138.029 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:05:38.029Z,1563923138.029 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2019-07-23T23:05:40.385Z,1563923140.385 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T23:07:38.437Z,1563923258.437 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:07:38.438Z,1563923258.438 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2019-07-23T23:07:38.438Z,1563923258.438 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:07:38.448Z,1563923258.448 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:07:38.847Z,1563923258.847 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:07:38.847Z,1563923258.847 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2019-07-23T23:09:37.664Z,1563923377.664 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T23:09:37.664Z,1563923377.664 [Default:CheckIn:C.Wait] Stopped
2019-07-23T23:09:37.664Z,1563923377.664 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T23:09:37.664Z,1563923377.664 [Default:CheckIn:D] Running Loop=1
2019-07-23T23:09:38.075Z,1563923378.075 [Default:CheckIn:D] Stopped
2019-07-23T23:09:38.075Z,1563923378.075 [Default:CheckIn:E] Running Loop=1
2019-07-23T23:09:38.484Z,1563923378.484 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 149.464844 min 
2019-07-23T23:09:38.484Z,1563923378.484 [Default:CheckIn:E] Stopped
2019-07-23T23:09:38.484Z,1563923378.484 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T23:09:38.484Z,1563923378.484 [Default:CheckIn] Stopped
2019-07-23T23:09:38.485Z,1563923378.485 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T23:09:38.485Z,1563923378.485 [Default:CheckIn](INFO): Running loop #16
2019-07-23T23:09:38.485Z,1563923378.485 [Default:CheckIn] Running Loop=16
2019-07-23T23:09:38.485Z,1563923378.485 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T23:09:38.485Z,1563923378.485 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T23:09:39.281Z,1563923379.281 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:09:39.282Z,1563923379.282 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2019-07-23T23:09:39.282Z,1563923379.282 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:09:39.294Z,1563923379.294 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:09:39.704Z,1563923379.704 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:09:39.704Z,1563923379.704 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2019-07-23T23:09:40.081Z,1563923380.081 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:10:11.198Z,1563923411.198 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-07-23T23:10:11.281Z,1563923411.281 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-07-23T23:10:11.281Z,1563923411.281 [NAL9602] Data Fault, FailCount= 3
2019-07-23T23:10:11.281Z,1563923411.281 [NAL9602](ERROR): Data Fault
2019-07-23T23:10:11.317Z,1563923411.317 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T23:10:11.602Z,1563923411.602 [NAL9602](INFO): Powering down
2019-07-23T23:10:12.487Z,1563923412.487 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T23:10:12.487Z,1563923412.487 [NAL9602] No Fault, FailCount= 3
2019-07-23T23:10:41.902Z,1563923441.902 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:10:52.830Z,1563923452.830 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:10:53.638Z,1563923453.638 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T23:10:53.638Z,1563923453.638 [NAL9602] Data Fault, FailCount= 4
2019-07-23T23:10:53.638Z,1563923453.638 [NAL9602](ERROR): Data Fault
2019-07-23T23:10:53.669Z,1563923453.669 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T23:10:54.038Z,1563923454.038 [NAL9602](INFO): Powering down
2019-07-23T23:10:54.880Z,1563923454.880 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T23:10:54.880Z,1563923454.880 [NAL9602] No Fault, FailCount= 4
2019-07-23T23:11:24.350Z,1563923484.350 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:11:35.262Z,1563923495.262 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:11:36.081Z,1563923496.081 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:11:40.130Z,1563923500.130 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:11:40.130Z,1563923500.130 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2019-07-23T23:11:40.130Z,1563923500.130 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:11:40.141Z,1563923500.141 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:11:40.141Z,1563923500.141 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:14:38.747Z,1563923678.747 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T23:09:38.5Z
2019-07-23T23:14:38.747Z,1563923678.747 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T23:14:38.747Z,1563923678.747 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T23:14:42.542Z,1563923682.542 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T23:14:43.300Z,1563923683.300 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0049.lzma
2019-07-23T23:14:43.402Z,1563923683.402 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0049.lzma.bak
2019-07-23T23:14:43.402Z,1563923683.402 [DataOverHttps](INFO): SBD MOMSN=11466785
2019-07-23T23:14:51.297Z,1563923691.297 [DataOverHttps](INFO): Sending 368 bytes from file Logs/20190723T203657/Express0050.lzma
2019-07-23T23:14:51.398Z,1563923691.398 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0050.lzma.bak
2019-07-23T23:14:51.398Z,1563923691.398 [DataOverHttps](INFO): SBD MOMSN=11466787
2019-07-23T23:14:52.277Z,1563923692.277 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T23:14:52.277Z,1563923692.277 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T23:14:52.278Z,1563923692.278 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T23:15:13.262Z,1563923713.262 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T23:19:52.985Z,1563923992.985 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T23:19:52.985Z,1563923992.985 [Default:CheckIn:C.Wait] Stopped
2019-07-23T23:19:52.985Z,1563923992.985 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T23:19:52.985Z,1563923992.985 [Default:CheckIn:D] Running Loop=1
2019-07-23T23:19:53.360Z,1563923993.360 [Default:CheckIn:D] Stopped
2019-07-23T23:19:53.360Z,1563923993.360 [Default:CheckIn:E] Running Loop=1
2019-07-23T23:19:53.773Z,1563923993.773 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 159.719580 min 
2019-07-23T23:19:53.773Z,1563923993.773 [Default:CheckIn:E] Stopped
2019-07-23T23:19:53.773Z,1563923993.773 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T23:19:53.773Z,1563923993.773 [Default:CheckIn] Stopped
2019-07-23T23:19:53.773Z,1563923993.773 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T23:19:53.774Z,1563923993.774 [Default:CheckIn](INFO): Running loop #17
2019-07-23T23:19:53.774Z,1563923993.774 [Default:CheckIn] Running Loop=17
2019-07-23T23:19:53.774Z,1563923993.774 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T23:19:53.774Z,1563923993.774 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T23:19:55.373Z,1563923995.373 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:20:26.483Z,1563924026.483 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-07-23T23:20:26.557Z,1563924026.557 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-07-23T23:20:26.557Z,1563924026.557 [NAL9602] Data Fault, FailCount= 5
2019-07-23T23:20:26.557Z,1563924026.557 [NAL9602](ERROR): Data Fault
2019-07-23T23:20:26.591Z,1563924026.591 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T23:20:26.592Z,1563924026.592 [CBIT](CRITICAL): Data Fault in component: NAL9602
2019-07-23T23:20:26.954Z,1563924026.954 [NAL9602](INFO): Powering down
2019-07-23T23:20:27.013Z,1563924027.013 [CBIT](INFO): Critical error at 20190723T232026
2019-07-23T23:22:26.990Z,1563924146.990 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T23:22:26.990Z,1563924146.990 [NAL9602] No Fault, FailCount= 5
2019-07-23T23:22:27.330Z,1563924147.330 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:22:38.238Z,1563924158.238 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:22:39.062Z,1563924159.062 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T23:22:39.062Z,1563924159.062 [NAL9602] Data Fault, FailCount= 1
2019-07-23T23:22:39.062Z,1563924159.062 [NAL9602](ERROR): Data Fault
2019-07-23T23:22:39.110Z,1563924159.110 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T23:22:39.454Z,1563924159.454 [NAL9602](INFO): Powering down
2019-07-23T23:22:40.296Z,1563924160.296 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T23:22:40.296Z,1563924160.296 [NAL9602] No Fault, FailCount= 1
2019-07-23T23:23:09.758Z,1563924189.758 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:23:20.666Z,1563924200.666 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:23:21.489Z,1563924201.489 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:24:54.038Z,1563924294.038 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T23:19:53.8Z
2019-07-23T23:24:54.038Z,1563924294.038 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T23:24:54.038Z,1563924294.038 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T23:24:57.314Z,1563924297.314 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T23:24:58.412Z,1563924298.412 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20190723T203657/Courier0052.lzma
2019-07-23T23:24:58.514Z,1563924298.514 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0052.lzma.bak
2019-07-23T23:24:58.514Z,1563924298.514 [DataOverHttps](INFO): SBD MOMSN=11466798
2019-07-23T23:25:06.388Z,1563924306.388 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20190723T203657/Express0053.lzma
2019-07-23T23:25:06.490Z,1563924306.490 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0053.lzma.bak
2019-07-23T23:25:06.490Z,1563924306.490 [DataOverHttps](INFO): SBD MOMSN=11466801
2019-07-23T23:25:07.469Z,1563924307.469 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T23:25:07.469Z,1563924307.469 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T23:25:07.469Z,1563924307.469 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T23:25:28.014Z,1563924328.014 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T23:26:40.394Z,1563924400.394 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:26:40.394Z,1563924400.394 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2019-07-23T23:28:40.790Z,1563924520.790 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:28:40.790Z,1563924520.790 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-07-23T23:28:40.790Z,1563924520.790 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:28:40.801Z,1563924520.801 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:28:41.206Z,1563924521.206 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:28:41.206Z,1563924521.206 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-07-23T23:30:08.085Z,1563924608.085 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T23:30:08.085Z,1563924608.085 [Default:CheckIn:C.Wait] Stopped
2019-07-23T23:30:08.085Z,1563924608.085 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T23:30:08.085Z,1563924608.085 [Default:CheckIn:D] Running Loop=1
2019-07-23T23:30:08.480Z,1563924608.480 [Default:CheckIn:D] Stopped
2019-07-23T23:30:08.480Z,1563924608.480 [Default:CheckIn:E] Running Loop=1
2019-07-23T23:30:08.896Z,1563924608.896 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 169.971582 min 
2019-07-23T23:30:08.896Z,1563924608.896 [Default:CheckIn:E] Stopped
2019-07-23T23:30:08.896Z,1563924608.896 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T23:30:08.896Z,1563924608.896 [Default:CheckIn] Stopped
2019-07-23T23:30:08.897Z,1563924608.897 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T23:30:08.897Z,1563924608.897 [Default:CheckIn](INFO): Running loop #18
2019-07-23T23:30:08.897Z,1563924608.897 [Default:CheckIn] Running Loop=18
2019-07-23T23:30:08.897Z,1563924608.897 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T23:30:08.897Z,1563924608.897 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T23:30:10.489Z,1563924610.489 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:30:41.610Z,1563924641.610 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-07-23T23:30:41.685Z,1563924641.685 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-07-23T23:30:41.685Z,1563924641.685 [NAL9602] Data Fault, FailCount= 2
2019-07-23T23:30:41.685Z,1563924641.685 [NAL9602](ERROR): Data Fault
2019-07-23T23:30:41.714Z,1563924641.714 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:30:41.714Z,1563924641.714 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-07-23T23:30:41.714Z,1563924641.714 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:30:41.724Z,1563924641.724 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:30:41.725Z,1563924641.725 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T23:30:42.020Z,1563924642.020 [NAL9602](INFO): Powering down
2019-07-23T23:30:42.058Z,1563924642.058 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:30:42.058Z,1563924642.058 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-07-23T23:30:42.883Z,1563924642.883 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T23:30:42.883Z,1563924642.883 [NAL9602] No Fault, FailCount= 2
2019-07-23T23:31:12.310Z,1563924672.310 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:31:23.246Z,1563924683.246 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:31:24.061Z,1563924684.061 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:32:42.528Z,1563924762.528 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:32:42.528Z,1563924762.528 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-07-23T23:32:42.528Z,1563924762.528 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:32:42.539Z,1563924762.539 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:32:42.929Z,1563924762.929 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:32:42.929Z,1563924762.929 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-07-23T23:34:43.373Z,1563924883.373 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:34:43.373Z,1563924883.373 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-07-23T23:34:43.373Z,1563924883.373 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:34:43.408Z,1563924883.408 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:34:43.805Z,1563924883.805 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:34:43.805Z,1563924883.805 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-07-23T23:35:09.217Z,1563924909.217 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T23:30:08.9Z
2019-07-23T23:35:09.217Z,1563924909.217 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T23:35:09.217Z,1563924909.217 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T23:35:12.530Z,1563924912.530 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T23:35:13.664Z,1563924913.664 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0055.lzma
2019-07-23T23:35:13.766Z,1563924913.766 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0055.lzma.bak
2019-07-23T23:35:13.766Z,1563924913.766 [DataOverHttps](INFO): SBD MOMSN=11466807
2019-07-23T23:35:21.520Z,1563924921.520 [DataOverHttps](INFO): Sending 291 bytes from file Logs/20190723T203657/Express0056.lzma
2019-07-23T23:35:21.674Z,1563924921.674 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0056.lzma.bak
2019-07-23T23:35:21.674Z,1563924921.674 [DataOverHttps](INFO): SBD MOMSN=11466809
2019-07-23T23:35:22.711Z,1563924922.711 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T23:35:22.711Z,1563924922.711 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T23:35:22.711Z,1563924922.711 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T23:35:43.259Z,1563924943.259 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T23:36:44.298Z,1563925004.298 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:36:44.298Z,1563925004.298 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-07-23T23:36:44.298Z,1563925004.298 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:36:44.308Z,1563925004.308 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:36:44.707Z,1563925004.707 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:36:44.707Z,1563925004.707 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-07-23T23:38:45.146Z,1563925125.146 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:38:45.146Z,1563925125.146 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-07-23T23:38:45.146Z,1563925125.146 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:38:45.157Z,1563925125.157 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:38:45.553Z,1563925125.553 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:38:45.554Z,1563925125.554 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-07-23T23:40:23.364Z,1563925223.364 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T23:40:23.364Z,1563925223.364 [Default:CheckIn:C.Wait] Stopped
2019-07-23T23:40:23.364Z,1563925223.364 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T23:40:23.364Z,1563925223.364 [Default:CheckIn:D] Running Loop=1
2019-07-23T23:40:23.759Z,1563925223.759 [Default:CheckIn:D] Stopped
2019-07-23T23:40:23.759Z,1563925223.759 [Default:CheckIn:E] Running Loop=1
2019-07-23T23:40:24.202Z,1563925224.202 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 180.226237 min 
2019-07-23T23:40:24.202Z,1563925224.202 [Default:CheckIn:E] Stopped
2019-07-23T23:40:24.202Z,1563925224.202 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T23:40:24.203Z,1563925224.203 [Default:CheckIn] Stopped
2019-07-23T23:40:24.203Z,1563925224.203 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T23:40:24.203Z,1563925224.203 [Default:CheckIn](INFO): Running loop #19
2019-07-23T23:40:24.203Z,1563925224.203 [Default:CheckIn] Running Loop=19
2019-07-23T23:40:24.203Z,1563925224.203 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T23:40:24.203Z,1563925224.203 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T23:40:25.758Z,1563925225.758 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T23:40:25.758Z,1563925225.758 [NAL9602] Data Fault, FailCount= 3
2019-07-23T23:40:25.758Z,1563925225.758 [NAL9602](ERROR): Data Fault
2019-07-23T23:40:25.793Z,1563925225.793 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T23:40:26.165Z,1563925226.165 [NAL9602](INFO): Powering down
2019-07-23T23:40:27.009Z,1563925227.009 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T23:40:27.009Z,1563925227.009 [NAL9602] No Fault, FailCount= 3
2019-07-23T23:40:45.993Z,1563925245.993 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:40:45.993Z,1563925245.993 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-07-23T23:40:45.993Z,1563925245.993 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:40:46.011Z,1563925246.011 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:40:46.431Z,1563925246.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:40:46.431Z,1563925246.431 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-07-23T23:40:56.474Z,1563925256.474 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:41:07.382Z,1563925267.382 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:41:08.229Z,1563925268.229 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:42:46.862Z,1563925366.862 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:42:46.862Z,1563925366.862 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-07-23T23:42:46.862Z,1563925366.862 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:42:46.873Z,1563925366.873 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:42:47.247Z,1563925367.247 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:42:47.247Z,1563925367.247 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-07-23T23:44:47.702Z,1563925487.702 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:44:47.702Z,1563925487.702 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-07-23T23:44:47.702Z,1563925487.702 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:44:47.713Z,1563925487.713 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:44:48.108Z,1563925488.108 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:44:48.108Z,1563925488.108 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-07-23T23:45:24.472Z,1563925524.472 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T23:40:24.2Z
2019-07-23T23:45:24.472Z,1563925524.472 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T23:45:24.473Z,1563925524.473 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T23:45:28.978Z,1563925528.978 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190723T203657/Courier0058.lzma
2019-07-23T23:45:29.078Z,1563925529.078 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0058.lzma.bak
2019-07-23T23:45:29.078Z,1563925529.078 [DataOverHttps](INFO): SBD MOMSN=11466818
2019-07-23T23:45:36.936Z,1563925536.936 [DataOverHttps](INFO): Sending 284 bytes from file Logs/20190723T203657/Express0059.lzma
2019-07-23T23:45:37.038Z,1563925537.038 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0059.lzma.bak
2019-07-23T23:45:37.039Z,1563925537.039 [DataOverHttps](INFO): SBD MOMSN=11466820
2019-07-23T23:45:38.348Z,1563925538.348 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T23:45:38.348Z,1563925538.348 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T23:45:38.348Z,1563925538.348 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T23:46:10.614Z,1563925570.614 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T23:46:41.329Z,1563925601.329 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T23:46:48.652Z,1563925608.652 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:46:48.652Z,1563925608.652 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2019-07-23T23:46:48.653Z,1563925608.653 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:46:48.675Z,1563925608.675 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:46:49.069Z,1563925609.069 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:46:49.069Z,1563925609.069 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2019-07-23T23:48:49.476Z,1563925729.476 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:48:49.476Z,1563925729.476 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2019-07-23T23:48:49.477Z,1563925729.477 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:48:49.499Z,1563925729.499 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:48:49.881Z,1563925729.881 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:48:49.881Z,1563925729.881 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2019-07-23T23:50:38.975Z,1563925838.975 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-07-23T23:50:38.975Z,1563925838.975 [Default:CheckIn:C.Wait] Stopped
2019-07-23T23:50:38.975Z,1563925838.975 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T23:50:38.975Z,1563925838.975 [Default:CheckIn:D] Running Loop=1
2019-07-23T23:50:39.388Z,1563925839.388 [Default:CheckIn:D] Stopped
2019-07-23T23:50:39.388Z,1563925839.388 [Default:CheckIn:E] Running Loop=1
2019-07-23T23:50:39.784Z,1563925839.784 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 190.486719 min 
2019-07-23T23:50:39.784Z,1563925839.784 [Default:CheckIn:E] Stopped
2019-07-23T23:50:39.784Z,1563925839.784 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-07-23T23:50:39.784Z,1563925839.784 [Default:CheckIn] Stopped
2019-07-23T23:50:39.785Z,1563925839.785 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T23:50:39.785Z,1563925839.785 [Default:CheckIn](INFO): Running loop #20
2019-07-23T23:50:39.785Z,1563925839.785 [Default:CheckIn] Running Loop=20
2019-07-23T23:50:39.785Z,1563925839.785 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-23T23:50:39.785Z,1563925839.785 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-23T23:50:41.389Z,1563925841.389 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:50:50.687Z,1563925850.687 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:50:50.687Z,1563925850.687 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2019-07-23T23:50:50.687Z,1563925850.687 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:50:50.731Z,1563925850.731 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:50:51.110Z,1563925851.110 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:50:51.110Z,1563925851.110 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2019-07-23T23:51:12.490Z,1563925872.490 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-07-23T23:51:12.573Z,1563925872.573 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-07-23T23:51:12.573Z,1563925872.573 [NAL9602] Data Fault, FailCount= 4
2019-07-23T23:51:12.573Z,1563925872.573 [NAL9602](ERROR): Data Fault
2019-07-23T23:51:12.612Z,1563925872.612 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T23:51:12.917Z,1563925872.917 [NAL9602](INFO): Powering down
2019-07-23T23:51:13.732Z,1563925873.732 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T23:51:13.732Z,1563925873.732 [NAL9602] No Fault, FailCount= 4
2019-07-23T23:51:43.194Z,1563925903.194 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:51:54.106Z,1563925914.106 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:51:54.910Z,1563925914.910 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-07-23T23:51:54.910Z,1563925914.910 [NAL9602] Data Fault, FailCount= 5
2019-07-23T23:51:54.910Z,1563925914.910 [NAL9602](ERROR): Data Fault
2019-07-23T23:51:54.941Z,1563925914.941 [CBIT](ERROR): Data Fault in component: NAL9602
2019-07-23T23:51:54.941Z,1563925914.941 [CBIT](CRITICAL): Data Fault in component: NAL9602
2019-07-23T23:51:55.314Z,1563925915.314 [NAL9602](INFO): Powering down
2019-07-23T23:51:55.343Z,1563925915.343 [CBIT](INFO): Critical error at 20190723T235154
2019-07-23T23:52:51.530Z,1563925971.530 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:52:51.530Z,1563925971.530 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2019-07-23T23:52:51.530Z,1563925971.530 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:52:51.541Z,1563925971.541 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:52:51.939Z,1563925971.939 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:52:51.939Z,1563925971.939 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2019-07-23T23:53:54.980Z,1563926034.980 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-23T23:53:54.980Z,1563926034.980 [NAL9602] No Fault, FailCount= 5
2019-07-23T23:53:55.358Z,1563926035.358 [NAL9602](INFO): Powering up NAL9602
2019-07-23T23:54:06.294Z,1563926046.294 [NAL9602](INFO): NAL9602 initialized
2019-07-23T23:54:07.085Z,1563926047.085 [NAL9602](DEBUG): Fix Requested
2019-07-23T23:54:52.369Z,1563926092.369 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:54:52.369Z,1563926092.369 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2019-07-23T23:54:52.369Z,1563926092.369 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:54:52.379Z,1563926092.379 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:54:52.775Z,1563926092.775 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:54:52.775Z,1563926092.775 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2019-07-23T23:55:40.093Z,1563926140.093 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-23T23:50:39.8Z
2019-07-23T23:55:40.093Z,1563926140.093 [Default:CheckIn:Read_GPS] Stopped
2019-07-23T23:55:40.093Z,1563926140.093 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-23T23:55:43.642Z,1563926143.642 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-07-23T23:55:47.804Z,1563926147.804 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20190723T203657/Courier0061.lzma
2019-07-23T23:55:47.906Z,1563926147.906 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Courier0061.lzma.bak
2019-07-23T23:55:47.906Z,1563926147.906 [DataOverHttps](INFO): SBD MOMSN=11466850
2019-07-23T23:55:59.773Z,1563926159.773 [DataOverHttps](INFO): Sending 316 bytes from file Logs/20190723T203657/Express0062.lzma
2019-07-23T23:55:59.882Z,1563926159.882 [DataOverHttps](INFO): Moved sent file to Logs/20190723T203657/Express0062.lzma.bak
2019-07-23T23:55:59.883Z,1563926159.883 [DataOverHttps](INFO): SBD MOMSN=11466853
2019-07-23T23:56:01.069Z,1563926161.069 [Default:CheckIn:Read_Iridium] Stopped
2019-07-23T23:56:01.069Z,1563926161.069 [Default:CheckIn:C.Wait] Running Loop=1
2019-07-23T23:56:01.069Z,1563926161.069 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-07-23T23:56:14.373Z,1563926174.373 [NAL9602](INFO): Not Powering down - fast GPS
2019-07-23T23:56:53.592Z,1563926213.592 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:56:53.592Z,1563926213.592 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2019-07-23T23:56:53.592Z,1563926213.592 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:56:53.602Z,1563926213.602 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:56:54.010Z,1563926214.010 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:56:54.010Z,1563926214.010 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2019-07-23T23:58:54.414Z,1563926334.414 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-23T23:58:54.414Z,1563926334.414 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2019-07-23T23:58:54.414Z,1563926334.414 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-23T23:58:54.425Z,1563926334.425 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-23T23:58:54.833Z,1563926334.833 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-23T23:58:54.833Z,1563926334.833 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2019-07-23T23:59:06.150Z,1563926346.150 [CommandLine](IMPORTANT): got command quit
2019-07-23T23:59:07.153Z,1563926347.153 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-23T23:59:07.153Z,1563926347.153 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:07.317Z,1563926347.317 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-07-23T23:59:07.317Z,1563926347.317 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:07.318Z,1563926347.318 [CommandLine](INFO): Join timeout helper Thread ID is 1534
2019-07-23T23:59:07.318Z,1563926347.318 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-07-23T23:59:07.318Z,1563926347.318 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:07.319Z,1563926347.319 [NavChartDb](INFO): Join timeout helper Thread ID is 1535
2019-07-23T23:59:07.613Z,1563926347.613 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-23T23:59:07.613Z,1563926347.613 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:07.621Z,1563926347.621 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-07-23T23:59:07.621Z,1563926347.621 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:07.621Z,1563926347.621 [Radio_Surface](INFO): Join timeout helper Thread ID is 1536
2019-07-23T23:59:07.989Z,1563926347.989 [Radio_Surface](INFO): Powering down
2019-07-23T23:59:07.990Z,1563926347.990 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-23T23:59:07.990Z,1563926347.990 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:07.997Z,1563926347.997 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-07-23T23:59:07.997Z,1563926347.997 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:07.997Z,1563926347.997 [DataOverHttps](INFO): Join timeout helper Thread ID is 1537
2019-07-23T23:59:08.557Z,1563926348.557 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-23T23:59:08.560Z,1563926348.560 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:08.569Z,1563926348.569 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-07-23T23:59:08.569Z,1563926348.569 [logger ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:08.569Z,1563926348.569 [logger](INFO): Join timeout helper Thread ID is 1538
2019-07-23T23:59:08.737Z,1563926348.737 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-23T23:59:08.737Z,1563926348.737 [logger ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:08.750Z,1563926348.750 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-07-23T23:59:08.750Z,1563926348.750 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:08.750Z,1563926348.750 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-07-23T23:59:08.750Z,1563926348.750 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:08.750Z,1563926348.750 [controlThread](INFO): Join timeout helper Thread ID is 1539
2019-07-23T23:59:08.929Z,1563926348.929 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-23T23:59:08.929Z,1563926348.929 [controlThread](DEBUG): Uninitializing ControlThread
2019-07-23T23:59:08.930Z,1563926348.930 [NAL9602](INFO): Powering down
2019-07-23T23:59:08.951Z,1563926348.951 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-07-23T23:59:08.952Z,1563926348.952 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-07-23T23:59:08.952Z,1563926348.952 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-07-23T23:59:08.953Z,1563926348.953 [MissionManager](INFO): Uninitializing Mission Default
2019-07-23T23:59:08.953Z,1563926348.953 [Default] Stopped
2019-07-23T23:59:08.953Z,1563926348.953 [Default](DEBUG): Aggregate::uninitialize Default
2019-07-23T23:59:08.953Z,1563926348.953 [Default:B.GoToSurface] Stopped
2019-07-23T23:59:08.953Z,1563926348.953 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-07-23T23:59:08.953Z,1563926348.953 [Default:CheckIn] Stopped
2019-07-23T23:59:08.954Z,1563926348.954 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-23T23:59:08.954Z,1563926348.954 [Default:CheckIn:C.Wait] Stopped
2019-07-23T23:59:08.954Z,1563926348.954 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-07-23T23:59:08.956Z,1563926348.956 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-07-23T23:59:08.956Z,1563926348.956 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-07-23T23:59:08.957Z,1563926348.957 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-07-23T23:59:08.957Z,1563926348.957 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-07-23T23:59:08.957Z,1563926348.957 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-07-23T23:59:08.957Z,1563926348.957 [BuoyancyServo](INFO): Powering down
2019-07-23T23:59:08.969Z,1563926348.969 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-07-23T23:59:08.969Z,1563926348.969 [ElevatorServo](INFO): Powering down
2019-07-23T23:59:08.970Z,1563926348.970 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-07-23T23:59:08.970Z,1563926348.970 [MassServo](INFO): Powering down
2019-07-23T23:59:08.971Z,1563926348.971 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-07-23T23:59:08.971Z,1563926348.971 [RudderServo](INFO): Powering down
2019-07-23T23:59:08.971Z,1563926348.971 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-07-23T23:59:08.972Z,1563926348.972 [ThrusterServo](INFO): Powering down
2019-07-23T23:59:08.972Z,1563926348.972 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-07-23T23:59:08.973Z,1563926348.973 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-07-23T23:59:08.973Z,1563926348.973 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-07-23T23:59:08.973Z,1563926348.973 [CBIT](DEBUG): Powering off loads.
2019-07-23T23:59:08.985Z,1563926348.985 [CBIT](DEBUG): Disabling WDT.
2019-07-23T23:59:08.997Z,1563926348.997 [CBIT](DEBUG): Opening all GF detection circuits.
2019-07-23T23:59:08.997Z,1563926348.997 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:09.076Z,1563926349.076 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:09.081Z,1563926349.081 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:09.140Z,1563926349.140 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-23T23:59:09.205Z,1563926349.205 [logger ThreadHandler](INFO): Thread cancelled.