2025-04-24T22:57:57.382Z,1745535477.382 [Supervisor](DEBUG): Initializing supervisor. 2025-04-24T22:57:57.386Z,1745535477.386 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-04-24T22:57:57.387Z,1745535477.387 [SyncHandler](INFO): Protected caller Thread ID is 8697 2025-04-24T22:57:57.387Z,1745535477.387 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-04-24T22:57:57.388Z,1745535477.388 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-04-24T22:57:57.389Z,1745535477.389 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8698 2025-04-24T22:57:57.393Z,1745535477.393 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-04-24T22:57:57.413Z,1745535477.413 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-04-24T22:57:57.414Z,1745535477.414 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-04-24T22:57:57.415Z,1745535477.415 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 8699 2025-04-24T22:57:57.419Z,1745535477.419 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-04-24T22:57:57.420Z,1745535477.420 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-04-24T22:57:57.420Z,1745535477.420 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8700 2025-04-24T22:57:57.423Z,1745535477.423 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-04-24T22:57:57.424Z,1745535477.424 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-04-24T22:57:57.424Z,1745535477.424 [logger ThreadHandler](INFO): Protected caller Thread ID is 8701 2025-04-24T22:57:57.428Z,1745535477.428 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-04-24T22:57:57.428Z,1745535477.428 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-04-24T22:57:57.430Z,1745535477.430 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-04-24T22:57:57.652Z,1745535477.652 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-04-24T22:57:57.652Z,1745535477.652 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-04-24T22:57:57.770Z,1745535477.770 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-04-24T22:57:57.770Z,1745535477.770 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-04-24T22:57:57.876Z,1745535477.876 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-04-24T22:57:57.877Z,1745535477.877 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-04-24T22:57:58.419Z,1745535478.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-04-24T22:57:58.420Z,1745535478.420 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-04-24T22:57:58.818Z,1745535478.818 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-04-24T22:57:58.818Z,1745535478.818 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-04-24T22:57:59.175Z,1745535479.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-04-24T22:57:59.176Z,1745535479.176 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-04-24T22:57:59.376Z,1745535479.376 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-04-24T22:57:59.377Z,1745535479.377 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-04-24T22:57:59.467Z,1745535479.467 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-04-24T22:57:59.558Z,1745535479.558 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-04-24T22:57:59.984Z,1745535479.984 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-04-24T22:57:59.984Z,1745535479.984 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-04-24T22:58:00.287Z,1745535480.287 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-04-24T22:58:00.287Z,1745535480.287 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-04-24T22:58:00.855Z,1745535480.855 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-04-24T22:58:00.855Z,1745535480.855 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-04-24T22:58:01.111Z,1745535481.111 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-04-24T22:58:01.111Z,1745535481.111 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-04-24T22:58:01.368Z,1745535481.368 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-04-24T22:58:01.368Z,1745535481.368 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-04-24T22:58:01.520Z,1745535481.520 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-04-24T22:58:01.520Z,1745535481.520 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-04-24T22:58:03.156Z,1745535483.156 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-04-24T22:58:03.158Z,1745535483.158 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2025-04-24T22:58:03.159Z,1745535483.159 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2025-04-24T22:58:03.256Z,1745535483.256 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2025-04-24T22:58:03.398Z,1745535483.398 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2025-04-24T22:58:03.678Z,1745535483.678 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-04-24T22:58:03.679Z,1745535483.679 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2025-04-24T22:58:03.814Z,1745535483.814 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2025-04-24T22:58:03.921Z,1745535483.921 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2025-04-24T22:58:04.025Z,1745535484.025 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2025-04-24T22:58:04.144Z,1745535484.144 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2025-04-24T22:58:04.239Z,1745535484.239 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2025-04-24T22:58:04.336Z,1745535484.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2025-04-24T22:58:04.437Z,1745535484.437 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2025-04-24T22:58:04.617Z,1745535484.617 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2025-04-24T22:58:04.618Z,1745535484.618 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-04-24T22:58:04.629Z,1745535484.629 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-04-24T22:58:04.681Z,1745535484.681 [DepthRateCalculator] Loaded 2025-04-24T22:58:04.681Z,1745535484.681 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-04-24T22:58:04.687Z,1745535484.687 [PitchRateCalculator] Loaded 2025-04-24T22:58:04.687Z,1745535484.687 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-04-24T22:58:04.698Z,1745535484.698 [SpeedCalculator] Loaded 2025-04-24T22:58:04.698Z,1745535484.698 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-04-24T22:58:04.703Z,1745535484.703 [YawRateCalculator] Loaded 2025-04-24T22:58:04.703Z,1745535484.703 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-04-24T22:58:04.725Z,1745535484.725 [ElevatorOffsetCalculator] Loaded 2025-04-24T22:58:04.725Z,1745535484.725 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-04-24T22:58:04.726Z,1745535484.726 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-04-24T22:58:04.726Z,1745535484.726 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-04-24T22:58:04.755Z,1745535484.755 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-04-24T22:58:04.756Z,1745535484.756 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-04-24T22:58:04.766Z,1745535484.766 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-04-24T22:58:04.767Z,1745535484.767 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-04-24T22:58:05.245Z,1745535485.245 [AHRS_M2] Loaded 2025-04-24T22:58:05.245Z,1745535485.245 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-04-24T22:58:05.284Z,1745535485.284 [BackseatComponent] Loaded 2025-04-24T22:58:05.284Z,1745535485.284 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-04-24T22:58:05.285Z,1745535485.285 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408754E0 2025-04-24T22:58:05.286Z,1745535485.286 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 8784 2025-04-24T22:58:05.289Z,1745535485.289 [LcmUniversalReporter] Loaded 2025-04-24T22:58:05.289Z,1745535485.289 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-04-24T22:58:06.089Z,1745535486.089 [BPC1] Loaded 2025-04-24T22:58:06.089Z,1745535486.089 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-04-24T22:58:06.185Z,1745535486.185 [DAT] Loaded 2025-04-24T22:58:06.186Z,1745535486.186 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-04-24T22:58:06.187Z,1745535486.187 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0 2025-04-24T22:58:06.187Z,1745535486.187 [DAT ThreadHandler](INFO): Protected caller Thread ID is 8785 2025-04-24T22:58:06.263Z,1745535486.263 [DataOverHttps] Loaded 2025-04-24T22:58:06.264Z,1745535486.264 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-04-24T22:58:06.265Z,1745535486.265 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0 2025-04-24T22:58:06.265Z,1745535486.265 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8786 2025-04-24T22:58:06.288Z,1745535486.288 [Depth_Keller] Loaded 2025-04-24T22:58:06.288Z,1745535486.288 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-04-24T22:58:06.293Z,1745535486.293 [DropWeight] Loaded 2025-04-24T22:58:06.294Z,1745535486.294 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-04-24T22:58:06.315Z,1745535486.315 [MultiRay](INFO): Found secondary power supply at: /dev/loadC7 2025-04-24T22:58:06.315Z,1745535486.315 [MultiRay] Loaded 2025-04-24T22:58:06.316Z,1745535486.316 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2025-04-24T22:58:06.380Z,1745535486.380 [NAL9602] Loaded 2025-04-24T22:58:06.381Z,1745535486.381 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-04-24T22:58:06.411Z,1745535486.411 [Onboard] Loaded 2025-04-24T22:58:06.411Z,1745535486.411 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-04-24T22:58:06.412Z,1745535486.412 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409054E0 2025-04-24T22:58:06.412Z,1745535486.412 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 8787 2025-04-24T22:58:06.418Z,1745535486.418 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2025-04-24T22:58:06.432Z,1745535486.432 [PowerOnly] Loaded 2025-04-24T22:58:06.432Z,1745535486.432 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-04-24T22:58:06.446Z,1745535486.446 [Power24vConverter] Loaded 2025-04-24T22:58:06.446Z,1745535486.446 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-04-24T22:58:06.464Z,1745535486.464 [Radio_Surface] Loaded 2025-04-24T22:58:06.464Z,1745535486.464 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-04-24T22:58:06.465Z,1745535486.465 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409354E0 2025-04-24T22:58:06.465Z,1745535486.465 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8788 2025-04-24T22:58:06.466Z,1745535486.466 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-04-24T22:58:06.467Z,1745535486.467 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-04-24T22:58:06.578Z,1745535486.578 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-04-24T22:58:06.579Z,1745535486.579 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-04-24T22:58:06.593Z,1745535486.593 [NavChart] Loaded 2025-04-24T22:58:06.593Z,1745535486.593 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-04-24T22:58:06.599Z,1745535486.599 [UniversalFixResidualReporter] Loaded 2025-04-24T22:58:06.599Z,1745535486.599 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-04-24T22:58:06.600Z,1745535486.600 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-04-24T22:58:06.600Z,1745535486.600 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-04-24T22:58:06.762Z,1745535486.762 [SBIT](DEBUG): Construct Startup Built In Test. 2025-04-24T22:58:06.776Z,1745535486.776 [SBIT] Loaded 2025-04-24T22:58:06.777Z,1745535486.777 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-04-24T22:58:06.780Z,1745535486.780 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-04-24T22:58:06.792Z,1745535486.792 [IBIT] Loaded 2025-04-24T22:58:06.793Z,1745535486.793 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-04-24T22:58:06.798Z,1745535486.798 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-04-24T22:58:06.878Z,1745535486.878 [CBIT] Loaded 2025-04-24T22:58:06.878Z,1745535486.878 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-04-24T22:58:06.909Z,1745535486.909 [GFScanner] Loaded 2025-04-24T22:58:06.910Z,1745535486.910 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-04-24T22:58:06.910Z,1745535486.910 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-04-24T22:58:06.910Z,1745535486.910 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-04-24T22:58:07.078Z,1745535487.078 [CTD_Seabird] Loaded 2025-04-24T22:58:07.078Z,1745535487.078 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-04-24T22:58:07.079Z,1745535487.079 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A474E0 2025-04-24T22:58:07.080Z,1745535487.080 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8789 2025-04-24T22:58:07.104Z,1745535487.104 [PAR_Licor] Loaded 2025-04-24T22:58:07.104Z,1745535487.104 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-04-24T22:58:07.150Z,1745535487.150 [WetLabsBB2FL] Loaded 2025-04-24T22:58:07.150Z,1745535487.150 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-04-24T22:58:07.151Z,1745535487.151 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0 2025-04-24T22:58:07.152Z,1745535487.152 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8790 2025-04-24T22:58:07.153Z,1745535487.153 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-04-24T22:58:07.153Z,1745535487.153 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-04-24T22:58:07.292Z,1745535487.292 [BuoyancyServo] Loaded 2025-04-24T22:58:07.292Z,1745535487.292 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-04-24T22:58:07.316Z,1745535487.316 [ElevatorServo] Loaded 2025-04-24T22:58:07.316Z,1745535487.316 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-04-24T22:58:07.340Z,1745535487.340 [MassServo] Loaded 2025-04-24T22:58:07.340Z,1745535487.340 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-04-24T22:58:07.363Z,1745535487.363 [RudderServo] Loaded 2025-04-24T22:58:07.363Z,1745535487.363 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-04-24T22:58:07.382Z,1745535487.382 [ThrusterHE] Loaded 2025-04-24T22:58:07.382Z,1745535487.382 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-04-24T22:58:07.382Z,1745535487.382 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-04-24T22:58:07.383Z,1745535487.383 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-04-24T22:58:07.438Z,1745535487.438 [VerticalControl](DEBUG): Construct VerticalControl. 2025-04-24T22:58:07.490Z,1745535487.490 [VerticalControl] Loaded 2025-04-24T22:58:07.490Z,1745535487.490 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-04-24T22:58:07.493Z,1745535487.493 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-04-24T22:58:07.537Z,1745535487.537 [HorizontalControl] Loaded 2025-04-24T22:58:07.537Z,1745535487.537 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-04-24T22:58:07.540Z,1745535487.540 [SpeedControl](DEBUG): Construct SpeedControl. 2025-04-24T22:58:07.542Z,1745535487.542 [SpeedControl] Loaded 2025-04-24T22:58:07.542Z,1745535487.542 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-04-24T22:58:07.545Z,1745535487.545 [LoopControl](DEBUG): Construct LoopControl. 2025-04-24T22:58:07.545Z,1745535487.545 [LoopControl] Loaded 2025-04-24T22:58:07.546Z,1745535487.546 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-04-24T22:58:07.546Z,1745535487.546 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-04-24T22:58:07.547Z,1745535487.547 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-04-24T22:58:07.679Z,1745535487.679 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-04-24T22:58:07.680Z,1745535487.680 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-04-24T22:58:07.855Z,1745535487.855 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-04-24T22:58:07.856Z,1745535487.856 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-04-24T22:58:08.212Z,1745535488.212 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-04-24T22:58:08.213Z,1745535488.213 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-04-24T22:58:08.542Z,1745535488.542 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-04-24T22:58:08.572Z,1745535488.572 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-04-24T22:58:08.575Z,1745535488.575 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-04-24T22:58:08.618Z,1745535488.618 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-04-24T22:58:08.619Z,1745535488.619 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0 2025-04-24T22:58:08.620Z,1745535488.620 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8791 2025-04-24T22:58:08.624Z,1745535488.624 [Supervisor](INFO): Main Thread ID is 8696 2025-04-24T22:58:08.624Z,1745535488.624 [Supervisor](DEBUG): Running supervisor. 2025-04-24T22:58:08.628Z,1745535488.628 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8793 2025-04-24T22:58:08.629Z,1745535488.629 [CommandExec ThreadHandler](INFO): Handler Thread ID is 8792 2025-04-24T22:58:08.630Z,1745535488.630 [CommandExec](INFO): Initializing the command executive. 2025-04-24T22:58:08.632Z,1745535488.632 [controlThread ThreadHandler](INFO): Handler Thread ID is 8794 2025-04-24T22:58:08.632Z,1745535488.632 [controlThread](DEBUG): Initializing ControlThread 2025-04-24T22:58:08.633Z,1745535488.633 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-04-24T22:58:08.633Z,1745535488.633 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-04-24T22:58:08.634Z,1745535488.634 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-04-24T22:58:08.634Z,1745535488.634 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-04-24T22:58:08.634Z,1745535488.634 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-04-24T22:58:08.639Z,1745535488.639 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-04-24T22:58:08.639Z,1745535488.639 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-04-24T22:58:08.640Z,1745535488.640 [SBIT](INFO): Initialize SBIT Component. 2025-04-24T22:58:08.640Z,1745535488.640 [SBIT](IMPORTANT): git: 2025-04-17_A-3-g239178f06 2025-04-24T22:58:08.640Z,1745535488.640 [SBIT](INFO): git hash: 239178f06e1908a99dae6b6ac2766c36a0a1292c 2025-04-24T22:58:08.640Z,1745535488.640 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-04-24T22:58:08.642Z,1745535488.642 [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-04-24T22:58:08.643Z,1745535488.643 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2025-04-24T22:58:08.643Z,1745535488.643 [IBIT](INFO): Initialize IBIT Component. 2025-04-24T22:58:08.644Z,1745535488.644 [CBIT](DEBUG): Initialize CBIT Component. 2025-04-24T22:58:08.645Z,1745535488.645 [logger ThreadHandler](INFO): Handler Thread ID is 8795 2025-04-24T22:58:08.657Z,1745535488.657 [CBIT](DEBUG): Initialized mux pins. 2025-04-24T22:58:08.657Z,1745535488.657 [CBIT](DEBUG): Initializing the watchdog timer. 2025-04-24T22:58:08.670Z,1745535488.670 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 8796 2025-04-24T22:58:08.681Z,1745535488.681 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-04-24T22:58:08.681Z,1745535488.681 [CBIT](DEBUG): Initializing heartbeat. 2025-04-24T22:58:08.682Z,1745535488.682 [DAT ThreadHandler](INFO): Handler Thread ID is 8797 2025-04-24T22:58:08.683Z,1745535488.683 [DAT](INFO): Powering up 2025-04-24T22:58:08.683Z,1745535488.683 [DAT](DEBUG): Initializing DAT. 2025-04-24T22:58:08.698Z,1745535488.698 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8799 2025-04-24T22:58:08.700Z,1745535488.700 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-04-24T22:58:08.702Z,1745535488.702 [Onboard ThreadHandler](INFO): Handler Thread ID is 8800 2025-04-24T22:58:08.715Z,1745535488.715 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8802 2025-04-24T22:58:08.718Z,1745535488.718 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T22:58:08.734Z,1745535488.734 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8801 2025-04-24T22:58:08.742Z,1745535488.742 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8804 2025-04-24T22:58:08.751Z,1745535488.751 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8805 2025-04-24T22:58:08.755Z,1745535488.755 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-04-24T22:58:08.755Z,1745535488.755 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-04-24T22:58:08.756Z,1745535488.756 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-04-24T22:58:08.756Z,1745535488.756 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-04-24T22:58:08.756Z,1745535488.756 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-04-24T22:58:08.756Z,1745535488.756 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-04-24T22:58:08.756Z,1745535488.756 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-04-24T22:58:08.756Z,1745535488.756 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-04-24T22:58:08.757Z,1745535488.757 [CBIT](DEBUG): Deactivating emergency mode. 2025-04-24T22:58:08.797Z,1745535488.797 [CBIT](DEBUG): Backplane powered. 2025-04-24T22:58:08.797Z,1745535488.797 [GFScanner](DEBUG): Initializing GFScanner 2025-04-24T22:58:08.798Z,1745535488.798 [GFScanner](DEBUG): Deactivating GF circuits. 2025-04-24T22:58:08.807Z,1745535488.807 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-04-24T22:58:08.808Z,1745535488.808 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-04-24T22:58:08.809Z,1745535488.809 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-04-24T22:58:08.810Z,1745535488.810 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-04-24T22:58:08.811Z,1745535488.811 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-04-24T22:58:08.811Z,1745535488.811 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-04-24T22:58:08.812Z,1745535488.812 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-04-24T22:58:08.814Z,1745535488.814 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-04-24T22:58:08.822Z,1745535488.822 [WetLabsBB2FL](INFO): Powering up 2025-04-24T22:58:08.859Z,1745535488.859 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-04-24T22:58:08.876Z,1745535488.876 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-24T22:58:08.900Z,1745535488.900 [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-24T22:58:08.901Z,1745535488.901 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-04-24T22:58:08.901Z,1745535488.901 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-04-24T22:58:08.902Z,1745535488.902 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-04-24T22:58:09.119Z,1745535489.119 [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-24T22:58:09.137Z,1745535489.137 [Radio_Surface](INFO): Powering up 2025-04-24T22:58:09.143Z,1745535489.143 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-04-24T22:58:09.145Z,1745535489.145 [Default:A.Wait](DEBUG): Construct Wait. 2025-04-24T22:58:09.163Z,1745535489.163 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-24T22:58:09.177Z,1745535489.177 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-04-24T22:58:09.189Z,1745535489.189 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-04-24T22:58:09.204Z,1745535489.204 [Default:E.Execute](DEBUG): Construct Execute. 2025-04-24T22:58:09.208Z,1745535489.208 [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-24T22:58:09.214Z,1745535489.214 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,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-24T22:58:09.221Z,1745535489.221 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-24T22:58:09.278Z,1745535489.278 [Depth_Keller](INFO): Initializing. 2025-04-24T22:58:09.279Z,1745535489.279 [MultiRay](INFO): Powering up MultiRay Lights 2025-04-24T22:58:09.279Z,1745535489.279 [MultiRay](INFO): Powering up secondary power supply. 2025-04-24T22:58:09.315Z,1745535489.315 [Power24vConverter](INFO): Powering up. 2025-04-24T22:58:09.322Z,1745535489.322 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-24T22:58:09.341Z,1745535489.341 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-04-24T22:58:09.345Z,1745535489.345 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-04-24T22:58:09.346Z,1745535489.346 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-04-24T22:58:09.353Z,1745535489.353 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-04-24T22:58:09.354Z,1745535489.354 [MassServo](DEBUG): Initializing EZServoServo. 2025-04-24T22:58:09.361Z,1745535489.361 [MassServo](DEBUG): Initializing MassServo. 2025-04-24T22:58:09.362Z,1745535489.362 [RudderServo](DEBUG): Initializing EZServoServo. 2025-04-24T22:58:09.369Z,1745535489.369 [RudderServo](DEBUG): Initializing RudderServo. 2025-04-24T22:58:09.370Z,1745535489.370 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-04-24T22:58:09.377Z,1745535489.377 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-04-24T22:58:09.671Z,1745535489.671 [Depth_Keller](ERROR): Pressure or depth reading out of range: 816.065491 decibar, 0.000000 m 2025-04-24T22:58:09.672Z,1745535489.672 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-04-24T22:58:09.672Z,1745535489.672 [DropWeight] Hardware Fault, FailCount= 1 2025-04-24T22:58:09.672Z,1745535489.672 [DropWeight](ERROR): Hardware Fault 2025-04-24T22:58:09.738Z,1745535489.738 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-24T22:58:09.755Z,1745535489.755 [CommandExec](FAULT): Scheduling is paused 2025-04-24T22:58:09.755Z,1745535489.755 [CBIT](INFO): Critical error at 20250424T225809 2025-04-24T22:58:09.755Z,1745535489.755 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-04-24T22:58:09.762Z,1745535489.762 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-04-24T22:58:09.762Z,1745535489.762 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-04-24T22:58:10.055Z,1745535490.055 [CBIT](INFO): Critical error at 20250424T225809 2025-04-24T22:58:10.433Z,1745535490.433 [MultiRay](INFO): Powering down 2025-04-24T22:58:10.554Z,1745535490.554 [MultiRay](INFO): Powering down LCB2 2025-04-24T22:58:11.361Z,1745535491.361 [WetLabsBB2FL](INFO): Powering down 2025-04-24T22:58:15.174Z,1745535495.174 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-04-24T22:58:18.388Z,1745535498.388 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004974 2025-04-24T22:58:20.526Z,1745535500.526 [DAT](INFO): DAT read: 2025-04-24T22:58:20.527Z,1745535500.527 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-04-24T22:58:22.038Z,1745535502.038 [DAT](INFO): DAT read: MF Frequency Band 2025-04-24T22:58:22.040Z,1745535502.040 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-04-24T22:58:22.040Z,1745535502.040 [DAT](INFO): DAT read: Apr 24 2025 22:46:22 2025-04-24T22:58:22.789Z,1745535502.789 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T22:58:22.789Z,1745535502.789 [CTD_Seabird] Communications Fault, FailCount= 1 2025-04-24T22:58:22.789Z,1745535502.789 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T22:58:23.042Z,1745535503.042 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T22:58:23.046Z,1745535503.046 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-04-24T22:58:23.048Z,1745535503.048 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-04-24T22:58:23.048Z,1745535503.048 [DAT](INFO): commRate: 800 2025-04-24T22:58:23.194Z,1745535503.194 [CTD_Seabird](INFO): Powering down 2025-04-24T22:58:24.257Z,1745535504.257 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T22:58:24.257Z,1745535504.257 [CTD_Seabird] No Fault, FailCount= 1 2025-04-24T22:58:24.542Z,1745535504.542 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T22:58:25.113Z,1745535505.113 [DAT](INFO): entering command mode 2025-04-24T22:58:25.314Z,1745535505.314 [DAT](INFO): DAT read: 2025-04-24T22:58:25.314Z,1745535505.314 [DAT](INFO): DAT read: user:1> 2025-04-24T22:58:25.315Z,1745535505.315 [DAT](INFO): setting verbose to 3 2025-04-24T22:58:25.566Z,1745535505.566 [DAT](INFO): DAT read: user:1> 2025-04-24T22:58:25.567Z,1745535505.567 [DAT](INFO): DAT read: Verbose | 3 2025-04-24T22:58:25.567Z,1745535505.567 [DAT](INFO): set verbose to 3 2025-04-24T22:58:25.568Z,1745535505.568 [DAT](INFO): setting DatVerbose to 27440 2025-04-24T22:58:25.820Z,1745535505.820 [DAT](INFO): DAT read: user:2> 2025-04-24T22:58:25.821Z,1745535505.821 [DAT](INFO): DAT read: DatVerbose | 27440 2025-04-24T22:58:25.821Z,1745535505.821 [DAT](INFO): set DatVerbose to 27440 2025-04-24T22:58:25.822Z,1745535505.822 [DAT](INFO): setting transmit power to 8 2025-04-24T22:58:26.074Z,1745535506.074 [DAT](INFO): DAT read: user:3> 2025-04-24T22:58:26.075Z,1745535506.075 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-04-24T22:58:26.075Z,1745535506.075 [DAT](INFO): set transmit power to 8 2025-04-24T22:58:26.075Z,1745535506.075 [DAT](INFO): setting local address to 9 2025-04-24T22:58:26.326Z,1745535506.326 [DAT](INFO): DAT read: user:4> 2025-04-24T22:58:26.327Z,1745535506.327 [DAT](INFO): DAT read: LocalAddr | 9 2025-04-24T22:58:26.327Z,1745535506.327 [DAT](INFO): set local address to 9 2025-04-24T22:58:26.328Z,1745535506.328 [DAT](INFO): Setting time to: 22:58:26 And date to:4/24/2025 2025-04-24T22:58:26.578Z,1745535506.578 [DAT](INFO): DAT read: user:5> 2025-04-24T22:58:26.579Z,1745535506.579 [DAT](INFO): DAT read: Thu Apr 24, 2025 22:58:26 2025-04-24T22:58:26.579Z,1745535506.579 [DAT](INFO): Local DAT time set to Thu Apr 24, 2025 22:58:26 2025-04-24T22:58:29.095Z,1745535509.095 [SBIT](IMPORTANT): Beginning Startup BIT 2025-04-24T22:58:29.099Z,1745535509.099 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-04-24T22:58:33.594Z,1745535513.594 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.002087 CHAN A1 (24V): 0.000851 CHAN A2 (12V): -0.005002 CHAN A3 (5V): -0.002813 CHAN B0 (3.3V): -0.000634 CHAN B1 (3.15aV): -0.001459 CHAN B2 (3.15bV): -0.001735 CHAN B3 (GND): -0.000584 OPEN: 0.004849 Full Scale: +/- 1 mA 2025-04-24T22:58:36.739Z,1745535516.739 [NAL9602](INFO): Powering up NAL9602 2025-04-24T22:58:37.593Z,1745535517.593 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T22:58:37.593Z,1745535517.593 [CTD_Seabird] Communications Fault, FailCount= 2 2025-04-24T22:58:37.594Z,1745535517.594 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T22:58:37.599Z,1745535517.599 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T22:58:38.005Z,1745535518.005 [CTD_Seabird](INFO): Powering down 2025-04-24T22:58:39.211Z,1745535519.211 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T22:58:39.211Z,1745535519.211 [CTD_Seabird] No Fault, FailCount= 2 2025-04-24T22:58:39.350Z,1745535519.350 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T22:58:42.439Z,1745535522.439 [SBIT](ERROR): Could not read massPosReader_. 2025-04-24T22:58:47.643Z,1745535527.643 [NAL9602](INFO): NAL9602 initialized 2025-04-24T22:58:52.405Z,1745535532.405 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T22:58:52.405Z,1745535532.405 [CTD_Seabird] Communications Fault, FailCount= 3 2025-04-24T22:58:52.405Z,1745535532.405 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T22:58:52.543Z,1745535532.543 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T22:58:52.543Z,1745535532.543 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2025-04-24T22:58:52.809Z,1745535532.809 [CTD_Seabird](INFO): Powering down 2025-04-24T22:59:06.606Z,1745535546.606 [CommandExec](IMPORTANT): got command failComponent 2025-04-24T22:59:06.606Z,1745535546.606 [CommandExec](IMPORTANT): Failed components: 2025-04-24T22:59:06.606Z,1745535546.606 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-04-24T22:59:06.606Z,1745535546.606 [CommandExec](IMPORTANT): CTD_Seabird: Communications Fault 2025-04-24T22:59:09.119Z,1745535549.119 [SBIT](ERROR): Could not read massPosReader_. 2025-04-24T22:59:09.119Z,1745535549.119 [SBIT](FAULT): Control surface position failure. 2025-04-24T22:59:20.434Z,1745535560.434 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T22:59:22.864Z,1745535562.864 [SBIT](ERROR): Could not read massPosReader_. 2025-04-24T22:59:22.864Z,1745535562.864 [SBIT](FAULT): Control surface position failure. 2025-04-24T22:59:23.262Z,1745535563.262 [SBIT](CRITICAL): SBIT FAILED 2025-04-24T22:59:23.262Z,1745535563.262 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-04-24T22:59:23.263Z,1745535563.263 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=1 bool; 2025-04-24T22:59:23.263Z,1745535563.263 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): MultiRay.brightnessWhite=100 none; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=1 bool; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=0 bool; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=297.568711 cubic_centimeter; 2025-04-24T22:59:23.264Z,1745535563.264 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool; 2025-04-24T22:59:23.282Z,1745535563.282 [CBIT](INFO): Critical error at 20250424T225923 2025-04-24T22:59:23.628Z,1745535563.628 [MissionManager](IMPORTANT): Started mission Startup 2025-04-24T22:59:23.628Z,1745535563.628 [Startup] Running Loop=1 2025-04-24T22:59:23.628Z,1745535563.628 [Startup](DEBUG): Aggregate::initialize Startup 2025-04-24T22:59:23.628Z,1745535563.628 [Startup:A.GoToSurface] Running Loop=1 2025-04-24T22:59:23.628Z,1745535563.628 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-24T22:59:23.633Z,1745535563.633 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-24T22:59:23.634Z,1745535563.634 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-24T22:59:23.634Z,1745535563.634 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-24T22:59:23.634Z,1745535563.634 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-24T22:59:23.635Z,1745535563.635 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-24T22:59:23.635Z,1745535563.635 [Sta