2023-04-14T15:55:41.897Z,1681487741.897 [Supervisor](DEBUG): Initializing supervisor. 2023-04-14T15:55:41.901Z,1681487741.901 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-04-14T15:55:41.902Z,1681487741.902 [SyncHandler](INFO): Protected caller Thread ID is 2956 2023-04-14T15:55:41.902Z,1681487741.902 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-04-14T15:55:41.903Z,1681487741.903 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-04-14T15:55:41.904Z,1681487741.904 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2957 2023-04-14T15:55:41.907Z,1681487741.907 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-04-14T15:55:41.925Z,1681487741.925 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-04-14T15:55:41.926Z,1681487741.926 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-04-14T15:55:41.926Z,1681487741.926 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2958 2023-04-14T15:55:41.930Z,1681487741.930 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-04-14T15:55:41.931Z,1681487741.931 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-04-14T15:55:41.931Z,1681487741.931 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2959 2023-04-14T15:55:41.934Z,1681487741.934 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-04-14T15:55:41.934Z,1681487741.934 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-04-14T15:55:41.935Z,1681487741.935 [logger ThreadHandler](INFO): Protected caller Thread ID is 2960 2023-04-14T15:55:41.938Z,1681487741.938 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-04-14T15:55:41.939Z,1681487741.939 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-04-14T15:55:41.940Z,1681487741.940 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-04-14T15:55:42.144Z,1681487742.144 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-04-14T15:55:42.144Z,1681487742.144 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-04-14T15:55:42.246Z,1681487742.246 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-04-14T15:55:42.247Z,1681487742.247 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-04-14T15:55:42.338Z,1681487742.338 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-04-14T15:55:42.339Z,1681487742.339 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-04-14T15:55:42.773Z,1681487742.773 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-04-14T15:55:42.773Z,1681487742.773 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-04-14T15:55:43.103Z,1681487743.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-04-14T15:55:43.103Z,1681487743.103 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-04-14T15:55:43.419Z,1681487743.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-04-14T15:55:43.420Z,1681487743.420 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-04-14T15:55:43.594Z,1681487743.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-04-14T15:55:43.594Z,1681487743.594 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-04-14T15:55:43.671Z,1681487743.671 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-04-14T15:55:43.750Z,1681487743.750 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-04-14T15:55:44.128Z,1681487744.128 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-04-14T15:55:44.128Z,1681487744.128 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-04-14T15:55:44.402Z,1681487744.402 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-04-14T15:55:44.402Z,1681487744.402 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-04-14T15:55:44.954Z,1681487744.954 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-04-14T15:55:44.954Z,1681487744.954 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-04-14T15:55:45.161Z,1681487745.161 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-04-14T15:55:45.162Z,1681487745.162 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-04-14T15:55:45.391Z,1681487745.391 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-04-14T15:55:45.391Z,1681487745.391 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-04-14T15:55:45.524Z,1681487745.524 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-04-14T15:55:45.525Z,1681487745.525 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-04-14T15:55:46.263Z,1681487746.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-04-14T15:55:46.265Z,1681487746.265 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2023-04-14T15:55:46.266Z,1681487746.266 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2023-04-14T15:55:46.346Z,1681487746.346 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2023-04-14T15:55:46.516Z,1681487746.516 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2023-04-14T15:55:46.789Z,1681487746.789 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-04-14T15:55:46.789Z,1681487746.789 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2023-04-14T15:55:47.141Z,1681487747.141 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2023-04-14T15:55:47.395Z,1681487747.395 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2023-04-14T15:55:47.582Z,1681487747.582 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2023-04-14T15:55:47.685Z,1681487747.685 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2023-04-14T15:55:47.775Z,1681487747.775 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2023-04-14T15:55:47.858Z,1681487747.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2023-04-14T15:55:47.952Z,1681487747.952 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2023-04-14T15:55:48.104Z,1681487748.104 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2023-04-14T15:55:48.105Z,1681487748.105 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-04-14T15:55:48.120Z,1681487748.120 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-04-14T15:55:48.171Z,1681487748.171 [DepthRateCalculator] Loaded 2023-04-14T15:55:48.171Z,1681487748.171 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-04-14T15:55:48.176Z,1681487748.176 [PitchRateCalculator] Loaded 2023-04-14T15:55:48.176Z,1681487748.176 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-04-14T15:55:48.186Z,1681487748.186 [SpeedCalculator] Loaded 2023-04-14T15:55:48.187Z,1681487748.187 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-04-14T15:55:48.201Z,1681487748.201 [VerticalHomogeneityIndexCalculator] Loaded 2023-04-14T15:55:48.202Z,1681487748.202 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread. 2023-04-14T15:55:48.206Z,1681487748.206 [YawRateCalculator] Loaded 2023-04-14T15:55:48.207Z,1681487748.207 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-04-14T15:55:48.227Z,1681487748.227 [ElevatorOffsetCalculator] Loaded 2023-04-14T15:55:48.228Z,1681487748.228 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-04-14T15:55:48.228Z,1681487748.228 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-04-14T15:55:48.229Z,1681487748.229 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-04-14T15:55:48.255Z,1681487748.255 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-04-14T15:55:48.256Z,1681487748.256 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-04-14T15:55:48.266Z,1681487748.266 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-04-14T15:55:48.266Z,1681487748.266 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-04-14T15:55:48.678Z,1681487748.678 [AHRS_M2] Loaded 2023-04-14T15:55:48.678Z,1681487748.678 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-04-14T15:55:48.712Z,1681487748.712 [BackseatComponent] Loaded 2023-04-14T15:55:48.712Z,1681487748.712 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-04-14T15:55:48.713Z,1681487748.713 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408474E0 2023-04-14T15:55:48.714Z,1681487748.714 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3043 2023-04-14T15:55:48.716Z,1681487748.716 [LcmUniversalReporter] Loaded 2023-04-14T15:55:48.717Z,1681487748.717 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-04-14T15:55:49.514Z,1681487749.514 [BPC1] Loaded 2023-04-14T15:55:49.515Z,1681487749.515 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-04-14T15:55:49.588Z,1681487749.588 [DataOverHttps] Loaded 2023-04-14T15:55:49.588Z,1681487749.588 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-04-14T15:55:49.589Z,1681487749.589 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408774E0 2023-04-14T15:55:49.589Z,1681487749.589 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3044 2023-04-14T15:55:49.610Z,1681487749.610 [Depth_Keller] Loaded 2023-04-14T15:55:49.610Z,1681487749.610 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-04-14T15:55:49.615Z,1681487749.615 [DropWeight] Loaded 2023-04-14T15:55:49.615Z,1681487749.615 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-04-14T15:55:49.676Z,1681487749.676 [NAL9602] Loaded 2023-04-14T15:55:49.677Z,1681487749.677 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-04-14T15:55:49.705Z,1681487749.705 [Onboard] Loaded 2023-04-14T15:55:49.706Z,1681487749.706 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-04-14T15:55:49.707Z,1681487749.707 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408A74E0 2023-04-14T15:55:49.707Z,1681487749.707 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3045 2023-04-14T15:55:49.713Z,1681487749.713 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2023-04-14T15:55:49.724Z,1681487749.724 [PowerOnly] Loaded 2023-04-14T15:55:49.724Z,1681487749.724 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2023-04-14T15:55:49.736Z,1681487749.736 [Power24vConverter] Loaded 2023-04-14T15:55:49.736Z,1681487749.736 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-04-14T15:55:49.750Z,1681487749.750 [Radio_Surface] Loaded 2023-04-14T15:55:49.750Z,1681487749.750 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-04-14T15:55:49.751Z,1681487749.751 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408D74E0 2023-04-14T15:55:49.752Z,1681487749.752 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3046 2023-04-14T15:55:49.753Z,1681487749.753 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-04-14T15:55:49.753Z,1681487749.753 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-04-14T15:55:49.863Z,1681487749.863 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-04-14T15:55:49.863Z,1681487749.863 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-04-14T15:55:49.904Z,1681487749.904 [DeadReckonUsingSpeedCalculator] Loaded 2023-04-14T15:55:49.904Z,1681487749.904 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2023-04-14T15:55:49.918Z,1681487749.918 [NavChart] Loaded 2023-04-14T15:55:49.918Z,1681487749.918 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-04-14T15:55:49.923Z,1681487749.923 [UniversalFixResidualReporter] Loaded 2023-04-14T15:55:49.923Z,1681487749.923 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-04-14T15:55:49.924Z,1681487749.924 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-04-14T15:55:49.925Z,1681487749.925 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-04-14T15:55:50.065Z,1681487750.065 [SBIT](DEBUG): Construct Startup Built In Test. 2023-04-14T15:55:50.079Z,1681487750.079 [SBIT] Loaded 2023-04-14T15:55:50.079Z,1681487750.079 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-04-14T15:55:50.082Z,1681487750.082 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-04-14T15:55:50.094Z,1681487750.094 [IBIT] Loaded 2023-04-14T15:55:50.094Z,1681487750.094 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-04-14T15:55:50.100Z,1681487750.100 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-04-14T15:55:50.200Z,1681487750.200 [CBIT] Loaded 2023-04-14T15:55:50.201Z,1681487750.201 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-04-14T15:55:50.201Z,1681487750.201 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-04-14T15:55:50.201Z,1681487750.201 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-04-14T15:55:50.369Z,1681487750.369 [CTD_Seabird] Loaded 2023-04-14T15:55:50.369Z,1681487750.369 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-04-14T15:55:50.370Z,1681487750.370 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0 2023-04-14T15:55:50.370Z,1681487750.370 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3047 2023-04-14T15:55:50.391Z,1681487750.391 [PAR_Licor] Loaded 2023-04-14T15:55:50.391Z,1681487750.391 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-04-14T15:55:50.421Z,1681487750.421 [WetLabsBB2FL] Loaded 2023-04-14T15:55:50.422Z,1681487750.422 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-04-14T15:55:50.423Z,1681487750.423 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A0B4E0 2023-04-14T15:55:50.423Z,1681487750.423 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3048 2023-04-14T15:55:50.424Z,1681487750.424 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-04-14T15:55:50.424Z,1681487750.424 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-04-14T15:55:50.555Z,1681487750.555 [BuoyancyServo] Loaded 2023-04-14T15:55:50.555Z,1681487750.555 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-04-14T15:55:50.577Z,1681487750.577 [ElevatorServo] Loaded 2023-04-14T15:55:50.577Z,1681487750.577 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-04-14T15:55:50.597Z,1681487750.597 [MassServo] Loaded 2023-04-14T15:55:50.598Z,1681487750.598 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-04-14T15:55:50.618Z,1681487750.618 [RudderServo] Loaded 2023-04-14T15:55:50.619Z,1681487750.619 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-04-14T15:55:50.634Z,1681487750.634 [ThrusterHE] Loaded 2023-04-14T15:55:50.634Z,1681487750.634 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-04-14T15:55:50.635Z,1681487750.635 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-04-14T15:55:50.635Z,1681487750.635 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-04-14T15:55:50.685Z,1681487750.685 [VerticalControl](DEBUG): Construct VerticalControl. 2023-04-14T15:55:50.735Z,1681487750.735 [VerticalControl] Loaded 2023-04-14T15:55:50.735Z,1681487750.735 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-04-14T15:55:50.738Z,1681487750.738 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-04-14T15:55:50.775Z,1681487750.775 [HorizontalControl] Loaded 2023-04-14T15:55:50.775Z,1681487750.775 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-04-14T15:55:50.778Z,1681487750.778 [SpeedControl](DEBUG): Construct SpeedControl. 2023-04-14T15:55:50.779Z,1681487750.779 [SpeedControl] Loaded 2023-04-14T15:55:50.780Z,1681487750.780 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-04-14T15:55:50.782Z,1681487750.782 [LoopControl](DEBUG): Construct LoopControl. 2023-04-14T15:55:50.783Z,1681487750.783 [LoopControl] Loaded 2023-04-14T15:55:50.783Z,1681487750.783 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-04-14T15:55:50.784Z,1681487750.784 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-04-14T15:55:50.784Z,1681487750.784 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-04-14T15:55:50.882Z,1681487750.882 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-04-14T15:55:50.883Z,1681487750.883 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-04-14T15:55:51.031Z,1681487751.031 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-04-14T15:55:51.031Z,1681487751.031 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-04-14T15:55:51.331Z,1681487751.331 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-04-14T15:55:51.332Z,1681487751.332 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-04-14T15:55:51.403Z,1681487751.403 [StratificationFrontDetector](INFO): thresholdVTHI set to: 0.399988 degC 2023-04-14T15:55:51.404Z,1681487751.404 [StratificationFrontDetector](DEBUG): (re)initializing 2023-04-14T15:55:51.404Z,1681487751.404 [StratificationFrontDetector] Loaded 2023-04-14T15:55:51.404Z,1681487751.404 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2023-04-14T15:55:51.405Z,1681487751.405 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-04-14T15:55:51.411Z,1681487751.411 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-04-14T15:55:51.414Z,1681487751.414 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-04-14T15:55:51.425Z,1681487751.425 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-04-14T15:55:51.426Z,1681487751.426 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BAE4E0 2023-04-14T15:55:51.426Z,1681487751.426 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3049 2023-04-14T15:55:51.430Z,1681487751.430 [Supervisor](INFO): Main Thread ID is 2955 2023-04-14T15:55:51.431Z,1681487751.431 [Supervisor](DEBUG): Running supervisor. 2023-04-14T15:55:51.431Z,1681487751.431 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3050 2023-04-14T15:55:51.432Z,1681487751.432 [CommandExec](INFO): Initializing the command executive. 2023-04-14T15:55:51.433Z,1681487751.433 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3051 2023-04-14T15:55:51.435Z,1681487751.435 [controlThread ThreadHandler](INFO): Handler Thread ID is 3052 2023-04-14T15:55:51.436Z,1681487751.436 [controlThread](DEBUG): Initializing ControlThread 2023-04-14T15:55:51.437Z,1681487751.437 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-04-14T15:55:51.437Z,1681487751.437 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-04-14T15:55:51.437Z,1681487751.437 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-04-14T15:55:51.438Z,1681487751.438 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing 2023-04-14T15:55:51.439Z,1681487751.439 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-04-14T15:55:51.439Z,1681487751.439 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-04-14T15:55:51.446Z,1681487751.446 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T15:55:51.447Z,1681487751.447 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-04-14T15:55:51.447Z,1681487751.447 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-04-14T15:55:51.447Z,1681487751.447 [SBIT](INFO): Initialize SBIT Component. 2023-04-14T15:55:51.448Z,1681487751.448 [SBIT](IMPORTANT): git: 2023-04-13 2023-04-14T15:55:51.448Z,1681487751.448 [SBIT](INFO): git hash: 58f49511cc08420abb0c5b69b0871de949886db6 2023-04-14T15:55:51.448Z,1681487751.448 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-04-14T15:55:51.450Z,1681487751.450 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2023-04-14T15:55:51.451Z,1681487751.451 [SBIT](INFO): Beginning SBIT in 65.000000 seconds. 2023-04-14T15:55:51.451Z,1681487751.451 [IBIT](INFO): Initialize IBIT Component. 2023-04-14T15:55:51.452Z,1681487751.452 [CBIT](DEBUG): Initialize CBIT Component. 2023-04-14T15:55:51.453Z,1681487751.453 [logger ThreadHandler](INFO): Handler Thread ID is 3053 2023-04-14T15:55:51.464Z,1681487751.464 [CBIT](DEBUG): Initialized mux pins. 2023-04-14T15:55:51.464Z,1681487751.464 [CBIT](DEBUG): Initializing the watchdog timer. 2023-04-14T15:55:51.472Z,1681487751.472 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3054 2023-04-14T15:55:51.484Z,1681487751.484 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3055 2023-04-14T15:55:51.485Z,1681487751.485 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-04-14T15:55:51.488Z,1681487751.488 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-04-14T15:55:51.489Z,1681487751.489 [CBIT](DEBUG): Initializing heartbeat. 2023-04-14T15:55:51.496Z,1681487751.496 [Onboard ThreadHandler](INFO): Handler Thread ID is 3056 2023-04-14T15:55:51.513Z,1681487751.513 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3057 2023-04-14T15:55:51.532Z,1681487751.532 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3058 2023-04-14T15:55:51.533Z,1681487751.533 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-04-14T15:55:51.538Z,1681487751.538 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3060 2023-04-14T15:55:51.540Z,1681487751.540 [WetLabsBB2FL](INFO): Powering up 2023-04-14T15:55:51.541Z,1681487751.541 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3062 2023-04-14T15:55:51.544Z,1681487751.544 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2023-04-14T15:55:51.544Z,1681487751.544 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2023-04-14T15:55:51.544Z,1681487751.544 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2023-04-14T15:55:51.545Z,1681487751.545 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2023-04-14T15:55:51.545Z,1681487751.545 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2023-04-14T15:55:51.545Z,1681487751.545 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2023-04-14T15:55:51.545Z,1681487751.545 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2023-04-14T15:55:51.545Z,1681487751.545 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2023-04-14T15:55:51.560Z,1681487751.560 [CBIT](DEBUG): Deactivating GF circuits. 2023-04-14T15:55:51.560Z,1681487751.560 [CBIT](DEBUG): Deactivating emergency mode. 2023-04-14T15:55:51.600Z,1681487751.600 [CBIT](DEBUG): Backplane powered. 2023-04-14T15:55:51.605Z,1681487751.605 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-04-14T15:55:51.607Z,1681487751.607 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-04-14T15:55:51.608Z,1681487751.608 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-04-14T15:55:51.608Z,1681487751.608 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-04-14T15:55:51.610Z,1681487751.610 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-04-14T15:55:51.622Z,1681487751.622 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-04-14T15:55:51.643Z,1681487751.643 [MissionManager](DEBUG): 2023-04-14T15:55:51.661Z,1681487751.661 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-04-14T15:55:51.718Z,1681487751.718 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-04-14T15:55:51.719Z,1681487751.719 [Default:A.Wait](DEBUG): Construct Wait. 2023-04-14T15:55:51.721Z,1681487751.721 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-04-14T15:55:51.745Z,1681487751.745 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-04-14T15:55:51.754Z,1681487751.754 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-04-14T15:55:51.768Z,1681487751.768 [Default:E.Execute](DEBUG): Construct Execute. 2023-04-14T15:55:51.771Z,1681487751.771 [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 2023-04-14T15:55:51.790Z,1681487751.790 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-04-14T15:55:51.811Z,1681487751.811 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-04-14T15:55:51.874Z,1681487751.874 [Depth_Keller](ERROR): Pressure or depth reading out of range: 816.065491 decibar, 0.000000 m 2023-04-14T15:55:51.876Z,1681487751.876 [Power24vConverter](INFO): Powering up. 2023-04-14T15:55:51.882Z,1681487751.882 [DepthRateCalculator](ERROR): Depth measurement is not active 2023-04-14T15:55:51.921Z,1681487751.921 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-04-14T15:55:51.928Z,1681487751.928 [Radio_Surface](INFO): Powering up 2023-04-14T15:55:51.957Z,1681487751.957 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-04-14T15:55:51.958Z,1681487751.958 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-04-14T15:55:52.004Z,1681487752.004 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-04-14T15:55:52.005Z,1681487752.005 [MassServo](DEBUG): Initializing EZServoServo. 2023-04-14T15:55:52.012Z,1681487752.012 [MassServo](DEBUG): Initializing MassServo. 2023-04-14T15:55:52.013Z,1681487752.013 [RudderServo](DEBUG): Initializing EZServoServo. 2023-04-14T15:55:52.020Z,1681487752.020 [RudderServo](DEBUG): Initializing RudderServo. 2023-04-14T15:55:52.021Z,1681487752.021 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-04-14T15:55:52.025Z,1681487752.025 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-04-14T15:55:52.254Z,1681487752.254 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-04-14T15:55:52.254Z,1681487752.254 [DropWeight] Hardware Fault, FailCount= 1 2023-04-14T15:55:52.254Z,1681487752.254 [DropWeight](ERROR): Hardware Fault 2023-04-14T15:55:52.288Z,1681487752.288 [CommandExec](FAULT): Scheduling is paused 2023-04-14T15:55:52.289Z,1681487752.289 [CBIT](INFO): Critical error at 20230414T155552 2023-04-14T15:55:52.289Z,1681487752.289 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-04-14T15:55:52.293Z,1681487752.293 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-04-14T15:55:52.293Z,1681487752.293 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-04-14T15:55:52.627Z,1681487752.627 [CBIT](INFO): Critical error at 20230414T155552 2023-04-14T15:55:54.152Z,1681487754.152 [WetLabsBB2FL](INFO): Powering down 2023-04-14T15:55:57.741Z,1681487757.741 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-04-14T15:55:58.566Z,1681487758.566 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2023-04-14T15:56:01.066Z,1681487761.066 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004657 2023-04-14T15:56:19.685Z,1681487779.685 [NAL9602](INFO): Powering up NAL9602 2023-04-14T15:56:30.585Z,1681487790.585 [NAL9602](INFO): NAL9602 initialized 2023-04-14T15:56:56.863Z,1681487816.863 [SBIT](IMPORTANT): Beginning Startup BIT 2023-04-14T15:56:56.868Z,1681487816.868 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T15:56:57.648Z,1681487817.648 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:57:07.826Z,1681487827.826 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.354965 CHAN A1 (24V): 0.406143 CHAN A2 (12V): 0.139144 CHAN A3 (5V): 0.023927 CHAN B0 (3.3V): 0.011911 CHAN B1 (3.15aV): 0.011113 CHAN B2 (3.15bV): 0.011219 CHAN B3 (GND): -0.006460 OPEN: 0.007998 Full Scale: +/- 1 mA 2023-04-14T15:57:10.173Z,1681487830.173 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:57:22.293Z,1681487842.293 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:57:35.220Z,1681487855.220 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:57:47.744Z,1681487867.744 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:57:51.000Z,1681487871.000 [SBIT](IMPORTANT): SBIT PASSED 2023-04-14T15:57:51.001Z,1681487871.001 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-04-14T15:57:51.001Z,1681487871.001 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2023-04-14T15:57:51.001Z,1681487871.001 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute; 2023-04-14T15:57:51.002Z,1681487871.002 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_salinity_homogeneity_index 0.050000 practical_salinity_unit; 2023-04-14T15:57:51.002Z,1681487871.002 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_temperature_homogeneity_index 0.050000 celsius; 2023-04-14T15:57:51.002Z,1681487871.002 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_disk_space 100.000000 gigabyte; 2023-04-14T15:57:51.002Z,1681487871.002 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 300.000000 count_per_second; 2023-04-14T15:57:51.002Z,1681487871.002 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_shape 10.000000 count_per_second; 2023-04-14T15:57:51.002Z,1681487871.002 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_slope 0.200000 count_per_millimeter; 2023-04-14T15:57:51.002Z,1681487871.002 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2023-04-14T15:57:51.003Z,1681487871.003 [SBIT](IMPORTANT): StratificationFrontDetector.loadAtStartup=1 bool; 2023-04-14T15:57:51.003Z,1681487871.003 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=404.421079 cubic_centimeter; 2023-04-14T15:57:51.003Z,1681487871.003 [SBIT](IMPORTANT): VerticalControl.massDefault=11.496592 millimeter; 2023-04-14T15:57:51.003Z,1681487871.003 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=20 meter; 2023-04-14T15:57:51.003Z,1681487871.003 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=30 meter; 2023-04-14T15:57:51.003Z,1681487871.003 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.loadAtStartup=1 bool; 2023-04-14T15:57:51.003Z,1681487871.003 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool; 2023-04-14T15:57:51.403Z,1681487871.403 [MissionManager](IMPORTANT): Started mission Startup 2023-04-14T15:57:51.403Z,1681487871.403 [Startup] Running Loop=1 2023-04-14T15:57:51.403Z,1681487871.403 [Startup](DEBUG): Aggregate::initialize Startup 2023-04-14T15:57:51.403Z,1681487871.403 [Startup:A.GoToSurface] Running Loop=1 2023-04-14T15:57:51.403Z,1681487871.403 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-04-14T15:57:51.404Z,1681487871.404 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-04-14T15:57:51.405Z,1681487871.405 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-04-14T15:57:51.405Z,1681487871.405 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-04-14T15:57:51.405Z,1681487871.405 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-04-14T15:57:51.406Z,1681487871.406 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-04-14T15:57:51.407Z,1681487871.407 [Startup:StartupSatComms] Running Loop=1 2023-04-14T15:57:51.407Z,1681487871.407 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-04-14T15:57:51.407Z,1681487871.407 [Startup:StartupSatComms:A] Running Loop=1 2023-04-14T15:57:51.817Z,1681487871.817 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-04-14T15:58:00.268Z,1681487880.268 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:58:12.804Z,1681487892.804 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:58:25.379Z,1681487905.379 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:58:37.181Z,1681487917.181 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:58:49.705Z,1681487929.705 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:58:51.750Z,1681487931.750 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-04-14T15:58:51.750Z,1681487931.750 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T15:58:51.751Z,1681487931.751 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2023-04-14T15:58:51.751Z,1681487931.751 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T15:58:51.753Z,1681487931.753 [Startup:StartupSatComms:A](INFO): Timed out from 2023-04-14T15:57:51.4Z 2023-04-14T15:58:51.753Z,1681487931.753 [Startup:StartupSatComms:A] Stopped 2023-04-14T15:58:51.753Z,1681487931.753 [Startup:StartupSatComms:B] Running Loop=1 2023-04-14T15:58:51.771Z,1681487931.771 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T15:58:51.771Z,1681487931.771 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T15:58:52.158Z,1681487932.158 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-04-14T15:58:52.209Z,1681487932.209 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T15:58:52.210Z,1681487932.210 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-04-14T15:58:52.210Z,1681487932.210 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T15:58:52.210Z,1681487932.210 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2023-04-14T15:58:53.045Z,1681487933.045 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T15:58:56.577Z,1681487936.577 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20230414T154806/Courier0000.lzma 2023-04-14T15:58:56.583Z,1681487936.583 [CommandExec](IMPORTANT): got command get HorizontalControl.rudderAngleAction degree 2023-04-14T15:58:56.584Z,1681487936.584 [CommandExec](IMPORTANT): HorizontalControl.rudderAngleAction 0.000000 arcdeg 2023-04-14T15:58:57.554Z,1681487937.554 [DataOverHttps](INFO): Moved sent file to Logs/20230414T154806/Courier0000.lzma.bak 2023-04-14T15:58:57.554Z,1681487937.554 [DataOverHttps](INFO): SBD MOMSN=18220807 2023-04-14T15:59:01.749Z,1681487941.749 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:59:13.096Z,1681487953.096 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20230414T155541/Courier0000.lzma 2023-04-14T15:59:13.869Z,1681487953.869 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:59:14.098Z,1681487954.098 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Courier0000.lzma.bak 2023-04-14T15:59:14.098Z,1681487954.098 [DataOverHttps](INFO): SBD MOMSN=18220812 2023-04-14T15:59:26.393Z,1681487966.393 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:59:29.549Z,1681487969.549 [DataOverHttps](INFO): Sending 532 bytes from file Logs/20230414T154806/Express0001.lzma 2023-04-14T15:59:30.550Z,1681487970.550 [DataOverHttps](INFO): Moved sent file to Logs/20230414T154806/Express0001.lzma.bak 2023-04-14T15:59:30.550Z,1681487970.550 [DataOverHttps](INFO): SBD MOMSN=18220817 2023-04-14T15:59:38.513Z,1681487978.513 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T15:59:46.037Z,1681487986.037 [DataOverHttps](INFO): Sending 1014 bytes from file Logs/20230414T155541/Express0001.lzma 2023-04-14T15:59:47.038Z,1681487987.038 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Express0001.lzma.bak 2023-04-14T15:59:47.038Z,1681487987.038 [DataOverHttps](INFO): SBD MOMSN=18220827 2023-04-14T15:59:48.259Z,1681487988.259 [Startup:StartupSatComms:B] Stopped 2023-04-14T15:59:48.260Z,1681487988.260 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-04-14T15:59:48.260Z,1681487988.260 [Startup:StartupSatComms] Stopped 2023-04-14T15:59:48.260Z,1681487988.260 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-04-14T15:59:48.280Z,1681487988.280 [Startup](INFO): Completed Startup 2023-04-14T15:59:48.280Z,1681487988.280 [MissionManager](INFO): Startup is completed. 2023-04-14T15:59:48.280Z,1681487988.280 [MissionManager](INFO): Uninitializing Mission Startup 2023-04-14T15:59:48.280Z,1681487988.280 [Startup] Stopped 2023-04-14T15:59:48.280Z,1681487988.280 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-04-14T15:59:48.280Z,1681487988.280 [Startup:A.GoToSurface] Stopped 2023-04-14T15:59:48.281Z,1681487988.281 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-04-14T15:59:48.639Z,1681487988.639 [MissionManager](IMPORTANT): Started mission Default 2023-04-14T15:59:48.639Z,1681487988.639 [Default] Running Loop=1 2023-04-14T15:59:48.640Z,1681487988.640 [Default](DEBUG): Aggregate::initialize Default 2023-04-14T15:59:48.640Z,1681487988.640 [Default:B.GoToSurface] Running Loop=1 2023-04-14T15:59:48.640Z,1681487988.640 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-04-14T15:59:48.640Z,1681487988.640 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-04-14T15:59:48.641Z,1681487988.641 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-04-14T15:59:48.641Z,1681487988.641 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-04-14T15:59:48.641Z,1681487988.641 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-04-14T15:59:48.641Z,1681487988.641 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-04-14T15:59:48.642Z,1681487988.642 [Default:A.Wait] Running Loop=1 2023-04-14T15:59:48.642Z,1681487988.642 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-04-14T15:59:51.037Z,1681487991.037 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:00:01.971Z,1681488001.971 [Default:A.Wait](INFO): Done Waiting. 2023-04-14T16:00:01.972Z,1681488001.972 [Default:A.Wait] Stopped 2023-04-14T16:00:01.972Z,1681488001.972 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-04-14T16:00:02.368Z,1681488002.368 [Default:CheckIn] Running Loop=1 2023-04-14T16:00:02.368Z,1681488002.368 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-04-14T16:00:02.368Z,1681488002.368 [Default:CheckIn:Read_GPS] Running Loop=1 2023-04-14T16:00:02.784Z,1681488002.784 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-04-14T16:00:03.965Z,1681488003.965 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:00:16.085Z,1681488016.085 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:00:29.013Z,1681488029.013 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:00:41.133Z,1681488041.133 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:00:41.139Z,1681488041.139 [BPC1](ERROR): BPC1B: No match for serial number FF55 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2023-04-14T16:00:53.316Z,1681488053.316 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:01:05.777Z,1681488065.777 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:01:18.301Z,1681488078.301 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:01:30.422Z,1681488090.422 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:01:34.067Z,1681488094.067 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-04-14T16:01:42.948Z,1681488102.948 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:01:53.066Z,1681488113.066 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-04-14T16:01:53.066Z,1681488113.066 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:01:53.067Z,1681488113.067 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2023-04-14T16:01:53.067Z,1681488113.067 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:01:53.079Z,1681488113.079 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:01:53.079Z,1681488113.079 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:01:53.490Z,1681488113.490 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:01:53.490Z,1681488113.490 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-04-14T16:01:53.491Z,1681488113.491 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:01:53.491Z,1681488113.491 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2023-04-14T16:01:53.868Z,1681488113.868 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:01:55.469Z,1681488115.469 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:02:07.590Z,1681488127.590 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:02:11.204Z,1681488131.204 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2023-04-14T16:02:11.208Z,1681488131.208 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread. 2023-04-14T16:02:11.304Z,1681488131.304 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-04-14T16:02:20.113Z,1681488140.113 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:02:32.637Z,1681488152.637 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:02:37.326Z,1681488157.326 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2023-04-14T16:02:44.763Z,1681488164.763 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:02:50.126Z,1681488170.126 [CommandExec](IMPORTANT): got command maintain clear 2023-04-14T16:02:50.470Z,1681488170.470 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-04-14T16:02:57.281Z,1681488177.281 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:03:08.997Z,1681488188.997 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:03:19.905Z,1681488199.905 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:03:30.818Z,1681488210.818 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:03:42.529Z,1681488222.529 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:03:54.245Z,1681488234.245 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:04:05.557Z,1681488245.557 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:04:16.869Z,1681488256.869 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:04:28.181Z,1681488268.181 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:04:39.493Z,1681488279.493 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:04:50.805Z,1681488290.805 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:04:54.082Z,1681488294.082 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2023-04-14T16:04:54.082Z,1681488294.082 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:04:54.083Z,1681488294.083 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2023-04-14T16:04:54.083Z,1681488294.083 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:04:54.094Z,1681488294.094 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:04:54.094Z,1681488294.094 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:04:54.468Z,1681488294.468 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:04:54.468Z,1681488294.468 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2023-04-14T16:04:54.468Z,1681488294.468 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:04:54.469Z,1681488294.469 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2023-04-14T16:04:54.865Z,1681488294.865 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:05:02.137Z,1681488302.137 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:05:02.572Z,1681488302.572 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-04-14T16:00:02.4Z 2023-04-14T16:05:02.572Z,1681488302.572 [Default:CheckIn:Read_GPS] Stopped 2023-04-14T16:05:02.572Z,1681488302.572 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-04-14T16:05:02.980Z,1681488302.980 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-04-14T16:05:08.684Z,1681488308.684 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230414T155541/Courier0004.lzma 2023-04-14T16:05:09.674Z,1681488309.674 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Courier0004.lzma.bak 2023-04-14T16:05:09.674Z,1681488309.674 [DataOverHttps](INFO): SBD MOMSN=18220863 2023-04-14T16:05:13.429Z,1681488313.429 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:05:24.341Z,1681488324.341 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:05:25.116Z,1681488325.116 [DataOverHttps](INFO): Sending 306 bytes from file Logs/20230414T155541/Express0005.lzma 2023-04-14T16:05:26.118Z,1681488326.118 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Express0005.lzma.bak 2023-04-14T16:05:26.118Z,1681488326.118 [DataOverHttps](INFO): SBD MOMSN=18220865 2023-04-14T16:05:27.212Z,1681488327.212 [Default:CheckIn:Read_Iridium] Stopped 2023-04-14T16:05:27.212Z,1681488327.212 [Default:CheckIn:C.Wait] Running Loop=1 2023-04-14T16:05:27.212Z,1681488327.212 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-04-14T16:05:36.461Z,1681488336.461 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:05:48.985Z,1681488348.985 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:05:53.034Z,1681488353.034 [Power24vConverter](INFO): Powering down. 2023-04-14T16:06:00.701Z,1681488360.701 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:06:12.826Z,1681488372.826 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:06:24.941Z,1681488384.941 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:06:32.226Z,1681488392.226 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-04-14T16:06:32.226Z,1681488392.226 [NAL9602] Data Fault, FailCount= 1 2023-04-14T16:06:32.226Z,1681488392.226 [NAL9602](ERROR): Data Fault 2023-04-14T16:06:32.277Z,1681488392.277 [CBIT](ERROR): Data Fault in component: NAL9602 2023-04-14T16:06:32.625Z,1681488392.625 [NAL9602](INFO): Powering down 2023-04-14T16:06:33.462Z,1681488393.462 [CBIT](INFO): Clearing failed state for component NAL9602 2023-04-14T16:06:33.462Z,1681488393.462 [NAL9602] No Fault, FailCount= 1 2023-04-14T16:06:37.465Z,1681488397.465 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:06:49.993Z,1681488409.993 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:07:02.117Z,1681488422.117 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:07:02.942Z,1681488422.942 [NAL9602](INFO): Powering up NAL9602 2023-04-14T16:07:13.834Z,1681488433.834 [NAL9602](INFO): NAL9602 initialized 2023-04-14T16:07:14.633Z,1681488434.633 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:07:27.157Z,1681488447.157 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:07:39.681Z,1681488459.681 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:07:52.205Z,1681488472.205 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:07:55.116Z,1681488475.116 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2023-04-14T16:07:55.116Z,1681488475.116 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:07:55.117Z,1681488475.117 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2023-04-14T16:07:55.117Z,1681488475.117 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:07:55.128Z,1681488475.128 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:07:55.128Z,1681488475.128 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:07:55.508Z,1681488475.508 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:07:55.509Z,1681488475.509 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2023-04-14T16:07:55.509Z,1681488475.509 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:07:55.509Z,1681488475.509 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2023-04-14T16:07:55.887Z,1681488475.887 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:08:04.330Z,1681488484.330 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:08:16.849Z,1681488496.849 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:08:29.373Z,1681488509.373 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:08:41.494Z,1681488521.494 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:08:53.210Z,1681488533.210 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:09:05.733Z,1681488545.733 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:09:18.258Z,1681488558.258 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:09:30.781Z,1681488570.781 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:09:42.917Z,1681488582.917 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:09:55.433Z,1681488595.433 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:10:08.357Z,1681488608.357 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:10:20.473Z,1681488620.473 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:10:27.772Z,1681488627.772 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-04-14T16:10:27.772Z,1681488627.772 [Default:CheckIn:C.Wait] Stopped 2023-04-14T16:10:27.772Z,1681488627.772 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-04-14T16:10:27.772Z,1681488627.772 [Default:CheckIn:D] Running Loop=1 2023-04-14T16:10:28.179Z,1681488628.179 [Default:CheckIn:D] Stopped 2023-04-14T16:10:28.179Z,1681488628.179 [Default:CheckIn:E] Running Loop=1 2023-04-14T16:10:28.595Z,1681488628.595 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.658985 min 2023-04-14T16:10:28.595Z,1681488628.595 [Default:CheckIn:E] Stopped 2023-04-14T16:10:28.595Z,1681488628.595 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-04-14T16:10:28.595Z,1681488628.595 [Default:CheckIn] Stopped 2023-04-14T16:10:28.595Z,1681488628.595 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-04-14T16:10:28.596Z,1681488628.596 [Default:CheckIn](INFO): Running loop #2 2023-04-14T16:10:28.596Z,1681488628.596 [Default:CheckIn] Running Loop=2 2023-04-14T16:10:28.596Z,1681488628.596 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-04-14T16:10:28.596Z,1681488628.596 [Default:CheckIn:Read_GPS] Running Loop=1 2023-04-14T16:10:33.401Z,1681488633.401 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:10:45.521Z,1681488645.521 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:10:52.461Z,1681488652.461 [CBIT](INFO): Clearing failed state for component DropWeight 2023-04-14T16:10:52.461Z,1681488652.461 [DropWeight] No Fault, FailCount= 1 2023-04-14T16:10:56.062Z,1681488656.062 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2023-04-14T16:10:56.062Z,1681488656.062 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:10:56.063Z,1681488656.063 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2023-04-14T16:10:56.063Z,1681488656.063 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:10:56.098Z,1681488656.098 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:10:56.098Z,1681488656.098 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:10:56.468Z,1681488656.468 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:10:56.468Z,1681488656.468 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2023-04-14T16:10:56.469Z,1681488656.469 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:10:56.469Z,1681488656.469 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2023-04-14T16:10:56.850Z,1681488656.850 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:10:58.045Z,1681488658.045 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:11:10.165Z,1681488670.165 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:11:22.701Z,1681488682.701 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:11:35.221Z,1681488695.221 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:11:47.744Z,1681488707.744 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:11:52.689Z,1681488712.689 [CommandExec](IMPORTANT): got command burn on 2023-04-14T16:11:52.689Z,1681488712.689 [CommandExec](IMPORTANT): Activating dropweight wire 2023-04-14T16:11:53.813Z,1681488713.813 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-04-14T16:11:53.813Z,1681488713.813 [DropWeight] Hardware Fault, FailCount= 1 2023-04-14T16:11:53.814Z,1681488713.814 [DropWeight](ERROR): Hardware Fault 2023-04-14T16:11:53.830Z,1681488713.830 [CBIT](INFO): Critical error at 20230414T161153 2023-04-14T16:11:53.833Z,1681488713.833 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-04-14T16:11:53.833Z,1681488713.833 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-04-14T16:11:54.238Z,1681488714.238 [CBIT](INFO): Critical error at 20230414T161153 2023-04-14T16:12:00.270Z,1681488720.270 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:12:13.197Z,1681488733.197 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:12:25.318Z,1681488745.318 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:12:37.853Z,1681488757.853 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:12:43.093Z,1681488763.093 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:12:52.261Z,1681488772.261 [CommandExec](IMPORTANT): got command burn off 2023-04-14T16:12:52.261Z,1681488772.261 [CommandExec](IMPORTANT): Deactivating dropweight wire 2023-04-14T16:12:54.809Z,1681488774.809 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:13:06.126Z,1681488786.126 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:13:17.445Z,1681488797.445 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:13:28.745Z,1681488808.745 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:13:40.057Z,1681488820.057 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:13:51.785Z,1681488831.785 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:13:57.040Z,1681488837.040 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2023-04-14T16:13:57.040Z,1681488837.040 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:13:57.041Z,1681488837.041 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2023-04-14T16:13:57.042Z,1681488837.042 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:13:57.052Z,1681488837.052 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:13:57.053Z,1681488837.053 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:13:57.458Z,1681488837.458 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:13:57.458Z,1681488837.458 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2023-04-14T16:13:57.458Z,1681488837.458 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:13:57.458Z,1681488837.458 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2023-04-14T16:13:57.860Z,1681488837.860 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:14:03.091Z,1681488843.091 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:14:14.402Z,1681488854.402 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:14:25.709Z,1681488865.709 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:14:37.425Z,1681488877.425 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:14:49.146Z,1681488889.146 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:15:00.454Z,1681488900.454 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:15:06.513Z,1681488906.513 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:15:18.633Z,1681488918.633 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:15:28.779Z,1681488928.779 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-04-14T16:10:28.6Z 2023-04-14T16:15:28.779Z,1681488928.779 [Default:CheckIn:Read_GPS] Stopped 2023-04-14T16:15:28.779Z,1681488928.779 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-04-14T16:15:30.753Z,1681488930.753 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:15:43.277Z,1681488943.277 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:15:55.810Z,1681488955.810 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:15:58.153Z,1681488958.153 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:16:00.163Z,1681488960.163 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.253780 2023-04-14T16:16:08.451Z,1681488968.451 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003846 2023-04-14T16:16:08.730Z,1681488968.730 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:16:15.660Z,1681488975.660 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20230414T155541/Courier0007.lzma 2023-04-14T16:16:16.662Z,1681488976.662 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Courier0007.lzma.bak 2023-04-14T16:16:16.662Z,1681488976.662 [DataOverHttps](INFO): SBD MOMSN=18220896 2023-04-14T16:16:20.850Z,1681488980.850 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:16:32.088Z,1681488992.088 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20230414T155541/Express0008.lzma 2023-04-14T16:16:33.090Z,1681488993.090 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Express0008.lzma.bak 2023-04-14T16:16:33.090Z,1681488993.090 [DataOverHttps](INFO): SBD MOMSN=18220904 2023-04-14T16:16:33.373Z,1681488993.373 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:16:34.210Z,1681488994.210 [Default:CheckIn:Read_Iridium] Stopped 2023-04-14T16:16:34.210Z,1681488994.210 [Default:CheckIn:C.Wait] Running Loop=1 2023-04-14T16:16:34.210Z,1681488994.210 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-04-14T16:16:45.909Z,1681489005.909 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:16:58.132Z,1681489018.132 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2023-04-14T16:16:58.132Z,1681489018.132 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:16:58.133Z,1681489018.133 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2023-04-14T16:16:58.133Z,1681489018.133 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:16:58.144Z,1681489018.144 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:16:58.144Z,1681489018.144 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:16:58.436Z,1681489018.436 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:16:58.501Z,1681489018.501 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:16:58.501Z,1681489018.501 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2023-04-14T16:16:58.502Z,1681489018.502 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:16:58.502Z,1681489018.502 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2023-04-14T16:16:58.878Z,1681489018.878 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:17:10.542Z,1681489030.542 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:17:15.398Z,1681489035.398 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-04-14T16:17:15.398Z,1681489035.398 [NAL9602] Data Fault, FailCount= 2 2023-04-14T16:17:15.398Z,1681489035.398 [NAL9602](ERROR): Data Fault 2023-04-14T16:17:15.417Z,1681489035.417 [CBIT](ERROR): Data Fault in component: NAL9602 2023-04-14T16:17:15.801Z,1681489035.801 [NAL9602](INFO): Powering down 2023-04-14T16:17:16.627Z,1681489036.627 [CBIT](INFO): Clearing failed state for component NAL9602 2023-04-14T16:17:16.627Z,1681489036.627 [NAL9602] No Fault, FailCount= 2 2023-04-14T16:17:22.661Z,1681489042.661 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:17:35.185Z,1681489055.185 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:17:39.557Z,1681489059.557 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:17:41.565Z,1681489061.565 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.251320 2023-04-14T16:17:46.105Z,1681489066.105 [NAL9602](INFO): Powering up NAL9602 2023-04-14T16:17:47.305Z,1681489067.305 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:17:57.010Z,1681489077.010 [NAL9602](INFO): NAL9602 initialized 2023-04-14T16:17:59.829Z,1681489079.829 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:18:11.949Z,1681489091.949 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:18:14.697Z,1681489094.697 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:18:24.473Z,1681489104.473 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:18:36.997Z,1681489116.997 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:18:49.837Z,1681489129.837 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:18:49.929Z,1681489129.929 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:19:01.642Z,1681489141.642 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:19:14.172Z,1681489154.172 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:19:24.977Z,1681489164.977 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:19:26.288Z,1681489166.288 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:19:39.218Z,1681489179.218 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:19:51.737Z,1681489191.737 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:19:59.025Z,1681489199.025 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2023-04-14T16:19:59.025Z,1681489199.025 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:19:59.026Z,1681489199.026 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2023-04-14T16:19:59.026Z,1681489199.026 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:19:59.037Z,1681489199.037 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:19:59.037Z,1681489199.037 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:19:59.451Z,1681489199.451 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:19:59.451Z,1681489199.451 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2023-04-14T16:19:59.452Z,1681489199.452 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:19:59.452Z,1681489199.452 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2023-04-14T16:19:59.854Z,1681489199.854 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:20:00.120Z,1681489200.120 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:20:04.263Z,1681489204.263 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:20:16.785Z,1681489216.785 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:20:28.502Z,1681489228.502 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:20:35.273Z,1681489235.273 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:20:40.621Z,1681489240.621 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:20:52.741Z,1681489252.741 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:21:05.670Z,1681489265.670 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:21:10.417Z,1681489270.417 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:21:18.205Z,1681489278.205 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:21:29.909Z,1681489289.909 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:21:34.775Z,1681489294.775 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-04-14T16:21:34.775Z,1681489294.775 [Default:CheckIn:C.Wait] Stopped 2023-04-14T16:21:34.775Z,1681489294.775 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-04-14T16:21:34.775Z,1681489294.775 [Default:CheckIn:D] Running Loop=1 2023-04-14T16:21:35.188Z,1681489295.188 [Default:CheckIn:D] Stopped 2023-04-14T16:21:35.188Z,1681489295.188 [Default:CheckIn:E] Running Loop=1 2023-04-14T16:21:35.603Z,1681489295.603 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.775802 min 2023-04-14T16:21:35.603Z,1681489295.603 [Default:CheckIn:E] Stopped 2023-04-14T16:21:35.603Z,1681489295.603 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-04-14T16:21:35.604Z,1681489295.604 [Default:CheckIn] Stopped 2023-04-14T16:21:35.604Z,1681489295.604 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-04-14T16:21:35.604Z,1681489295.604 [Default:CheckIn](INFO): Running loop #3 2023-04-14T16:21:35.604Z,1681489295.604 [Default:CheckIn] Running Loop=3 2023-04-14T16:21:35.604Z,1681489295.604 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-04-14T16:21:35.604Z,1681489295.604 [Default:CheckIn:Read_GPS] Running Loop=1 2023-04-14T16:21:42.445Z,1681489302.445 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:21:45.557Z,1681489305.557 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-04-14T16:21:55.021Z,1681489315.021 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:22:07.077Z,1681489327.077 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:22:17.857Z,1681489337.857 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003557 2023-04-14T16:22:18.794Z,1681489338.794 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:22:30.509Z,1681489350.509 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:22:41.821Z,1681489361.821 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:22:52.729Z,1681489372.729 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:23:00.031Z,1681489380.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2023-04-14T16:23:00.031Z,1681489380.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:23:00.032Z,1681489380.032 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2023-04-14T16:23:00.032Z,1681489380.032 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:23:00.042Z,1681489380.042 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:23:00.043Z,1681489380.043 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:23:00.459Z,1681489380.459 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:23:00.459Z,1681489380.459 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2023-04-14T16:23:00.459Z,1681489380.459 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:23:00.460Z,1681489380.460 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2023-04-14T16:23:00.821Z,1681489380.821 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:23:04.041Z,1681489384.041 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:23:15.353Z,1681489395.353 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:23:18.617Z,1681489398.617 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:23:18.641Z,1681489398.641 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:23:21.458Z,1681489401.458 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:23:26.665Z,1681489406.665 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:23:29.563Z,1681489409.563 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.324468 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.160422 CHAN A3 (5V): 0.028186 CHAN B0 (3.3V): 0.012853 CHAN B1 (3.15aV): 0.011493 CHAN B2 (3.15bV): 0.011846 CHAN B3 (GND): -0.005354 OPEN: 0.007892 Full Scale: +/- 1 mA 2023-04-14T16:23:38.381Z,1681489418.381 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:23:49.305Z,1681489429.305 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:24:01.012Z,1681489441.012 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:24:02.669Z,1681489442.669 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:24:03.116Z,1681489443.116 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:24:05.915Z,1681489445.915 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:24:12.558Z,1681489452.558 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:24:14.176Z,1681489454.176 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.273006 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.139367 CHAN A3 (5V): 0.026297 CHAN B0 (3.3V): 0.012309 CHAN B1 (3.15aV): 0.011569 CHAN B2 (3.15bV): 0.012020 CHAN B3 (GND): -0.006131 OPEN: 0.007911 Full Scale: +/- 1 mA 2023-04-14T16:24:23.410Z,1681489463.410 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:24:34.723Z,1681489474.723 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2023-04-14T16:24:40.782Z,1681489480.782 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:24:53.306Z,1681489493.306 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:25:00.984Z,1681489500.984 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2023-04-14T16:25:01.366Z,1681489501.366 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:25:01.452Z,1681489501.452 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:25:04.242Z,1681489504.242 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:25:05.831Z,1681489505.831 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:25:12.356Z,1681489512.356 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.208523 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.104208 CHAN A3 (5V): 0.020320 CHAN B0 (3.3V): 0.011047 CHAN B1 (3.15aV): 0.009416 CHAN B2 (3.15bV): 0.010057 CHAN B3 (GND): -0.005180 OPEN: 0.007802 Full Scale: +/- 1 mA 2023-04-14T16:25:18.354Z,1681489518.354 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:25:30.474Z,1681489530.474 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:25:42.608Z,1681489542.608 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:25:55.523Z,1681489555.523 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:26:01.206Z,1681489561.206 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2023-04-14T16:26:01.206Z,1681489561.206 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:26:01.207Z,1681489561.207 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2023-04-14T16:26:01.207Z,1681489561.207 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:26:01.222Z,1681489561.222 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:26:01.222Z,1681489561.222 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:26:01.640Z,1681489561.640 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:26:01.640Z,1681489561.640 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2023-04-14T16:26:01.641Z,1681489561.641 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:26:01.641Z,1681489561.641 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2023-04-14T16:26:02.018Z,1681489562.018 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:26:08.046Z,1681489568.046 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:26:20.166Z,1681489580.166 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:26:22.594Z,1681489582.594 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:26:22.655Z,1681489582.655 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:26:25.466Z,1681489585.466 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:26:32.690Z,1681489592.690 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:26:33.545Z,1681489593.545 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.180207 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.094484 CHAN A3 (5V): 0.019475 CHAN B0 (3.3V): 0.011585 CHAN B1 (3.15aV): 0.010387 CHAN B2 (3.15bV): 0.010004 CHAN B3 (GND): -0.005316 OPEN: 0.008048 Full Scale: +/- 1 mA 2023-04-14T16:26:35.940Z,1681489595.940 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-04-14T16:21:35.6Z 2023-04-14T16:26:35.940Z,1681489595.940 [Default:CheckIn:Read_GPS] Stopped 2023-04-14T16:26:35.940Z,1681489595.940 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-04-14T16:26:40.873Z,1681489600.873 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230414T155541/Courier0010.lzma 2023-04-14T16:26:41.875Z,1681489601.875 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Courier0010.lzma.bak 2023-04-14T16:26:41.875Z,1681489601.875 [DataOverHttps](INFO): SBD MOMSN=18220959 2023-04-14T16:26:45.238Z,1681489605.238 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2023-04-14T16:26:48.607Z,1681489608.607 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC3 2023-04-14T16:26:52.107Z,1681489612.107 [BPC1](INFO): Calculating totals. Valid battery stick count: 48. Valid reserve battery stick count: 6. 2023-04-14T16:26:52.110Z,1681489612.110 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2023-04-14T16:26:54.190Z,1681489614.190 [CBIT](INFO): Clearing failed state for component DropWeight 2023-04-14T16:26:54.190Z,1681489614.190 [DropWeight] No Fault, FailCount= 1 2023-04-14T16:26:57.410Z,1681489617.410 [DataOverHttps](INFO): Sending 495 bytes from file Logs/20230414T155541/Express0011.lzma 2023-04-14T16:26:58.411Z,1681489618.411 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Express0011.lzma.bak 2023-04-14T16:26:58.412Z,1681489618.412 [DataOverHttps](INFO): SBD MOMSN=18220971 2023-04-14T16:26:59.808Z,1681489619.808 [Default:CheckIn:Read_Iridium] Stopped 2023-04-14T16:26:59.808Z,1681489619.808 [Default:CheckIn:C.Wait] Running Loop=1 2023-04-14T16:26:59.808Z,1681489619.808 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-04-14T16:27:03.907Z,1681489623.907 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB2 2023-04-14T16:27:18.274Z,1681489638.274 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:27:18.415Z,1681489638.415 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:27:21.250Z,1681489641.250 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:27:29.316Z,1681489649.316 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.166682 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.089919 CHAN A3 (5V): 0.019305 CHAN B0 (3.3V): 0.011334 CHAN B1 (3.15aV): 0.010271 CHAN B2 (3.15bV): 0.009883 CHAN B3 (GND): -0.004738 OPEN: 0.007863 Full Scale: +/- 1 mA 2023-04-14T16:27:59.623Z,1681489679.623 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-04-14T16:27:59.624Z,1681489679.624 [NAL9602] Data Fault, FailCount= 3 2023-04-14T16:27:59.624Z,1681489679.624 [NAL9602](ERROR): Data Fault 2023-04-14T16:27:59.642Z,1681489679.642 [CBIT](ERROR): Data Fault in component: NAL9602 2023-04-14T16:28:00.036Z,1681489680.036 [NAL9602](INFO): Powering down 2023-04-14T16:28:00.849Z,1681489680.849 [CBIT](INFO): Clearing failed state for component NAL9602 2023-04-14T16:28:00.849Z,1681489680.849 [NAL9602] No Fault, FailCount= 3 2023-04-14T16:28:30.332Z,1681489710.332 [NAL9602](INFO): Powering up NAL9602 2023-04-14T16:28:41.239Z,1681489721.239 [NAL9602](INFO): NAL9602 initialized 2023-04-14T16:29:02.268Z,1681489742.268 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2023-04-14T16:29:02.268Z,1681489742.268 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:29:02.269Z,1681489742.269 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2023-04-14T16:29:02.269Z,1681489742.269 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:29:02.279Z,1681489742.279 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:29:02.280Z,1681489742.280 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:29:02.684Z,1681489742.684 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:29:02.684Z,1681489742.684 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2023-04-14T16:29:02.684Z,1681489742.684 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:29:02.684Z,1681489742.684 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2023-04-14T16:29:03.058Z,1681489743.058 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:30:34.555Z,1681489834.555 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:30:34.804Z,1681489834.804 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:30:37.242Z,1681489837.242 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:30:45.280Z,1681489845.280 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.167882 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.086360 CHAN A3 (5V): 0.017843 CHAN B0 (3.3V): 0.009890 CHAN B1 (3.15aV): 0.009689 CHAN B2 (3.15bV): 0.009256 CHAN B3 (GND): -0.005182 OPEN: 0.007752 Full Scale: +/- 1 mA 2023-04-14T16:32:00.420Z,1681489920.420 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-04-14T16:32:00.420Z,1681489920.420 [Default:CheckIn:C.Wait] Stopped 2023-04-14T16:32:00.420Z,1681489920.420 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-04-14T16:32:00.420Z,1681489920.420 [Default:CheckIn:D] Running Loop=1 2023-04-14T16:32:00.840Z,1681489920.840 [Default:CheckIn:D] Stopped 2023-04-14T16:32:00.840Z,1681489920.840 [Default:CheckIn:E] Running Loop=1 2023-04-14T16:32:01.227Z,1681489921.227 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.203341 min 2023-04-14T16:32:01.227Z,1681489921.227 [Default:CheckIn:E] Stopped 2023-04-14T16:32:01.227Z,1681489921.227 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-04-14T16:32:01.227Z,1681489921.227 [Default:CheckIn] Stopped 2023-04-14T16:32:01.227Z,1681489921.227 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-04-14T16:32:01.227Z,1681489921.227 [Default:CheckIn](INFO): Running loop #4 2023-04-14T16:32:01.227Z,1681489921.227 [Default:CheckIn] Running Loop=4 2023-04-14T16:32:01.228Z,1681489921.228 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-04-14T16:32:01.228Z,1681489921.228 [Default:CheckIn:Read_GPS] Running Loop=1 2023-04-14T16:32:03.245Z,1681489923.245 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2023-04-14T16:32:03.245Z,1681489923.245 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:32:03.246Z,1681489923.246 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2023-04-14T16:32:03.246Z,1681489923.246 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:32:03.258Z,1681489923.258 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:32:03.258Z,1681489923.258 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:32:03.666Z,1681489923.666 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:32:03.666Z,1681489923.666 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2023-04-14T16:32:03.667Z,1681489923.667 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:32:03.667Z,1681489923.667 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2023-04-14T16:32:04.052Z,1681489924.052 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:34:27.657Z,1681490067.657 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:34:27.934Z,1681490067.934 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:34:30.747Z,1681490070.747 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:34:38.848Z,1681490078.848 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.165003 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.084681 CHAN A3 (5V): 0.018204 CHAN B0 (3.3V): 0.010146 CHAN B1 (3.15aV): 0.009622 CHAN B2 (3.15bV): 0.008603 CHAN B3 (GND): -0.004430 OPEN: 0.007766 Full Scale: +/- 1 mA 2023-04-14T16:35:04.257Z,1681490104.257 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2023-04-14T16:35:04.257Z,1681490104.257 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:35:04.258Z,1681490104.258 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2023-04-14T16:35:04.258Z,1681490104.258 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:35:04.309Z,1681490104.309 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:35:04.309Z,1681490104.309 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:35:04.675Z,1681490104.675 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:35:04.675Z,1681490104.675 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2023-04-14T16:35:04.676Z,1681490104.676 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:35:04.676Z,1681490104.676 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2023-04-14T16:35:05.073Z,1681490105.073 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:36:53.454Z,1681490213.454 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA1 2023-04-14T16:36:55.326Z,1681490215.326 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA2 2023-04-14T16:36:56.274Z,1681490216.274 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA3 2023-04-14T16:36:57.106Z,1681490217.106 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA4 2023-04-14T16:36:58.250Z,1681490218.250 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA5 2023-04-14T16:36:59.086Z,1681490219.086 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA6 2023-04-14T16:37:01.425Z,1681490221.425 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-04-14T16:32:01.2Z 2023-04-14T16:37:01.425Z,1681490221.425 [Default:CheckIn:Read_GPS] Stopped 2023-04-14T16:37:01.425Z,1681490221.425 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-04-14T16:37:02.834Z,1681490222.834 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB5 2023-04-14T16:37:06.688Z,1681490226.688 [CommandExec](IMPORTANT): got command failComponent 2023-04-14T16:37:06.688Z,1681490226.688 [CommandExec](IMPORTANT): Failed components: 2023-04-14T16:37:06.688Z,1681490226.688 [CommandExec](IMPORTANT): No failed Components. 2023-04-14T16:37:06.844Z,1681490226.844 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20230414T155541/Courier0013.lzma 2023-04-14T16:37:07.846Z,1681490227.846 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Courier0013.lzma.bak 2023-04-14T16:37:07.846Z,1681490227.846 [DataOverHttps](INFO): SBD MOMSN=18221047 2023-04-14T16:37:13.658Z,1681490233.658 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB4 2023-04-14T16:37:15.842Z,1681490235.842 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB3 2023-04-14T16:37:17.506Z,1681490237.506 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB2 2023-04-14T16:37:19.898Z,1681490239.898 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB1 2023-04-14T16:37:23.393Z,1681490243.393 [DataOverHttps](INFO): Sending 525 bytes from file Logs/20230414T155541/Express0014.lzma 2023-04-14T16:37:23.442Z,1681490243.442 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:37:23.681Z,1681490243.681 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:37:24.394Z,1681490244.394 [DataOverHttps](INFO): Moved sent file to Logs/20230414T155541/Express0014.lzma.bak 2023-04-14T16:37:24.394Z,1681490244.394 [DataOverHttps](INFO): SBD MOMSN=18221049 2023-04-14T16:37:25.664Z,1681490245.664 [Default:CheckIn:Read_Iridium] Stopped 2023-04-14T16:37:25.664Z,1681490245.664 [Default:CheckIn:C.Wait] Running Loop=1 2023-04-14T16:37:25.664Z,1681490245.664 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-04-14T16:37:26.494Z,1681490246.494 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:37:34.602Z,1681490254.602 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.161594 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.084019 CHAN A3 (5V): 0.017480 CHAN B0 (3.3V): 0.009992 CHAN B1 (3.15aV): 0.009238 CHAN B2 (3.15bV): 0.009001 CHAN B3 (GND): -0.005403 OPEN: 0.006444 Full Scale: +/- 1 mA 2023-04-14T16:37:42.530Z,1681490262.530 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC1 2023-04-14T16:37:43.778Z,1681490263.778 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC2 2023-04-14T16:37:44.818Z,1681490264.818 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC3 2023-04-14T16:37:45.962Z,1681490265.962 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC4 2023-04-14T16:37:48.666Z,1681490268.666 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC5 2023-04-14T16:37:50.142Z,1681490270.142 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC6 2023-04-14T16:37:53.370Z,1681490273.370 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC6 2023-04-14T16:37:55.034Z,1681490275.034 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC7 2023-04-14T16:37:56.593Z,1681490276.593 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:37:56.817Z,1681490276.817 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:37:58.792Z,1681490278.792 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2023-04-14T16:37:58.792Z,1681490278.792 [AHRS_M2] Data Fault, FailCount= 1 2023-04-14T16:37:58.793Z,1681490278.793 [AHRS_M2](ERROR): Data Fault 2023-04-14T16:37:58.867Z,1681490278.867 [CBIT](ERROR): Data Fault in component: AHRS_M2 2023-04-14T16:37:59.185Z,1681490279.185 [AHRS_M2](INFO): Powering down 2023-04-14T16:37:59.623Z,1681490279.623 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:38:00.019Z,1681490280.019 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-04-14T16:38:00.019Z,1681490280.019 [AHRS_M2] No Fault, FailCount= 1 2023-04-14T16:38:00.397Z,1681490280.397 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-04-14T16:38:05.313Z,1681490285.313 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2023-04-14T16:38:05.313Z,1681490285.313 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:38:05.315Z,1681490285.315 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2023-04-14T16:38:05.315Z,1681490285.315 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:38:05.361Z,1681490285.361 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:38:05.361Z,1681490285.361 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:38:05.712Z,1681490285.712 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:38:05.712Z,1681490285.712 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2023-04-14T16:38:05.713Z,1681490285.713 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:38:05.713Z,1681490285.713 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2023-04-14T16:38:06.071Z,1681490286.071 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:38:07.709Z,1681490287.709 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.146412 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.078540 CHAN A3 (5V): 0.016786 CHAN B0 (3.3V): 0.009921 CHAN B1 (3.15aV): 0.009116 CHAN B2 (3.15bV): 0.008876 CHAN B3 (GND): -0.004527 OPEN: 0.005689 Full Scale: +/- 1 mA 2023-04-14T16:38:42.426Z,1681490322.426 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-04-14T16:38:42.426Z,1681490322.426 [NAL9602] Data Fault, FailCount= 4 2023-04-14T16:38:42.426Z,1681490322.426 [NAL9602](ERROR): Data Fault 2023-04-14T16:38:42.472Z,1681490322.472 [CBIT](ERROR): Data Fault in component: NAL9602 2023-04-14T16:38:42.823Z,1681490322.823 [NAL9602](INFO): Powering down 2023-04-14T16:38:43.659Z,1681490323.659 [CBIT](INFO): Clearing failed state for component NAL9602 2023-04-14T16:38:43.659Z,1681490323.659 [NAL9602] No Fault, FailCount= 4 2023-04-14T16:39:03.105Z,1681490343.105 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:39:03.445Z,1681490343.445 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:39:06.292Z,1681490346.292 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:39:13.130Z,1681490353.130 [NAL9602](INFO): Powering up NAL9602 2023-04-14T16:39:14.411Z,1681490354.411 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.144842 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.076813 CHAN A3 (5V): 0.016788 CHAN B0 (3.3V): 0.009084 CHAN B1 (3.15aV): 0.008959 CHAN B2 (3.15bV): 0.008757 CHAN B3 (GND): -0.004315 OPEN: 0.005464 Full Scale: +/- 1 mA 2023-04-14T16:39:24.038Z,1681490364.038 [NAL9602](INFO): NAL9602 initialized 2023-04-14T16:39:45.638Z,1681490385.638 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB3 2023-04-14T16:39:51.157Z,1681490391.157 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:39:51.177Z,1681490391.177 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:39:53.981Z,1681490393.981 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:40:02.060Z,1681490402.060 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.138946 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.074941 CHAN A3 (5V): 0.016514 CHAN B0 (3.3V): 0.009243 CHAN B1 (3.15aV): 0.009000 CHAN B2 (3.15bV): 0.008500 CHAN B3 (GND): -0.004429 OPEN: 0.005606 Full Scale: +/- 1 mA 2023-04-14T16:40:17.909Z,1681490417.909 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:17.909Z,1681490417.909 [AHRS_M2] Hardware Fault, FailCount= 1 2023-04-14T16:40:17.909Z,1681490417.909 [AHRS_M2](ERROR): Hardware Fault 2023-04-14T16:40:17.910Z,1681490417.910 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:18.173Z,1681490418.173 [AHRS_M2](INFO): Powering down 2023-04-14T16:40:18.267Z,1681490418.267 [CBIT](ERROR): Hardware Fault in component: AHRS_M2 2023-04-14T16:40:18.741Z,1681490418.741 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:18.741Z,1681490418.741 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:18.949Z,1681490418.949 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:18.949Z,1681490418.949 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:19.036Z,1681490419.036 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-04-14T16:40:19.036Z,1681490419.036 [AHRS_M2] No Fault, FailCount= 1 2023-04-14T16:40:19.261Z,1681490419.261 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:19.261Z,1681490419.261 [AHRS_M2] Hardware Fault, FailCount= 2 2023-04-14T16:40:19.261Z,1681490419.261 [AHRS_M2](ERROR): Hardware Fault 2023-04-14T16:40:19.261Z,1681490419.261 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:19.424Z,1681490419.424 [CBIT](ERROR): Hardware Fault in component: AHRS_M2 2023-04-14T16:40:19.424Z,1681490419.424 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-04-14T16:40:19.424Z,1681490419.424 [AHRS_M2] No Fault, FailCount= 2 2023-04-14T16:40:19.469Z,1681490419.469 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:19.469Z,1681490419.469 [AHRS_M2] Hardware Fault, FailCount= 3 2023-04-14T16:40:19.469Z,1681490419.469 [AHRS_M2](ERROR): Hardware Fault 2023-04-14T16:40:19.470Z,1681490419.470 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:19.677Z,1681490419.677 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:19.677Z,1681490419.677 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:19.813Z,1681490419.813 [CBIT](ERROR): Hardware Fault in component: AHRS_M2 2023-04-14T16:40:19.813Z,1681490419.813 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-04-14T16:40:19.813Z,1681490419.813 [AHRS_M2] No Fault, FailCount= 3 2023-04-14T16:40:19.989Z,1681490419.989 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:19.989Z,1681490419.989 [AHRS_M2] Hardware Fault, FailCount= 4 2023-04-14T16:40:19.989Z,1681490419.989 [AHRS_M2](ERROR): Hardware Fault 2023-04-14T16:40:19.989Z,1681490419.989 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:20.213Z,1681490420.213 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:20.213Z,1681490420.213 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:20.262Z,1681490420.262 [CBIT](ERROR): Hardware Fault in component: AHRS_M2 2023-04-14T16:40:20.263Z,1681490420.263 [CBIT](INFO): Clearing failed state for component AHRS_M2 2023-04-14T16:40:20.263Z,1681490420.263 [AHRS_M2] No Fault, FailCount= 4 2023-04-14T16:40:20.405Z,1681490420.405 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:20.405Z,1681490420.405 [AHRS_M2] Hardware Fault, FailCount= 5 2023-04-14T16:40:20.405Z,1681490420.405 [AHRS_M2](ERROR): Hardware Fault 2023-04-14T16:40:20.405Z,1681490420.405 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:20.617Z,1681490420.617 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:20.617Z,1681490420.617 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:20.632Z,1681490420.632 [CBIT](ERROR): Hardware Fault in component: AHRS_M2 2023-04-14T16:40:20.633Z,1681490420.633 [CBIT](CRITICAL): Hardware Fault in component: AHRS_M2 2023-04-14T16:40:20.821Z,1681490420.821 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2 2023-04-14T16:40:20.821Z,1681490420.821 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault 2023-04-14T16:40:21.030Z,1681490421.030 [CBIT](INFO): Critical error at 20230414T164020 2023-04-14T16:40:22.693Z,1681490422.693 [CommandExec](IMPORTANT): got command failComponent 2023-04-14T16:40:22.693Z,1681490422.693 [CommandExec](IMPORTANT): Failed components: 2023-04-14T16:40:22.694Z,1681490422.694 [CommandExec](IMPORTANT): AHRS_M2: Hardware Fault 2023-04-14T16:40:29.291Z,1681490429.291 [CommandExec](IMPORTANT): got command get 2023-04-14T16:40:29.291Z,1681490429.291 [CommandExec](FAULT): Incomplete syntax. Try: help get 2023-04-14T16:40:52.930Z,1681490452.930 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC5 2023-04-14T16:40:55.113Z,1681490455.113 [CommandExec](IMPORTANT): got command gfscan 2023-04-14T16:40:55.389Z,1681490455.389 [CBIT](IMPORTANT): Beginning ground fault scan 2023-04-14T16:40:58.209Z,1681490458.209 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-04-14T16:41:06.264Z,1681490466.264 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2023-04-14T16:41:06.264Z,1681490466.264 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-04-14T16:41:06.266Z,1681490466.266 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2023-04-14T16:41:06.266Z,1681490466.266 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-04-14T16:41:06.277Z,1681490466.277 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-04-14T16:41:06.277Z,1681490466.277 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-04-14T16:41:06.281Z,1681490466.281 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.136343 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.073723 CHAN A3 (5V): 0.015379 CHAN B0 (3.3V): 0.009974 CHAN B1 (3.15aV): 0.009095 CHAN B2 (3.15bV): 0.008753 CHAN B3 (GND): -0.004685 OPEN: 0.005695 Full Scale: +/- 1 mA 2023-04-14T16:41:06.691Z,1681490466.691 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-04-14T16:41:06.691Z,1681490466.691 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2023-04-14T16:41:06.692Z,1681490466.692 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-04-14T16:41:06.692Z,1681490466.692 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2023-04-14T16:41:07.093Z,1681490467.093 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-04-14T16:41:18.438Z,1681490478.438 [CommandExec](IMPORTANT): got command restart system 2023-04-14T16:41:20.501Z,1681490480.501 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:20.501Z,1681490480.501 [CommandExec](INFO): Uninitializing the command executive. 2023-04-14T16:41:20.501Z,1681490480.501 [CommandExec](INFO): Uninitializing the command scheduler. 2023-04-14T16:41:20.501Z,1681490480.501 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:20.700Z,1681490480.700 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-04-14T16:41:20.701Z,1681490480.701 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-04-14T16:41:20.701Z,1681490480.701 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:20.702Z,1681490480.702 [NavChartDb](INFO): Join timeout helper Thread ID is 3182 2023-04-14T16:41:20.729Z,1681490480.729 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:20.729Z,1681490480.729 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:20.740Z,1681490480.740 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-04-14T16:41:20.741Z,1681490480.741 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:20.741Z,1681490480.741 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3183 2023-04-14T16:41:20.961Z,1681490480.961 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:20.961Z,1681490480.961 [WetLabsBB2FL](INFO): Powering down 2023-04-14T16:41:20.962Z,1681490480.962 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:20.973Z,1681490480.973 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-04-14T16:41:20.973Z,1681490480.973 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:20.973Z,1681490480.973 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3184 2023-04-14T16:41:21.565Z,1681490481.565 [CTD_Seabird](INFO): Powering down 2023-04-14T16:41:21.576Z,1681490481.576 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:21.577Z,1681490481.577 [CTD_Seabird](INFO): Powering down 2023-04-14T16:41:21.588Z,1681490481.588 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:21.609Z,1681490481.609 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-04-14T16:41:21.609Z,1681490481.609 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:21.610Z,1681490481.610 [Radio_Surface](INFO): Join timeout helper Thread ID is 3185 2023-04-14T16:41:21.812Z,1681490481.812 [Radio_Surface](INFO): Powering down 2023-04-14T16:41:21.813Z,1681490481.813 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:21.814Z,1681490481.814 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:21.824Z,1681490481.824 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-04-14T16:41:21.825Z,1681490481.825 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:21.825Z,1681490481.825 [Onboard](INFO): Join timeout helper Thread ID is 3186 2023-04-14T16:41:21.949Z,1681490481.949 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-04-14T16:41:23.357Z,1681490483.357 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:23.357Z,1681490483.357 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:23.377Z,1681490483.377 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-04-14T16:41:23.378Z,1681490483.378 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:23.378Z,1681490483.378 [DataOverHttps](INFO): Join timeout helper Thread ID is 3187 2023-04-14T16:41:23.957Z,1681490483.957 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:23.957Z,1681490483.957 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:23.961Z,1681490483.961 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-04-14T16:41:23.961Z,1681490483.961 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:23.962Z,1681490483.962 [BackseatComponent](INFO): Join timeout helper Thread ID is 3188 2023-04-14T16:41:23.965Z,1681490483.965 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:23.965Z,1681490483.965 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:23.981Z,1681490483.981 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-04-14T16:41:23.981Z,1681490483.981 [logger ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:23.982Z,1681490483.982 [logger](INFO): Join timeout helper Thread ID is 3189 2023-04-14T16:41:23.997Z,1681490483.997 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:23.997Z,1681490483.997 [logger ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.001Z,1681490484.001 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-04-14T16:41:24.001Z,1681490484.001 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.002Z,1681490484.002 [CommandLine](INFO): Join timeout helper Thread ID is 3190 2023-04-14T16:41:24.085Z,1681490484.085 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:24.085Z,1681490484.085 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.101Z,1681490484.101 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-04-14T16:41:24.101Z,1681490484.101 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.102Z,1681490484.102 [CommandExec](INFO): Join timeout helper Thread ID is 3191 2023-04-14T16:41:24.103Z,1681490484.103 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-04-14T16:41:24.103Z,1681490484.103 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.103Z,1681490484.103 [controlThread](INFO): Join timeout helper Thread ID is 3192 2023-04-14T16:41:24.425Z,1681490484.425 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-04-14T16:41:24.425Z,1681490484.425 [controlThread](DEBUG): Uninitializing ControlThread 2023-04-14T16:41:24.425Z,1681490484.425 [AHRS_M2](INFO): Powering down 2023-04-14T16:41:24.427Z,1681490484.427 [NAL9602](INFO): Powering down 2023-04-14T16:41:24.428Z,1681490484.428 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-04-14T16:41:24.429Z,1681490484.429 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-04-14T16:41:24.430Z,1681490484.430 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-04-14T16:41:24.430Z,1681490484.430 [MissionManager](INFO): Uninitializing Mission Default 2023-04-14T16:41:24.430Z,1681490484.430 [Default] Stopped 2023-04-14T16:41:24.430Z,1681490484.430 [Default](DEBUG): Aggregate::uninitialize Default 2023-04-14T16:41:24.430Z,1681490484.430 [Default:B.GoToSurface] Stopped 2023-04-14T16:41:24.430Z,1681490484.430 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-04-14T16:41:24.431Z,1681490484.431 [Default:CheckIn] Stopped 2023-04-14T16:41:24.431Z,1681490484.431 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-04-14T16:41:24.431Z,1681490484.431 [Default:CheckIn:C.Wait] Stopped 2023-04-14T16:41:24.431Z,1681490484.431 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-04-14T16:41:24.434Z,1681490484.434 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-04-14T16:41:24.434Z,1681490484.434 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-04-14T16:41:24.435Z,1681490484.435 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-04-14T16:41:24.435Z,1681490484.435 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-04-14T16:41:24.435Z,1681490484.435 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-04-14T16:41:24.436Z,1681490484.436 [BuoyancyServo](INFO): Powering down 2023-04-14T16:41:24.449Z,1681490484.449 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-04-14T16:41:24.449Z,1681490484.449 [ElevatorServo](INFO): Powering down 2023-04-14T16:41:24.450Z,1681490484.450 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-04-14T16:41:24.450Z,1681490484.450 [MassServo](INFO): Powering down 2023-04-14T16:41:24.451Z,1681490484.451 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-04-14T16:41:24.451Z,1681490484.451 [RudderServo](INFO): Powering down 2023-04-14T16:41:24.452Z,1681490484.452 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-04-14T16:41:24.452Z,1681490484.452 [ThrusterHE](INFO): Powering down 2023-04-14T16:41:24.453Z,1681490484.453 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-04-14T16:41:24.453Z,1681490484.453 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-04-14T16:41:24.454Z,1681490484.454 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-04-14T16:41:24.454Z,1681490484.454 [CBIT](DEBUG): Powering off loads. 2023-04-14T16:41:24.464Z,1681490484.464 [CBIT](DEBUG): Disabling WDT. 2023-04-14T16:41:24.476Z,1681490484.476 [CBIT](DEBUG): Opening all GF detection circuits. 2023-04-14T16:41:24.477Z,1681490484.477 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.496Z,1681490484.496 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.500Z,1681490484.500 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.506Z,1681490484.506 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.553Z,1681490484.553 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.602Z,1681490484.602 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.606Z,1681490484.606 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.663Z,1681490484.663 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-04-14T16:41:24.708Z,1681490484.708 [logger ThreadHandler](INFO): Thread cancelled.