2025-04-21T14:55:39.970Z,1745247339.970 [Supervisor](DEBUG): Initializing supervisor.
2025-04-21T14:55:39.975Z,1745247339.975 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-04-21T14:55:39.976Z,1745247339.976 [SyncHandler](INFO): Protected caller Thread ID is 7238
2025-04-21T14:55:39.976Z,1745247339.976 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-04-21T14:55:39.977Z,1745247339.977 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-04-21T14:55:39.978Z,1745247339.978 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7239
2025-04-21T14:55:39.982Z,1745247339.982 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-04-21T14:55:40.002Z,1745247340.002 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-04-21T14:55:40.003Z,1745247340.003 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-04-21T14:55:40.003Z,1745247340.003 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7240
2025-04-21T14:55:40.008Z,1745247340.008 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-04-21T14:55:40.009Z,1745247340.009 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-04-21T14:55:40.009Z,1745247340.009 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7241
2025-04-21T14:55:40.011Z,1745247340.011 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-04-21T14:55:40.012Z,1745247340.012 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-04-21T14:55:40.013Z,1745247340.013 [logger ThreadHandler](INFO): Protected caller Thread ID is 7242
2025-04-21T14:55:40.017Z,1745247340.017 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-04-21T14:55:40.017Z,1745247340.017 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-04-21T14:55:40.019Z,1745247340.019 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-04-21T14:55:40.507Z,1745247340.507 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-04-21T14:55:40.507Z,1745247340.507 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-04-21T14:55:40.732Z,1745247340.732 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-04-21T14:55:40.732Z,1745247340.732 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-04-21T14:55:40.825Z,1745247340.825 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-04-21T14:55:41.075Z,1745247341.075 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-04-21T14:55:41.075Z,1745247341.075 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-04-21T14:55:41.165Z,1745247341.165 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-04-21T14:55:41.273Z,1745247341.273 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-04-21T14:55:41.274Z,1745247341.274 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-04-21T14:55:41.642Z,1745247341.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-04-21T14:55:41.642Z,1745247341.642 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-04-21T14:55:41.787Z,1745247341.787 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-04-21T14:55:41.787Z,1745247341.787 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-04-21T14:55:42.341Z,1745247342.341 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-04-21T14:55:42.342Z,1745247342.342 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-04-21T14:55:42.537Z,1745247342.537 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-04-21T14:55:42.538Z,1745247342.538 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-04-21T14:55:42.966Z,1745247342.966 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-04-21T14:55:42.967Z,1745247342.967 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-04-21T14:55:43.265Z,1745247343.265 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-04-21T14:55:43.266Z,1745247343.266 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-04-21T14:55:43.427Z,1745247343.427 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-04-21T14:55:43.427Z,1745247343.427 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-04-21T14:55:44.815Z,1745247344.815 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-04-21T14:55:44.816Z,1745247344.816 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-04-21T14:55:45.182Z,1745247345.182 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-04-21T14:55:45.182Z,1745247345.182 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-04-21T14:55:45.437Z,1745247345.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-04-21T14:55:45.439Z,1745247345.439 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2025-04-21T14:55:45.440Z,1745247345.440 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2025-04-21T14:55:45.573Z,1745247345.573 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2025-04-21T14:55:45.668Z,1745247345.668 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2025-04-21T14:55:45.820Z,1745247345.820 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2025-04-21T14:55:45.918Z,1745247345.918 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2025-04-21T14:55:46.198Z,1745247346.198 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-04-21T14:55:46.199Z,1745247346.199 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2025-04-21T14:55:46.317Z,1745247346.317 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2025-04-21T14:55:46.438Z,1745247346.438 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2025-04-21T14:55:46.551Z,1745247346.551 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2025-04-21T14:55:46.717Z,1745247346.717 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2025-04-21T14:55:46.828Z,1745247346.828 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2025-04-21T14:55:46.928Z,1745247346.928 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2025-04-21T14:55:46.928Z,1745247346.928 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-04-21T14:55:46.935Z,1745247346.935 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-04-21T14:55:46.946Z,1745247346.946 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-04-21T14:55:46.947Z,1745247346.947 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-04-21T14:55:47.080Z,1745247347.080 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-04-21T14:55:47.081Z,1745247347.081 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-04-21T14:55:47.134Z,1745247347.134 [VerticalControl](DEBUG): Construct VerticalControl.
2025-04-21T14:55:47.195Z,1745247347.195 [VerticalControl] Loaded
2025-04-21T14:55:47.196Z,1745247347.196 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-04-21T14:55:47.198Z,1745247347.198 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-04-21T14:55:47.245Z,1745247347.245 [HorizontalControl] Loaded
2025-04-21T14:55:47.245Z,1745247347.245 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-04-21T14:55:47.248Z,1745247347.248 [SpeedControl](DEBUG): Construct SpeedControl.
2025-04-21T14:55:47.251Z,1745247347.251 [SpeedControl] Loaded
2025-04-21T14:55:47.251Z,1745247347.251 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-04-21T14:55:47.254Z,1745247347.254 [LoopControl](DEBUG): Construct LoopControl.
2025-04-21T14:55:47.254Z,1745247347.254 [LoopControl] Loaded
2025-04-21T14:55:47.254Z,1745247347.254 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-04-21T14:55:47.255Z,1745247347.255 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-04-21T14:55:47.255Z,1745247347.255 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-04-21T14:55:47.416Z,1745247347.416 [BuoyancyServo] Loaded
2025-04-21T14:55:47.417Z,1745247347.417 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-04-21T14:55:47.438Z,1745247347.438 [ElevatorServo] Loaded
2025-04-21T14:55:47.439Z,1745247347.439 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-04-21T14:55:47.460Z,1745247347.460 [MassServo] Loaded
2025-04-21T14:55:47.460Z,1745247347.460 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-04-21T14:55:47.481Z,1745247347.481 [RudderServo] Loaded
2025-04-21T14:55:47.481Z,1745247347.481 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-04-21T14:55:47.498Z,1745247347.498 [ThrusterHE] Loaded
2025-04-21T14:55:47.498Z,1745247347.498 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-04-21T14:55:47.498Z,1745247347.498 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-04-21T14:55:47.499Z,1745247347.499 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-04-21T14:55:47.551Z,1745247347.551 [DepthRateCalculator] Loaded
2025-04-21T14:55:47.551Z,1745247347.551 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-04-21T14:55:47.556Z,1745247347.556 [PitchRateCalculator] Loaded
2025-04-21T14:55:47.556Z,1745247347.556 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-04-21T14:55:47.566Z,1745247347.566 [SpeedCalculator] Loaded
2025-04-21T14:55:47.566Z,1745247347.566 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-04-21T14:55:47.570Z,1745247347.570 [YawRateCalculator] Loaded
2025-04-21T14:55:47.571Z,1745247347.571 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-04-21T14:55:47.589Z,1745247347.589 [ElevatorOffsetCalculator] Loaded
2025-04-21T14:55:47.589Z,1745247347.589 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-04-21T14:55:47.590Z,1745247347.590 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-04-21T14:55:47.590Z,1745247347.590 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-04-21T14:55:47.705Z,1745247347.705 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-04-21T14:55:47.705Z,1745247347.705 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-04-21T14:55:47.719Z,1745247347.719 [NavChart] Loaded
2025-04-21T14:55:47.719Z,1745247347.719 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-04-21T14:55:47.725Z,1745247347.725 [UniversalFixResidualReporter] Loaded
2025-04-21T14:55:47.725Z,1745247347.725 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-04-21T14:55:47.725Z,1745247347.725 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-04-21T14:55:47.726Z,1745247347.726 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-04-21T14:55:48.221Z,1745247348.221 [AHRS_M2] Loaded
2025-04-21T14:55:48.222Z,1745247348.222 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-04-21T14:55:48.261Z,1745247348.261 [BackseatComponent] Loaded
2025-04-21T14:55:48.261Z,1745247348.261 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-04-21T14:55:48.262Z,1745247348.262 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409294E0
2025-04-21T14:55:48.263Z,1745247348.263 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7324
2025-04-21T14:55:48.265Z,1745247348.265 [LcmUniversalReporter] Loaded
2025-04-21T14:55:48.266Z,1745247348.266 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-04-21T14:55:48.272Z,1745247348.272 [BioacousticsDataBridge] Loaded
2025-04-21T14:55:48.272Z,1745247348.272 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2025-04-21T14:55:49.206Z,1745247349.206 [BPC1] Loaded
2025-04-21T14:55:49.207Z,1745247349.207 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-04-21T14:55:49.468Z,1745247349.468 [DataOverHttps] Loaded
2025-04-21T14:55:49.468Z,1745247349.468 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-04-21T14:55:49.493Z,1745247349.493 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409594E0
2025-04-21T14:55:49.493Z,1745247349.493 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7325
2025-04-21T14:55:49.552Z,1745247349.552 [Depth_Keller] Loaded
2025-04-21T14:55:49.552Z,1745247349.552 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-04-21T14:55:49.557Z,1745247349.557 [DropWeight] Loaded
2025-04-21T14:55:49.558Z,1745247349.558 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-04-21T14:55:49.702Z,1745247349.702 [NAL9602] Loaded
2025-04-21T14:55:49.702Z,1745247349.702 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-04-21T14:55:49.771Z,1745247349.771 [Onboard] Loaded
2025-04-21T14:55:49.771Z,1745247349.771 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-04-21T14:55:49.772Z,1745247349.772 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409894E0
2025-04-21T14:55:49.773Z,1745247349.773 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7326
2025-04-21T14:55:49.787Z,1745247349.787 [Power24vConverter] Loaded
2025-04-21T14:55:49.787Z,1745247349.787 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-04-21T14:55:49.803Z,1745247349.803 [Radio_Surface] Loaded
2025-04-21T14:55:49.803Z,1745247349.803 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-04-21T14:55:49.805Z,1745247349.805 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409B94E0
2025-04-21T14:55:49.805Z,1745247349.805 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7327
2025-04-21T14:55:49.821Z,1745247349.821 [Sonardyne_Nano] Loaded
2025-04-21T14:55:49.821Z,1745247349.821 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-04-21T14:55:49.821Z,1745247349.821 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-04-21T14:55:49.822Z,1745247349.822 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-04-21T14:55:50.029Z,1745247350.029 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-04-21T14:55:50.029Z,1745247350.029 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-04-21T14:55:50.211Z,1745247350.211 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-04-21T14:55:50.212Z,1745247350.212 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-04-21T14:55:50.240Z,1745247350.240 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-04-21T14:55:50.241Z,1745247350.241 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-04-21T14:55:50.409Z,1745247350.409 [CTD_Seabird] Loaded
2025-04-21T14:55:50.409Z,1745247350.409 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-04-21T14:55:50.410Z,1745247350.410 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AFE4E0
2025-04-21T14:55:50.410Z,1745247350.410 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7328
2025-04-21T14:55:50.434Z,1745247350.434 [PAR_Licor] Loaded
2025-04-21T14:55:50.434Z,1745247350.434 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-04-21T14:55:50.478Z,1745247350.478 [WetLabsBB2FL] Loaded
2025-04-21T14:55:50.478Z,1745247350.478 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-04-21T14:55:50.479Z,1745247350.479 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B2E4E0
2025-04-21T14:55:50.479Z,1745247350.479 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7329
2025-04-21T14:55:50.480Z,1745247350.480 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-04-21T14:55:50.480Z,1745247350.480 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-04-21T14:55:50.828Z,1745247350.828 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-04-21T14:55:50.829Z,1745247350.829 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-04-21T14:55:50.991Z,1745247350.991 [SBIT](DEBUG): Construct Startup Built In Test.
2025-04-21T14:55:50.000Z,1745247351.000 [SBIT] Loaded
2025-04-21T14:55:50.000Z,1745247351.000 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-04-21T14:55:51.003Z,1745247351.003 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-04-21T14:55:51.016Z,1745247351.016 [IBIT] Loaded
2025-04-21T14:55:51.016Z,1745247351.016 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-04-21T14:55:51.021Z,1745247351.021 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-04-21T14:55:51.101Z,1745247351.101 [CBIT] Loaded
2025-04-21T14:55:51.102Z,1745247351.102 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-04-21T14:55:51.133Z,1745247351.133 [GFScanner] Loaded
2025-04-21T14:55:51.134Z,1745247351.134 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-04-21T14:55:51.134Z,1745247351.134 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-04-21T14:55:51.140Z,1745247351.140 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-04-21T14:55:51.143Z,1745247351.143 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-04-21T14:55:51.155Z,1745247351.155 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-04-21T14:55:51.156Z,1745247351.156 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C354E0
2025-04-21T14:55:51.157Z,1745247351.157 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7330
2025-04-21T14:55:51.161Z,1745247351.161 [Supervisor](INFO): Main Thread ID is 7110
2025-04-21T14:55:51.161Z,1745247351.161 [Supervisor](DEBUG): Running supervisor.
2025-04-21T14:55:51.162Z,1745247351.162 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7331
2025-04-21T14:55:51.162Z,1745247351.162 [CommandExec](INFO): Initializing the command executive.
2025-04-21T14:55:51.164Z,1745247351.164 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7332
2025-04-21T14:55:51.166Z,1745247351.166 [controlThread ThreadHandler](INFO): Handler Thread ID is 7333
2025-04-21T14:55:51.167Z,1745247351.167 [controlThread](DEBUG): Initializing ControlThread
2025-04-21T14:55:51.167Z,1745247351.167 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-04-21T14:55:51.169Z,1745247351.169 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-04-21T14:55:51.170Z,1745247351.170 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-04-21T14:55:51.170Z,1745247351.170 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-04-21T14:55:51.172Z,1745247351.172 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-04-21T14:55:51.172Z,1745247351.172 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-04-21T14:55:51.172Z,1745247351.172 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-04-21T14:55:51.173Z,1745247351.173 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-04-21T14:55:51.173Z,1745247351.173 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-04-21T14:55:51.174Z,1745247351.174 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-04-21T14:55:51.175Z,1745247351.175 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-04-21T14:55:51.181Z,1745247351.181 [SBIT](INFO): Initialize SBIT Component.
2025-04-21T14:55:51.181Z,1745247351.181 [SBIT](IMPORTANT): git: 2025-04-15
2025-04-21T14:55:51.182Z,1745247351.182 [SBIT](INFO): git hash: e5e9d680ffe788b716b2397065cfa67465e27e09
2025-04-21T14:55:51.182Z,1745247351.182 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-04-21T14:55:51.183Z,1745247351.183 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2025-04-21T14:55:51.184Z,1745247351.184 [SBIT](INFO): Beginning SBIT in 122.000000 seconds.
2025-04-21T14:55:51.185Z,1745247351.185 [IBIT](INFO): Initialize IBIT Component.
2025-04-21T14:55:51.185Z,1745247351.185 [CBIT](DEBUG): Initialize CBIT Component.
2025-04-21T14:55:51.186Z,1745247351.186 [logger ThreadHandler](INFO): Handler Thread ID is 7334
2025-04-21T14:55:51.197Z,1745247351.197 [CBIT](DEBUG): Initialized mux pins.
2025-04-21T14:55:51.197Z,1745247351.197 [CBIT](DEBUG): Initializing the watchdog timer.
2025-04-21T14:55:51.205Z,1745247351.205 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7335
2025-04-21T14:55:51.217Z,1745247351.217 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7336
2025-04-21T14:55:51.219Z,1745247351.219 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-04-21T14:55:51.221Z,1745247351.221 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-04-21T14:55:51.221Z,1745247351.221 [CBIT](DEBUG): Initializing heartbeat.
2025-04-21T14:55:51.229Z,1745247351.229 [Onboard ThreadHandler](INFO): Handler Thread ID is 7337
2025-04-21T14:55:51.246Z,1745247351.246 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7338
2025-04-21T14:55:51.266Z,1745247351.266 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7339
2025-04-21T14:55:51.267Z,1745247351.267 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-21T14:55:51.270Z,1745247351.270 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7341
2025-04-21T14:55:51.273Z,1745247351.273 [WetLabsBB2FL](INFO): Powering up
2025-04-21T14:55:51.274Z,1745247351.274 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7343
2025-04-21T14:55:51.278Z,1745247351.278 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI79M.000
2025-04-21T14:55:51.278Z,1745247351.278 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI79M.000
2025-04-21T14:55:51.278Z,1745247351.278 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QL.000
2025-04-21T14:55:51.278Z,1745247351.278 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QL.000
2025-04-21T14:55:51.279Z,1745247351.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QM.000
2025-04-21T14:55:51.279Z,1745247351.279 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QM.000
2025-04-21T14:55:51.279Z,1745247351.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2PM.000
2025-04-21T14:55:51.279Z,1745247351.279 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2PM.000
2025-04-21T14:55:51.279Z,1745247351.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI74M.000
2025-04-21T14:55:51.279Z,1745247351.279 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI74M.000
2025-04-21T14:55:51.279Z,1745247351.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QN.000
2025-04-21T14:55:51.280Z,1745247351.280 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QN.000
2025-04-21T14:55:51.280Z,1745247351.280 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QO.000
2025-04-21T14:55:51.280Z,1745247351.280 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QO.000
2025-04-21T14:55:51.280Z,1745247351.280 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RO.000
2025-04-21T14:55:51.280Z,1745247351.280 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RO.000
2025-04-21T14:55:51.281Z,1745247351.281 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RN.000
2025-04-21T14:55:51.281Z,1745247351.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RN.000
2025-04-21T14:55:51.281Z,1745247351.281 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QP.000
2025-04-21T14:55:51.281Z,1745247351.281 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QP.000
2025-04-21T14:55:51.293Z,1745247351.293 [CBIT](DEBUG): Deactivating emergency mode.
2025-04-21T14:55:51.333Z,1745247351.333 [CBIT](DEBUG): Backplane powered.
2025-04-21T14:55:51.333Z,1745247351.333 [GFScanner](DEBUG): Initializing GFScanner
2025-04-21T14:55:51.333Z,1745247351.333 [GFScanner](DEBUG): Deactivating GF circuits.
2025-04-21T14:55:51.338Z,1745247351.338 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-04-21T14:55:51.339Z,1745247351.339 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-04-21T14:55:51.339Z,1745247351.339 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-04-21T14:55:51.340Z,1745247351.340 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-04-21T14:55:51.398Z,1745247351.398 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-04-21T14:55:51.418Z,1745247351.418 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-21T14:55:51.442Z,1745247351.442 [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
}
}
}
2025-04-21T14:55:51.443Z,1745247351.443 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-04-21T14:55:51.443Z,1745247351.443 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-04-21T14:55:51.444Z,1745247351.444 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-04-21T14:55:51.669Z,1745247351.669 [Radio_Surface](INFO): Powering up
2025-04-21T14:55:51.802Z,1745247351.802 [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
2025-04-21T14:55:51.831Z,1745247351.831 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-04-21T14:55:51.832Z,1745247351.832 [Default:A.Wait](DEBUG): Construct Wait.
2025-04-21T14:55:51.847Z,1745247351.847 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-21T14:55:51.872Z,1745247351.872 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-21T14:55:51.899Z,1745247351.899 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-21T14:55:51.920Z,1745247351.920 [Default:E.Execute](DEBUG): Construct Execute.
2025-04-21T14:55:51.928Z,1745247351.928 [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"
}
}
2025-04-21T14:55:51.933Z,1745247351.933 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-21T14:55:51.940Z,1745247351.940 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-21T14:55:52.009Z,1745247352.009 [Depth_Keller](INFO): Initializing.
2025-04-21T14:55:52.011Z,1745247352.011 [Power24vConverter](INFO): Powering up.
2025-04-21T14:55:52.011Z,1745247352.011 [Sonardyne_Nano](INFO): Initializing.
2025-04-21T14:55:52.049Z,1745247352.049 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-21T14:55:52.076Z,1745247352.076 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-21T14:55:52.093Z,1745247352.093 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-21T14:55:52.094Z,1745247352.094 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-21T14:55:52.101Z,1745247352.101 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-21T14:55:52.102Z,1745247352.102 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-21T14:55:52.113Z,1745247352.113 [MassServo](DEBUG): Initializing MassServo.
2025-04-21T14:55:52.125Z,1745247352.125 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-21T14:55:52.133Z,1745247352.133 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-21T14:55:52.134Z,1745247352.134 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-21T14:55:52.141Z,1745247352.141 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-21T14:55:52.403Z,1745247352.403 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-04-21T14:55:52.403Z,1745247352.403 [DropWeight] Hardware Fault, FailCount= 1
2025-04-21T14:55:52.403Z,1745247352.403 [DropWeight](ERROR): Hardware Fault
2025-04-21T14:55:52.427Z,1745247352.427 [CommandExec](FAULT): Scheduling is paused
2025-04-21T14:55:52.427Z,1745247352.427 [CBIT](INFO): Critical error at 20250421T145552
2025-04-21T14:55:52.428Z,1745247352.428 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-04-21T14:55:52.438Z,1745247352.438 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-04-21T14:55:52.439Z,1745247352.439 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-04-21T14:55:52.770Z,1745247352.770 [CBIT](INFO): Critical error at 20250421T145552
2025-04-21T14:55:53.885Z,1745247353.885 [WetLabsBB2FL](INFO): Powering down
2025-04-21T14:55:53.967Z,1745247353.967 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-04-21T14:55:55.249Z,1745247355.249 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107
2025-04-21T14:55:57.858Z,1745247357.858 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-04-21T14:55:58.297Z,1745247358.297 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-04-21T14:56:19.822Z,1745247379.822 [NAL9602](INFO): Powering up NAL9602
2025-04-21T14:56:22.989Z,1745247382.989 [MassServo](ERROR): getPosition uart error serial timeout
2025-04-21T14:56:22.989Z,1745247382.989 [MassServo](FAULT): Invalid EZ Servo response:""
2025-04-21T14:56:22.989Z,1745247382.989 [MassServo] Communications Fault, FailCount= 1
2025-04-21T14:56:22.989Z,1745247382.989 [MassServo](ERROR): Communications Fault
2025-04-21T14:56:22.994Z,1745247382.994 [CBIT](ERROR): Communications Fault in component: MassServo
2025-04-21T14:56:23.152Z,1745247383.152 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-21T14:56:23.152Z,1745247383.152 [MassServo](INFO): Powering down
2025-04-21T14:56:23.891Z,1745247383.891 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-21T14:56:24.027Z,1745247384.027 [MassServo](DEBUG): Initializing MassServo.
2025-04-21T14:56:24.032Z,1745247384.032 [CBIT](INFO): Clearing failed state for component MassServo
2025-04-21T14:56:24.032Z,1745247384.032 [MassServo] No Fault, FailCount= 1
2025-04-21T14:56:24.137Z,1745247384.137 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2025-04-21T14:56:24.141Z,1745247384.141 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread.
2025-04-21T14:56:24.311Z,1745247384.311 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-21T14:56:26.337Z,1745247386.337 [ElevatorServo](FAULT): Overload Error
2025-04-21T14:56:26.337Z,1745247386.337 [ElevatorServo] Hardware Fault, FailCount= 1
2025-04-21T14:56:26.337Z,1745247386.337 [ElevatorServo](ERROR): Hardware Fault
2025-04-21T14:56:26.450Z,1745247386.450 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-04-21T14:56:26.709Z,1745247386.709 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-21T14:56:26.709Z,1745247386.709 [ElevatorServo](INFO): Powering down
2025-04-21T14:56:27.510Z,1745247387.510 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-21T14:56:27.626Z,1745247387.626 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-21T14:56:27.790Z,1745247387.790 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-04-21T14:56:27.790Z,1745247387.790 [ElevatorServo] No Fault, FailCount= 1
2025-04-21T14:56:30.735Z,1745247390.735 [NAL9602](INFO): NAL9602 initialized
2025-04-21T14:57:02.817Z,1745247422.817 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo
2025-04-21T14:57:02.817Z,1745247422.817 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault
2025-04-21T14:57:06.747Z,1745247426.747 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-04-21T14:57:13.585Z,1745247433.585 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T14:57:20.228Z,1745247440.228 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2025-04-21T14:57:28.357Z,1745247448.357 [CommandExec](IMPORTANT): got command failComponent
2025-04-21T14:57:28.357Z,1745247448.357 [CommandExec](IMPORTANT): Failed components:
2025-04-21T14:57:28.358Z,1745247448.358 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2025-04-21T14:57:41.735Z,1745247461.735 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2025-04-21T14:57:41.888Z,1745247461.888 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T14:57:48.365Z,1745247468.365 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-04-21T14:57:53.606Z,1745247473.606 [SBIT](IMPORTANT): Beginning Startup BIT
2025-04-21T14:57:53.610Z,1745247473.610 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-21T14:57:58.086Z,1745247478.086 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.004522
CHAN A1 (24V): -0.007016
CHAN A2 (12V): -0.004713
CHAN A3 (5V): -0.003217
CHAN B0 (3.3V): -0.001161
CHAN B1 (3.15aV): -0.001197
CHAN B2 (3.15bV): -0.001146
CHAN B3 (GND): -0.000628
OPEN: 0.004974
Full Scale: +/- 1 mA
2025-04-21T14:58:06.901Z,1745247486.901 [SBIT](FAULT): Elevator: EXPECTED:15.000000 ACTUAL:-14.975829
2025-04-21T14:58:19.056Z,1745247499.056 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-04-21T14:58:19.184Z,1745247499.184 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005739
2025-04-21T14:58:25.480Z,1745247505.480 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-04-21T14:58:42.431Z,1745247522.431 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T14:58:47.318Z,1745247527.318 [SBIT](FAULT): Elevator: EXPECTED:0.000000 ACTUAL:-14.975829
2025-04-21T14:58:47.318Z,1745247527.318 [SBIT](FAULT): Control surface position failure.
2025-04-21T14:58:47.704Z,1745247527.704 [SBIT](CRITICAL): SBIT FAILED
2025-04-21T14:58:47.704Z,1745247527.704 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-04-21T14:58:47.705Z,1745247527.705 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;
2025-04-21T14:58:47.705Z,1745247527.705 [SBIT](IMPORTANT): BackseatComponent.missionCritical=0 bool;
2025-04-21T14:58:47.705Z,1745247527.705 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=1 bool;
2025-04-21T14:58:47.705Z,1745247527.705 [SBIT](IMPORTANT): SpeedControl.rollOptimum=0.750000 m/s;
2025-04-21T14:58:47.705Z,1745247527.705 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=161.274998 cubic_centimeter;
2025-04-21T14:58:47.705Z,1745247527.705 [SBIT](IMPORTANT): VerticalControl.massDefault=25.748476 millimeter;
2025-04-21T14:58:47.707Z,1745247527.707 [CBIT](INFO): Critical error at 20250421T145847
2025-04-21T14:58:48.115Z,1745247528.115 [MissionManager](IMPORTANT): Started mission Startup
2025-04-21T14:58:48.115Z,1745247528.115 [Startup] Running Loop=1
2025-04-21T14:58:48.115Z,1745247528.115 [Startup](DEBUG): Aggregate::initialize Startup
2025-04-21T14:58:48.115Z,1745247528.115 [Startup:A.GoToSurface] Running Loop=1
2025-04-21T14:58:48.115Z,1745247528.115 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T14:58:48.116Z,1745247528.116 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-21T14:58:48.116Z,1745247528.116 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-21T14:58:48.117Z,1745247528.117 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-21T14:58:48.117Z,1745247528.117 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-21T14:58:48.118Z,1745247528.118 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T14:58:48.118Z,1745247528.118 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T14:58:48.120Z,1745247528.120 [Startup:StartupSatComms] Running Loop=1
2025-04-21T14:58:48.120Z,1745247528.120 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-04-21T14:58:48.120Z,1745247528.120 [Startup:StartupSatComms:A] Running Loop=1
2025-04-21T14:58:48.523Z,1745247528.523 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-04-21T14:58:51.353Z,1745247531.353 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-04-21T14:58:51.353Z,1745247531.353 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T14:58:51.372Z,1745247531.372 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T14:58:51.779Z,1745247531.779 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T14:58:51.779Z,1745247531.779 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-04-21T14:58:59.065Z,1745247539.065 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T14:58:59.804Z,1745247539.804 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T14:59:15.559Z,1745247555.559 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T14:59:32.123Z,1745247572.123 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T14:59:48.366Z,1745247588.366 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-21T14:58:48.1Z
2025-04-21T14:59:48.366Z,1745247588.366 [Startup:StartupSatComms:A] Stopped
2025-04-21T14:59:48.366Z,1745247588.366 [Startup:StartupSatComms:B] Running Loop=1
2025-04-21T14:59:48.687Z,1745247588.687 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T14:59:48.751Z,1745247588.751 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-21T14:59:55.626Z,1745247595.626 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250418T202617/Courier0010.lzma
2025-04-21T14:59:56.627Z,1745247596.627 [DataOverHttps](INFO): Moved sent file to Logs/20250418T202617/Courier0010.lzma.bak
2025-04-21T14:59:56.627Z,1745247596.627 [DataOverHttps](INFO): SBD MOMSN=24697901
2025-04-21T14:59:59.192Z,1745247599.192 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-04-21T15:00:06.061Z,1745247606.061 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T15:00:11.770Z,1745247611.770 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T15:00:12.277Z,1745247612.277 [DataOverHttps](INFO): Sending 244 bytes from file Logs/20250421T145250/Courier0000.lzma
2025-04-21T15:00:13.279Z,1745247613.279 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145250/Courier0000.lzma.bak
2025-04-21T15:00:13.279Z,1745247613.279 [DataOverHttps](INFO): SBD MOMSN=24697903
2025-04-21T15:00:23.029Z,1745247623.029 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T15:00:26.262Z,1745247626.262 [BPC1](ERROR): BPC1B failed to parse battery stick message.
2025-04-21T15:00:28.977Z,1745247628.977 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20250421T145539/Courier0000.lzma
2025-04-21T15:00:29.978Z,1745247629.978 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0000.lzma.bak
2025-04-21T15:00:29.979Z,1745247629.979 [DataOverHttps](INFO): SBD MOMSN=24697908
2025-04-21T15:00:39.187Z,1745247639.187 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2025-04-21T15:00:45.588Z,1745247645.588 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20250418T202617/Express0011.lzma
2025-04-21T15:00:46.591Z,1745247646.591 [DataOverHttps](INFO): Moved sent file to Logs/20250418T202617/Express0011.lzma.bak
2025-04-21T15:00:46.591Z,1745247646.591 [DataOverHttps](INFO): SBD MOMSN=24697914
2025-04-21T15:00:48.490Z,1745247648.490 [Startup:StartupSatComms:B](INFO): Timed out from 2025-04-21T14:59:48.4Z
2025-04-21T15:00:48.490Z,1745247648.490 [Startup:StartupSatComms:B] Stopped
2025-04-21T15:00:48.490Z,1745247648.490 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-04-21T15:00:48.491Z,1745247648.491 [Startup:StartupSatComms] Stopped
2025-04-21T15:00:48.491Z,1745247648.491 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-04-21T15:00:48.492Z,1745247648.492 [Startup](INFO): Completed Startup
2025-04-21T15:00:48.492Z,1745247648.492 [MissionManager](INFO): Startup is completed.
2025-04-21T15:00:48.492Z,1745247648.492 [MissionManager](INFO): Uninitializing Mission Startup
2025-04-21T15:00:48.492Z,1745247648.492 [Startup] Stopped
2025-04-21T15:00:48.492Z,1745247648.492 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-04-21T15:00:48.492Z,1745247648.492 [Startup:A.GoToSurface] Stopped
2025-04-21T15:00:48.492Z,1745247648.492 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T15:00:48.899Z,1745247648.899 [MissionManager](IMPORTANT): Started mission Default
2025-04-21T15:00:48.899Z,1745247648.899 [Default] Running Loop=1
2025-04-21T15:00:48.899Z,1745247648.899 [Default](DEBUG): Aggregate::initialize Default
2025-04-21T15:00:48.899Z,1745247648.899 [Default:B.GoToSurface] Running Loop=1
2025-04-21T15:00:48.899Z,1745247648.899 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T15:00:48.900Z,1745247648.900 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-21T15:00:48.900Z,1745247648.900 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-21T15:00:48.900Z,1745247648.900 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-21T15:00:48.900Z,1745247648.900 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-21T15:00:48.901Z,1745247648.901 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T15:00:48.901Z,1745247648.901 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T15:00:48.902Z,1745247648.902 [Default:A.Wait] Running Loop=1
2025-04-21T15:00:48.902Z,1745247648.902 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-21T15:01:02.259Z,1745247662.259 [Default:A.Wait](INFO): Done Waiting.
2025-04-21T15:01:02.259Z,1745247662.259 [Default:A.Wait] Stopped
2025-04-21T15:01:02.259Z,1745247662.259 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T15:01:02.647Z,1745247662.647 [Default:CheckIn] Running Loop=1
2025-04-21T15:01:02.648Z,1745247662.648 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T15:01:02.648Z,1745247662.648 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T15:01:03.035Z,1745247663.035 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-21T15:01:14.009Z,1745247674.009 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-04-21T15:01:29.443Z,1745247689.443 [DataOverHttps](INFO): Sending 1033 bytes from file Logs/20250421T145250/Express0001.lzma
2025-04-21T15:01:30.442Z,1745247690.442 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145250/Express0001.lzma.bak
2025-04-21T15:01:30.443Z,1745247690.443 [DataOverHttps](INFO): SBD MOMSN=24697924
2025-04-21T15:01:34.138Z,1745247694.138 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-21T15:01:52.349Z,1745247712.349 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-04-21T15:01:52.349Z,1745247712.349 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:01:52.360Z,1745247712.360 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:01:52.739Z,1745247712.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:01:52.739Z,1745247712.739 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-04-21T15:01:57.177Z,1745247717.177 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-21T15:01:57.204Z,1745247717.204 [BPC1](INFO): Calculating totals. Valid battery stick count: 46. Valid reserve battery stick count: 4.
2025-04-21T15:01:57.207Z,1745247717.207 [BPC1](INFO): Received data from all battery sticks.
2025-04-21T15:04:53.321Z,1745247893.321 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-04-21T15:04:53.322Z,1745247893.322 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:04:53.332Z,1745247893.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:04:53.739Z,1745247893.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:04:53.739Z,1745247893.739 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-04-21T15:05:53.109Z,1745247953.109 [Power24vConverter](INFO): Powering down.
2025-04-21T15:06:02.823Z,1745247962.823 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T15:01:02.6Z
2025-04-21T15:06:02.823Z,1745247962.823 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T15:06:02.823Z,1745247962.823 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T15:06:03.231Z,1745247963.231 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-21T15:06:10.429Z,1745247970.429 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250421T145539/Courier0004.lzma
2025-04-21T15:06:11.431Z,1745247971.431 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0004.lzma.bak
2025-04-21T15:06:11.431Z,1745247971.431 [DataOverHttps](INFO): SBD MOMSN=24697953
2025-04-21T15:06:26.282Z,1745247986.282 [DataOverHttps](INFO): Sending 1147 bytes from file Logs/20250421T145539/Express0001.lzma
2025-04-21T15:06:27.271Z,1745247987.271 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0001.lzma.bak
2025-04-21T15:06:27.271Z,1745247987.271 [DataOverHttps](INFO): SBD MOMSN=24697955
2025-04-21T15:06:33.502Z,1745247993.502 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T15:06:33.502Z,1745247993.502 [NAL9602] Data Fault, FailCount= 1
2025-04-21T15:06:33.502Z,1745247993.502 [NAL9602](ERROR): Data Fault
2025-04-21T15:06:33.544Z,1745247993.544 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T15:06:33.906Z,1745247993.906 [NAL9602](INFO): Powering down
2025-04-21T15:06:34.726Z,1745247994.726 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T15:06:34.727Z,1745247994.727 [NAL9602] No Fault, FailCount= 1
2025-04-21T15:06:42.661Z,1745248002.661 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20250421T145539/Express0005.lzma
2025-04-21T15:06:43.662Z,1745248003.662 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0005.lzma.bak
2025-04-21T15:06:43.663Z,1745248003.663 [DataOverHttps](INFO): SBD MOMSN=24697990
2025-04-21T15:06:44.823Z,1745248004.823 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T15:06:44.823Z,1745248004.823 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T15:06:44.823Z,1745248004.823 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T15:07:04.206Z,1745248024.206 [NAL9602](INFO): Powering up NAL9602
2025-04-21T15:07:15.114Z,1745248035.114 [NAL9602](INFO): NAL9602 initialized
2025-04-21T15:07:54.308Z,1745248074.308 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-04-21T15:07:54.308Z,1745248074.308 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:07:54.319Z,1745248074.319 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:07:54.728Z,1745248074.728 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:07:54.728Z,1745248074.728 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-04-21T15:10:52.497Z,1745248252.497 [CBIT](INFO): Clearing failed state for component DropWeight
2025-04-21T15:10:52.497Z,1745248252.497 [DropWeight] No Fault, FailCount= 1
2025-04-21T15:10:55.321Z,1745248255.321 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-04-21T15:10:55.321Z,1745248255.321 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:10:55.377Z,1745248255.377 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:10:55.764Z,1745248255.764 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:10:55.764Z,1745248255.764 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-04-21T15:11:45.415Z,1745248305.415 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T15:11:45.415Z,1745248305.415 [Default:CheckIn:C.Wait] Stopped
2025-04-21T15:11:45.415Z,1745248305.415 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T15:11:45.415Z,1745248305.415 [Default:CheckIn:D] Running Loop=1
2025-04-21T15:11:45.809Z,1745248305.809 [Default:CheckIn:D] Stopped
2025-04-21T15:11:45.809Z,1745248305.809 [Default:CheckIn:E] Running Loop=1
2025-04-21T15:11:46.206Z,1745248306.206 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.948495 min
2025-04-21T15:11:46.206Z,1745248306.206 [Default:CheckIn:E] Stopped
2025-04-21T15:11:46.206Z,1745248306.206 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T15:11:46.206Z,1745248306.206 [Default:CheckIn] Stopped
2025-04-21T15:11:46.206Z,1745248306.206 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T15:11:46.206Z,1745248306.206 [Default:CheckIn](INFO): Running loop #2
2025-04-21T15:11:46.207Z,1745248306.207 [Default:CheckIn] Running Loop=2
2025-04-21T15:11:46.207Z,1745248306.207 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T15:11:46.207Z,1745248306.207 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T15:13:56.341Z,1745248436.341 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-04-21T15:13:56.341Z,1745248436.341 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:13:56.353Z,1745248436.353 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:13:56.773Z,1745248436.773 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:13:56.773Z,1745248436.773 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-04-21T15:16:46.420Z,1745248606.420 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T15:11:46.2Z
2025-04-21T15:16:46.420Z,1745248606.420 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T15:16:46.420Z,1745248606.420 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T15:16:52.288Z,1745248612.288 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250421T145539/Courier0007.lzma
2025-04-21T15:16:53.290Z,1745248613.290 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0007.lzma.bak
2025-04-21T15:16:53.290Z,1745248613.290 [DataOverHttps](INFO): SBD MOMSN=24698033
2025-04-21T15:16:57.324Z,1745248617.324 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2025-04-21T15:16:57.324Z,1745248617.324 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:16:57.362Z,1745248617.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:16:57.735Z,1745248617.735 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:16:57.736Z,1745248617.736 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2025-04-21T15:17:08.840Z,1745248628.840 [DataOverHttps](INFO): Sending 183 bytes from file Logs/20250421T145539/Express0008.lzma
2025-04-21T15:17:09.843Z,1745248629.843 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0008.lzma.bak
2025-04-21T15:17:09.843Z,1745248629.843 [DataOverHttps](INFO): SBD MOMSN=24698035
2025-04-21T15:17:11.066Z,1745248631.066 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T15:17:11.066Z,1745248631.066 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T15:17:11.067Z,1745248631.067 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T15:17:16.694Z,1745248636.694 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T15:17:16.694Z,1745248636.694 [NAL9602] Data Fault, FailCount= 2
2025-04-21T15:17:16.694Z,1745248636.694 [NAL9602](ERROR): Data Fault
2025-04-21T15:17:16.711Z,1745248636.711 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T15:17:17.106Z,1745248637.106 [NAL9602](INFO): Powering down
2025-04-21T15:17:17.939Z,1745248637.939 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T15:17:17.939Z,1745248637.939 [NAL9602] No Fault, FailCount= 2
2025-04-21T15:17:47.392Z,1745248667.392 [NAL9602](INFO): Powering up NAL9602
2025-04-21T15:17:58.302Z,1745248678.302 [NAL9602](INFO): NAL9602 initialized
2025-04-21T15:18:03.264Z,1745248683.264 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2025-04-21T15:18:18.266Z,1745248698.266 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2025-04-21T15:19:39.040Z,1745248779.040 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2025-04-21T15:19:44.865Z,1745248784.865 [CommandExec](IMPORTANT): got command failComponent
2025-04-21T15:19:44.865Z,1745248784.865 [CommandExec](IMPORTANT): Failed components:
2025-04-21T15:19:44.865Z,1745248784.865 [CommandExec](IMPORTANT): No failed Components.
2025-04-21T15:19:58.309Z,1745248798.309 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2025-04-21T15:19:58.309Z,1745248798.309 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:19:58.320Z,1745248798.320 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:19:58.721Z,1745248798.721 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:19:58.721Z,1745248798.721 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2025-04-21T15:22:11.464Z,1745248931.464 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T15:22:11.465Z,1745248931.465 [Default:CheckIn:C.Wait] Stopped
2025-04-21T15:22:11.465Z,1745248931.465 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T15:22:11.465Z,1745248931.465 [Default:CheckIn:D] Running Loop=1
2025-04-21T15:22:11.878Z,1745248931.878 [Default:CheckIn:D] Stopped
2025-04-21T15:22:11.878Z,1745248931.878 [Default:CheckIn:E] Running Loop=1
2025-04-21T15:22:12.275Z,1745248932.275 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.382987 min
2025-04-21T15:22:12.275Z,1745248932.275 [Default:CheckIn:E] Stopped
2025-04-21T15:22:12.275Z,1745248932.275 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T15:22:12.275Z,1745248932.275 [Default:CheckIn] Stopped
2025-04-21T15:22:12.275Z,1745248932.275 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T15:22:12.275Z,1745248932.275 [Default:CheckIn](INFO): Running loop #3
2025-04-21T15:22:12.275Z,1745248932.275 [Default:CheckIn] Running Loop=3
2025-04-21T15:22:12.276Z,1745248932.276 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T15:22:12.276Z,1745248932.276 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T15:22:50.163Z,1745248970.163 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2025-04-21T15:22:59.167Z,1745248979.167 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2025-04-21T15:22:59.167Z,1745248979.167 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:22:59.210Z,1745248979.210 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:22:59.574Z,1745248979.574 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:22:59.574Z,1745248979.574 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2025-04-21T15:23:03.114Z,1745248983.114 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2025-04-21T15:23:18.324Z,1745248998.324 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2025-04-21T15:23:31.447Z,1745249011.447 [CommandExec](IMPORTANT): got command gfscan
2025-04-21T15:23:31.488Z,1745249011.488 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-21T15:23:32.677Z,1745249012.677 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-21T15:23:35.916Z,1745249015.916 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.003760
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.004113
CHAN A3 (5V): -0.002951
CHAN B0 (3.3V): -0.001525
CHAN B1 (3.15aV): -0.001126
CHAN B2 (3.15bV): -0.001262
CHAN B3 (GND): -0.000404
OPEN: 0.005005
Full Scale: +/- 1 mA
2025-04-21T15:26:00.131Z,1745249160.131 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2025-04-21T15:26:00.131Z,1745249160.131 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:26:00.142Z,1745249160.142 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:26:00.554Z,1745249160.554 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:26:00.554Z,1745249160.554 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2025-04-21T15:27:12.447Z,1745249232.447 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T15:22:12.3Z
2025-04-21T15:27:12.447Z,1745249232.447 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T15:27:12.448Z,1745249232.448 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T15:27:18.645Z,1745249238.645 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250421T145539/Courier0010.lzma
2025-04-21T15:27:19.648Z,1745249239.648 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0010.lzma.bak
2025-04-21T15:27:19.648Z,1745249239.648 [DataOverHttps](INFO): SBD MOMSN=24698100
2025-04-21T15:27:35.067Z,1745249255.067 [DataOverHttps](INFO): Sending 479 bytes from file Logs/20250421T145539/Express0011.lzma
2025-04-21T15:27:36.067Z,1745249256.067 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0011.lzma.bak
2025-04-21T15:27:36.068Z,1745249256.068 [DataOverHttps](INFO): SBD MOMSN=24698102
2025-04-21T15:27:37.508Z,1745249257.508 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T15:27:37.508Z,1745249257.508 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T15:27:37.508Z,1745249257.508 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T15:28:00.919Z,1745249280.919 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T15:28:00.919Z,1745249280.919 [NAL9602] Data Fault, FailCount= 3
2025-04-21T15:28:00.919Z,1745249280.919 [NAL9602](ERROR): Data Fault
2025-04-21T15:28:00.965Z,1745249280.965 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T15:28:01.323Z,1745249281.323 [NAL9602](INFO): Powering down
2025-04-21T15:28:02.148Z,1745249282.148 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T15:28:02.148Z,1745249282.148 [NAL9602] No Fault, FailCount= 3
2025-04-21T15:28:31.380Z,1745249311.380 [NAL9602](INFO): Powering up NAL9602
2025-04-21T15:28:42.291Z,1745249322.291 [NAL9602](INFO): NAL9602 initialized
2025-04-21T15:29:01.307Z,1745249341.307 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2025-04-21T15:29:01.307Z,1745249341.307 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:29:01.318Z,1745249341.318 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:29:01.725Z,1745249341.725 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:29:01.725Z,1745249341.725 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2025-04-21T15:32:02.278Z,1745249522.278 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2025-04-21T15:32:02.278Z,1745249522.278 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:32:02.305Z,1745249522.305 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:32:02.691Z,1745249522.691 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:32:02.691Z,1745249522.691 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2025-04-21T15:32:38.235Z,1745249558.235 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T15:32:38.235Z,1745249558.235 [Default:CheckIn:C.Wait] Stopped
2025-04-21T15:32:38.235Z,1745249558.235 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T15:32:38.236Z,1745249558.236 [Default:CheckIn:D] Running Loop=1
2025-04-21T15:32:38.639Z,1745249558.639 [Default:CheckIn:D] Stopped
2025-04-21T15:32:38.639Z,1745249558.639 [Default:CheckIn:E] Running Loop=1
2025-04-21T15:32:39.041Z,1745249559.041 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.828994 min
2025-04-21T15:32:39.041Z,1745249559.041 [Default:CheckIn:E] Stopped
2025-04-21T15:32:39.042Z,1745249559.042 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T15:32:39.042Z,1745249559.042 [Default:CheckIn] Stopped
2025-04-21T15:32:39.042Z,1745249559.042 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T15:32:39.042Z,1745249559.042 [Default:CheckIn](INFO): Running loop #4
2025-04-21T15:32:39.042Z,1745249559.042 [Default:CheckIn] Running Loop=4
2025-04-21T15:32:39.042Z,1745249559.042 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T15:32:39.042Z,1745249559.042 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T15:35:03.274Z,1745249703.274 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2025-04-21T15:35:03.274Z,1745249703.274 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:35:03.285Z,1745249703.285 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:35:03.691Z,1745249703.691 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:35:03.691Z,1745249703.691 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2025-04-21T15:37:39.219Z,1745249859.219 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T15:32:39.0Z
2025-04-21T15:37:39.219Z,1745249859.219 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T15:37:39.219Z,1745249859.219 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T15:37:44.349Z,1745249864.349 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250421T145539/Courier0013.lzma
2025-04-21T15:37:45.351Z,1745249865.351 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0013.lzma.bak
2025-04-21T15:37:45.352Z,1745249865.352 [DataOverHttps](INFO): SBD MOMSN=24698207
2025-04-21T15:38:00.818Z,1745249880.818 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250421T145539/Express0014.lzma
2025-04-21T15:38:01.819Z,1745249881.819 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0014.lzma.bak
2025-04-21T15:38:01.820Z,1745249881.820 [DataOverHttps](INFO): SBD MOMSN=24698209
2025-04-21T15:38:03.072Z,1745249883.072 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T15:38:03.072Z,1745249883.072 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T15:38:03.072Z,1745249883.072 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T15:38:04.370Z,1745249884.370 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2025-04-21T15:38:04.370Z,1745249884.370 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:38:04.401Z,1745249884.401 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:38:04.740Z,1745249884.740 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:38:04.740Z,1745249884.740 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2025-04-21T15:38:45.067Z,1745249925.067 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T15:38:45.067Z,1745249925.067 [NAL9602] Data Fault, FailCount= 4
2025-04-21T15:38:45.067Z,1745249925.067 [NAL9602](ERROR): Data Fault
2025-04-21T15:38:45.090Z,1745249925.090 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T15:38:45.468Z,1745249925.468 [NAL9602](INFO): Powering down
2025-04-21T15:38:46.297Z,1745249926.297 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T15:38:46.297Z,1745249926.297 [NAL9602] No Fault, FailCount= 4
2025-04-21T15:39:15.779Z,1745249955.779 [NAL9602](INFO): Powering up NAL9602
2025-04-21T15:39:26.679Z,1745249966.679 [NAL9602](INFO): NAL9602 initialized
2025-04-21T15:40:53.943Z,1745250053.943 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-04-21T15:40:53.943Z,1745250053.943 [DropWeight] Hardware Fault, FailCount= 1
2025-04-21T15:40:53.943Z,1745250053.943 [DropWeight](ERROR): Hardware Fault
2025-04-21T15:40:54.007Z,1745250054.007 [CBIT](INFO): Critical error at 20250421T154053
2025-04-21T15:40:54.009Z,1745250054.009 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-04-21T15:40:54.018Z,1745250054.018 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-04-21T15:40:54.359Z,1745250054.359 [CBIT](INFO): Critical error at 20250421T154054
2025-04-21T15:41:05.272Z,1745250065.272 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2025-04-21T15:41:05.272Z,1745250065.272 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:41:05.304Z,1745250065.304 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:41:05.689Z,1745250065.689 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:41:05.689Z,1745250065.689 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2025-04-21T15:41:35.890Z,1745250095.890 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2025-04-21T15:43:03.826Z,1745250183.826 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T15:43:03.826Z,1745250183.826 [Default:CheckIn:C.Wait] Stopped
2025-04-21T15:43:03.826Z,1745250183.826 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T15:43:03.826Z,1745250183.826 [Default:CheckIn:D] Running Loop=1
2025-04-21T15:43:04.221Z,1745250184.221 [Default:CheckIn:D] Stopped
2025-04-21T15:43:04.221Z,1745250184.221 [Default:CheckIn:E] Running Loop=1
2025-04-21T15:43:04.618Z,1745250184.618 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.255367 min
2025-04-21T15:43:04.618Z,1745250184.618 [Default:CheckIn:E] Stopped
2025-04-21T15:43:04.618Z,1745250184.618 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T15:43:04.618Z,1745250184.618 [Default:CheckIn] Stopped
2025-04-21T15:43:04.618Z,1745250184.618 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T15:43:04.618Z,1745250184.618 [Default:CheckIn](INFO): Running loop #5
2025-04-21T15:43:04.618Z,1745250184.618 [Default:CheckIn] Running Loop=5
2025-04-21T15:43:04.618Z,1745250184.618 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T15:43:04.619Z,1745250184.619 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T15:44:06.464Z,1745250246.464 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2025-04-21T15:44:06.464Z,1745250246.464 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:44:06.475Z,1745250246.475 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:44:06.880Z,1745250246.880 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:44:06.880Z,1745250246.880 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2025-04-21T15:44:11.929Z,1745250251.929 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2025-04-21T15:44:27.567Z,1745250267.567 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2025-04-21T15:45:19.712Z,1745250319.712 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree
2025-04-21T15:45:19.716Z,1745250319.716 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread.
2025-04-21T15:45:19.973Z,1745250319.973 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-21T15:45:41.936Z,1745250341.936 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree
2025-04-21T15:46:14.302Z,1745250374.302 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 0 degree
2025-04-21T15:47:07.431Z,1745250427.431 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2025-04-21T15:47:07.431Z,1745250427.431 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:47:07.442Z,1745250427.442 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:47:07.848Z,1745250427.848 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:47:07.848Z,1745250427.848 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2025-04-21T15:48:04.793Z,1745250484.793 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T15:43:04.6Z
2025-04-21T15:48:04.793Z,1745250484.793 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T15:48:04.793Z,1745250484.793 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T15:48:09.787Z,1745250489.787 [DataOverHttps](INFO): Sending 117 bytes from file Logs/20250421T145539/Courier0016.lzma
2025-04-21T15:48:10.790Z,1745250490.790 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0016.lzma.bak
2025-04-21T15:48:10.790Z,1745250490.790 [DataOverHttps](INFO): SBD MOMSN=24698261
2025-04-21T15:48:26.752Z,1745250506.752 [DataOverHttps](INFO): Sending 278 bytes from file Logs/20250421T145539/Express0017.lzma
2025-04-21T15:48:27.753Z,1745250507.753 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0017.lzma.bak
2025-04-21T15:48:27.754Z,1745250507.754 [DataOverHttps](INFO): SBD MOMSN=24698265
2025-04-21T15:48:29.101Z,1745250509.101 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T15:48:29.101Z,1745250509.101 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T15:48:29.101Z,1745250509.101 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T15:49:29.265Z,1745250569.265 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T15:49:29.266Z,1745250569.266 [NAL9602] Data Fault, FailCount= 5
2025-04-21T15:49:29.266Z,1745250569.266 [NAL9602](ERROR): Data Fault
2025-04-21T15:49:29.284Z,1745250569.284 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T15:49:29.285Z,1745250569.285 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-04-21T15:49:29.665Z,1745250569.665 [NAL9602](INFO): Powering down
2025-04-21T15:49:29.707Z,1745250569.707 [CBIT](INFO): Critical error at 20250421T154929
2025-04-21T15:50:08.455Z,1745250608.455 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2025-04-21T15:50:08.455Z,1745250608.455 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:50:08.466Z,1745250608.466 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:50:08.881Z,1745250608.881 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:50:08.881Z,1745250608.881 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2025-04-21T15:51:29.524Z,1745250689.524 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T15:51:29.524Z,1745250689.524 [NAL9602] No Fault, FailCount= 5
2025-04-21T15:51:29.877Z,1745250689.877 [NAL9602](INFO): Powering up NAL9602
2025-04-21T15:51:40.779Z,1745250700.779 [NAL9602](INFO): NAL9602 initialized
2025-04-21T15:53:09.667Z,1745250789.667 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2025-04-21T15:53:09.667Z,1745250789.667 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:53:09.678Z,1745250789.678 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:53:10.082Z,1745250790.082 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:53:10.082Z,1745250790.082 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2025-04-21T15:53:29.867Z,1745250809.867 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T15:53:29.867Z,1745250809.867 [Default:CheckIn:C.Wait] Stopped
2025-04-21T15:53:29.867Z,1745250809.867 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T15:53:29.867Z,1745250809.867 [Default:CheckIn:D] Running Loop=1
2025-04-21T15:53:30.272Z,1745250810.272 [Default:CheckIn:D] Stopped
2025-04-21T15:53:30.272Z,1745250810.272 [Default:CheckIn:E] Running Loop=1
2025-04-21T15:53:30.689Z,1745250810.689 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.689555 min
2025-04-21T15:53:30.689Z,1745250810.689 [Default:CheckIn:E] Stopped
2025-04-21T15:53:30.689Z,1745250810.689 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T15:53:30.689Z,1745250810.689 [Default:CheckIn] Stopped
2025-04-21T15:53:30.689Z,1745250810.689 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T15:53:30.690Z,1745250810.690 [Default:CheckIn](INFO): Running loop #6
2025-04-21T15:53:30.690Z,1745250810.690 [Default:CheckIn] Running Loop=6
2025-04-21T15:53:30.690Z,1745250810.690 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T15:53:30.690Z,1745250810.690 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T15:55:54.110Z,1745250954.110 [CBIT](INFO): Clearing failed state for component DropWeight
2025-04-21T15:55:54.110Z,1745250954.110 [DropWeight] No Fault, FailCount= 1
2025-04-21T15:56:10.730Z,1745250970.730 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2025-04-21T15:56:10.731Z,1745250970.731 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:56:10.742Z,1745250970.742 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:56:11.095Z,1745250971.095 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:56:11.095Z,1745250971.095 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2025-04-21T15:58:30.848Z,1745251110.848 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T15:53:30.7Z
2025-04-21T15:58:30.848Z,1745251110.848 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T15:58:30.848Z,1745251110.848 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T15:58:36.458Z,1745251116.458 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20250421T145539/Courier0019.lzma
2025-04-21T15:58:37.460Z,1745251117.460 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0019.lzma.bak
2025-04-21T15:58:37.460Z,1745251117.460 [DataOverHttps](INFO): SBD MOMSN=24698299
2025-04-21T15:58:52.958Z,1745251132.958 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250421T145539/Express0020.lzma
2025-04-21T15:58:53.960Z,1745251133.960 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0020.lzma.bak
2025-04-21T15:58:53.960Z,1745251133.960 [DataOverHttps](INFO): SBD MOMSN=24698302
2025-04-21T15:58:55.109Z,1745251135.109 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T15:58:55.109Z,1745251135.109 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T15:58:55.109Z,1745251135.109 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T15:59:11.651Z,1745251151.651 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2025-04-21T15:59:11.651Z,1745251151.651 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T15:59:11.663Z,1745251151.663 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T15:59:12.071Z,1745251152.071 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T15:59:12.072Z,1745251152.072 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2025-04-21T16:01:42.534Z,1745251302.534 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T16:01:42.534Z,1745251302.534 [NAL9602] Data Fault, FailCount= 1
2025-04-21T16:01:42.534Z,1745251302.534 [NAL9602](ERROR): Data Fault
2025-04-21T16:01:42.588Z,1745251302.588 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T16:01:42.937Z,1745251302.937 [NAL9602](INFO): Powering down
2025-04-21T16:01:43.779Z,1745251303.779 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T16:01:43.779Z,1745251303.779 [NAL9602] No Fault, FailCount= 1
2025-04-21T16:02:12.843Z,1745251332.843 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22
2025-04-21T16:02:12.843Z,1745251332.843 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:02:12.883Z,1745251332.883 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:02:13.241Z,1745251333.241 [NAL9602](INFO): Powering up NAL9602
2025-04-21T16:02:13.259Z,1745251333.259 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:02:13.259Z,1745251333.259 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22
2025-04-21T16:02:24.149Z,1745251344.149 [NAL9602](INFO): NAL9602 initialized
2025-04-21T16:03:17.123Z,1745251397.123 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T16:03:55.865Z,1745251435.865 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T16:03:55.866Z,1745251435.866 [Default:CheckIn:C.Wait] Stopped
2025-04-21T16:03:55.866Z,1745251435.866 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:03:55.866Z,1745251435.866 [Default:CheckIn:D] Running Loop=1
2025-04-21T16:03:56.269Z,1745251436.269 [Default:CheckIn:D] Stopped
2025-04-21T16:03:56.269Z,1745251436.269 [Default:CheckIn:E] Running Loop=1
2025-04-21T16:03:56.694Z,1745251436.694 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.122831 min
2025-04-21T16:03:56.694Z,1745251436.694 [Default:CheckIn:E] Stopped
2025-04-21T16:03:56.694Z,1745251436.694 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T16:03:56.695Z,1745251436.695 [Default:CheckIn] Stopped
2025-04-21T16:03:56.695Z,1745251436.695 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T16:03:56.695Z,1745251436.695 [Default:CheckIn](INFO): Running loop #7
2025-04-21T16:03:56.695Z,1745251436.695 [Default:CheckIn] Running Loop=7
2025-04-21T16:03:56.695Z,1745251436.695 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T16:03:56.695Z,1745251436.695 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:03:57.930Z,1745251437.930 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-04-21T16:04:12.071Z,1745251452.071 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-04-21T16:04:56.454Z,1745251496.454 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T16:05:02.581Z,1745251502.581 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T16:05:12.255Z,1745251512.255 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-04-21T16:05:13.847Z,1745251513.847 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23
2025-04-21T16:05:13.847Z,1745251513.847 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:05:13.861Z,1745251513.861 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:05:14.270Z,1745251514.270 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:05:14.270Z,1745251514.270 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23
2025-04-21T16:05:29.985Z,1745251529.985 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T16:05:47.363Z,1745251547.363 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T16:05:59.540Z,1745251559.540 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T16:06:04.330Z,1745251564.330 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T16:06:21.298Z,1745251581.298 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T16:06:38.670Z,1745251598.670 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T16:06:55.234Z,1745251615.234 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T16:07:11.394Z,1745251631.394 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2025-04-21T16:07:44.004Z,1745251664.004 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T16:08:02.135Z,1745251682.135 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-21T16:08:02.142Z,1745251682.142 [BPC1](INFO): Calculating totals. Valid battery stick count: 45. Valid reserve battery stick count: 4.
2025-04-21T16:08:02.144Z,1745251682.144 [BPC1](INFO): Received data from all battery sticks.
2025-04-21T16:08:14.683Z,1745251694.683 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24
2025-04-21T16:08:14.683Z,1745251694.683 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:08:14.694Z,1745251694.694 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:08:15.093Z,1745251695.093 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:08:15.093Z,1745251695.093 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24
2025-04-21T16:08:56.708Z,1745251736.708 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T16:03:56.7Z
2025-04-21T16:08:56.708Z,1745251736.708 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T16:08:56.708Z,1745251736.708 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T16:09:02.497Z,1745251742.497 [DataOverHttps](INFO): Sending 49 bytes from file Logs/20250421T145539/Courier0022.lzma
2025-04-21T16:09:03.499Z,1745251743.499 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0022.lzma.bak
2025-04-21T16:09:03.500Z,1745251743.500 [DataOverHttps](INFO): SBD MOMSN=24698334
2025-04-21T16:09:18.970Z,1745251758.970 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250421T145539/Express0023.lzma
2025-04-21T16:09:19.972Z,1745251759.972 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0023.lzma.bak
2025-04-21T16:09:19.972Z,1745251759.972 [DataOverHttps](INFO): SBD MOMSN=24698336
2025-04-21T16:09:21.336Z,1745251761.336 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T16:09:21.336Z,1745251761.336 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T16:09:21.336Z,1745251761.336 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:11:15.667Z,1745251875.667 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25
2025-04-21T16:11:15.667Z,1745251875.667 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:11:15.704Z,1745251875.704 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:11:16.064Z,1745251876.064 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:11:16.064Z,1745251876.064 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25
2025-04-21T16:12:26.747Z,1745251946.747 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T16:12:26.748Z,1745251946.748 [NAL9602] Data Fault, FailCount= 2
2025-04-21T16:12:26.748Z,1745251946.748 [NAL9602](ERROR): Data Fault
2025-04-21T16:12:26.765Z,1745251946.765 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T16:12:27.147Z,1745251947.147 [NAL9602](INFO): Powering down
2025-04-21T16:12:27.976Z,1745251947.976 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T16:12:27.976Z,1745251947.976 [NAL9602] No Fault, FailCount= 2
2025-04-21T16:12:57.447Z,1745251977.447 [NAL9602](INFO): Powering up NAL9602
2025-04-21T16:13:08.360Z,1745251988.360 [NAL9602](INFO): NAL9602 initialized
2025-04-21T16:14:16.642Z,1745252056.642 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26
2025-04-21T16:14:16.642Z,1745252056.642 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:14:16.677Z,1745252056.677 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:14:17.056Z,1745252057.056 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:14:17.056Z,1745252057.056 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26
2025-04-21T16:14:21.909Z,1745252061.909 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T16:14:21.909Z,1745252061.909 [Default:CheckIn:C.Wait] Stopped
2025-04-21T16:14:21.909Z,1745252061.909 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:14:21.909Z,1745252061.909 [Default:CheckIn:D] Running Loop=1
2025-04-21T16:14:22.295Z,1745252062.295 [Default:CheckIn:D] Stopped
2025-04-21T16:14:22.295Z,1745252062.295 [Default:CheckIn:E] Running Loop=1
2025-04-21T16:14:22.710Z,1745252062.710 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.556600 min
2025-04-21T16:14:22.710Z,1745252062.710 [Default:CheckIn:E] Stopped
2025-04-21T16:14:22.710Z,1745252062.710 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T16:14:22.710Z,1745252062.710 [Default:CheckIn] Stopped
2025-04-21T16:14:22.710Z,1745252062.710 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T16:14:22.710Z,1745252062.710 [Default:CheckIn](INFO): Running loop #8
2025-04-21T16:14:22.710Z,1745252062.710 [Default:CheckIn] Running Loop=8
2025-04-21T16:14:22.710Z,1745252062.710 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T16:14:22.711Z,1745252062.711 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:17:17.641Z,1745252237.641 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27
2025-04-21T16:17:17.641Z,1745252237.641 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:17:17.685Z,1745252237.685 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:17:18.062Z,1745252238.062 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:17:18.062Z,1745252238.062 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27
2025-04-21T16:19:22.894Z,1745252362.894 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T16:14:22.7Z
2025-04-21T16:19:22.894Z,1745252362.894 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T16:19:22.894Z,1745252362.894 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T16:19:28.163Z,1745252368.163 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250421T145539/Courier0025.lzma
2025-04-21T16:19:29.166Z,1745252369.166 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0025.lzma.bak
2025-04-21T16:19:29.166Z,1745252369.166 [DataOverHttps](INFO): SBD MOMSN=24698364
2025-04-21T16:19:44.619Z,1745252384.619 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250421T145539/Express0026.lzma
2025-04-21T16:19:45.621Z,1745252385.621 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0026.lzma.bak
2025-04-21T16:19:45.621Z,1745252385.621 [DataOverHttps](INFO): SBD MOMSN=24698366
2025-04-21T16:19:47.124Z,1745252387.124 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T16:19:47.124Z,1745252387.124 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T16:19:47.124Z,1745252387.124 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:20:18.633Z,1745252418.633 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28
2025-04-21T16:20:18.633Z,1745252418.633 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:20:18.645Z,1745252418.645 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:20:19.062Z,1745252419.062 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:20:19.062Z,1745252419.062 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28
2025-04-21T16:23:11.121Z,1745252591.121 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T16:23:11.121Z,1745252591.121 [NAL9602] Data Fault, FailCount= 3
2025-04-21T16:23:11.121Z,1745252591.121 [NAL9602](ERROR): Data Fault
2025-04-21T16:23:11.168Z,1745252591.168 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T16:23:11.524Z,1745252591.524 [NAL9602](INFO): Powering down
2025-04-21T16:23:12.350Z,1745252592.350 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T16:23:12.350Z,1745252592.350 [NAL9602] No Fault, FailCount= 3
2025-04-21T16:23:19.622Z,1745252599.622 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29
2025-04-21T16:23:19.622Z,1745252599.622 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:23:19.634Z,1745252599.634 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:23:20.049Z,1745252600.049 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:23:20.049Z,1745252600.049 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29
2025-04-21T16:23:41.828Z,1745252621.828 [NAL9602](INFO): Powering up NAL9602
2025-04-21T16:23:52.737Z,1745252632.737 [NAL9602](INFO): NAL9602 initialized
2025-04-21T16:24:47.696Z,1745252687.696 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T16:24:47.696Z,1745252687.696 [Default:CheckIn:C.Wait] Stopped
2025-04-21T16:24:47.696Z,1745252687.696 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:24:47.697Z,1745252687.697 [Default:CheckIn:D] Running Loop=1
2025-04-21T16:24:48.088Z,1745252688.088 [Default:CheckIn:D] Stopped
2025-04-21T16:24:48.088Z,1745252688.088 [Default:CheckIn:E] Running Loop=1
2025-04-21T16:24:48.499Z,1745252688.499 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.986475 min
2025-04-21T16:24:48.499Z,1745252688.499 [Default:CheckIn:E] Stopped
2025-04-21T16:24:48.499Z,1745252688.499 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T16:24:48.499Z,1745252688.499 [Default:CheckIn] Stopped
2025-04-21T16:24:48.499Z,1745252688.499 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T16:24:48.499Z,1745252688.499 [Default:CheckIn](INFO): Running loop #9
2025-04-21T16:24:48.499Z,1745252688.499 [Default:CheckIn] Running Loop=9
2025-04-21T16:24:48.499Z,1745252688.499 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T16:24:48.500Z,1745252688.500 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:25:55.556Z,1745252755.556 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-04-21T16:25:55.556Z,1745252755.556 [DropWeight] Hardware Fault, FailCount= 1
2025-04-21T16:25:55.556Z,1745252755.556 [DropWeight](ERROR): Hardware Fault
2025-04-21T16:25:55.574Z,1745252755.574 [CBIT](INFO): Critical error at 20250421T162555
2025-04-21T16:25:55.576Z,1745252755.576 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-04-21T16:25:55.577Z,1745252755.577 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-04-21T16:25:55.983Z,1745252755.983 [CBIT](INFO): Critical error at 20250421T162555
2025-04-21T16:26:20.623Z,1745252780.623 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30
2025-04-21T16:26:20.623Z,1745252780.623 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:26:20.654Z,1745252780.654 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:26:21.043Z,1745252781.043 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:26:21.043Z,1745252781.043 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30
2025-04-21T16:29:21.727Z,1745252961.727 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31
2025-04-21T16:29:21.727Z,1745252961.727 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:29:21.739Z,1745252961.739 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:29:22.146Z,1745252962.146 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:29:22.146Z,1745252962.146 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31
2025-04-21T16:29:48.802Z,1745252988.802 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T16:24:48.5Z
2025-04-21T16:29:48.802Z,1745252988.802 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T16:29:48.802Z,1745252988.802 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T16:29:53.725Z,1745252993.725 [DataOverHttps](INFO): Sending 116 bytes from file Logs/20250421T145539/Courier0028.lzma
2025-04-21T16:29:54.725Z,1745252994.725 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0028.lzma.bak
2025-04-21T16:29:54.725Z,1745252994.725 [DataOverHttps](INFO): SBD MOMSN=24698391
2025-04-21T16:30:10.239Z,1745253010.239 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20250421T145539/Express0029.lzma
2025-04-21T16:30:11.241Z,1745253011.241 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0029.lzma.bak
2025-04-21T16:30:11.241Z,1745253011.241 [DataOverHttps](INFO): SBD MOMSN=24698395
2025-04-21T16:30:12.641Z,1745253012.641 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T16:30:12.641Z,1745253012.641 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T16:30:12.641Z,1745253012.641 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:32:22.739Z,1745253142.739 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32
2025-04-21T16:32:22.740Z,1745253142.740 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:32:22.751Z,1745253142.751 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:32:23.168Z,1745253143.168 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:32:23.168Z,1745253143.168 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32
2025-04-21T16:33:53.629Z,1745253233.629 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T16:33:53.629Z,1745253233.629 [NAL9602] Data Fault, FailCount= 4
2025-04-21T16:33:53.629Z,1745253233.629 [NAL9602](ERROR): Data Fault
2025-04-21T16:33:53.648Z,1745253233.648 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T16:33:54.032Z,1745253234.032 [NAL9602](INFO): Powering down
2025-04-21T16:33:54.857Z,1745253234.857 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T16:33:54.857Z,1745253234.857 [NAL9602] No Fault, FailCount= 4
2025-04-21T16:34:24.328Z,1745253264.328 [NAL9602](INFO): Powering up NAL9602
2025-04-21T16:34:35.241Z,1745253275.241 [NAL9602](INFO): NAL9602 initialized
2025-04-21T16:35:13.045Z,1745253313.045 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T16:35:13.045Z,1745253313.045 [Default:CheckIn:C.Wait] Stopped
2025-04-21T16:35:13.045Z,1745253313.045 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:35:13.045Z,1745253313.045 [Default:CheckIn:D] Running Loop=1
2025-04-21T16:35:13.449Z,1745253313.449 [Default:CheckIn:D] Stopped
2025-04-21T16:35:13.449Z,1745253313.449 [Default:CheckIn:E] Running Loop=1
2025-04-21T16:35:13.884Z,1745253313.884 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.409163 min
2025-04-21T16:35:13.884Z,1745253313.884 [Default:CheckIn:E] Stopped
2025-04-21T16:35:13.884Z,1745253313.884 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T16:35:13.885Z,1745253313.885 [Default:CheckIn] Stopped
2025-04-21T16:35:13.885Z,1745253313.885 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T16:35:13.885Z,1745253313.885 [Default:CheckIn](INFO): Running loop #10
2025-04-21T16:35:13.885Z,1745253313.885 [Default:CheckIn] Running Loop=10
2025-04-21T16:35:13.885Z,1745253313.885 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T16:35:13.885Z,1745253313.885 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:35:23.950Z,1745253323.950 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33
2025-04-21T16:35:23.951Z,1745253323.951 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:35:23.986Z,1745253323.986 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:35:24.365Z,1745253324.365 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:35:24.365Z,1745253324.365 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33
2025-04-21T16:38:24.944Z,1745253504.944 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34
2025-04-21T16:38:24.944Z,1745253504.944 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:38:24.984Z,1745253504.984 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:38:25.357Z,1745253505.357 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:38:25.357Z,1745253505.357 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34
2025-04-21T16:40:14.025Z,1745253614.025 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T16:35:13.9Z
2025-04-21T16:40:14.025Z,1745253614.025 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T16:40:14.025Z,1745253614.025 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T16:40:20.230Z,1745253620.230 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250421T145539/Courier0031.lzma
2025-04-21T16:40:21.233Z,1745253621.233 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0031.lzma.bak
2025-04-21T16:40:21.233Z,1745253621.233 [DataOverHttps](INFO): SBD MOMSN=24698419
2025-04-21T16:40:36.727Z,1745253636.727 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250421T145539/Express0032.lzma
2025-04-21T16:40:37.729Z,1745253637.729 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0032.lzma.bak
2025-04-21T16:40:37.729Z,1745253637.729 [DataOverHttps](INFO): SBD MOMSN=24698421
2025-04-21T16:40:39.097Z,1745253639.097 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T16:40:39.097Z,1745253639.097 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T16:40:39.097Z,1745253639.097 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:40:55.659Z,1745253655.659 [CBIT](INFO): Clearing failed state for component DropWeight
2025-04-21T16:40:55.659Z,1745253655.659 [DropWeight] No Fault, FailCount= 1
2025-04-21T16:41:25.935Z,1745253685.935 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35
2025-04-21T16:41:25.935Z,1745253685.935 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:41:25.946Z,1745253685.946 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:41:26.350Z,1745253686.350 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:41:26.350Z,1745253686.350 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35
2025-04-21T16:44:26.929Z,1745253866.929 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36
2025-04-21T16:44:26.929Z,1745253866.929 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:44:26.940Z,1745253866.940 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:44:27.354Z,1745253867.354 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:44:27.354Z,1745253867.354 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36
2025-04-21T16:44:37.017Z,1745253877.017 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T16:44:37.017Z,1745253877.017 [NAL9602] Data Fault, FailCount= 5
2025-04-21T16:44:37.017Z,1745253877.017 [NAL9602](ERROR): Data Fault
2025-04-21T16:44:37.064Z,1745253877.064 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T16:44:37.064Z,1745253877.064 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-04-21T16:44:37.424Z,1745253877.424 [NAL9602](INFO): Powering down
2025-04-21T16:44:37.461Z,1745253877.461 [CBIT](INFO): Critical error at 20250421T164437
2025-04-21T16:45:39.647Z,1745253939.647 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-21T16:45:39.647Z,1745253939.647 [Default:CheckIn:C.Wait] Stopped
2025-04-21T16:45:39.647Z,1745253939.647 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:45:39.648Z,1745253939.648 [Default:CheckIn:D] Running Loop=1
2025-04-21T16:45:40.060Z,1745253940.060 [Default:CheckIn:D] Stopped
2025-04-21T16:45:40.060Z,1745253940.060 [Default:CheckIn:E] Running Loop=1
2025-04-21T16:45:40.456Z,1745253940.456 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.852677 min
2025-04-21T16:45:40.456Z,1745253940.456 [Default:CheckIn:E] Stopped
2025-04-21T16:45:40.456Z,1745253940.456 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-21T16:45:40.456Z,1745253940.456 [Default:CheckIn] Stopped
2025-04-21T16:45:40.456Z,1745253940.456 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T16:45:40.457Z,1745253940.457 [Default:CheckIn](INFO): Running loop #11
2025-04-21T16:45:40.457Z,1745253940.457 [Default:CheckIn] Running Loop=11
2025-04-21T16:45:40.457Z,1745253940.457 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T16:45:40.457Z,1745253940.457 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:46:37.260Z,1745253997.260 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T16:46:37.260Z,1745253997.260 [NAL9602] No Fault, FailCount= 5
2025-04-21T16:46:37.623Z,1745253997.623 [NAL9602](INFO): Powering up NAL9602
2025-04-21T16:46:48.539Z,1745254008.539 [NAL9602](INFO): NAL9602 initialized
2025-04-21T16:47:28.154Z,1745254048.154 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 37
2025-04-21T16:47:28.154Z,1745254048.154 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:47:28.166Z,1745254048.166 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:47:28.571Z,1745254048.571 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:47:28.572Z,1745254048.572 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 37
2025-04-21T16:50:29.125Z,1745254229.125 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 38
2025-04-21T16:50:29.125Z,1745254229.125 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:50:29.137Z,1745254229.137 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:50:29.548Z,1745254229.548 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:50:29.548Z,1745254229.548 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 38
2025-04-21T16:50:40.843Z,1745254240.843 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T16:45:40.5Z
2025-04-21T16:50:40.843Z,1745254240.843 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T16:50:40.843Z,1745254240.843 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-21T16:50:46.049Z,1745254246.049 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20250421T145539/Courier0034.lzma
2025-04-21T16:50:47.051Z,1745254247.051 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Courier0034.lzma.bak
2025-04-21T16:50:47.051Z,1745254247.051 [DataOverHttps](INFO): SBD MOMSN=24698449
2025-04-21T16:51:02.565Z,1745254262.565 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250421T145539/Express0035.lzma
2025-04-21T16:51:03.567Z,1745254263.567 [DataOverHttps](INFO): Moved sent file to Logs/20250421T145539/Express0035.lzma.bak
2025-04-21T16:51:03.567Z,1745254263.567 [DataOverHttps](INFO): SBD MOMSN=24698452
2025-04-21T16:51:05.084Z,1745254265.084 [Default:CheckIn:Read_Iridium] Stopped
2025-04-21T16:51:05.084Z,1745254265.084 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-21T16:51:05.084Z,1745254265.084 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:52:58.900Z,1745254378.900 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:52:58.900Z,1745254378.900 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:52:58.901Z,1745254378.901 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:52:58.903Z,1745254378.903 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:53:02.168Z,1745254382.168 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into:
0
Burn on
Dropped weight due to communications timeout.
5
run_backseat_on_surface mission has been running for
Restarting logs and run_backseat_on_surface mission.
restart logs
2025-04-21T16:53:02.172Z,1745254382.172 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min
2025-04-21T16:53:02.173Z,1745254382.173 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl
2025-04-21T16:53:02.173Z,1745254382.173 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl
2025-04-21T16:53:02.178Z,1745254382.178 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl
2025-04-21T16:53:06.014Z,1745254386.014 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into:
NaN
3
100
80
20
5
NaN
NaN
2.0
NaN
0
NaN
NaN
5
0
0
0
0
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
PeakDetectVsDepth
EdgeDetectVsDepth
GoDown, ChlPeakThresh, PeakChl, PeakChlDepth, EdgeChl, EdgeChlDepth =
,
,
,
,
,
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
_.planktivore_LM_AvgRois
EdgeDetectVsDepth
_.planktivore_LM_AvgRois
GoDown, PlanktivoreLMavgROIPeakThresh, PeakPlanktivoreLMavgROI, PeakPlanktivoreLMavgROIDepth, EdgePlanktivoreLMavgROI, EdgePlanktivoreLMavgROIDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_HM_AvgRois
EdgeDetectVsDepth
_.planktivore_HM_AvgRois
GoDown, PlanktivoreHMavgROIPeakThresh, PeakPlanktivoreHMavgROI, PeakPlanktivoreHMavgROIDepth, EdgePlanktivoreHMavgROI, EdgePlanktivoreHMavgROIDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_diatoms
EdgeDetectVsDepth
_.planktivore_diatoms
GoDown, PlanktivoreDiatomsPeakThresh, PeakPlanktivoreDiatoms, PeakPlanktivoreDiatomsDepth, EdgePlanktivoreDiatoms, EdgePlanktivoreDiatomsDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_dinoflagellates
EdgeDetectVsDepth
_.planktivore_dinoflagellates
GoDown, PlanktivoreDinoflagellatesPeakThresh, PeakPlanktivoreDinoflagellates, PeakPlanktivoreDinoflagellatesDepth, EdgePlanktivoreDinoflagellates, EdgePlanktivoreDinoflagellatesDepth =
,
,
,
,
,
Triggered. PeakChl values on
consecutive yo-yo profiles fall in [
] (NaN bound is ignored).
2025-04-21T16:53:06.039Z,1745254386.039 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool
2025-04-21T16:53:06.042Z,1745254386.042 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectChlActive = 0 bool
2025-04-21T16:53:06.045Z,1745254386.045 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min
2025-04-21T16:53:06.047Z,1745254386.047 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool
2025-04-21T16:53:06.050Z,1745254386.050 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool
2025-04-21T16:53:06.053Z,1745254386.053 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool
2025-04-21T16:53:06.055Z,1745254386.055 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool
2025-04-21T16:53:06.137Z,1745254386.137 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count
2025-04-21T16:53:06.140Z,1745254386.140 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count
2025-04-21T16:53:06.159Z,1745254386.159 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 %
2025-04-21T16:53:06.187Z,1745254386.187 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool
2025-04-21T16:53:06.190Z,1745254386.190 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool
2025-04-21T16:53:06.192Z,1745254386.192 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool
2025-04-21T16:53:06.195Z,1745254386.195 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool
2025-04-21T16:53:06.230Z,1745254386.230 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool
2025-04-21T16:53:06.245Z,1745254386.245 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectPlanktivoreLMavgROIActive = 0 bool
2025-04-21T16:53:06.248Z,1745254386.248 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool
2025-04-21T16:53:06.279Z,1745254386.279 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectPlanktivoreHMavgROIActive = 0 bool
2025-04-21T16:53:06.302Z,1745254386.302 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool
2025-04-21T16:53:06.304Z,1745254386.304 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectPlanktivoreDiatomsActive = 0 bool
2025-04-21T16:53:06.341Z,1745254386.341 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-04-21T16:53:06.344Z,1745254386.344 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-04-21T16:53:06.359Z,1745254386.359 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2025-04-21T16:53:06.383Z,1745254386.383 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0 bool
2025-04-21T16:53:06.417Z,1745254386.417 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0 bool
2025-04-21T16:53:06.432Z,1745254386.432 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 1 bool
2025-04-21T16:53:06.440Z,1745254386.440 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 1 bool
2025-04-21T16:53:06.467Z,1745254386.467 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2025-04-21T16:53:06.475Z,1745254386.475 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0 bool
2025-04-21T16:53:06.500Z,1745254386.500 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count
2025-04-21T16:53:06.511Z,1745254386.511 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count
2025-04-21T16:53:06.523Z,1745254386.523 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ShallowBound = nan m
2025-04-21T16:53:06.546Z,1745254386.546 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DeepBound = nan m
2025-04-21T16:53:06.557Z,1745254386.557 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2025-04-21T16:53:06.572Z,1745254386.572 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionVertical = nan %
2025-04-21T16:53:06.584Z,1745254386.583 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlPeakThresh = 0.000000 ug/l
2025-04-21T16:53:06.594Z,1745254386.594 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlThreshTriggerActive = 0 bool
2025-04-21T16:53:06.605Z,1745254386.605 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlLowerThresh = nan ug/l
2025-04-21T16:53:06.619Z,1745254386.619 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlUpperThresh = nan ug/l
2025-04-21T16:53:06.622Z,1745254386.622 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesThresh = 5.000000 count
2025-04-21T16:53:06.638Z,1745254386.638 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PlanktivoreLMavgROIPeakThresh = 0.000000 count/s
2025-04-21T16:53:06.641Z,1745254386.641 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PlanktivoreHMavgROIPeakThresh = 0.000000 count/s
2025-04-21T16:53:06.652Z,1745254386.652 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PlanktivoreDiatomsPeakThresh = 0.000000 count/ml
2025-04-21T16:53:06.695Z,1745254386.695 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PlanktivoreDinoflagellatesPeakThresh = 0.000000 count/ml
2025-04-21T16:53:06.699Z,1745254386.699 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.GoDown = 1 bool
2025-04-21T16:53:06.746Z,1745254386.746 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = nan ug/l
2025-04-21T16:53:06.751Z,1745254386.751 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = nan m
2025-04-21T16:53:06.762Z,1745254386.762 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = nan degC
2025-04-21T16:53:06.786Z,1745254386.786 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg
2025-04-21T16:53:06.793Z,1745254386.793 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg
2025-04-21T16:53:06.815Z,1745254386.815 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChl = nan ug/l
2025-04-21T16:53:06.819Z,1745254386.819 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlDepth = nan m
2025-04-21T16:53:06.834Z,1745254386.834 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlTemperature = nan degC
2025-04-21T16:53:06.859Z,1745254386.859 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlLatitude = nan arcdeg
2025-04-21T16:53:06.862Z,1745254386.862 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlLongitude = nan arcdeg
2025-04-21T16:53:06.878Z,1745254386.878 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = nan umol/l
2025-04-21T16:53:06.883Z,1745254386.883 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = nan m
2025-04-21T16:53:06.890Z,1745254386.890 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg
2025-04-21T16:53:06.915Z,1745254386.915 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg
2025-04-21T16:53:06.926Z,1745254386.926 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = nan kg/m3
2025-04-21T16:53:06.947Z,1745254386.947 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = nan m
2025-04-21T16:53:06.959Z,1745254386.959 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg
2025-04-21T16:53:06.974Z,1745254386.974 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg
2025-04-21T16:53:06.981Z,1745254386.981 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = nan ppb
2025-04-21T16:53:06.985Z,1745254386.985 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = nan m
2025-04-21T16:53:06.996Z,1745254386.996 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC
2025-04-21T16:53:07.015Z,1745254387.015 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg
2025-04-21T16:53:07.030Z,1745254387.030 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg
2025-04-21T16:53:07.061Z,1745254387.061 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = nan psu
2025-04-21T16:53:07.081Z,1745254387.081 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = nan m
2025-04-21T16:53:07.084Z,1745254387.084 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = nan degC
2025-04-21T16:53:07.119Z,1745254387.119 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg
2025-04-21T16:53:07.147Z,1745254387.147 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg
2025-04-21T16:53:07.159Z,1745254387.159 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROI = nan count/s
2025-04-21T16:53:07.206Z,1745254387.206 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROIDepth = nan m
2025-04-21T16:53:07.225Z,1745254387.225 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROITemperature = nan degC
2025-04-21T16:53:07.228Z,1745254387.228 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg
2025-04-21T16:53:07.231Z,1745254387.231 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg
2025-04-21T16:53:07.259Z,1745254387.259 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROI = nan count/s
2025-04-21T16:53:07.262Z,1745254387.262 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROIDepth = nan m
2025-04-21T16:53:07.284Z,1745254387.284 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROITemperature = nan degC
2025-04-21T16:53:07.287Z,1745254387.287 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROILatitude = nan arcdeg
2025-04-21T16:53:07.331Z,1745254387.331 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROILongitude = nan arcdeg
2025-04-21T16:53:07.334Z,1745254387.334 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROI = nan count/s
2025-04-21T16:53:07.366Z,1745254387.366 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROIDepth = nan m
2025-04-21T16:53:07.370Z,1745254387.370 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROITemperature = nan degC
2025-04-21T16:53:07.373Z,1745254387.373 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg
2025-04-21T16:53:07.402Z,1745254387.402 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg
2025-04-21T16:53:07.405Z,1745254387.405 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreHMavgROI = nan count/s
2025-04-21T16:53:07.408Z,1745254387.408 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreHMavgROIDepth = nan m
2025-04-21T16:53:07.444Z,1745254387.444 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreHMavgROITemperature = nan degC
2025-04-21T16:53:07.460Z,1745254387.460 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreHMavgROILatitude = nan arcdeg
2025-04-21T16:53:07.483Z,1745254387.483 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreHMavgROILongitude = nan arcdeg
2025-04-21T16:53:07.515Z,1745254387.515 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatoms = nan count/ml
2025-04-21T16:53:07.534Z,1745254387.534 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsDepth = nan m
2025-04-21T16:53:07.554Z,1745254387.554 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsTemperature = nan degC
2025-04-21T16:53:07.573Z,1745254387.573 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg
2025-04-21T16:53:07.576Z,1745254387.576 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg
2025-04-21T16:53:07.588Z,1745254387.588 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDiatoms = nan count/ml
2025-04-21T16:53:07.623Z,1745254387.623 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDiatomsDepth = nan m
2025-04-21T16:53:07.642Z,1745254387.642 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDiatomsTemperature = nan degC
2025-04-21T16:53:07.658Z,1745254387.658 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDiatomsLatitude = nan arcdeg
2025-04-21T16:53:07.669Z,1745254387.669 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDiatomsLongitude = nan arcdeg
2025-04-21T16:53:07.672Z,1745254387.672 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellates = nan count/ml
2025-04-21T16:53:07.716Z,1745254387.716 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesDepth = nan m
2025-04-21T16:53:07.724Z,1745254387.724 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC
2025-04-21T16:53:07.731Z,1745254387.731 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-04-21T16:53:07.746Z,1745254387.746 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-04-21T16:53:07.770Z,1745254387.770 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDinoflagellates = nan count/ml
2025-04-21T16:53:07.781Z,1745254387.781 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDinoflagellatesDepth = nan m
2025-04-21T16:53:07.784Z,1745254387.784 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDinoflagellatesTemperature = nan degC
2025-04-21T16:53:07.796Z,1745254387.796 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-04-21T16:53:07.816Z,1745254387.816 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-04-21T16:53:07.831Z,1745254387.831 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = nan ug/l
2025-04-21T16:53:07.857Z,1745254387.857 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = nan m
2025-04-21T16:53:07.860Z,1745254387.860 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg
2025-04-21T16:53:07.908Z,1745254387.908 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg
2025-04-21T16:53:07.923Z,1745254387.923 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m
2025-04-21T16:53:07.965Z,1745254387.965 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = nan psu
2025-04-21T16:53:07.969Z,1745254387.969 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = nan m
2025-04-21T16:53:07.984Z,1745254387.984 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg
2025-04-21T16:53:08.003Z,1745254388.003 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg
2025-04-21T16:53:08.007Z,1745254388.007 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m
2025-04-21T16:53:08.023Z,1745254388.023 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = nan psu
2025-04-21T16:53:08.035Z,1745254388.035 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = nan m
2025-04-21T16:53:08.039Z,1745254388.039 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg
2025-04-21T16:53:08.064Z,1745254388.064 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg
2025-04-21T16:53:08.080Z,1745254388.080 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m
2025-04-21T16:53:08.096Z,1745254388.096 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.TriggeredOnChl = 0 bool
2025-04-21T16:53:08.111Z,1745254388.111 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.ChlTriggering = nan ug/l
2025-04-21T16:53:08.313Z,1745254388.313 [run_backseat_on_surface:Science:PeakDetectChl:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:08.384Z,1745254388.384 [run_backseat_on_surface:Science:EdgeDetectChl:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-21T16:53:08.456Z,1745254388.456 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T16:53:08.513Z,1745254388.513 [run_backseat_on_surface:Science:PeakDetectNO3:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:08.553Z,1745254388.553 [run_backseat_on_surface:Science:PeakDetectOil:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:08.635Z,1745254388.635 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T16:53:08.708Z,1745254388.708 [run_backseat_on_surface:Science:PeakDetectFDOM:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:08.764Z,1745254388.764 [run_backseat_on_surface:Science:PeakDetectSalinity:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:08.841Z,1745254388.841 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T16:53:08.910Z,1745254388.910 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:08.948Z,1745254388.948 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-21T16:53:09.025Z,1745254389.025 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:09.069Z,1745254389.069 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-21T16:53:09.219Z,1745254389.219 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:09.297Z,1745254389.297 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-21T16:53:09.375Z,1745254389.375 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T16:53:09.451Z,1745254389.451 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-21T16:53:09.639Z,1745254389.639 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2025-04-21T16:53:09.674Z,1745254389.674 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-04-21T16:53:09.674Z,1745254389.674 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-04-21T16:53:09.675Z,1745254389.675 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-04-21T16:53:09.731Z,1745254389.731 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-04-21T16:53:09.765Z,1745254389.765 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool
2025-04-21T16:53:09.768Z,1745254389.768 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-04-21T16:53:09.797Z,1745254389.797 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-04-21T16:53:09.797Z,1745254389.797 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-04-21T16:53:09.799Z,1745254389.799 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-04-21T16:53:10.267Z,1745254390.267 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-04-21T16:53:10.295Z,1745254390.295 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool
2025-04-21T16:53:10.318Z,1745254390.318 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool
2025-04-21T16:53:10.338Z,1745254390.338 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool
2025-04-21T16:53:10.341Z,1745254390.341 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool
2025-04-21T16:53:10.360Z,1745254390.360 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 0 bool
2025-04-21T16:53:10.405Z,1745254390.405 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-04-21T16:53:10.419Z,1745254390.419 [run_backseat_on_surface:E.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-21T16:53:10.482Z,1745254390.482 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-21T16:53:10.484Z,1745254390.484 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-21T16:53:10.515Z,1745254390.515 [run_backseat_on_surface:H.Execute](DEBUG): Construct Execute.
2025-04-21T16:53:10.674Z,1745254390.674 [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 run_backseat_on_surface {
arguments {
ElapsedSinceMissionStarted = 0 minute
}
# Power the science payload.
insert id="Science" Insert/Science.tl
# Power the Backseat payload.
insert Insert/BackseatDriver.tl
assign in sequence BackseatDriver:EnableBackseat = true
insert Insert/PowerOnly.tl
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=P2H {
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 ElapsedSinceMissionStarted = elapsed ( Universal:mission_started )
syslog important "run_backseat_on_surface mission has been running for "
+ ElapsedSinceMissionStarted~minute
}
syslog important "Restarting logs and run_backseat_on_surface mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2025-04-21T16:53:10.691Z,1745254390.691 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:53:10.746Z,1745254390.746 [Default] Stopped
2025-04-21T16:53:10.746Z,1745254390.746 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-21T16:53:10.746Z,1745254390.746 [Default:B.GoToSurface] Stopped
2025-04-21T16:53:10.746Z,1745254390.746 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T16:53:10.746Z,1745254390.746 [Default:CheckIn] Stopped
2025-04-21T16:53:10.746Z,1745254390.746 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T16:53:10.747Z,1745254390.747 [Default:CheckIn:C.Wait] Stopped
2025-04-21T16:53:10.747Z,1745254390.747 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:53:10.747Z,1745254390.747 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface
2025-04-21T16:53:10.747Z,1745254390.747 [run_backseat_on_surface] Running Loop=1
2025-04-21T16:53:10.747Z,1745254390.747 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface
2025-04-21T16:53:10.747Z,1745254390.747 [run_backseat_on_surface:Science] Running Loop=1
2025-04-21T16:53:10.747Z,1745254390.747 [run_backseat_on_surface:Science](DEBUG): Aggregate::initialize run_backseat_on_surface:Science
2025-04-21T16:53:10.747Z,1745254390.747 [run_backseat_on_surface:Science:A] Running Loop=1
2025-04-21T16:53:10.747Z,1745254390.747 [run_backseat_on_surface:Science:B] Running Loop=1
2025-04-21T16:53:10.747Z,1745254390.747 [run_backseat_on_surface:Science:C] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:D] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:E] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:F] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:Read_Oil] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:PeakDetectChl] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectChl
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:PeakDetectChl:A] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:EdgeDetectChl] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:EdgeDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectChl
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:EdgeDetectChl:A] Running Loop=1
2025-04-21T16:53:10.748Z,1745254390.748 [run_backseat_on_surface:Science:HighestChlPeakReport] Running Loop=1
2025-04-21T16:53:10.749Z,1745254390.749 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestChlPeakReport
2025-04-21T16:53:10.749Z,1745254390.749 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T16:53:10.749Z,1745254390.749 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T16:53:10.749Z,1745254390.749 [run_backseat_on_surface:Science:PeakDetectNO3] Running Loop=1
2025-04-21T16:53:10.750Z,1745254390.750 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectNO3
2025-04-21T16:53:10.750Z,1745254390.750 [run_backseat_on_surface:Science:PeakDetectNO3:A] Running Loop=1
2025-04-21T16:53:10.750Z,1745254390.750 [run_backseat_on_surface:Science:PeakDetectOil] Running Loop=1
2025-04-21T16:53:10.750Z,1745254390.750 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectOil
2025-04-21T16:53:10.750Z,1745254390.750 [run_backseat_on_surface:Science:PeakDetectOil:A] Running Loop=1
2025-04-21T16:53:10.750Z,1745254390.750 [run_backseat_on_surface:Science:HighestOilPeakReport] Running Loop=1
2025-04-21T16:53:10.750Z,1745254390.750 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestOilPeakReport
2025-04-21T16:53:10.769Z,1745254390.769 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T16:53:10.769Z,1745254390.769 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:PeakDetectFDOM] Running Loop=1
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectFDOM
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:PeakDetectFDOM:A] Running Loop=1
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:PeakDetectSalinity] Running Loop=1
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectSalinity
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:PeakDetectSalinity:A] Running Loop=1
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:HighestSaltPeakReport] Running Loop=1
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestSaltPeakReport
2025-04-21T16:53:10.770Z,1745254390.770 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T16:53:10.771Z,1745254390.771 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T16:53:10.771Z,1745254390.771 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1
2025-04-21T16:53:10.771Z,1745254390.771 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI
2025-04-21T16:53:10.771Z,1745254390.771 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-04-21T16:53:10.771Z,1745254390.771 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI] Running Loop=1
2025-04-21T16:53:10.771Z,1745254390.771 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI
2025-04-21T16:53:10.771Z,1745254390.771 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-04-21T16:53:10.771Z,1745254390.771 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1
2025-04-21T16:53:10.772Z,1745254390.772 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI
2025-04-21T16:53:10.772Z,1745254390.772 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-04-21T16:53:10.772Z,1745254390.772 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI] Running Loop=1
2025-04-21T16:53:10.772Z,1745254390.772 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI
2025-04-21T16:53:10.772Z,1745254390.772 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-04-21T16:53:10.772Z,1745254390.772 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1
2025-04-21T16:53:10.773Z,1745254390.773 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms
2025-04-21T16:53:10.773Z,1745254390.773 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:A] Running Loop=1
2025-04-21T16:53:10.793Z,1745254390.793 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms] Running Loop=1
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms:A] Running Loop=1
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates] Running Loop=1
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-04-21T16:53:10.794Z,1745254390.794 [run_backseat_on_surface:Science:ChlThreshTrigger] Running Loop=1
2025-04-21T16:53:10.795Z,1745254390.795 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:ChlThreshTrigger
2025-04-21T16:53:10.795Z,1745254390.795 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2025-04-21T16:53:10.795Z,1745254390.795 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2025-04-21T16:53:10.795Z,1745254390.795 [run_backseat_on_surface:Science:OceanCurrent] Running Loop=1
2025-04-21T16:53:10.795Z,1745254390.795 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:OceanCurrent
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:BackseatDriver] Running Loop=1
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:PowerOnly] Running Loop=1
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:PowerOnly:A] Running Loop=1
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:PowerOnly:B] Running Loop=1
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:PowerOnly:C] Running Loop=1
2025-04-21T16:53:10.796Z,1745254390.796 [run_backseat_on_surface:PowerOnly:D] Running Loop=1
2025-04-21T16:53:10.797Z,1745254390.797 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1
2025-04-21T16:53:10.797Z,1745254390.797 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:53:10.797Z,1745254390.797 [run_backseat_on_surface:E.GoToSurface] Running Loop=1
2025-04-21T16:53:10.797Z,1745254390.797 [run_backseat_on_surface:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T16:53:10.797Z,1745254390.797 [run_backseat_on_surface:E.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-21T16:53:10.797Z,1745254390.797 [run_backseat_on_surface:E.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-21T16:53:10.798Z,1745254390.798 [run_backseat_on_surface:E.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-21T16:53:10.798Z,1745254390.798 [run_backseat_on_surface:E.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-21T16:53:10.798Z,1745254390.798 [run_backseat_on_surface:E.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T16:53:10.799Z,1745254390.799 [run_backseat_on_surface:E.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T16:53:10.799Z,1745254390.799 [run_backseat_on_surface:C] Running Loop=1
2025-04-21T16:53:10.800Z,1745254390.800 [run_backseat_on_surface:PowerOnly] Running Loop=1
2025-04-21T16:53:10.800Z,1745254390.800 [run_backseat_on_surface:PowerOnly:D] Stopped
2025-04-21T16:53:10.800Z,1745254390.800 [run_backseat_on_surface:PowerOnly:C] Stopped
2025-04-21T16:53:10.800Z,1745254390.800 [run_backseat_on_surface:PowerOnly:B] Stopped
2025-04-21T16:53:10.801Z,1745254390.801 [run_backseat_on_surface:PowerOnly:A] Stopped
2025-04-21T16:53:10.813Z,1745254390.813 [run_backseat_on_surface:C] Stopped
2025-04-21T16:53:10.813Z,1745254390.813 [run_backseat_on_surface:BackseatDriver] Running Loop=1
2025-04-21T16:53:10.814Z,1745254390.814 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-04-21T16:53:10.950Z,1745254390.950 [BackseatComponent](INFO): Powering up
2025-04-21T16:53:10.950Z,1745254390.950 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-04-21T16:53:11.044Z,1745254391.044 [run_backseat_on_surface:Science] Running Loop=1
2025-04-21T16:53:11.046Z,1745254391.046 [run_backseat_on_surface:Science:ChlThreshTrigger] Stopped
2025-04-21T16:53:11.046Z,1745254391.046 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:ChlThreshTrigger
2025-04-21T16:53:11.046Z,1745254391.046 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2025-04-21T16:53:11.046Z,1745254391.046 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2025-04-21T16:53:11.046Z,1745254391.046 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates] Stopped
2025-04-21T16:53:11.046Z,1745254391.046 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates
2025-04-21T16:53:11.046Z,1745254391.046 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDinoflagellates:A] Stopped
2025-04-21T16:53:11.046Z,1745254391.046 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:A] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreDiatoms:A] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:A] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreHMavgROI:A] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI] Stopped
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI
2025-04-21T16:53:11.047Z,1745254391.047 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:A] Stopped
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI] Stopped
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:A] Stopped
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI] Stopped
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:A] Stopped
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:HighestSaltPeakReport] Stopped
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestSaltPeakReport
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:PeakDetectSalinity] Stopped
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectSalinity
2025-04-21T16:53:11.048Z,1745254391.048 [run_backseat_on_surface:Science:PeakDetectSalinity:A] Stopped
2025-04-21T16:53:11.049Z,1745254391.049 [run_backseat_on_surface:Science:PeakDetectFDOM] Stopped
2025-04-21T16:53:11.049Z,1745254391.049 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectFDOM
2025-04-21T16:53:11.049Z,1745254391.049 [run_backseat_on_surface:Science:PeakDetectFDOM:A] Stopped
2025-04-21T16:53:11.055Z,1745254391.055 [run_backseat_on_surface:Science:HighestOilPeakReport] Stopped
2025-04-21T16:53:11.055Z,1745254391.055 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestOilPeakReport
2025-04-21T16:53:11.055Z,1745254391.055 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T16:53:11.055Z,1745254391.055 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T16:53:11.055Z,1745254391.055 [run_backseat_on_surface:Science:PeakDetectOil] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectOil
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:PeakDetectOil:A] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:PeakDetectNO3] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectNO3
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:PeakDetectNO3:A] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:HighestChlPeakReport] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestChlPeakReport
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:EdgeDetectChl] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:EdgeDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectChl
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:EdgeDetectChl:A] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:PeakDetectChl] Stopped
2025-04-21T16:53:11.056Z,1745254391.056 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectChl
2025-04-21T16:53:11.057Z,1745254391.057 [run_backseat_on_surface:Science:PeakDetectChl:A] Stopped
2025-04-21T16:53:11.057Z,1745254391.057 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2025-04-21T16:53:11.069Z,1745254391.069 [run_backseat_on_surface:Science:Read_Oil] Stopped
2025-04-21T16:53:11.069Z,1745254391.069 [run_backseat_on_surface:Science:F] Stopped
2025-04-21T16:53:11.069Z,1745254391.069 [run_backseat_on_surface:Science:E] Running Loop=1
2025-04-21T16:53:11.070Z,1745254391.070 [run_backseat_on_surface:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2025-04-21T16:53:11.070Z,1745254391.070 [run_backseat_on_surface:Science:D] Stopped
2025-04-21T16:53:11.070Z,1745254391.070 [run_backseat_on_surface:Science:C] Running Loop=1
2025-04-21T16:53:11.071Z,1745254391.071 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2025-04-21T16:53:11.071Z,1745254391.071 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2025-04-21T16:53:11.071Z,1745254391.071 [run_backseat_on_surface:Science:B] Running Loop=1
2025-04-21T16:53:11.072Z,1745254391.072 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2025-04-21T16:53:11.073Z,1745254391.073 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2025-04-21T16:53:11.081Z,1745254391.081 [run_backseat_on_surface:Science:A] Stopped
2025-04-21T16:53:11.199Z,1745254391.199 [Power24vConverter](INFO): Powering up.
2025-04-21T16:53:11.220Z,1745254391.220 [run_backseat_on_surface:CheckIn] Running Loop=1
2025-04-21T16:53:11.220Z,1745254391.220 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2025-04-21T16:53:11.220Z,1745254391.220 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:53:11.563Z,1745254391.563 [WetLabsBB2FL](INFO): Powering up
2025-04-21T16:53:11.587Z,1745254391.587 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-21T16:53:13.730Z,1745254393.730 [CommandExec](IMPORTANT): got command report touch BackseatComponent.handled_message
2025-04-21T16:53:14.862Z,1745254394.862 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-21T16:53:16.872Z,1745254396.872 [CTD_Seabird](ERROR): Salinity reading out of range: 0.163634 psu
2025-04-21T16:53:16.874Z,1745254396.874 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:17.875Z,1745254397.875 [CTD_Seabird](ERROR): Salinity reading out of range: 0.179068 psu
2025-04-21T16:53:17.876Z,1745254397.876 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:18.884Z,1745254398.884 [CTD_Seabird](ERROR): Salinity reading out of range: 0.178271 psu
2025-04-21T16:53:18.885Z,1745254398.885 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:19.883Z,1745254399.883 [CTD_Seabird](ERROR): Salinity reading out of range: 0.173734 psu
2025-04-21T16:53:19.884Z,1745254399.884 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:20.887Z,1745254400.887 [CTD_Seabird](ERROR): Salinity reading out of range: 0.171868 psu
2025-04-21T16:53:20.888Z,1745254400.888 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:21.891Z,1745254401.891 [CTD_Seabird](ERROR): Salinity reading out of range: 0.170805 psu
2025-04-21T16:53:21.892Z,1745254401.892 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:22.896Z,1745254402.896 [CTD_Seabird](ERROR): Salinity reading out of range: 0.170008 psu
2025-04-21T16:53:22.897Z,1745254402.897 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:23.899Z,1745254403.899 [CTD_Seabird](ERROR): Salinity reading out of range: 0.169423 psu
2025-04-21T16:53:23.900Z,1745254403.900 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:24.903Z,1745254404.903 [CTD_Seabird](ERROR): Salinity reading out of range: 0.168999 psu
2025-04-21T16:53:24.904Z,1745254404.904 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:25.907Z,1745254405.907 [CTD_Seabird](ERROR): Salinity reading out of range: 0.168625 psu
2025-04-21T16:53:25.908Z,1745254405.908 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:26.911Z,1745254406.911 [CTD_Seabird](ERROR): Salinity reading out of range: 0.168306 psu
2025-04-21T16:53:26.912Z,1745254406.912 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:27.915Z,1745254407.915 [CTD_Seabird](ERROR): Salinity reading out of range: 0.168040 psu
2025-04-21T16:53:27.916Z,1745254407.916 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:28.919Z,1745254408.919 [CTD_Seabird](ERROR): Salinity reading out of range: 0.167774 psu
2025-04-21T16:53:28.920Z,1745254408.920 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:29.381Z,1745254409.381 [Reporter](INFO): BackseatComponent.handled_message 0 bool
2025-04-21T16:53:29.923Z,1745254409.923 [CTD_Seabird](ERROR): Salinity reading out of range: 0.167564 psu
2025-04-21T16:53:29.924Z,1745254409.924 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:30.157Z,1745254410.157 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 39
2025-04-21T16:53:30.157Z,1745254410.157 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:53:30.176Z,1745254410.176 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:53:30.598Z,1745254410.598 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:53:30.598Z,1745254410.598 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 39
2025-04-21T16:53:30.927Z,1745254410.927 [CTD_Seabird](ERROR): Salinity reading out of range: 0.167406 psu
2025-04-21T16:53:30.928Z,1745254410.928 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:31.931Z,1745254411.931 [CTD_Seabird](ERROR): Salinity reading out of range: 0.167250 psu
2025-04-21T16:53:31.933Z,1745254411.933 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:32.935Z,1745254412.935 [CTD_Seabird](ERROR): Salinity reading out of range: 0.167097 psu
2025-04-21T16:53:32.936Z,1745254412.936 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:33.939Z,1745254413.939 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166993 psu
2025-04-21T16:53:33.940Z,1745254413.940 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:34.943Z,1745254414.943 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166839 psu
2025-04-21T16:53:34.944Z,1745254414.944 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:35.947Z,1745254415.947 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166739 psu
2025-04-21T16:53:35.948Z,1745254415.948 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:36.951Z,1745254416.951 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166635 psu
2025-04-21T16:53:36.952Z,1745254416.952 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:37.955Z,1745254417.955 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166586 psu
2025-04-21T16:53:37.956Z,1745254417.956 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:38.959Z,1745254418.959 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166431 psu
2025-04-21T16:53:38.960Z,1745254418.960 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:39.963Z,1745254419.963 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166379 psu
2025-04-21T16:53:39.964Z,1745254419.964 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:40.967Z,1745254420.967 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166276 psu
2025-04-21T16:53:40.968Z,1745254420.968 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:41.971Z,1745254421.971 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166225 psu
2025-04-21T16:53:41.972Z,1745254421.972 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:42.976Z,1745254422.976 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166123 psu
2025-04-21T16:53:42.977Z,1745254422.977 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:43.979Z,1745254423.979 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166075 psu
2025-04-21T16:53:43.980Z,1745254423.980 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:44.983Z,1745254424.983 [CTD_Seabird](ERROR): Salinity reading out of range: 0.166027 psu
2025-04-21T16:53:44.984Z,1745254424.984 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:45.987Z,1745254425.987 [CTD_Seabird](ERROR): Salinity reading out of range: 0.165973 psu
2025-04-21T16:53:45.988Z,1745254425.988 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:46.991Z,1745254426.991 [CTD_Seabird](ERROR): Salinity reading out of range: 0.165871 psu
2025-04-21T16:53:46.992Z,1745254426.992 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-21T16:53:47.154Z,1745254427.154 [CommandExec](IMPORTANT): got command stop
2025-04-21T16:53:47.154Z,1745254427.154 [CommandExec](IMPORTANT): Scheduling is paused
2025-04-21T16:53:47.154Z,1745254427.154 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2025-04-21T16:53:47.535Z,1745254427.535 [MissionManager](INFO): MissionManager is completed.
2025-04-21T16:53:47.535Z,1745254427.535 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface
2025-04-21T16:53:47.535Z,1745254427.535 [run_backseat_on_surface] Stopped
2025-04-21T16:53:47.535Z,1745254427.535 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface
2025-04-21T16:53:47.535Z,1745254427.535 [run_backseat_on_surface:Science] Stopped
2025-04-21T16:53:47.535Z,1745254427.535 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science
2025-04-21T16:53:47.535Z,1745254427.535 [run_backseat_on_surface:Science:B] Stopped
2025-04-21T16:53:47.535Z,1745254427.535 [run_backseat_on_surface:Science:C] Stopped
2025-04-21T16:53:47.535Z,1745254427.535 [run_backseat_on_surface:Science:E] Stopped
2025-04-21T16:53:47.535Z,1745254427.535 [run_backseat_on_surface:Science:OceanCurrent] Stopped
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:BackseatDriver] Stopped
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:PowerOnly] Stopped
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:E.GoToSurface] Stopped
2025-04-21T16:53:47.536Z,1745254427.536 [run_backseat_on_surface:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T16:53:47.537Z,1745254427.537 [run_backseat_on_surface:CheckIn] Stopped
2025-04-21T16:53:47.537Z,1745254427.537 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2025-04-21T16:53:47.537Z,1745254427.537 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2025-04-21T16:53:47.914Z,1745254427.914 [MissionManager](IMPORTANT): Started mission Default
2025-04-21T16:53:47.915Z,1745254427.915 [Default] Running Loop=1
2025-04-21T16:53:47.915Z,1745254427.915 [Default](DEBUG): Aggregate::initialize Default
2025-04-21T16:53:47.915Z,1745254427.915 [Default:B.GoToSurface] Running Loop=1
2025-04-21T16:53:47.915Z,1745254427.915 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T16:53:47.915Z,1745254427.915 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-21T16:53:47.915Z,1745254427.915 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-21T16:53:47.916Z,1745254427.916 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-21T16:53:47.916Z,1745254427.916 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-21T16:53:47.916Z,1745254427.916 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T16:53:47.917Z,1745254427.917 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T16:53:47.917Z,1745254427.917 [Default:A.Wait] Running Loop=1
2025-04-21T16:53:47.917Z,1745254427.917 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:53:47.993Z,1745254427.993 [WetLabsBB2FL](INFO): Powering down
2025-04-21T16:53:49.373Z,1745254429.373 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-04-21T16:53:49.373Z,1745254429.373 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-04-21T16:54:01.264Z,1745254441.264 [Default:A.Wait](INFO): Done Waiting.
2025-04-21T16:54:01.264Z,1745254441.264 [Default:A.Wait] Stopped
2025-04-21T16:54:01.264Z,1745254441.264 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:54:01.666Z,1745254441.666 [Default:CheckIn] Running Loop=1
2025-04-21T16:54:01.666Z,1745254441.666 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T16:54:01.666Z,1745254441.666 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:54:07.525Z,1745254447.525 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-04-21T16:54:07.526Z,1745254447.526 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-04-21T16:54:07.526Z,1745254447.526 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-04-21T16:54:37.868Z,1745254477.868 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2025-04-21T16:54:40.055Z,1745254480.055 [CommandExec](IMPORTANT): got command maintain clear
2025-04-21T16:54:40.083Z,1745254480.083 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-21T16:54:56.421Z,1745254496.421 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:54:56.422Z,1745254496.422 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:54:56.422Z,1745254496.422 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:54:56.424Z,1745254496.424 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:54:56.725Z,1745254496.725 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into:
0
Burn on
Dropped weight due to communications timeout.
5
run_backseat_on_surface mission has been running for
Restarting logs and run_backseat_on_surface mission.
restart logs
2025-04-21T16:54:56.729Z,1745254496.729 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min
2025-04-21T16:54:56.729Z,1745254496.729 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-04-21T16:54:56.729Z,1745254496.729 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-04-21T16:54:56.730Z,1745254496.730 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-04-21T16:54:56.777Z,1745254496.777 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-04-21T16:54:56.780Z,1745254496.780 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool
2025-04-21T16:54:56.782Z,1745254496.782 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-04-21T16:54:56.786Z,1745254496.786 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-04-21T16:54:56.787Z,1745254496.787 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-04-21T16:54:56.788Z,1745254496.788 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-04-21T16:54:56.927Z,1745254496.927 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-04-21T16:54:56.931Z,1745254496.931 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool
2025-04-21T16:54:56.933Z,1745254496.933 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool
2025-04-21T16:54:56.935Z,1745254496.935 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool
2025-04-21T16:54:56.938Z,1745254496.938 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool
2025-04-21T16:54:56.940Z,1745254496.940 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 0 bool
2025-04-21T16:54:56.947Z,1745254496.947 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-04-21T16:54:56.950Z,1745254496.950 [run_backseat_on_surface:D.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-21T16:54:57.072Z,1745254497.072 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-21T16:54:57.078Z,1745254497.078 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-21T16:54:57.084Z,1745254497.084 [run_backseat_on_surface:G.Execute](DEBUG): Construct Execute.
2025-04-21T16:54:57.102Z,1745254497.102 [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 run_backseat_on_surface {
arguments {
ElapsedSinceMissionStarted = 0 minute
}
# Power the science payload.
# insert id="Science" Insert/Science.tl
# Power the Backseat payload.
insert Insert/BackseatDriver.tl
assign in sequence BackseatDriver:EnableBackseat = true
insert Insert/PowerOnly.tl
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=P2H {
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 ElapsedSinceMissionStarted = elapsed ( Universal:mission_started )
syslog important "run_backseat_on_surface mission has been running for "
+ ElapsedSinceMissionStarted~minute
}
syslog important "Restarting logs and run_backseat_on_surface mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2025-04-21T16:54:57.104Z,1745254497.104 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.tl
2025-04-21T16:54:57.410Z,1745254497.410 [Default] Stopped
2025-04-21T16:54:57.410Z,1745254497.410 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-21T16:54:57.410Z,1745254497.410 [Default:B.GoToSurface] Stopped
2025-04-21T16:54:57.410Z,1745254497.410 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T16:54:57.410Z,1745254497.410 [Default:CheckIn] Stopped
2025-04-21T16:54:57.411Z,1745254497.411 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T16:54:57.411Z,1745254497.411 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T16:54:57.411Z,1745254497.411 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface
2025-04-21T16:54:57.411Z,1745254497.411 [run_backseat_on_surface] Running Loop=1
2025-04-21T16:54:57.411Z,1745254497.411 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface
2025-04-21T16:54:57.411Z,1745254497.411 [run_backseat_on_surface:BackseatDriver] Running Loop=1
2025-04-21T16:54:57.411Z,1745254497.411 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver
2025-04-21T16:54:57.411Z,1745254497.411 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:PowerOnly] Running Loop=1
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:PowerOnly:A] Running Loop=1
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:PowerOnly:B] Running Loop=1
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:PowerOnly:C] Running Loop=1
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:PowerOnly:D] Running Loop=1
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:D.GoToSurface] Running Loop=1
2025-04-21T16:54:57.412Z,1745254497.412 [run_backseat_on_surface:D.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T16:54:57.413Z,1745254497.413 [run_backseat_on_surface:D.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-21T16:54:57.414Z,1745254497.414 [run_backseat_on_surface:D.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-21T16:54:57.414Z,1745254497.414 [run_backseat_on_surface:D.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-21T16:54:57.414Z,1745254497.414 [run_backseat_on_surface:D.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-21T16:54:57.415Z,1745254497.415 [run_backseat_on_surface:D.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T16:54:57.415Z,1745254497.415 [run_backseat_on_surface:D.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T16:54:57.415Z,1745254497.415 [run_backseat_on_surface:B] Running Loop=1
2025-04-21T16:54:57.416Z,1745254497.416 [run_backseat_on_surface:PowerOnly] Running Loop=1
2025-04-21T16:54:57.417Z,1745254497.417 [run_backseat_on_surface:PowerOnly:D] Stopped
2025-04-21T16:54:57.417Z,1745254497.417 [run_backseat_on_surface:PowerOnly:C] Stopped
2025-04-21T16:54:57.417Z,1745254497.417 [run_backseat_on_surface:PowerOnly:B] Stopped
2025-04-21T16:54:57.417Z,1745254497.417 [run_backseat_on_surface:PowerOnly:A] Stopped
2025-04-21T16:54:57.417Z,1745254497.417 [run_backseat_on_surface:B] Stopped
2025-04-21T16:54:57.417Z,1745254497.417 [run_backseat_on_surface:BackseatDriver] Running Loop=1
2025-04-21T16:54:57.418Z,1745254497.418 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-04-21T16:54:57.549Z,1745254497.549 [BackseatComponent](INFO): Powering up
2025-04-21T16:54:57.550Z,1745254497.550 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-04-21T16:54:57.816Z,1745254497.816 [run_backseat_on_surface:CheckIn] Running Loop=1
2025-04-21T16:54:57.816Z,1745254497.816 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2025-04-21T16:54:57.816Z,1745254497.816 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:54:58.232Z,1745254498.232 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-21T16:55:15.641Z,1745254515.641 [Reporter](INFO): BackseatComponent.handled_message 0 bool
2025-04-21T16:56:31.154Z,1745254591.154 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 40
2025-04-21T16:56:31.154Z,1745254591.154 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:56:31.199Z,1745254591.199 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:56:31.553Z,1745254591.553 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:56:31.553Z,1745254591.553 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 40
2025-04-21T16:56:51.322Z,1745254611.322 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-21T16:56:51.322Z,1745254611.322 [NAL9602] Data Fault, FailCount= 1
2025-04-21T16:56:51.322Z,1745254611.322 [NAL9602](ERROR): Data Fault
2025-04-21T16:56:51.374Z,1745254611.374 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-21T16:56:51.726Z,1745254611.726 [NAL9602](INFO): Powering down
2025-04-21T16:56:52.572Z,1745254612.572 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-21T16:56:52.572Z,1745254612.572 [NAL9602] No Fault, FailCount= 1
2025-04-21T16:57:22.022Z,1745254642.022 [NAL9602](INFO): Powering up NAL9602
2025-04-21T16:57:32.934Z,1745254652.934 [NAL9602](INFO): NAL9602 initialized
2025-04-21T16:58:12.482Z,1745254692.482 [CommandExec](IMPORTANT): got command stop
2025-04-21T16:58:12.482Z,1745254692.482 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2025-04-21T16:58:12.581Z,1745254692.581 [MissionManager](INFO): MissionManager is completed.
2025-04-21T16:58:12.581Z,1745254692.581 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface
2025-04-21T16:58:12.581Z,1745254692.581 [run_backseat_on_surface] Stopped
2025-04-21T16:58:12.581Z,1745254692.581 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface
2025-04-21T16:58:12.581Z,1745254692.581 [run_backseat_on_surface:BackseatDriver] Stopped
2025-04-21T16:58:12.581Z,1745254692.581 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver
2025-04-21T16:58:12.581Z,1745254692.581 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:PowerOnly] Stopped
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:D.GoToSurface] Stopped
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:D.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:CheckIn] Stopped
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2025-04-21T16:58:12.582Z,1745254692.582 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2025-04-21T16:58:12.962Z,1745254692.962 [MissionManager](IMPORTANT): Started mission Default
2025-04-21T16:58:12.962Z,1745254692.962 [Default] Running Loop=1
2025-04-21T16:58:12.962Z,1745254692.962 [Default](DEBUG): Aggregate::initialize Default
2025-04-21T16:58:12.962Z,1745254692.962 [Default:B.GoToSurface] Running Loop=1
2025-04-21T16:58:12.963Z,1745254692.963 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T16:58:12.963Z,1745254692.963 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-21T16:58:12.963Z,1745254692.963 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-21T16:58:12.963Z,1745254692.963 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-21T16:58:12.964Z,1745254692.964 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-21T16:58:12.964Z,1745254692.964 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T16:58:12.964Z,1745254692.964 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T16:58:13.002Z,1745254693.002 [Default:A.Wait] Running Loop=1
2025-04-21T16:58:13.002Z,1745254693.002 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-21T16:58:13.034Z,1745254693.034 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-04-21T16:58:13.034Z,1745254693.034 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-04-21T16:58:26.284Z,1745254706.284 [Default:A.Wait](INFO): Done Waiting.
2025-04-21T16:58:26.284Z,1745254706.284 [Default:A.Wait] Stopped
2025-04-21T16:58:26.284Z,1745254706.284 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T16:58:26.699Z,1745254706.699 [Default:CheckIn] Running Loop=1
2025-04-21T16:58:26.699Z,1745254706.699 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-21T16:58:26.699Z,1745254706.699 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-21T16:58:31.205Z,1745254711.205 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-04-21T16:58:31.206Z,1745254711.206 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-04-21T16:58:31.206Z,1745254711.206 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-04-21T16:59:32.137Z,1745254772.137 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 41
2025-04-21T16:59:32.137Z,1745254772.137 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-21T16:59:32.148Z,1745254772.148 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-21T16:59:32.551Z,1745254772.551 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-21T16:59:32.551Z,1745254772.551 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 41
2025-04-21T16:59:39.762Z,1745254779.762 [CommandExec](IMPORTANT): got command restart application
2025-04-21T16:59:40.765Z,1745254780.765 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:40.765Z,1745254780.765 [CommandExec](INFO): Uninitializing the command executive.
2025-04-21T16:59:40.765Z,1745254780.765 [CommandExec](INFO): Uninitializing the command scheduler.
2025-04-21T16:59:40.765Z,1745254780.765 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:40.885Z,1745254780.885 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-04-21T16:59:40.885Z,1745254780.885 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-04-21T16:59:40.885Z,1745254780.885 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:40.885Z,1745254780.885 [NavChartDb](INFO): Join timeout helper Thread ID is 7472
2025-04-21T16:59:40.893Z,1745254780.893 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:40.893Z,1745254780.893 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:40.917Z,1745254780.917 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-04-21T16:59:40.917Z,1745254780.917 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:40.918Z,1745254780.918 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7473
2025-04-21T16:59:41.173Z,1745254781.173 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:41.173Z,1745254781.173 [WetLabsBB2FL](INFO): Powering down
2025-04-21T16:59:41.174Z,1745254781.174 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:41.189Z,1745254781.189 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-04-21T16:59:41.189Z,1745254781.189 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:41.189Z,1745254781.189 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7474
2025-04-21T16:59:41.230Z,1745254781.230 [CTD_Seabird](INFO): Powering down
2025-04-21T16:59:41.245Z,1745254781.245 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:41.245Z,1745254781.245 [CTD_Seabird](INFO): Powering down
2025-04-21T16:59:41.257Z,1745254781.257 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:41.269Z,1745254781.269 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-04-21T16:59:41.269Z,1745254781.269 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:41.269Z,1745254781.269 [Radio_Surface](INFO): Join timeout helper Thread ID is 7475
2025-04-21T16:59:41.533Z,1745254781.533 [Radio_Surface](INFO): Powering down
2025-04-21T16:59:41.534Z,1745254781.534 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:41.534Z,1745254781.534 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:41.547Z,1745254781.547 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-04-21T16:59:41.547Z,1745254781.547 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:41.547Z,1745254781.547 [Onboard](INFO): Join timeout helper Thread ID is 7476
2025-04-21T16:59:42.225Z,1745254782.225 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-04-21T16:59:44.641Z,1745254784.641 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:44.641Z,1745254784.641 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:44.648Z,1745254784.648 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-04-21T16:59:44.648Z,1745254784.648 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:44.648Z,1745254784.648 [DataOverHttps](INFO): Join timeout helper Thread ID is 7477
2025-04-21T16:59:45.241Z,1745254785.241 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:45.241Z,1745254785.241 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.257Z,1745254785.257 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-04-21T16:59:45.258Z,1745254785.258 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.258Z,1745254785.258 [BackseatComponent](INFO): Join timeout helper Thread ID is 7478
2025-04-21T16:59:45.325Z,1745254785.325 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:45.325Z,1745254785.325 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.338Z,1745254785.338 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-04-21T16:59:45.338Z,1745254785.338 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.338Z,1745254785.338 [logger](INFO): Join timeout helper Thread ID is 7479
2025-04-21T16:59:45.348Z,1745254785.348 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:45.364Z,1745254785.364 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.369Z,1745254785.369 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-04-21T16:59:45.370Z,1745254785.370 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.370Z,1745254785.370 [CommandLine](INFO): Join timeout helper Thread ID is 7480
2025-04-21T16:59:45.437Z,1745254785.437 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:45.437Z,1745254785.437 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.452Z,1745254785.452 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-04-21T16:59:45.452Z,1745254785.452 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.452Z,1745254785.452 [CommandExec](INFO): Join timeout helper Thread ID is 7481
2025-04-21T16:59:45.460Z,1745254785.460 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-04-21T16:59:45.460Z,1745254785.460 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.460Z,1745254785.460 [controlThread](INFO): Join timeout helper Thread ID is 7482
2025-04-21T16:59:45.498Z,1745254785.498 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-21T16:59:45.498Z,1745254785.498 [controlThread](DEBUG): Uninitializing ControlThread
2025-04-21T16:59:45.499Z,1745254785.499 [AHRS_M2](INFO): Powering down
2025-04-21T16:59:45.577Z,1745254785.577 [NAL9602](INFO): Powering down
2025-04-21T16:59:45.578Z,1745254785.578 [Sonardyne_Nano](INFO): Powering down
2025-04-21T16:59:45.785Z,1745254785.785 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-04-21T16:59:45.786Z,1745254785.786 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-04-21T16:59:45.786Z,1745254785.786 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-04-21T16:59:45.787Z,1745254785.787 [MissionManager](INFO): Uninitializing Mission Default
2025-04-21T16:59:45.787Z,1745254785.787 [Default] Stopped
2025-04-21T16:59:45.787Z,1745254785.787 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-21T16:59:45.787Z,1745254785.787 [Default:B.GoToSurface] Stopped
2025-04-21T16:59:45.787Z,1745254785.787 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T16:59:45.787Z,1745254785.787 [Default:CheckIn] Stopped
2025-04-21T16:59:45.787Z,1745254785.787 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-21T16:59:45.787Z,1745254785.787 [Default:CheckIn:Read_GPS] Stopped
2025-04-21T16:59:45.790Z,1745254785.790 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-04-21T16:59:45.791Z,1745254785.791 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-04-21T16:59:45.791Z,1745254785.791 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-04-21T16:59:45.791Z,1745254785.791 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-04-21T16:59:45.792Z,1745254785.792 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-21T16:59:45.792Z,1745254785.792 [BuoyancyServo](INFO): Powering down
2025-04-21T16:59:45.805Z,1745254785.805 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-21T16:59:45.805Z,1745254785.805 [ElevatorServo](INFO): Powering down
2025-04-21T16:59:45.806Z,1745254785.806 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-21T16:59:45.806Z,1745254785.806 [MassServo](INFO): Powering down
2025-04-21T16:59:45.807Z,1745254785.807 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-21T16:59:45.807Z,1745254785.807 [RudderServo](INFO): Powering down
2025-04-21T16:59:45.808Z,1745254785.808 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-21T16:59:45.808Z,1745254785.808 [ThrusterHE](INFO): Powering down
2025-04-21T16:59:45.808Z,1745254785.808 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-04-21T16:59:45.809Z,1745254785.809 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-04-21T16:59:45.809Z,1745254785.809 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-04-21T16:59:45.809Z,1745254785.809 [CBIT](DEBUG): Powering off loads.
2025-04-21T16:59:45.821Z,1745254785.821 [CBIT](DEBUG): Disabling WDT.
2025-04-21T16:59:45.833Z,1745254785.833 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-21T16:59:45.833Z,1745254785.833 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-21T16:59:45.834Z,1745254785.834 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.896Z,1745254785.896 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.899Z,1745254785.899 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.905Z,1745254785.905 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.949Z,1745254785.949 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.991Z,1745254785.991 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:45.995Z,1745254785.995 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:46.015Z,1745254786.015 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-21T16:59:46.015Z,1745254786.015 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-21T16:59:46.030Z,1745254786.030 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-21T16:59:46.080Z,1745254786.080 [logger ThreadHandler](INFO): Thread cancelled.