2024-07-08T15:32:57.227Z,1720452777.227 [Supervisor](DEBUG): Initializing supervisor. 2024-07-08T15:32:57.231Z,1720452777.231 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-07-08T15:32:57.232Z,1720452777.232 [SyncHandler](INFO): Protected caller Thread ID is 8559 2024-07-08T15:32:57.232Z,1720452777.232 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-07-08T15:32:57.233Z,1720452777.233 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-07-08T15:32:57.234Z,1720452777.234 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8560 2024-07-08T15:32:57.237Z,1720452777.237 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-07-08T15:32:57.271Z,1720452777.271 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-07-08T15:32:57.279Z,1720452777.279 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-07-08T15:32:57.279Z,1720452777.279 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 8562 2024-07-08T15:32:57.295Z,1720452777.295 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-07-08T15:32:57.308Z,1720452777.308 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-07-08T15:32:57.309Z,1720452777.309 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8563 2024-07-08T15:32:57.327Z,1720452777.327 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-07-08T15:32:57.338Z,1720452777.338 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-07-08T15:32:57.338Z,1720452777.338 [logger ThreadHandler](INFO): Protected caller Thread ID is 8564 2024-07-08T15:32:57.342Z,1720452777.342 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-07-08T15:32:57.342Z,1720452777.342 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-07-08T15:32:57.344Z,1720452777.344 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-07-08T15:32:57.910Z,1720452777.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-07-08T15:32:57.911Z,1720452777.911 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-07-08T15:32:58.151Z,1720452778.151 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-07-08T15:32:58.152Z,1720452778.152 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-07-08T15:32:58.264Z,1720452778.264 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-07-08T15:32:58.516Z,1720452778.516 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-07-08T15:32:58.516Z,1720452778.516 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-07-08T15:32:58.609Z,1720452778.609 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-07-08T15:32:58.718Z,1720452778.718 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-07-08T15:32:58.718Z,1720452778.718 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-07-08T15:32:59.082Z,1720452779.082 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-07-08T15:32:59.083Z,1720452779.083 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-07-08T15:32:59.230Z,1720452779.230 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-07-08T15:32:59.231Z,1720452779.231 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-07-08T15:32:59.814Z,1720452779.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-07-08T15:32:59.814Z,1720452779.814 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-07-08T15:33:00.022Z,1720452780.022 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-07-08T15:33:00.022Z,1720452780.022 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-07-08T15:33:00.461Z,1720452780.461 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-07-08T15:33:00.461Z,1720452780.461 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-07-08T15:33:00.771Z,1720452780.771 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-07-08T15:33:00.772Z,1720452780.772 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-07-08T15:33:00.927Z,1720452780.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-07-08T15:33:00.927Z,1720452780.927 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-07-08T15:33:02.062Z,1720452782.062 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-07-08T15:33:02.062Z,1720452782.062 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-07-08T15:33:02.437Z,1720452782.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-07-08T15:33:02.438Z,1720452782.438 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-07-08T15:33:02.687Z,1720452782.687 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-07-08T15:33:02.689Z,1720452782.689 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2024-07-08T15:33:02.691Z,1720452782.691 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2024-07-08T15:33:02.824Z,1720452782.824 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2024-07-08T15:33:02.920Z,1720452782.920 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2024-07-08T15:33:03.073Z,1720452783.073 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2024-07-08T15:33:03.173Z,1720452783.173 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2024-07-08T15:33:03.453Z,1720452783.453 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-07-08T15:33:03.454Z,1720452783.454 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2024-07-08T15:33:03.575Z,1720452783.575 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2024-07-08T15:33:03.696Z,1720452783.696 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2024-07-08T15:33:03.804Z,1720452783.804 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2024-07-08T15:33:03.968Z,1720452783.968 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2024-07-08T15:33:04.080Z,1720452784.080 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2024-07-08T15:33:04.181Z,1720452784.181 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/ 2024-07-08T15:33:04.181Z,1720452784.181 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-07-08T15:33:04.188Z,1720452784.188 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-07-08T15:33:04.204Z,1720452784.204 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-07-08T15:33:04.205Z,1720452784.205 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-07-08T15:33:04.344Z,1720452784.344 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-07-08T15:33:04.345Z,1720452784.345 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-07-08T15:33:04.419Z,1720452784.419 [VerticalControl](DEBUG): Construct VerticalControl. 2024-07-08T15:33:04.487Z,1720452784.487 [VerticalControl] Loaded 2024-07-08T15:33:04.487Z,1720452784.487 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-07-08T15:33:04.490Z,1720452784.490 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-07-08T15:33:04.536Z,1720452784.536 [HorizontalControl] Loaded 2024-07-08T15:33:04.537Z,1720452784.537 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-07-08T15:33:04.539Z,1720452784.539 [SpeedControl](DEBUG): Construct SpeedControl. 2024-07-08T15:33:04.542Z,1720452784.542 [SpeedControl] Loaded 2024-07-08T15:33:04.542Z,1720452784.542 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-07-08T15:33:04.545Z,1720452784.545 [LoopControl](DEBUG): Construct LoopControl. 2024-07-08T15:33:04.545Z,1720452784.545 [LoopControl] Loaded 2024-07-08T15:33:04.545Z,1720452784.545 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-07-08T15:33:04.546Z,1720452784.546 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-07-08T15:33:04.546Z,1720452784.546 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-07-08T15:33:04.711Z,1720452784.711 [BuoyancyServo] Loaded 2024-07-08T15:33:04.712Z,1720452784.712 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-07-08T15:33:04.733Z,1720452784.733 [ElevatorServo] Loaded 2024-07-08T15:33:04.733Z,1720452784.733 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-07-08T15:33:04.754Z,1720452784.754 [MassServo] Loaded 2024-07-08T15:33:04.754Z,1720452784.754 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-07-08T15:33:04.843Z,1720452784.843 [RudderServo] Loaded 2024-07-08T15:33:04.844Z,1720452784.844 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-07-08T15:33:04.860Z,1720452784.860 [ThrusterHE] Loaded 2024-07-08T15:33:04.860Z,1720452784.860 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-07-08T15:33:04.860Z,1720452784.860 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-07-08T15:33:04.861Z,1720452784.861 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-07-08T15:33:04.933Z,1720452784.933 [DepthRateCalculator] Loaded 2024-07-08T15:33:04.933Z,1720452784.933 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-07-08T15:33:04.938Z,1720452784.938 [PitchRateCalculator] Loaded 2024-07-08T15:33:04.938Z,1720452784.938 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-07-08T15:33:04.948Z,1720452784.948 [SpeedCalculator] Loaded 2024-07-08T15:33:04.948Z,1720452784.948 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-07-08T15:33:04.952Z,1720452784.952 [YawRateCalculator] Loaded 2024-07-08T15:33:04.952Z,1720452784.952 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-07-08T15:33:04.977Z,1720452784.977 [ElevatorOffsetCalculator] Loaded 2024-07-08T15:33:04.977Z,1720452784.977 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-07-08T15:33:04.977Z,1720452784.977 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-07-08T15:33:04.978Z,1720452784.978 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-07-08T15:33:05.119Z,1720452785.119 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-07-08T15:33:05.119Z,1720452785.119 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-07-08T15:33:05.133Z,1720452785.133 [NavChart] Loaded 2024-07-08T15:33:05.133Z,1720452785.133 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-07-08T15:33:05.138Z,1720452785.138 [UniversalFixResidualReporter] Loaded 2024-07-08T15:33:05.139Z,1720452785.139 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-07-08T15:33:05.139Z,1720452785.139 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-07-08T15:33:05.140Z,1720452785.140 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-07-08T15:33:06.125Z,1720452786.125 [BackseatComponent] Loaded 2024-07-08T15:33:06.125Z,1720452786.125 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-07-08T15:33:06.126Z,1720452786.126 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0 2024-07-08T15:33:06.127Z,1720452786.127 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 8646 2024-07-08T15:33:06.129Z,1720452786.129 [LcmUniversalReporter] Loaded 2024-07-08T15:33:06.130Z,1720452786.130 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-07-08T15:33:06.136Z,1720452786.136 [BioacousticsDataBridge] Loaded 2024-07-08T15:33:06.136Z,1720452786.136 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2024-07-08T15:33:07.079Z,1720452787.079 [BPC1] Loaded 2024-07-08T15:33:07.079Z,1720452787.079 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-07-08T15:33:07.171Z,1720452787.171 [DataOverHttps] Loaded 2024-07-08T15:33:07.171Z,1720452787.171 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-07-08T15:33:07.173Z,1720452787.173 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0 2024-07-08T15:33:07.173Z,1720452787.173 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8647 2024-07-08T15:33:07.196Z,1720452787.196 [Depth_Keller] Loaded 2024-07-08T15:33:07.196Z,1720452787.196 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-07-08T15:33:07.201Z,1720452787.201 [DropWeight] Loaded 2024-07-08T15:33:07.201Z,1720452787.201 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-07-08T15:33:07.271Z,1720452787.271 [NAL9602] Loaded 2024-07-08T15:33:07.272Z,1720452787.272 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-07-08T15:33:07.301Z,1720452787.301 [Onboard] Loaded 2024-07-08T15:33:07.302Z,1720452787.302 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-07-08T15:33:07.303Z,1720452787.303 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0 2024-07-08T15:33:07.303Z,1720452787.303 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 8648 2024-07-08T15:33:07.317Z,1720452787.317 [Power24vConverter] Loaded 2024-07-08T15:33:07.317Z,1720452787.317 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-07-08T15:33:07.335Z,1720452787.335 [Radio_Surface] Loaded 2024-07-08T15:33:07.335Z,1720452787.335 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-07-08T15:33:07.336Z,1720452787.336 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0 2024-07-08T15:33:07.337Z,1720452787.337 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8649 2024-07-08T15:33:07.352Z,1720452787.352 [Sonardyne_Nano] Loaded 2024-07-08T15:33:07.352Z,1720452787.352 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-07-08T15:33:07.353Z,1720452787.353 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-07-08T15:33:07.353Z,1720452787.353 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-07-08T15:33:07.441Z,1720452787.441 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-07-08T15:33:07.441Z,1720452787.441 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-07-08T15:33:07.657Z,1720452787.657 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-07-08T15:33:07.658Z,1720452787.658 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-07-08T15:33:07.701Z,1720452787.701 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-07-08T15:33:07.701Z,1720452787.701 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-07-08T15:33:07.931Z,1720452787.931 [CTD_Seabird] Loaded 2024-07-08T15:33:07.931Z,1720452787.931 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-07-08T15:33:07.932Z,1720452787.932 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ADB4E0 2024-07-08T15:33:07.933Z,1720452787.933 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8650 2024-07-08T15:33:07.955Z,1720452787.955 [PAR_Licor] Loaded 2024-07-08T15:33:07.955Z,1720452787.955 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-07-08T15:33:07.998Z,1720452787.998 [WetLabsBB2FL] Loaded 2024-07-08T15:33:07.998Z,1720452787.998 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-07-08T15:33:07.999Z,1720452787.999 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B0B4E0 2024-07-08T15:33:07.000Z,1720452788.000 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8651 2024-07-08T15:33:08.000Z,1720452788.000 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-07-08T15:33:08.001Z,1720452788.001 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-07-08T15:33:08.405Z,1720452788.405 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-07-08T15:33:08.406Z,1720452788.406 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-07-08T15:33:08.569Z,1720452788.569 [SBIT](DEBUG): Construct Startup Built In Test. 2024-07-08T15:33:08.579Z,1720452788.579 [SBIT] Loaded 2024-07-08T15:33:08.579Z,1720452788.579 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-07-08T15:33:08.582Z,1720452788.582 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-07-08T15:33:08.595Z,1720452788.595 [IBIT] Loaded 2024-07-08T15:33:08.595Z,1720452788.595 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-07-08T15:33:08.601Z,1720452788.601 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-07-08T15:33:08.703Z,1720452788.703 [CBIT] Loaded 2024-07-08T15:33:08.703Z,1720452788.703 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-07-08T15:33:08.704Z,1720452788.704 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-07-08T15:33:08.710Z,1720452788.710 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-07-08T15:33:08.713Z,1720452788.713 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-07-08T15:33:08.724Z,1720452788.724 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-07-08T15:33:08.737Z,1720452788.737 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-07-08T15:33:08.738Z,1720452788.738 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8652 2024-07-08T15:33:08.744Z,1720452788.744 [Supervisor](INFO): Main Thread ID is 8558 2024-07-08T15:33:08.744Z,1720452788.744 [Supervisor](DEBUG): Running supervisor. 2024-07-08T15:33:08.745Z,1720452788.745 [CommandExec ThreadHandler](INFO): Handler Thread ID is 8653 2024-07-08T15:33:08.746Z,1720452788.746 [CommandExec](INFO): Initializing the command executive. 2024-07-08T15:33:08.754Z,1720452788.754 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8654 2024-07-08T15:33:08.756Z,1720452788.756 [controlThread ThreadHandler](INFO): Handler Thread ID is 8655 2024-07-08T15:33:08.756Z,1720452788.756 [controlThread](DEBUG): Initializing ControlThread 2024-07-08T15:33:08.757Z,1720452788.757 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-07-08T15:33:08.760Z,1720452788.760 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-07-08T15:33:08.761Z,1720452788.761 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-07-08T15:33:08.761Z,1720452788.761 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-07-08T15:33:08.763Z,1720452788.763 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-07-08T15:33:08.763Z,1720452788.763 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-07-08T15:33:08.763Z,1720452788.763 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-07-08T15:33:08.764Z,1720452788.764 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-07-08T15:33:08.764Z,1720452788.764 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-07-08T15:33:08.765Z,1720452788.765 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-07-08T15:33:08.765Z,1720452788.765 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-07-08T15:33:08.774Z,1720452788.774 [SBIT](INFO): Initialize SBIT Component. 2024-07-08T15:33:08.775Z,1720452788.775 [SBIT](IMPORTANT): git: 2024-06-03 2024-07-08T15:33:08.775Z,1720452788.775 [SBIT](INFO): git hash: 7fa19da3a148abf4baea4b65318d99ca26f8c915 2024-07-08T15:33:08.775Z,1720452788.775 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-07-08T15:33:08.776Z,1720452788.776 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-07-08T15:33:08.777Z,1720452788.777 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2024-07-08T15:33:08.778Z,1720452788.778 [IBIT](INFO): Initialize IBIT Component. 2024-07-08T15:33:08.779Z,1720452788.779 [CBIT](DEBUG): Initialize CBIT Component. 2024-07-08T15:33:08.780Z,1720452788.780 [logger ThreadHandler](INFO): Handler Thread ID is 8656 2024-07-08T15:33:08.790Z,1720452788.790 [CBIT](DEBUG): Initialized mux pins. 2024-07-08T15:33:08.790Z,1720452788.790 [CBIT](DEBUG): Initializing the watchdog timer. 2024-07-08T15:33:08.798Z,1720452788.798 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 8657 2024-07-08T15:33:08.810Z,1720452788.810 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8658 2024-07-08T15:33:08.812Z,1720452788.812 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-07-08T15:33:08.814Z,1720452788.814 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-07-08T15:33:08.815Z,1720452788.815 [CBIT](DEBUG): Initializing heartbeat. 2024-07-08T15:33:08.822Z,1720452788.822 [Onboard ThreadHandler](INFO): Handler Thread ID is 8659 2024-07-08T15:33:08.858Z,1720452788.858 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8660 2024-07-08T15:33:08.862Z,1720452788.862 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8661 2024-07-08T15:33:08.863Z,1720452788.863 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-07-08T15:33:08.867Z,1720452788.867 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8663 2024-07-08T15:33:08.871Z,1720452788.871 [WetLabsBB2FL](INFO): Powering up 2024-07-08T15:33:08.872Z,1720452788.872 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8665 2024-07-08T15:33:08.876Z,1720452788.876 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-07-08T15:33:08.876Z,1720452788.876 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-07-08T15:33:08.876Z,1720452788.876 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-07-08T15:33:08.876Z,1720452788.876 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-07-08T15:33:08.876Z,1720452788.876 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-07-08T15:33:08.877Z,1720452788.877 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-07-08T15:33:08.877Z,1720452788.877 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-07-08T15:33:08.877Z,1720452788.877 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-07-08T15:33:08.886Z,1720452788.886 [CBIT](DEBUG): Deactivating GF circuits. 2024-07-08T15:33:08.887Z,1720452788.887 [CBIT](DEBUG): Deactivating emergency mode. 2024-07-08T15:33:08.926Z,1720452788.926 [CBIT](DEBUG): Backplane powered. 2024-07-08T15:33:08.927Z,1720452788.927 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-07-08T15:33:08.927Z,1720452788.927 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-07-08T15:33:08.928Z,1720452788.928 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-07-08T15:33:08.931Z,1720452788.931 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-07-08T15:33:09.014Z,1720452789.014 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-07-08T15:33:09.024Z,1720452789.024 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-07-08T15:33:09.068Z,1720452789.068 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-07-08T15:33:09.069Z,1720452789.069 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-07-08T15:33:09.069Z,1720452789.069 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-07-08T15:33:09.079Z,1720452789.079 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-07-08T15:33:09.262Z,1720452789.262 [Radio_Surface](INFO): Powering up 2024-07-08T15:33:09.393Z,1720452789.393 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-07-08T15:33:09.415Z,1720452789.415 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-07-08T15:33:09.416Z,1720452789.416 [Default:A.Wait](DEBUG): Construct Wait. 2024-07-08T15:33:09.427Z,1720452789.427 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-07-08T15:33:09.448Z,1720452789.448 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-07-08T15:33:09.475Z,1720452789.475 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-07-08T15:33:09.481Z,1720452789.481 [Default:E.Execute](DEBUG): Construct Execute. 2024-07-08T15:33:09.500Z,1720452789.500 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-07-08T15:33:09.504Z,1720452789.504 [controlThread](DEBUG): Component order: CycleStarter,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-07-08T15:33:09.572Z,1720452789.572 [Power24vConverter](INFO): Powering up. 2024-07-08T15:33:09.573Z,1720452789.573 [Sonardyne_Nano](INFO): Initializing. 2024-07-08T15:33:09.639Z,1720452789.639 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-07-08T15:33:09.646Z,1720452789.646 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-07-08T15:33:09.647Z,1720452789.647 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-07-08T15:33:09.654Z,1720452789.654 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-07-08T15:33:09.655Z,1720452789.655 [MassServo](DEBUG): Initializing EZServoServo. 2024-07-08T15:33:09.662Z,1720452789.662 [MassServo](DEBUG): Initializing MassServo. 2024-07-08T15:33:09.663Z,1720452789.663 [RudderServo](DEBUG): Initializing EZServoServo. 2024-07-08T15:33:09.670Z,1720452789.670 [RudderServo](DEBUG): Initializing RudderServo. 2024-07-08T15:33:09.671Z,1720452789.671 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-07-08T15:33:09.678Z,1720452789.678 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-07-08T15:33:10.978Z,1720452790.978 [WetLabsBB2FL](INFO): Powering down 2024-07-08T15:33:11.532Z,1720452791.532 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-07-08T15:33:12.746Z,1720452792.746 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107 2024-07-08T15:33:22.144Z,1720452802.144 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004725 2024-07-08T15:33:29.343Z,1720452809.343 [SBIT](IMPORTANT): Beginning Startup BIT 2024-07-08T15:33:29.351Z,1720452809.351 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-08T15:33:37.387Z,1720452817.387 [NAL9602](INFO): Powering up NAL9602 2024-07-08T15:33:40.240Z,1720452820.240 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.018538 CHAN A1 (24V): -0.006397 CHAN A2 (12V): -0.004701 CHAN A3 (5V): -0.002863 CHAN B0 (3.3V): -0.001276 CHAN B1 (3.15aV): -0.001040 CHAN B2 (3.15bV): -0.001435 CHAN B3 (GND): 0.000196 OPEN: 0.003897 Full Scale: +/- 1 mA 2024-07-08T15:33:48.296Z,1720452828.296 [NAL9602](INFO): NAL9602 initialized 2024-07-08T15:34:23.463Z,1720452863.463 [SBIT](IMPORTANT): SBIT PASSED 2024-07-08T15:34:23.463Z,1720452863.463 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-07-08T15:34:23.465Z,1720452863.465 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2024-07-08T15:34:23.465Z,1720452863.465 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count; 2024-07-08T15:34:23.465Z,1720452863.466 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-07-08T15:34:23.863Z,1720452863.863 [MissionManager](IMPORTANT): Started mission Startup 2024-07-08T15:34:23.864Z,1720452863.864 [Startup] Running Loop=1 2024-07-08T15:34:23.864Z,1720452863.864 [Startup](DEBUG): Aggregate::initialize Startup 2024-07-08T15:34:23.864Z,1720452863.864 [Startup:A.GoToSurface] Running Loop=1 2024-07-08T15:34:23.864Z,1720452863.864 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-07-08T15:34:23.864Z,1720452863.864 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-07-08T15:34:23.865Z,1720452863.865 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-07-08T15:34:23.865Z,1720452863.865 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-07-08T15:34:23.865Z,1720452863.865 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-07-08T15:34:23.870Z,1720452863.870 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-07-08T15:34:23.870Z,1720452863.870 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-07-08T15:34:23.872Z,1720452863.872 [Startup:StartupSatComms] Running Loop=1 2024-07-08T15:34:23.872Z,1720452863.872 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-07-08T15:34:23.872Z,1720452863.872 [Startup:StartupSatComms:A] Running Loop=1 2024-07-08T15:34:24.281Z,1720452864.281 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-07-08T15:35:08.911Z,1720452908.911 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:35:08.911Z,1720452908.911 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T15:35:08.911Z,1720452908.911 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:35:08.923Z,1720452908.923 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:35:09.318Z,1720452909.318 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:35:09.318Z,1720452909.318 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T15:35:24.262Z,1720452924.262 [Startup:StartupSatComms:A](INFO): Timed out from 2024-07-08T15:34:23.9Z 2024-07-08T15:35:24.262Z,1720452924.262 [Startup:StartupSatComms:A] Stopped 2024-07-08T15:35:24.262Z,1720452924.262 [Startup:StartupSatComms:B] Running Loop=1 2024-07-08T15:35:24.666Z,1720452924.666 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-07-08T15:35:33.681Z,1720452933.681 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240706T022813/Courier0004.lzma 2024-07-08T15:35:34.683Z,1720452934.683 [DataOverHttps](INFO): Moved sent file to Logs/20240706T022813/Courier0004.lzma.bak 2024-07-08T15:35:34.683Z,1720452934.683 [DataOverHttps](INFO): SBD MOMSN=21340281 2024-07-08T15:35:55.328Z,1720452955.328 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240708T153257/Courier0000.lzma 2024-07-08T15:35:55.695Z,1720452955.695 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Courier0000.lzma.bak 2024-07-08T15:35:55.695Z,1720452955.695 [DataOverHttps](INFO): SBD MOMSN=21340283 2024-07-08T15:36:13.982Z,1720452973.982 [CommandExec](IMPORTANT): got command strobe off 2024-07-08T15:36:13.982Z,1720452973.982 [CommandExec](IMPORTANT): Deactivating strobe 2024-07-08T15:36:14.753Z,1720452974.753 [DataOverHttps](INFO): Sending 863 bytes from file Logs/20240706T022142/Express0001.lzma 2024-07-08T15:36:15.746Z,1720452975.746 [DataOverHttps](INFO): Moved sent file to Logs/20240706T022142/Express0001.lzma.bak 2024-07-08T15:36:15.746Z,1720452975.746 [DataOverHttps](INFO): SBD MOMSN=21340286 2024-07-08T15:36:21.435Z,1720452981.435 [CommandExec](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch 2024-07-08T15:36:21.436Z,1720452981.436 [CommandExec](IMPORTANT): Onboard.Pressure 10.114576 psi 2024-07-08T15:36:24.432Z,1720452984.432 [Startup:StartupSatComms:B](INFO): Timed out from 2024-07-08T15:35:24.3Z 2024-07-08T15:36:24.432Z,1720452984.432 [Startup:StartupSatComms:B] Stopped 2024-07-08T15:36:24.432Z,1720452984.432 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-07-08T15:36:24.432Z,1720452984.432 [Startup:StartupSatComms] Stopped 2024-07-08T15:36:24.432Z,1720452984.432 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-07-08T15:36:24.433Z,1720452984.433 [Startup](INFO): Completed Startup 2024-07-08T15:36:24.433Z,1720452984.433 [MissionManager](INFO): Startup is completed. 2024-07-08T15:36:24.433Z,1720452984.433 [MissionManager](INFO): Uninitializing Mission Startup 2024-07-08T15:36:24.433Z,1720452984.434 [Startup] Stopped 2024-07-08T15:36:24.434Z,1720452984.434 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-07-08T15:36:24.434Z,1720452984.434 [Startup:A.GoToSurface] Stopped 2024-07-08T15:36:24.434Z,1720452984.434 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-07-08T15:36:24.845Z,1720452984.845 [MissionManager](IMPORTANT): Started mission Default 2024-07-08T15:36:24.845Z,1720452984.845 [Default] Running Loop=1 2024-07-08T15:36:24.845Z,1720452984.845 [Default](DEBUG): Aggregate::initialize Default 2024-07-08T15:36:24.845Z,1720452984.845 [Default:B.GoToSurface] Running Loop=1 2024-07-08T15:36:24.845Z,1720452984.845 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-07-08T15:36:24.845Z,1720452984.845 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-07-08T15:36:24.846Z,1720452984.846 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-07-08T15:36:24.846Z,1720452984.846 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-07-08T15:36:24.846Z,1720452984.846 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-07-08T15:36:24.846Z,1720452984.846 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-07-08T15:36:24.847Z,1720452984.847 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-07-08T15:36:24.847Z,1720452984.847 [Default:A.Wait] Running Loop=1 2024-07-08T15:36:24.847Z,1720452984.847 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-07-08T15:36:38.195Z,1720452998.195 [Default:A.Wait](INFO): Done Waiting. 2024-07-08T15:36:38.195Z,1720452998.195 [Default:A.Wait] Stopped 2024-07-08T15:36:38.195Z,1720452998.195 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-07-08T15:36:38.588Z,1720452998.588 [Default:CheckIn] Running Loop=1 2024-07-08T15:36:38.588Z,1720452998.588 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-08T15:36:38.588Z,1720452998.588 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-08T15:36:38.627Z,1720452998.627 [DataOverHttps](INFO): Sending 959 bytes from file Logs/20240706T022340/Express0001.lzma 2024-07-08T15:36:38.984Z,1720452998.984 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-07-08T15:36:39.599Z,1720452999.599 [DataOverHttps](INFO): Moved sent file to Logs/20240706T022340/Express0001.lzma.bak 2024-07-08T15:36:39.616Z,1720452999.616 [DataOverHttps](INFO): SBD MOMSN=21340322 2024-07-08T15:36:45.360Z,1720453005.360 [CommandExec](IMPORTANT): got command get Onboard.Humidity 2024-07-08T15:36:45.361Z,1720453005.361 [CommandExec](IMPORTANT): Onboard.Humidity 10.987669 % 2024-07-08T15:37:10.089Z,1720453030.089 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:37:10.089Z,1720453030.089 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-07-08T15:37:10.089Z,1720453030.089 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:37:10.110Z,1720453030.110 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:37:10.512Z,1720453030.512 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:37:10.512Z,1720453030.512 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-07-08T15:38:06.289Z,1720453086.289 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:38:21.582Z,1720453101.582 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:38:36.934Z,1720453116.934 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:38:52.331Z,1720453132.331 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-07-08T15:38:52.690Z,1720453132.690 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:39:08.850Z,1720453148.850 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:39:11.287Z,1720453151.287 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:39:11.287Z,1720453151.287 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-07-08T15:39:11.287Z,1720453151.287 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:39:11.298Z,1720453151.298 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:39:11.699Z,1720453151.699 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:39:11.699Z,1720453151.699 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-07-08T15:39:23.799Z,1720453163.799 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:39:39.150Z,1720453179.150 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:39:54.503Z,1720453194.503 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:40:09.854Z,1720453209.854 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:40:24.802Z,1720453224.802 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-08T15:40:32.889Z,1720453232.889 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5. 2024-07-08T15:40:32.917Z,1720453232.917 [BPC1](INFO): Received data from all battery sticks. 2024-07-08T15:41:12.512Z,1720453272.512 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:41:12.512Z,1720453272.512 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-07-08T15:41:12.512Z,1720453272.512 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:41:12.523Z,1720453272.523 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:41:12.915Z,1720453272.915 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:41:12.915Z,1720453272.915 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-07-08T15:41:38.753Z,1720453298.753 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-07-08T15:36:38.6Z 2024-07-08T15:41:38.754Z,1720453298.754 [Default:CheckIn:Read_GPS] Stopped 2024-07-08T15:41:38.754Z,1720453298.754 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-08T15:41:39.157Z,1720453299.157 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-07-08T15:41:53.892Z,1720453313.892 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240708T153257/Courier0004.lzma 2024-07-08T15:41:54.895Z,1720453314.895 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Courier0004.lzma.bak 2024-07-08T15:41:54.895Z,1720453314.895 [DataOverHttps](INFO): SBD MOMSN=21340367 2024-07-08T15:42:20.246Z,1720453340.246 [DataOverHttps](INFO): Sending 192 bytes from file Logs/20240706T022340/Express0005.lzma 2024-07-08T15:42:21.246Z,1720453341.246 [DataOverHttps](INFO): Moved sent file to Logs/20240706T022340/Express0005.lzma.bak 2024-07-08T15:42:21.247Z,1720453341.247 [DataOverHttps](INFO): SBD MOMSN=21340369 2024-07-08T15:42:45.239Z,1720453365.239 [DataOverHttps](INFO): Sending 924 bytes from file Logs/20240706T022813/Express0001.lzma 2024-07-08T15:42:46.238Z,1720453366.238 [DataOverHttps](INFO): Moved sent file to Logs/20240706T022813/Express0001.lzma.bak 2024-07-08T15:42:46.238Z,1720453366.238 [DataOverHttps](INFO): SBD MOMSN=21340380 2024-07-08T15:43:06.457Z,1720453386.457 [DataOverHttps](INFO): Sending 291 bytes from file Logs/20240706T022813/Express0005.lzma 2024-07-08T15:43:07.274Z,1720453387.274 [DataOverHttps](INFO): Moved sent file to Logs/20240706T022813/Express0005.lzma.bak 2024-07-08T15:43:07.275Z,1720453387.275 [DataOverHttps](INFO): SBD MOMSN=21340401 2024-07-08T15:43:10.625Z,1720453390.625 [Power24vConverter](INFO): Powering down. 2024-07-08T15:43:13.468Z,1720453393.468 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:43:13.468Z,1720453393.468 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-07-08T15:43:13.468Z,1720453393.468 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:43:13.491Z,1720453393.491 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:43:13.890Z,1720453393.890 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:43:13.890Z,1720453393.890 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-07-08T15:43:27.710Z,1720453407.710 [DataOverHttps](INFO): Sending 821 bytes from file Logs/20240708T153257/Express0001.lzma 2024-07-08T15:43:28.457Z,1720453408.457 [CommandExec](IMPORTANT): got command failComponent 2024-07-08T15:43:28.457Z,1720453408.457 [CommandExec](IMPORTANT): Failed components: 2024-07-08T15:43:28.458Z,1720453408.458 [CommandExec](IMPORTANT): No failed Components. 2024-07-08T15:43:28.711Z,1720453408.711 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Express0001.lzma.bak 2024-07-08T15:43:28.711Z,1720453408.711 [DataOverHttps](INFO): SBD MOMSN=21340409 2024-07-08T15:43:34.386Z,1720453414.386 [CommandExec](IMPORTANT): got command gfscan 2024-07-08T15:43:34.475Z,1720453414.475 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-08T15:43:37.312Z,1720453417.312 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2024-07-08T15:43:45.401Z,1720453425.401 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.020028 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): -0.004781 CHAN A3 (5V): -0.002749 CHAN B0 (3.3V): -0.001108 CHAN B1 (3.15aV): -0.000967 CHAN B2 (3.15bV): -0.001652 CHAN B3 (GND): -0.000116 OPEN: 0.003591 Full Scale: +/- 1 mA 2024-07-08T15:43:48.417Z,1720453428.417 [DataOverHttps](INFO): Sending 412 bytes from file Logs/20240708T153257/Express0005.lzma 2024-07-08T15:43:49.418Z,1720453429.418 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Express0005.lzma.bak 2024-07-08T15:43:49.419Z,1720453429.419 [DataOverHttps](INFO): SBD MOMSN=21340426 2024-07-08T15:43:51.014Z,1720453431.014 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-07-08T15:43:51.014Z,1720453431.014 [NAL9602] Data Fault, FailCount= 1 2024-07-08T15:43:51.014Z,1720453431.014 [NAL9602](ERROR): Data Fault 2024-07-08T15:43:51.066Z,1720453431.066 [CBIT](ERROR): Data Fault in component: NAL9602 2024-07-08T15:43:51.418Z,1720453431.418 [NAL9602](INFO): Powering down 2024-07-08T15:43:52.254Z,1720453432.254 [CBIT](INFO): Clearing failed state for component NAL9602 2024-07-08T15:43:52.254Z,1720453432.254 [NAL9602] No Fault, FailCount= 1 2024-07-08T15:43:57.505Z,1720453437.505 [Default:CheckIn:Read_Iridium] Stopped 2024-07-08T15:43:57.505Z,1720453437.505 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-08T15:43:57.505Z,1720453437.505 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-08T15:44:21.722Z,1720453461.722 [NAL9602](INFO): Powering up NAL9602 2024-07-08T15:44:32.627Z,1720453472.627 [NAL9602](INFO): NAL9602 initialized 2024-07-08T15:45:14.652Z,1720453514.652 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:45:14.652Z,1720453514.652 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-07-08T15:45:14.652Z,1720453514.652 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:45:14.689Z,1720453514.689 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:45:15.065Z,1720453515.065 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:45:15.065Z,1720453515.065 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-07-08T15:47:15.488Z,1720453635.488 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:47:15.488Z,1720453635.488 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-07-08T15:47:15.488Z,1720453635.488 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:47:15.500Z,1720453635.500 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:47:15.882Z,1720453635.882 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:47:15.882Z,1720453635.882 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-07-08T15:48:58.067Z,1720453738.067 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-08T15:48:58.067Z,1720453738.067 [Default:CheckIn:C.Wait] Stopped 2024-07-08T15:48:58.067Z,1720453738.067 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-08T15:48:58.067Z,1720453738.067 [Default:CheckIn:D] Running Loop=1 2024-07-08T15:48:58.486Z,1720453738.486 [Default:CheckIn:D] Stopped 2024-07-08T15:48:58.486Z,1720453738.486 [Default:CheckIn:E] Running Loop=1 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.560687 min 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn:E] Stopped 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn] Stopped 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn](INFO): Running loop #2 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn] Running Loop=2 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-08T15:48:58.897Z,1720453738.897 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-08T15:49:16.650Z,1720453756.650 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:49:16.650Z,1720453756.650 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-07-08T15:49:16.650Z,1720453756.650 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:49:16.661Z,1720453756.661 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:49:17.071Z,1720453757.071 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:49:17.071Z,1720453757.071 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-07-08T15:51:17.844Z,1720453877.844 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:51:17.844Z,1720453877.844 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-07-08T15:51:17.845Z,1720453877.845 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:51:17.876Z,1720453877.876 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:51:18.285Z,1720453878.285 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:51:18.285Z,1720453878.285 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-07-08T15:53:19.056Z,1720453999.056 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:53:19.056Z,1720453999.056 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-07-08T15:53:19.056Z,1720453999.056 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:53:19.067Z,1720453999.067 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:53:19.483Z,1720453999.483 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:53:19.483Z,1720453999.483 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-07-08T15:53:59.061Z,1720454039.061 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-07-08T15:48:58.9Z 2024-07-08T15:53:59.061Z,1720454039.061 [Default:CheckIn:Read_GPS] Stopped 2024-07-08T15:53:59.061Z,1720454039.061 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-08T15:54:08.656Z,1720454048.656 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240708T153257/Courier0007.lzma 2024-07-08T15:54:09.659Z,1720454049.659 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Courier0007.lzma.bak 2024-07-08T15:54:09.659Z,1720454049.659 [DataOverHttps](INFO): SBD MOMSN=21340465 2024-07-08T15:54:29.650Z,1720454069.650 [DataOverHttps](INFO): Sending 525 bytes from file Logs/20240708T153257/Express0008.lzma 2024-07-08T15:54:30.650Z,1720454070.650 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Express0008.lzma.bak 2024-07-08T15:54:30.651Z,1720454070.651 [DataOverHttps](INFO): SBD MOMSN=21340467 2024-07-08T15:54:34.191Z,1720454074.191 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-07-08T15:54:34.191Z,1720454074.191 [NAL9602] Data Fault, FailCount= 2 2024-07-08T15:54:34.191Z,1720454074.191 [NAL9602](ERROR): Data Fault 2024-07-08T15:54:34.247Z,1720454074.247 [CBIT](ERROR): Data Fault in component: NAL9602 2024-07-08T15:54:34.602Z,1720454074.602 [NAL9602](INFO): Powering down 2024-07-08T15:54:35.435Z,1720454075.435 [CBIT](INFO): Clearing failed state for component NAL9602 2024-07-08T15:54:35.436Z,1720454075.436 [NAL9602] No Fault, FailCount= 2 2024-07-08T15:54:36.634Z,1720454076.634 [Default:CheckIn:Read_Iridium] Stopped 2024-07-08T15:54:36.634Z,1720454076.634 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-08T15:54:36.634Z,1720454076.634 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-08T15:55:04.894Z,1720454104.894 [NAL9602](INFO): Powering up NAL9602 2024-07-08T15:55:15.803Z,1720454115.803 [NAL9602](INFO): NAL9602 initialized 2024-07-08T15:55:20.273Z,1720454120.273 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:55:20.273Z,1720454120.273 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-07-08T15:55:20.273Z,1720454120.273 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:55:20.284Z,1720454120.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:55:20.690Z,1720454120.690 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:55:20.690Z,1720454120.690 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-07-08T15:56:01.459Z,1720454161.459 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155600.00,A,3648.17419,N,12147.27987,W,0.097,0.00,080724,,,A*7D 2024-07-08T15:56:01.507Z,1720454161.507 [NAL9602](INFO): GPS fix at 20240708T155600: (36.802903, -121.787998) 2024-07-08T15:56:33.775Z,1720454193.775 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-08T15:57:21.455Z,1720454241.455 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:57:21.455Z,1720454241.455 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T15:57:21.455Z,1720454241.455 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:57:21.467Z,1720454241.467 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:57:21.879Z,1720454241.879 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:57:21.879Z,1720454241.879 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T15:58:26.134Z,1720454306.134 [DataOverHttps](IMPORTANT): SBD MTMSN=20240708T155825 2024-07-08T15:58:33.281Z,1720454313.281 [DataOverHttps](INFO): Received command: ibit 2024-07-08T15:58:33.325Z,1720454313.325 [CommandExec](IMPORTANT): got command ibit 2024-07-08T15:58:33.384Z,1720454313.384 [IBIT](IMPORTANT): Beginning Initiated BIT 2024-07-08T15:58:33.384Z,1720454313.384 [IBIT](IMPORTANT): Beginning control surface checks. 2024-07-08T15:58:33.388Z,1720454313.388 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-08T15:58:34.976Z,1720454314.976 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155834.00,A,3648.17191,N,12147.28373,W,0.039,0.00,080724,,,A*7B 2024-07-08T15:58:34.983Z,1720454314.983 [NAL9602](INFO): GPS fix at 20240708T155834: (36.802865, -121.788062) 2024-07-08T15:58:36.273Z,1720454316.273 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2024-07-08T15:58:44.286Z,1720454324.286 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006040 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): -0.004363 CHAN A3 (5V): -0.003099 CHAN B0 (3.3V): -0.000534 CHAN B1 (3.15aV): -0.000984 CHAN B2 (3.15bV): -0.001467 CHAN B3 (GND): -0.000404 OPEN: 0.003917 Full Scale: +/- 1 mA 2024-07-08T15:58:56.388Z,1720454336.388 [NAL9602](INFO): SBD MO Status=2, MOMSN=5057, MT Status=2, MTMSN=0 2024-07-08T15:58:56.389Z,1720454336.389 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-07-08T15:59:22.602Z,1720454362.602 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T15:59:22.602Z,1720454362.602 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T15:59:22.602Z,1720454362.602 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T15:59:22.613Z,1720454362.613 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T15:59:23.020Z,1720454363.020 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T15:59:23.020Z,1720454363.020 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T15:59:30.311Z,1720454370.311 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 1 Latitude: 36.802864 Longitude: -121.788063 2024-07-08T15:59:30.704Z,1720454370.704 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 15.580000 2024-07-08T15:59:30.704Z,1720454370.704 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2024-07-08T15:59:30.704Z,1720454370.704 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2024-07-08T15:59:31.093Z,1720454371.093 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2024-07-08T15:59:31.094Z,1720454371.094 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2024-07-08T15:59:31.094Z,1720454371.094 [IBIT](IMPORTANT): Pressure:10.156526 PSI 2024-07-08T15:59:31.094Z,1720454371.094 [IBIT](IMPORTANT): Humidity:10.963252 % 2024-07-08T15:59:31.505Z,1720454371.505 [IBIT](FAULT): Unable to read vehicle orientation values from AHRS 2024-07-08T15:59:31.902Z,1720454371.902 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2024-07-08T15:59:31.902Z,1720454371.902 [IBIT](IMPORTANT): buoyancyNeutral: 200.000000 cc 2024-07-08T15:59:31.902Z,1720454371.902 [IBIT](IMPORTANT): massDefault: 0.000000 cm 2024-07-08T15:59:31.903Z,1720454371.903 [IBIT](IMPORTANT): stopDepth: 275.000000 m 2024-07-08T15:59:31.903Z,1720454371.903 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2024-07-08T15:59:31.903Z,1720454371.903 [IBIT](IMPORTANT): IBIT FAILED 2024-07-08T15:59:37.147Z,1720454377.147 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-08T15:59:37.147Z,1720454377.147 [Default:CheckIn:C.Wait] Stopped 2024-07-08T15:59:37.147Z,1720454377.147 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-08T15:59:37.147Z,1720454377.147 [Default:CheckIn:D] Running Loop=1 2024-07-08T15:59:37.558Z,1720454377.558 [Default:CheckIn:D] Stopped 2024-07-08T15:59:37.558Z,1720454377.558 [Default:CheckIn:E] Running Loop=1 2024-07-08T15:59:37.958Z,1720454377.958 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.211888 min 2024-07-08T15:59:37.958Z,1720454377.958 [Default:CheckIn:E] Stopped 2024-07-08T15:59:37.958Z,1720454377.958 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-08T15:59:37.958Z,1720454377.958 [Default:CheckIn] Stopped 2024-07-08T15:59:37.958Z,1720454377.958 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-08T15:59:37.958Z,1720454377.958 [Default:CheckIn](INFO): Running loop #3 2024-07-08T15:59:37.958Z,1720454377.958 [Default:CheckIn] Running Loop=3 2024-07-08T15:59:37.959Z,1720454377.959 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-08T15:59:37.959Z,1720454377.959 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-08T16:00:14.310Z,1720454414.310 [NAL9602](INFO): SBD MO Status=2, MOMSN=5057, MT Status=2, MTMSN=0 2024-07-08T16:00:14.310Z,1720454414.310 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-07-08T16:00:44.610Z,1720454444.610 [NAL9602](INFO): SBD MO Status=0, MOMSN=5057, MT Status=0, MTMSN=0 2024-07-08T16:00:44.611Z,1720454444.611 [NAL9602](INFO): No messages in MT queue 2024-07-08T16:00:45.822Z,1720454445.822 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160045.00,A,3648.17009,N,12147.28332,W,0.136,0.00,080724,,,A*78 2024-07-08T16:00:45.825Z,1720454445.825 [NAL9602](INFO): GPS fix at 20240708T160045: (36.802835, -121.788055) 2024-07-08T16:00:45.834Z,1720454445.834 [Default:CheckIn:Read_GPS] Stopped 2024-07-08T16:00:45.834Z,1720454445.834 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-08T16:00:55.147Z,1720454455.147 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20240708T153257/Courier0010.lzma 2024-07-08T16:00:56.149Z,1720454456.149 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Courier0010.lzma.bak 2024-07-08T16:00:56.149Z,1720454456.149 [DataOverHttps](INFO): SBD MOMSN=21340506 2024-07-08T16:01:16.436Z,1720454476.436 [DataOverHttps](INFO): Sending 1009 bytes from file Logs/20240708T153257/Express0011.lzma 2024-07-08T16:01:17.437Z,1720454477.437 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Express0011.lzma.bak 2024-07-08T16:01:17.437Z,1720454477.437 [DataOverHttps](INFO): SBD MOMSN=21340509 2024-07-08T16:01:18.140Z,1720454478.140 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-08T16:01:23.424Z,1720454483.424 [Default:CheckIn:Read_Iridium] Stopped 2024-07-08T16:01:23.424Z,1720454483.424 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-08T16:01:23.424Z,1720454483.424 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-08T16:01:23.814Z,1720454483.814 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:01:23.814Z,1720454483.814 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T16:01:23.814Z,1720454483.814 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:01:23.867Z,1720454483.867 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:01:24.232Z,1720454484.232 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:01:24.232Z,1720454484.232 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T16:03:25.014Z,1720454605.014 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:03:25.014Z,1720454605.014 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-07-08T16:03:25.014Z,1720454605.014 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:03:25.060Z,1720454605.060 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:03:25.428Z,1720454605.428 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:03:25.428Z,1720454605.428 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-07-08T16:04:02.500Z,1720454642.500 [DataOverHttps](IMPORTANT): SBD MTMSN=20240708T160401 2024-07-08T16:04:09.559Z,1720454649.559 [DataOverHttps](INFO): Received command: ibit 2024-07-08T16:04:09.604Z,1720454649.604 [CommandExec](IMPORTANT): got command ibit 2024-07-08T16:04:09.855Z,1720454649.855 [IBIT](IMPORTANT): Beginning Initiated BIT 2024-07-08T16:04:09.855Z,1720454649.855 [IBIT](IMPORTANT): Beginning control surface checks. 2024-07-08T16:04:09.858Z,1720454649.858 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-08T16:04:11.458Z,1720454651.458 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160411.00,A,3648.17219,N,12147.28406,W,0.039,7.61,080724,,,A*70 2024-07-08T16:04:11.461Z,1720454651.461 [NAL9602](INFO): GPS fix at 20240708T160411: (36.802870, -121.788068) 2024-07-08T16:04:12.752Z,1720454652.752 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2024-07-08T16:04:20.770Z,1720454660.770 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006625 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): -0.004811 CHAN A3 (5V): -0.002507 CHAN B0 (3.3V): -0.000855 CHAN B1 (3.15aV): -0.000906 CHAN B2 (3.15bV): -0.000764 CHAN B3 (GND): -0.000119 OPEN: 0.003807 Full Scale: +/- 1 mA 2024-07-08T16:04:26.011Z,1720454666.011 [NAL9602](INFO): SBD MO Status=0, MOMSN=5058, MT Status=0, MTMSN=0 2024-07-08T16:04:26.011Z,1720454666.011 [NAL9602](INFO): No messages in MT queue 2024-07-08T16:04:27.214Z,1720454667.214 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160426.00,A,3648.17207,N,12147.28347,W,0.039,7.61,080724,,,A*79 2024-07-08T16:04:27.217Z,1720454667.217 [NAL9602](INFO): GPS fix at 20240708T160426: (36.802868, -121.788058) 2024-07-08T16:04:29.639Z,1720454669.639 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160429.00,A,3648.17205,N,12147.28338,W,0.039,7.61,080724,,,A*7C 2024-07-08T16:04:29.641Z,1720454669.641 [NAL9602](INFO): GPS fix at 20240708T160429: (36.802867, -121.788056) 2024-07-08T16:04:32.467Z,1720454672.467 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160432.00,A,3648.17195,N,12147.28335,W,0.039,7.61,080724,,,A*71 2024-07-08T16:04:32.472Z,1720454672.472 [NAL9602](INFO): GPS fix at 20240708T160432: (36.802866, -121.788056) 2024-07-08T16:04:35.698Z,1720454675.698 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160435.00,A,3648.17197,N,12147.28340,W,0.019,7.61,080724,,,A*74 2024-07-08T16:04:35.701Z,1720454675.701 [NAL9602](INFO): GPS fix at 20240708T160435: (36.802866, -121.788057) 2024-07-08T16:04:38.527Z,1720454678.527 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160438.00,A,3648.17206,N,12147.28356,W,0.039,7.61,080724,,,A*77 2024-07-08T16:04:38.529Z,1720454678.529 [NAL9602](INFO): GPS fix at 20240708T160438: (36.802868, -121.788059) 2024-07-08T16:04:41.766Z,1720454681.766 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160441.00,A,3648.17207,N,12147.28367,W,0.000,7.61,080724,,,A*70 2024-07-08T16:04:41.768Z,1720454681.768 [NAL9602](INFO): GPS fix at 20240708T160441: (36.802868, -121.788061) 2024-07-08T16:04:44.587Z,1720454684.587 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160444.00,A,3648.17206,N,12147.28373,W,0.019,7.61,080724,,,A*79 2024-07-08T16:04:44.589Z,1720454684.589 [NAL9602](INFO): GPS fix at 20240708T160444: (36.802868, -121.788062) 2024-07-08T16:04:47.416Z,1720454687.416 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160447.00,A,3648.17206,N,12147.28372,W,0.039,7.61,080724,,,A*79 2024-07-08T16:04:47.418Z,1720454687.418 [NAL9602](INFO): GPS fix at 20240708T160447: (36.802868, -121.788062) 2024-07-08T16:04:50.647Z,1720454690.647 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160450.00,A,3648.17206,N,12147.28374,W,0.019,7.61,080724,,,A*7B 2024-07-08T16:04:50.649Z,1720454690.649 [NAL9602](INFO): GPS fix at 20240708T160450: (36.802868, -121.788062) 2024-07-08T16:04:53.475Z,1720454693.475 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160453.00,A,3648.17210,N,12147.28379,W,0.039,7.61,080724,,,A*70 2024-07-08T16:04:53.477Z,1720454693.477 [NAL9602](INFO): GPS fix at 20240708T160453: (36.802868, -121.788063) 2024-07-08T16:04:56.336Z,1720454696.336 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 5 Latitude: 36.802868 Longitude: -121.788063 2024-07-08T16:04:56.707Z,1720454696.707 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160456.00,A,3648.17213,N,12147.28381,W,0.039,7.61,080724,,,A*71 2024-07-08T16:04:56.709Z,1720454696.709 [NAL9602](INFO): GPS fix at 20240708T160456: (36.802869, -121.788064) 2024-07-08T16:04:56.746Z,1720454696.746 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 15.580000 2024-07-08T16:04:56.747Z,1720454696.747 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2024-07-08T16:04:56.747Z,1720454696.747 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2024-07-08T16:04:57.139Z,1720454697.139 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2024-07-08T16:04:57.154Z,1720454697.154 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2024-07-08T16:04:57.154Z,1720454697.154 [IBIT](IMPORTANT): Pressure:10.160606 PSI 2024-07-08T16:04:57.154Z,1720454697.154 [IBIT](IMPORTANT): Humidity:10.908314 % 2024-07-08T16:04:57.531Z,1720454697.531 [IBIT](FAULT): Unable to read vehicle orientation values from AHRS 2024-07-08T16:04:57.943Z,1720454697.943 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2024-07-08T16:04:57.943Z,1720454697.943 [IBIT](IMPORTANT): buoyancyNeutral: 200.000000 cc 2024-07-08T16:04:57.944Z,1720454697.944 [IBIT](IMPORTANT): massDefault: 0.000000 cm 2024-07-08T16:04:57.944Z,1720454697.944 [IBIT](IMPORTANT): stopDepth: 275.000000 m 2024-07-08T16:04:57.944Z,1720454697.944 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2024-07-08T16:04:57.944Z,1720454697.944 [IBIT](IMPORTANT): IBIT FAILED 2024-07-08T16:05:26.202Z,1720454726.202 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:05:26.202Z,1720454726.202 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T16:05:26.202Z,1720454726.202 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:05:26.232Z,1720454726.232 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:05:26.630Z,1720454726.630 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:05:26.630Z,1720454726.630 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T16:05:29.026Z,1720454729.026 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-08T16:06:23.899Z,1720454783.899 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-08T16:06:23.899Z,1720454783.899 [Default:CheckIn:C.Wait] Stopped 2024-07-08T16:06:23.899Z,1720454783.899 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-08T16:06:23.899Z,1720454783.899 [Default:CheckIn:D] Running Loop=1 2024-07-08T16:06:24.303Z,1720454784.303 [Default:CheckIn:D] Stopped 2024-07-08T16:06:24.303Z,1720454784.303 [Default:CheckIn:E] Running Loop=1 2024-07-08T16:06:24.708Z,1720454784.708 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 29.990971 min 2024-07-08T16:06:24.709Z,1720454784.709 [Default:CheckIn:E] Stopped 2024-07-08T16:06:24.709Z,1720454784.709 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-08T16:06:24.709Z,1720454784.709 [Default:CheckIn] Stopped 2024-07-08T16:06:24.709Z,1720454784.709 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-08T16:06:24.709Z,1720454784.709 [Default:CheckIn](INFO): Running loop #4 2024-07-08T16:06:24.709Z,1720454784.709 [Default:CheckIn] Running Loop=4 2024-07-08T16:06:24.709Z,1720454784.709 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-08T16:06:24.709Z,1720454784.709 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-08T16:06:26.721Z,1720454786.721 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160626.00,A,3648.17258,N,12147.28254,W,0.039,7.61,080724,,,A*72 2024-07-08T16:06:26.724Z,1720454786.724 [NAL9602](INFO): GPS fix at 20240708T160626: (36.802876, -121.788042) 2024-07-08T16:06:26.745Z,1720454786.745 [Default:CheckIn:Read_GPS] Stopped 2024-07-08T16:06:26.745Z,1720454786.745 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-08T16:06:32.763Z,1720454792.763 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240708T153257/Courier0015.lzma 2024-07-08T16:06:33.767Z,1720454793.767 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Courier0015.lzma.bak 2024-07-08T16:06:33.767Z,1720454793.767 [DataOverHttps](INFO): SBD MOMSN=21340547 2024-07-08T16:06:46.188Z,1720454806.188 [NAL9602](INFO): SBD MO Status=0, MOMSN=5059, MT Status=0, MTMSN=0 2024-07-08T16:06:46.188Z,1720454806.188 [NAL9602](INFO): No messages in MT queue 2024-07-08T16:06:55.591Z,1720454815.591 [DataOverHttps](INFO): Sending 834 bytes from file Logs/20240708T153257/Express0017.lzma 2024-07-08T16:06:56.665Z,1720454816.665 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Express0017.lzma.bak 2024-07-08T16:06:56.666Z,1720454816.666 [DataOverHttps](INFO): SBD MOMSN=21340550 2024-07-08T16:07:16.577Z,1720454836.577 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240708T153257/Express0020.lzma 2024-07-08T16:07:16.891Z,1720454836.891 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-08T16:07:17.579Z,1720454837.579 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Express0020.lzma.bak 2024-07-08T16:07:17.580Z,1720454837.580 [DataOverHttps](INFO): SBD MOMSN=21340578 2024-07-08T16:07:23.370Z,1720454843.370 [Default:CheckIn:Read_Iridium] Stopped 2024-07-08T16:07:23.370Z,1720454843.370 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-08T16:07:23.370Z,1720454843.370 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-08T16:07:27.404Z,1720454847.404 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:07:27.405Z,1720454847.405 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T16:07:27.405Z,1720454847.405 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:07:27.449Z,1720454847.449 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:07:27.817Z,1720454847.817 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:07:27.817Z,1720454847.817 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T16:09:28.602Z,1720454968.602 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:09:28.602Z,1720454968.602 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-07-08T16:09:28.602Z,1720454968.602 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:09:28.614Z,1720454968.614 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:09:29.024Z,1720454969.024 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:09:29.024Z,1720454969.024 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-07-08T16:10:38.427Z,1720455038.427 [DataOverHttps](IMPORTANT): SBD MTMSN=20240708T161037 2024-07-08T16:10:45.457Z,1720455045.457 [DataOverHttps](INFO): Received command: ! echo 1 > /dev/loadC5 2024-07-08T16:10:45.527Z,1720455045.527 [CommandExec](IMPORTANT): got command ! echo 1 > /dev/loadC5 2024-07-08T16:11:21.615Z,1720455081.615 [DataOverHttps](IMPORTANT): SBD MTMSN=20240708T161120 2024-07-08T16:11:28.729Z,1720455088.729 [DataOverHttps](INFO): Received command: ibit 2024-07-08T16:11:28.774Z,1720455088.774 [CommandExec](IMPORTANT): got command ibit 2024-07-08T16:11:29.010Z,1720455089.010 [IBIT](IMPORTANT): Beginning Initiated BIT 2024-07-08T16:11:29.010Z,1720455089.010 [IBIT](IMPORTANT): Beginning control surface checks. 2024-07-08T16:11:29.013Z,1720455089.013 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-08T16:11:29.800Z,1720455089.800 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:11:29.800Z,1720455089.800 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-07-08T16:11:29.800Z,1720455089.800 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:11:29.813Z,1720455089.813 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:11:30.228Z,1720455090.228 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:11:30.228Z,1720455090.228 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-07-08T16:11:30.600Z,1720455090.600 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161130.00,A,3648.17391,N,12147.28592,W,0.019,7.61,080724,,,A*78 2024-07-08T16:11:30.603Z,1720455090.603 [NAL9602](INFO): GPS fix at 20240708T161130: (36.802898, -121.788099) 2024-07-08T16:11:31.895Z,1720455091.895 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2024-07-08T16:11:39.917Z,1720455099.917 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.005901 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): -0.004692 CHAN A3 (5V): -0.002919 CHAN B0 (3.3V): -0.000457 CHAN B1 (3.15aV): -0.001255 CHAN B2 (3.15bV): -0.001105 CHAN B3 (GND): -0.000027 OPEN: 0.003490 Full Scale: +/- 1 mA 2024-07-08T16:11:58.076Z,1720455118.076 [NAL9602](INFO): SBD MO Status=0, MOMSN=5060, MT Status=0, MTMSN=0 2024-07-08T16:11:58.076Z,1720455118.076 [NAL9602](INFO): No messages in MT queue 2024-07-08T16:11:59.288Z,1720455119.288 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161158.00,A,3648.17410,N,12147.28632,W,0.078,7.61,080724,,,A*76 2024-07-08T16:11:59.291Z,1720455119.291 [NAL9602](INFO): GPS fix at 20240708T161158: (36.802902, -121.788105) 2024-07-08T16:12:01.710Z,1720455121.710 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161201.00,A,3648.17404,N,12147.28635,W,0.039,7.61,080724,,,A*7E 2024-07-08T16:12:01.712Z,1720455121.712 [NAL9602](INFO): GPS fix at 20240708T161201: (36.802901, -121.788106) 2024-07-08T16:12:04.946Z,1720455124.946 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161204.00,A,3648.17395,N,12147.28629,W,0.039,7.61,080724,,,A*79 2024-07-08T16:12:04.948Z,1720455124.948 [NAL9602](INFO): GPS fix at 20240708T161204: (36.802899, -121.788105) 2024-07-08T16:12:07.772Z,1720455127.772 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161207.00,A,3648.17385,N,12147.28623,W,0.019,7.61,080724,,,A*73 2024-07-08T16:12:07.775Z,1720455127.775 [NAL9602](INFO): GPS fix at 20240708T161207: (36.802898, -121.788104) 2024-07-08T16:12:10.600Z,1720455130.600 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161210.00,A,3648.17366,N,12147.28610,W,0.058,7.61,080724,,,A*7D 2024-07-08T16:12:10.602Z,1720455130.602 [NAL9602](INFO): GPS fix at 20240708T161210: (36.802894, -121.788102) 2024-07-08T16:12:13.833Z,1720455133.833 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161213.00,A,3648.17341,N,12147.28590,W,0.058,7.61,080724,,,A*70 2024-07-08T16:12:13.835Z,1720455133.835 [NAL9602](INFO): GPS fix at 20240708T161213: (36.802890, -121.788098) 2024-07-08T16:12:15.476Z,1720455135.476 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 3 Latitude: 36.802891 Longitude: -121.788101 2024-07-08T16:12:15.866Z,1720455135.866 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 15.580000 2024-07-08T16:12:15.866Z,1720455135.866 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2024-07-08T16:12:15.866Z,1720455135.866 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2024-07-08T16:12:16.268Z,1720455136.268 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2024-07-08T16:12:16.268Z,1720455136.268 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2024-07-08T16:12:16.268Z,1720455136.268 [IBIT](IMPORTANT): Pressure:10.131479 PSI 2024-07-08T16:12:16.268Z,1720455136.268 [IBIT](IMPORTANT): Humidity:10.816751 % 2024-07-08T16:12:16.668Z,1720455136.668 [IBIT](FAULT): Unable to read vehicle orientation values from AHRS 2024-07-08T16:12:17.085Z,1720455137.085 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2024-07-08T16:12:17.085Z,1720455137.085 [IBIT](IMPORTANT): buoyancyNeutral: 200.000000 cc 2024-07-08T16:12:17.085Z,1720455137.085 [IBIT](IMPORTANT): massDefault: 0.000000 cm 2024-07-08T16:12:17.086Z,1720455137.086 [IBIT](IMPORTANT): stopDepth: 275.000000 m 2024-07-08T16:12:17.086Z,1720455137.086 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2024-07-08T16:12:17.086Z,1720455137.086 [IBIT](IMPORTANT): IBIT FAILED 2024-07-08T16:12:23.938Z,1720455143.938 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-08T16:12:23.938Z,1720455143.938 [Default:CheckIn:C.Wait] Stopped 2024-07-08T16:12:23.938Z,1720455143.938 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-08T16:12:23.938Z,1720455143.938 [Default:CheckIn:D] Running Loop=1 2024-07-08T16:12:24.342Z,1720455144.342 [Default:CheckIn:D] Stopped 2024-07-08T16:12:24.343Z,1720455144.343 [Default:CheckIn:E] Running Loop=1 2024-07-08T16:12:24.746Z,1720455144.746 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.991626 min 2024-07-08T16:12:24.746Z,1720455144.746 [Default:CheckIn:E] Stopped 2024-07-08T16:12:24.747Z,1720455144.747 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-08T16:12:24.747Z,1720455144.747 [Default:CheckIn] Stopped 2024-07-08T16:12:24.747Z,1720455144.747 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-08T16:12:24.747Z,1720455144.747 [Default:CheckIn](INFO): Running loop #5 2024-07-08T16:12:24.747Z,1720455144.747 [Default:CheckIn] Running Loop=5 2024-07-08T16:12:24.747Z,1720455144.747 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-08T16:12:24.747Z,1720455144.747 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-08T16:12:26.763Z,1720455146.763 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161226.00,A,3648.17207,N,12147.28454,W,0.039,7.61,080724,,,A*7B 2024-07-08T16:12:26.765Z,1720455146.765 [NAL9602](INFO): GPS fix at 20240708T161226: (36.802868, -121.788076) 2024-07-08T16:12:26.775Z,1720455146.775 [Default:CheckIn:Read_GPS] Stopped 2024-07-08T16:12:26.775Z,1720455146.775 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-08T16:12:35.997Z,1720455155.997 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240708T153257/Courier0022.lzma 2024-07-08T16:12:36.999Z,1720455156.999 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Courier0022.lzma.bak 2024-07-08T16:12:36.000Z,1720455157.000 [DataOverHttps](INFO): SBD MOMSN=21340605 2024-07-08T16:12:57.115Z,1720455177.115 [DataOverHttps](INFO): Sending 867 bytes from file Logs/20240708T153257/Express0023.lzma 2024-07-08T16:12:58.115Z,1720455178.115 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Express0023.lzma.bak 2024-07-08T16:12:58.116Z,1720455178.116 [DataOverHttps](INFO): SBD MOMSN=21340608 2024-07-08T16:12:59.079Z,1720455179.079 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-08T16:13:03.959Z,1720455183.959 [Default:CheckIn:Read_Iridium] Stopped 2024-07-08T16:13:03.959Z,1720455183.959 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-08T16:13:03.959Z,1720455183.959 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-08T16:13:31.000Z,1720455211.000 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:13:31.000Z,1720455211.000 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T16:13:31.000Z,1720455211.000 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:13:31.012Z,1720455211.012 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:13:31.415Z,1720455211.415 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:13:31.415Z,1720455211.415 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T16:13:57.955Z,1720455237.955 [DataOverHttps](IMPORTANT): SBD MTMSN=20240708T161357 2024-07-08T16:14:05.090Z,1720455245.090 [DataOverHttps](INFO): Received command: strobe on 2024-07-08T16:14:05.159Z,1720455245.159 [CommandExec](IMPORTANT): got command strobe on 2024-07-08T16:14:05.159Z,1720455245.159 [CommandExec](IMPORTANT): Activating strobe 2024-07-08T16:15:16.507Z,1720455316.507 [DataOverHttps](IMPORTANT): SBD MTMSN=20240708T161515 2024-07-08T16:15:23.801Z,1720455323.801 [DataOverHttps](INFO): Received command: ibit 2024-07-08T16:15:23.830Z,1720455323.830 [CommandExec](IMPORTANT): got command ibit 2024-07-08T16:15:23.918Z,1720455323.918 [IBIT](IMPORTANT): Beginning Initiated BIT 2024-07-08T16:15:23.919Z,1720455323.919 [IBIT](IMPORTANT): Beginning control surface checks. 2024-07-08T16:15:23.922Z,1720455323.922 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-08T16:15:25.520Z,1720455325.520 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161524.00,A,3648.17115,N,12147.28303,W,0.000,7.61,080724,,,A*71 2024-07-08T16:15:25.522Z,1720455325.522 [NAL9602](INFO): GPS fix at 20240708T161524: (36.802853, -121.788050) 2024-07-08T16:15:26.812Z,1720455326.812 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2024-07-08T16:15:31.982Z,1720455331.982 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:15:31.982Z,1720455331.982 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T16:15:31.982Z,1720455331.982 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:15:31.993Z,1720455331.993 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:15:32.403Z,1720455332.403 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:15:32.403Z,1720455332.403 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T16:15:34.846Z,1720455334.846 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006343 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): -0.004898 CHAN A3 (5V): -0.002786 CHAN B0 (3.3V): -0.001163 CHAN B1 (3.15aV): -0.001117 CHAN B2 (3.15bV): -0.000963 CHAN B3 (GND): -0.000194 OPEN: 0.003519 Full Scale: +/- 1 mA 2024-07-08T16:15:46.528Z,1720455346.528 [NAL9602](INFO): SBD MO Status=0, MOMSN=5061, MT Status=0, MTMSN=0 2024-07-08T16:15:46.528Z,1720455346.528 [NAL9602](INFO): No messages in MT queue 2024-07-08T16:15:47.740Z,1720455347.740 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161547.00,A,3648.17114,N,12147.28323,W,0.019,7.61,080724,,,A*7F 2024-07-08T16:15:47.742Z,1720455347.742 [NAL9602](INFO): GPS fix at 20240708T161547: (36.802852, -121.788054) 2024-07-08T16:15:50.972Z,1720455350.972 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161550.00,A,3648.17120,N,12147.28327,W,0.000,7.61,080724,,,A*72 2024-07-08T16:15:50.974Z,1720455350.974 [NAL9602](INFO): GPS fix at 20240708T161550: (36.802853, -121.788055) 2024-07-08T16:15:53.800Z,1720455353.800 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161553.00,A,3648.17126,N,12147.28331,W,0.019,7.61,080724,,,A*78 2024-07-08T16:15:53.802Z,1720455353.802 [NAL9602](INFO): GPS fix at 20240708T161553: (36.802854, -121.788055) 2024-07-08T16:15:57.028Z,1720455357.028 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161556.00,A,3648.17133,N,12147.28338,W,0.039,7.61,080724,,,A*72 2024-07-08T16:15:57.030Z,1720455357.030 [NAL9602](INFO): GPS fix at 20240708T161556: (36.802855, -121.788056) 2024-07-08T16:15:59.860Z,1720455359.860 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161559.00,A,3648.17144,N,12147.28356,W,0.000,7.61,080724,,,A*7F 2024-07-08T16:15:59.862Z,1720455359.862 [NAL9602](INFO): GPS fix at 20240708T161559: (36.802857, -121.788059) 2024-07-08T16:16:00.174Z,1720455360.174 [DataOverHttps](IMPORTANT): SBD MTMSN=20240708T161559 2024-07-08T16:16:02.713Z,1720455362.713 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161602.00,A,3648.17152,N,12147.28373,W,0.019,7.61,080724,,,A*7A 2024-07-08T16:16:02.718Z,1720455362.718 [NAL9602](INFO): GPS fix at 20240708T161602: (36.802859, -121.788062) 2024-07-08T16:16:05.916Z,1720455365.916 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161605.00,A,3648.17168,N,12147.28391,W,0.019,7.61,080724,,,A*78 2024-07-08T16:16:05.919Z,1720455365.919 [NAL9602](INFO): GPS fix at 20240708T161605: (36.802861, -121.788065) 2024-07-08T16:16:07.293Z,1720455367.293 [DataOverHttps](INFO): Received command: configSet list 2024-07-08T16:16:07.365Z,1720455367.365 [CommandExec](IMPORTANT): got command configSet list 2024-07-08T16:16:07.366Z,1720455367.366 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-07-08T16:16:07.367Z,1720455367.367 [CommandExec](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2024-07-08T16:16:07.367Z,1720455367.367 [CommandExec](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count; 2024-07-08T16:16:07.368Z,1720455367.368 [CommandExec](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-07-08T16:16:08.749Z,1720455368.749 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161608.00,A,3648.17184,N,12147.28406,W,0.000,7.61,080724,,,A*76 2024-07-08T16:16:08.752Z,1720455368.752 [NAL9602](INFO): GPS fix at 20240708T161608: (36.802864, -121.788068) 2024-07-08T16:16:10.378Z,1720455370.378 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 5 Latitude: 36.802864 Longitude: -121.788071 2024-07-08T16:16:10.796Z,1720455370.796 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 15.580000 2024-07-08T16:16:10.796Z,1720455370.796 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2024-07-08T16:16:10.797Z,1720455370.797 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2024-07-08T16:16:11.185Z,1720455371.185 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2024-07-08T16:16:11.185Z,1720455371.185 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2024-07-08T16:16:11.186Z,1720455371.186 [IBIT](IMPORTANT): Pressure:10.110514 PSI 2024-07-08T16:16:11.186Z,1720455371.186 [IBIT](IMPORTANT): Humidity:10.780125 % 2024-07-08T16:16:11.587Z,1720455371.587 [IBIT](FAULT): Unable to read vehicle orientation values from AHRS 2024-07-08T16:16:11.992Z,1720455371.992 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2024-07-08T16:16:11.993Z,1720455371.993 [IBIT](IMPORTANT): buoyancyNeutral: 200.000000 cc 2024-07-08T16:16:11.993Z,1720455371.993 [IBIT](IMPORTANT): massDefault: 0.000000 cm 2024-07-08T16:16:11.993Z,1720455371.993 [IBIT](IMPORTANT): stopDepth: 275.000000 m 2024-07-08T16:16:11.994Z,1720455371.994 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2024-07-08T16:16:11.994Z,1720455371.994 [IBIT](IMPORTANT): IBIT FAILED 2024-07-08T16:16:41.466Z,1720455401.466 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-08T16:17:33.192Z,1720455453.192 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:17:33.192Z,1720455453.192 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T16:17:33.192Z,1720455453.192 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:17:33.203Z,1720455453.203 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:17:33.614Z,1720455453.614 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:17:33.614Z,1720455453.614 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T16:18:04.728Z,1720455484.728 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-08T16:18:04.728Z,1720455484.728 [Default:CheckIn:C.Wait] Stopped 2024-07-08T16:18:04.728Z,1720455484.728 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-08T16:18:04.729Z,1720455484.729 [Default:CheckIn:D] Running Loop=1 2024-07-08T16:18:05.138Z,1720455485.138 [Default:CheckIn:D] Stopped 2024-07-08T16:18:05.138Z,1720455485.138 [Default:CheckIn:E] Running Loop=1 2024-07-08T16:18:05.544Z,1720455485.544 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.671558 min 2024-07-08T16:18:05.544Z,1720455485.544 [Default:CheckIn:E] Stopped 2024-07-08T16:18:05.544Z,1720455485.544 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-08T16:18:05.544Z,1720455485.544 [Default:CheckIn] Stopped 2024-07-08T16:18:05.544Z,1720455485.544 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-08T16:18:05.544Z,1720455485.544 [Default:CheckIn](INFO): Running loop #6 2024-07-08T16:18:05.544Z,1720455485.544 [Default:CheckIn] Running Loop=6 2024-07-08T16:18:05.544Z,1720455485.544 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-08T16:18:05.545Z,1720455485.545 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-08T16:18:07.556Z,1720455487.556 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161807.00,A,3648.17267,N,12147.28451,W,0.019,7.61,080724,,,A*73 2024-07-08T16:18:07.563Z,1720455487.563 [NAL9602](INFO): GPS fix at 20240708T161807: (36.802878, -121.788075) 2024-07-08T16:18:07.573Z,1720455487.573 [Default:CheckIn:Read_GPS] Stopped 2024-07-08T16:18:07.573Z,1720455487.573 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-08T16:18:16.917Z,1720455496.917 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240708T153257/Courier0025.lzma 2024-07-08T16:18:17.919Z,1720455497.919 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Courier0025.lzma.bak 2024-07-08T16:18:17.920Z,1720455497.920 [DataOverHttps](INFO): SBD MOMSN=21340650 2024-07-08T16:18:21.692Z,1720455501.692 [NAL9602](INFO): SBD MO Status=0, MOMSN=5062, MT Status=0, MTMSN=0 2024-07-08T16:18:21.692Z,1720455501.692 [NAL9602](INFO): No messages in MT queue 2024-07-08T16:18:38.254Z,1720455518.254 [DataOverHttps](INFO): Sending 993 bytes from file Logs/20240708T153257/Express0027.lzma 2024-07-08T16:18:39.255Z,1720455519.255 [DataOverHttps](INFO): Moved sent file to Logs/20240708T153257/Express0027.lzma.bak 2024-07-08T16:18:39.255Z,1720455519.255 [DataOverHttps](INFO): SBD MOMSN=21340657 2024-07-08T16:18:45.138Z,1720455525.138 [Default:CheckIn:Read_Iridium] Stopped 2024-07-08T16:18:45.139Z,1720455525.139 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-08T16:18:45.139Z,1720455525.139 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-08T16:18:52.394Z,1720455532.394 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-08T16:19:34.020Z,1720455574.020 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:19:34.020Z,1720455574.020 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-08T16:19:34.020Z,1720455574.020 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:19:34.032Z,1720455574.032 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:19:34.470Z,1720455574.470 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:19:34.470Z,1720455574.470 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-08T16:21:35.223Z,1720455695.223 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-07-08T16:21:35.224Z,1720455695.224 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-07-08T16:21:35.224Z,1720455695.224 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-08T16:21:35.235Z,1720455695.235 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-08T16:21:35.638Z,1720455695.638 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-08T16:21:35.638Z,1720455695.638 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-07-08T16:22:00.739Z,1720455720.739 [DataOverHttps](IMPORTANT): SBD MTMSN=20240708T162200 2024-07-08T16:22:07.805Z,1720455727.805 [DataOverHttps](INFO): Received command: configSet AHRS_M2.loadAtStartup 1 bool persist;restart app 2024-07-08T16:22:08.179Z,1720455728.179 [CommandExec](IMPORTANT): got command configSet AHRS_M2.loadAtStartup 1 bool persist 2024-07-08T16:22:08.180Z,1720455728.180 [CommandExec](IMPORTANT): configSet AHRS_M2.loadAtStartup requires a restart to take effect. 2024-07-08T16:22:08.187Z,1720455728.187 [CommandExec](IMPORTANT): got command restart application 2024-07-08T16:22:09.189Z,1720455729.189 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-07-08T16:22:09.190Z,1720455729.190 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:09.190Z,1720455729.190 [CommandExec](INFO): Uninitializing the command executive. 2024-07-08T16:22:09.190Z,1720455729.190 [CommandExec](INFO): Uninitializing the command scheduler. 2024-07-08T16:22:09.190Z,1720455729.190 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.221Z,1720455729.221 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-07-08T16:22:09.221Z,1720455729.221 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-07-08T16:22:09.222Z,1720455729.222 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.222Z,1720455729.222 [NavChartDb](INFO): Join timeout helper Thread ID is 8715 2024-07-08T16:22:09.245Z,1720455729.245 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:09.246Z,1720455729.246 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.261Z,1720455729.261 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-07-08T16:22:09.261Z,1720455729.261 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.262Z,1720455729.262 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8716 2024-07-08T16:22:09.521Z,1720455729.521 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:09.522Z,1720455729.522 [WetLabsBB2FL](INFO): Powering down 2024-07-08T16:22:09.522Z,1720455729.522 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.541Z,1720455729.541 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-07-08T16:22:09.541Z,1720455729.541 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.542Z,1720455729.542 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8717 2024-07-08T16:22:09.702Z,1720455729.702 [CTD_Seabird](INFO): Powering down 2024-07-08T16:22:09.713Z,1720455729.713 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:09.713Z,1720455729.713 [CTD_Seabird](INFO): Powering down 2024-07-08T16:22:09.725Z,1720455729.725 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.741Z,1720455729.741 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-07-08T16:22:09.741Z,1720455729.741 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.742Z,1720455729.742 [Radio_Surface](INFO): Join timeout helper Thread ID is 8718 2024-07-08T16:22:09.849Z,1720455729.849 [Radio_Surface](INFO): Powering down 2024-07-08T16:22:09.850Z,1720455729.850 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:09.850Z,1720455729.850 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.866Z,1720455729.866 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-07-08T16:22:09.866Z,1720455729.866 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:09.866Z,1720455729.866 [Onboard](INFO): Join timeout helper Thread ID is 8719 2024-07-08T16:22:10.813Z,1720455730.813 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-07-08T16:22:12.985Z,1720455732.985 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:12.986Z,1720455732.986 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:12.990Z,1720455732.990 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-07-08T16:22:12.990Z,1720455732.990 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:12.991Z,1720455732.991 [DataOverHttps](INFO): Join timeout helper Thread ID is 8720 2024-07-08T16:22:13.837Z,1720455733.837 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:13.838Z,1720455733.838 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.850Z,1720455733.850 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-07-08T16:22:13.850Z,1720455733.850 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.850Z,1720455733.850 [BackseatComponent](INFO): Join timeout helper Thread ID is 8721 2024-07-08T16:22:13.893Z,1720455733.893 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:13.894Z,1720455733.894 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.914Z,1720455733.914 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-07-08T16:22:13.914Z,1720455733.914 [logger ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.914Z,1720455733.914 [logger](INFO): Join timeout helper Thread ID is 8722 2024-07-08T16:22:13.915Z,1720455733.915 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:13.915Z,1720455733.915 [logger ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.916Z,1720455733.916 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-07-08T16:22:13.916Z,1720455733.916 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.917Z,1720455733.917 [CommandLine](INFO): Join timeout helper Thread ID is 8723 2024-07-08T16:22:13.985Z,1720455733.985 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:13.986Z,1720455733.986 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.994Z,1720455733.994 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-07-08T16:22:13.994Z,1720455733.994 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.994Z,1720455733.994 [CommandExec](INFO): Join timeout helper Thread ID is 8724 2024-07-08T16:22:13.995Z,1720455733.995 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-07-08T16:22:13.996Z,1720455733.996 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:13.996Z,1720455733.996 [controlThread](INFO): Join timeout helper Thread ID is 8725 2024-07-08T16:22:13.997Z,1720455733.997 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-08T16:22:13.998Z,1720455733.998 [controlThread](DEBUG): Uninitializing ControlThread 2024-07-08T16:22:13.999Z,1720455733.999 [NAL9602](INFO): Powering down 2024-07-08T16:22:14.000Z,1720455734.000 [Sonardyne_Nano](INFO): Powering down 2024-07-08T16:22:14.118Z,1720455734.118 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-07-08T16:22:14.119Z,1720455734.119 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-07-08T16:22:14.119Z,1720455734.119 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-07-08T16:22:14.120Z,1720455734.120 [MissionManager](INFO): Uninitializing Mission Default 2024-07-08T16:22:14.120Z,1720455734.120 [Default] Stopped 2024-07-08T16:22:14.120Z,1720455734.120 [Default](DEBUG): Aggregate::uninitialize Default 2024-07-08T16:22:14.120Z,1720455734.120 [Default:B.GoToSurface] Stopped 2024-07-08T16:22:14.120Z,1720455734.120 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-07-08T16:22:14.120Z,1720455734.120 [Default:CheckIn] Stopped 2024-07-08T16:22:14.120Z,1720455734.120 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-08T16:22:14.120Z,1720455734.120 [Default:CheckIn:C.Wait] Stopped 2024-07-08T16:22:14.120Z,1720455734.120 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-08T16:22:14.123Z,1720455734.123 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-07-08T16:22:14.123Z,1720455734.123 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-07-08T16:22:14.124Z,1720455734.124 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-07-08T16:22:14.124Z,1720455734.124 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-07-08T16:22:14.124Z,1720455734.124 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-07-08T16:22:14.124Z,1720455734.124 [BuoyancyServo](INFO): Powering down 2024-07-08T16:22:14.137Z,1720455734.137 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-07-08T16:22:14.137Z,1720455734.137 [ElevatorServo](INFO): Powering down 2024-07-08T16:22:14.138Z,1720455734.138 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-07-08T16:22:14.138Z,1720455734.138 [MassServo](INFO): Powering down 2024-07-08T16:22:14.139Z,1720455734.139 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-07-08T16:22:14.139Z,1720455734.139 [RudderServo](INFO): Powering down 2024-07-08T16:22:14.140Z,1720455734.140 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-07-08T16:22:14.140Z,1720455734.140 [ThrusterHE](INFO): Powering down 2024-07-08T16:22:14.141Z,1720455734.141 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-07-08T16:22:14.141Z,1720455734.141 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-07-08T16:22:14.142Z,1720455734.142 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-07-08T16:22:14.142Z,1720455734.142 [CBIT](DEBUG): Powering off loads. 2024-07-08T16:22:14.153Z,1720455734.153 [CBIT](DEBUG): Disabling WDT. 2024-07-08T16:22:14.165Z,1720455734.165 [CBIT](DEBUG): Opening all GF detection circuits. 2024-07-08T16:22:14.166Z,1720455734.166 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:14.216Z,1720455734.216 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:14.219Z,1720455734.219 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:14.225Z,1720455734.225 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:14.268Z,1720455734.268 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:14.307Z,1720455734.307 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:14.312Z,1720455734.312 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:14.347Z,1720455734.347 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-08T16:22:14.419Z,1720455734.419 [logger ThreadHandler](INFO): Thread cancelled.