2024-10-17T19:57:39.941Z,1729195059.941 [Supervisor](DEBUG): Initializing supervisor.
2024-10-17T19:57:39.945Z,1729195059.945 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-10-17T19:57:39.946Z,1729195059.946 [SyncHandler](INFO): Protected caller Thread ID is 3734
2024-10-17T19:57:39.946Z,1729195059.946 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-10-17T19:57:39.947Z,1729195059.947 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-10-17T19:57:39.948Z,1729195059.948 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3735
2024-10-17T19:57:39.951Z,1729195059.951 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-10-17T19:57:39.969Z,1729195059.969 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-10-17T19:57:39.970Z,1729195059.970 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-10-17T19:57:39.970Z,1729195059.970 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3736
2024-10-17T19:57:39.974Z,1729195059.974 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-10-17T19:57:39.975Z,1729195059.975 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-10-17T19:57:39.975Z,1729195059.975 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3737
2024-10-17T19:57:39.978Z,1729195059.978 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-10-17T19:57:39.979Z,1729195059.979 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-10-17T19:57:39.979Z,1729195059.979 [logger ThreadHandler](INFO): Protected caller Thread ID is 3738
2024-10-17T19:57:39.994Z,1729195059.994 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-10-17T19:57:39.995Z,1729195059.995 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-10-17T19:57:40.063Z,1729195060.063 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-10-17T19:57:40.367Z,1729195060.367 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-10-17T19:57:40.367Z,1729195060.367 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-10-17T19:57:40.595Z,1729195060.595 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-10-17T19:57:40.597Z,1729195060.597 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-10-17T19:57:40.708Z,1729195060.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-10-17T19:57:40.709Z,1729195060.709 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-10-17T19:57:40.910Z,1729195060.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-10-17T19:57:40.912Z,1729195060.912 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-10-17T19:57:41.435Z,1729195061.435 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-10-17T19:57:41.437Z,1729195061.437 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-10-17T19:57:41.558Z,1729195061.558 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-10-17T19:57:41.559Z,1729195061.559 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-10-17T19:57:41.850Z,1729195061.850 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-10-17T19:57:41.851Z,1729195061.851 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-10-17T19:57:42.078Z,1729195062.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-10-17T19:57:42.078Z,1729195062.078 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-10-17T19:57:42.639Z,1729195062.639 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-10-17T19:57:42.640Z,1729195062.640 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-10-17T19:57:43.079Z,1729195063.079 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-10-17T19:57:43.080Z,1729195063.080 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-10-17T19:57:56.071Z,1729195076.071 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-10-17T19:57:59.296Z,1729195079.296 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-10-17T19:57:59.297Z,1729195079.297 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-10-17T19:58:01.887Z,1729195081.887 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-10-17T19:58:03.682Z,1729195083.682 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-10-17T19:58:06.710Z,1729195086.710 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-10-17T19:58:08.497Z,1729195088.497 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-10-17T19:58:08.878Z,1729195088.878 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-10-17T19:58:08.879Z,1729195088.879 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-10-17T19:58:10.498Z,1729195090.498 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/
2024-10-17T19:58:10.501Z,1729195090.501 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg
2024-10-17T19:58:10.598Z,1729195090.598 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg
2024-10-17T19:58:10.719Z,1729195090.719 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg
2024-10-17T19:58:10.839Z,1729195090.839 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg
2024-10-17T19:58:10.958Z,1729195090.958 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg
2024-10-17T19:58:11.061Z,1729195091.061 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg
2024-10-17T19:58:11.160Z,1729195091.160 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg
2024-10-17T19:58:11.277Z,1729195091.277 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg
2024-10-17T19:58:11.422Z,1729195091.422 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg
2024-10-17T19:58:11.598Z,1729195091.598 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg
2024-10-17T19:58:11.710Z,1729195091.710 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg
2024-10-17T19:58:11.989Z,1729195091.989 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-10-17T19:58:11.991Z,1729195091.991 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/
2024-10-17T19:58:11.991Z,1729195091.991 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-10-17T19:58:12.001Z,1729195092.001 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-10-17T19:58:12.394Z,1729195092.394 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-10-17T19:58:12.394Z,1729195092.394 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-10-17T19:58:12.999Z,1729195092.999 [AHRS_M2] Loaded
2024-10-17T19:58:12.999Z,1729195092.999 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-10-17T19:58:13.038Z,1729195093.038 [BackseatComponent] Loaded
2024-10-17T19:58:13.038Z,1729195093.038 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-10-17T19:58:13.039Z,1729195093.039 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408914E0
2024-10-17T19:58:13.040Z,1729195093.040 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3820
2024-10-17T19:58:13.043Z,1729195093.043 [LcmUniversalReporter] Loaded
2024-10-17T19:58:13.043Z,1729195093.043 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-10-17T19:58:13.848Z,1729195093.848 [BPC1] Loaded
2024-10-17T19:58:13.848Z,1729195093.848 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-10-17T19:58:13.923Z,1729195093.923 [DataOverHttps] Loaded
2024-10-17T19:58:13.923Z,1729195093.923 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-10-17T19:58:13.924Z,1729195093.924 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408C14E0
2024-10-17T19:58:13.924Z,1729195093.924 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3821
2024-10-17T19:58:13.947Z,1729195093.947 [Depth_Keller] Loaded
2024-10-17T19:58:13.947Z,1729195093.947 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-10-17T19:58:13.952Z,1729195093.952 [DropWeight] Loaded
2024-10-17T19:58:13.952Z,1729195093.952 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-10-17T19:58:14.016Z,1729195094.016 [NAL9602] Loaded
2024-10-17T19:58:14.017Z,1729195094.017 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-10-17T19:58:14.046Z,1729195094.046 [Onboard] Loaded
2024-10-17T19:58:14.046Z,1729195094.046 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-10-17T19:58:14.047Z,1729195094.047 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408F14E0
2024-10-17T19:58:14.048Z,1729195094.048 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3822
2024-10-17T19:58:14.062Z,1729195094.062 [Power24vConverter] Loaded
2024-10-17T19:58:14.062Z,1729195094.062 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-10-17T19:58:14.079Z,1729195094.079 [Radio_Surface] Loaded
2024-10-17T19:58:14.080Z,1729195094.080 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-10-17T19:58:14.081Z,1729195094.081 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409214E0
2024-10-17T19:58:14.081Z,1729195094.081 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3823
2024-10-17T19:58:14.096Z,1729195094.096 [Sonardyne_Nano] Loaded
2024-10-17T19:58:14.097Z,1729195094.097 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-10-17T19:58:14.097Z,1729195094.097 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-10-17T19:58:14.098Z,1729195094.098 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-10-17T19:58:15.988Z,1729195095.988 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-10-17T19:58:15.988Z,1729195095.988 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-10-17T19:58:16.053Z,1729195096.053 [VerticalControl](DEBUG): Construct VerticalControl.
2024-10-17T19:58:16.111Z,1729195096.111 [VerticalControl] Loaded
2024-10-17T19:58:16.111Z,1729195096.111 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-10-17T19:58:16.114Z,1729195096.114 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-10-17T19:58:16.161Z,1729195096.161 [HorizontalControl] Loaded
2024-10-17T19:58:16.161Z,1729195096.161 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-10-17T19:58:16.163Z,1729195096.163 [SpeedControl](DEBUG): Construct SpeedControl.
2024-10-17T19:58:16.167Z,1729195096.167 [SpeedControl] Loaded
2024-10-17T19:58:16.167Z,1729195096.167 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-10-17T19:58:16.170Z,1729195096.170 [LoopControl](DEBUG): Construct LoopControl.
2024-10-17T19:58:16.170Z,1729195096.170 [LoopControl] Loaded
2024-10-17T19:58:16.170Z,1729195096.170 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-10-17T19:58:16.171Z,1729195096.171 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-10-17T19:58:16.171Z,1729195096.171 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-10-17T19:58:16.185Z,1729195096.185 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-10-17T19:58:16.186Z,1729195096.186 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-10-17T19:58:16.223Z,1729195096.223 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-10-17T19:58:16.224Z,1729195096.224 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-10-17T19:58:16.356Z,1729195096.356 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-10-17T19:58:16.356Z,1729195096.356 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-10-17T19:58:16.398Z,1729195096.398 [DeadReckonUsingSpeedCalculator] Loaded
2024-10-17T19:58:16.398Z,1729195096.398 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2024-10-17T19:58:16.441Z,1729195096.441 [DeadReckonWithRespectToSeafloor] Loaded
2024-10-17T19:58:16.441Z,1729195096.441 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2024-10-17T19:58:16.454Z,1729195096.454 [NavChart] Loaded
2024-10-17T19:58:16.455Z,1729195096.455 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-10-17T19:58:16.460Z,1729195096.460 [UniversalFixResidualReporter] Loaded
2024-10-17T19:58:16.461Z,1729195096.461 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-10-17T19:58:16.461Z,1729195096.461 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-10-17T19:58:16.462Z,1729195096.462 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-10-17T19:58:16.631Z,1729195096.631 [SBIT](DEBUG): Construct Startup Built In Test.
2024-10-17T19:58:16.641Z,1729195096.641 [SBIT] Loaded
2024-10-17T19:58:16.641Z,1729195096.641 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-10-17T19:58:16.644Z,1729195096.644 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-10-17T19:58:16.656Z,1729195096.656 [IBIT] Loaded
2024-10-17T19:58:16.657Z,1729195096.657 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-10-17T19:58:16.663Z,1729195096.663 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-10-17T19:58:16.768Z,1729195096.768 [CBIT] Loaded
2024-10-17T19:58:16.768Z,1729195096.768 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-10-17T19:58:16.768Z,1729195096.768 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-10-17T19:58:16.769Z,1729195096.769 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-10-17T19:58:16.975Z,1729195096.975 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-10-17T19:58:16.975Z,1729195096.975 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-10-17T19:58:17.136Z,1729195097.136 [BuoyancyServo] Loaded
2024-10-17T19:58:17.136Z,1729195097.136 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-10-17T19:58:17.159Z,1729195097.159 [ElevatorServo] Loaded
2024-10-17T19:58:17.159Z,1729195097.159 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-10-17T19:58:17.181Z,1729195097.181 [MassServo] Loaded
2024-10-17T19:58:17.181Z,1729195097.181 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-10-17T19:58:17.202Z,1729195097.202 [RudderServo] Loaded
2024-10-17T19:58:17.202Z,1729195097.202 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-10-17T19:58:17.219Z,1729195097.219 [ThrusterHE] Loaded
2024-10-17T19:58:17.219Z,1729195097.219 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-10-17T19:58:17.219Z,1729195097.219 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-10-17T19:58:17.220Z,1729195097.220 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-10-17T19:58:17.440Z,1729195097.440 [CTD_Seabird] Loaded
2024-10-17T19:58:17.441Z,1729195097.441 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-10-17T19:58:17.445Z,1729195097.445 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B4B4E0
2024-10-17T19:58:17.445Z,1729195097.445 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3824
2024-10-17T19:58:17.481Z,1729195097.481 [ESPComponent] Loaded
2024-10-17T19:58:17.481Z,1729195097.481 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2024-10-17T19:58:17.503Z,1729195097.503 [PAR_Licor] Loaded
2024-10-17T19:58:17.504Z,1729195097.504 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-10-17T19:58:17.548Z,1729195097.548 [WetLabsBB2FL] Loaded
2024-10-17T19:58:17.548Z,1729195097.548 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-10-17T19:58:17.549Z,1729195097.549 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B7B4E0
2024-10-17T19:58:17.550Z,1729195097.550 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3825
2024-10-17T19:58:17.550Z,1729195097.550 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-10-17T19:58:17.551Z,1729195097.551 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-10-17T19:58:17.619Z,1729195097.619 [DepthRateCalculator] Loaded
2024-10-17T19:58:17.619Z,1729195097.619 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-10-17T19:58:17.624Z,1729195097.624 [PitchRateCalculator] Loaded
2024-10-17T19:58:17.624Z,1729195097.624 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-10-17T19:58:17.633Z,1729195097.633 [SpeedCalculator] Loaded
2024-10-17T19:58:17.634Z,1729195097.634 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-10-17T19:58:17.638Z,1729195097.638 [YawRateCalculator] Loaded
2024-10-17T19:58:17.638Z,1729195097.638 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-10-17T19:58:17.657Z,1729195097.657 [ElevatorOffsetCalculator] Loaded
2024-10-17T19:58:17.658Z,1729195097.658 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-10-17T19:58:17.658Z,1729195097.658 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-10-17T19:58:17.658Z,1729195097.658 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-10-17T19:58:17.738Z,1729195097.738 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-10-17T19:58:17.744Z,1729195097.744 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-10-17T19:58:17.747Z,1729195097.747 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-10-17T19:58:17.758Z,1729195097.758 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-10-17T19:58:17.761Z,1729195097.761 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-10-17T19:58:17.761Z,1729195097.761 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3826
2024-10-17T19:58:17.766Z,1729195097.766 [Supervisor](INFO): Main Thread ID is 6776
2024-10-17T19:58:17.766Z,1729195097.766 [Supervisor](DEBUG): Running supervisor.
2024-10-17T19:58:17.766Z,1729195097.766 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3827
2024-10-17T19:58:17.767Z,1729195097.767 [CommandExec](INFO): Initializing the command executive.
2024-10-17T19:58:17.768Z,1729195097.768 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3828
2024-10-17T19:58:17.771Z,1729195097.771 [controlThread ThreadHandler](INFO): Handler Thread ID is 3829
2024-10-17T19:58:17.772Z,1729195097.772 [controlThread](DEBUG): Initializing ControlThread
2024-10-17T19:58:17.778Z,1729195097.778 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-10-17T19:58:17.780Z,1729195097.780 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-10-17T19:58:17.781Z,1729195097.781 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-10-17T19:58:17.781Z,1729195097.781 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-10-17T19:58:17.782Z,1729195097.782 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-17T19:58:17.783Z,1729195097.783 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-10-17T19:58:17.784Z,1729195097.784 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-10-17T19:58:17.784Z,1729195097.784 [SBIT](INFO): Initialize SBIT Component.
2024-10-17T19:58:17.785Z,1729195097.785 [SBIT](IMPORTANT): git: 2024-09-16-2-g9a6e6361e
2024-10-17T19:58:17.785Z,1729195097.785 [SBIT](INFO): git hash: 9a6e6361ee0225b4338ccb03ae7adeebd6db69cf
2024-10-17T19:58:17.785Z,1729195097.785 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-10-17T19:58:17.786Z,1729195097.786 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-10-17T19:58:17.787Z,1729195097.787 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2024-10-17T19:58:17.788Z,1729195097.788 [IBIT](INFO): Initialize IBIT Component.
2024-10-17T19:58:17.789Z,1729195097.789 [CBIT](DEBUG): Initialize CBIT Component.
2024-10-17T19:58:17.790Z,1729195097.790 [logger ThreadHandler](INFO): Handler Thread ID is 3830
2024-10-17T19:58:17.800Z,1729195097.800 [CBIT](DEBUG): Initialized mux pins.
2024-10-17T19:58:17.800Z,1729195097.800 [CBIT](DEBUG): Initializing the watchdog timer.
2024-10-17T19:58:17.809Z,1729195097.809 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3831
2024-10-17T19:58:17.821Z,1729195097.821 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3832
2024-10-17T19:58:17.822Z,1729195097.822 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-10-17T19:58:17.824Z,1729195097.824 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-10-17T19:58:17.825Z,1729195097.825 [CBIT](DEBUG): Initializing heartbeat.
2024-10-17T19:58:17.841Z,1729195097.841 [Onboard ThreadHandler](INFO): Handler Thread ID is 3833
2024-10-17T19:58:17.858Z,1729195097.858 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3834
2024-10-17T19:58:17.881Z,1729195097.881 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3835
2024-10-17T19:58:17.881Z,1729195097.881 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-10-17T19:58:17.886Z,1729195097.886 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3837
2024-10-17T19:58:17.889Z,1729195097.889 [WetLabsBB2FL](INFO): Powering up
2024-10-17T19:58:17.890Z,1729195097.890 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3839
2024-10-17T19:58:17.896Z,1729195097.896 [CBIT](DEBUG): Deactivating GF circuits.
2024-10-17T19:58:17.896Z,1729195097.896 [CBIT](DEBUG): Deactivating emergency mode.
2024-10-17T19:58:17.898Z,1729195097.898 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
2024-10-17T19:58:17.898Z,1729195097.898 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000
2024-10-17T19:58:17.899Z,1729195097.899 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
2024-10-17T19:58:17.899Z,1729195097.899 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000
2024-10-17T19:58:17.899Z,1729195097.899 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2024-10-17T19:58:17.899Z,1729195097.899 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2024-10-17T19:58:17.899Z,1729195097.899 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2024-10-17T19:58:17.899Z,1729195097.899 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2024-10-17T19:58:17.899Z,1729195097.899 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
2024-10-17T19:58:17.900Z,1729195097.900 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000
2024-10-17T19:58:17.900Z,1729195097.900 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
2024-10-17T19:58:17.900Z,1729195097.900 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000
2024-10-17T19:58:17.936Z,1729195097.936 [CBIT](DEBUG): Backplane powered.
2024-10-17T19:58:17.941Z,1729195097.941 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-10-17T19:58:17.941Z,1729195097.941 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-10-17T19:58:17.941Z,1729195097.941 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-10-17T19:58:17.942Z,1729195097.942 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-10-17T19:58:17.942Z,1729195097.942 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-10-17T19:58:17.943Z,1729195097.943 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-10-17T19:58:17.944Z,1729195097.944 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-10-17T19:58:17.944Z,1729195097.944 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-10-17T19:58:17.950Z,1729195097.950 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-10-17T19:58:18.007Z,1729195098.007 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-10-17T19:58:18.012Z,1729195098.012 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-10-17T19:58:18.045Z,1729195098.045 [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-10-17T19:58:18.045Z,1729195098.045 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-10-17T19:58:18.046Z,1729195098.046 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-10-17T19:58:18.049Z,1729195098.049 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-10-17T19:58:18.250Z,1729195098.250 [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-10-17T19:58:18.264Z,1729195098.264 [Radio_Surface](INFO): Powering up
2024-10-17T19:58:18.273Z,1729195098.273 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-10-17T19:58:18.274Z,1729195098.274 [Default:A.Wait](DEBUG): Construct Wait.
2024-10-17T19:58:18.285Z,1729195098.285 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-10-17T19:58:18.297Z,1729195098.297 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-10-17T19:58:18.299Z,1729195098.299 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-10-17T19:58:18.311Z,1729195098.311 [Default:E.Execute](DEBUG): Construct Execute.
2024-10-17T19:58:18.314Z,1729195098.314 [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-10-17T19:58:18.329Z,1729195098.329 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-10-17T19:58:18.335Z,1729195098.335 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-10-17T19:58:18.388Z,1729195098.388 [Power24vConverter](INFO): Powering up.
2024-10-17T19:58:18.389Z,1729195098.389 [Sonardyne_Nano](INFO): Initializing.
2024-10-17T19:58:18.449Z,1729195098.449 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-10-17T19:58:18.457Z,1729195098.457 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-10-17T19:58:18.458Z,1729195098.458 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-10-17T19:58:18.465Z,1729195098.465 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-10-17T19:58:18.465Z,1729195098.465 [MassServo](DEBUG): Initializing EZServoServo.
2024-10-17T19:58:18.480Z,1729195098.480 [MassServo](DEBUG): Initializing MassServo.
2024-10-17T19:58:18.481Z,1729195098.481 [RudderServo](DEBUG): Initializing EZServoServo.
2024-10-17T19:58:18.488Z,1729195098.488 [RudderServo](DEBUG): Initializing RudderServo.
2024-10-17T19:58:18.489Z,1729195098.489 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-10-17T19:58:18.497Z,1729195098.497 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-10-17T19:58:19.996Z,1729195099.996 [WetLabsBB2FL](INFO): Powering down
2024-10-17T19:58:20.359Z,1729195100.359 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-10-17T19:58:21.645Z,1729195101.645 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409
2024-10-17T19:58:24.047Z,1729195104.047 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-10-17T19:58:38.557Z,1729195118.557 [SBIT](IMPORTANT): Beginning Startup BIT
2024-10-17T19:58:38.561Z,1729195118.561 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-17T19:58:44.202Z,1729195124.202 [NAL9602](INFO): Powering up NAL9602
2024-10-17T19:58:49.517Z,1729195129.517 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000689
CHAN A1 (24V): -0.000652
CHAN A2 (12V): 0.000446
CHAN A3 (5V): -0.001993
CHAN B0 (3.3V): -0.000899
CHAN B1 (3.15aV): -0.001306
CHAN B2 (3.15bV): -0.001514
CHAN B3 (GND): -0.001637
OPEN: 0.005256
Full Scale: +/- 1 mA
2024-10-17T19:58:55.161Z,1729195135.161 [NAL9602](INFO): NAL9602 initialized
2024-10-17T19:59:32.700Z,1729195172.700 [SBIT](IMPORTANT): SBIT PASSED
2024-10-17T19:59:32.700Z,1729195172.700 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-10-17T19:59:32.701Z,1729195172.701 [SBIT](IMPORTANT):
2024-10-17T19:59:32.701Z,1729195172.701 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool;
2024-10-17T19:59:32.701Z,1729195172.701 [SBIT](IMPORTANT): CBIT.gf24Offset=162 microampere;
2024-10-17T19:59:32.702Z,1729195172.702 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2024-10-17T19:59:32.702Z,1729195172.702 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool;
2024-10-17T19:59:32.702Z,1729195172.702 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool;
2024-10-17T19:59:32.702Z,1729195172.702 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=-0.1 meter;
2024-10-17T19:59:32.702Z,1729195172.702 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;
2024-10-17T19:59:32.702Z,1729195172.702 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute;
2024-10-17T19:59:32.702Z,1729195172.702 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;
2024-10-17T19:59:33.099Z,1729195173.099 [MissionManager](IMPORTANT): Started mission Startup
2024-10-17T19:59:33.100Z,1729195173.100 [Startup] Running Loop=1
2024-10-17T19:59:33.100Z,1729195173.100 [Startup](DEBUG): Aggregate::initialize Startup
2024-10-17T19:59:33.100Z,1729195173.100 [Startup:A.GoToSurface] Running Loop=1
2024-10-17T19:59:33.100Z,1729195173.100 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-10-17T19:59:33.101Z,1729195173.101 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-10-17T19:59:33.101Z,1729195173.101 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-10-17T19:59:33.102Z,1729195173.102 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-10-17T19:59:33.102Z,1729195173.102 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-10-17T19:59:33.102Z,1729195173.102 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-10-17T19:59:33.103Z,1729195173.103 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-10-17T19:59:33.104Z,1729195173.104 [Startup:StartupSatComms] Running Loop=1
2024-10-17T19:59:33.105Z,1729195173.105 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-10-17T19:59:33.105Z,1729195173.105 [Startup:StartupSatComms:A] Running Loop=1
2024-10-17T19:59:33.500Z,1729195173.500 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-10-17T20:00:29.550Z,1729195229.550 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004466
2024-10-17T20:00:33.304Z,1729195233.304 [Startup:StartupSatComms:A](INFO): Timed out from 2024-10-17T19:59:33.1Z
2024-10-17T20:00:33.304Z,1729195233.304 [Startup:StartupSatComms:A] Stopped
2024-10-17T20:00:33.304Z,1729195233.304 [Startup:StartupSatComms:B] Running Loop=1
2024-10-17T20:00:33.711Z,1729195233.711 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-10-17T20:00:40.696Z,1729195240.696 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20241016T231601/Courier0390.lzma
2024-10-17T20:00:41.699Z,1729195241.699 [DataOverHttps](INFO): Moved sent file to Logs/20241016T231601/Courier0390.lzma.bak
2024-10-17T20:00:41.699Z,1729195241.699 [DataOverHttps](INFO): SBD MOMSN=23313701
2024-10-17T20:00:57.320Z,1729195257.320 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20241017T195739/Courier0000.lzma
2024-10-17T20:00:58.322Z,1729195258.322 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0000.lzma.bak
2024-10-17T20:00:58.322Z,1729195258.322 [DataOverHttps](INFO): SBD MOMSN=23313703
2024-10-17T20:01:17.397Z,1729195277.397 [DataOverHttps](INFO): Sending 2007 bytes from file Logs/20241016T231601/Express0388.lzma
2024-10-17T20:01:18.139Z,1729195278.139 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-10-17T20:01:18.139Z,1729195278.139 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-10-17T20:01:18.141Z,1729195278.141 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2024-10-17T20:01:18.141Z,1729195278.141 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-10-17T20:01:18.143Z,1729195278.143 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:01:18.143Z,1729195278.143 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:01:18.153Z,1729195278.153 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-10-17T20:01:18.154Z,1729195278.154 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-10-17T20:01:18.154Z,1729195278.154 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:01:18.410Z,1729195278.410 [DataOverHttps](INFO): Moved sent file to Logs/20241016T231601/Express0388.lzma.bak
2024-10-17T20:01:18.411Z,1729195278.411 [DataOverHttps](INFO): SBD MOMSN=23313706
2024-10-17T20:01:18.553Z,1729195278.553 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-10-17T20:01:18.553Z,1729195278.553 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-10-17T20:01:18.553Z,1729195278.553 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-10-17T20:01:18.553Z,1729195278.553 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2024-10-17T20:01:18.554Z,1729195278.554 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:01:18.554Z,1729195278.554 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:01:18.955Z,1729195278.955 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-17T20:01:33.495Z,1729195293.495 [Startup:StartupSatComms:B](INFO): Timed out from 2024-10-17T20:00:33.3Z
2024-10-17T20:01:33.495Z,1729195293.495 [Startup:StartupSatComms:B] Stopped
2024-10-17T20:01:33.495Z,1729195293.495 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-10-17T20:01:33.495Z,1729195293.495 [Startup:StartupSatComms] Stopped
2024-10-17T20:01:33.495Z,1729195293.495 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-10-17T20:01:33.496Z,1729195293.496 [Startup](INFO): Completed Startup
2024-10-17T20:01:33.500Z,1729195293.500 [MissionManager](INFO): Startup is completed.
2024-10-17T20:01:33.500Z,1729195293.500 [MissionManager](INFO): Uninitializing Mission Startup
2024-10-17T20:01:33.501Z,1729195293.501 [Startup] Stopped
2024-10-17T20:01:33.501Z,1729195293.501 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-10-17T20:01:33.501Z,1729195293.501 [Startup:A.GoToSurface] Stopped
2024-10-17T20:01:33.501Z,1729195293.501 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-10-17T20:01:33.900Z,1729195293.900 [MissionManager](IMPORTANT): Started mission Default
2024-10-17T20:01:33.900Z,1729195293.900 [Default] Running Loop=1
2024-10-17T20:01:33.900Z,1729195293.900 [Default](DEBUG): Aggregate::initialize Default
2024-10-17T20:01:33.905Z,1729195293.905 [Default:B.GoToSurface] Running Loop=1
2024-10-17T20:01:33.905Z,1729195293.905 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-10-17T20:01:33.905Z,1729195293.905 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-10-17T20:01:33.905Z,1729195293.905 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-10-17T20:01:33.906Z,1729195293.906 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-10-17T20:01:33.906Z,1729195293.906 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-10-17T20:01:33.906Z,1729195293.906 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-10-17T20:01:33.906Z,1729195293.906 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-10-17T20:01:33.907Z,1729195293.907 [Default:A.Wait] Running Loop=1
2024-10-17T20:01:33.907Z,1729195293.907 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:01:36.628Z,1729195296.628 [DataOverHttps](INFO): Sending 99 bytes from file Logs/20241016T231601/Express0391.lzma
2024-10-17T20:01:37.631Z,1729195297.631 [DataOverHttps](INFO): Moved sent file to Logs/20241016T231601/Express0391.lzma.bak
2024-10-17T20:01:37.631Z,1729195297.631 [DataOverHttps](INFO): SBD MOMSN=23313858
2024-10-17T20:01:47.221Z,1729195307.221 [Default:A.Wait](INFO): Done Waiting.
2024-10-17T20:01:47.221Z,1729195307.221 [Default:A.Wait] Stopped
2024-10-17T20:01:47.221Z,1729195307.221 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:01:47.648Z,1729195307.648 [Default:CheckIn] Running Loop=1
2024-10-17T20:01:47.648Z,1729195307.648 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:01:47.649Z,1729195307.649 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:01:48.071Z,1729195308.071 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-10-17T20:03:58.110Z,1729195438.110 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T20:04:19.129Z,1729195459.129 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-10-17T20:04:19.129Z,1729195459.129 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-10-17T20:04:19.131Z,1729195459.131 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2024-10-17T20:04:19.131Z,1729195459.131 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-10-17T20:04:19.132Z,1729195459.132 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T20:04:19.132Z,1729195459.132 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:04:19.179Z,1729195459.179 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-10-17T20:04:19.180Z,1729195459.180 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-10-17T20:04:19.180Z,1729195459.180 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:04:19.601Z,1729195459.601 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-10-17T20:04:19.601Z,1729195459.601 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-10-17T20:04:19.602Z,1729195459.602 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-10-17T20:04:19.602Z,1729195459.602 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2024-10-17T20:04:19.602Z,1729195459.602 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:04:19.602Z,1729195459.602 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T20:04:19.942Z,1729195459.942 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-17T20:05:43.201Z,1729195543.201 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-10-17T20:05:45.973Z,1729195545.973 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-17T20:05:50.017Z,1729195550.017 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2024-10-17T20:05:50.017Z,1729195550.017 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2024-10-17T20:05:50.021Z,1729195550.021 [BPC1](INFO): Received data from all battery sticks.
2024-10-17T20:06:47.799Z,1729195607.799 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-17T20:01:47.6Z
2024-10-17T20:06:47.799Z,1729195607.799 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:06:47.799Z,1729195607.799 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:06:48.200Z,1729195608.200 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-10-17T20:06:49.150Z,1729195609.150 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20241017T195739/Courier0004.lzma
2024-10-17T20:06:50.278Z,1729195610.278 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0004.lzma.bak
2024-10-17T20:06:50.278Z,1729195610.278 [DataOverHttps](INFO): SBD MOMSN=23313861
2024-10-17T20:07:07.125Z,1729195627.125 [DataOverHttps](INFO): Sending 830 bytes from file Logs/20241017T195739/Express0001.lzma
2024-10-17T20:07:08.132Z,1729195628.132 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0001.lzma.bak
2024-10-17T20:07:08.133Z,1729195628.133 [DataOverHttps](INFO): SBD MOMSN=23313863
2024-10-17T20:07:20.189Z,1729195640.189 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-10-17T20:07:20.189Z,1729195640.189 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-10-17T20:07:20.191Z,1729195640.191 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2024-10-17T20:07:20.191Z,1729195640.191 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-10-17T20:07:20.192Z,1729195640.192 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2024-10-17T20:07:20.192Z,1729195640.192 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:07:20.226Z,1729195640.226 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-10-17T20:07:20.227Z,1729195640.227 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-10-17T20:07:20.227Z,1729195640.227 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:07:20.582Z,1729195640.582 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-10-17T20:07:20.582Z,1729195640.582 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-10-17T20:07:20.583Z,1729195640.583 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-10-17T20:07:20.583Z,1729195640.583 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2024-10-17T20:07:20.583Z,1729195640.583 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:07:20.583Z,1729195640.583 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2024-10-17T20:07:20.989Z,1729195640.989 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-17T20:07:33.271Z,1729195653.271 [DataOverHttps](INFO): Sending 196 bytes from file Logs/20241017T195739/Express0005.lzma
2024-10-17T20:07:34.278Z,1729195654.278 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0005.lzma.bak
2024-10-17T20:07:34.278Z,1729195654.278 [DataOverHttps](INFO): SBD MOMSN=23313886
2024-10-17T20:07:36.746Z,1729195656.746 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:07:36.746Z,1729195656.746 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:07:36.747Z,1729195656.747 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:08:19.565Z,1729195699.565 [Power24vConverter](INFO): Powering down.
2024-10-17T20:08:49.851Z,1729195729.851 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200840.00,A,3648.19106,N,12147.28951,W,0.194,16.44,171024,,,A*48
2024-10-17T20:08:49.855Z,1729195729.855 [NAL9602](INFO): GPS fix at 20241017T200840: (36.803184, -121.788158)
2024-10-17T20:09:22.174Z,1729195762.174 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T20:10:21.186Z,1729195821.186 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:10:21.186Z,1729195821.186 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:10:21.209Z,1729195821.209 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:10:21.617Z,1729195821.617 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:10:21.617Z,1729195821.617 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:12:37.312Z,1729195957.312 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:12:37.313Z,1729195957.313 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:12:37.313Z,1729195957.313 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:12:37.313Z,1729195957.313 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:12:37.722Z,1729195957.722 [Default:CheckIn:D] Stopped
2024-10-17T20:12:37.722Z,1729195957.722 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.063695 min
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn:E] Stopped
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn] Stopped
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn](INFO): Running loop #2
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn] Running Loop=2
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:12:38.132Z,1729195958.132 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:12:40.130Z,1729195960.130 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201233.00,A,3648.16520,N,12147.28081,W,0.389,173.15,171024,,,D*71
2024-10-17T20:12:40.132Z,1729195960.132 [NAL9602](INFO): GPS fix at 20241017T201233: (36.802753, -121.788014)
2024-10-17T20:12:40.146Z,1729195960.146 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:12:40.146Z,1729195960.146 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:12:47.872Z,1729195967.872 [DataOverHttps](INFO): Sending 225 bytes from file Logs/20241017T195739/Courier0007.lzma
2024-10-17T20:12:49.748Z,1729195969.748 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0007.lzma.bak
2024-10-17T20:12:49.748Z,1729195969.748 [DataOverHttps](INFO): SBD MOMSN=23313896
2024-10-17T20:13:05.932Z,1729195985.932 [DataOverHttps](INFO): Sending 304 bytes from file Logs/20241017T195739/Express0008.lzma
2024-10-17T20:13:06.934Z,1729195986.934 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0008.lzma.bak
2024-10-17T20:13:06.934Z,1729195986.934 [DataOverHttps](INFO): SBD MOMSN=23313899
2024-10-17T20:13:09.663Z,1729195989.663 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:13:09.663Z,1729195989.663 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:13:09.663Z,1729195989.663 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:13:10.834Z,1729195990.834 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T20:13:10.912Z,1729195990.912 [NAL9602](ERROR): received:
+CSQ:0
OK
2024-10-17T20:13:22.178Z,1729196002.178 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:13:22.178Z,1729196002.178 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:13:22.202Z,1729196002.202 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:13:22.607Z,1729196002.607 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:13:22.607Z,1729196002.607 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:16:23.201Z,1729196183.201 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T20:16:23.201Z,1729196183.201 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:16:23.224Z,1729196183.224 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:16:23.615Z,1729196183.615 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:16:23.615Z,1729196183.615 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T20:17:41.916Z,1729196261.916 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T20:18:10.230Z,1729196290.230 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:18:10.230Z,1729196290.230 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:18:10.230Z,1729196290.230 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:18:10.230Z,1729196290.230 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:18:10.613Z,1729196290.613 [Default:CheckIn:D] Stopped
2024-10-17T20:18:10.613Z,1729196290.613 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:18:11.018Z,1729196291.018 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.611892 min
2024-10-17T20:18:11.018Z,1729196291.018 [Default:CheckIn:E] Stopped
2024-10-17T20:18:11.019Z,1729196291.019 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:18:11.019Z,1729196291.019 [Default:CheckIn] Stopped
2024-10-17T20:18:11.019Z,1729196291.019 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:18:11.019Z,1729196291.019 [Default:CheckIn](INFO): Running loop #3
2024-10-17T20:18:11.019Z,1729196291.019 [Default:CheckIn] Running Loop=3
2024-10-17T20:18:11.019Z,1729196291.019 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:18:11.019Z,1729196291.019 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:18:13.031Z,1729196293.031 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201806.00,A,3648.16515,N,12147.28623,W,0.253,128.63,171024,,,D*7C
2024-10-17T20:18:13.033Z,1729196293.033 [NAL9602](INFO): GPS fix at 20241017T201806: (36.802752, -121.788104)
2024-10-17T20:18:13.076Z,1729196293.076 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:18:13.076Z,1729196293.076 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:18:20.260Z,1729196300.260 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241017T195739/Courier0010.lzma
2024-10-17T20:18:20.894Z,1729196300.894 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0010.lzma.bak
2024-10-17T20:18:20.895Z,1729196300.895 [DataOverHttps](INFO): SBD MOMSN=23313902
2024-10-17T20:18:38.044Z,1729196318.044 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20241017T195739/Express0011.lzma
2024-10-17T20:18:39.046Z,1729196319.046 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0011.lzma.bak
2024-10-17T20:18:39.046Z,1729196319.046 [DataOverHttps](INFO): SBD MOMSN=23313905
2024-10-17T20:18:45.350Z,1729196325.350 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T20:18:55.875Z,1729196335.875 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:18:55.875Z,1729196335.875 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:18:55.875Z,1729196335.875 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:19:24.140Z,1729196364.140 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:19:24.140Z,1729196364.140 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:19:24.150Z,1729196364.150 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:19:24.551Z,1729196364.551 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:19:24.551Z,1729196364.551 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:20:44.713Z,1729196444.713 [CommandExec](IMPORTANT): got command strobe off
2024-10-17T20:20:44.714Z,1729196444.714 [CommandExec](IMPORTANT): Deactivating strobe
2024-10-17T20:22:25.128Z,1729196545.128 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T20:22:25.128Z,1729196545.128 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:22:25.143Z,1729196545.143 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:22:25.551Z,1729196545.551 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:22:25.551Z,1729196545.551 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T20:23:56.433Z,1729196636.433 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:23:56.433Z,1729196636.433 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:23:56.434Z,1729196636.434 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:23:56.434Z,1729196636.434 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:23:56.855Z,1729196636.855 [Default:CheckIn:D] Stopped
2024-10-17T20:23:56.855Z,1729196636.855 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:23:57.250Z,1729196637.250 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.382593 min
2024-10-17T20:23:57.250Z,1729196637.250 [Default:CheckIn:E] Stopped
2024-10-17T20:23:57.250Z,1729196637.250 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:23:57.250Z,1729196637.250 [Default:CheckIn] Stopped
2024-10-17T20:23:57.250Z,1729196637.250 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:23:57.251Z,1729196637.251 [Default:CheckIn](INFO): Running loop #4
2024-10-17T20:23:57.251Z,1729196637.251 [Default:CheckIn] Running Loop=4
2024-10-17T20:23:57.251Z,1729196637.251 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:23:57.251Z,1729196637.251 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:23:59.251Z,1729196639.251 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202352.00,A,3648.16480,N,12147.27707,W,1.069,123.57,171024,,,D*76
2024-10-17T20:23:59.253Z,1729196639.253 [NAL9602](INFO): GPS fix at 20241017T202352: (36.802747, -121.787951)
2024-10-17T20:23:59.270Z,1729196639.270 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:23:59.270Z,1729196639.270 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:24:06.952Z,1729196646.952 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241017T195739/Courier0013.lzma
2024-10-17T20:24:07.954Z,1729196647.954 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0013.lzma.bak
2024-10-17T20:24:07.954Z,1729196647.954 [DataOverHttps](INFO): SBD MOMSN=23313922
2024-10-17T20:24:25.277Z,1729196665.277 [DataOverHttps](INFO): Sending 217 bytes from file Logs/20241017T195739/Express0014.lzma
2024-10-17T20:24:26.278Z,1729196666.278 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0014.lzma.bak
2024-10-17T20:24:26.279Z,1729196666.279 [DataOverHttps](INFO): SBD MOMSN=23313925
2024-10-17T20:24:29.580Z,1729196669.580 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:24:29.580Z,1729196669.580 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:24:29.580Z,1729196669.580 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:24:29.957Z,1729196669.957 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T20:24:30.036Z,1729196670.036 [NAL9602](ERROR): received:
+CSQ:0
OK
2024-10-17T20:25:22.135Z,1729196722.135 [NAL9602](INFO): SBD MO Status=2, MOMSN=9901, MT Status=2, MTMSN=0
2024-10-17T20:25:22.135Z,1729196722.135 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-10-17T20:25:26.181Z,1729196726.181 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:25:26.181Z,1729196726.181 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:25:26.192Z,1729196726.192 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:25:26.611Z,1729196726.611 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:25:26.611Z,1729196726.611 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:28:27.228Z,1729196907.228 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T20:28:27.228Z,1729196907.228 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:28:27.239Z,1729196907.239 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:28:27.641Z,1729196907.641 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:28:27.641Z,1729196907.641 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T20:29:01.153Z,1729196941.153 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T20:29:30.261Z,1729196970.261 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:29:30.261Z,1729196970.261 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:29:30.261Z,1729196970.261 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:29:30.261Z,1729196970.261 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:29:30.668Z,1729196970.668 [Default:CheckIn:D] Stopped
2024-10-17T20:29:30.668Z,1729196970.668 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.946143 min
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn:E] Stopped
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn] Stopped
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn](INFO): Running loop #5
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn] Running Loop=5
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:29:31.066Z,1729196971.066 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:29:33.070Z,1729196973.070 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202926.00,A,3648.14500,N,12147.26655,W,0.486,10.05,171024,,,D*41
2024-10-17T20:29:33.073Z,1729196973.073 [NAL9602](INFO): GPS fix at 20241017T202926: (36.802417, -121.787776)
2024-10-17T20:29:33.107Z,1729196973.107 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:29:33.107Z,1729196973.107 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:29:41.812Z,1729196981.812 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241017T195739/Courier0016.lzma
2024-10-17T20:29:42.814Z,1729196982.814 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0016.lzma.bak
2024-10-17T20:29:42.814Z,1729196982.814 [DataOverHttps](INFO): SBD MOMSN=23314007
2024-10-17T20:30:02.020Z,1729197002.020 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20241017T195739/Express0017.lzma
2024-10-17T20:30:03.022Z,1729197003.022 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0017.lzma.bak
2024-10-17T20:30:03.022Z,1729197003.022 [DataOverHttps](INFO): SBD MOMSN=23314012
2024-10-17T20:30:05.189Z,1729197005.189 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T20:30:05.605Z,1729197005.605 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:30:05.605Z,1729197005.605 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:30:05.605Z,1729197005.605 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:31:28.056Z,1729197088.056 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:31:28.056Z,1729197088.056 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:31:28.067Z,1729197088.067 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:31:28.493Z,1729197088.493 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:31:28.493Z,1729197088.493 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:34:29.104Z,1729197269.104 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T20:34:29.104Z,1729197269.104 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:34:29.150Z,1729197269.150 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:34:29.506Z,1729197269.506 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:34:29.507Z,1729197269.507 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T20:35:06.242Z,1729197306.242 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:35:06.242Z,1729197306.242 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:35:06.242Z,1729197306.242 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:35:06.242Z,1729197306.242 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:35:06.650Z,1729197306.650 [Default:CheckIn:D] Stopped
2024-10-17T20:35:06.650Z,1729197306.650 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:35:07.065Z,1729197307.065 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.545844 min
2024-10-17T20:35:07.065Z,1729197307.065 [Default:CheckIn:E] Stopped
2024-10-17T20:35:07.065Z,1729197307.065 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:35:07.066Z,1729197307.066 [Default:CheckIn] Stopped
2024-10-17T20:35:07.066Z,1729197307.066 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:35:07.066Z,1729197307.066 [Default:CheckIn](INFO): Running loop #6
2024-10-17T20:35:07.066Z,1729197307.066 [Default:CheckIn] Running Loop=6
2024-10-17T20:35:07.066Z,1729197307.066 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:35:07.066Z,1729197307.066 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:35:09.058Z,1729197309.058 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203502.00,A,3648.11371,N,12147.27605,W,1.594,7.29,171024,,,D*70
2024-10-17T20:35:09.060Z,1729197309.060 [NAL9602](INFO): GPS fix at 20241017T203502: (36.801895, -121.787934)
2024-10-17T20:35:09.075Z,1729197309.075 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:35:09.075Z,1729197309.075 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:35:16.262Z,1729197316.262 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241017T195739/Courier0019.lzma
2024-10-17T20:35:17.090Z,1729197317.090 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0019.lzma.bak
2024-10-17T20:35:17.090Z,1729197317.090 [DataOverHttps](INFO): SBD MOMSN=23314030
2024-10-17T20:35:39.770Z,1729197339.770 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T20:35:39.852Z,1729197339.852 [NAL9602](ERROR): received:
+CSQ:0
OK01, 2, 0, 0, 0
OK
2024-10-17T20:35:44.222Z,1729197344.222 [DataOverHttps](INFO): Sending 142 bytes from file Logs/20241017T195739/Express0020.lzma
2024-10-17T20:35:45.230Z,1729197345.230 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0020.lzma.bak
2024-10-17T20:35:45.230Z,1729197345.230 [DataOverHttps](INFO): SBD MOMSN=23314033
2024-10-17T20:35:47.863Z,1729197347.863 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:35:47.863Z,1729197347.863 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:35:47.863Z,1729197347.863 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:37:30.127Z,1729197450.127 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:37:30.127Z,1729197450.127 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:37:30.176Z,1729197450.176 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:37:30.532Z,1729197450.532 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:37:30.532Z,1729197450.532 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:40:11.286Z,1729197611.286 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T20:40:31.087Z,1729197631.087 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T20:40:31.087Z,1729197631.087 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:40:31.118Z,1729197631.118 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:40:31.529Z,1729197631.529 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:40:31.529Z,1729197631.529 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T20:40:41.984Z,1729197641.984 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T20:40:48.467Z,1729197648.467 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:40:48.467Z,1729197648.467 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:40:48.467Z,1729197648.467 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:40:48.467Z,1729197648.467 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:40:48.886Z,1729197648.886 [Default:CheckIn:D] Stopped
2024-10-17T20:40:48.886Z,1729197648.886 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:40:49.268Z,1729197649.268 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.249768 min
2024-10-17T20:40:49.268Z,1729197649.268 [Default:CheckIn:E] Stopped
2024-10-17T20:40:49.268Z,1729197649.268 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:40:49.268Z,1729197649.268 [Default:CheckIn] Stopped
2024-10-17T20:40:49.268Z,1729197649.268 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:40:49.269Z,1729197649.269 [Default:CheckIn](INFO): Running loop #7
2024-10-17T20:40:49.269Z,1729197649.269 [Default:CheckIn] Running Loop=7
2024-10-17T20:40:49.269Z,1729197649.269 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:40:49.269Z,1729197649.269 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:40:51.279Z,1729197651.279 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204044.00,A,3648.14896,N,12147.27402,W,0.914,0.00,171024,,,A*7E
2024-10-17T20:40:51.281Z,1729197651.281 [NAL9602](INFO): GPS fix at 20241017T204044: (36.802483, -121.787900)
2024-10-17T20:40:51.296Z,1729197651.296 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:40:51.296Z,1729197651.296 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:40:58.220Z,1729197658.220 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241017T195739/Courier0022.lzma
2024-10-17T20:40:59.222Z,1729197659.222 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0022.lzma.bak
2024-10-17T20:40:59.222Z,1729197659.222 [DataOverHttps](INFO): SBD MOMSN=23314043
2024-10-17T20:41:21.982Z,1729197681.982 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T20:41:22.056Z,1729197682.056 [NAL9602](ERROR): received:
+CSQ:0
OK01, 2, 0, 0, 0
OK
2024-10-17T20:41:22.354Z,1729197682.354 [DataOverHttps](INFO): Sending 217 bytes from file Logs/20241017T195739/Express0023.lzma
2024-10-17T20:41:23.362Z,1729197683.362 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0023.lzma.bak
2024-10-17T20:41:23.362Z,1729197683.362 [DataOverHttps](INFO): SBD MOMSN=23314046
2024-10-17T20:41:26.072Z,1729197686.072 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:41:26.072Z,1729197686.072 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:41:26.072Z,1729197686.072 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:43:32.083Z,1729197812.083 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:43:32.083Z,1729197812.083 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:43:32.114Z,1729197812.114 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:43:32.507Z,1729197812.507 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:43:32.507Z,1729197812.507 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:45:53.070Z,1729197953.070 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T20:46:23.774Z,1729197983.774 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T20:46:26.612Z,1729197986.612 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:46:26.613Z,1729197986.613 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:46:26.613Z,1729197986.613 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:46:26.613Z,1729197986.613 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:46:27.027Z,1729197987.027 [Default:CheckIn:D] Stopped
2024-10-17T20:46:27.027Z,1729197987.027 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:46:27.441Z,1729197987.441 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.885457 min
2024-10-17T20:46:27.441Z,1729197987.441 [Default:CheckIn:E] Stopped
2024-10-17T20:46:27.441Z,1729197987.441 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:46:27.441Z,1729197987.441 [Default:CheckIn] Stopped
2024-10-17T20:46:27.441Z,1729197987.441 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:46:27.441Z,1729197987.441 [Default:CheckIn](INFO): Running loop #8
2024-10-17T20:46:27.442Z,1729197987.442 [Default:CheckIn] Running Loop=8
2024-10-17T20:46:27.442Z,1729197987.442 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:46:27.442Z,1729197987.442 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:46:29.430Z,1729197989.430 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204623.00,A,3648.15410,N,12147.27438,W,0.330,18.09,171024,,,A*4F
2024-10-17T20:46:29.433Z,1729197989.433 [NAL9602](INFO): GPS fix at 20241017T204623: (36.802568, -121.787906)
2024-10-17T20:46:29.451Z,1729197989.451 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:46:29.451Z,1729197989.451 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:46:33.093Z,1729197993.093 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:46:33.093Z,1729197993.093 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:46:33.140Z,1729197993.140 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:46:33.549Z,1729197993.549 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:46:33.549Z,1729197993.549 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:46:47.141Z,1729198007.141 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241017T195739/Courier0025.lzma
2024-10-17T20:46:48.146Z,1729198008.146 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0025.lzma.bak
2024-10-17T20:46:48.146Z,1729198008.146 [DataOverHttps](INFO): SBD MOMSN=23314056
2024-10-17T20:47:00.137Z,1729198020.137 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T20:47:00.208Z,1729198020.208 [NAL9602](ERROR): received:
+CSQ:0
OK01, 2, 0, 0, 0
OK
2024-10-17T20:47:05.464Z,1729198025.464 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20241017T195739/Express0026.lzma
2024-10-17T20:47:06.466Z,1729198026.466 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0026.lzma.bak
2024-10-17T20:47:06.466Z,1729198026.466 [DataOverHttps](INFO): SBD MOMSN=23314059
2024-10-17T20:47:09.054Z,1729198029.054 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:47:09.054Z,1729198029.054 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:47:09.054Z,1729198029.054 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:48:23.771Z,1729198103.771 [Sonardyne_Nano](ERROR): Failed to parse response: >VS:2409,HPR45,EXT,TILT
2024-10-17T20:49:34.100Z,1729198174.100 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T20:49:34.100Z,1729198174.100 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:49:34.110Z,1729198174.110 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:49:34.494Z,1729198174.494 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:49:34.494Z,1729198174.494 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T20:51:32.041Z,1729198292.041 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T20:52:02.741Z,1729198322.741 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T20:52:09.621Z,1729198329.621 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:52:09.621Z,1729198329.621 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:52:09.621Z,1729198329.621 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:52:09.622Z,1729198329.622 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:52:10.025Z,1729198330.025 [Default:CheckIn:D] Stopped
2024-10-17T20:52:10.025Z,1729198330.025 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:52:10.443Z,1729198330.443 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.602091 min
2024-10-17T20:52:10.443Z,1729198330.443 [Default:CheckIn:E] Stopped
2024-10-17T20:52:10.443Z,1729198330.443 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:52:10.443Z,1729198330.443 [Default:CheckIn] Stopped
2024-10-17T20:52:10.443Z,1729198330.443 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:52:10.444Z,1729198330.444 [Default:CheckIn](INFO): Running loop #9
2024-10-17T20:52:10.444Z,1729198330.444 [Default:CheckIn] Running Loop=9
2024-10-17T20:52:10.444Z,1729198330.444 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:52:10.444Z,1729198330.444 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:52:12.434Z,1729198332.434 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205206.00,A,3648.16487,N,12147.27667,W,0.467,166.54,171024,,,A*7D
2024-10-17T20:52:12.436Z,1729198332.436 [NAL9602](INFO): GPS fix at 20241017T205206: (36.802748, -121.787944)
2024-10-17T20:52:12.450Z,1729198332.450 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:52:12.450Z,1729198332.450 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:52:19.716Z,1729198339.716 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241017T195739/Courier0028.lzma
2024-10-17T20:52:20.718Z,1729198340.718 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0028.lzma.bak
2024-10-17T20:52:20.718Z,1729198340.718 [DataOverHttps](INFO): SBD MOMSN=23314125
2024-10-17T20:52:35.086Z,1729198355.086 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:52:35.086Z,1729198355.086 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:52:35.133Z,1729198355.133 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:52:35.509Z,1729198355.509 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:52:35.509Z,1729198355.509 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:52:43.141Z,1729198363.141 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T20:52:43.216Z,1729198363.216 [NAL9602](ERROR): received:
+CSQ:0
OK01, 2, 0, 0, 0
OK
2024-10-17T20:52:47.151Z,1729198367.151 [DataOverHttps](INFO): Sending 228 bytes from file Logs/20241017T195739/Express0029.lzma
2024-10-17T20:52:48.182Z,1729198368.182 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0029.lzma.bak
2024-10-17T20:52:48.182Z,1729198368.182 [DataOverHttps](INFO): SBD MOMSN=23314137
2024-10-17T20:52:50.869Z,1729198370.869 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:52:50.869Z,1729198370.869 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:52:50.869Z,1729198370.869 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T20:55:36.089Z,1729198536.089 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T20:55:36.089Z,1729198536.089 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:55:36.104Z,1729198536.104 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:55:36.551Z,1729198536.551 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:55:36.552Z,1729198536.552 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T20:57:15.050Z,1729198635.050 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T20:57:45.746Z,1729198665.746 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T20:57:51.412Z,1729198671.412 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T20:57:51.412Z,1729198671.412 [Default:CheckIn:C.Wait] Stopped
2024-10-17T20:57:51.412Z,1729198671.412 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T20:57:51.412Z,1729198671.412 [Default:CheckIn:D] Running Loop=1
2024-10-17T20:57:51.821Z,1729198671.821 [Default:CheckIn:D] Stopped
2024-10-17T20:57:51.821Z,1729198671.821 [Default:CheckIn:E] Running Loop=1
2024-10-17T20:57:52.222Z,1729198672.222 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.298686 min
2024-10-17T20:57:52.222Z,1729198672.222 [Default:CheckIn:E] Stopped
2024-10-17T20:57:52.222Z,1729198672.222 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T20:57:52.223Z,1729198672.223 [Default:CheckIn] Stopped
2024-10-17T20:57:52.223Z,1729198672.223 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T20:57:52.223Z,1729198672.223 [Default:CheckIn](INFO): Running loop #10
2024-10-17T20:57:52.223Z,1729198672.223 [Default:CheckIn] Running Loop=10
2024-10-17T20:57:52.223Z,1729198672.223 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T20:57:52.223Z,1729198672.223 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T20:57:54.230Z,1729198674.230 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205747.00,A,3648.18223,N,12147.27393,W,0.797,196.01,171024,,,A*76
2024-10-17T20:57:54.232Z,1729198674.232 [NAL9602](INFO): GPS fix at 20241017T205747: (36.803037, -121.787899)
2024-10-17T20:57:54.266Z,1729198674.266 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T20:57:54.267Z,1729198674.267 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T20:58:01.920Z,1729198681.920 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241017T195739/Courier0031.lzma
2024-10-17T20:58:02.922Z,1729198682.922 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0031.lzma.bak
2024-10-17T20:58:02.922Z,1729198682.922 [DataOverHttps](INFO): SBD MOMSN=23314149
2024-10-17T20:58:24.934Z,1729198704.934 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T20:58:25.016Z,1729198705.016 [NAL9602](ERROR): received:
+CSQ:0
OK01, 2, 0, 0, 0
OK
2024-10-17T20:58:35.804Z,1729198715.804 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20241017T195739/Express0032.lzma
2024-10-17T20:58:36.806Z,1729198716.806 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0032.lzma.bak
2024-10-17T20:58:36.806Z,1729198716.806 [DataOverHttps](INFO): SBD MOMSN=23314155
2024-10-17T20:58:37.076Z,1729198717.076 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T20:58:37.076Z,1729198717.076 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T20:58:37.087Z,1729198717.087 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T20:58:37.494Z,1729198717.494 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T20:58:37.494Z,1729198717.494 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T20:58:39.533Z,1729198719.533 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T20:58:39.533Z,1729198719.533 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T20:58:39.533Z,1729198719.533 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T21:01:38.056Z,1729198898.056 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T21:01:38.056Z,1729198898.056 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:01:38.105Z,1729198898.105 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:01:38.494Z,1729198898.494 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:01:38.494Z,1729198898.494 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T21:02:56.022Z,1729198976.022 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T21:03:26.721Z,1729199006.721 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T21:03:40.063Z,1729199020.063 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T21:03:40.064Z,1729199020.064 [Default:CheckIn:C.Wait] Stopped
2024-10-17T21:03:40.064Z,1729199020.064 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T21:03:40.064Z,1729199020.064 [Default:CheckIn:D] Running Loop=1
2024-10-17T21:03:40.468Z,1729199020.468 [Default:CheckIn:D] Stopped
2024-10-17T21:03:40.468Z,1729199020.468 [Default:CheckIn:E] Running Loop=1
2024-10-17T21:03:40.877Z,1729199020.877 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 62.109469 min
2024-10-17T21:03:40.877Z,1729199020.877 [Default:CheckIn:E] Stopped
2024-10-17T21:03:40.877Z,1729199020.877 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T21:03:40.877Z,1729199020.877 [Default:CheckIn] Stopped
2024-10-17T21:03:40.877Z,1729199020.877 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T21:03:40.878Z,1729199020.878 [Default:CheckIn](INFO): Running loop #11
2024-10-17T21:03:40.878Z,1729199020.878 [Default:CheckIn] Running Loop=11
2024-10-17T21:03:40.878Z,1729199020.878 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T21:03:40.878Z,1729199020.878 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T21:03:42.882Z,1729199022.882 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210336.00,A,3648.16730,N,12147.28243,W,1.166,0.00,171024,,,A*7C
2024-10-17T21:03:42.893Z,1729199022.893 [NAL9602](INFO): GPS fix at 20241017T210336: (36.802788, -121.788040)
2024-10-17T21:03:42.923Z,1729199022.923 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T21:03:42.923Z,1729199022.923 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T21:03:50.327Z,1729199030.327 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20241017T195739/Courier0034.lzma
2024-10-17T21:03:51.326Z,1729199031.326 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0034.lzma.bak
2024-10-17T21:03:51.326Z,1729199031.326 [DataOverHttps](INFO): SBD MOMSN=23314188
2024-10-17T21:04:08.624Z,1729199048.624 [DataOverHttps](INFO): Sending 219 bytes from file Logs/20241017T195739/Express0035.lzma
2024-10-17T21:04:09.626Z,1729199049.626 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0035.lzma.bak
2024-10-17T21:04:09.626Z,1729199049.626 [DataOverHttps](INFO): SBD MOMSN=23314192
2024-10-17T21:04:12.412Z,1729199052.412 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T21:04:12.412Z,1729199052.412 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T21:04:12.412Z,1729199052.412 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T21:04:13.586Z,1729199053.586 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T21:04:13.669Z,1729199053.669 [NAL9602](ERROR): received:
+CSQ:0
OK01, 2, 0, 0, 0
OK
2024-10-17T21:04:39.057Z,1729199079.057 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T21:04:39.057Z,1729199079.057 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:04:39.068Z,1729199079.068 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:04:39.474Z,1729199079.474 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:04:39.474Z,1729199079.474 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T21:07:40.049Z,1729199260.049 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T21:07:40.049Z,1729199260.049 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:07:40.060Z,1729199260.060 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:07:40.462Z,1729199260.462 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:07:40.463Z,1729199260.463 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T21:08:45.090Z,1729199325.090 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T21:09:12.981Z,1729199352.981 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T21:09:12.981Z,1729199352.981 [Default:CheckIn:C.Wait] Stopped
2024-10-17T21:09:12.982Z,1729199352.981 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T21:09:12.982Z,1729199352.982 [Default:CheckIn:D] Running Loop=1
2024-10-17T21:09:13.369Z,1729199353.369 [Default:CheckIn:D] Stopped
2024-10-17T21:09:13.369Z,1729199353.369 [Default:CheckIn:E] Running Loop=1
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.657817 min
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn:E] Stopped
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn] Stopped
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn](INFO): Running loop #12
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn] Running Loop=12
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T21:09:13.771Z,1729199353.771 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T21:09:15.779Z,1729199355.779 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210909.00,A,3648.14401,N,12147.28283,W,0.583,0.00,171024,,,A*7B
2024-10-17T21:09:15.781Z,1729199355.781 [NAL9602](INFO): GPS fix at 20241017T210909: (36.802400, -121.788047)
2024-10-17T21:09:15.817Z,1729199355.817 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T21:09:15.817Z,1729199355.817 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T21:09:23.136Z,1729199363.136 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20241017T195739/Courier0037.lzma
2024-10-17T21:09:24.138Z,1729199364.138 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0037.lzma.bak
2024-10-17T21:09:24.138Z,1729199364.138 [DataOverHttps](INFO): SBD MOMSN=23314205
2024-10-17T21:09:48.101Z,1729199388.101 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T21:09:51.553Z,1729199391.553 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20241017T195739/Express0038.lzma
2024-10-17T21:09:52.558Z,1729199392.558 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0038.lzma.bak
2024-10-17T21:09:52.558Z,1729199392.558 [DataOverHttps](INFO): SBD MOMSN=23314209
2024-10-17T21:09:55.381Z,1729199395.381 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T21:09:55.381Z,1729199395.381 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T21:09:55.381Z,1729199395.381 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T21:10:41.032Z,1729199441.032 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-17T21:10:41.032Z,1729199441.032 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:10:41.043Z,1729199441.043 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:10:41.450Z,1729199441.450 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:10:41.450Z,1729199441.450 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-17T21:12:51.453Z,1729199571.453 [CommandExec](IMPORTANT): got command gfscan
2024-10-17T21:12:51.554Z,1729199571.554 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-17T21:12:54.369Z,1729199574.369 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2024-10-17T21:13:02.474Z,1729199582.474 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001773
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): 0.000462
CHAN A3 (5V): -0.001775
CHAN B0 (3.3V): -0.001048
CHAN B1 (3.15aV): -0.001564
CHAN B2 (3.15bV): -0.001579
CHAN B3 (GND): -0.001561
OPEN: 0.005386
Full Scale: +/- 1 mA
2024-10-17T21:13:16.156Z,1729199596.156 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-17T21:13:25.049Z,1729199605.049 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2024-10-17T21:13:25.050Z,1729199605.050 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2024-10-17T21:13:25.052Z,1729199605.052 [BPC1](INFO): Received data from all battery sticks.
2024-10-17T21:13:42.038Z,1729199622.038 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-17T21:13:42.038Z,1729199622.038 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:13:42.061Z,1729199622.061 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:13:42.439Z,1729199622.439 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:13:42.439Z,1729199622.439 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-17T21:14:02.273Z,1729199642.273 [CommandExec](IMPORTANT): got command gfscan
2024-10-17T21:14:02.650Z,1729199642.650 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-17T21:14:05.474Z,1729199645.474 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2024-10-17T21:14:13.570Z,1729199653.570 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.700543
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): 0.463247
CHAN A3 (5V): 0.127804
CHAN B0 (3.3V): 0.064399
CHAN B1 (3.15aV): 0.064103
CHAN B2 (3.15bV): 0.064048
CHAN B3 (GND): -0.018878
OPEN: 0.011362
Full Scale: +/- 1 mA
2024-10-17T21:14:55.965Z,1729199695.965 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T21:14:55.965Z,1729199695.965 [Default:CheckIn:C.Wait] Stopped
2024-10-17T21:14:55.965Z,1729199695.965 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T21:14:55.965Z,1729199695.965 [Default:CheckIn:D] Running Loop=1
2024-10-17T21:14:56.382Z,1729199696.382 [Default:CheckIn:D] Stopped
2024-10-17T21:14:56.383Z,1729199696.383 [Default:CheckIn:E] Running Loop=1
2024-10-17T21:14:56.765Z,1729199696.765 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.374707 min
2024-10-17T21:14:56.765Z,1729199696.765 [Default:CheckIn:E] Stopped
2024-10-17T21:14:56.765Z,1729199696.765 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T21:14:56.765Z,1729199696.765 [Default:CheckIn] Stopped
2024-10-17T21:14:56.765Z,1729199696.765 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T21:14:56.766Z,1729199696.766 [Default:CheckIn](INFO): Running loop #13
2024-10-17T21:14:56.766Z,1729199696.766 [Default:CheckIn] Running Loop=13
2024-10-17T21:14:56.766Z,1729199696.766 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T21:14:56.766Z,1729199696.766 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T21:15:29.477Z,1729199729.477 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-10-17T21:15:29.560Z,1729199729.560 [NAL9602](ERROR): received:
+CSQ:0
OK01, 2, 0, 0, 0
OK
2024-10-17T21:16:43.073Z,1729199803.073 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2024-10-17T21:16:43.073Z,1729199803.073 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:16:43.094Z,1729199803.094 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:16:43.456Z,1729199803.456 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:16:43.456Z,1729199803.456 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2024-10-17T21:18:34.173Z,1729199914.173 [CommandExec](IMPORTANT): got command gfscan
2024-10-17T21:18:34.552Z,1729199914.552 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-17T21:18:37.369Z,1729199917.369 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2024-10-17T21:18:45.500Z,1729199925.500 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001707
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.000172
CHAN A3 (5V): -0.001494
CHAN B0 (3.3V): -0.000580
CHAN B1 (3.15aV): -0.000669
CHAN B2 (3.15bV): -0.001426
CHAN B3 (GND): -0.002466
OPEN: 0.005026
Full Scale: +/- 1 mA
2024-10-17T21:19:44.015Z,1729199984.015 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2024-10-17T21:19:44.015Z,1729199984.015 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:19:44.026Z,1729199984.026 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:19:44.456Z,1729199984.456 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:19:44.460Z,1729199984.460 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2024-10-17T21:19:56.951Z,1729199996.951 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-17T21:14:56.8Z
2024-10-17T21:19:56.951Z,1729199996.951 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T21:19:56.951Z,1729199996.951 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T21:20:00.966Z,1729200000.966 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T21:20:10.813Z,1729200010.813 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20241017T195739/Courier0040.lzma
2024-10-17T21:20:12.608Z,1729200012.608 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0040.lzma.bak
2024-10-17T21:20:12.608Z,1729200012.608 [DataOverHttps](INFO): SBD MOMSN=23314326
2024-10-17T21:20:28.949Z,1729200028.949 [DataOverHttps](INFO): Sending 487 bytes from file Logs/20241017T195739/Express0041.lzma
2024-10-17T21:20:31.675Z,1729200031.675 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T21:20:32.962Z,1729200032.962 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0041.lzma.bak
2024-10-17T21:20:32.962Z,1729200032.962 [DataOverHttps](INFO): SBD MOMSN=23314331
2024-10-17T21:20:35.781Z,1729200035.781 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T21:20:35.781Z,1729200035.781 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T21:20:35.781Z,1729200035.781 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T21:20:57.429Z,1729200057.429 [CommandExec](IMPORTANT): got command gfscan
2024-10-17T21:20:57.550Z,1729200057.550 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-17T21:21:00.387Z,1729200060.387 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2024-10-17T21:21:08.462Z,1729200068.462 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001796
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): 0.000098
CHAN A3 (5V): -0.002539
CHAN B0 (3.3V): -0.000575
CHAN B1 (3.15aV): -0.001013
CHAN B2 (3.15bV): -0.001662
CHAN B3 (GND): -0.001914
OPEN: 0.005053
Full Scale: +/- 1 mA
2024-10-17T21:22:38.821Z,1729200158.821 [CommandExec](IMPORTANT): got command gfscan
2024-10-17T21:22:38.950Z,1729200158.950 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-17T21:22:41.800Z,1729200161.800 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2024-10-17T21:22:45.004Z,1729200165.004 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2024-10-17T21:22:45.004Z,1729200165.004 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:22:45.035Z,1729200165.035 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:22:45.419Z,1729200165.419 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:22:45.419Z,1729200165.419 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2024-10-17T21:22:49.899Z,1729200169.899 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.002023
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): 0.000195
CHAN A3 (5V): -0.001598
CHAN B0 (3.3V): -0.000693
CHAN B1 (3.15aV): -0.001582
CHAN B2 (3.15bV): -0.001235
CHAN B3 (GND): -0.002393
OPEN: 0.005105
Full Scale: +/- 1 mA
2024-10-17T21:23:51.893Z,1729200231.893 [CommandExec](IMPORTANT): got command gfscan
2024-10-17T21:23:52.091Z,1729200232.091 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-17T21:23:54.902Z,1729200234.902 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2024-10-17T21:24:03.015Z,1729200243.015 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001808
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): 0.000816
CHAN A3 (5V): -0.002049
CHAN B0 (3.3V): -0.000892
CHAN B1 (3.15aV): -0.001078
CHAN B2 (3.15bV): -0.001624
CHAN B3 (GND): -0.002837
OPEN: 0.005424
Full Scale: +/- 1 mA
2024-10-17T21:24:48.642Z,1729200288.642 [CommandExec](IMPORTANT): got command ! echo d > /dev/loadC3
2024-10-17T21:24:54.265Z,1729200294.265 [CommandExec](IMPORTANT): got command gfscan
2024-10-17T21:24:54.320Z,1729200294.320 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-17T21:24:57.135Z,1729200297.135 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2024-10-17T21:25:05.217Z,1729200305.217 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000773
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): 0.000110
CHAN A3 (5V): -0.001135
CHAN B0 (3.3V): -0.000458
CHAN B1 (3.15aV): -0.000934
CHAN B2 (3.15bV): -0.000879
CHAN B3 (GND): -0.002572
OPEN: 0.005258
Full Scale: +/- 1 mA
2024-10-17T21:25:36.301Z,1729200336.301 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-17T21:25:36.301Z,1729200336.301 [Default:CheckIn:C.Wait] Stopped
2024-10-17T21:25:36.301Z,1729200336.301 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T21:25:36.301Z,1729200336.301 [Default:CheckIn:D] Running Loop=1
2024-10-17T21:25:36.717Z,1729200336.717 [Default:CheckIn:D] Stopped
2024-10-17T21:25:36.717Z,1729200336.717 [Default:CheckIn:E] Running Loop=1
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.046948 min
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn:E] Stopped
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn] Stopped
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn](INFO): Running loop #14
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn] Running Loop=14
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-17T21:25:37.110Z,1729200337.110 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-17T21:25:38.709Z,1729200338.709 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-10-17T21:25:38.709Z,1729200338.709 [NAL9602] Data Fault, FailCount= 1
2024-10-17T21:25:38.709Z,1729200338.709 [NAL9602](ERROR): Data Fault
2024-10-17T21:25:38.731Z,1729200338.731 [CBIT](ERROR): Data Fault in component: NAL9602
2024-10-17T21:25:39.117Z,1729200339.117 [NAL9602](INFO): Powering down
2024-10-17T21:25:39.967Z,1729200339.967 [CBIT](INFO): Clearing failed state for component NAL9602
2024-10-17T21:25:39.968Z,1729200339.968 [NAL9602] No Fault, FailCount= 1
2024-10-17T21:25:46.002Z,1729200346.002 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6
2024-10-17T21:25:46.002Z,1729200346.002 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:25:46.012Z,1729200346.012 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:25:46.430Z,1729200346.430 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:25:46.430Z,1729200346.430 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6
2024-10-17T21:26:09.413Z,1729200369.413 [NAL9602](INFO): Powering up NAL9602
2024-10-17T21:26:20.320Z,1729200380.320 [NAL9602](INFO): NAL9602 initialized
2024-10-17T21:28:47.022Z,1729200527.022 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 7
2024-10-17T21:28:47.022Z,1729200527.022 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:28:47.033Z,1729200527.033 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:28:47.439Z,1729200527.439 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:28:47.439Z,1729200527.439 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 7
2024-10-17T21:30:37.391Z,1729200637.391 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-17T21:25:37.1Z
2024-10-17T21:30:37.391Z,1729200637.391 [Default:CheckIn:Read_GPS] Stopped
2024-10-17T21:30:37.391Z,1729200637.391 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-17T21:30:44.876Z,1729200644.876 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241017T195739/Courier0043.lzma
2024-10-17T21:30:45.878Z,1729200645.878 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Courier0043.lzma.bak
2024-10-17T21:30:45.878Z,1729200645.878 [DataOverHttps](INFO): SBD MOMSN=23314421
2024-10-17T21:30:49.345Z,1729200649.345 [CommandExec](IMPORTANT): got command get DAT.loadAtStartup
2024-10-17T21:30:49.346Z,1729200649.346 [CommandExec](IMPORTANT): DAT.loadAtStartup 0 bool
2024-10-17T21:31:04.891Z,1729200664.891 [CommandExec](IMPORTANT): got command get DATMMP.loadAtStartup
2024-10-17T21:31:04.892Z,1729200664.892 [CommandExec](IMPORTANT): DATMMP.loadAtStartup 1 bool
2024-10-17T21:31:05.565Z,1729200665.565 [DataOverHttps](INFO): Sending 632 bytes from file Logs/20241017T195739/Express0044.lzma
2024-10-17T21:31:06.566Z,1729200666.566 [DataOverHttps](INFO): Moved sent file to Logs/20241017T195739/Express0044.lzma.bak
2024-10-17T21:31:06.566Z,1729200666.566 [DataOverHttps](INFO): SBD MOMSN=23314423
2024-10-17T21:31:09.637Z,1729200669.637 [Default:CheckIn:Read_Iridium] Stopped
2024-10-17T21:31:09.637Z,1729200669.637 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-17T21:31:09.637Z,1729200669.637 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-17T21:31:23.342Z,1729200683.342 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-17T21:31:47.996Z,1729200707.996 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 8
2024-10-17T21:31:47.996Z,1729200707.996 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-17T21:31:48.007Z,1729200708.007 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-17T21:31:48.405Z,1729200708.405 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-17T21:31:48.405Z,1729200708.405 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 8
2024-10-17T21:31:54.041Z,1729200714.041 [NAL9602](INFO): Not Powering down - fast GPS
2024-10-17T21:32:02.382Z,1729200722.382 [CommandExec](IMPORTANT): got command configSet DAT.loadAtStartup 1 bool persist
2024-10-17T21:32:02.382Z,1729200722.382 [CommandExec](IMPORTANT): configSet DAT.loadAtStartup requires a restart to take effect.
2024-10-17T21:32:02.386Z,1729200722.386 [CommandExec](IMPORTANT): got command configSet DATMMP.loadAtStartup 0 bool persist
2024-10-17T21:32:02.389Z,1729200722.389 [CommandExec](IMPORTANT): got command restart application
2024-10-17T21:32:03.415Z,1729200723.415 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-10-17T21:32:03.415Z,1729200723.415 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:03.415Z,1729200723.415 [CommandExec](INFO): Uninitializing the command executive.
2024-10-17T21:32:03.415Z,1729200723.415 [CommandExec](INFO): Uninitializing the command scheduler.
2024-10-17T21:32:03.416Z,1729200723.416 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:03.464Z,1729200723.464 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-10-17T21:32:03.464Z,1729200723.464 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-10-17T21:32:03.465Z,1729200723.465 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:03.465Z,1729200723.465 [NavChartDb](INFO): Join timeout helper Thread ID is 5109
2024-10-17T21:32:03.466Z,1729200723.466 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:03.466Z,1729200723.466 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:03.484Z,1729200723.484 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-10-17T21:32:03.484Z,1729200723.484 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:03.485Z,1729200723.485 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5110
2024-10-17T21:32:03.928Z,1729200723.928 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:03.929Z,1729200723.929 [WetLabsBB2FL](INFO): Powering down
2024-10-17T21:32:03.929Z,1729200723.929 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:03.948Z,1729200723.948 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-10-17T21:32:03.948Z,1729200723.948 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:03.949Z,1729200723.949 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5112
2024-10-17T21:32:04.720Z,1729200724.720 [CTD_Seabird](INFO): Powering down
2024-10-17T21:32:04.732Z,1729200724.732 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:04.732Z,1729200724.732 [CTD_Seabird](INFO): Powering down
2024-10-17T21:32:04.744Z,1729200724.744 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:04.745Z,1729200724.745 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-10-17T21:32:04.745Z,1729200724.745 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:04.745Z,1729200724.745 [Radio_Surface](INFO): Join timeout helper Thread ID is 5116
2024-10-17T21:32:05.132Z,1729200725.132 [Radio_Surface](INFO): Powering down
2024-10-17T21:32:05.133Z,1729200725.133 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:05.134Z,1729200725.134 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:05.152Z,1729200725.152 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-10-17T21:32:05.152Z,1729200725.152 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:05.153Z,1729200725.153 [Onboard](INFO): Join timeout helper Thread ID is 5124
2024-10-17T21:32:06.020Z,1729200726.020 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-10-17T21:32:07.665Z,1729200727.665 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:07.665Z,1729200727.665 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:07.673Z,1729200727.673 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-10-17T21:32:07.673Z,1729200727.673 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:07.674Z,1729200727.674 [DataOverHttps](INFO): Join timeout helper Thread ID is 5125
2024-10-17T21:32:08.029Z,1729200728.029 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:08.029Z,1729200728.029 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.033Z,1729200728.033 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-10-17T21:32:08.033Z,1729200728.033 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.034Z,1729200728.034 [BackseatComponent](INFO): Join timeout helper Thread ID is 5129
2024-10-17T21:32:08.101Z,1729200728.101 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:08.101Z,1729200728.101 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.119Z,1729200728.119 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-10-17T21:32:08.119Z,1729200728.119 [logger ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.119Z,1729200728.119 [logger](INFO): Join timeout helper Thread ID is 5130
2024-10-17T21:32:08.132Z,1729200728.132 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:08.132Z,1729200728.132 [logger ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.149Z,1729200728.149 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-10-17T21:32:08.149Z,1729200728.149 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.149Z,1729200728.149 [CommandLine](INFO): Join timeout helper Thread ID is 5131
2024-10-17T21:32:08.192Z,1729200728.192 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:08.193Z,1729200728.193 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.209Z,1729200728.209 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-10-17T21:32:08.209Z,1729200728.209 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.210Z,1729200728.210 [CommandExec](INFO): Join timeout helper Thread ID is 5132
2024-10-17T21:32:08.220Z,1729200728.220 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-10-17T21:32:08.220Z,1729200728.220 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.221Z,1729200728.221 [controlThread](INFO): Join timeout helper Thread ID is 5133
2024-10-17T21:32:08.580Z,1729200728.580 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-17T21:32:08.581Z,1729200728.581 [controlThread](DEBUG): Uninitializing ControlThread
2024-10-17T21:32:08.581Z,1729200728.581 [AHRS_M2](INFO): Powering down
2024-10-17T21:32:08.653Z,1729200728.653 [NAL9602](INFO): Powering down
2024-10-17T21:32:08.655Z,1729200728.655 [Sonardyne_Nano](INFO): Powering down
2024-10-17T21:32:08.773Z,1729200728.773 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-10-17T21:32:08.774Z,1729200728.774 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-10-17T21:32:08.775Z,1729200728.775 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-10-17T21:32:08.775Z,1729200728.775 [MissionManager](INFO): Uninitializing Mission Default
2024-10-17T21:32:08.775Z,1729200728.775 [Default] Stopped
2024-10-17T21:32:08.775Z,1729200728.775 [Default](DEBUG): Aggregate::uninitialize Default
2024-10-17T21:32:08.775Z,1729200728.775 [Default:B.GoToSurface] Stopped
2024-10-17T21:32:08.776Z,1729200728.776 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-10-17T21:32:08.776Z,1729200728.776 [Default:CheckIn] Stopped
2024-10-17T21:32:08.776Z,1729200728.776 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-17T21:32:08.776Z,1729200728.776 [Default:CheckIn:C.Wait] Stopped
2024-10-17T21:32:08.776Z,1729200728.776 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-17T21:32:08.779Z,1729200728.779 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-10-17T21:32:08.779Z,1729200728.779 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-10-17T21:32:08.779Z,1729200728.779 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-10-17T21:32:08.779Z,1729200728.779 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-10-17T21:32:08.780Z,1729200728.780 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-10-17T21:32:08.780Z,1729200728.780 [BuoyancyServo](INFO): Powering down
2024-10-17T21:32:08.792Z,1729200728.792 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-10-17T21:32:08.792Z,1729200728.792 [ElevatorServo](INFO): Powering down
2024-10-17T21:32:08.793Z,1729200728.793 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-10-17T21:32:08.793Z,1729200728.793 [MassServo](INFO): Powering down
2024-10-17T21:32:08.794Z,1729200728.794 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-10-17T21:32:08.794Z,1729200728.794 [RudderServo](INFO): Powering down
2024-10-17T21:32:08.795Z,1729200728.795 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-10-17T21:32:08.795Z,1729200728.795 [ThrusterHE](INFO): Powering down
2024-10-17T21:32:08.796Z,1729200728.796 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-10-17T21:32:08.796Z,1729200728.796 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-10-17T21:32:08.797Z,1729200728.797 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-10-17T21:32:08.797Z,1729200728.797 [CBIT](DEBUG): Powering off loads.
2024-10-17T21:32:08.808Z,1729200728.808 [CBIT](DEBUG): Disabling WDT.
2024-10-17T21:32:08.820Z,1729200728.820 [CBIT](DEBUG): Opening all GF detection circuits.
2024-10-17T21:32:08.821Z,1729200728.821 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.840Z,1729200728.840 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.842Z,1729200728.842 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.848Z,1729200728.848 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.889Z,1729200728.889 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.979Z,1729200728.979 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:08.985Z,1729200728.985 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:09.003Z,1729200729.003 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-10-17T21:32:09.050Z,1729200729.050 [logger ThreadHandler](INFO): Thread cancelled.