2018-11-02T19:56:05.435Z,1541188565.435 [Supervisor](DEBUG): Initializing supervisor. 2018-11-02T19:56:05.438Z,1541188565.438 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-11-02T19:56:05.438Z,1541188565.438 [SyncHandler](INFO): Protected caller Thread ID is 1953 2018-11-02T19:56:05.438Z,1541188565.438 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-11-02T19:56:05.439Z,1541188565.439 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-11-02T19:56:05.440Z,1541188565.440 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1954 2018-11-02T19:56:05.442Z,1541188565.442 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-11-02T19:56:05.454Z,1541188565.454 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-11-02T19:56:05.455Z,1541188565.455 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-11-02T19:56:05.455Z,1541188565.455 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1955 2018-11-02T19:56:05.456Z,1541188565.456 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-11-02T19:56:05.457Z,1541188565.457 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-11-02T19:56:05.457Z,1541188565.457 [logger ThreadHandler](INFO): Protected caller Thread ID is 1956 2018-11-02T19:56:05.459Z,1541188565.459 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-11-02T19:56:05.459Z,1541188565.459 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-11-02T19:56:05.461Z,1541188565.461 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-11-02T19:56:05.890Z,1541188565.890 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-11-02T19:56:05.891Z,1541188565.891 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-11-02T19:56:06.331Z,1541188566.331 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-11-02T19:56:06.331Z,1541188566.331 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-11-02T19:56:06.523Z,1541188566.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-11-02T19:56:06.524Z,1541188566.524 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-11-02T19:56:06.667Z,1541188566.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-11-02T19:56:06.668Z,1541188566.668 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-11-02T19:56:07.103Z,1541188567.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-11-02T19:56:07.104Z,1541188567.104 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-11-02T19:56:07.198Z,1541188567.198 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-11-02T19:56:07.198Z,1541188567.198 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-11-02T19:56:07.339Z,1541188567.339 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-11-02T19:56:07.339Z,1541188567.339 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-11-02T19:56:07.438Z,1541188567.438 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-11-02T19:56:07.439Z,1541188567.439 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-11-02T19:56:07.541Z,1541188567.541 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-11-02T19:56:07.541Z,1541188567.541 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-11-02T19:56:07.955Z,1541188567.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-11-02T19:56:07.956Z,1541188567.956 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-11-02T19:56:08.152Z,1541188568.152 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-11-02T19:56:08.153Z,1541188568.153 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-11-02T19:56:08.362Z,1541188568.362 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-11-02T19:56:08.363Z,1541188568.363 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-11-02T19:56:08.443Z,1541188568.443 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-11-02T19:56:08.791Z,1541188568.791 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-11-02T19:56:08.792Z,1541188568.792 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-11-02T19:56:09.106Z,1541188569.106 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-11-02T19:56:09.108Z,1541188569.108 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2018-11-02T19:56:09.109Z,1541188569.109 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2018-11-02T19:56:09.192Z,1541188569.192 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2018-11-02T19:56:09.340Z,1541188569.340 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2018-11-02T19:56:09.437Z,1541188569.437 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2018-11-02T19:56:09.608Z,1541188569.608 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2018-11-02T19:56:09.689Z,1541188569.689 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2018-11-02T19:56:09.914Z,1541188569.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-11-02T19:56:09.914Z,1541188569.914 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2018-11-02T19:56:10.027Z,1541188570.027 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2018-11-02T19:56:10.125Z,1541188570.125 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2018-11-02T19:56:10.262Z,1541188570.262 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2018-11-02T19:56:10.473Z,1541188570.473 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2018-11-02T19:56:10.825Z,1541188570.825 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2018-11-02T19:56:10.825Z,1541188570.825 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-11-02T19:56:10.831Z,1541188570.831 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-11-02T19:56:10.891Z,1541188570.891 [DepthRateCalculator] Loaded 2018-11-02T19:56:10.892Z,1541188570.892 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-11-02T19:56:10.936Z,1541188570.936 [PitchRateCalculator] Loaded 2018-11-02T19:56:10.936Z,1541188570.936 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-11-02T19:56:10.952Z,1541188570.952 [SpeedCalculator] Loaded 2018-11-02T19:56:10.952Z,1541188570.952 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-11-02T19:56:10.973Z,1541188570.973 [TempGradientCalculator] Loaded 2018-11-02T19:56:10.973Z,1541188570.973 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-11-02T19:56:10.979Z,1541188570.979 [YawRateCalculator] Loaded 2018-11-02T19:56:10.979Z,1541188570.979 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-11-02T19:56:11.125Z,1541188571.125 [ElevatorOffsetCalculator] Loaded 2018-11-02T19:56:11.126Z,1541188571.126 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-11-02T19:56:11.126Z,1541188571.126 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-11-02T19:56:11.127Z,1541188571.127 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-11-02T19:56:11.370Z,1541188571.370 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-11-02T19:56:11.371Z,1541188571.371 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-11-02T19:56:11.662Z,1541188571.662 [DataOverHttps] Loaded 2018-11-02T19:56:11.662Z,1541188571.662 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-11-02T19:56:11.688Z,1541188571.688 [Depth_Keller] Loaded 2018-11-02T19:56:11.688Z,1541188571.688 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-11-02T19:56:11.693Z,1541188571.693 [DropWeight] Loaded 2018-11-02T19:56:11.693Z,1541188571.693 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-11-02T19:56:11.790Z,1541188571.790 [NAL9602] Loaded 2018-11-02T19:56:11.790Z,1541188571.790 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-11-02T19:56:11.806Z,1541188571.806 [Onboard] Loaded 2018-11-02T19:56:11.807Z,1541188571.807 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-11-02T19:56:11.817Z,1541188571.817 [Radio_Surface] Loaded 2018-11-02T19:56:11.817Z,1541188571.817 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-11-02T19:56:11.818Z,1541188571.818 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C34E0 2018-11-02T19:56:11.818Z,1541188571.818 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2036 2018-11-02T19:56:11.825Z,1541188571.825 [SCPI] Loaded 2018-11-02T19:56:11.825Z,1541188571.825 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread. 2018-11-02T19:56:13.574Z,1541188573.574 [BPC1] Loaded 2018-11-02T19:56:13.574Z,1541188573.574 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-11-02T19:56:13.574Z,1541188573.574 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-11-02T19:56:13.575Z,1541188573.575 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-11-02T19:56:13.640Z,1541188573.640 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-11-02T19:56:13.640Z,1541188573.640 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-11-02T19:56:13.736Z,1541188573.736 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-11-02T19:56:13.736Z,1541188573.736 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-11-02T19:56:13.790Z,1541188573.790 [DeadReckonUsingSpeedCalculator] Loaded 2018-11-02T19:56:13.790Z,1541188573.790 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-11-02T19:56:13.806Z,1541188573.806 [NavChart] Loaded 2018-11-02T19:56:13.806Z,1541188573.806 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-11-02T19:56:13.810Z,1541188573.810 [UniversalFixResidualReporter] Loaded 2018-11-02T19:56:13.811Z,1541188573.811 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-11-02T19:56:13.811Z,1541188573.811 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-11-02T19:56:13.812Z,1541188573.812 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-11-02T19:56:14.034Z,1541188574.034 [CTD_NeilBrown] Loaded 2018-11-02T19:56:14.035Z,1541188574.035 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2018-11-02T19:56:14.036Z,1541188574.036 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408CE4E0 2018-11-02T19:56:14.036Z,1541188574.036 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 2037 2018-11-02T19:56:14.085Z,1541188574.085 [WetLabsBB2FL] Loaded 2018-11-02T19:56:14.085Z,1541188574.085 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-11-02T19:56:14.086Z,1541188574.086 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408FE4E0 2018-11-02T19:56:14.087Z,1541188574.087 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2038 2018-11-02T19:56:14.087Z,1541188574.087 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-11-02T19:56:14.088Z,1541188574.088 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-11-02T19:56:14.155Z,1541188574.155 [VerticalControl](DEBUG): Construct VerticalControl. 2018-11-02T19:56:14.254Z,1541188574.254 [VerticalControl] Loaded 2018-11-02T19:56:14.254Z,1541188574.254 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-11-02T19:56:14.255Z,1541188574.255 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-11-02T19:56:14.323Z,1541188574.323 [HorizontalControl] Loaded 2018-11-02T19:56:14.323Z,1541188574.323 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-11-02T19:56:14.324Z,1541188574.324 [SpeedControl](DEBUG): Construct SpeedControl. 2018-11-02T19:56:14.329Z,1541188574.329 [SpeedControl] Loaded 2018-11-02T19:56:14.329Z,1541188574.329 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-11-02T19:56:14.330Z,1541188574.330 [LoopControl](DEBUG): Construct LoopControl. 2018-11-02T19:56:14.330Z,1541188574.330 [LoopControl] Loaded 2018-11-02T19:56:14.331Z,1541188574.331 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-11-02T19:56:14.331Z,1541188574.331 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-11-02T19:56:14.332Z,1541188574.332 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-11-02T19:56:14.345Z,1541188574.345 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-11-02T19:56:14.345Z,1541188574.345 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-11-02T19:56:14.474Z,1541188574.474 [SBIT](DEBUG): Construct Startup Built In Test. 2018-11-02T19:56:14.485Z,1541188574.485 [SBIT] Loaded 2018-11-02T19:56:14.486Z,1541188574.486 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-11-02T19:56:14.486Z,1541188574.486 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-11-02T19:56:14.498Z,1541188574.498 [IBIT] Loaded 2018-11-02T19:56:14.498Z,1541188574.498 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-11-02T19:56:14.501Z,1541188574.501 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-11-02T19:56:14.649Z,1541188574.649 [CBIT] Loaded 2018-11-02T19:56:14.649Z,1541188574.649 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-11-02T19:56:14.650Z,1541188574.650 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-11-02T19:56:14.650Z,1541188574.650 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-11-02T19:56:14.752Z,1541188574.752 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-11-02T19:56:14.752Z,1541188574.752 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-11-02T19:56:14.777Z,1541188574.777 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-11-02T19:56:14.778Z,1541188574.778 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-11-02T19:56:14.876Z,1541188574.876 [BuoyancyServo] Loaded 2018-11-02T19:56:14.876Z,1541188574.876 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-11-02T19:56:14.887Z,1541188574.887 [ElevatorServo] Loaded 2018-11-02T19:56:14.888Z,1541188574.888 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-11-02T19:56:14.898Z,1541188574.898 [MassServo] Loaded 2018-11-02T19:56:14.899Z,1541188574.899 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-11-02T19:56:14.910Z,1541188574.910 [RudderServo] Loaded 2018-11-02T19:56:14.910Z,1541188574.910 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-11-02T19:56:14.921Z,1541188574.921 [ThrusterServo] Loaded 2018-11-02T19:56:14.921Z,1541188574.921 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-11-02T19:56:14.922Z,1541188574.922 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-11-02T19:56:14.925Z,1541188574.925 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-11-02T19:56:14.926Z,1541188574.926 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-11-02T19:56:14.933Z,1541188574.933 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-11-02T19:56:14.934Z,1541188574.934 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0 2018-11-02T19:56:14.934Z,1541188574.934 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2039 2018-11-02T19:56:14.939Z,1541188574.939 [Supervisor](INFO): Main Thread ID is 1952 2018-11-02T19:56:14.939Z,1541188574.939 [Supervisor](DEBUG): Running supervisor. 2018-11-02T19:56:14.939Z,1541188574.939 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2040 2018-11-02T19:56:14.942Z,1541188574.942 [controlThread ThreadHandler](INFO): Handler Thread ID is 2041 2018-11-02T19:56:14.942Z,1541188574.942 [controlThread](DEBUG): Initializing ControlThread 2018-11-02T19:56:14.943Z,1541188574.943 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-11-02T19:56:14.943Z,1541188574.943 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-11-02T19:56:14.944Z,1541188574.944 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-11-02T19:56:14.944Z,1541188574.944 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-11-02T19:56:14.945Z,1541188574.945 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-11-02T19:56:14.945Z,1541188574.945 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-11-02T19:56:14.952Z,1541188574.952 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T19:56:14.953Z,1541188574.953 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T19:56:14.953Z,1541188574.953 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T19:56:14.954Z,1541188574.954 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T19:56:14.954Z,1541188574.954 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T19:56:14.954Z,1541188574.954 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T19:56:14.955Z,1541188574.955 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-11-02T19:56:14.955Z,1541188574.955 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-11-02T19:56:14.955Z,1541188574.955 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-11-02T19:56:14.957Z,1541188574.957 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-11-02T19:56:14.958Z,1541188574.958 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-11-02T19:56:14.958Z,1541188574.958 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-11-02T19:56:14.959Z,1541188574.959 [SBIT](INFO): Initialize SBIT Component. 2018-11-02T19:56:14.959Z,1541188574.959 [SBIT](IMPORTANT): git: 2018-11-02 2018-11-02T19:56:14.959Z,1541188574.959 [SBIT](INFO): git hash: 766718804c5d96cf896f07eddb44b232c8585615 2018-11-02T19:56:14.960Z,1541188574.960 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-11-02T19:56:14.960Z,1541188574.960 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-11-02T19:56:14.961Z,1541188574.961 [SBIT](INFO): Beginning SBIT in 28.000000 seconds. 2018-11-02T19:56:14.961Z,1541188574.961 [IBIT](INFO): Initialize IBIT Component. 2018-11-02T19:56:14.962Z,1541188574.962 [CBIT](DEBUG): Initialize CBIT Component. 2018-11-02T19:56:14.963Z,1541188574.963 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-11-02T19:56:14.963Z,1541188574.963 [logger ThreadHandler](INFO): Handler Thread ID is 2042 2018-11-02T19:56:14.981Z,1541188574.981 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2043 2018-11-02T19:56:14.987Z,1541188574.987 [Radio_Surface](INFO): Powering up 2018-11-02T19:56:14.993Z,1541188574.993 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 2044 2018-11-02T19:56:15.005Z,1541188575.005 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2045 2018-11-02T19:56:15.006Z,1541188575.006 [WetLabsBB2FL](INFO): Powering down 2018-11-02T19:56:15.033Z,1541188575.033 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2046 2018-11-02T19:56:15.036Z,1541188575.036 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-11-02T19:56:15.037Z,1541188575.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-11-02T19:56:15.037Z,1541188575.037 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-11-02T19:56:15.037Z,1541188575.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-11-02T19:56:15.037Z,1541188575.037 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-11-02T19:56:15.037Z,1541188575.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-11-02T19:56:15.038Z,1541188575.038 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-11-02T19:56:15.038Z,1541188575.038 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-11-02T19:56:15.038Z,1541188575.038 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-11-02T19:56:15.038Z,1541188575.038 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-11-02T19:56:15.038Z,1541188575.038 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-11-02T19:56:15.039Z,1541188575.039 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-11-02T19:56:15.039Z,1541188575.039 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-11-02T19:56:15.039Z,1541188575.039 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-11-02T19:56:15.039Z,1541188575.039 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-11-02T19:56:15.039Z,1541188575.039 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-11-02T19:56:15.070Z,1541188575.070 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-11-02T19:56:15.081Z,1541188575.081 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-02T19:56:15.092Z,1541188575.092 [MissionManager](DEBUG): 2018-11-02T19:56:15.109Z,1541188575.109 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-11-02T19:56:15.191Z,1541188575.191 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-11-02T19:56:15.192Z,1541188575.192 [Default:A.Wait](DEBUG): Construct Wait. 2018-11-02T19:56:15.194Z,1541188575.194 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-02T19:56:15.241Z,1541188575.241 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-11-02T19:56:15.254Z,1541188575.254 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-11-02T19:56:15.259Z,1541188575.259 [Default:E.Execute](DEBUG): Construct Execute. 2018-11-02T19:56:15.268Z,1541188575.268 [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 2018-11-02T19:56:15.289Z,1541188575.289 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-11-02T19:56:15.314Z,1541188575.314 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-11-02T19:56:15.753Z,1541188575.753 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-02T19:56:15.761Z,1541188575.761 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-02T19:56:15.775Z,1541188575.775 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-02T19:56:15.781Z,1541188575.781 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-02T19:56:15.803Z,1541188575.803 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-02T19:56:15.809Z,1541188575.809 [MassServo](DEBUG): Initializing MassServo. 2018-11-02T19:56:15.821Z,1541188575.821 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-02T19:56:15.829Z,1541188575.829 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-02T19:56:15.842Z,1541188575.842 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-02T19:56:15.849Z,1541188575.849 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-02T19:56:15.987Z,1541188575.987 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar 2018-11-02T19:56:15.988Z,1541188575.988 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-11-02T19:56:15.988Z,1541188575.988 [DropWeight] Hardware Fault, FailCount= 1 2018-11-02T19:56:15.988Z,1541188575.988 [DropWeight](ERROR): Hardware Fault 2018-11-02T19:56:16.050Z,1541188576.050 [CommandLine](FAULT): Scheduling is paused 2018-11-02T19:56:16.051Z,1541188576.051 [CBIT](INFO): Critical error at 20181102T195615 2018-11-02T19:56:16.051Z,1541188576.051 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-11-02T19:56:16.053Z,1541188576.053 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-11-02T19:56:16.054Z,1541188576.054 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-11-02T19:56:16.709Z,1541188576.709 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-02T19:56:16.709Z,1541188576.709 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-02T19:56:16.709Z,1541188576.709 [BuoyancyServo] Communications Fault, FailCount= 1 2018-11-02T19:56:16.709Z,1541188576.709 [BuoyancyServo](ERROR): Communications Fault 2018-11-02T19:56:16.907Z,1541188576.907 [CBIT](INFO): Critical error at 20181102T195616 2018-11-02T19:56:16.909Z,1541188576.909 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-02T19:56:19.006Z,1541188579.006 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-02T19:56:19.007Z,1541188579.007 [BuoyancyServo] No Fault, FailCount= 1 2018-11-02T19:56:19.351Z,1541188579.351 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-02T19:56:19.470Z,1541188579.470 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-02T19:56:42.122Z,1541188602.122 [NAL9602](INFO): Powering up NAL9602 2018-11-02T19:56:43.369Z,1541188603.369 [SBIT](IMPORTANT): Beginning Startup BIT 2018-11-02T19:56:43.373Z,1541188603.373 [CBIT](IMPORTANT): Beginning ground fault scan 2018-11-02T19:56:56.872Z,1541188616.872 [SBIT](FAULT): Mass: EXPECTED:0.010000 ACTUAL:0.009879 2018-11-02T19:56:57.766Z,1541188617.766 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003859 2018-11-02T19:56:59.913Z,1541188619.913 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.008273 CHAN A1 (24V): 0.001782 CHAN A2 (12V): -0.005291 CHAN A3 (5V): -0.003122 CHAN B0 (3.3V): -0.000934 CHAN B1 (3.15aV): -0.001827 CHAN B2 (3.15bV): -0.001747 CHAN B3 (GND): -0.000268 OPEN: -0.001238 Full Scale Calc: 4.765 mA, -1.589 mA 2018-11-02T19:57:07.366Z,1541188627.366 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T19:57:07.366Z,1541188627.366 [NAL9602] Communications Fault, FailCount= 1 2018-11-02T19:57:07.366Z,1541188627.366 [NAL9602](ERROR): Communications Fault 2018-11-02T19:57:07.478Z,1541188627.478 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T19:57:07.765Z,1541188627.765 [NAL9602](INFO): Powering down 2018-11-02T19:57:08.658Z,1541188628.658 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T19:57:08.658Z,1541188628.658 [NAL9602] No Fault, FailCount= 1 2018-11-02T19:57:13.878Z,1541188633.878 [CommandLine](IMPORTANT): got command failComponent 2018-11-02T19:57:13.879Z,1541188633.879 [CommandLine](IMPORTANT): Failed components: 2018-11-02T19:57:13.879Z,1541188633.879 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-11-02T19:57:37.585Z,1541188657.585 [SBIT](CRITICAL): SBIT FAILED 2018-11-02T19:57:37.634Z,1541188657.634 [CBIT](INFO): Critical error at 20181102T195737 2018-11-02T19:57:37.682Z,1541188657.682 [CommandLine](IMPORTANT): got command configSet list 2018-11-02T19:57:37.682Z,1541188657.682 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2018-11-02T19:57:37.683Z,1541188657.683 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2018-11-02T19:57:37.683Z,1541188657.683 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2018-11-02T19:57:37.683Z,1541188657.683 [CommandLine](IMPORTANT): Depth_Keller.offset=2.34 decibar; 2018-11-02T19:57:37.683Z,1541188657.683 [CommandLine](IMPORTANT): Depth_Keller.scale=38.77 micropascal; 2018-11-02T19:57:37.683Z,1541188657.683 [CommandLine](IMPORTANT): PAR_Licor.loadAtStartup=0 bool; 2018-11-02T19:57:37.946Z,1541188657.946 [NAL9602](INFO): Powering up NAL9602 2018-11-02T19:57:37.985Z,1541188657.985 [MissionManager](IMPORTANT): Started mission Startup 2018-11-02T19:57:37.985Z,1541188657.985 [Startup] Running Loop=1 2018-11-02T19:57:37.985Z,1541188657.985 [Startup](DEBUG): Aggregate::initialize Startup 2018-11-02T19:57:37.985Z,1541188657.985 [Startup:A.GoToSurface] Running Loop=1 2018-11-02T19:57:37.985Z,1541188657.985 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-11-02T19:57:37.986Z,1541188657.986 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-11-02T19:57:37.986Z,1541188657.986 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-11-02T19:57:37.987Z,1541188657.987 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-11-02T19:57:37.987Z,1541188657.987 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-11-02T19:57:37.987Z,1541188657.987 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2018-11-02T19:57:37.994Z,1541188657.994 [Startup:StartupSatComms] Running Loop=1 2018-11-02T19:57:37.994Z,1541188657.994 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2018-11-02T19:57:37.994Z,1541188657.994 [Startup:StartupSatComms:A] Running Loop=1 2018-11-02T19:57:38.384Z,1541188658.384 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2018-11-02T19:57:59.146Z,1541188679.146 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T19:57:59.147Z,1541188679.147 [NAL9602] Communications Fault, FailCount= 2 2018-11-02T19:57:59.147Z,1541188679.147 [NAL9602](ERROR): Communications Fault 2018-11-02T19:57:59.207Z,1541188679.207 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T19:57:59.546Z,1541188679.546 [NAL9602](INFO): Powering down 2018-11-02T19:58:00.390Z,1541188680.390 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T19:58:00.390Z,1541188680.390 [NAL9602] No Fault, FailCount= 2 2018-11-02T19:58:15.237Z,1541188695.237 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T19:58:15.237Z,1541188695.237 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2018-11-02T19:58:15.237Z,1541188695.237 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T19:58:15.239Z,1541188695.239 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T19:58:15.239Z,1541188695.239 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2018-11-02T19:58:15.239Z,1541188695.239 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T19:58:15.252Z,1541188695.252 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T19:58:15.252Z,1541188695.252 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T19:58:15.643Z,1541188695.643 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T19:58:15.643Z,1541188695.643 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2018-11-02T19:58:15.643Z,1541188695.643 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T19:58:15.643Z,1541188695.643 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2018-11-02T19:58:16.036Z,1541188696.036 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T19:58:16.037Z,1541188696.037 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T19:58:16.037Z,1541188696.037 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T19:58:16.038Z,1541188696.038 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T19:58:16.038Z,1541188696.038 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T19:58:16.039Z,1541188696.039 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T19:58:29.599Z,1541188709.599 [NAL9602](INFO): Powering up NAL9602 2018-11-02T19:58:39.907Z,1541188719.907 [Startup:StartupSatComms:A](INFO): Timed out from 2018-11-02T19:57:37.0Z 2018-11-02T19:58:39.907Z,1541188719.907 [Startup:StartupSatComms:A] Stopped 2018-11-02T19:58:39.907Z,1541188719.907 [Startup:StartupSatComms:B] Running Loop=1 2018-11-02T19:58:40.019Z,1541188720.019 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2018-11-02T19:58:44.761Z,1541188724.761 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20181101T212758/Courier0394.lzma 2018-11-02T19:58:45.564Z,1541188725.564 [DataOverHttps](INFO): Moved sent file to Logs/20181101T212758/Courier0394.lzma.bak 2018-11-02T19:58:45.564Z,1541188725.564 [DataOverHttps](INFO): SBD MOMSN=8783263 2018-11-02T19:58:50.302Z,1541188730.302 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T19:58:50.302Z,1541188730.302 [NAL9602] Communications Fault, FailCount= 3 2018-11-02T19:58:50.302Z,1541188730.302 [NAL9602](ERROR): Communications Fault 2018-11-02T19:58:50.341Z,1541188730.341 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T19:58:50.694Z,1541188730.694 [NAL9602](INFO): Powering down 2018-11-02T19:58:54.221Z,1541188734.221 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T19:58:54.221Z,1541188734.221 [NAL9602] No Fault, FailCount= 3 2018-11-02T19:58:54.235Z,1541188734.235 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20181102T195243/Courier0000.lzma 2018-11-02T19:58:55.031Z,1541188735.031 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195243/Courier0000.lzma.bak 2018-11-02T19:58:55.031Z,1541188735.031 [DataOverHttps](INFO): SBD MOMSN=8783266 2018-11-02T19:59:04.005Z,1541188744.005 [DataOverHttps](INFO): Sending 157 bytes from file Logs/20181102T195605/Courier0000.lzma 2018-11-02T19:59:04.803Z,1541188744.803 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Courier0000.lzma.bak 2018-11-02T19:59:04.803Z,1541188744.803 [DataOverHttps](INFO): SBD MOMSN=8783274 2018-11-02T19:59:13.605Z,1541188753.605 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20181101T212758/Express0395.lzma 2018-11-02T19:59:14.403Z,1541188754.403 [DataOverHttps](INFO): Moved sent file to Logs/20181101T212758/Express0395.lzma.bak 2018-11-02T19:59:14.404Z,1541188754.404 [DataOverHttps](INFO): SBD MOMSN=8783280 2018-11-02T19:59:23.014Z,1541188763.014 [NAL9602](INFO): Powering up NAL9602 2018-11-02T19:59:23.101Z,1541188763.101 [DataOverHttps](INFO): Sending 615 bytes from file Logs/20181102T195243/Express0001.lzma 2018-11-02T19:59:23.873Z,1541188763.873 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195243/Express0001.lzma.bak 2018-11-02T19:59:23.873Z,1541188763.873 [DataOverHttps](INFO): SBD MOMSN=8783290 2018-11-02T19:59:32.704Z,1541188772.704 [DataOverHttps](INFO): Sending 968 bytes from file Logs/20181102T195605/Express0001.lzma 2018-11-02T19:59:33.475Z,1541188773.475 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Express0001.lzma.bak 2018-11-02T19:59:33.475Z,1541188773.475 [DataOverHttps](INFO): SBD MOMSN=8783312 2018-11-02T19:59:33.963Z,1541188773.963 [Startup:StartupSatComms:B] Stopped 2018-11-02T19:59:33.963Z,1541188773.963 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2018-11-02T19:59:33.963Z,1541188773.963 [Startup:StartupSatComms] Stopped 2018-11-02T19:59:33.963Z,1541188773.963 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2018-11-02T19:59:33.964Z,1541188773.964 [Startup](INFO): Completed Startup 2018-11-02T19:59:33.964Z,1541188773.964 [MissionManager](INFO): Startup is completed. 2018-11-02T19:59:33.964Z,1541188773.964 [MissionManager](INFO): Uninitializing Mission Startup 2018-11-02T19:59:33.964Z,1541188773.964 [Startup] Stopped 2018-11-02T19:59:33.965Z,1541188773.965 [Startup](DEBUG): Aggregate::uninitialize Startup 2018-11-02T19:59:33.965Z,1541188773.965 [Startup:A.GoToSurface] Stopped 2018-11-02T19:59:33.965Z,1541188773.965 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-11-02T19:59:34.308Z,1541188774.308 [MissionManager](IMPORTANT): Started mission Default 2018-11-02T19:59:34.308Z,1541188774.308 [Default] Running Loop=1 2018-11-02T19:59:34.309Z,1541188774.309 [Default](DEBUG): Aggregate::initialize Default 2018-11-02T19:59:34.309Z,1541188774.309 [Default:B.GoToSurface] Running Loop=1 2018-11-02T19:59:34.309Z,1541188774.309 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-11-02T19:59:34.309Z,1541188774.309 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-11-02T19:59:34.309Z,1541188774.309 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-11-02T19:59:34.310Z,1541188774.310 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-11-02T19:59:34.310Z,1541188774.310 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-11-02T19:59:34.310Z,1541188774.310 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2018-11-02T19:59:34.311Z,1541188774.311 [Default:A.Wait] Running Loop=1 2018-11-02T19:59:34.311Z,1541188774.311 [Default:A.Wait](DEBUG): Initialize Wait Component. 2018-11-02T19:59:43.818Z,1541188783.818 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T19:59:43.818Z,1541188783.818 [NAL9602] Communications Fault, FailCount= 4 2018-11-02T19:59:43.818Z,1541188783.818 [NAL9602](ERROR): Communications Fault 2018-11-02T19:59:43.876Z,1541188783.876 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T19:59:44.218Z,1541188784.218 [NAL9602](INFO): Powering down 2018-11-02T19:59:45.061Z,1541188785.061 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T19:59:45.061Z,1541188785.061 [NAL9602] No Fault, FailCount= 4 2018-11-02T19:59:47.446Z,1541188787.446 [Default:A.Wait](INFO): Done Waiting. 2018-11-02T19:59:47.447Z,1541188787.447 [Default:A.Wait] Stopped 2018-11-02T19:59:47.447Z,1541188787.447 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2018-11-02T19:59:47.856Z,1541188787.856 [Default:CheckIn] Running Loop=1 2018-11-02T19:59:47.856Z,1541188787.856 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-02T19:59:47.856Z,1541188787.856 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-02T19:59:48.258Z,1541188788.258 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2018-11-02T20:00:14.556Z,1541188814.556 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:00:16.192Z,1541188816.192 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:00:16.192Z,1541188816.192 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2018-11-02T20:00:16.192Z,1541188816.192 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:00:16.194Z,1541188816.194 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:00:16.194Z,1541188816.194 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2018-11-02T20:00:16.194Z,1541188816.194 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:00:16.206Z,1541188816.206 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:00:16.207Z,1541188816.207 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:00:16.608Z,1541188816.608 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:00:16.608Z,1541188816.608 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2018-11-02T20:00:16.609Z,1541188816.609 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:00:16.609Z,1541188816.609 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2018-11-02T20:00:16.992Z,1541188816.992 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:00:16.993Z,1541188816.993 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:00:16.993Z,1541188816.993 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:00:16.994Z,1541188816.994 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:00:16.994Z,1541188816.994 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:00:16.994Z,1541188816.994 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:00:35.362Z,1541188835.362 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:00:35.362Z,1541188835.362 [NAL9602] Communications Fault, FailCount= 5 2018-11-02T20:00:35.362Z,1541188835.362 [NAL9602](ERROR): Communications Fault 2018-11-02T20:00:35.418Z,1541188835.418 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:00:35.419Z,1541188835.419 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2018-11-02T20:00:35.758Z,1541188835.758 [NAL9602](INFO): Powering down 2018-11-02T20:00:35.808Z,1541188835.808 [CBIT](INFO): Critical error at 20181102T200035 2018-11-02T20:02:17.289Z,1541188937.289 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:02:17.289Z,1541188937.289 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2018-11-02T20:02:17.289Z,1541188937.289 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:02:17.291Z,1541188937.291 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:02:17.291Z,1541188937.291 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2018-11-02T20:02:17.291Z,1541188937.291 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:02:17.304Z,1541188937.304 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:02:17.304Z,1541188937.304 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:02:17.746Z,1541188937.746 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:02:17.746Z,1541188937.746 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2018-11-02T20:02:17.746Z,1541188937.746 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:02:17.747Z,1541188937.747 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2018-11-02T20:02:18.108Z,1541188938.108 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:02:18.109Z,1541188938.109 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:02:18.109Z,1541188938.109 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:02:18.110Z,1541188938.110 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:02:18.110Z,1541188938.110 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:02:18.110Z,1541188938.110 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:02:35.637Z,1541188955.637 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:02:35.638Z,1541188955.638 [NAL9602] No Fault, FailCount= 5 2018-11-02T20:02:35.994Z,1541188955.994 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:02:52.023Z,1541188972.023 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2018-11-02T20:02:56.794Z,1541188976.794 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:02:56.794Z,1541188976.794 [NAL9602] Communications Fault, FailCount= 1 2018-11-02T20:02:56.794Z,1541188976.794 [NAL9602](ERROR): Communications Fault 2018-11-02T20:02:56.851Z,1541188976.851 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:02:57.194Z,1541188977.194 [NAL9602](INFO): Powering down 2018-11-02T20:02:58.038Z,1541188978.038 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:02:58.038Z,1541188978.038 [NAL9602] No Fault, FailCount= 1 2018-11-02T20:03:27.520Z,1541189007.520 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:03:48.262Z,1541189028.262 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:03:48.262Z,1541189028.262 [NAL9602] Communications Fault, FailCount= 2 2018-11-02T20:03:48.262Z,1541189028.262 [NAL9602](ERROR): Communications Fault 2018-11-02T20:03:48.333Z,1541189028.333 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:03:48.662Z,1541189028.662 [NAL9602](INFO): Powering down 2018-11-02T20:03:49.510Z,1541189029.510 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:03:49.510Z,1541189029.510 [NAL9602] No Fault, FailCount= 2 2018-11-02T20:04:18.558Z,1541189058.558 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:04:18.558Z,1541189058.558 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2018-11-02T20:04:18.558Z,1541189058.558 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:04:18.559Z,1541189058.559 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:04:18.559Z,1541189058.559 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2018-11-02T20:04:18.560Z,1541189058.560 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:04:18.573Z,1541189058.573 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:04:18.573Z,1541189058.573 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:04:18.700Z,1541189058.700 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:04:18.700Z,1541189058.700 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2018-11-02T20:04:18.701Z,1541189058.701 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:04:18.701Z,1541189058.701 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2018-11-02T20:04:18.986Z,1541189058.986 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:04:19.015Z,1541189059.015 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:04:19.016Z,1541189059.016 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:04:19.016Z,1541189059.016 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:04:19.017Z,1541189059.017 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:04:19.017Z,1541189059.017 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:04:19.018Z,1541189059.018 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:04:40.186Z,1541189080.186 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:04:40.186Z,1541189080.186 [NAL9602] Communications Fault, FailCount= 3 2018-11-02T20:04:40.186Z,1541189080.186 [NAL9602](ERROR): Communications Fault 2018-11-02T20:04:40.262Z,1541189080.262 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:04:40.590Z,1541189080.590 [NAL9602](INFO): Powering down 2018-11-02T20:04:41.421Z,1541189081.421 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:04:41.421Z,1541189081.421 [NAL9602] No Fault, FailCount= 3 2018-11-02T20:04:48.217Z,1541189088.217 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-02T19:59:47.9Z 2018-11-02T20:04:48.218Z,1541189088.218 [Default:CheckIn:Read_GPS] Stopped 2018-11-02T20:04:48.218Z,1541189088.218 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-11-02T20:04:48.619Z,1541189088.619 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2018-11-02T20:04:52.550Z,1541189092.550 [DataOverHttps](INFO): Sending 236 bytes from file Logs/20181102T195605/Courier0004.lzma 2018-11-02T20:04:53.339Z,1541189093.339 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Courier0004.lzma.bak 2018-11-02T20:04:53.339Z,1541189093.339 [DataOverHttps](INFO): SBD MOMSN=8783344 2018-11-02T20:05:02.032Z,1541189102.032 [DataOverHttps](INFO): Sending 180 bytes from file Logs/20181102T195605/Express0005.lzma 2018-11-02T20:05:02.799Z,1541189102.799 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Express0005.lzma.bak 2018-11-02T20:05:02.799Z,1541189102.799 [DataOverHttps](INFO): SBD MOMSN=8783347 2018-11-02T20:05:03.283Z,1541189103.283 [Default:CheckIn:Read_Iridium] Stopped 2018-11-02T20:05:03.284Z,1541189103.284 [Default:CheckIn:C.Wait] Running Loop=1 2018-11-02T20:05:03.284Z,1541189103.284 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-11-02T20:05:10.732Z,1541189110.732 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:05:31.534Z,1541189131.534 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:05:31.534Z,1541189131.534 [NAL9602] Communications Fault, FailCount= 4 2018-11-02T20:05:31.534Z,1541189131.534 [NAL9602](ERROR): Communications Fault 2018-11-02T20:05:31.610Z,1541189131.610 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:05:31.934Z,1541189131.934 [NAL9602](INFO): Powering down 2018-11-02T20:05:32.886Z,1541189132.886 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:05:32.886Z,1541189132.886 [NAL9602] No Fault, FailCount= 4 2018-11-02T20:06:02.256Z,1541189162.256 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:06:19.045Z,1541189179.045 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:06:19.045Z,1541189179.045 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2018-11-02T20:06:19.045Z,1541189179.045 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:06:19.047Z,1541189179.047 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:06:19.047Z,1541189179.047 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2018-11-02T20:06:19.047Z,1541189179.047 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:06:19.059Z,1541189179.059 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:06:19.060Z,1541189179.060 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:06:19.453Z,1541189179.453 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:06:19.453Z,1541189179.453 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2018-11-02T20:06:19.454Z,1541189179.454 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:06:19.454Z,1541189179.454 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2018-11-02T20:06:19.844Z,1541189179.844 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:06:19.845Z,1541189179.845 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:06:19.846Z,1541189179.846 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:06:19.846Z,1541189179.846 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:06:19.846Z,1541189179.846 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:06:19.847Z,1541189179.847 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:06:23.410Z,1541189183.410 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:06:23.410Z,1541189183.410 [NAL9602] Communications Fault, FailCount= 5 2018-11-02T20:06:23.410Z,1541189183.410 [NAL9602](ERROR): Communications Fault 2018-11-02T20:06:23.472Z,1541189183.472 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:06:23.472Z,1541189183.472 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2018-11-02T20:06:23.810Z,1541189183.810 [NAL9602](INFO): Powering down 2018-11-02T20:06:23.859Z,1541189183.859 [CBIT](INFO): Critical error at 20181102T200623 2018-11-02T20:08:20.001Z,1541189300.001 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:08:20.001Z,1541189300.001 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2018-11-02T20:08:20.001Z,1541189300.001 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:08:20.003Z,1541189300.003 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:08:20.003Z,1541189300.003 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2018-11-02T20:08:20.003Z,1541189300.003 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:08:20.016Z,1541189300.016 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:08:20.017Z,1541189300.017 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:08:20.414Z,1541189300.414 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:08:20.414Z,1541189300.414 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2018-11-02T20:08:20.414Z,1541189300.414 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:08:20.414Z,1541189300.414 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2018-11-02T20:08:20.801Z,1541189300.801 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:08:20.802Z,1541189300.802 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:08:20.802Z,1541189300.802 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:08:20.803Z,1541189300.803 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:08:20.803Z,1541189300.803 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:08:20.803Z,1541189300.803 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:08:23.622Z,1541189303.622 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:08:23.622Z,1541189303.622 [NAL9602] No Fault, FailCount= 5 2018-11-02T20:08:23.978Z,1541189303.978 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:08:47.526Z,1541189327.526 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:08:47.526Z,1541189327.526 [NAL9602] Communications Fault, FailCount= 1 2018-11-02T20:08:47.526Z,1541189327.526 [NAL9602](ERROR): Communications Fault 2018-11-02T20:08:47.598Z,1541189327.598 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:08:47.926Z,1541189327.926 [NAL9602](INFO): Powering down 2018-11-02T20:08:48.763Z,1541189328.763 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:08:48.763Z,1541189328.763 [NAL9602] No Fault, FailCount= 1 2018-11-02T20:09:18.245Z,1541189358.245 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:09:39.442Z,1541189379.442 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:09:39.442Z,1541189379.442 [NAL9602] Communications Fault, FailCount= 2 2018-11-02T20:09:39.442Z,1541189379.442 [NAL9602](ERROR): Communications Fault 2018-11-02T20:09:39.510Z,1541189379.510 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:09:39.843Z,1541189379.843 [NAL9602](INFO): Powering down 2018-11-02T20:09:40.681Z,1541189380.681 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:09:40.682Z,1541189380.682 [NAL9602] No Fault, FailCount= 2 2018-11-02T20:10:03.782Z,1541189403.782 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-11-02T20:10:03.782Z,1541189403.782 [Default:CheckIn:C.Wait] Stopped 2018-11-02T20:10:03.782Z,1541189403.782 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-11-02T20:10:03.782Z,1541189403.782 [Default:CheckIn:D] Running Loop=1 2018-11-02T20:10:04.193Z,1541189404.193 [Default:CheckIn:D] Stopped 2018-11-02T20:10:04.193Z,1541189404.193 [Default:CheckIn:E] Running Loop=1 2018-11-02T20:10:04.587Z,1541189404.587 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.498046 min 2018-11-02T20:10:04.589Z,1541189404.589 [Default:CheckIn:E] Stopped 2018-11-02T20:10:04.589Z,1541189404.589 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-11-02T20:10:04.589Z,1541189404.589 [Default:CheckIn] Stopped 2018-11-02T20:10:04.590Z,1541189404.590 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-02T20:10:04.590Z,1541189404.590 [Default:CheckIn](INFO): Running loop #2 2018-11-02T20:10:04.590Z,1541189404.590 [Default:CheckIn] Running Loop=2 2018-11-02T20:10:04.590Z,1541189404.590 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-02T20:10:04.590Z,1541189404.590 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-02T20:10:10.166Z,1541189410.166 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:10:22.866Z,1541189422.866 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:10:22.866Z,1541189422.866 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2018-11-02T20:10:22.867Z,1541189422.867 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:10:22.868Z,1541189422.868 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:10:22.868Z,1541189422.868 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2018-11-02T20:10:22.868Z,1541189422.868 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:10:22.882Z,1541189422.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:10:22.882Z,1541189422.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:10:23.003Z,1541189423.003 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:10:23.003Z,1541189423.003 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2018-11-02T20:10:23.004Z,1541189423.004 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:10:23.004Z,1541189423.004 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2018-11-02T20:10:23.321Z,1541189423.321 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:10:23.322Z,1541189423.322 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:10:23.322Z,1541189423.322 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:10:23.322Z,1541189423.322 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:10:23.323Z,1541189423.323 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:10:23.323Z,1541189423.323 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:10:33.294Z,1541189433.294 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:10:33.294Z,1541189433.294 [NAL9602] Communications Fault, FailCount= 3 2018-11-02T20:10:33.294Z,1541189433.294 [NAL9602](ERROR): Communications Fault 2018-11-02T20:10:33.358Z,1541189433.358 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:10:33.694Z,1541189433.694 [NAL9602](INFO): Powering down 2018-11-02T20:10:34.542Z,1541189434.542 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:10:34.542Z,1541189434.542 [NAL9602] No Fault, FailCount= 3 2018-11-02T20:11:04.014Z,1541189464.014 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:11:16.054Z,1541189476.054 [CBIT](INFO): Clearing failed state for component DropWeight 2018-11-02T20:11:16.054Z,1541189476.054 [DropWeight] No Fault, FailCount= 1 2018-11-02T20:11:25.214Z,1541189485.214 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:11:25.215Z,1541189485.215 [NAL9602] Communications Fault, FailCount= 4 2018-11-02T20:11:25.215Z,1541189485.215 [NAL9602](ERROR): Communications Fault 2018-11-02T20:11:25.278Z,1541189485.278 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:11:25.614Z,1541189485.614 [NAL9602](INFO): Powering down 2018-11-02T20:11:26.456Z,1541189486.456 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:11:26.456Z,1541189486.456 [NAL9602] No Fault, FailCount= 4 2018-11-02T20:11:55.939Z,1541189515.939 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:12:18.755Z,1541189538.755 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:12:18.755Z,1541189538.755 [NAL9602] Communications Fault, FailCount= 5 2018-11-02T20:12:18.755Z,1541189538.755 [NAL9602](ERROR): Communications Fault 2018-11-02T20:12:18.826Z,1541189538.826 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:12:18.826Z,1541189538.826 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2018-11-02T20:12:19.150Z,1541189539.150 [NAL9602](INFO): Powering down 2018-11-02T20:12:19.187Z,1541189539.187 [CBIT](INFO): Critical error at 20181102T201218 2018-11-02T20:12:23.569Z,1541189543.569 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:12:23.569Z,1541189543.569 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2018-11-02T20:12:23.569Z,1541189543.569 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:12:23.571Z,1541189543.571 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:12:23.571Z,1541189543.571 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2018-11-02T20:12:23.571Z,1541189543.571 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:12:23.584Z,1541189543.584 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:12:23.584Z,1541189543.584 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:12:23.992Z,1541189543.992 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:12:23.992Z,1541189543.992 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2018-11-02T20:12:23.993Z,1541189543.993 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:12:23.993Z,1541189543.993 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2018-11-02T20:12:24.368Z,1541189544.368 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:12:24.369Z,1541189544.369 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:12:24.369Z,1541189544.369 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:12:24.374Z,1541189544.374 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:12:24.374Z,1541189544.374 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:12:24.374Z,1541189544.374 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:14:18.990Z,1541189658.990 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:14:18.990Z,1541189658.990 [NAL9602] No Fault, FailCount= 5 2018-11-02T20:14:19.346Z,1541189659.346 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:14:24.569Z,1541189664.569 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:14:24.570Z,1541189664.570 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2018-11-02T20:14:24.570Z,1541189664.570 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:14:24.571Z,1541189664.571 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:14:24.571Z,1541189664.571 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2018-11-02T20:14:24.571Z,1541189664.571 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:14:24.584Z,1541189664.584 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:14:24.584Z,1541189664.584 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:14:24.992Z,1541189664.992 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:14:24.992Z,1541189664.992 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2018-11-02T20:14:24.993Z,1541189664.993 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:14:24.993Z,1541189664.993 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2018-11-02T20:14:25.372Z,1541189665.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:14:25.373Z,1541189665.373 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:14:25.373Z,1541189665.373 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:14:25.374Z,1541189665.374 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:14:25.374Z,1541189665.374 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:14:25.374Z,1541189665.374 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:14:40.502Z,1541189680.502 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:14:40.503Z,1541189680.503 [NAL9602] Communications Fault, FailCount= 1 2018-11-02T20:14:40.503Z,1541189680.503 [NAL9602](ERROR): Communications Fault 2018-11-02T20:14:40.569Z,1541189680.569 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:14:40.902Z,1541189680.902 [NAL9602](INFO): Powering down 2018-11-02T20:14:41.746Z,1541189681.746 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:14:41.746Z,1541189681.746 [NAL9602] No Fault, FailCount= 1 2018-11-02T20:15:04.854Z,1541189704.854 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-02T20:10:04.6Z 2018-11-02T20:15:04.854Z,1541189704.854 [Default:CheckIn:Read_GPS] Stopped 2018-11-02T20:15:04.854Z,1541189704.854 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-11-02T20:15:09.162Z,1541189709.162 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20181102T195605/Courier0007.lzma 2018-11-02T20:15:09.963Z,1541189709.963 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Courier0007.lzma.bak 2018-11-02T20:15:09.963Z,1541189709.963 [DataOverHttps](INFO): SBD MOMSN=8783402 2018-11-02T20:15:13.842Z,1541189713.842 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:15:18.666Z,1541189718.666 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20181102T195605/Express0008.lzma 2018-11-02T20:15:19.467Z,1541189719.467 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Express0008.lzma.bak 2018-11-02T20:15:19.470Z,1541189719.470 [DataOverHttps](INFO): SBD MOMSN=8783406 2018-11-02T20:15:19.954Z,1541189719.954 [Default:CheckIn:Read_Iridium] Stopped 2018-11-02T20:15:19.955Z,1541189719.955 [Default:CheckIn:C.Wait] Running Loop=1 2018-11-02T20:15:19.955Z,1541189719.955 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-11-02T20:15:35.015Z,1541189735.015 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:15:35.015Z,1541189735.015 [NAL9602] Communications Fault, FailCount= 2 2018-11-02T20:15:35.015Z,1541189735.015 [NAL9602](ERROR): Communications Fault 2018-11-02T20:15:35.076Z,1541189735.076 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:15:35.414Z,1541189735.414 [NAL9602](INFO): Powering down 2018-11-02T20:15:36.264Z,1541189736.264 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:15:36.264Z,1541189736.264 [NAL9602] No Fault, FailCount= 2 2018-11-02T20:16:05.778Z,1541189765.778 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:16:25.409Z,1541189785.409 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:16:25.409Z,1541189785.409 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2018-11-02T20:16:25.410Z,1541189785.410 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:16:25.411Z,1541189785.411 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:16:25.411Z,1541189785.411 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2018-11-02T20:16:25.411Z,1541189785.411 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:16:25.424Z,1541189785.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:16:25.424Z,1541189785.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:16:25.816Z,1541189785.816 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:16:25.816Z,1541189785.816 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2018-11-02T20:16:25.817Z,1541189785.817 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:16:25.817Z,1541189785.817 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2018-11-02T20:16:26.210Z,1541189786.210 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:16:26.210Z,1541189786.210 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:16:26.211Z,1541189786.211 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:16:26.211Z,1541189786.211 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:16:26.211Z,1541189786.211 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:16:26.212Z,1541189786.212 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:16:26.978Z,1541189786.978 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:16:26.979Z,1541189786.979 [NAL9602] Communications Fault, FailCount= 3 2018-11-02T20:16:26.979Z,1541189786.979 [NAL9602](ERROR): Communications Fault 2018-11-02T20:16:27.062Z,1541189787.062 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:16:27.382Z,1541189787.382 [NAL9602](INFO): Powering down 2018-11-02T20:16:28.239Z,1541189788.239 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:16:28.239Z,1541189788.239 [NAL9602] No Fault, FailCount= 3 2018-11-02T20:16:57.703Z,1541189817.703 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:17:19.230Z,1541189839.230 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:17:19.231Z,1541189839.231 [NAL9602] Communications Fault, FailCount= 4 2018-11-02T20:17:19.231Z,1541189839.231 [NAL9602](ERROR): Communications Fault 2018-11-02T20:17:19.270Z,1541189839.270 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:17:19.635Z,1541189839.635 [NAL9602](INFO): Powering down 2018-11-02T20:17:20.464Z,1541189840.464 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:17:20.464Z,1541189840.464 [NAL9602] No Fault, FailCount= 4 2018-11-02T20:17:49.978Z,1541189869.978 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:18:11.178Z,1541189891.178 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:18:11.179Z,1541189891.179 [NAL9602] Communications Fault, FailCount= 5 2018-11-02T20:18:11.179Z,1541189891.179 [NAL9602](ERROR): Communications Fault 2018-11-02T20:18:11.240Z,1541189891.240 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:18:11.241Z,1541189891.241 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2018-11-02T20:18:11.578Z,1541189891.578 [NAL9602](INFO): Powering down 2018-11-02T20:18:11.626Z,1541189891.626 [CBIT](INFO): Critical error at 20181102T201811 2018-11-02T20:18:26.333Z,1541189906.333 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:18:26.333Z,1541189906.333 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2018-11-02T20:18:26.333Z,1541189906.333 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:18:26.335Z,1541189906.335 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:18:26.335Z,1541189906.335 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2018-11-02T20:18:26.335Z,1541189906.335 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:18:26.348Z,1541189906.348 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:18:26.348Z,1541189906.348 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:18:26.737Z,1541189906.737 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:18:26.737Z,1541189906.737 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2018-11-02T20:18:26.738Z,1541189906.738 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:18:26.738Z,1541189906.738 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2018-11-02T20:18:27.132Z,1541189907.132 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:18:27.133Z,1541189907.133 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:18:27.133Z,1541189907.133 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:18:27.134Z,1541189907.134 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:18:27.134Z,1541189907.134 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:18:27.134Z,1541189907.134 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:20:11.315Z,1541190011.315 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:20:11.315Z,1541190011.315 [NAL9602] No Fault, FailCount= 5 2018-11-02T20:20:11.678Z,1541190011.678 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:20:20.510Z,1541190020.510 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-11-02T20:20:20.510Z,1541190020.510 [Default:CheckIn:C.Wait] Stopped 2018-11-02T20:20:20.510Z,1541190020.510 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-11-02T20:20:20.511Z,1541190020.510 [Default:CheckIn:D] Running Loop=1 2018-11-02T20:20:20.906Z,1541190020.906 [Default:CheckIn:D] Stopped 2018-11-02T20:20:20.906Z,1541190020.906 [Default:CheckIn:E] Running Loop=1 2018-11-02T20:20:21.307Z,1541190021.307 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.776626 min 2018-11-02T20:20:21.308Z,1541190021.308 [Default:CheckIn:E] Stopped 2018-11-02T20:20:21.308Z,1541190021.308 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-11-02T20:20:21.308Z,1541190021.308 [Default:CheckIn] Stopped 2018-11-02T20:20:21.308Z,1541190021.308 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-02T20:20:21.308Z,1541190021.308 [Default:CheckIn](INFO): Running loop #3 2018-11-02T20:20:21.308Z,1541190021.308 [Default:CheckIn] Running Loop=3 2018-11-02T20:20:21.309Z,1541190021.309 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-02T20:20:21.309Z,1541190021.309 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-02T20:20:27.304Z,1541190027.304 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:20:27.304Z,1541190027.304 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2018-11-02T20:20:27.304Z,1541190027.304 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:20:27.306Z,1541190027.306 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:20:27.306Z,1541190027.306 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2018-11-02T20:20:27.306Z,1541190027.306 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:20:27.318Z,1541190027.318 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:20:27.318Z,1541190027.318 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:20:27.732Z,1541190027.732 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:20:27.732Z,1541190027.732 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2018-11-02T20:20:27.733Z,1541190027.733 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:20:27.733Z,1541190027.733 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2018-11-02T20:20:28.108Z,1541190028.108 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:20:28.109Z,1541190028.109 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:20:28.109Z,1541190028.109 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:20:28.110Z,1541190028.110 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:20:28.110Z,1541190028.110 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:20:28.110Z,1541190028.110 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:20:32.878Z,1541190032.878 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:20:32.879Z,1541190032.879 [NAL9602] Communications Fault, FailCount= 1 2018-11-02T20:20:32.879Z,1541190032.879 [NAL9602](ERROR): Communications Fault 2018-11-02T20:20:32.934Z,1541190032.934 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:20:33.278Z,1541190033.278 [NAL9602](INFO): Powering down 2018-11-02T20:20:34.117Z,1541190034.117 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:20:34.117Z,1541190034.117 [NAL9602] No Fault, FailCount= 1 2018-11-02T20:21:03.596Z,1541190063.596 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:21:25.143Z,1541190085.143 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:21:25.143Z,1541190085.143 [NAL9602] Communications Fault, FailCount= 2 2018-11-02T20:21:25.143Z,1541190085.143 [NAL9602](ERROR): Communications Fault 2018-11-02T20:21:25.216Z,1541190085.216 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:21:25.542Z,1541190085.542 [NAL9602](INFO): Powering down 2018-11-02T20:21:26.378Z,1541190086.378 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:21:26.378Z,1541190086.378 [NAL9602] No Fault, FailCount= 2 2018-11-02T20:21:55.862Z,1541190115.862 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:22:17.066Z,1541190137.066 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:22:17.066Z,1541190137.066 [NAL9602] Communications Fault, FailCount= 3 2018-11-02T20:22:17.066Z,1541190137.066 [NAL9602](ERROR): Communications Fault 2018-11-02T20:22:17.098Z,1541190137.098 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:22:17.458Z,1541190137.458 [NAL9602](INFO): Powering down 2018-11-02T20:22:18.301Z,1541190138.301 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:22:18.301Z,1541190138.301 [NAL9602] No Fault, FailCount= 3 2018-11-02T20:22:28.236Z,1541190148.236 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:22:28.236Z,1541190148.236 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2018-11-02T20:22:28.236Z,1541190148.236 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:22:28.237Z,1541190148.237 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:22:28.238Z,1541190148.238 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2018-11-02T20:22:28.238Z,1541190148.238 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:22:28.250Z,1541190148.250 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:22:28.250Z,1541190148.250 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:22:28.647Z,1541190148.647 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:22:28.647Z,1541190148.647 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2018-11-02T20:22:28.648Z,1541190148.648 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:22:28.648Z,1541190148.648 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2018-11-02T20:22:29.040Z,1541190149.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:22:29.041Z,1541190149.041 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:22:29.041Z,1541190149.041 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:22:29.042Z,1541190149.042 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:22:29.042Z,1541190149.042 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:22:29.043Z,1541190149.043 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:22:47.808Z,1541190167.808 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:23:10.530Z,1541190190.530 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:23:10.530Z,1541190190.530 [NAL9602] Communications Fault, FailCount= 4 2018-11-02T20:23:10.530Z,1541190190.530 [NAL9602](ERROR): Communications Fault 2018-11-02T20:23:10.569Z,1541190190.569 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:23:10.926Z,1541190190.926 [NAL9602](INFO): Powering down 2018-11-02T20:23:11.762Z,1541190191.762 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:23:11.762Z,1541190191.762 [NAL9602] No Fault, FailCount= 4 2018-11-02T20:23:41.270Z,1541190221.270 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:24:02.470Z,1541190242.470 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:24:02.471Z,1541190242.471 [NAL9602] Communications Fault, FailCount= 5 2018-11-02T20:24:02.471Z,1541190242.471 [NAL9602](ERROR): Communications Fault 2018-11-02T20:24:02.530Z,1541190242.530 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:24:02.531Z,1541190242.531 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2018-11-02T20:24:02.870Z,1541190242.870 [NAL9602](INFO): Powering down 2018-11-02T20:24:02.919Z,1541190242.919 [CBIT](INFO): Critical error at 20181102T202402 2018-11-02T20:24:29.258Z,1541190269.258 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:24:29.258Z,1541190269.258 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2018-11-02T20:24:29.258Z,1541190269.258 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:24:29.259Z,1541190269.259 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:24:29.259Z,1541190269.259 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2018-11-02T20:24:29.259Z,1541190269.259 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:24:29.272Z,1541190269.272 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:24:29.272Z,1541190269.272 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:24:29.687Z,1541190269.687 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:24:29.687Z,1541190269.687 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2018-11-02T20:24:29.687Z,1541190269.687 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:24:29.687Z,1541190269.687 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2018-11-02T20:24:30.060Z,1541190270.060 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:24:30.060Z,1541190270.060 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:24:30.061Z,1541190270.061 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:24:30.061Z,1541190270.061 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:24:30.062Z,1541190270.062 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:24:30.062Z,1541190270.062 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:24:42.007Z,1541190282.007 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100.000000 cubic_centimeter 2018-11-02T20:24:42.008Z,1541190282.008 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread. 2018-11-02T20:24:42.093Z,1541190282.093 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-11-02T20:25:21.530Z,1541190321.530 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-02T20:20:21.3Z 2018-11-02T20:25:21.531Z,1541190321.531 [Default:CheckIn:Read_GPS] Stopped 2018-11-02T20:25:21.531Z,1541190321.531 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-11-02T20:25:25.878Z,1541190325.878 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20181102T195605/Courier0010.lzma 2018-11-02T20:25:26.679Z,1541190326.679 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Courier0010.lzma.bak 2018-11-02T20:25:26.679Z,1541190326.679 [DataOverHttps](INFO): SBD MOMSN=8783476 2018-11-02T20:25:35.406Z,1541190335.406 [DataOverHttps](INFO): Sending 294 bytes from file Logs/20181102T195605/Express0011.lzma 2018-11-02T20:25:36.199Z,1541190336.199 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Express0011.lzma.bak 2018-11-02T20:25:36.199Z,1541190336.199 [DataOverHttps](INFO): SBD MOMSN=8783480 2018-11-02T20:25:36.694Z,1541190336.694 [Default:CheckIn:Read_Iridium] Stopped 2018-11-02T20:25:36.694Z,1541190336.694 [Default:CheckIn:C.Wait] Running Loop=1 2018-11-02T20:25:36.694Z,1541190336.694 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-11-02T20:26:02.654Z,1541190362.654 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:26:02.654Z,1541190362.654 [NAL9602] No Fault, FailCount= 5 2018-11-02T20:26:02.975Z,1541190362.975 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:26:25.698Z,1541190385.698 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:26:25.699Z,1541190385.699 [NAL9602] Communications Fault, FailCount= 1 2018-11-02T20:26:25.699Z,1541190385.699 [NAL9602](ERROR): Communications Fault 2018-11-02T20:26:25.771Z,1541190385.771 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:26:26.102Z,1541190386.102 [NAL9602](INFO): Powering down 2018-11-02T20:26:26.933Z,1541190386.933 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:26:26.933Z,1541190386.933 [NAL9602] No Fault, FailCount= 1 2018-11-02T20:26:30.129Z,1541190390.129 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:26:30.129Z,1541190390.129 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2018-11-02T20:26:30.129Z,1541190390.129 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:26:30.131Z,1541190390.131 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:26:30.131Z,1541190390.131 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2018-11-02T20:26:30.131Z,1541190390.131 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:26:30.172Z,1541190390.172 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:26:30.172Z,1541190390.172 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:26:30.534Z,1541190390.534 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:26:30.534Z,1541190390.534 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2018-11-02T20:26:30.535Z,1541190390.535 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:26:30.535Z,1541190390.535 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2018-11-02T20:26:30.920Z,1541190390.920 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:26:30.921Z,1541190390.921 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:26:30.921Z,1541190390.921 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:26:30.922Z,1541190390.922 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:26:30.922Z,1541190390.922 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:26:30.922Z,1541190390.922 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:26:56.436Z,1541190416.436 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:27:17.243Z,1541190437.243 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:27:17.243Z,1541190437.243 [NAL9602] Communications Fault, FailCount= 2 2018-11-02T20:27:17.243Z,1541190437.243 [NAL9602](ERROR): Communications Fault 2018-11-02T20:27:17.315Z,1541190437.315 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:27:17.638Z,1541190437.638 [NAL9602](INFO): Powering down 2018-11-02T20:27:18.482Z,1541190438.482 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:27:18.482Z,1541190438.482 [NAL9602] No Fault, FailCount= 2 2018-11-02T20:27:47.958Z,1541190467.958 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:28:11.102Z,1541190491.102 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:28:11.103Z,1541190491.103 [NAL9602] Communications Fault, FailCount= 3 2018-11-02T20:28:11.103Z,1541190491.103 [NAL9602](ERROR): Communications Fault 2018-11-02T20:28:11.182Z,1541190491.182 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:28:11.502Z,1541190491.502 [NAL9602](INFO): Powering down 2018-11-02T20:28:12.341Z,1541190492.341 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:28:12.341Z,1541190492.341 [NAL9602] No Fault, FailCount= 3 2018-11-02T20:28:31.136Z,1541190511.136 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:28:31.136Z,1541190511.136 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2018-11-02T20:28:31.136Z,1541190511.136 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:28:31.138Z,1541190511.138 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:28:31.138Z,1541190511.138 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16 2018-11-02T20:28:31.138Z,1541190511.138 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:28:31.151Z,1541190511.151 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:28:31.151Z,1541190511.151 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:28:31.548Z,1541190511.548 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:28:31.548Z,1541190511.548 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2018-11-02T20:28:31.549Z,1541190511.549 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:28:31.549Z,1541190511.549 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16 2018-11-02T20:28:31.931Z,1541190511.931 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:28:31.932Z,1541190511.932 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:28:31.932Z,1541190511.932 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:28:31.933Z,1541190511.933 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:28:31.933Z,1541190511.933 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:28:31.933Z,1541190511.933 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:28:41.830Z,1541190521.830 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:29:03.027Z,1541190543.027 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:29:03.027Z,1541190543.027 [NAL9602] Communications Fault, FailCount= 4 2018-11-02T20:29:03.027Z,1541190543.027 [NAL9602](ERROR): Communications Fault 2018-11-02T20:29:03.104Z,1541190543.104 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:29:03.424Z,1541190543.424 [NAL9602](INFO): Powering down 2018-11-02T20:29:04.273Z,1541190544.273 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:29:04.274Z,1541190544.274 [NAL9602] No Fault, FailCount= 4 2018-11-02T20:29:33.768Z,1541190573.768 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:29:56.494Z,1541190596.494 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:29:56.495Z,1541190596.495 [NAL9602] Communications Fault, FailCount= 5 2018-11-02T20:29:56.495Z,1541190596.495 [NAL9602](ERROR): Communications Fault 2018-11-02T20:29:56.555Z,1541190596.555 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:29:56.555Z,1541190596.555 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2018-11-02T20:29:56.894Z,1541190596.894 [NAL9602](INFO): Powering down 2018-11-02T20:29:56.952Z,1541190596.952 [CBIT](INFO): Critical error at 20181102T202956 2018-11-02T20:30:32.041Z,1541190632.041 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:30:32.041Z,1541190632.041 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2018-11-02T20:30:32.041Z,1541190632.041 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:30:32.043Z,1541190632.043 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:30:32.043Z,1541190632.043 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17 2018-11-02T20:30:32.043Z,1541190632.043 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:30:32.056Z,1541190632.056 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:30:32.057Z,1541190632.057 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:30:32.450Z,1541190632.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:30:32.450Z,1541190632.450 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2018-11-02T20:30:32.451Z,1541190632.451 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:30:32.451Z,1541190632.451 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17 2018-11-02T20:30:32.844Z,1541190632.844 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:30:32.845Z,1541190632.845 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:30:32.845Z,1541190632.845 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:30:32.846Z,1541190632.846 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:30:32.846Z,1541190632.846 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:30:32.846Z,1541190632.846 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:30:37.247Z,1541190637.247 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-11-02T20:30:37.247Z,1541190637.247 [Default:CheckIn:C.Wait] Stopped 2018-11-02T20:30:37.247Z,1541190637.247 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-11-02T20:30:37.247Z,1541190637.247 [Default:CheckIn:D] Running Loop=1 2018-11-02T20:30:37.647Z,1541190637.647 [Default:CheckIn:D] Stopped 2018-11-02T20:30:37.647Z,1541190637.647 [Default:CheckIn:E] Running Loop=1 2018-11-02T20:30:38.045Z,1541190638.045 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.055642 min 2018-11-02T20:30:38.045Z,1541190638.045 [Default:CheckIn:E] Stopped 2018-11-02T20:30:38.045Z,1541190638.045 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-11-02T20:30:38.045Z,1541190638.045 [Default:CheckIn] Stopped 2018-11-02T20:30:38.046Z,1541190638.046 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-02T20:30:38.046Z,1541190638.046 [Default:CheckIn](INFO): Running loop #4 2018-11-02T20:30:38.046Z,1541190638.046 [Default:CheckIn] Running Loop=4 2018-11-02T20:30:38.046Z,1541190638.046 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-02T20:30:38.046Z,1541190638.046 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-02T20:31:56.718Z,1541190716.718 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:31:56.718Z,1541190716.718 [NAL9602] No Fault, FailCount= 5 2018-11-02T20:31:57.074Z,1541190717.074 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:32:18.195Z,1541190738.195 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:32:18.195Z,1541190738.195 [NAL9602] Communications Fault, FailCount= 1 2018-11-02T20:32:18.195Z,1541190738.195 [NAL9602](ERROR): Communications Fault 2018-11-02T20:32:18.262Z,1541190738.262 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:32:18.594Z,1541190738.594 [NAL9602](INFO): Powering down 2018-11-02T20:32:19.438Z,1541190739.438 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:32:19.438Z,1541190739.438 [NAL9602] No Fault, FailCount= 1 2018-11-02T20:32:33.028Z,1541190753.028 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:32:33.028Z,1541190753.028 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2018-11-02T20:32:33.029Z,1541190753.029 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:32:33.030Z,1541190753.030 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:32:33.030Z,1541190753.030 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 18 2018-11-02T20:32:33.030Z,1541190753.030 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:32:33.043Z,1541190753.043 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:32:33.044Z,1541190753.044 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:32:33.446Z,1541190753.446 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:32:33.446Z,1541190753.446 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2018-11-02T20:32:33.446Z,1541190753.446 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:32:33.446Z,1541190753.446 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 18 2018-11-02T20:32:33.829Z,1541190753.829 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:32:33.829Z,1541190753.829 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:32:33.830Z,1541190753.830 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:32:33.830Z,1541190753.830 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:32:33.830Z,1541190753.830 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:32:33.831Z,1541190753.831 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:32:48.916Z,1541190768.916 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:33:10.118Z,1541190790.118 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:33:10.119Z,1541190790.119 [NAL9602] Communications Fault, FailCount= 2 2018-11-02T20:33:10.119Z,1541190790.119 [NAL9602](ERROR): Communications Fault 2018-11-02T20:33:10.184Z,1541190790.184 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:33:10.518Z,1541190790.518 [NAL9602](INFO): Powering down 2018-11-02T20:33:11.366Z,1541190791.366 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:33:11.366Z,1541190791.366 [NAL9602] No Fault, FailCount= 2 2018-11-02T20:33:40.838Z,1541190820.838 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:34:02.359Z,1541190842.359 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:34:02.359Z,1541190842.359 [NAL9602] Communications Fault, FailCount= 3 2018-11-02T20:34:02.359Z,1541190842.359 [NAL9602](ERROR): Communications Fault 2018-11-02T20:34:02.429Z,1541190842.429 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:34:02.759Z,1541190842.759 [NAL9602](INFO): Powering down 2018-11-02T20:34:03.603Z,1541190843.603 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:34:03.603Z,1541190843.603 [NAL9602] No Fault, FailCount= 3 2018-11-02T20:34:33.119Z,1541190873.119 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:34:33.949Z,1541190873.949 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:34:33.949Z,1541190873.949 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2018-11-02T20:34:33.949Z,1541190873.949 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:34:33.951Z,1541190873.951 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:34:33.951Z,1541190873.951 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 19 2018-11-02T20:34:33.951Z,1541190873.951 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:34:33.965Z,1541190873.965 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:34:33.966Z,1541190873.966 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:34:34.354Z,1541190874.354 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:34:34.354Z,1541190874.354 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2018-11-02T20:34:34.355Z,1541190874.355 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:34:34.355Z,1541190874.355 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 19 2018-11-02T20:34:34.744Z,1541190874.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:34:34.744Z,1541190874.744 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:34:34.744Z,1541190874.744 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:34:34.745Z,1541190874.745 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:34:34.745Z,1541190874.745 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:34:34.746Z,1541190874.746 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:34:54.318Z,1541190894.318 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:34:54.319Z,1541190894.319 [NAL9602] Communications Fault, FailCount= 4 2018-11-02T20:34:54.319Z,1541190894.319 [NAL9602](ERROR): Communications Fault 2018-11-02T20:34:54.381Z,1541190894.381 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:34:54.722Z,1541190894.722 [NAL9602](INFO): Powering down 2018-11-02T20:34:55.559Z,1541190895.559 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-02T20:34:55.559Z,1541190895.559 [NAL9602] No Fault, FailCount= 4 2018-11-02T20:35:25.046Z,1541190925.046 [NAL9602](INFO): Powering up NAL9602 2018-11-02T20:35:38.219Z,1541190938.219 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-02T20:30:38.0Z 2018-11-02T20:35:38.219Z,1541190938.219 [Default:CheckIn:Read_GPS] Stopped 2018-11-02T20:35:38.219Z,1541190938.219 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-11-02T20:35:42.527Z,1541190942.527 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20181102T195605/Courier0013.lzma 2018-11-02T20:35:43.299Z,1541190943.299 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Courier0013.lzma.bak 2018-11-02T20:35:43.299Z,1541190943.299 [DataOverHttps](INFO): SBD MOMSN=8783543 2018-11-02T20:35:47.635Z,1541190947.635 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-02T20:35:47.635Z,1541190947.635 [NAL9602] Communications Fault, FailCount= 5 2018-11-02T20:35:47.635Z,1541190947.635 [NAL9602](ERROR): Communications Fault 2018-11-02T20:35:47.690Z,1541190947.690 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-02T20:35:47.690Z,1541190947.690 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2018-11-02T20:35:48.038Z,1541190948.038 [NAL9602](INFO): Powering down 2018-11-02T20:35:48.095Z,1541190948.095 [CBIT](INFO): Critical error at 20181102T203547 2018-11-02T20:35:51.980Z,1541190951.980 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20181102T195605/Express0014.lzma 2018-11-02T20:35:52.755Z,1541190952.755 [DataOverHttps](INFO): Moved sent file to Logs/20181102T195605/Express0014.lzma.bak 2018-11-02T20:35:52.755Z,1541190952.755 [DataOverHttps](INFO): SBD MOMSN=8783546 2018-11-02T20:35:53.236Z,1541190953.236 [Default:CheckIn:Read_Iridium] Stopped 2018-11-02T20:35:53.236Z,1541190953.236 [Default:CheckIn:C.Wait] Running Loop=1 2018-11-02T20:35:53.236Z,1541190953.236 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-11-02T20:36:35.029Z,1541190995.029 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:36:35.029Z,1541190995.029 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2018-11-02T20:36:35.029Z,1541190995.029 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-02T20:36:35.031Z,1541190995.031 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-02T20:36:35.031Z,1541190995.031 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 20 2018-11-02T20:36:35.031Z,1541190995.031 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-02T20:36:35.044Z,1541190995.044 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-02T20:36:35.044Z,1541190995.044 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-02T20:36:35.449Z,1541190995.449 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-02T20:36:35.449Z,1541190995.449 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2018-11-02T20:36:35.450Z,1541190995.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-02T20:36:35.450Z,1541190995.450 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 20 2018-11-02T20:36:35.836Z,1541190995.836 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-02T20:36:35.837Z,1541190995.837 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:36:35.837Z,1541190995.837 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:36:35.838Z,1541190995.838 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-02T20:36:35.838Z,1541190995.838 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-02T20:36:35.838Z,1541190995.838 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-02T20:36:55.394Z,1541191015.394 [CommandLine](IMPORTANT): got command restart application 2018-11-02T20:36:56.400Z,1541191016.400 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-02T20:36:56.400Z,1541191016.400 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.509Z,1541191016.509 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-11-02T20:36:56.509Z,1541191016.509 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.509Z,1541191016.509 [CommandLine](INFO): Join timeout helper Thread ID is 2067 2018-11-02T20:36:56.510Z,1541191016.510 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-11-02T20:36:56.510Z,1541191016.510 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.510Z,1541191016.510 [NavChartDb](INFO): Join timeout helper Thread ID is 2068 2018-11-02T20:36:56.625Z,1541191016.625 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-02T20:36:56.625Z,1541191016.625 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.629Z,1541191016.629 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-11-02T20:36:56.629Z,1541191016.629 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.629Z,1541191016.629 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2069 2018-11-02T20:36:56.633Z,1541191016.633 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-02T20:36:56.633Z,1541191016.633 [WetLabsBB2FL](INFO): Powering down 2018-11-02T20:36:56.634Z,1541191016.634 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.649Z,1541191016.649 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2018-11-02T20:36:56.649Z,1541191016.649 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.649Z,1541191016.649 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 2070 2018-11-02T20:36:56.809Z,1541191016.809 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-02T20:36:56.809Z,1541191016.809 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.825Z,1541191016.825 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-11-02T20:36:56.825Z,1541191016.825 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.825Z,1541191016.825 [Radio_Surface](INFO): Join timeout helper Thread ID is 2071 2018-11-02T20:36:56.881Z,1541191016.881 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-02T20:36:56.881Z,1541191016.881 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.886Z,1541191016.886 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-11-02T20:36:56.886Z,1541191016.886 [logger ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.886Z,1541191016.886 [logger](INFO): Join timeout helper Thread ID is 2072 2018-11-02T20:36:56.889Z,1541191016.889 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-02T20:36:56.889Z,1541191016.889 [logger ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.905Z,1541191016.905 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-11-02T20:36:56.906Z,1541191016.906 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.906Z,1541191016.906 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-11-02T20:36:56.906Z,1541191016.906 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:56.906Z,1541191016.906 [controlThread](INFO): Join timeout helper Thread ID is 2073 2018-11-02T20:36:56.997Z,1541191016.997 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-02T20:36:56.997Z,1541191016.997 [controlThread](DEBUG): Uninitializing ControlThread 2018-11-02T20:36:56.998Z,1541191016.998 [NAL9602](INFO): Powering down 2018-11-02T20:36:56.000Z,1541191017.000 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-11-02T20:36:57.001Z,1541191017.001 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2018-11-02T20:36:57.001Z,1541191017.001 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-11-02T20:36:57.002Z,1541191017.002 [MissionManager](INFO): Uninitializing Mission Default 2018-11-02T20:36:57.002Z,1541191017.002 [Default] Stopped 2018-11-02T20:36:57.002Z,1541191017.002 [Default](DEBUG): Aggregate::uninitialize Default 2018-11-02T20:36:57.002Z,1541191017.002 [Default:B.GoToSurface] Stopped 2018-11-02T20:36:57.002Z,1541191017.002 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-11-02T20:36:57.002Z,1541191017.002 [Default:CheckIn] Stopped 2018-11-02T20:36:57.002Z,1541191017.002 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-02T20:36:57.002Z,1541191017.002 [Default:CheckIn:C.Wait] Stopped 2018-11-02T20:36:57.002Z,1541191017.002 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-11-02T20:36:57.006Z,1541191017.006 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-11-02T20:36:57.006Z,1541191017.006 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-11-02T20:36:57.006Z,1541191017.006 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-11-02T20:36:57.006Z,1541191017.006 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-11-02T20:36:57.007Z,1541191017.007 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-02T20:36:57.007Z,1541191017.007 [BuoyancyServo](INFO): Powering down 2018-11-02T20:36:57.021Z,1541191017.021 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-02T20:36:57.021Z,1541191017.021 [ElevatorServo](INFO): Powering down 2018-11-02T20:36:57.022Z,1541191017.022 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-02T20:36:57.022Z,1541191017.022 [MassServo](INFO): Powering down 2018-11-02T20:36:57.023Z,1541191017.023 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-02T20:36:57.023Z,1541191017.023 [RudderServo](INFO): Powering down 2018-11-02T20:36:57.024Z,1541191017.024 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-02T20:36:57.024Z,1541191017.024 [ThrusterServo](INFO): Powering down 2018-11-02T20:36:57.025Z,1541191017.025 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-11-02T20:36:57.025Z,1541191017.025 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-11-02T20:36:57.026Z,1541191017.026 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-11-02T20:36:57.026Z,1541191017.026 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:57.106Z,1541191017.106 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:57.146Z,1541191017.146 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:57.148Z,1541191017.148 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:57.198Z,1541191017.198 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-02T20:36:57.250Z,1541191017.250 [logger ThreadHandler](INFO): Thread cancelled.