2019-08-05T19:25:05.091Z,1565033105.091 [Supervisor](DEBUG): Initializing supervisor. 2019-08-05T19:25:05.094Z,1565033105.094 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-08-05T19:25:05.094Z,1565033105.094 [SyncHandler](INFO): Protected caller Thread ID is 3108 2019-08-05T19:25:05.095Z,1565033105.095 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-08-05T19:25:05.096Z,1565033105.096 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-08-05T19:25:05.096Z,1565033105.096 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3109 2019-08-05T19:25:05.099Z,1565033105.099 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-08-05T19:25:05.110Z,1565033105.110 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-08-05T19:25:05.111Z,1565033105.111 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-08-05T19:25:05.111Z,1565033105.111 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3110 2019-08-05T19:25:05.112Z,1565033105.112 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-08-05T19:25:05.113Z,1565033105.113 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-08-05T19:25:05.114Z,1565033105.114 [logger ThreadHandler](INFO): Protected caller Thread ID is 3111 2019-08-05T19:25:05.116Z,1565033105.116 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-08-05T19:25:05.116Z,1565033105.116 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-08-05T19:25:05.117Z,1565033105.117 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-08-05T19:25:05.324Z,1565033105.324 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-08-05T19:25:05.324Z,1565033105.324 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-08-05T19:25:05.406Z,1565033105.406 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-08-05T19:25:05.854Z,1565033105.854 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-08-05T19:25:05.854Z,1565033105.854 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-08-05T19:25:06.202Z,1565033106.202 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-08-05T19:25:06.202Z,1565033106.202 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-08-05T19:25:06.300Z,1565033106.300 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-08-05T19:25:06.301Z,1565033106.301 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-08-05T19:25:06.609Z,1565033106.609 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-08-05T19:25:06.610Z,1565033106.610 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-08-05T19:25:06.811Z,1565033106.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-08-05T19:25:06.812Z,1565033106.812 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-08-05T19:25:07.280Z,1565033107.280 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-08-05T19:25:07.281Z,1565033107.281 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-08-05T19:25:07.388Z,1565033107.388 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-08-05T19:25:07.389Z,1565033107.389 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-08-05T19:25:07.490Z,1565033107.490 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-08-05T19:25:07.491Z,1565033107.491 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-08-05T19:25:08.110Z,1565033108.110 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-08-05T19:25:08.110Z,1565033108.110 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-08-05T19:25:08.516Z,1565033108.516 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-08-05T19:25:08.516Z,1565033108.516 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-08-05T19:25:08.718Z,1565033108.718 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-08-05T19:25:08.718Z,1565033108.718 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-08-05T19:25:08.866Z,1565033108.866 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-08-05T19:25:08.867Z,1565033108.867 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-08-05T19:25:09.020Z,1565033109.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-08-05T19:25:09.022Z,1565033109.022 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2019-08-05T19:25:09.022Z,1565033109.022 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2019-08-05T19:25:09.188Z,1565033109.188 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2019-08-05T19:25:09.275Z,1565033109.275 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2019-08-05T19:25:09.383Z,1565033109.383 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2019-08-05T19:25:09.468Z,1565033109.468 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2019-08-05T19:25:09.566Z,1565033109.566 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2019-08-05T19:25:09.669Z,1565033109.669 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2019-08-05T19:25:09.908Z,1565033109.908 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg 2019-08-05T19:25:10.130Z,1565033110.130 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2019-08-05T19:25:10.385Z,1565033110.385 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2019-08-05T19:25:10.616Z,1565033110.616 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2019-08-05T19:25:10.863Z,1565033110.863 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2019-08-05T19:25:11.103Z,1565033111.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-08-05T19:25:11.103Z,1565033111.103 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-08-05T19:25:11.124Z,1565033111.124 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-08-05T19:25:11.195Z,1565033111.195 [VerticalControl](DEBUG): Construct VerticalControl. 2019-08-05T19:25:11.308Z,1565033111.308 [VerticalControl] Loaded 2019-08-05T19:25:11.308Z,1565033111.308 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-08-05T19:25:11.309Z,1565033111.309 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-08-05T19:25:11.379Z,1565033111.379 [HorizontalControl] Loaded 2019-08-05T19:25:11.380Z,1565033111.380 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-08-05T19:25:11.380Z,1565033111.380 [SpeedControl](DEBUG): Construct SpeedControl. 2019-08-05T19:25:11.386Z,1565033111.386 [SpeedControl] Loaded 2019-08-05T19:25:11.386Z,1565033111.386 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-08-05T19:25:11.387Z,1565033111.387 [LoopControl](DEBUG): Construct LoopControl. 2019-08-05T19:25:11.388Z,1565033111.388 [LoopControl] Loaded 2019-08-05T19:25:11.388Z,1565033111.388 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-08-05T19:25:11.388Z,1565033111.388 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-08-05T19:25:11.389Z,1565033111.389 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-08-05T19:25:11.402Z,1565033111.402 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-08-05T19:25:11.403Z,1565033111.403 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-08-05T19:25:11.504Z,1565033111.504 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-08-05T19:25:11.504Z,1565033111.504 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-08-05T19:25:11.609Z,1565033111.609 [BuoyancyServo] Loaded 2019-08-05T19:25:11.609Z,1565033111.609 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-08-05T19:25:11.620Z,1565033111.620 [ElevatorServo] Loaded 2019-08-05T19:25:11.621Z,1565033111.621 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-08-05T19:25:11.631Z,1565033111.631 [MassServo] Loaded 2019-08-05T19:25:11.632Z,1565033111.632 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-08-05T19:25:11.643Z,1565033111.643 [RudderServo] Loaded 2019-08-05T19:25:11.643Z,1565033111.643 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-08-05T19:25:11.654Z,1565033111.654 [ThrusterServo] Loaded 2019-08-05T19:25:11.654Z,1565033111.654 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-08-05T19:25:11.655Z,1565033111.655 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-08-05T19:25:11.655Z,1565033111.655 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-08-05T19:25:11.765Z,1565033111.765 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-08-05T19:25:11.765Z,1565033111.765 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-08-05T19:25:11.787Z,1565033111.787 [NavChart] Loaded 2019-08-05T19:25:11.787Z,1565033111.787 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-08-05T19:25:11.791Z,1565033111.791 [UniversalFixResidualReporter] Loaded 2019-08-05T19:25:11.791Z,1565033111.791 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-08-05T19:25:11.791Z,1565033111.791 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-08-05T19:25:11.792Z,1565033111.792 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-08-05T19:25:11.865Z,1565033111.865 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-08-05T19:25:11.865Z,1565033111.865 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-08-05T19:25:12.203Z,1565033112.203 [DataOverHttps] Loaded 2019-08-05T19:25:12.203Z,1565033112.203 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-08-05T19:25:12.204Z,1565033112.204 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087D4E0 2019-08-05T19:25:12.204Z,1565033112.204 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3194 2019-08-05T19:25:12.218Z,1565033112.218 [Depth_Keller] Loaded 2019-08-05T19:25:12.218Z,1565033112.218 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-08-05T19:25:12.317Z,1565033112.317 [NAL9602] Loaded 2019-08-05T19:25:12.318Z,1565033112.318 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-08-05T19:25:12.334Z,1565033112.334 [Onboard] Loaded 2019-08-05T19:25:12.335Z,1565033112.335 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-08-05T19:25:12.338Z,1565033112.338 [Radio_Surface] Loaded 2019-08-05T19:25:12.338Z,1565033112.338 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-08-05T19:25:12.339Z,1565033112.339 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408AD4E0 2019-08-05T19:25:12.340Z,1565033112.340 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3195 2019-08-05T19:25:13.888Z,1565033113.888 [BPC1] Loaded 2019-08-05T19:25:13.888Z,1565033113.888 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-08-05T19:25:13.888Z,1565033113.888 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-08-05T19:25:13.889Z,1565033113.889 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-08-05T19:25:13.931Z,1565033113.931 [DepthRateCalculator] Loaded 2019-08-05T19:25:13.931Z,1565033113.931 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-08-05T19:25:13.937Z,1565033113.937 [PitchRateCalculator] Loaded 2019-08-05T19:25:13.937Z,1565033113.937 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-08-05T19:25:13.949Z,1565033113.949 [SpeedCalculator] Loaded 2019-08-05T19:25:13.949Z,1565033113.949 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-08-05T19:25:13.971Z,1565033113.971 [TempGradientCalculator] Loaded 2019-08-05T19:25:13.971Z,1565033113.971 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-08-05T19:25:13.976Z,1565033113.976 [YawRateCalculator] Loaded 2019-08-05T19:25:13.977Z,1565033113.977 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-08-05T19:25:14.007Z,1565033114.007 [ElevatorOffsetCalculator] Loaded 2019-08-05T19:25:14.007Z,1565033114.007 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-08-05T19:25:14.008Z,1565033114.008 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-08-05T19:25:14.008Z,1565033114.008 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-08-05T19:25:14.208Z,1565033114.208 [ESPComponent] Loaded 2019-08-05T19:25:14.208Z,1565033114.208 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2019-08-05T19:25:14.222Z,1565033114.222 [PAR_Licor] Loaded 2019-08-05T19:25:14.223Z,1565033114.223 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2019-08-05T19:25:14.224Z,1565033114.224 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-08-05T19:25:14.224Z,1565033114.224 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-08-05T19:25:14.257Z,1565033114.257 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-08-05T19:25:14.258Z,1565033114.258 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-08-05T19:25:14.561Z,1565033114.561 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-08-05T19:25:14.562Z,1565033114.562 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-08-05T19:25:14.700Z,1565033114.700 [SBIT](DEBUG): Construct Startup Built In Test. 2019-08-05T19:25:14.712Z,1565033114.712 [SBIT] Loaded 2019-08-05T19:25:14.712Z,1565033114.712 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-08-05T19:25:14.713Z,1565033114.713 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-08-05T19:25:14.724Z,1565033114.724 [IBIT] Loaded 2019-08-05T19:25:14.724Z,1565033114.724 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-08-05T19:25:14.728Z,1565033114.728 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-08-05T19:25:14.865Z,1565033114.865 [CBIT] Loaded 2019-08-05T19:25:14.865Z,1565033114.865 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-08-05T19:25:14.865Z,1565033114.865 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-08-05T19:25:14.869Z,1565033114.869 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-08-05T19:25:14.870Z,1565033114.870 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-08-05T19:25:14.876Z,1565033114.876 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-08-05T19:25:14.877Z,1565033114.877 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A7F4E0 2019-08-05T19:25:14.878Z,1565033114.878 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3196 2019-08-05T19:25:14.882Z,1565033114.882 [Supervisor](INFO): Main Thread ID is 3107 2019-08-05T19:25:14.882Z,1565033114.882 [Supervisor](DEBUG): Running supervisor. 2019-08-05T19:25:14.883Z,1565033114.883 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3197 2019-08-05T19:25:14.885Z,1565033114.885 [controlThread ThreadHandler](INFO): Handler Thread ID is 3198 2019-08-05T19:25:14.886Z,1565033114.886 [controlThread](DEBUG): Initializing ControlThread 2019-08-05T19:25:14.887Z,1565033114.887 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-08-05T19:25:14.888Z,1565033114.888 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-08-05T19:25:14.889Z,1565033114.889 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-08-05T19:25:14.889Z,1565033114.889 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-08-05T19:25:14.891Z,1565033114.891 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-08-05T19:25:14.892Z,1565033114.892 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-08-05T19:25:14.896Z,1565033114.896 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-08-05T19:25:14.896Z,1565033114.896 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-08-05T19:25:14.896Z,1565033114.896 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-08-05T19:25:14.897Z,1565033114.897 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-08-05T19:25:14.897Z,1565033114.897 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-08-05T19:25:14.898Z,1565033114.898 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-08-05T19:25:14.899Z,1565033114.899 [SBIT](INFO): Initialize SBIT Component. 2019-08-05T19:25:14.900Z,1565033114.900 [SBIT](IMPORTANT): git: 2019-07-26-1-g6ad825a 2019-08-05T19:25:14.900Z,1565033114.900 [SBIT](INFO): git hash: 6ad825a153e96bf2505e39e5df4d606652139ef6 2019-08-05T19:25:14.900Z,1565033114.900 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-08-05T19:25:14.901Z,1565033114.901 [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-08-05T19:25:14.902Z,1565033114.902 [SBIT](INFO): Beginning SBIT in 29.000000 seconds. 2019-08-05T19:25:14.903Z,1565033114.903 [IBIT](INFO): Initialize IBIT Component. 2019-08-05T19:25:14.904Z,1565033114.904 [CBIT](DEBUG): Initialize CBIT Component. 2019-08-05T19:25:14.905Z,1565033114.905 [logger ThreadHandler](INFO): Handler Thread ID is 3199 2019-08-05T19:25:14.915Z,1565033114.915 [CBIT](DEBUG): Initialized mux pins. 2019-08-05T19:25:14.915Z,1565033114.915 [CBIT](DEBUG): Initializing the watchdog timer. 2019-08-05T19:25:14.936Z,1565033114.936 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3200 2019-08-05T19:25:14.937Z,1565033114.937 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-08-05T19:25:14.939Z,1565033114.939 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-08-05T19:25:14.939Z,1565033114.939 [CBIT](DEBUG): Initializing heartbeat. 2019-08-05T19:25:14.947Z,1565033114.947 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3201 2019-08-05T19:25:14.949Z,1565033114.949 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3202 2019-08-05T19:25:14.953Z,1565033114.953 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-08-05T19:25:14.953Z,1565033114.953 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-08-05T19:25:14.953Z,1565033114.953 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-08-05T19:25:14.953Z,1565033114.953 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-08-05T19:25:14.953Z,1565033114.953 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-08-05T19:25:14.953Z,1565033114.953 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-08-05T19:25:14.954Z,1565033114.954 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-08-05T19:25:14.954Z,1565033114.954 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-08-05T19:25:14.954Z,1565033114.954 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-08-05T19:25:14.954Z,1565033114.954 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-08-05T19:25:14.955Z,1565033114.955 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-08-05T19:25:14.955Z,1565033114.955 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-08-05T19:25:14.955Z,1565033114.955 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-08-05T19:25:14.955Z,1565033114.955 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-08-05T19:25:14.956Z,1565033114.956 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-08-05T19:25:14.956Z,1565033114.956 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-08-05T19:25:15.011Z,1565033115.011 [CBIT](DEBUG): Deactivating GF circuits. 2019-08-05T19:25:15.011Z,1565033115.011 [CBIT](DEBUG): Deactivating emergency mode. 2019-08-05T19:25:15.047Z,1565033115.047 [CBIT](DEBUG): Backplane powered. 2019-08-05T19:25:15.048Z,1565033115.048 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-08-05T19:25:15.058Z,1565033115.058 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-08-05T19:25:15.069Z,1565033115.069 [MissionManager](DEBUG): 2019-08-05T19:25:15.070Z,1565033115.070 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-08-05T19:25:15.186Z,1565033115.186 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-08-05T19:25:15.195Z,1565033115.195 [Default:A.Wait](DEBUG): Construct Wait. 2019-08-05T19:25:15.197Z,1565033115.197 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-08-05T19:25:15.244Z,1565033115.244 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-08-05T19:25:15.246Z,1565033115.246 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-08-05T19:25:15.268Z,1565033115.268 [Default:E.Execute](DEBUG): Construct Execute. 2019-08-05T19:25:15.271Z,1565033115.271 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2019-08-05T19:25:15.275Z,1565033115.275 [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-08-05T19:25:15.292Z,1565033115.292 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar 2019-08-05T19:25:15.351Z,1565033115.351 [Radio_Surface](INFO): Powering up 2019-08-05T19:25:15.360Z,1565033115.360 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-08-05T19:25:15.385Z,1565033115.385 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-08-05T19:25:15.391Z,1565033115.391 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-08-05T19:25:15.392Z,1565033115.392 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-08-05T19:25:15.399Z,1565033115.399 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-08-05T19:25:15.400Z,1565033115.400 [MassServo](DEBUG): Initializing EZServoServo. 2019-08-05T19:25:15.407Z,1565033115.407 [MassServo](DEBUG): Initializing MassServo. 2019-08-05T19:25:15.408Z,1565033115.408 [RudderServo](DEBUG): Initializing EZServoServo. 2019-08-05T19:25:15.415Z,1565033115.415 [RudderServo](DEBUG): Initializing RudderServo. 2019-08-05T19:25:15.416Z,1565033115.416 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-08-05T19:25:15.423Z,1565033115.423 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-08-05T19:25:25.084Z,1565033125.084 [CBIT](CRITICAL): Environmental Failure. Press:14.820789 PSI. Humidity:38%. Temp:26 C. ABORTING MISSION 2019-08-05T19:25:25.084Z,1565033125.084 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2019-08-05T19:25:25.541Z,1565033125.541 [CommandLine](FAULT): Scheduling is paused 2019-08-05T19:25:25.541Z,1565033125.541 [CBIT](INFO): Critical error at 20190805T192525 2019-08-05T19:25:27.736Z,1565033127.736 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004480 2019-08-05T19:25:42.352Z,1565033142.352 [NAL9602](INFO): Powering up NAL9602 2019-08-05T19:25:44.421Z,1565033144.421 [SBIT](IMPORTANT): Beginning Startup BIT 2019-08-05T19:25:44.425Z,1565033144.425 [CBIT](IMPORTANT): Beginning ground fault scan 2019-08-05T19:25:53.376Z,1565033153.376 [NAL9602](INFO): NAL9602 initialized 2019-08-05T19:25:54.195Z,1565033154.195 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:25:55.468Z,1565033155.468 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.009992 CHAN A1 (24V): -0.198634 CHAN A2 (12V): -0.001950 CHAN A3 (5V): -0.001990 CHAN B0 (3.3V): 0.000126 CHAN B1 (3.15aV): -0.000101 CHAN B2 (3.15bV): 4.767929 CHAN B3 (GND): 0.000402 OPEN: -0.000258 Full Scale Calc: 4.765 mA, -1.589 mA 2019-08-05T19:26:38.022Z,1565033198.022 [SBIT](IMPORTANT): SBIT PASSED 2019-08-05T19:26:38.060Z,1565033198.060 [CommandLine](IMPORTANT): got command configSet list 2019-08-05T19:26:38.061Z,1565033198.061 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool; 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=0 count; 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=6 hour; 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): CBIT.abortDepth=296 meter; 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): CBIT.gf24Offset=172 microampere; 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): CBIT.stopDepth=288 meter; 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool; 2019-08-05T19:26:38.062Z,1565033198.062 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2019-08-05T19:26:38.063Z,1565033198.063 [CommandLine](IMPORTANT): DAT.ignoreElevationAngle=1 bool; 2019-08-05T19:26:38.063Z,1565033198.063 [CommandLine](IMPORTANT): DAT.loadAtStartup=0 bool; 2019-08-05T19:26:38.063Z,1565033198.063 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool; 2019-08-05T19:26:38.063Z,1565033198.063 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2019-08-05T19:26:38.063Z,1565033198.063 [CommandLine](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2019-08-05T19:26:38.063Z,1565033198.063 [CommandLine](IMPORTANT): Express linearApproximation DAT.range 5.000000 meter; 2019-08-05T19:26:38.063Z,1565033198.063 [CommandLine](IMPORTANT): Express linearApproximation acoustic_contact_range 10.000000 meter; 2019-08-05T19:26:38.063Z,1565033198.063 [CommandLine](IMPORTANT): Express linearApproximation depth 5.000000 meter; 2019-08-05T19:26:38.064Z,1565033198.064 [CommandLine](IMPORTANT): Express linearApproximation latitude 0.005000 degree; 2019-08-05T19:26:38.064Z,1565033198.064 [CommandLine](IMPORTANT): Express linearApproximation longitude 0.005000 degree; 2019-08-05T19:26:38.064Z,1565033198.064 [CommandLine](IMPORTANT): NAL9602.fastGPSFix=1 bool; 2019-08-05T19:26:38.064Z,1565033198.064 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=274 cubic_centimeter; 2019-08-05T19:26:38.064Z,1565033198.064 [CommandLine](IMPORTANT): VerticalControl.massDefault=-2.3 millimeter; 2019-08-05T19:26:38.064Z,1565033198.064 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitAft=-31 millimeter; 2019-08-05T19:26:38.064Z,1565033198.064 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitFwd=30 millimeter; 2019-08-05T19:26:38.064Z,1565033198.064 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2019-08-05T19:26:38.430Z,1565033198.430 [MissionManager](IMPORTANT): Started mission Startup 2019-08-05T19:26:38.430Z,1565033198.430 [Startup] Running Loop=1 2019-08-05T19:26:38.430Z,1565033198.430 [Startup](DEBUG): Aggregate::initialize Startup 2019-08-05T19:26:38.431Z,1565033198.431 [Startup:A.GoToSurface] Running Loop=1 2019-08-05T19:26:38.431Z,1565033198.431 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-08-05T19:26:38.431Z,1565033198.431 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-08-05T19:26:38.432Z,1565033198.432 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-08-05T19:26:38.432Z,1565033198.432 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-08-05T19:26:38.433Z,1565033198.433 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-08-05T19:26:38.433Z,1565033198.433 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-08-05T19:26:38.434Z,1565033198.434 [Startup:StartupSatComms] Running Loop=1 2019-08-05T19:26:38.434Z,1565033198.434 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-08-05T19:26:38.434Z,1565033198.434 [Startup:StartupSatComms:A] Running Loop=1 2019-08-05T19:26:38.865Z,1565033198.865 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-08-05T19:27:08.409Z,1565033228.409 [CommandLine](IMPORTANT): got command show best platform_orientation 2019-08-05T19:27:08.409Z,1565033228.409 [CommandLine](IMPORTANT): platform_orientation best is null 2019-08-05T19:27:13.605Z,1565033233.605 [CommandLine](IMPORTANT): got command failComponent 2019-08-05T19:27:13.605Z,1565033233.605 [CommandLine](IMPORTANT): Failed components: 2019-08-05T19:27:13.605Z,1565033233.605 [CommandLine](IMPORTANT): No failed Components. 2019-08-05T19:27:15.186Z,1565033235.186 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:27:15.186Z,1565033235.186 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-08-05T19:27:15.187Z,1565033235.187 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:27:15.197Z,1565033235.197 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:27:15.595Z,1565033235.595 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:27:15.595Z,1565033235.595 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-08-05T19:27:38.598Z,1565033258.598 [Startup:StartupSatComms:A](INFO): Timed out from 2019-08-05T19:26:38.4Z 2019-08-05T19:27:38.598Z,1565033258.598 [Startup:StartupSatComms:A] Stopped 2019-08-05T19:27:38.598Z,1565033258.598 [Startup:StartupSatComms:B] Running Loop=1 2019-08-05T19:27:39.005Z,1565033259.005 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-08-05T19:27:45.502Z,1565033265.502 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190805T185919/Courier0004.lzma 2019-08-05T19:27:46.308Z,1565033266.308 [DataOverHttps](INFO): Moved sent file to Logs/20190805T185919/Courier0004.lzma.bak 2019-08-05T19:27:46.309Z,1565033266.309 [DataOverHttps](INFO): SBD MOMSN=11521933 2019-08-05T19:27:56.805Z,1565033276.805 [CommandLine](IMPORTANT): got command configSet list 2019-08-05T19:27:56.805Z,1565033276.805 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-08-05T19:27:56.806Z,1565033276.806 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2019-08-05T19:27:56.806Z,1565033276.806 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool; 2019-08-05T19:27:56.806Z,1565033276.806 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=0 count; 2019-08-05T19:27:56.806Z,1565033276.806 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=6 hour; 2019-08-05T19:27:56.806Z,1565033276.806 [CommandLine](IMPORTANT): CBIT.abortDepth=296 meter; 2019-08-05T19:27:56.806Z,1565033276.806 [CommandLine](IMPORTANT): CBIT.gf24Offset=172 microampere; 2019-08-05T19:27:56.806Z,1565033276.806 [CommandLine](IMPORTANT): CBIT.stopDepth=288 meter; 2019-08-05T19:27:56.807Z,1565033276.807 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool; 2019-08-05T19:27:56.807Z,1565033276.807 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2019-08-05T19:27:56.807Z,1565033276.807 [CommandLine](IMPORTANT): DAT.ignoreElevationAngle=1 bool; 2019-08-05T19:27:56.807Z,1565033276.807 [CommandLine](IMPORTANT): DAT.loadAtStartup=0 bool; 2019-08-05T19:27:56.807Z,1565033276.807 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool; 2019-08-05T19:27:56.807Z,1565033276.807 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2019-08-05T19:27:56.807Z,1565033276.807 [CommandLine](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2019-08-05T19:27:56.807Z,1565033276.807 [CommandLine](IMPORTANT): Express linearApproximation DAT.range 5.000000 meter; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): Express linearApproximation acoustic_contact_range 10.000000 meter; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): Express linearApproximation depth 5.000000 meter; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): Express linearApproximation latitude 0.005000 degree; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): Express linearApproximation longitude 0.005000 degree; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): NAL9602.fastGPSFix=1 bool; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=274 cubic_centimeter; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): VerticalControl.massDefault=-2.3 millimeter; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitAft=-31 millimeter; 2019-08-05T19:27:56.808Z,1565033276.808 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitFwd=30 millimeter; 2019-08-05T19:27:56.809Z,1565033276.809 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2019-08-05T19:27:59.690Z,1565033279.690 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20190805T192505/Courier0000.lzma 2019-08-05T19:28:00.496Z,1565033280.496 [DataOverHttps](INFO): Moved sent file to Logs/20190805T192505/Courier0000.lzma.bak 2019-08-05T19:28:00.497Z,1565033280.497 [DataOverHttps](INFO): SBD MOMSN=11521935 2019-08-05T19:28:13.975Z,1565033293.975 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20190805T185919/Express0005.lzma 2019-08-05T19:28:14.164Z,1565033294.164 [CommandLine](IMPORTANT): got command show variable ahrs 2019-08-05T19:28:14.227Z,1565033294.227 [CommandLine](IMPORTANT): AHRS_3DMGX3.loadControl (none) 2019-08-05T19:28:14.227Z,1565033294.227 [CommandLine](IMPORTANT): AHRS_3DMGX3.uart (none) 2019-08-05T19:28:14.227Z,1565033294.227 [CommandLine](IMPORTANT): AHRS_3DMGX3.baud (bit_per_second) 2019-08-05T19:28:14.228Z,1565033294.228 [CommandLine](IMPORTANT): AHRS_sp3003D.loadControl (none) 2019-08-05T19:28:14.228Z,1565033294.228 [CommandLine](IMPORTANT): AHRS_sp3003D.uart (none) 2019-08-05T19:28:14.228Z,1565033294.228 [CommandLine](IMPORTANT): AHRS_sp3003D.baud (bit_per_second) 2019-08-05T19:28:14.229Z,1565033294.229 [CommandLine](IMPORTANT): AHRS_M2.loadControl (none) 2019-08-05T19:28:14.229Z,1565033294.229 [CommandLine](IMPORTANT): AHRS_M2.uart (none) 2019-08-05T19:28:14.229Z,1565033294.229 [CommandLine](IMPORTANT): AHRS_M2.baud (bit_per_second) 2019-08-05T19:28:14.240Z,1565033294.240 [CommandLine](IMPORTANT): AHRS_3DMGX3.loadAtStartup (bool) 2019-08-05T19:28:14.240Z,1565033294.240 [CommandLine](IMPORTANT): AHRS_3DMGX3.simulateHardware (bool) 2019-08-05T19:28:14.241Z,1565033294.241 [CommandLine](IMPORTANT): AHRS_3DMGX3.magDeviation (degree) 2019-08-05T19:28:14.241Z,1565033294.241 [CommandLine](IMPORTANT): AHRS_3DMGX3.pitchOffset (degree) 2019-08-05T19:28:14.241Z,1565033294.241 [CommandLine](IMPORTANT): AHRS_3DMGX3.power (watt) 2019-08-05T19:28:14.242Z,1565033294.242 [CommandLine](IMPORTANT): AHRS_3DMGX3.rollOffset (degree) 2019-08-05T19:28:14.242Z,1565033294.242 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup (bool) 2019-08-05T19:28:14.242Z,1565033294.242 [CommandLine](IMPORTANT): AHRS_M2.simulateHardware (bool) 2019-08-05T19:28:14.243Z,1565033294.243 [CommandLine](IMPORTANT): AHRS_M2.boresightMatrix (none) 2019-08-05T19:28:14.243Z,1565033294.243 [CommandLine](IMPORTANT): AHRS_M2.magDeviation (degree) 2019-08-05T19:28:14.243Z,1565033294.243 [CommandLine](IMPORTANT): AHRS_M2.minNumPointsCal (count) 2019-08-05T19:28:14.244Z,1565033294.244 [CommandLine](IMPORTANT): AHRS_M2.power (watt) 2019-08-05T19:28:14.244Z,1565033294.244 [CommandLine](IMPORTANT): AHRS_M2.readAccelerations (bool) 2019-08-05T19:28:14.244Z,1565033294.244 [CommandLine](IMPORTANT): AHRS_M2.readAngularVelocities (bool) 2019-08-05T19:28:14.245Z,1565033294.245 [CommandLine](IMPORTANT): AHRS_M2.readMagnetics (bool) 2019-08-05T19:28:14.245Z,1565033294.245 [CommandLine](IMPORTANT): AHRS_M2.verbosity (count) 2019-08-05T19:28:14.245Z,1565033294.245 [CommandLine](IMPORTANT): AHRS_sp3003D.loadAtStartup (bool) 2019-08-05T19:28:14.246Z,1565033294.246 [CommandLine](IMPORTANT): AHRS_sp3003D.simulateHardware (bool) 2019-08-05T19:28:14.246Z,1565033294.246 [CommandLine](IMPORTANT): AHRS_sp3003D.magDeviation (degree) 2019-08-05T19:28:14.247Z,1565033294.247 [CommandLine](IMPORTANT): AHRS_sp3003D.pitchOffset (degree) 2019-08-05T19:28:14.247Z,1565033294.247 [CommandLine](IMPORTANT): AHRS_sp3003D.power (watt) 2019-08-05T19:28:14.247Z,1565033294.247 [CommandLine](IMPORTANT): AHRS_sp3003D.readAccelerations (bool) 2019-08-05T19:28:14.248Z,1565033294.248 [CommandLine](IMPORTANT): AHRS_sp3003D.readMagnetics (bool) 2019-08-05T19:28:14.248Z,1565033294.248 [CommandLine](IMPORTANT): AHRS_sp3003D.rollOffset (degree) 2019-08-05T19:28:14.248Z,1565033294.248 [CommandLine](IMPORTANT): AHRS_sp3003D.verticalMounting (bool) 2019-08-05T19:28:14.780Z,1565033294.780 [DataOverHttps](INFO): Moved sent file to Logs/20190805T185919/Express0005.lzma.bak 2019-08-05T19:28:14.781Z,1565033294.781 [DataOverHttps](INFO): SBD MOMSN=11521939 2019-08-05T19:28:31.200Z,1565033311.200 [DataOverHttps](INFO): Sending 1217 bytes from file Logs/20190805T192505/Express0001.lzma 2019-08-05T19:28:32.004Z,1565033312.004 [DataOverHttps](INFO): Moved sent file to Logs/20190805T192505/Express0001.lzma.bak 2019-08-05T19:28:32.005Z,1565033312.005 [DataOverHttps](INFO): SBD MOMSN=11521947 2019-08-05T19:28:33.556Z,1565033313.556 [Startup:StartupSatComms:B] Stopped 2019-08-05T19:28:33.556Z,1565033313.556 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-08-05T19:28:33.556Z,1565033313.556 [Startup:StartupSatComms] Stopped 2019-08-05T19:28:33.557Z,1565033313.557 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-08-05T19:28:33.557Z,1565033313.557 [Startup](INFO): Completed Startup 2019-08-05T19:28:33.557Z,1565033313.557 [MissionManager](INFO): Startup is completed. 2019-08-05T19:28:33.558Z,1565033313.558 [MissionManager](INFO): Uninitializing Mission Startup 2019-08-05T19:28:33.558Z,1565033313.558 [Startup] Stopped 2019-08-05T19:28:33.558Z,1565033313.558 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-08-05T19:28:33.558Z,1565033313.558 [Startup:A.GoToSurface] Stopped 2019-08-05T19:28:33.558Z,1565033313.558 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-08-05T19:28:33.992Z,1565033313.992 [MissionManager](IMPORTANT): Started mission Default 2019-08-05T19:28:33.992Z,1565033313.992 [Default] Running Loop=1 2019-08-05T19:28:33.992Z,1565033313.992 [Default](DEBUG): Aggregate::initialize Default 2019-08-05T19:28:33.992Z,1565033313.992 [Default:B.GoToSurface] Running Loop=1 2019-08-05T19:28:33.992Z,1565033313.992 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-08-05T19:28:33.993Z,1565033313.993 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-08-05T19:28:33.993Z,1565033313.993 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-08-05T19:28:33.993Z,1565033313.993 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-08-05T19:28:33.994Z,1565033313.994 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-08-05T19:28:33.994Z,1565033313.994 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-08-05T19:28:33.994Z,1565033313.994 [Default:A.Wait] Running Loop=1 2019-08-05T19:28:33.994Z,1565033313.994 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-08-05T19:28:47.330Z,1565033327.330 [Default:A.Wait](INFO): Done Waiting. 2019-08-05T19:28:47.330Z,1565033327.330 [Default:A.Wait] Stopped 2019-08-05T19:28:47.330Z,1565033327.330 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-08-05T19:28:47.737Z,1565033327.737 [Default:CheckIn] Running Loop=1 2019-08-05T19:28:47.737Z,1565033327.737 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-08-05T19:28:47.737Z,1565033327.737 [Default:CheckIn:Read_GPS] Running Loop=1 2019-08-05T19:28:48.163Z,1565033328.163 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-08-05T19:28:55.446Z,1565033335.446 [CommandLine](INFO): End of History 2019-08-05T19:28:55.504Z,1565033335.504 [CommandLine](INFO): End of History 2019-08-05T19:28:55.526Z,1565033335.526 [CommandLine](INFO): End of History 2019-08-05T19:28:55.550Z,1565033335.550 [CommandLine](INFO): End of History 2019-08-05T19:28:55.601Z,1565033335.601 [CommandLine](INFO): End of History 2019-08-05T19:28:55.624Z,1565033335.624 [CommandLine](INFO): End of History 2019-08-05T19:28:55.649Z,1565033335.649 [CommandLine](INFO): End of History 2019-08-05T19:28:55.687Z,1565033335.687 [CommandLine](INFO): End of History 2019-08-05T19:28:55.812Z,1565033335.812 [CommandLine](INFO): End of History 2019-08-05T19:28:55.899Z,1565033335.899 [CommandLine](INFO): End of History 2019-08-05T19:28:55.988Z,1565033335.988 [CommandLine](INFO): End of History 2019-08-05T19:28:56.010Z,1565033336.010 [CommandLine](INFO): End of History 2019-08-05T19:28:56.033Z,1565033336.033 [CommandLine](INFO): End of History 2019-08-05T19:29:10.717Z,1565033350.717 [CommandLine](IMPORTANT): got command show variable ahrs_m2 2019-08-05T19:29:10.812Z,1565033350.812 [CommandLine](IMPORTANT): AHRS_M2.loadControl (none) 2019-08-05T19:29:10.812Z,1565033350.812 [CommandLine](IMPORTANT): AHRS_M2.uart (none) 2019-08-05T19:29:10.813Z,1565033350.813 [CommandLine](IMPORTANT): AHRS_M2.baud (bit_per_second) 2019-08-05T19:29:10.825Z,1565033350.825 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup (bool) 2019-08-05T19:29:10.825Z,1565033350.825 [CommandLine](IMPORTANT): AHRS_M2.simulateHardware (bool) 2019-08-05T19:29:10.825Z,1565033350.825 [CommandLine](IMPORTANT): AHRS_M2.boresightMatrix (none) 2019-08-05T19:29:10.826Z,1565033350.826 [CommandLine](IMPORTANT): AHRS_M2.magDeviation (degree) 2019-08-05T19:29:10.826Z,1565033350.826 [CommandLine](IMPORTANT): AHRS_M2.minNumPointsCal (count) 2019-08-05T19:29:10.826Z,1565033350.826 [CommandLine](IMPORTANT): AHRS_M2.power (watt) 2019-08-05T19:29:10.827Z,1565033350.827 [CommandLine](IMPORTANT): AHRS_M2.readAccelerations (bool) 2019-08-05T19:29:10.827Z,1565033350.827 [CommandLine](IMPORTANT): AHRS_M2.readAngularVelocities (bool) 2019-08-05T19:29:10.828Z,1565033350.828 [CommandLine](IMPORTANT): AHRS_M2.readMagnetics (bool) 2019-08-05T19:29:10.828Z,1565033350.828 [CommandLine](IMPORTANT): AHRS_M2.verbosity (count) 2019-08-05T19:29:16.431Z,1565033356.431 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:29:16.431Z,1565033356.431 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2019-08-05T19:29:16.431Z,1565033356.431 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:29:16.441Z,1565033356.441 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:29:16.832Z,1565033356.832 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:29:16.832Z,1565033356.832 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2019-08-05T19:29:25.612Z,1565033365.612 [CommandLine](IMPORTANT): got command get AHRS_M2.loadAtStartup 2019-08-05T19:29:25.612Z,1565033365.612 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup 0 bool 2019-08-05T19:29:34.595Z,1565033374.595 [CommandLine](IMPORTANT): got command configSet list 2019-08-05T19:29:34.596Z,1565033374.596 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-08-05T19:29:34.596Z,1565033374.596 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=0 count; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=6 hour; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): CBIT.abortDepth=296 meter; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): CBIT.gf24Offset=172 microampere; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): CBIT.stopDepth=288 meter; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2019-08-05T19:29:34.597Z,1565033374.597 [CommandLine](IMPORTANT): DAT.ignoreElevationAngle=1 bool; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): DAT.loadAtStartup=0 bool; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): Express linearApproximation DAT.range 5.000000 meter; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): Express linearApproximation acoustic_contact_range 10.000000 meter; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): Express linearApproximation depth 5.000000 meter; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): Express linearApproximation latitude 0.005000 degree; 2019-08-05T19:29:34.598Z,1565033374.598 [CommandLine](IMPORTANT): Express linearApproximation longitude 0.005000 degree; 2019-08-05T19:29:34.599Z,1565033374.599 [CommandLine](IMPORTANT): NAL9602.fastGPSFix=1 bool; 2019-08-05T19:29:34.599Z,1565033374.599 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=274 cubic_centimeter; 2019-08-05T19:29:34.599Z,1565033374.599 [CommandLine](IMPORTANT): VerticalControl.massDefault=-2.3 millimeter; 2019-08-05T19:29:34.599Z,1565033374.599 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitAft=-31 millimeter; 2019-08-05T19:29:34.599Z,1565033374.599 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitFwd=30 millimeter; 2019-08-05T19:29:34.599Z,1565033374.599 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2019-08-05T19:30:06.874Z,1565033406.874 [CommandLine](INFO): End of History 2019-08-05T19:30:06.928Z,1565033406.928 [CommandLine](INFO): End of History 2019-08-05T19:30:06.958Z,1565033406.958 [CommandLine](INFO): End of History 2019-08-05T19:30:07.015Z,1565033407.015 [CommandLine](INFO): End of History 2019-08-05T19:30:07.067Z,1565033407.067 [CommandLine](INFO): End of History 2019-08-05T19:30:07.089Z,1565033407.089 [CommandLine](INFO): End of History 2019-08-05T19:30:07.111Z,1565033407.111 [CommandLine](INFO): End of History 2019-08-05T19:30:07.134Z,1565033407.134 [CommandLine](INFO): End of History 2019-08-05T19:30:07.156Z,1565033407.156 [CommandLine](INFO): End of History 2019-08-05T19:30:07.211Z,1565033407.211 [CommandLine](INFO): End of History 2019-08-05T19:30:07.244Z,1565033407.244 [CommandLine](INFO): End of History 2019-08-05T19:30:07.266Z,1565033407.266 [CommandLine](INFO): End of History 2019-08-05T19:30:07.387Z,1565033407.387 [CommandLine](INFO): End of History 2019-08-05T19:30:07.427Z,1565033407.427 [CommandLine](INFO): End of History 2019-08-05T19:30:07.450Z,1565033407.450 [CommandLine](INFO): End of History 2019-08-05T19:30:07.472Z,1565033407.472 [CommandLine](INFO): End of History 2019-08-05T19:30:07.520Z,1565033407.520 [CommandLine](INFO): End of History 2019-08-05T19:30:07.542Z,1565033407.542 [CommandLine](INFO): End of History 2019-08-05T19:30:07.564Z,1565033407.564 [CommandLine](INFO): End of History 2019-08-05T19:30:07.600Z,1565033407.599 [CommandLine](INFO): End of History 2019-08-05T19:30:43.882Z,1565033443.882 [CommandLine](IMPORTANT): got command show variable wetlabs 2019-08-05T19:30:43.917Z,1565033443.917 [CommandLine](IMPORTANT): WetLabsBB2FL.loadControl (none) 2019-08-05T19:30:43.918Z,1565033443.918 [CommandLine](IMPORTANT): WetLabsBB2FL.uart (none) 2019-08-05T19:30:43.918Z,1565033443.918 [CommandLine](IMPORTANT): WetLabsBB2FL.baud (bit_per_second) 2019-08-05T19:30:43.918Z,1565033443.918 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.loadControl (none) 2019-08-05T19:30:43.919Z,1565033443.919 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.uart (none) 2019-08-05T19:30:43.919Z,1565033443.919 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.baud (bit_per_second) 2019-08-05T19:30:43.920Z,1565033443.920 [CommandLine](IMPORTANT): WetLabsUBAT.loadContorl (none) 2019-08-05T19:30:43.920Z,1565033443.920 [CommandLine](IMPORTANT): WetLabsUBAT.uart (none) 2019-08-05T19:30:43.920Z,1565033443.920 [CommandLine](IMPORTANT): WetLabsUBAT.baud (bit_per_second) 2019-08-05T19:30:43.931Z,1565033443.931 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup (bool) 2019-08-05T19:30:43.932Z,1565033443.932 [CommandLine](IMPORTANT): WetLabsBB2FL.simulateHardware (bool) 2019-08-05T19:30:43.932Z,1565033443.932 [CommandLine](IMPORTANT): WetLabsBB2FL.chlAccuracy (microgram_per_liter) 2019-08-05T19:30:43.933Z,1565033443.933 [CommandLine](IMPORTANT): WetLabsBB2FL.darkCounts470 (count) 2019-08-05T19:30:43.933Z,1565033443.933 [CommandLine](IMPORTANT): WetLabsBB2FL.darkCounts650 (count) 2019-08-05T19:30:43.933Z,1565033443.933 [CommandLine](IMPORTANT): WetLabsBB2FL.darkCountsChl (count) 2019-08-05T19:30:43.934Z,1565033443.934 [CommandLine](IMPORTANT): WetLabsBB2FL.power (watt) 2019-08-05T19:30:43.934Z,1565033443.934 [CommandLine](IMPORTANT): WetLabsBB2FL.scaleFactor470 (reciprocal_meter_per_steradian_count) 2019-08-05T19:30:43.934Z,1565033443.934 [CommandLine](IMPORTANT): WetLabsBB2FL.scaleFactor650 (reciprocal_meter_per_steradian_count) 2019-08-05T19:30:43.935Z,1565033443.935 [CommandLine](IMPORTANT): WetLabsBB2FL.scaleFactorChl (microgram_per_liter_per_count) 2019-08-05T19:30:43.935Z,1565033443.935 [CommandLine](IMPORTANT): WetLabsBB2FL.serial (none) 2019-08-05T19:30:43.936Z,1565033443.936 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.loadAtStartup (bool) 2019-08-05T19:30:43.936Z,1565033443.936 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.simulateHardware (bool) 2019-08-05T19:30:43.936Z,1565033443.936 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.chlAccuracy (microgram_per_liter) 2019-08-05T19:30:43.937Z,1565033443.937 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.darkCounts700 (count) 2019-08-05T19:30:43.937Z,1565033443.937 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.darkCountsChl (count) 2019-08-05T19:30:43.938Z,1565033443.938 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.darkCountsFDOM (count) 2019-08-05T19:30:43.938Z,1565033443.938 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.darkCountsOil (count) 2019-08-05T19:30:43.938Z,1565033443.938 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.fdomAccuracy (part_per_billion) 2019-08-05T19:30:43.939Z,1565033443.939 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.oilAccuracy (part_per_billion) 2019-08-05T19:30:43.939Z,1565033443.939 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.period (second) 2019-08-05T19:30:43.939Z,1565033443.939 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.power (watt) 2019-08-05T19:30:43.940Z,1565033443.940 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.scaleFactor700 (reciprocal_meter_per_steradian_count) 2019-08-05T19:30:43.940Z,1565033443.940 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.scaleFactorChl (microgram_per_liter_per_count) 2019-08-05T19:30:43.941Z,1565033443.941 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.scaleFactorFDOM (part_per_billion_per_count) 2019-08-05T19:30:43.941Z,1565033443.941 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.scaleFactorOil (part_per_billion_per_count) 2019-08-05T19:30:43.941Z,1565033443.941 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.serial (none) 2019-08-05T19:30:43.942Z,1565033443.942 [CommandLine](IMPORTANT): WetLabsSeaOWL_UV_A.timeout (second) 2019-08-05T19:30:43.942Z,1565033443.942 [CommandLine](IMPORTANT): WetLabsUBAT.loadAtStartup (bool) 2019-08-05T19:30:43.942Z,1565033443.942 [CommandLine](IMPORTANT): WetLabsUBAT.simulateHardware (bool) 2019-08-05T19:30:43.943Z,1565033443.943 [CommandLine](IMPORTANT): WetLabsUBAT.emulateHardware (bool) 2019-08-05T19:30:43.943Z,1565033443.943 [CommandLine](IMPORTANT): WetLabsUBAT.serial (none) 2019-08-05T19:30:43.944Z,1565033443.944 [CommandLine](IMPORTANT): WetLabsUBAT.optionalArgs (none) 2019-08-05T19:30:56.839Z,1565033456.839 [CommandLine](IMPORTANT): got command get WetLabsBB2FL.loadAtStartup 2019-08-05T19:30:56.839Z,1565033456.839 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup 0 bool 2019-08-05T19:30:56.988Z,1565033456.988 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-08-05T19:30:57.807Z,1565033457.807 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:02.255Z,1565033462.255 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:05.487Z,1565033465.487 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:08.315Z,1565033468.315 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:11.547Z,1565033471.547 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:14.375Z,1565033474.375 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:17.203Z,1565033477.203 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:17.235Z,1565033477.235 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:31:17.235Z,1565033477.235 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2019-08-05T19:31:17.235Z,1565033477.235 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:31:17.245Z,1565033477.245 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:31:17.649Z,1565033477.649 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:31:17.649Z,1565033477.649 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2019-08-05T19:31:19.219Z,1565033479.219 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:21.239Z,1565033481.239 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:24.471Z,1565033484.471 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:27.303Z,1565033487.303 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:30.531Z,1565033490.531 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:33.359Z,1565033493.359 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:36.595Z,1565033496.595 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:39.423Z,1565033499.423 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:42.247Z,1565033502.247 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:45.483Z,1565033505.483 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:48.307Z,1565033508.307 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:51.540Z,1565033511.540 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:54.367Z,1565033514.367 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:31:57.603Z,1565033517.603 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:00.431Z,1565033520.431 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:03.255Z,1565033523.255 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:05.275Z,1565033525.275 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:07.299Z,1565033527.299 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:10.531Z,1565033530.531 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:13.359Z,1565033533.359 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:16.587Z,1565033536.587 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:19.415Z,1565033539.415 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:22.647Z,1565033542.647 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:25.479Z,1565033545.479 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:28.303Z,1565033548.303 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:30.327Z,1565033550.327 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:32.343Z,1565033552.343 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:35.579Z,1565033555.579 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:38.407Z,1565033558.407 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:41.639Z,1565033561.639 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:44.463Z,1565033564.463 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:46.898Z,1565033566.898 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2019-08-05T19:32:46.901Z,1565033566.901 [BPC1](INFO): Received data from all battery sticks. 2019-08-05T19:32:47.703Z,1565033567.703 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:50.523Z,1565033570.523 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:53.355Z,1565033573.355 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:55.371Z,1565033575.371 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:32:58.607Z,1565033578.607 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:01.434Z,1565033581.434 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:04.667Z,1565033584.667 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:07.491Z,1565033587.491 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:10.727Z,1565033590.727 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:13.551Z,1565033593.551 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:16.383Z,1565033596.383 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:18.415Z,1565033598.415 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:18.435Z,1565033598.435 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:33:18.435Z,1565033598.435 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2019-08-05T19:33:18.435Z,1565033598.435 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:33:18.462Z,1565033598.462 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:33:18.870Z,1565033598.870 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:33:18.871Z,1565033598.871 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2019-08-05T19:33:20.435Z,1565033600.435 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:23.667Z,1565033603.667 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:26.483Z,1565033606.483 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:29.719Z,1565033609.719 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:32.551Z,1565033612.551 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:35.779Z,1565033615.779 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:38.603Z,1565033618.603 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:41.431Z,1565033621.431 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:43.451Z,1565033623.451 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:46.691Z,1565033626.691 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:47.909Z,1565033627.909 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-08-05T19:28:47.7Z 2019-08-05T19:33:47.909Z,1565033627.909 [Default:CheckIn:Read_GPS] Stopped 2019-08-05T19:33:47.909Z,1565033627.909 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-08-05T19:33:48.317Z,1565033628.317 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-08-05T19:33:49.539Z,1565033629.539 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:52.743Z,1565033632.743 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:53.006Z,1565033633.006 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20190805T192505/Courier0004.lzma 2019-08-05T19:33:53.813Z,1565033633.813 [DataOverHttps](INFO): Moved sent file to Logs/20190805T192505/Courier0004.lzma.bak 2019-08-05T19:33:53.813Z,1565033633.813 [DataOverHttps](INFO): SBD MOMSN=11521991 2019-08-05T19:33:55.575Z,1565033635.575 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:33:58.803Z,1565033638.803 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:01.635Z,1565033641.635 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:04.459Z,1565033644.459 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:06.273Z,1565033646.273 [DataOverHttps](INFO): Sending 1735 bytes from file Logs/20190805T192505/Express0005.lzma 2019-08-05T19:34:06.479Z,1565033646.479 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:07.076Z,1565033647.076 [DataOverHttps](INFO): Moved sent file to Logs/20190805T192505/Express0005.lzma.bak 2019-08-05T19:34:07.076Z,1565033647.076 [DataOverHttps](INFO): SBD MOMSN=11521993 2019-08-05T19:34:08.499Z,1565033648.499 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:08.547Z,1565033648.547 [Default:CheckIn:Read_Iridium] Stopped 2019-08-05T19:34:08.547Z,1565033648.547 [Default:CheckIn:C.Wait] Running Loop=1 2019-08-05T19:34:08.547Z,1565033648.547 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-08-05T19:34:11.731Z,1565033651.731 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:14.559Z,1565033654.559 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:17.791Z,1565033657.791 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:20.619Z,1565033660.619 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:23.851Z,1565033663.851 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:26.683Z,1565033666.683 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:29.507Z,1565033669.507 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:31.531Z,1565033671.531 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:34.759Z,1565033674.759 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:37.591Z,1565033677.591 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:40.819Z,1565033680.819 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:43.651Z,1565033683.651 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:46.883Z,1565033686.883 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:49.711Z,1565033689.711 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:52.535Z,1565033692.535 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:54.559Z,1565033694.559 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:34:57.787Z,1565033697.787 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:00.619Z,1565033700.619 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:03.847Z,1565033703.847 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:06.679Z,1565033706.679 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:09.907Z,1565033709.907 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:12.739Z,1565033712.739 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:15.563Z,1565033715.563 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:17.587Z,1565033717.587 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:19.603Z,1565033719.603 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:19.628Z,1565033719.628 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:35:19.628Z,1565033719.628 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2019-08-05T19:35:19.628Z,1565033719.628 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:35:19.639Z,1565033719.639 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:35:20.119Z,1565033720.119 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:35:20.119Z,1565033720.119 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2019-08-05T19:35:22.835Z,1565033722.835 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:25.663Z,1565033725.663 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:28.899Z,1565033728.899 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:31.723Z,1565033731.723 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:34.955Z,1565033734.955 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:37.787Z,1565033737.787 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:40.615Z,1565033740.615 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:42.631Z,1565033742.631 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:45.863Z,1565033745.863 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:48.691Z,1565033748.691 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:51.923Z,1565033751.923 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:35:54.740Z,1565033754.740 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-08-05T19:35:54.740Z,1565033754.740 [NAL9602] Data Fault, FailCount= 1 2019-08-05T19:35:54.740Z,1565033754.740 [NAL9602](ERROR): Data Fault 2019-08-05T19:35:54.791Z,1565033754.791 [CBIT](ERROR): Data Fault in component: NAL9602 2019-08-05T19:35:55.148Z,1565033755.148 [NAL9602](INFO): Powering down 2019-08-05T19:35:55.977Z,1565033755.977 [CBIT](INFO): Clearing failed state for component NAL9602 2019-08-05T19:35:55.977Z,1565033755.977 [NAL9602] No Fault, FailCount= 1 2019-08-05T19:36:25.448Z,1565033785.448 [NAL9602](INFO): Powering up NAL9602 2019-08-05T19:36:36.352Z,1565033796.352 [NAL9602](INFO): NAL9602 initialized 2019-08-05T19:36:37.171Z,1565033797.171 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:36:40.003Z,1565033800.003 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:36:42.827Z,1565033802.827 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:36:46.063Z,1565033806.063 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:36:48.891Z,1565033808.891 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:36:52.119Z,1565033812.119 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:36:54.947Z,1565033814.947 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:36:58.183Z,1565033818.183 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:01.007Z,1565033821.007 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:03.835Z,1565033823.835 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:05.859Z,1565033825.859 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:09.091Z,1565033829.091 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:11.915Z,1565033831.915 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:15.151Z,1565033835.151 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:17.975Z,1565033837.975 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:20.822Z,1565033840.822 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:37:20.822Z,1565033840.822 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2019-08-05T19:37:20.822Z,1565033840.822 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:37:20.832Z,1565033840.832 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:37:21.207Z,1565033841.207 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:21.260Z,1565033841.260 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:37:21.260Z,1565033841.260 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2019-08-05T19:37:24.038Z,1565033844.038 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:26.867Z,1565033846.867 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:28.883Z,1565033848.883 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:30.907Z,1565033850.907 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:34.139Z,1565033854.139 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:36.967Z,1565033856.967 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:40.199Z,1565033860.199 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:43.027Z,1565033863.027 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:46.259Z,1565033866.259 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:49.087Z,1565033869.087 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:51.911Z,1565033871.911 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:53.931Z,1565033873.931 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:57.163Z,1565033877.163 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:37:59.995Z,1565033879.995 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:03.223Z,1565033883.223 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:06.055Z,1565033886.055 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:09.283Z,1565033889.283 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:12.115Z,1565033892.115 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:14.939Z,1565033894.939 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:16.959Z,1565033896.959 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:18.979Z,1565033898.979 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:22.211Z,1565033902.211 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:25.039Z,1565033905.039 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:28.271Z,1565033908.271 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:31.099Z,1565033911.099 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:34.331Z,1565033914.331 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:37.159Z,1565033917.159 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:39.991Z,1565033919.991 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:42.007Z,1565033922.007 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:45.247Z,1565033925.247 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:48.071Z,1565033928.071 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:51.303Z,1565033931.303 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:54.127Z,1565033934.127 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:38:57.359Z,1565033937.359 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:00.191Z,1565033940.191 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:03.019Z,1565033943.019 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:05.035Z,1565033945.035 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:07.059Z,1565033947.059 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:09.096Z,1565033949.096 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-08-05T19:39:09.096Z,1565033949.096 [Default:CheckIn:C.Wait] Stopped 2019-08-05T19:39:09.096Z,1565033949.096 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-08-05T19:39:09.097Z,1565033949.097 [Default:CheckIn:D] Running Loop=1 2019-08-05T19:39:09.496Z,1565033949.496 [Default:CheckIn:D] Stopped 2019-08-05T19:39:09.496Z,1565033949.496 [Default:CheckIn:E] Running Loop=1 2019-08-05T19:39:09.903Z,1565033949.903 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.591733 min 2019-08-05T19:39:09.903Z,1565033949.903 [Default:CheckIn:E] Stopped 2019-08-05T19:39:09.903Z,1565033949.903 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-08-05T19:39:09.903Z,1565033949.903 [Default:CheckIn] Stopped 2019-08-05T19:39:09.904Z,1565033949.904 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-08-05T19:39:09.904Z,1565033949.904 [Default:CheckIn](INFO): Running loop #2 2019-08-05T19:39:09.904Z,1565033949.904 [Default:CheckIn] Running Loop=2 2019-08-05T19:39:09.904Z,1565033949.904 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-08-05T19:39:09.904Z,1565033949.904 [Default:CheckIn:Read_GPS] Running Loop=1 2019-08-05T19:39:10.291Z,1565033950.291 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:13.115Z,1565033953.115 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:16.351Z,1565033956.351 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:19.175Z,1565033959.175 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:22.038Z,1565033962.038 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:39:22.038Z,1565033962.038 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2019-08-05T19:39:22.038Z,1565033962.038 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:39:22.059Z,1565033962.059 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:39:22.407Z,1565033962.407 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:22.455Z,1565033962.455 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:39:22.455Z,1565033962.455 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2019-08-05T19:39:25.235Z,1565033965.235 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:28.063Z,1565033968.063 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:30.083Z,1565033970.083 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:33.315Z,1565033973.315 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:36.147Z,1565033976.147 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:39.379Z,1565033979.379 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:42.203Z,1565033982.203 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:45.439Z,1565033985.439 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:48.267Z,1565033988.267 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:51.091Z,1565033991.091 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:53.111Z,1565033993.111 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:56.351Z,1565033996.351 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:39:59.171Z,1565033999.171 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:02.403Z,1565034002.403 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:05.235Z,1565034005.235 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:08.467Z,1565034008.467 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:11.295Z,1565034011.295 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:14.127Z,1565034014.127 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:16.139Z,1565034016.139 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:18.163Z,1565034018.163 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:21.391Z,1565034021.391 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:24.219Z,1565034024.219 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:27.451Z,1565034027.451 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:30.283Z,1565034030.283 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:33.511Z,1565034033.511 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:36.339Z,1565034036.339 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:39.167Z,1565034039.167 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:41.191Z,1565034041.191 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:43.207Z,1565034043.207 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:46.443Z,1565034046.443 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:49.267Z,1565034049.267 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:52.495Z,1565034052.495 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:55.345Z,1565034055.345 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:40:58.559Z,1565034058.559 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:01.387Z,1565034061.387 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:04.219Z,1565034064.219 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:06.239Z,1565034066.239 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:09.471Z,1565034069.471 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:12.299Z,1565034072.299 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:15.527Z,1565034075.527 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:18.359Z,1565034078.359 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:21.587Z,1565034081.587 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:23.238Z,1565034083.238 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:41:23.238Z,1565034083.238 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2019-08-05T19:41:23.238Z,1565034083.238 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:41:23.260Z,1565034083.260 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:41:23.663Z,1565034083.663 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:41:23.663Z,1565034083.663 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2019-08-05T19:41:24.415Z,1565034084.415 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:27.247Z,1565034087.247 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:29.263Z,1565034089.263 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:32.495Z,1565034092.495 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:35.323Z,1565034095.323 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:38.559Z,1565034098.559 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:41.383Z,1565034101.383 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:44.615Z,1565034104.615 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:47.443Z,1565034107.443 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:50.275Z,1565034110.275 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:52.295Z,1565034112.295 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:54.311Z,1565034114.311 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:41:57.547Z,1565034117.547 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:00.371Z,1565034120.371 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:03.607Z,1565034123.607 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:06.431Z,1565034126.431 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:09.667Z,1565034129.667 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:12.495Z,1565034132.495 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:15.319Z,1565034135.319 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:17.339Z,1565034137.339 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:20.575Z,1565034140.575 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:23.399Z,1565034143.399 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:26.635Z,1565034146.635 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:29.463Z,1565034149.463 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:32.695Z,1565034152.695 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:35.519Z,1565034155.519 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:38.351Z,1565034158.351 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:40.367Z,1565034160.367 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:42.391Z,1565034162.391 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:45.619Z,1565034165.619 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:48.455Z,1565034168.455 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:51.683Z,1565034171.683 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:54.507Z,1565034174.507 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:42:57.739Z,1565034177.739 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:00.571Z,1565034180.571 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:03.395Z,1565034183.395 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:05.419Z,1565034185.419 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:08.651Z,1565034188.651 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:11.479Z,1565034191.479 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:14.711Z,1565034194.711 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:17.539Z,1565034197.539 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:20.771Z,1565034200.771 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:23.595Z,1565034203.595 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:24.046Z,1565034204.046 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:43:24.046Z,1565034204.046 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2019-08-05T19:43:24.046Z,1565034204.046 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:43:24.068Z,1565034204.068 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:43:24.450Z,1565034204.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:43:24.451Z,1565034204.451 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2019-08-05T19:43:26.427Z,1565034206.427 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:28.443Z,1565034208.443 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:30.463Z,1565034210.463 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:33.699Z,1565034213.699 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:36.523Z,1565034216.523 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:39.755Z,1565034219.755 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:42.583Z,1565034222.583 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:45.815Z,1565034225.815 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:48.647Z,1565034228.647 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:51.471Z,1565034231.471 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:53.491Z,1565034233.491 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:56.723Z,1565034236.723 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:43:59.551Z,1565034239.551 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:02.783Z,1565034242.783 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:05.611Z,1565034245.611 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:08.843Z,1565034248.843 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:10.072Z,1565034250.072 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-08-05T19:39:09.9Z 2019-08-05T19:44:10.072Z,1565034250.072 [Default:CheckIn:Read_GPS] Stopped 2019-08-05T19:44:10.073Z,1565034250.073 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-08-05T19:44:11.675Z,1565034251.675 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:14.503Z,1565034254.503 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:16.519Z,1565034256.519 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:18.539Z,1565034258.539 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:19.202Z,1565034259.202 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190805T192505/Courier0007.lzma 2019-08-05T19:44:20.008Z,1565034260.008 [DataOverHttps](INFO): Moved sent file to Logs/20190805T192505/Courier0007.lzma.bak 2019-08-05T19:44:20.008Z,1565034260.008 [DataOverHttps](INFO): SBD MOMSN=11522225 2019-08-05T19:44:21.771Z,1565034261.771 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:24.599Z,1565034264.599 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:27.835Z,1565034267.835 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:30.659Z,1565034270.659 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:33.891Z,1565034273.891 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:34.227Z,1565034274.227 [DataOverHttps](INFO): Sending 263 bytes from file Logs/20190805T192505/Express0008.lzma 2019-08-05T19:44:35.032Z,1565034275.032 [DataOverHttps](INFO): Moved sent file to Logs/20190805T192505/Express0008.lzma.bak 2019-08-05T19:44:35.033Z,1565034275.033 [DataOverHttps](INFO): SBD MOMSN=11522227 2019-08-05T19:44:36.719Z,1565034276.719 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:36.747Z,1565034276.747 [Default:CheckIn:Read_Iridium] Stopped 2019-08-05T19:44:36.748Z,1565034276.748 [Default:CheckIn:C.Wait] Running Loop=1 2019-08-05T19:44:36.748Z,1565034276.748 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-08-05T19:44:39.547Z,1565034279.547 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:41.567Z,1565034281.567 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:44.803Z,1565034284.803 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:47.627Z,1565034287.627 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:50.863Z,1565034290.863 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:53.687Z,1565034293.687 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:56.923Z,1565034296.923 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:44:59.751Z,1565034299.751 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:02.575Z,1565034302.575 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:04.595Z,1565034304.595 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:06.619Z,1565034306.619 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:09.847Z,1565034309.847 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:12.679Z,1565034312.679 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:15.911Z,1565034315.911 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:18.735Z,1565034318.735 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:21.967Z,1565034321.967 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:24.799Z,1565034324.799 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:24.823Z,1565034324.823 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-08-05T19:45:24.823Z,1565034324.823 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2019-08-05T19:45:24.824Z,1565034324.824 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-08-05T19:45:24.854Z,1565034324.854 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-08-05T19:45:25.236Z,1565034325.236 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-08-05T19:45:25.236Z,1565034325.236 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2019-08-05T19:45:27.627Z,1565034327.627 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:29.647Z,1565034329.647 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:32.879Z,1565034332.879 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:35.707Z,1565034335.707 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:38.939Z,1565034338.939 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:41.763Z,1565034341.763 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:44.995Z,1565034344.995 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:47.823Z,1565034347.823 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:50.663Z,1565034350.663 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:52.675Z,1565034352.675 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:54.695Z,1565034354.695 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:45:57.927Z,1565034357.927 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:46:00.759Z,1565034360.759 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:46:03.987Z,1565034363.987 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:46:06.815Z,1565034366.815 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:46:10.043Z,1565034370.043 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:46:12.203Z,1565034372.203 [CommandLine](IMPORTANT): got command quit 2019-08-05T19:46:12.875Z,1565034372.875 [NAL9602](DEBUG): Fix Requested 2019-08-05T19:46:13.211Z,1565034373.211 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-08-05T19:46:13.211Z,1565034373.211 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.243Z,1565034373.243 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-08-05T19:46:13.243Z,1565034373.243 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.244Z,1565034373.244 [CommandLine](INFO): Join timeout helper Thread ID is 3290 2019-08-05T19:46:13.244Z,1565034373.244 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-08-05T19:46:13.244Z,1565034373.244 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.245Z,1565034373.245 [NavChartDb](INFO): Join timeout helper Thread ID is 3291 2019-08-05T19:46:13.455Z,1565034373.455 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-08-05T19:46:13.455Z,1565034373.455 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.467Z,1565034373.467 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-08-05T19:46:13.467Z,1565034373.467 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.467Z,1565034373.467 [Radio_Surface](INFO): Join timeout helper Thread ID is 3292 2019-08-05T19:46:13.519Z,1565034373.519 [Radio_Surface](INFO): Powering down 2019-08-05T19:46:13.520Z,1565034373.520 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-08-05T19:46:13.520Z,1565034373.520 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.527Z,1565034373.527 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-08-05T19:46:13.527Z,1565034373.527 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.527Z,1565034373.527 [DataOverHttps](INFO): Join timeout helper Thread ID is 3293 2019-08-05T19:46:13.531Z,1565034373.531 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-08-05T19:46:13.531Z,1565034373.531 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.559Z,1565034373.559 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-08-05T19:46:13.559Z,1565034373.559 [logger ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.559Z,1565034373.559 [logger](INFO): Join timeout helper Thread ID is 3294 2019-08-05T19:46:13.567Z,1565034373.567 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-08-05T19:46:13.568Z,1565034373.568 [logger ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.569Z,1565034373.569 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-08-05T19:46:13.569Z,1565034373.569 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.569Z,1565034373.569 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-08-05T19:46:13.569Z,1565034373.569 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.570Z,1565034373.570 [controlThread](INFO): Join timeout helper Thread ID is 3295 2019-08-05T19:46:13.659Z,1565034373.659 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-08-05T19:46:13.659Z,1565034373.659 [controlThread](DEBUG): Uninitializing ControlThread 2019-08-05T19:46:13.660Z,1565034373.660 [NAL9602](INFO): Powering down 2019-08-05T19:46:13.681Z,1565034373.681 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-08-05T19:46:13.682Z,1565034373.682 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-08-05T19:46:13.682Z,1565034373.682 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-08-05T19:46:13.683Z,1565034373.683 [MissionManager](INFO): Uninitializing Mission Default 2019-08-05T19:46:13.683Z,1565034373.683 [Default] Stopped 2019-08-05T19:46:13.683Z,1565034373.683 [Default](DEBUG): Aggregate::uninitialize Default 2019-08-05T19:46:13.683Z,1565034373.683 [Default:B.GoToSurface] Stopped 2019-08-05T19:46:13.683Z,1565034373.683 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-08-05T19:46:13.683Z,1565034373.683 [Default:CheckIn] Stopped 2019-08-05T19:46:13.684Z,1565034373.684 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-08-05T19:46:13.684Z,1565034373.684 [Default:CheckIn:C.Wait] Stopped 2019-08-05T19:46:13.684Z,1565034373.684 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-08-05T19:46:13.686Z,1565034373.686 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-08-05T19:46:13.686Z,1565034373.686 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-08-05T19:46:13.686Z,1565034373.686 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-08-05T19:46:13.687Z,1565034373.687 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-08-05T19:46:13.687Z,1565034373.687 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-08-05T19:46:13.687Z,1565034373.687 [BuoyancyServo](INFO): Powering down 2019-08-05T19:46:13.699Z,1565034373.699 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-08-05T19:46:13.699Z,1565034373.699 [ElevatorServo](INFO): Powering down 2019-08-05T19:46:13.700Z,1565034373.700 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-08-05T19:46:13.700Z,1565034373.700 [MassServo](INFO): Powering down 2019-08-05T19:46:13.701Z,1565034373.701 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-08-05T19:46:13.701Z,1565034373.701 [RudderServo](INFO): Powering down 2019-08-05T19:46:13.702Z,1565034373.702 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-08-05T19:46:13.702Z,1565034373.702 [ThrusterServo](INFO): Powering down 2019-08-05T19:46:13.703Z,1565034373.703 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-08-05T19:46:13.703Z,1565034373.703 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-08-05T19:46:13.703Z,1565034373.703 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-08-05T19:46:13.703Z,1565034373.703 [CBIT](DEBUG): Powering off loads. 2019-08-05T19:46:13.715Z,1565034373.715 [CBIT](DEBUG): Disabling WDT. 2019-08-05T19:46:13.727Z,1565034373.727 [CBIT](DEBUG): Opening all GF detection circuits. 2019-08-05T19:46:13.728Z,1565034373.728 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.815Z,1565034373.815 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.821Z,1565034373.821 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.880Z,1565034373.880 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-08-05T19:46:13.936Z,1565034373.936 [logger ThreadHandler](INFO): Thread cancelled.