2025-06-04T00:32:34.939Z,1748997154.939 [Supervisor](DEBUG): Initializing supervisor. 2025-06-04T00:32:34.944Z,1748997154.944 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-06-04T00:32:34.944Z,1748997154.944 [SyncHandler](INFO): Protected caller Thread ID is 3989 2025-06-04T00:32:34.945Z,1748997154.945 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-06-04T00:32:34.946Z,1748997154.946 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-06-04T00:32:34.946Z,1748997154.946 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3990 2025-06-04T00:32:34.950Z,1748997154.950 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-06-04T00:32:34.971Z,1748997154.971 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-06-04T00:32:34.972Z,1748997154.972 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-06-04T00:32:34.973Z,1748997154.973 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3991 2025-06-04T00:32:34.977Z,1748997154.977 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-06-04T00:32:34.978Z,1748997154.978 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-06-04T00:32:34.979Z,1748997154.979 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3992 2025-06-04T00:32:34.981Z,1748997154.981 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-06-04T00:32:34.983Z,1748997154.983 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-06-04T00:32:34.983Z,1748997154.983 [logger ThreadHandler](INFO): Protected caller Thread ID is 3993 2025-06-04T00:32:34.987Z,1748997154.987 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-06-04T00:32:34.988Z,1748997154.988 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-06-04T00:32:34.989Z,1748997154.989 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-06-04T00:32:35.114Z,1748997155.114 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-06-04T00:32:35.114Z,1748997155.114 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-06-04T00:32:35.346Z,1748997155.346 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-06-04T00:32:35.346Z,1748997155.346 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-06-04T00:32:35.618Z,1748997155.618 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-06-04T00:32:35.618Z,1748997155.618 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-06-04T00:32:35.735Z,1748997155.735 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-06-04T00:32:35.735Z,1748997155.735 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-06-04T00:32:36.493Z,1748997156.493 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-06-04T00:32:36.494Z,1748997156.494 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-06-04T00:32:37.013Z,1748997157.013 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-06-04T00:32:37.013Z,1748997157.013 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-06-04T00:32:37.567Z,1748997157.567 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-06-04T00:32:37.567Z,1748997157.567 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-06-04T00:32:37.992Z,1748997157.992 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-06-04T00:32:37.993Z,1748997157.993 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-06-04T00:32:38.353Z,1748997158.353 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-06-04T00:32:38.354Z,1748997158.354 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-06-04T00:32:39.172Z,1748997159.172 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-06-04T00:32:39.172Z,1748997159.172 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-06-04T00:32:39.407Z,1748997159.407 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-06-04T00:32:39.408Z,1748997159.408 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-06-04T00:32:39.561Z,1748997159.561 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-06-04T00:32:39.562Z,1748997159.562 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-06-04T00:32:39.665Z,1748997159.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-06-04T00:32:39.665Z,1748997159.665 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-06-04T00:32:39.755Z,1748997159.755 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-06-04T00:32:39.951Z,1748997159.951 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-06-04T00:32:39.951Z,1748997159.951 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-06-04T00:32:40.209Z,1748997160.209 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-06-04T00:32:40.211Z,1748997160.211 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2025-06-04T00:32:40.211Z,1748997160.211 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2025-06-04T00:32:40.306Z,1748997160.306 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2025-06-04T00:32:40.581Z,1748997160.581 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-06-04T00:32:40.581Z,1748997160.581 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2025-06-04T00:32:40.677Z,1748997160.677 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2025-06-04T00:32:40.858Z,1748997160.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2025-06-04T00:32:40.969Z,1748997160.969 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2025-06-04T00:32:41.090Z,1748997161.090 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2025-06-04T00:32:41.214Z,1748997161.214 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2025-06-04T00:32:41.319Z,1748997161.319 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2025-06-04T00:32:41.491Z,1748997161.491 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2025-06-04T00:32:41.599Z,1748997161.599 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg 2025-06-04T00:32:41.695Z,1748997161.695 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2025-06-04T00:32:41.805Z,1748997161.805 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2025-06-04T00:32:41.904Z,1748997161.904 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2025-06-04T00:32:41.904Z,1748997161.904 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2025-06-04T00:32:41.906Z,1748997161.906 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-06-04T00:32:42.122Z,1748997162.122 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-06-04T00:32:42.123Z,1748997162.123 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-06-04T00:32:42.290Z,1748997162.290 [BuoyancyServo] Loaded 2025-06-04T00:32:42.290Z,1748997162.290 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-06-04T00:32:42.314Z,1748997162.314 [ElevatorServo] Loaded 2025-06-04T00:32:42.314Z,1748997162.314 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-06-04T00:32:42.337Z,1748997162.337 [MassServo] Loaded 2025-06-04T00:32:42.338Z,1748997162.338 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-06-04T00:32:42.360Z,1748997162.360 [RudderServo] Loaded 2025-06-04T00:32:42.360Z,1748997162.360 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-06-04T00:32:42.378Z,1748997162.378 [ThrusterHE] Loaded 2025-06-04T00:32:42.379Z,1748997162.379 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-06-04T00:32:42.379Z,1748997162.379 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-06-04T00:32:42.379Z,1748997162.379 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-06-04T00:32:42.579Z,1748997162.579 [SBIT](DEBUG): Construct Startup Built In Test. 2025-06-04T00:32:42.594Z,1748997162.594 [SBIT] Loaded 2025-06-04T00:32:42.594Z,1748997162.594 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-06-04T00:32:42.597Z,1748997162.597 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-06-04T00:32:42.618Z,1748997162.618 [IBIT] Loaded 2025-06-04T00:32:42.619Z,1748997162.619 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-06-04T00:32:42.624Z,1748997162.624 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-06-04T00:32:42.820Z,1748997162.820 [CBIT] Loaded 2025-06-04T00:32:42.821Z,1748997162.821 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-06-04T00:32:42.852Z,1748997162.852 [GFScanner] Loaded 2025-06-04T00:32:42.852Z,1748997162.852 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-06-04T00:32:42.852Z,1748997162.852 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-06-04T00:32:42.853Z,1748997162.853 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-06-04T00:32:43.074Z,1748997163.074 [CTD_Seabird] Loaded 2025-06-04T00:32:43.074Z,1748997163.074 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-06-04T00:32:43.075Z,1748997163.075 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406864E0 2025-06-04T00:32:43.075Z,1748997163.075 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4081 2025-06-04T00:32:43.110Z,1748997163.110 [ESPComponent] Loaded 2025-06-04T00:32:43.111Z,1748997163.111 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-06-04T00:32:43.133Z,1748997163.133 [PAR_Licor] Loaded 2025-06-04T00:32:43.133Z,1748997163.133 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-06-04T00:32:43.179Z,1748997163.179 [WetLabsBB2FL] Loaded 2025-06-04T00:32:43.179Z,1748997163.179 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-06-04T00:32:43.180Z,1748997163.180 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B64E0 2025-06-04T00:32:43.180Z,1748997163.180 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4082 2025-06-04T00:32:43.181Z,1748997163.181 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-06-04T00:32:43.182Z,1748997163.182 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-06-04T00:32:43.248Z,1748997163.248 [DepthRateCalculator] Loaded 2025-06-04T00:32:43.249Z,1748997163.249 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-06-04T00:32:43.254Z,1748997163.254 [PitchRateCalculator] Loaded 2025-06-04T00:32:43.254Z,1748997163.254 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-06-04T00:32:43.265Z,1748997163.265 [SpeedCalculator] Loaded 2025-06-04T00:32:43.265Z,1748997163.265 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-06-04T00:32:43.270Z,1748997163.270 [YawRateCalculator] Loaded 2025-06-04T00:32:43.270Z,1748997163.270 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-06-04T00:32:43.290Z,1748997163.290 [ElevatorOffsetCalculator] Loaded 2025-06-04T00:32:43.290Z,1748997163.290 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-06-04T00:32:43.291Z,1748997163.291 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-06-04T00:32:43.291Z,1748997163.291 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-06-04T00:32:43.458Z,1748997163.458 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-06-04T00:32:43.458Z,1748997163.458 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-06-04T00:32:43.506Z,1748997163.506 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-06-04T00:32:43.507Z,1748997163.507 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-06-04T00:32:43.647Z,1748997163.647 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-06-04T00:32:43.647Z,1748997163.647 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-06-04T00:32:43.662Z,1748997163.662 [NavChart] Loaded 2025-06-04T00:32:43.662Z,1748997163.662 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-06-04T00:32:43.668Z,1748997163.668 [UniversalFixResidualReporter] Loaded 2025-06-04T00:32:43.668Z,1748997163.668 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-06-04T00:32:43.668Z,1748997163.668 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-06-04T00:32:43.669Z,1748997163.669 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-06-04T00:32:44.693Z,1748997164.693 [AHRS_M2] Loaded 2025-06-04T00:32:44.694Z,1748997164.694 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-06-04T00:32:45.024Z,1748997165.024 [BackseatComponent] Loaded 2025-06-04T00:32:45.024Z,1748997165.024 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-06-04T00:32:45.025Z,1748997165.025 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A824E0 2025-06-04T00:32:45.025Z,1748997165.025 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4083 2025-06-04T00:32:45.028Z,1748997165.028 [LcmUniversalReporter] Loaded 2025-06-04T00:32:45.029Z,1748997165.029 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-06-04T00:32:45.861Z,1748997165.861 [BPC1] Loaded 2025-06-04T00:32:45.861Z,1748997165.861 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-06-04T00:32:45.963Z,1748997165.963 [DAT] Loaded 2025-06-04T00:32:45.963Z,1748997165.963 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-06-04T00:32:45.964Z,1748997165.964 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AB24E0 2025-06-04T00:32:45.964Z,1748997165.964 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4084 2025-06-04T00:32:46.060Z,1748997166.060 [DataOverHttps] Loaded 2025-06-04T00:32:46.060Z,1748997166.060 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-06-04T00:32:46.061Z,1748997166.061 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AE24E0 2025-06-04T00:32:46.061Z,1748997166.061 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4085 2025-06-04T00:32:46.085Z,1748997166.085 [Depth_Keller] Loaded 2025-06-04T00:32:46.085Z,1748997166.085 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-06-04T00:32:46.091Z,1748997166.091 [DropWeight] Loaded 2025-06-04T00:32:46.091Z,1748997166.091 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-06-04T00:32:46.133Z,1748997166.133 [DVL_micro] Loaded 2025-06-04T00:32:46.133Z,1748997166.133 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2025-06-04T00:32:46.197Z,1748997166.197 [NAL9602] Loaded 2025-06-04T00:32:46.197Z,1748997166.197 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-06-04T00:32:46.224Z,1748997166.224 [Onboard] Loaded 2025-06-04T00:32:46.224Z,1748997166.224 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-06-04T00:32:46.225Z,1748997166.225 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B124E0 2025-06-04T00:32:46.226Z,1748997166.226 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4086 2025-06-04T00:32:46.232Z,1748997166.232 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1 2025-06-04T00:32:46.246Z,1748997166.246 [PowerOnly] Loaded 2025-06-04T00:32:46.246Z,1748997166.246 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-06-04T00:32:46.261Z,1748997166.261 [Power24vConverter] Loaded 2025-06-04T00:32:46.261Z,1748997166.261 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-06-04T00:32:46.277Z,1748997166.277 [Radio_Surface] Loaded 2025-06-04T00:32:46.278Z,1748997166.278 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-06-04T00:32:46.279Z,1748997166.279 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B424E0 2025-06-04T00:32:46.279Z,1748997166.279 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4087 2025-06-04T00:32:46.295Z,1748997166.295 [Sonardyne_Nano] Loaded 2025-06-04T00:32:46.295Z,1748997166.295 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-06-04T00:32:46.296Z,1748997166.296 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-06-04T00:32:46.297Z,1748997166.297 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-06-04T00:32:46.382Z,1748997166.382 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-06-04T00:32:46.383Z,1748997166.383 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-06-04T00:32:46.455Z,1748997166.455 [VerticalControl](DEBUG): Construct VerticalControl. 2025-06-04T00:32:46.508Z,1748997166.508 [VerticalControl] Loaded 2025-06-04T00:32:46.508Z,1748997166.508 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-06-04T00:32:46.511Z,1748997166.511 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-06-04T00:32:46.556Z,1748997166.556 [HorizontalControl] Loaded 2025-06-04T00:32:46.557Z,1748997166.557 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-06-04T00:32:46.559Z,1748997166.559 [SpeedControl](DEBUG): Construct SpeedControl. 2025-06-04T00:32:46.561Z,1748997166.561 [SpeedControl] Loaded 2025-06-04T00:32:46.561Z,1748997166.561 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-06-04T00:32:46.564Z,1748997166.564 [LoopControl](DEBUG): Construct LoopControl. 2025-06-04T00:32:46.564Z,1748997166.564 [LoopControl] Loaded 2025-06-04T00:32:46.565Z,1748997166.565 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-06-04T00:32:46.565Z,1748997166.565 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-06-04T00:32:46.566Z,1748997166.566 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-06-04T00:32:46.580Z,1748997166.580 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-06-04T00:32:46.581Z,1748997166.581 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-06-04T00:32:46.990Z,1748997166.990 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-06-04T00:32:46.997Z,1748997166.997 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-06-04T00:32:46.000Z,1748997167.000 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-06-04T00:32:47.011Z,1748997167.011 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-06-04T00:32:47.012Z,1748997167.012 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0 2025-06-04T00:32:47.013Z,1748997167.013 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4088 2025-06-04T00:32:47.027Z,1748997167.027 [Supervisor](INFO): Main Thread ID is 3987 2025-06-04T00:32:47.027Z,1748997167.027 [Supervisor](DEBUG): Running supervisor. 2025-06-04T00:32:47.028Z,1748997167.028 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4089 2025-06-04T00:32:47.028Z,1748997167.028 [CommandExec](INFO): Initializing the command executive. 2025-06-04T00:32:47.030Z,1748997167.030 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4090 2025-06-04T00:32:47.032Z,1748997167.032 [controlThread ThreadHandler](INFO): Handler Thread ID is 4091 2025-06-04T00:32:47.033Z,1748997167.033 [controlThread](DEBUG): Initializing ControlThread 2025-06-04T00:32:47.034Z,1748997167.034 [SBIT](INFO): Initialize SBIT Component. 2025-06-04T00:32:47.035Z,1748997167.035 [SBIT](IMPORTANT): git: 2025-05-29 2025-06-04T00:32:47.035Z,1748997167.035 [SBIT](INFO): git hash: c78c975c7bb2a66b27244d2837f68dff299fa024 2025-06-04T00:32:47.035Z,1748997167.035 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-06-04T00:32:47.037Z,1748997167.037 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2025-06-04T00:32:47.038Z,1748997167.038 [SBIT](INFO): Beginning SBIT in 107.000000 seconds. 2025-06-04T00:32:47.038Z,1748997167.038 [IBIT](INFO): Initialize IBIT Component. 2025-06-04T00:32:47.039Z,1748997167.039 [CBIT](DEBUG): Initialize CBIT Component. 2025-06-04T00:32:47.040Z,1748997167.040 [logger ThreadHandler](INFO): Handler Thread ID is 4092 2025-06-04T00:32:47.052Z,1748997167.052 [CBIT](DEBUG): Initialized mux pins. 2025-06-04T00:32:47.053Z,1748997167.053 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2025-06-04T00:32:47.053Z,1748997167.053 [CBIT](DEBUG): Initializing the watchdog timer. 2025-06-04T00:32:47.065Z,1748997167.065 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4093 2025-06-04T00:32:47.066Z,1748997167.066 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-06-04T00:32:47.070Z,1748997167.070 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4095 2025-06-04T00:32:47.073Z,1748997167.073 [WetLabsBB2FL](INFO): Powering up 2025-06-04T00:32:47.074Z,1748997167.074 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4097 2025-06-04T00:32:47.077Z,1748997167.077 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-06-04T00:32:47.077Z,1748997167.077 [CBIT](DEBUG): Initializing heartbeat. 2025-06-04T00:32:47.092Z,1748997167.092 [DAT ThreadHandler](INFO): Handler Thread ID is 4098 2025-06-04T00:32:47.092Z,1748997167.092 [DAT](INFO): Powering up 2025-06-04T00:32:47.093Z,1748997167.093 [DAT](DEBUG): Initializing DAT. 2025-06-04T00:32:47.098Z,1748997167.098 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4100 2025-06-04T00:32:47.099Z,1748997167.099 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-06-04T00:32:47.113Z,1748997167.113 [Onboard ThreadHandler](INFO): Handler Thread ID is 4101 2025-06-04T00:32:47.130Z,1748997167.130 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4102 2025-06-04T00:32:47.148Z,1748997167.148 [CBIT](DEBUG): Deactivating emergency mode. 2025-06-04T00:32:47.149Z,1748997167.149 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4103 2025-06-04T00:32:47.154Z,1748997167.154 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-06-04T00:32:47.154Z,1748997167.154 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-06-04T00:32:47.154Z,1748997167.154 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-06-04T00:32:47.155Z,1748997167.155 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-06-04T00:32:47.155Z,1748997167.155 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-06-04T00:32:47.155Z,1748997167.155 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-06-04T00:32:47.155Z,1748997167.155 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-06-04T00:32:47.155Z,1748997167.155 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-06-04T00:32:47.189Z,1748997167.189 [CBIT](DEBUG): Backplane powered. 2025-06-04T00:32:47.189Z,1748997167.189 [GFScanner](DEBUG): Initializing GFScanner 2025-06-04T00:32:47.189Z,1748997167.189 [GFScanner](DEBUG): Deactivating GF circuits. 2025-06-04T00:32:47.197Z,1748997167.197 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-06-04T00:32:47.197Z,1748997167.197 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-06-04T00:32:47.198Z,1748997167.198 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-06-04T00:32:47.198Z,1748997167.198 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-06-04T00:32:47.198Z,1748997167.198 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-06-04T00:32:47.199Z,1748997167.199 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-06-04T00:32:47.200Z,1748997167.200 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-06-04T00:32:47.204Z,1748997167.204 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-06-04T00:32:47.214Z,1748997167.214 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-06-04T00:32:47.214Z,1748997167.214 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-06-04T00:32:47.215Z,1748997167.215 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-06-04T00:32:47.215Z,1748997167.215 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-06-04T00:32:47.216Z,1748997167.216 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-06-04T00:32:47.225Z,1748997167.225 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-06-04T00:32:47.226Z,1748997167.226 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-06-04T00:32:47.322Z,1748997167.322 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-06-04T00:32:47.327Z,1748997167.327 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-04T00:32:47.379Z,1748997167.379 [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-06-04T00:32:47.380Z,1748997167.380 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-06-04T00:32:47.380Z,1748997167.380 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-06-04T00:32:47.381Z,1748997167.381 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-06-04T00:32:47.537Z,1748997167.537 [Radio_Surface](INFO): Powering up 2025-06-04T00:32:47.699Z,1748997167.699 [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-06-04T00:32:47.721Z,1748997167.721 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-06-04T00:32:47.722Z,1748997167.722 [Default:A.Wait](DEBUG): Construct Wait. 2025-06-04T00:32:47.741Z,1748997167.741 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-04T00:32:47.773Z,1748997167.773 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-06-04T00:32:47.776Z,1748997167.776 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-06-04T00:32:47.798Z,1748997167.798 [Default:E.Execute](DEBUG): Construct Execute. 2025-06-04T00:32:47.825Z,1748997167.825 [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-06-04T00:32:47.830Z,1748997167.830 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,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-06-04T00:32:47.870Z,1748997167.870 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-06-04T00:32:47.993Z,1748997167.993 [Depth_Keller](INFO): Initializing. 2025-06-04T00:32:48.002Z,1748997168.002 [PowerOnly](INFO): Powering up loadControl 2025-06-04T00:32:48.021Z,1748997168.021 [Power24vConverter](INFO): Powering up. 2025-06-04T00:32:48.022Z,1748997168.022 [Sonardyne_Nano](INFO): Initializing. 2025-06-04T00:32:48.049Z,1748997168.049 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-06-04T00:32:48.131Z,1748997168.131 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-06-04T00:32:48.137Z,1748997168.137 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-06-04T00:32:48.138Z,1748997168.138 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-04T00:32:48.145Z,1748997168.145 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-04T00:32:48.161Z,1748997168.161 [MassServo](DEBUG): Initializing EZServoServo. 2025-06-04T00:32:48.165Z,1748997168.165 [MassServo](DEBUG): Initializing MassServo. 2025-06-04T00:32:48.166Z,1748997168.166 [RudderServo](DEBUG): Initializing EZServoServo. 2025-06-04T00:32:48.174Z,1748997168.174 [RudderServo](DEBUG): Initializing RudderServo. 2025-06-04T00:32:48.174Z,1748997168.174 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-06-04T00:32:48.181Z,1748997168.181 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-06-04T00:32:48.285Z,1748997168.285 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-06-04T00:32:48.286Z,1748997168.286 [DropWeight] Hardware Fault, FailCount= 1 2025-06-04T00:32:48.286Z,1748997168.286 [DropWeight](ERROR): Hardware Fault 2025-06-04T00:32:48.326Z,1748997168.326 [CommandExec](FAULT): Scheduling is paused 2025-06-04T00:32:48.326Z,1748997168.326 [CBIT](INFO): Critical error at 20250604T003248 2025-06-04T00:32:48.326Z,1748997168.326 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-06-04T00:32:48.337Z,1748997168.337 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-06-04T00:32:48.338Z,1748997168.338 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-06-04T00:32:48.692Z,1748997168.692 [CBIT](INFO): Critical error at 20250604T003248 2025-06-04T00:32:49.685Z,1748997169.685 [WetLabsBB2FL](INFO): Powering down 2025-06-04T00:32:50.268Z,1748997170.268 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-06-04T00:32:51.518Z,1748997171.518 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213 2025-06-04T00:32:53.810Z,1748997173.810 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-06-04T00:33:00.197Z,1748997180.197 [DAT](INFO): DAT read: 2025-06-04T00:33:00.199Z,1748997180.199 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-06-04T00:33:01.962Z,1748997181.962 [DAT](INFO): DAT read: MF Frequency Band 2025-06-04T00:33:01.963Z,1748997181.963 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-06-04T00:33:01.963Z,1748997181.963 [DAT](INFO): DAT read: Jun 3 2025 19:48:00 2025-06-04T00:33:02.970Z,1748997182.970 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-06-04T00:33:02.971Z,1748997182.971 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2025-06-04T00:33:02.971Z,1748997182.971 [DAT](INFO): commRate: 1200 2025-06-04T00:33:05.037Z,1748997185.037 [DAT](INFO): entering command mode 2025-06-04T00:33:05.237Z,1748997185.237 [DAT](INFO): DAT read: 2025-06-04T00:33:05.238Z,1748997185.238 [DAT](INFO): DAT read: user:1> 2025-06-04T00:33:05.238Z,1748997185.238 [DAT](INFO): setting verbose to 3 2025-06-04T00:33:05.489Z,1748997185.489 [DAT](INFO): DAT read: user:1> 2025-06-04T00:33:05.490Z,1748997185.490 [DAT](INFO): DAT read: Verbose | 3 2025-06-04T00:33:05.491Z,1748997185.491 [DAT](INFO): set verbose to 3 2025-06-04T00:33:05.491Z,1748997185.491 [DAT](INFO): setting DatVerbose to 27440 2025-06-04T00:33:05.742Z,1748997185.742 [DAT](INFO): DAT read: user:2> 2025-06-04T00:33:05.744Z,1748997185.744 [DAT](INFO): DAT read: DatVerbose | 27440 2025-06-04T00:33:05.744Z,1748997185.744 [DAT](INFO): set DatVerbose to 27440 2025-06-04T00:33:05.745Z,1748997185.745 [DAT](INFO): setting transmit power to 8 2025-06-04T00:33:05.993Z,1748997185.993 [DAT](INFO): DAT read: user:3> 2025-06-04T00:33:05.994Z,1748997185.994 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-06-04T00:33:05.995Z,1748997185.995 [DAT](INFO): set transmit power to 8 2025-06-04T00:33:05.995Z,1748997185.995 [DAT](INFO): setting local address to 5 2025-06-04T00:33:06.245Z,1748997186.245 [DAT](INFO): DAT read: user:4> 2025-06-04T00:33:06.246Z,1748997186.246 [DAT](INFO): DAT read: LocalAddr | 5 2025-06-04T00:33:06.247Z,1748997186.247 [DAT](INFO): set local address to 5 2025-06-04T00:33:06.248Z,1748997186.248 [DAT](INFO): Setting time to: 0:33:6 And date to:6/4/2025 2025-06-04T00:33:06.497Z,1748997186.497 [DAT](INFO): DAT read: user:5> 2025-06-04T00:33:06.498Z,1748997186.498 [DAT](INFO): DAT read: Wed Jun 4, 2025 00:33:06 2025-06-04T00:33:06.499Z,1748997186.499 [DAT](INFO): Local DAT time set to Wed Jun 4, 2025 00:33:06 2025-06-04T00:33:16.585Z,1748997196.585 [NAL9602](INFO): Powering up NAL9602 2025-06-04T00:33:27.471Z,1748997207.471 [NAL9602](INFO): NAL9602 initialized 2025-06-04T00:33:52.944Z,1748997232.944 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T00:33:55.761Z,1748997235.761 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T00:33:58.586Z,1748997238.586 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:01.413Z,1748997241.413 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:04.251Z,1748997244.251 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:06.310Z,1748997246.310 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:07.069Z,1748997247.069 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:16.833Z,1748997256.833 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:22.080Z,1748997262.080 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:27.740Z,1748997267.740 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:34.582Z,1748997274.582 [SBIT](IMPORTANT): Beginning Startup BIT 2025-06-04T00:34:34.586Z,1748997274.586 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:34:39.066Z,1748997279.066 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:39.429Z,1748997279.429 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.095026 CHAN A1 (24V): 0.033816 CHAN A2 (12V): -0.018459 CHAN A3 (5V): -0.105118 CHAN B0 (3.3V): -0.029768 CHAN B1 (3.15aV): -0.012621 CHAN B2 (3.15bV): -0.006014 CHAN B3 (GND): -0.033189 OPEN: 0.009850 Full Scale: +/- 1 mA 2025-06-04T00:34:50.421Z,1748997290.421 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:34:59.142Z,1748997299.142 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003961 2025-06-04T00:35:01.332Z,1748997301.332 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:35:12.262Z,1748997312.262 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:35:23.212Z,1748997323.211 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:35:23.758Z,1748997323.758 [CommandExec](IMPORTANT): got command failComponent 2025-06-04T00:35:23.758Z,1748997323.758 [CommandExec](IMPORTANT): Failed components: 2025-06-04T00:35:23.759Z,1748997323.759 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-06-04T00:35:26.270Z,1748997326.270 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:35:26.466Z,1748997326.466 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:35:28.406Z,1748997328.406 [SBIT](IMPORTANT): SBIT PASSED 2025-06-04T00:35:28.406Z,1748997328.406 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2025-06-04T00:35:28.795Z,1748997328.795 [MissionManager](IMPORTANT): Started mission Startup 2025-06-04T00:35:28.795Z,1748997328.795 [Startup] Running Loop=1 2025-06-04T00:35:28.796Z,1748997328.796 [Startup](DEBUG): Aggregate::initialize Startup 2025-06-04T00:35:28.796Z,1748997328.796 [Startup:A.GoToSurface] Running Loop=1 2025-06-04T00:35:28.796Z,1748997328.796 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-04T00:35:28.796Z,1748997328.796 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-04T00:35:28.797Z,1748997328.797 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-04T00:35:28.797Z,1748997328.797 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-04T00:35:28.798Z,1748997328.798 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-04T00:35:28.798Z,1748997328.798 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-04T00:35:28.798Z,1748997328.798 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-04T00:35:28.800Z,1748997328.800 [Startup:StartupSatComms] Running Loop=1 2025-06-04T00:35:28.800Z,1748997328.800 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-06-04T00:35:28.800Z,1748997328.800 [Startup:StartupSatComms:A] Running Loop=1 2025-06-04T00:35:29.217Z,1748997329.217 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-06-04T00:35:30.897Z,1748997330.897 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.052763 CHAN A1 (24V): 0.034207 CHAN A2 (12V): -0.066126 CHAN A3 (5V): -0.080764 CHAN B0 (3.3V): -0.023343 CHAN B1 (3.15aV): -0.012076 CHAN B2 (3.15bV): -0.005125 CHAN B3 (GND): -0.048738 OPEN: 0.009885 Full Scale: +/- 1 mA 2025-06-04T00:35:34.522Z,1748997334.522 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:35:35.738Z,1748997335.738 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:35:36.121Z,1748997336.121 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:35:40.524Z,1748997340.524 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.031742 CHAN A1 (24V): 0.027624 CHAN A2 (12V): -0.072730 CHAN A3 (5V): -0.076494 CHAN B0 (3.3V): -0.023693 CHAN B1 (3.15aV): -0.011270 CHAN B2 (3.15bV): -0.006482 CHAN B3 (GND): -0.036079 OPEN: 0.008848 Full Scale: +/- 1 mA 2025-06-04T00:35:43.781Z,1748997343.781 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:35:44.172Z,1748997344.172 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:35:45.421Z,1748997345.421 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:35:47.377Z,1748997347.377 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-06-04T00:35:47.377Z,1748997347.377 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-04T00:35:47.387Z,1748997347.387 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-04T00:35:47.808Z,1748997347.808 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-04T00:35:47.808Z,1748997347.808 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-06-04T00:35:48.605Z,1748997348.605 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.046128 CHAN A1 (24V): 0.023928 CHAN A2 (12V): -0.072296 CHAN A3 (5V): -0.075823 CHAN B0 (3.3V): -0.023117 CHAN B1 (3.15aV): -0.011435 CHAN B2 (3.15bV): -0.006353 CHAN B3 (GND): -0.038307 OPEN: 0.010014 Full Scale: +/- 1 mA 2025-06-04T00:35:51.810Z,1748997351.810 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:35:51.915Z,1748997351.915 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:35:56.314Z,1748997356.314 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.042584 CHAN A1 (24V): 0.026050 CHAN A2 (12V): -0.048484 CHAN A3 (5V): -0.080846 CHAN B0 (3.3V): -0.027153 CHAN B1 (3.15aV): -0.010552 CHAN B2 (3.15bV): -0.005896 CHAN B3 (GND): -0.036288 OPEN: 0.009475 Full Scale: +/- 1 mA 2025-06-04T00:35:56.796Z,1748997356.796 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:36:00.161Z,1748997360.161 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:36:00.319Z,1748997360.319 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:36:04.766Z,1748997364.766 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.038296 CHAN A1 (24V): 0.030241 CHAN A2 (12V): -0.046171 CHAN A3 (5V): -0.069013 CHAN B0 (3.3V): -0.023160 CHAN B1 (3.15aV): -0.011158 CHAN B2 (3.15bV): -0.006732 CHAN B3 (GND): -0.040766 OPEN: 0.009908 Full Scale: +/- 1 mA 2025-06-04T00:36:07.661Z,1748997367.661 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:36:12.758Z,1748997372.758 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB4 2025-06-04T00:36:15.153Z,1748997375.153 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:36:15.275Z,1748997375.275 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:36:18.549Z,1748997378.549 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:36:19.717Z,1748997379.717 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006296 CHAN A1 (24V): 0.001166 CHAN A2 (12V): -0.005367 CHAN A3 (5V): -0.002536 CHAN B0 (3.3V): -0.001182 CHAN B1 (3.15aV): -0.001234 CHAN B2 (3.15bV): -0.000752 CHAN B3 (GND): 0.000015 OPEN: 0.006728 Full Scale: +/- 1 mA 2025-06-04T00:36:21.715Z,1748997381.715 [DVL_micro](ERROR): No DVL communication! Re-initializing 2025-06-04T00:36:21.715Z,1748997381.715 [DVL_micro] Communications Fault, FailCount= 1 2025-06-04T00:36:21.715Z,1748997381.715 [DVL_micro](ERROR): Communications Fault 2025-06-04T00:36:21.751Z,1748997381.751 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-06-04T00:36:22.213Z,1748997382.213 [DVL_micro](INFO): Powering down 2025-06-04T00:36:22.994Z,1748997382.994 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-06-04T00:36:22.994Z,1748997382.994 [DVL_micro] No Fault, FailCount= 1 2025-06-04T00:36:23.481Z,1748997383.481 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:36:23.764Z,1748997383.764 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:36:28.251Z,1748997388.251 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.051485 CHAN A1 (24V): 0.029740 CHAN A2 (12V): -0.043570 CHAN A3 (5V): -0.060497 CHAN B0 (3.3V): -0.018594 CHAN B1 (3.15aV): -0.010492 CHAN B2 (3.15bV): -0.005913 CHAN B3 (GND): -0.038012 OPEN: 0.009596 Full Scale: +/- 1 mA 2025-06-04T00:36:29.018Z,1748997389.018 [Startup:StartupSatComms:A](INFO): Timed out from 2025-06-04T00:35:28.8Z 2025-06-04T00:36:29.018Z,1748997389.018 [Startup:StartupSatComms:A] Stopped 2025-06-04T00:36:29.018Z,1748997389.018 [Startup:StartupSatComms:B] Running Loop=1 2025-06-04T00:36:29.471Z,1748997389.471 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:36:29.483Z,1748997389.483 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-04T00:36:30.330Z,1748997390.330 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250603T190938/Courier0016.lzma 2025-06-04T00:36:31.151Z,1748997391.151 [DataOverHttps](INFO): Moved sent file to Logs/20250603T190938/Courier0016.lzma.bak 2025-06-04T00:36:31.151Z,1748997391.151 [DataOverHttps](INFO): SBD MOMSN=25088324 2025-06-04T00:36:39.634Z,1748997399.634 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB4 2025-06-04T00:36:40.367Z,1748997400.367 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:36:41.922Z,1748997401.922 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:36:41.934Z,1748997401.934 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:36:46.403Z,1748997406.403 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.004973 CHAN A1 (24V): 0.001877 CHAN A2 (12V): -0.005276 CHAN A3 (5V): -0.003140 CHAN B0 (3.3V): -0.001597 CHAN B1 (3.15aV): -0.001161 CHAN B2 (3.15bV): -0.000999 CHAN B3 (GND): -0.000316 OPEN: 0.006772 Full Scale: +/- 1 mA 2025-06-04T00:36:47.117Z,1748997407.117 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20250604T003234/Courier0000.lzma 2025-06-04T00:36:48.118Z,1748997408.118 [DataOverHttps](INFO): Moved sent file to Logs/20250604T003234/Courier0000.lzma.bak 2025-06-04T00:36:48.119Z,1748997408.119 [DataOverHttps](INFO): SBD MOMSN=25088326 2025-06-04T00:36:48.834Z,1748997408.834 [DVL_micro](ERROR): No DVL communication! Re-initializing 2025-06-04T00:36:48.834Z,1748997408.834 [DVL_micro] Communications Fault, FailCount= 1 2025-06-04T00:36:48.834Z,1748997408.834 [DVL_micro](ERROR): Communications Fault 2025-06-04T00:36:48.882Z,1748997408.882 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-06-04T00:36:49.277Z,1748997409.277 [DVL_micro](INFO): Powering down 2025-06-04T00:36:50.010Z,1748997410.010 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-06-04T00:36:50.011Z,1748997410.011 [DVL_micro] No Fault, FailCount= 1 2025-06-04T00:36:50.457Z,1748997410.457 [CommandExec](IMPORTANT): got command gfscan 2025-06-04T00:36:50.835Z,1748997410.835 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T00:36:51.339Z,1748997411.339 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:36:55.286Z,1748997415.286 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.096067 CHAN A1 (24V): 0.037714 CHAN A2 (12V): -0.045232 CHAN A3 (5V): -0.066250 CHAN B0 (3.3V): -0.016748 CHAN B1 (3.15aV): -0.011316 CHAN B2 (3.15bV): -0.006397 CHAN B3 (GND): -0.038203 OPEN: 0.009740 Full Scale: +/- 1 mA 2025-06-04T00:37:02.231Z,1748997422.231 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:37:03.316Z,1748997423.316 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250603T190938/Express0017.lzma 2025-06-04T00:37:04.318Z,1748997424.318 [DataOverHttps](INFO): Moved sent file to Logs/20250603T190938/Express0017.lzma.bak 2025-06-04T00:37:04.319Z,1748997424.319 [DataOverHttps](INFO): SBD MOMSN=25088331 2025-06-04T00:37:06.657Z,1748997426.657 [CommandExec](IMPORTANT): got command configSet list 2025-06-04T00:37:06.657Z,1748997426.657 [CommandExec](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2025-06-04T00:37:12.386Z,1748997432.386 [CommandExec](IMPORTANT): got command restart system 2025-06-04T00:37:12.686Z,1748997432.686 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T00:37:14.477Z,1748997434.477 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T00:37:14.477Z,1748997434.477 [CommandExec](INFO): Uninitializing the command executive. 2025-06-04T00:37:14.477Z,1748997434.477 [CommandExec](INFO): Uninitializing the command scheduler. 2025-06-04T00:37:14.477Z,1748997434.477 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:14.597Z,1748997434.597 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-06-04T00:37:14.597Z,1748997434.597 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-06-04T00:37:14.597Z,1748997434.597 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:14.598Z,1748997434.598 [NavChartDb](INFO): Join timeout helper Thread ID is 4127 2025-06-04T00:37:14.830Z,1748997434.830 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T00:37:14.830Z,1748997434.830 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:14.849Z,1748997434.849 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-06-04T00:37:14.849Z,1748997434.849 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:14.849Z,1748997434.849 [Radio_Surface](INFO): Join timeout helper Thread ID is 4128 2025-06-04T00:37:15.041Z,1748997435.041 [Radio_Surface](INFO): Powering down 2025-06-04T00:37:15.042Z,1748997435.042 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T00:37:15.042Z,1748997435.042 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:15.045Z,1748997435.045 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-06-04T00:37:15.045Z,1748997435.045 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:15.045Z,1748997435.045 [Onboard](INFO): Join timeout helper Thread ID is 4129 2025-06-04T00:37:17.337Z,1748997437.337 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T00:37:17.337Z,1748997437.337 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:17.341Z,1748997437.341 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-06-04T00:37:17.341Z,1748997437.341 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:17.341Z,1748997437.341 [DataOverHttps](INFO): Join timeout helper Thread ID is 4130 2025-06-04T00:37:19.300Z,1748997439.300 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T00:37:19.303Z,1748997439.303 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:19.321Z,1748997439.321 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-06-04T00:37:19.321Z,1748997439.321 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:19.321Z,1748997439.321 [DAT](INFO): Join timeout helper Thread ID is 4131 2025-06-04T00:37:19.365Z,1748997439.365 [DAT](INFO): Powering down 2025-06-04T00:37:19.437Z,1748997439.437 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T00:37:19.437Z,1748997439.437 [DAT](INFO): Powering down 2025-06-04T00:37:19.438Z,1748997439.438 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:19.442Z,1748997439.442 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-06-04T00:37:19.442Z,1748997439.442 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:19.442Z,1748997439.442 [BackseatComponent](INFO): Join timeout helper Thread ID is 4132 2025-06-04T00:37:19.525Z,1748997439.525 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T00:37:19.525Z,1748997439.525 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-04T00:37:19.529Z,1748997439.529 [ComponentRegistry](INFO): Shutting down WetLabsB