2025-06-25T22:41:27.323Z,1750891287.323 [Supervisor](DEBUG): Initializing supervisor. 2025-06-25T22:41:27.327Z,1750891287.327 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-06-25T22:41:27.328Z,1750891287.328 [SyncHandler](INFO): Protected caller Thread ID is 8326 2025-06-25T22:41:27.328Z,1750891287.328 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-06-25T22:41:27.329Z,1750891287.329 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-06-25T22:41:27.330Z,1750891287.330 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8327 2025-06-25T22:41:27.333Z,1750891287.333 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-06-25T22:41:27.350Z,1750891287.350 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-06-25T22:41:27.352Z,1750891287.352 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-06-25T22:41:27.352Z,1750891287.352 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 8328 2025-06-25T22:41:27.356Z,1750891287.356 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-06-25T22:41:27.357Z,1750891287.357 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-06-25T22:41:27.357Z,1750891287.357 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8329 2025-06-25T22:41:27.359Z,1750891287.359 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-06-25T22:41:27.360Z,1750891287.360 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-06-25T22:41:27.361Z,1750891287.361 [logger ThreadHandler](INFO): Protected caller Thread ID is 8330 2025-06-25T22:41:27.364Z,1750891287.364 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-06-25T22:41:27.364Z,1750891287.364 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-06-25T22:41:27.366Z,1750891287.366 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-06-25T22:41:27.732Z,1750891287.732 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-06-25T22:41:27.732Z,1750891287.732 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-06-25T22:41:28.617Z,1750891288.617 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-06-25T22:41:28.618Z,1750891288.618 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-06-25T22:41:28.741Z,1750891288.741 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-06-25T22:41:28.742Z,1750891288.742 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-06-25T22:41:29.345Z,1750891289.345 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-06-25T22:41:29.345Z,1750891289.345 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-06-25T22:41:29.459Z,1750891289.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-06-25T22:41:29.460Z,1750891289.460 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-06-25T22:41:29.556Z,1750891289.556 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-06-25T22:41:30.028Z,1750891290.028 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-06-25T22:41:30.029Z,1750891290.029 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-06-25T22:41:30.289Z,1750891290.289 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-06-25T22:41:30.289Z,1750891290.289 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-06-25T22:41:30.452Z,1750891290.452 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-06-25T22:41:30.453Z,1750891290.453 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-06-25T22:41:30.743Z,1750891290.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-06-25T22:41:30.744Z,1750891290.744 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-06-25T22:41:31.327Z,1750891291.327 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-06-25T22:41:31.328Z,1750891291.328 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-06-25T22:41:31.742Z,1750891291.742 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-06-25T22:41:31.743Z,1750891291.743 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-06-25T22:41:31.837Z,1750891291.837 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-06-25T22:41:32.056Z,1750891292.056 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-06-25T22:41:32.056Z,1750891292.056 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-06-25T22:41:32.321Z,1750891292.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-06-25T22:41:32.321Z,1750891292.321 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-06-25T22:41:33.150Z,1750891293.150 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-06-25T22:41:33.152Z,1750891293.152 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2025-06-25T22:41:33.153Z,1750891293.153 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2025-06-25T22:41:33.276Z,1750891293.276 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2025-06-25T22:41:33.447Z,1750891293.447 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2025-06-25T22:41:33.548Z,1750891293.548 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2025-06-25T22:41:33.646Z,1750891293.646 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2025-06-25T22:41:33.772Z,1750891293.772 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg 2025-06-25T22:41:33.870Z,1750891293.870 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2025-06-25T22:41:33.992Z,1750891293.992 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2025-06-25T22:41:34.269Z,1750891294.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-06-25T22:41:34.270Z,1750891294.270 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2025-06-25T22:41:34.422Z,1750891294.422 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2025-06-25T22:41:34.531Z,1750891294.531 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2025-06-25T22:41:34.641Z,1750891294.641 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2025-06-25T22:41:34.753Z,1750891294.753 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/ 2025-06-25T22:41:34.753Z,1750891294.753 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-06-25T22:41:34.772Z,1750891294.772 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-06-25T22:41:34.880Z,1750891294.880 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-06-25T22:41:34.880Z,1750891294.880 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-06-25T22:41:34.890Z,1750891294.890 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-06-25T22:41:34.891Z,1750891294.891 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-06-25T22:41:34.940Z,1750891294.940 [DepthRateCalculator] Loaded 2025-06-25T22:41:34.940Z,1750891294.940 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-06-25T22:41:34.946Z,1750891294.946 [PitchRateCalculator] Loaded 2025-06-25T22:41:34.946Z,1750891294.946 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-06-25T22:41:34.956Z,1750891294.956 [SpeedCalculator] Loaded 2025-06-25T22:41:34.956Z,1750891294.956 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-06-25T22:41:34.961Z,1750891294.961 [YawRateCalculator] Loaded 2025-06-25T22:41:34.961Z,1750891294.961 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-06-25T22:41:34.982Z,1750891294.982 [ElevatorOffsetCalculator] Loaded 2025-06-25T22:41:34.982Z,1750891294.982 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-06-25T22:41:34.982Z,1750891294.982 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-06-25T22:41:34.983Z,1750891294.983 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-06-25T22:41:35.033Z,1750891295.033 [VerticalControl](DEBUG): Construct VerticalControl. 2025-06-25T22:41:35.087Z,1750891295.087 [VerticalControl] Loaded 2025-06-25T22:41:35.087Z,1750891295.087 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-06-25T22:41:35.090Z,1750891295.090 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-06-25T22:41:35.134Z,1750891295.134 [HorizontalControl] Loaded 2025-06-25T22:41:35.135Z,1750891295.135 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-06-25T22:41:35.137Z,1750891295.137 [SpeedControl](DEBUG): Construct SpeedControl. 2025-06-25T22:41:35.140Z,1750891295.140 [SpeedControl] Loaded 2025-06-25T22:41:35.140Z,1750891295.140 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-06-25T22:41:35.142Z,1750891295.142 [LoopControl](DEBUG): Construct LoopControl. 2025-06-25T22:41:35.143Z,1750891295.143 [LoopControl] Loaded 2025-06-25T22:41:35.143Z,1750891295.143 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-06-25T22:41:35.143Z,1750891295.143 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-06-25T22:41:35.144Z,1750891295.144 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-06-25T22:41:35.251Z,1750891295.251 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-06-25T22:41:35.251Z,1750891295.251 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-06-25T22:41:35.265Z,1750891295.265 [NavChart] Loaded 2025-06-25T22:41:35.265Z,1750891295.265 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-06-25T22:41:35.270Z,1750891295.270 [UniversalFixResidualReporter] Loaded 2025-06-25T22:41:35.271Z,1750891295.271 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-06-25T22:41:35.271Z,1750891295.271 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-06-25T22:41:35.272Z,1750891295.272 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-06-25T22:41:35.438Z,1750891295.438 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-06-25T22:41:35.439Z,1750891295.439 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-06-25T22:41:35.885Z,1750891295.885 [AHRS_M2] Loaded 2025-06-25T22:41:35.886Z,1750891295.886 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-06-25T22:41:35.924Z,1750891295.924 [BackseatComponent] Loaded 2025-06-25T22:41:35.924Z,1750891295.924 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-06-25T22:41:35.925Z,1750891295.925 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409384E0 2025-06-25T22:41:35.926Z,1750891295.926 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 8416 2025-06-25T22:41:35.928Z,1750891295.928 [LcmUniversalReporter] Loaded 2025-06-25T22:41:35.929Z,1750891295.929 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-06-25T22:41:36.736Z,1750891296.736 [BPC1] Loaded 2025-06-25T22:41:36.737Z,1750891296.737 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-06-25T22:41:36.822Z,1750891296.822 [DATMMP] Loaded 2025-06-25T22:41:36.823Z,1750891296.823 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2025-06-25T22:41:36.824Z,1750891296.824 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409694E0 2025-06-25T22:41:36.824Z,1750891296.824 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 8417 2025-06-25T22:41:36.900Z,1750891296.900 [DataOverHttps] Loaded 2025-06-25T22:41:36.900Z,1750891296.900 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-06-25T22:41:36.901Z,1750891296.901 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409994E0 2025-06-25T22:41:36.902Z,1750891296.902 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8418 2025-06-25T22:41:36.925Z,1750891296.925 [Depth_Keller] Loaded 2025-06-25T22:41:36.925Z,1750891296.925 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-06-25T22:41:36.964Z,1750891296.964 [DVL_micro] Loaded 2025-06-25T22:41:36.964Z,1750891296.964 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2025-06-25T22:41:37.027Z,1750891297.027 [NAL9602] Loaded 2025-06-25T22:41:37.027Z,1750891297.027 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-06-25T22:41:37.056Z,1750891297.056 [Onboard] Loaded 2025-06-25T22:41:37.057Z,1750891297.057 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-06-25T22:41:37.058Z,1750891297.058 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409C94E0 2025-06-25T22:41:37.058Z,1750891297.058 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 8419 2025-06-25T22:41:37.072Z,1750891297.072 [Power24vConverter] Loaded 2025-06-25T22:41:37.073Z,1750891297.073 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-06-25T22:41:37.088Z,1750891297.088 [Radio_Surface] Loaded 2025-06-25T22:41:37.088Z,1750891297.088 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-06-25T22:41:37.089Z,1750891297.089 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409F94E0 2025-06-25T22:41:37.089Z,1750891297.089 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8420 2025-06-25T22:41:37.104Z,1750891297.104 [Sonardyne_Nano] Loaded 2025-06-25T22:41:37.105Z,1750891297.105 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-06-25T22:41:37.105Z,1750891297.105 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-06-25T22:41:37.106Z,1750891297.106 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-06-25T22:41:37.235Z,1750891297.235 [BuoyancyServo] Loaded 2025-06-25T22:41:37.235Z,1750891297.235 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-06-25T22:41:37.257Z,1750891297.257 [ElevatorServo] Loaded 2025-06-25T22:41:37.258Z,1750891297.258 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-06-25T22:41:37.279Z,1750891297.279 [MassServo] Loaded 2025-06-25T22:41:37.280Z,1750891297.280 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-06-25T22:41:37.299Z,1750891297.299 [RudderServo] Loaded 2025-06-25T22:41:37.300Z,1750891297.300 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-06-25T22:41:37.315Z,1750891297.315 [ThrusterHE] Loaded 2025-06-25T22:41:37.316Z,1750891297.316 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-06-25T22:41:37.316Z,1750891297.316 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-06-25T22:41:37.317Z,1750891297.317 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-06-25T22:41:37.464Z,1750891297.464 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-06-25T22:41:37.465Z,1750891297.465 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-06-25T22:41:37.689Z,1750891297.689 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-06-25T22:41:37.690Z,1750891297.690 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-06-25T22:41:38.226Z,1750891298.226 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-06-25T22:41:38.226Z,1750891298.226 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-06-25T22:41:38.399Z,1750891298.399 [CTD_Seabird] Loaded 2025-06-25T22:41:38.399Z,1750891298.399 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-06-25T22:41:38.401Z,1750891298.401 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BB34E0 2025-06-25T22:41:38.401Z,1750891298.401 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8421 2025-06-25T22:41:38.436Z,1750891298.436 [ESPComponent] Loaded 2025-06-25T22:41:38.436Z,1750891298.436 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-06-25T22:41:38.458Z,1750891298.458 [PAR_Licor] Loaded 2025-06-25T22:41:38.458Z,1750891298.458 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-06-25T22:41:38.501Z,1750891298.501 [WetLabsBB2FL] Loaded 2025-06-25T22:41:38.502Z,1750891298.502 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-06-25T22:41:38.503Z,1750891298.503 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BE34E0 2025-06-25T22:41:38.503Z,1750891298.503 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8422 2025-06-25T22:41:38.504Z,1750891298.504 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-06-25T22:41:38.504Z,1750891298.504 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-06-25T22:41:38.646Z,1750891298.646 [SBIT](DEBUG): Construct Startup Built In Test. 2025-06-25T22:41:38.655Z,1750891298.655 [SBIT] Loaded 2025-06-25T22:41:38.655Z,1750891298.655 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-06-25T22:41:38.658Z,1750891298.658 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-06-25T22:41:38.670Z,1750891298.670 [IBIT] Loaded 2025-06-25T22:41:38.671Z,1750891298.671 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-06-25T22:41:38.676Z,1750891298.676 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-06-25T22:41:38.785Z,1750891298.785 [CBIT] Loaded 2025-06-25T22:41:38.785Z,1750891298.785 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-06-25T22:41:38.785Z,1750891298.785 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-06-25T22:41:38.792Z,1750891298.792 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-06-25T22:41:38.794Z,1750891298.794 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-06-25T22:41:38.808Z,1750891298.808 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-06-25T22:41:38.809Z,1750891298.809 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C524E0 2025-06-25T22:41:38.809Z,1750891298.809 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8423 2025-06-25T22:41:38.814Z,1750891298.814 [Supervisor](INFO): Main Thread ID is 8325 2025-06-25T22:41:38.814Z,1750891298.814 [Supervisor](DEBUG): Running supervisor. 2025-06-25T22:41:38.815Z,1750891298.815 [CommandExec ThreadHandler](INFO): Handler Thread ID is 8424 2025-06-25T22:41:38.815Z,1750891298.815 [CommandExec](INFO): Initializing the command executive. 2025-06-25T22:41:38.817Z,1750891298.817 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8425 2025-06-25T22:41:38.819Z,1750891298.819 [controlThread ThreadHandler](INFO): Handler Thread ID is 8426 2025-06-25T22:41:38.819Z,1750891298.819 [controlThread](DEBUG): Initializing ControlThread 2025-06-25T22:41:38.820Z,1750891298.820 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-06-25T22:41:38.820Z,1750891298.820 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-06-25T22:41:38.821Z,1750891298.821 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-06-25T22:41:38.821Z,1750891298.821 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-06-25T22:41:38.821Z,1750891298.821 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-06-25T22:41:38.822Z,1750891298.822 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-06-25T22:41:38.824Z,1750891298.824 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-06-25T22:41:38.825Z,1750891298.825 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-06-25T22:41:38.825Z,1750891298.825 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-06-25T22:41:38.826Z,1750891298.826 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-06-25T22:41:38.826Z,1750891298.826 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-06-25T22:41:38.843Z,1750891298.843 [SBIT](INFO): Initialize SBIT Component. 2025-06-25T22:41:38.844Z,1750891298.844 [SBIT](IMPORTANT): git: 2024-09-17 2025-06-25T22:41:38.844Z,1750891298.844 [SBIT](INFO): git hash: 40e9ce87bff78b617219447905233bfcf6062b37 2025-06-25T22:41:38.844Z,1750891298.844 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-06-25T22:41:38.845Z,1750891298.845 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2025-06-25T22:41:38.846Z,1750891298.846 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2025-06-25T22:41:38.847Z,1750891298.847 [IBIT](INFO): Initialize IBIT Component. 2025-06-25T22:41:38.848Z,1750891298.848 [CBIT](DEBUG): Initialize CBIT Component. 2025-06-25T22:41:38.849Z,1750891298.849 [logger ThreadHandler](INFO): Handler Thread ID is 8427 2025-06-25T22:41:38.859Z,1750891298.859 [CBIT](DEBUG): Initialized mux pins. 2025-06-25T22:41:38.859Z,1750891298.859 [CBIT](DEBUG): Initializing the watchdog timer. 2025-06-25T22:41:38.867Z,1750891298.867 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 8428 2025-06-25T22:41:38.879Z,1750891298.879 [DATMMP ThreadHandler](INFO): Handler Thread ID is 8429 2025-06-25T22:41:38.880Z,1750891298.880 [DATMMP](INFO): Start 2025-06-25T22:41:38.880Z,1750891298.880 [DATMMP](INFO): Powering up 2025-06-25T22:41:38.880Z,1750891298.880 [DATMMP](DEBUG): Initializing DATMMP. 2025-06-25T22:41:38.883Z,1750891298.883 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-06-25T22:41:38.883Z,1750891298.883 [CBIT](DEBUG): Initializing heartbeat. 2025-06-25T22:41:38.885Z,1750891298.885 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8431 2025-06-25T22:41:38.887Z,1750891298.887 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-06-25T22:41:38.896Z,1750891298.896 [Onboard ThreadHandler](INFO): Handler Thread ID is 8432 2025-06-25T22:41:38.913Z,1750891298.913 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8433 2025-06-25T22:41:38.931Z,1750891298.931 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8434 2025-06-25T22:41:38.932Z,1750891298.932 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-06-25T22:41:38.936Z,1750891298.936 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8436 2025-06-25T22:41:38.939Z,1750891298.939 [WetLabsBB2FL](INFO): Powering up 2025-06-25T22:41:38.941Z,1750891298.941 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8438 2025-06-25T22:41:38.943Z,1750891298.943 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-06-25T22:41:38.943Z,1750891298.943 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-06-25T22:41:38.943Z,1750891298.943 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-06-25T22:41:38.944Z,1750891298.944 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-06-25T22:41:38.944Z,1750891298.944 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-06-25T22:41:38.944Z,1750891298.944 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-06-25T22:41:38.944Z,1750891298.944 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-06-25T22:41:38.944Z,1750891298.944 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-06-25T22:41:38.955Z,1750891298.955 [CBIT](DEBUG): Deactivating GF circuits. 2025-06-25T22:41:38.955Z,1750891298.955 [CBIT](DEBUG): Deactivating emergency mode. 2025-06-25T22:41:38.995Z,1750891298.995 [CBIT](DEBUG): Backplane powered. 2025-06-25T22:41:38.996Z,1750891298.996 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-06-25T22:41:38.996Z,1750891298.996 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-06-25T22:41:38.997Z,1750891298.997 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-06-25T22:41:38.998Z,1750891298.998 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-06-25T22:41:39.038Z,1750891299.038 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-06-25T22:41:39.059Z,1750891299.059 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-25T22:41:39.107Z,1750891299.107 [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-25T22:41:39.108Z,1750891299.108 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-06-25T22:41:39.108Z,1750891299.108 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-06-25T22:41:39.109Z,1750891299.109 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-06-25T22:41:39.131Z,1750891299.131 [DATMMP](INFO): Starting 2025-06-25T22:41:39.320Z,1750891299.320 [Radio_Surface](INFO): Powering up 2025-06-25T22:41:39.383Z,1750891299.383 [DATMMP](INFO): Starting 2025-06-25T22:41:39.425Z,1750891299.425 [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-25T22:41:39.450Z,1750891299.450 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-06-25T22:41:39.460Z,1750891299.460 [Default:A.Wait](DEBUG): Construct Wait. 2025-06-25T22:41:39.462Z,1750891299.462 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-25T22:41:39.508Z,1750891299.508 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-06-25T22:41:39.515Z,1750891299.515 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-06-25T22:41:39.537Z,1750891299.537 [Default:E.Execute](DEBUG): Construct Execute. 2025-06-25T22:41:39.540Z,1750891299.540 [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-25T22:41:39.545Z,1750891299.545 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2025-06-25T22:41:39.568Z,1750891299.568 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-06-25T22:41:39.635Z,1750891299.635 [DATMMP](INFO): Starting 2025-06-25T22:41:39.644Z,1750891299.644 [Power24vConverter](INFO): Powering up. 2025-06-25T22:41:39.645Z,1750891299.645 [Sonardyne_Nano](INFO): Initializing. 2025-06-25T22:41:39.709Z,1750891299.709 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-06-25T22:41:39.719Z,1750891299.719 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-06-25T22:41:39.720Z,1750891299.720 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-25T22:41:39.727Z,1750891299.727 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-25T22:41:39.728Z,1750891299.728 [MassServo](DEBUG): Initializing EZServoServo. 2025-06-25T22:41:39.735Z,1750891299.735 [MassServo](DEBUG): Initializing MassServo. 2025-06-25T22:41:39.736Z,1750891299.736 [RudderServo](DEBUG): Initializing EZServoServo. 2025-06-25T22:41:39.743Z,1750891299.743 [RudderServo](DEBUG): Initializing RudderServo. 2025-06-25T22:41:39.744Z,1750891299.744 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-06-25T22:41:39.752Z,1750891299.752 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-06-25T22:41:39.899Z,1750891299.899 [DATMMP](INFO): Starting 2025-06-25T22:41:40.151Z,1750891300.151 [DATMMP](INFO): Starting 2025-06-25T22:41:40.404Z,1750891300.404 [DATMMP](INFO): Starting 2025-06-25T22:41:40.655Z,1750891300.655 [DATMMP](INFO): Starting 2025-06-25T22:41:40.908Z,1750891300.908 [DATMMP](INFO): Starting 2025-06-25T22:41:41.047Z,1750891301.047 [WetLabsBB2FL](INFO): Powering down 2025-06-25T22:41:41.159Z,1750891301.159 [DATMMP](INFO): Starting 2025-06-25T22:41:41.411Z,1750891301.411 [DATMMP](INFO): Starting 2025-06-25T22:41:41.573Z,1750891301.573 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-06-25T22:41:41.663Z,1750891301.663 [DATMMP](INFO): Starting 2025-06-25T22:41:41.915Z,1750891301.915 [DATMMP](INFO): Starting 2025-06-25T22:41:42.167Z,1750891302.167 [DATMMP](INFO): Starting 2025-06-25T22:41:42.419Z,1750891302.419 [DATMMP](INFO): Starting 2025-06-25T22:41:42.671Z,1750891302.671 [DATMMP](INFO): Starting 2025-06-25T22:41:42.861Z,1750891302.861 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2207 2025-06-25T22:41:42.923Z,1750891302.923 [DATMMP](INFO): Starting 2025-06-25T22:41:43.175Z,1750891303.175 [DATMMP](INFO): Starting 2025-06-25T22:41:43.427Z,1750891303.427 [DATMMP](INFO): Starting 2025-06-25T22:41:43.679Z,1750891303.679 [DATMMP](INFO): Starting 2025-06-25T22:41:43.931Z,1750891303.931 [DATMMP](INFO): Starting 2025-06-25T22:41:44.183Z,1750891304.183 [DATMMP](INFO): Starting 2025-06-25T22:41:44.435Z,1750891304.435 [DATMMP](INFO): Starting 2025-06-25T22:41:44.687Z,1750891304.687 [DATMMP](INFO): Starting 2025-06-25T22:41:44.939Z,1750891304.939 [DATMMP](INFO): Starting 2025-06-25T22:41:45.191Z,1750891305.191 [DATMMP](INFO): Starting 2025-06-25T22:41:45.404Z,1750891305.404 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-06-25T22:41:45.443Z,1750891305.443 [DATMMP](INFO): Starting 2025-06-25T22:41:45.695Z,1750891305.695 [DATMMP](INFO): Starting 2025-06-25T22:41:45.947Z,1750891305.947 [DATMMP](INFO): Starting 2025-06-25T22:41:45.971Z,1750891305.971 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2025-06-25T22:41:46.199Z,1750891306.199 [DATMMP](INFO): Starting 2025-06-25T22:41:46.455Z,1750891306.455 [DATMMP](INFO): Starting 2025-06-25T22:41:46.707Z,1750891306.707 [DATMMP](INFO): Starting 2025-06-25T22:41:46.959Z,1750891306.959 [DATMMP](INFO): Starting 2025-06-25T22:41:47.211Z,1750891307.211 [DATMMP](INFO): Starting 2025-06-25T22:41:47.463Z,1750891307.463 [DATMMP](INFO): Starting 2025-06-25T22:41:47.715Z,1750891307.715 [DATMMP](INFO): Starting 2025-06-25T22:41:47.967Z,1750891307.967 [DATMMP](INFO): Starting 2025-06-25T22:41:48.219Z,1750891308.219 [DATMMP](INFO): Starting 2025-06-25T22:41:48.471Z,1750891308.471 [DATMMP](INFO): Starting 2025-06-25T22:41:48.723Z,1750891308.723 [DATMMP](INFO): Starting 2025-06-25T22:41:48.966Z,1750891308.966 [CBIT](CRITICAL): Environmental Failure. Press:14.692290 PSI. Humidity:41%. Temp:24 C. ABORTING MISSION 2025-06-25T22:41:48.966Z,1750891308.966 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2025-06-25T22:41:48.975Z,1750891308.975 [DATMMP](INFO): Starting 2025-06-25T22:41:49.227Z,1750891309.227 [DATMMP](INFO): Starting 2025-06-25T22:41:49.319Z,1750891309.319 [CommandExec](FAULT): Scheduling is paused 2025-06-25T22:41:49.320Z,1750891309.320 [CBIT](INFO): Critical error at 20250625T224148 2025-06-25T22:41:49.479Z,1750891309.479 [DATMMP](INFO): Starting 2025-06-25T22:41:49.731Z,1750891309.731 [DATMMP](INFO): Starting 2025-06-25T22:41:49.983Z,1750891309.983 [DATMMP](INFO): Starting 2025-06-25T22:41:50.235Z,1750891310.235 [DATMMP](INFO): Starting 2025-06-25T22:41:50.487Z,1750891310.487 [DATMMP](INFO): Starting 2025-06-25T22:41:50.739Z,1750891310.739 [DATMMP](INFO): Starting 2025-06-25T22:41:50.991Z,1750891310.991 [DATMMP](INFO): Starting 2025-06-25T22:41:50.992Z,1750891310.992 [DATMMP](INFO): DAT read: 2025-06-25T22:41:50.992Z,1750891310.992 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-06-25T22:41:51.243Z,1750891311.243 [DATMMP](INFO): Starting 2025-06-25T22:41:51.495Z,1750891311.495 [DATMMP](INFO): Starting 2025-06-25T22:41:51.747Z,1750891311.747 [DATMMP](INFO): Starting 2025-06-25T22:41:51.999Z,1750891311.999 [DATMMP](INFO): Starting 2025-06-25T22:41:52.251Z,1750891312.251 [DATMMP](INFO): Starting 2025-06-25T22:41:52.503Z,1750891312.503 [DATMMP](INFO): Starting 2025-06-25T22:41:52.709Z,1750891312.709 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004704 2025-06-25T22:41:52.755Z,1750891312.755 [DATMMP](INFO): Starting 2025-06-25T22:41:52.756Z,1750891312.756 [DATMMP](INFO): DAT read: MF Frequency Band 2025-06-25T22:41:52.757Z,1750891312.757 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-06-25T22:41:52.757Z,1750891312.757 [DATMMP](INFO): DAT read: Jan 23 2000 03:21:02 2025-06-25T22:41:53.007Z,1750891313.007 [DATMMP](INFO): Starting 2025-06-25T22:41:53.259Z,1750891313.259 [DATMMP](INFO): Starting 2025-06-25T22:41:53.511Z,1750891313.511 [DATMMP](INFO): Starting 2025-06-25T22:41:53.764Z,1750891313.764 [DATMMP](INFO): Starting 2025-06-25T22:41:53.767Z,1750891313.767 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2025-06-25T22:41:54.015Z,1750891314.015 [DATMMP](INFO): Starting 2025-06-25T22:41:54.016Z,1750891314.016 [DATMMP](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2025-06-25T22:41:54.016Z,1750891314.016 [DATMMP](INFO): commRate: 600 2025-06-25T22:41:54.267Z,1750891314.267 [DATMMP](INFO): Starting 2025-06-25T22:41:54.519Z,1750891314.519 [DATMMP](INFO): Starting 2025-06-25T22:41:54.771Z,1750891314.771 [DATMMP](INFO): Starting 2025-06-25T22:41:55.023Z,1750891315.023 [DATMMP](INFO): Starting 2025-06-25T22:41:55.275Z,1750891315.275 [DATMMP](INFO): Starting 2025-06-25T22:41:55.527Z,1750891315.527 [DATMMP](INFO): Starting 2025-06-25T22:41:55.779Z,1750891315.779 [DATMMP](INFO): Starting 2025-06-25T22:41:56.031Z,1750891316.031 [DATMMP](INFO): Starting 2025-06-25T22:41:56.083Z,1750891316.083 [DATMMP](INFO): entering command mode 2025-06-25T22:41:56.283Z,1750891316.283 [DATMMP](INFO): Starting 2025-06-25T22:41:56.283Z,1750891316.283 [DATMMP](INFO): DAT read: 2025-06-25T22:41:56.284Z,1750891316.284 [DATMMP](INFO): DAT read: user:1> 2025-06-25T22:41:56.284Z,1750891316.284 [DATMMP](DEBUG): read user prompt 1: user:1> 2025-06-25T22:41:56.284Z,1750891316.284 [DATMMP](INFO): entering MMP mode 2025-06-25T22:41:56.535Z,1750891316.535 [DATMMP](INFO): Starting 2025-06-25T22:41:56.536Z,1750891316.536 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:41:56.537Z,1750891316.537 [DATMMP](INFO): status rx: x1 2025-06-25T22:41:56.537Z,1750891316.537 [DATMMP](INFO): MMP status: 1: started 2025-06-25T22:41:56.538Z,1750891316.538 [DATMMP](INFO): Received message type: status 2025-06-25T22:41:56.538Z,1750891316.538 [DATMMP](INFO): Handled 2025-06-25T22:41:56.787Z,1750891316.787 [DATMMP](INFO): Starting 2025-06-25T22:41:56.788Z,1750891316.788 [DATMMP](INFO): Sent Tx Power Config 8 2025-06-25T22:41:56.788Z,1750891316.788 [DATMMP](INFO): Setting local address: 11 2025-06-25T22:41:56.790Z,1750891316.790 [DATMMP](INFO): Setting time to: 22:41:56 And date to:6/25/2025 2025-06-25T22:41:56.928Z,1750891316.928 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-06-25T22:41:56.928Z,1750891316.928 [DVL_micro] Communications Fault, FailCount= 1 2025-06-25T22:41:56.928Z,1750891316.928 [DVL_micro](ERROR): Communications Fault 2025-06-25T22:41:56.964Z,1750891316.964 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-06-25T22:41:57.039Z,1750891317.039 [DATMMP](INFO): Starting 2025-06-25T22:41:57.040Z,1750891317.040 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:41:57.040Z,1750891317.040 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0 2025-06-25T22:41:57.041Z,1750891317.041 [DATMMP](INFO): Received message type: mdmpower 2025-06-25T22:41:57.041Z,1750891317.041 [DATMMP](INFO): Handled 2025-06-25T22:41:57.291Z,1750891317.291 [DATMMP](INFO): Starting 2025-06-25T22:41:57.291Z,1750891317.291 [DATMMP](INFO): GSXN notify for xid: 10 2025-06-25T22:41:57.292Z,1750891317.292 [DATMMP](INFO): sreg_txpower rx: x8 2025-06-25T22:41:57.292Z,1750891317.292 [DATMMP](INFO): Received message type: sreg_txpower 2025-06-25T22:41:57.292Z,1750891317.292 [DATMMP](INFO): Match for : sreg_txpower 2025-06-25T22:41:57.293Z,1750891317.293 [DATMMP](INFO): ACK 2025-06-25T22:41:57.451Z,1750891317.451 [DVL_micro](INFO): Powering down 2025-06-25T22:41:57.543Z,1750891317.543 [DATMMP](INFO): Starting 2025-06-25T22:41:57.544Z,1750891317.544 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:41:57.544Z,1750891317.544 [DATMMP](INFO): mdmlocal rx: xB x0 x0 x0 2025-06-25T22:41:57.545Z,1750891317.545 [DATMMP](INFO): Received message type: mdmlocal 2025-06-25T22:41:57.545Z,1750891317.545 [DATMMP](INFO): Handled 2025-06-25T22:41:57.795Z,1750891317.795 [DATMMP](INFO): Starting 2025-06-25T22:41:57.796Z,1750891317.796 [DATMMP](INFO): GSXN notify for xid: 11 2025-06-25T22:41:57.796Z,1750891317.796 [DATMMP](INFO): sreg_locaddr rx: xB 2025-06-25T22:41:57.796Z,1750891317.796 [DATMMP](INFO): Received message type: sreg_locaddr 2025-06-25T22:41:57.796Z,1750891317.796 [DATMMP](INFO): Match for : sreg_locaddr 2025-06-25T22:41:57.797Z,1750891317.797 [DATMMP](INFO): ACK 2025-06-25T22:41:58.047Z,1750891318.047 [DATMMP](INFO): Starting 2025-06-25T22:41:58.048Z,1750891318.048 [DATMMP](INFO): GSXN notify for xid: 12 2025-06-25T22:41:58.049Z,1750891318.049 [DATMMP](INFO): timedate rx: x0 x16 x29 x38 x5 x19 x7D x0 2025-06-25T22:41:58.049Z,1750891318.049 [DATMMP](INFO): Received message type: timedate 2025-06-25T22:41:58.049Z,1750891318.049 [DATMMP](INFO): Match for : timedate 2025-06-25T22:41:58.049Z,1750891318.049 [DATMMP](INFO): ACK 2025-06-25T22:41:58.271Z,1750891318.271 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-06-25T22:41:58.271Z,1750891318.271 [DVL_micro] No Fault, FailCount= 1 2025-06-25T22:41:58.299Z,1750891318.299 [DATMMP](INFO): Starting 2025-06-25T22:41:58.300Z,1750891318.300 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:41:58.300Z,1750891318.300 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2025-06-25T22:41:58.301Z,1750891318.301 [DATMMP](INFO): Received message type: sys_verb 2025-06-25T22:41:58.301Z,1750891318.301 [DATMMP](INFO): Handled 2025-06-25T22:41:58.551Z,1750891318.551 [DATMMP](INFO): Starting 2025-06-25T22:41:58.551Z,1750891318.551 [DATMMP](INFO): GSXN notify for xid: 13 2025-06-25T22:41:58.552Z,1750891318.552 [DATMMP](INFO): sreg_verbosity rx: x0 2025-06-25T22:41:58.552Z,1750891318.552 [DATMMP](INFO): Received message type: sreg_verbosity 2025-06-25T22:41:58.552Z,1750891318.552 [DATMMP](INFO): Match for : sreg_verbosity 2025-06-25T22:41:58.552Z,1750891318.552 [DATMMP](INFO): ACK 2025-06-25T22:41:58.803Z,1750891318.803 [DATMMP](INFO): Starting 2025-06-25T22:41:58.803Z,1750891318.803 [DATMMP](INFO): GSXN notify for xid: 14 2025-06-25T22:41:58.804Z,1750891318.804 [DATMMP](INFO): version rx: x2 x5 2025-06-25T22:41:58.804Z,1750891318.804 [DATMMP](INFO): DatMMPVersion: 2.5 2025-06-25T22:41:58.805Z,1750891318.805 [DATMMP](INFO): Received message type: version 2025-06-25T22:41:58.805Z,1750891318.805 [DATMMP](INFO): Match for : version 2025-06-25T22:41:58.805Z,1750891318.805 [DATMMP](INFO): ACK 2025-06-25T22:41:58.805Z,1750891318.805 [DATMMP](INFO): in MMP mode: config complete going to runnable 2025-06-25T22:41:59.449Z,1750891319.449 [SBIT](IMPORTANT): Beginning Startup BIT 2025-06-25T22:41:59.469Z,1750891319.469 [CBIT](IMPORTANT): Beginning ground fault scan 2025-06-25T22:42:01.443Z,1750891321.443 [ElevatorServo](FAULT): Overload Error 2025-06-25T22:42:01.443Z,1750891321.443 [ElevatorServo] Hardware Fault, FailCount= 1 2025-06-25T22:42:01.443Z,1750891321.443 [ElevatorServo](ERROR): Hardware Fault 2025-06-25T22:42:01.549Z,1750891321.549 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-06-25T22:42:01.846Z,1750891321.846 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-06-25T22:42:01.846Z,1750891321.846 [ElevatorServo](INFO): Powering down 2025-06-25T22:42:02.625Z,1750891322.625 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-25T22:42:02.745Z,1750891322.745 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-25T22:42:02.814Z,1750891322.814 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-06-25T22:42:02.814Z,1750891322.814 [ElevatorServo] No Fault, FailCount= 1 2025-06-25T22:42:07.028Z,1750891327.028 [NAL9602](INFO): Powering up NAL9602 2025-06-25T22:42:07.907Z,1750891327.907 [ElevatorServo](FAULT): Overload Error 2025-06-25T22:42:07.907Z,1750891327.907 [ElevatorServo] Hardware Fault, FailCount= 2 2025-06-25T22:42:07.907Z,1750891327.907 [ElevatorServo](ERROR): Hardware Fault 2025-06-25T22:42:07.964Z,1750891327.964 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-06-25T22:42:08.273Z,1750891328.273 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-06-25T22:42:08.273Z,1750891328.273 [ElevatorServo](INFO): Powering down 2025-06-25T22:42:09.077Z,1750891329.077 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-25T22:42:09.192Z,1750891329.192 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-25T22:42:09.224Z,1750891329.224 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-06-25T22:42:09.224Z,1750891329.224 [ElevatorServo] No Fault, FailCount= 2 2025-06-25T22:42:10.720Z,1750891330.720 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.020099 CHAN A1 (24V): -0.001330 CHAN A2 (12V): 0.000108 CHAN A3 (5V): 0.000095 CHAN B0 (3.3V): 0.001632 CHAN B1 (3.15aV): 0.000403 CHAN B2 (3.15bV): 0.000525 CHAN B3 (GND): 0.000817 OPEN: 0.004800 Full Scale: +/- 1 mA 2025-06-25T22:42:12.801Z,1750891332.801 [SBIT](FAULT): Elevator: EXPECTED:15.000000 ACTUAL:17.639322 2025-06-25T22:42:13.420Z,1750891333.420 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:42:13.420Z,1750891333.420 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2025-06-25T22:42:13.421Z,1750891333.421 [DATMMP](INFO): Received message type: timesync 2025-06-25T22:42:13.421Z,1750891333.421 [DATMMP](INFO): Handled 2025-06-25T22:42:14.035Z,1750891334.035 [ElevatorServo](FAULT): Overload Error 2025-06-25T22:42:14.035Z,1750891334.035 [ElevatorServo] Hardware Fault, FailCount= 3 2025-06-25T22:42:14.035Z,1750891334.035 [ElevatorServo](ERROR): Hardware Fault 2025-06-25T22:42:14.044Z,1750891334.044 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-06-25T22:42:14.045Z,1750891334.045 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2025-06-25T22:42:14.337Z,1750891334.337 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-06-25T22:42:14.337Z,1750891334.337 [ElevatorServo](INFO): Powering down 2025-06-25T22:42:14.349Z,1750891334.349 [CBIT](INFO): Critical error at 20250625T224214 2025-06-25T22:42:15.140Z,1750891335.140 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-25T22:42:15.260Z,1750891335.260 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-25T22:42:15.924Z,1750891335.924 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-06-25T22:42:15.924Z,1750891335.924 [DVL_micro] Communications Fault, FailCount= 2 2025-06-25T22:42:15.924Z,1750891335.924 [DVL_micro](ERROR): Communications Fault 2025-06-25T22:42:16.042Z,1750891336.042 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-06-25T22:42:16.415Z,1750891336.415 [DVL_micro](INFO): Powering down 2025-06-25T22:42:17.256Z,1750891337.256 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-06-25T22:42:17.256Z,1750891337.256 [DVL_micro] No Fault, FailCount= 2 2025-06-25T22:42:17.937Z,1750891337.937 [NAL9602](INFO): NAL9602 initialized 2025-06-25T22:42:23.248Z,1750891343.248 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:42:23.249Z,1750891343.249 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2025-06-25T22:42:23.249Z,1750891343.249 [DATMMP](INFO): Received message type: timesync 2025-06-25T22:42:23.249Z,1750891343.249 [DATMMP](INFO): Handled 2025-06-25T22:42:34.904Z,1750891354.904 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-06-25T22:42:34.904Z,1750891354.904 [DVL_micro] Communications Fault, FailCount= 3 2025-06-25T22:42:34.904Z,1750891354.904 [DVL_micro](ERROR): Communications Fault 2025-06-25T22:42:34.954Z,1750891354.954 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-06-25T22:42:34.955Z,1750891354.955 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2025-06-25T22:42:35.403Z,1750891355.403 [DVL_micro](INFO): Powering down 2025-06-25T22:42:35.424Z,1750891355.424 [CBIT](INFO): Critical error at 20250625T224234 2025-06-25T22:42:39.366Z,1750891359.366 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-06-25T22:42:39.366Z,1750891359.366 [SBIT](FAULT): Control surface position failure. 2025-06-25T22:42:53.130Z,1750891373.130 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-06-25T22:42:53.130Z,1750891373.130 [SBIT](FAULT): Control surface position failure. 2025-06-25T22:42:53.292Z,1750891373.292 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:42:53.293Z,1750891373.293 [DATMMP](INFO): timesync rx: x0 x0 x0 x0 2025-06-25T22:42:53.293Z,1750891373.293 [DATMMP](INFO): Received message type: timesync 2025-06-25T22:42:53.293Z,1750891373.293 [DATMMP](INFO): Handled 2025-06-25T22:42:53.536Z,1750891373.536 [SBIT](CRITICAL): SBIT FAILED 2025-06-25T22:42:53.536Z,1750891373.536 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-06-25T22:42:53.537Z,1750891373.537 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2025-06-25T22:42:53.537Z,1750891373.537 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2025-06-25T22:42:53.539Z,1750891373.539 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2025-06-25T22:42:53.539Z,1750891373.539 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2025-06-25T22:42:53.541Z,1750891373.541 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=2 meter; 2025-06-25T22:42:53.541Z,1750891373.541 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=1 bool; 2025-06-25T22:42:53.541Z,1750891373.541 [SBIT](IMPORTANT): Depth_Keller.offset=3.4 decibar; 2025-06-25T22:42:53.541Z,1750891373.541 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2025-06-25T22:42:53.541Z,1750891373.541 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=30 minute; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_temperature; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): Express linearApproximation DAT.acoustic_contact_range 15.000000 meter; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): Express none DATMMP.acoustic_contact_range; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): Express none platform_average_current; 2025-06-25T22:42:53.542Z,1750891373.542 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=-0.1 ampere_hour; 2025-06-25T22:42:53.543Z,1750891373.543 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11.5 volt; 2025-06-25T22:42:53.583Z,1750891373.583 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool; 2025-06-25T22:42:53.583Z,1750891373.583 [SBIT](IMPORTANT): RudderServo.currLimit=70 percent; 2025-06-25T22:42:53.583Z,1750891373.583 [SBIT](IMPORTANT): RudderServo.deviationAngle=0.8 degree; 2025-06-25T22:42:53.583Z,1750891373.583 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=80 cubic_centimeter; 2025-06-25T22:42:53.584Z,1750891373.584 [SBIT](IMPORTANT): VerticalControl.massDefault=0 millimeter; 2025-06-25T22:42:53.585Z,1750891373.585 [CBIT](INFO): Critical error at 20250625T224253 2025-06-25T22:42:53.920Z,1750891373.920 [MissionManager](IMPORTANT): Started mission Startup 2025-06-25T22:42:53.921Z,1750891373.921 [Startup] Running Loop=1 2025-06-25T22:42:53.921Z,1750891373.921 [Startup](DEBUG): Aggregate::initialize Startup 2025-06-25T22:42:53.921Z,1750891373.921 [Startup:A.GoToSurface] Running Loop=1 2025-06-25T22:42:53.921Z,1750891373.921 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-25T22:42:53.922Z,1750891373.922 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-25T22:42:53.922Z,1750891373.922 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-25T22:42:53.922Z,1750891373.922 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-25T22:42:53.923Z,1750891373.923 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-25T22:42:53.923Z,1750891373.923 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-25T22:42:53.923Z,1750891373.923 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-25T22:42:53.925Z,1750891373.925 [Startup:StartupSatComms] Running Loop=1 2025-06-25T22:42:53.925Z,1750891373.925 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-06-25T22:42:53.925Z,1750891373.925 [Startup:StartupSatComms:A] Running Loop=1 2025-06-25T22:42:54.318Z,1750891374.318 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-06-25T22:42:55.579Z,1750891375.579 [BuoyancyServo](FAULT): Invalid EZ Servo response:"" 2025-06-25T22:42:55.579Z,1750891375.579 [BuoyancyServo] Communications Fault, FailCount= 1 2025-06-25T22:42:55.579Z,1750891375.579 [BuoyancyServo](ERROR): Communications Fault 2025-06-25T22:42:55.580Z,1750891375.580 [BuoyancyServo](FAULT): Buoyancy engine reporting null position 2025-06-25T22:42:55.580Z,1750891375.580 [BuoyancyServo] Hardware Fault, FailCount= 1 2025-06-25T22:42:55.580Z,1750891375.580 [BuoyancyServo](ERROR): Hardware Fault 2025-06-25T22:42:55.623Z,1750891375.623 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2025-06-25T22:42:57.559Z,1750891377.559 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-06-25T22:42:57.559Z,1750891377.559 [BuoyancyServo](INFO): Powering down 2025-06-25T22:42:58.396Z,1750891378.396 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2025-06-25T22:42:58.397Z,1750891378.397 [BuoyancyServo] No Fault, FailCount= 1 2025-06-25T22:42:58.770Z,1750891378.770 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-06-25T22:42:58.771Z,1750891378.771 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-06-25T22:43:14.220Z,1750891394.220 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:43:14.221Z,1750891394.221 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2025-06-25T22:43:14.221Z,1750891394.221 [DATMMP](INFO): Received message type: timesync 2025-06-25T22:43:14.221Z,1750891394.221 [DATMMP](INFO): Handled 2025-06-25T22:43:24.303Z,1750891404.303 [DATMMP](INFO): GSXN notify for xid: 0 2025-06-25T22:43:24.304Z,1750891404.304 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2025-06-25T22:43:24.304Z,1750891404.304 [DATMMP](INFO): Received message type: timesync 2025-06-25T22:43:24.305Z,1750891404.305 [DATMMP](INFO): Handled 2025-06-25T22:43:54.107Z,1750891434.107 [Startup:StartupSatComms:A](INFO): Timed out from 2025-06-25T22:42:53.9Z 2025-06-25T22:43:54.107Z,1750891434.107 [Startup:StartupSatComms:A] Stopped 2025-06-25T22:43:54.107Z,1750891434.107 [Startup:StartupSatComms:B] Running Loop=1 2025-06-25T22:43:54.505Z,1750891434.505 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-25T22:43:59.000Z,1750891439.000 [CommandExec](IMPORTANT): got command docking arm 2025-06-25T22:43:59.000Z,1750891439.000 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2025-06-25T22:44:01.679Z,1750891441.679 [DataOverHttps](INFO): Sending 314 bytes from file Logs/20000223T031622/Courier0000.lzma 2025-06-25T22:44:02.681Z,1750891442.681 [DataOverHttps](INFO): Moved sent file to Logs/20000223T031622/Courier0000.lzma.bak 2025-06-25T22:44:02.681Z,1750891442.681 [DataOverHttps](INFO): SBD MOMSN=25246771 2025-06-25T22:44:06.700Z,1750891446.700 [CommandExec](IMPORTANT): got command show variable docking 2025-06-25T22:44:06.708Z,1750891446.708 [CommandExec](IMPORTANT): Dock.docking_state_cmd (enum) 2025-06-25T22:44:06.804Z,1750891446.804 [CommandExec](IMPORTANT): DockingServo.loadAtStartup (bool) 2025-06-25T22:44:06.804Z,1750891446.804 [CommandExec](IMPORTANT): DockingServo.simulateHardware (bool) 2025-06-25T22:44:06.805Z,1750891446.805 [CommandExec](IMPORTANT): DockingServo.countsPerDeg (count_per_angular_degree) 2025-06-25T22:44:06.805Z,1750891446.805 [CommandExec](IMPORTANT): DockingServo.currLimit (percent) 2025-06-25T22:44:06.805Z,1750891446.805 [CommandExec](IMPORTANT): DockingServo.deviationAngle (angular_degree) 2025-06-25T22:44:06.806Z,1750891446.806 [CommandExec](IMPORTANT): DockingServo.limitHi (count) 2025-06-25T22:44:06.806Z,1750891446.806 [CommandExec](IMPORTANT): DockingServo.limitLo (count) 2025-06-25T22:44:06.806Z,1750891446.806 [CommandExec](IMPORTANT): DockingServo.mtrCenter (count) 2025-06-25T22:44:06.806Z,1750891446.806 [CommandExec](IMPORTANT): DockingServo.offsetAngle (degree) 2025-06-25T22:44:06.811Z,1750891446.811 [CommandExec](IMPORTANT): DockingServo.pidW (count) 2025-06-25T22:44:06.811Z,1750891446.811 [CommandExec](IMPORTANT): DockingServo.pidX (count) 2025-06-25T22:44:06.812Z,1750891446.812 [CommandExec](IMPORTANT): DockingServo.pidY (count) 2025-06-25T22:44:06.812Z,1750891446.812 [CommandExec](IMPORTANT): DockingServo.powerOnTimeout (second) 2025-06-25T22:44:06.812Z,1750891446.812 [CommandExec](IMPORTANT): DockingServo.openAngle (degree) 2025-06-25T22:44:06.813Z,1750891446.813 [CommandExec](IMPORTANT): DockingServo.closedAngle (degree) 2025-06-25T22:44:06.813Z,1750891446.813 [CommandExec](IMPORTANT): DockingStepper.loadAtStartup (bool) 2025-06-25T22:44:06.813Z,1750891446.813 [CommandExec](IMPORTANT): DockingStepper.simulateHardware (bool) 2025-06-25T22:44:06.814Z,1750891446.814 [CommandExec](IMPORTANT): DockingStepper.openValue (count) 2025-06-25T22:44:06.814Z,1750891446.814 [CommandExec](IMPORTANT): DockingStepper.closedValue (count) 2025-06-25T22:44:06.814Z,1750891446.814 [CommandExec](IMPORTANT): DockingStepper.slideValue (count) 2025-06-25T22:44:06.819Z,1750891446.819 [CommandExec](IMPORTANT): DockingStepper.deviationValue (count) 2025-06-25T22:44:06.819Z,1750891446.819 [CommandExec](IMPORTANT): DockingStepper.currLimit (percent) 2025-06-25T22:44:06.820Z,1750891446.820 [CommandExec](IMPORTANT): DockingStepper.velocity (none) 2025-06-25T22:44:06.820Z,1750891446.820 [CommandExec](IMPORTANT): DockingStepper.powerOnTimeout (second) 2025-06-25T22:44:06.820Z,1750891446.820 [CommandExec](IMPORTANT): DockingStepper.powerOffTimeout (second) 2025-06-25T22:44:06.862Z,1750891446.862 [CommandExec](IMPORTANT): Docked.dockingDepthOffset (meter) 2025-06-25T22:44:06.885Z,1750891446.885 [CommandExec](IMPORTANT): DockingServo.loadControl (none) 2025-06-25T22:44:06.886Z,1750891446.886 [CommandExec](IMPORTANT): DockingServo.uart (none) 2025-06-25T22:44:06.886Z,1750891446.886 [CommandExec](IMPORTANT): DockingServo.baud (bit_per_second) 2025-06-25T22:44:06.886Z,1750891446.886 [CommandExec](IMPORTANT): DockingStepper.loadControl (none) 2025-06-25T22:44:06.894Z,1750891446.894 [CommandExec](IMPORTANT): DockingStepper.uart (none) 2025-06-25T22:44:06.894Z,1750891446.894 [CommandExec](IMPORTANT): DockingStepper.baud (bit_per_second) 2025-06-25T22:44:15.656Z,1750891455.656 [CommandExec](IMPORTANT): got command get DockingServo.loadAtStartup 2025-06-25T22:44:15.656Z,1750891455.656 [CommandExec](IMPORTANT): DockingServo.loadAtStartup 0 bool 2025-06-25T22:44:20.024Z,1750891460.024 [DataOverHttps](INFO): Sending 91 bytes from file Logs/20250625T200918/Courier0016.lzma 2025-06-25T22:44:21.025Z,1750891461.025 [DataOverHttps](INFO): Moved sent file to Logs/20250625T200918/Courier0016.lzma.bak 2025-06-25T22:44:21.025Z,1750891461.025 [DataOverHttps](INFO): SBD MOMSN=25246777 2025-06-25T22:44:25.100Z,1750891465.100 [CommandExec](IMPORTANT): got command get DockingServo.simulateHardware 2025-06-25T22:44:25.101Z,1750891465.101 [CommandExec](IMPORTANT): DockingServo.simulateHardware 1 bool 2025-06-25T22:44:38.641Z,1750891478.641 [CommandExec](IMPORTANT): got command get DockingServo.uart 2025-06-25T22:44:38.641Z,1750891478.641 [CommandExec](IMPORTANT): DockingServo.uart /dev/ttyB1 2025-06-25T22:44:38.947Z,1750891478.947 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-06-25T22:44:38.947Z,1750891478.947 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-25T22:44:38.958Z,1750891478.958 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-25T22:44:39.363Z,1750891479.363 [DataOverHttps](INFO): Sending 335 bytes from file Logs/20250625T224127/Courier0000.lzma 2025-06-25T22:44:39.375Z,1750891479.375 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-25T22:44:39.375Z,1750891479.375 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-06-25T22:44:40.365Z,1750891480.365 [DataOverHttps](INFO): Moved sent file to Logs/20250625T224127/Courier0000.lzma.bak 2025-06-25T22:44:40.365Z,1750891480.365 [DataOverHttps](INFO): SBD MOMSN=25246780 2025-06-25T22:44:54.312Z,1750891494.312 [Startup:StartupSatComms:B](INFO): Timed out from 2025-06-25T22:43:54.1Z 2025-06-25T22:44:54.312Z,1750891494.312 [Startup:StartupSatComms:B] Stopped 2025-06-25T22:44:54.312Z,1750891494.312 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-06-25T22:44:54.312Z,1750891494.312 [Startup:StartupSatComms] Stopped 2025-06-25T22:44:54.312Z,1750891494.312 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-06-25T22:44:54.313Z,1750891494.313 [Startup](INFO): Completed Startup 2025-06-25T22:44:54.313Z,1750891494.313 [MissionManager](INFO): Startup is completed. 2025-06-25T22:44:54.314Z,1750891494.314 [MissionManager](INFO): Uninitializing Mission Startup 2025-06-25T22:44:54.314Z,1750891494.314 [Startup] Stopped 2025-06-25T22:44:54.314Z,1750891494.314 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-06-25T22:44:54.314Z,1750891494.314 [Startup:A.GoToSurface] Stopped 2025-06-25T22:44:54.314Z,1750891494.314 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-25T22:44:54.722Z,1750891494.722 [MissionManager](IMPORTANT): Started mission Default 2025-06-25T22:44:54.722Z,1750891494.722 [Default] Running Loop=1 2025-06-25T22:44:54.722Z,1750891494.722 [Default](DEBUG): Aggregate::initialize Default 2025-06-25T22:44:54.723Z,1750891494.723 [Default:B.GoToSurface] Running Loop=1 2025-06-25T22:44:54.727Z,1750891494.727 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-25T22:44:54.727Z,1750891494.727 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-25T22:44:54.727Z,1750891494.727 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-25T22:44:54.728Z,1750891494.728 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-25T22:44:54.728Z,1750891494.728 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-25T22:44:54.728Z,1750891494.728 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-25T22:44:54.729Z,1750891494.729 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-25T22:44:54.729Z,1750891494.729 [Default:A.Wait] Running Loop=1 2025-06-25T22:44:54.729Z,1750891494.729 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-06-25T22:44:57.004Z,1750891497.004 [DataOverHttps](INFO): Sending 791 bytes from file Logs/20000223T031622/Express0001.lzma 2025-06-25T22:44:58.005Z,1750891498.005 [DataOverHttps](INFO): Moved sent file to Logs/20000223T031622/Express0001.lzma.bak 2025-06-25T22:44:58.005Z,1750891498.005 [DataOverHttps](INFO): SBD MOMSN=25246787 2025-06-25T22:45:08.033Z,1750891508.033 [Default:A.Wait](INFO): Done Waiting. 2025-06-25T22:45:08.034Z,1750891508.034 [Default:A.Wait] Stopped 2025-06-25T22:45:08.034Z,1750891508.034 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-06-25T22:45:08.464Z,1750891508.464 [Default:CheckIn] Running Loop=1 2025-06-25T22:45:08.464Z,1750891508.464 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-25T22:45:08.464Z,1750891508.464 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-25T22:45:08.852Z,1750891508.852 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-06-25T22:45:34.688Z,1750891534.688 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-25T22:45:35.142Z,1750891535.142 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-06-25T22:45:35.142Z,1750891535.142 [DVL_micro] No Fault, FailCount= 3 2025-06-25T22:45:52.872Z,1750891552.872 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-06-25T22:45:52.872Z,1750891552.872 [DVL_micro] Communications Fault, FailCount= 1 2025-06-25T22:45:52.872Z,1750891552.872 [DVL_micro](ERROR): Communications Fault 2025-06-25T22:45:52.918Z,1750891552.918 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-06-25T22:45:53.363Z,1750891553.363 [DVL_micro](INFO): Powering down 2025-06-25T22:45:54.102Z,1750891554.102 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-06-25T22:45:54.102Z,1750891554.102 [DVL_micro] No Fault, FailCount= 1 2025-06-25T22:46:11.852Z,1750891571.852 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-06-25T22:46:11.852Z,1750891571.852 [DVL_micro] Communications Fault, FailCount= 2 2025-06-25T22:46:11.852Z,1750891571.852 [DVL_micro](ERROR): Communications Fault 2025-06-25T22:46:11.921Z,1750891571.921 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-06-25T22:46:12.351Z,1750891572.351 [DVL_micro](INFO): Powering down 2025-06-25T22:46:13.101Z,1750891573.101 [CBIT](INFO): Clearing failed state for component DVL_micro 2025-06-25T22:46:13.101Z,1750891573.101 [DVL_micro] No Fault, FailCount= 2 2025-06-25T22:46:30.850Z,1750891590.850 [DVL_micro](FAULT): Failed to initialize within timeout. 2025-06-25T22:46:30.850Z,1750891590.850 [DVL_micro] Communications Fault, FailCount= 3 2025-06-25T22:46:30.850Z,1750891590.850 [DVL_micro](ERROR): Communications Fault 2025-06-25T22:46:30.868Z,1750891590.868 [CBIT](ERROR): Communications Fault in component: DVL_micro 2025-06-25T22:46:30.868Z,1750891590.868 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2025-06-25T22:46:31.351Z,1750891591.351 [DVL_micro](INFO): Powering down 2025-06-25T22:46:31.388Z,1750891591.388 [CBIT](INFO): Critical error at 20250625T224630 2025-06-25T22:46:55.328Z,1750891615.328 [CommandExec](IMPORTANT): got command configSet DockingServo.loadAtStartup 1 bool persist 2025-06-25T22:46:55.328Z,1750891615.328 [CommandExec](IMPORTANT): configSet DockingServo.loadAtStartup requires a restart to take effect. 2025-06-25T22:46:55.332Z,1750891615.332 [CommandExec](IMPORTANT): got command configSet DockingServo.simulateHardware 0 bool persist 2025-06-25T22:46:59.080Z,1750891619.080 [CommandExec](IMPORTANT): got command restart application 2025-06-25T22:47:00.083Z,1750891620.083 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:00.083Z,1750891620.083 [CommandExec](INFO): Uninitializing the command executive. 2025-06-25T22:47:00.083Z,1750891620.083 [CommandExec](INFO): Uninitializing the command scheduler. 2025-06-25T22:47:00.084Z,1750891620.084 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:00.263Z,1750891620.263 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-06-25T22:47:00.263Z,1750891620.263 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-06-25T22:47:00.263Z,1750891620.263 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:00.264Z,1750891620.264 [NavChartDb](INFO): Join timeout helper Thread ID is 8476 2025-06-25T22:47:00.419Z,1750891620.419 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:00.419Z,1750891620.419 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:00.431Z,1750891620.431 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-06-25T22:47:00.431Z,1750891620.431 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:00.431Z,1750891620.431 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8477 2025-06-25T22:47:00.615Z,1750891620.615 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:00.615Z,1750891620.615 [WetLabsBB2FL](INFO): Powering down 2025-06-25T22:47:00.616Z,1750891620.616 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:00.623Z,1750891620.623 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-06-25T22:47:00.623Z,1750891620.623 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:00.623Z,1750891620.623 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8478 2025-06-25T22:47:01.251Z,1750891621.251 [CTD_Seabird](INFO): Powering down 2025-06-25T22:47:01.263Z,1750891621.263 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:01.263Z,1750891621.263 [CTD_Seabird](INFO): Powering down 2025-06-25T22:47:01.275Z,1750891621.275 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:01.283Z,1750891621.283 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-06-25T22:47:01.283Z,1750891621.283 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:01.283Z,1750891621.283 [Radio_Surface](INFO): Join timeout helper Thread ID is 8479 2025-06-25T22:47:01.323Z,1750891621.323 [Radio_Surface](INFO): Powering down 2025-06-25T22:47:01.324Z,1750891621.324 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:01.324Z,1750891621.324 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:01.325Z,1750891621.325 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-06-25T22:47:01.325Z,1750891621.325 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:01.325Z,1750891621.325 [Onboard](INFO): Join timeout helper Thread ID is 8480 2025-06-25T22:47:01.479Z,1750891621.479 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-06-25T22:47:04.159Z,1750891624.159 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:04.159Z,1750891624.159 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.183Z,1750891624.183 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-06-25T22:47:04.183Z,1750891624.183 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.187Z,1750891624.187 [DataOverHttps](INFO): Join timeout helper Thread ID is 8481 2025-06-25T22:47:04.491Z,1750891624.491 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:04.491Z,1750891624.491 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.500Z,1750891624.500 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2025-06-25T22:47:04.500Z,1750891624.500 [DATMMP ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.500Z,1750891624.500 [DATMMP](INFO): Join timeout helper Thread ID is 8482 2025-06-25T22:47:04.683Z,1750891624.683 [DATMMP](INFO): Stop 2025-06-25T22:47:04.683Z,1750891624.683 [DATMMP](INFO): uninitialize 2025-06-25T22:47:04.683Z,1750891624.683 [DATMMP](INFO): Powering down 2025-06-25T22:47:04.756Z,1750891624.756 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:04.756Z,1750891624.756 [DATMMP](INFO): uninitialize 2025-06-25T22:47:04.756Z,1750891624.756 [DATMMP](INFO): Powering down 2025-06-25T22:47:04.757Z,1750891624.757 [DATMMP ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.760Z,1750891624.760 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-06-25T22:47:04.760Z,1750891624.760 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.760Z,1750891624.760 [BackseatComponent](INFO): Join timeout helper Thread ID is 8483 2025-06-25T22:47:04.847Z,1750891624.847 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:04.847Z,1750891624.847 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.860Z,1750891624.860 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-06-25T22:47:04.860Z,1750891624.860 [logger ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.860Z,1750891624.860 [logger](INFO): Join timeout helper Thread ID is 8484 2025-06-25T22:47:04.895Z,1750891624.895 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:04.896Z,1750891624.896 [logger ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.916Z,1750891624.916 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-06-25T22:47:04.916Z,1750891624.916 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.916Z,1750891624.916 [CommandLine](INFO): Join timeout helper Thread ID is 8485 2025-06-25T22:47:04.951Z,1750891624.951 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:04.951Z,1750891624.951 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.956Z,1750891624.956 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-06-25T22:47:04.956Z,1750891624.956 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.956Z,1750891624.956 [CommandExec](INFO): Join timeout helper Thread ID is 8486 2025-06-25T22:47:04.957Z,1750891624.957 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-06-25T22:47:04.957Z,1750891624.957 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:04.958Z,1750891624.958 [controlThread](INFO): Join timeout helper Thread ID is 8487 2025-06-25T22:47:05.167Z,1750891625.167 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-25T22:47:05.167Z,1750891625.167 [controlThread](DEBUG): Uninitializing ControlThread 2025-06-25T22:47:05.168Z,1750891625.168 [AHRS_M2](INFO): Powering down 2025-06-25T22:47:05.240Z,1750891625.240 [DVL_micro](INFO): Powering down 2025-06-25T22:47:05.241Z,1750891625.241 [NAL9602](INFO): Powering down 2025-06-25T22:47:05.242Z,1750891625.242 [Sonardyne_Nano](INFO): Powering down 2025-06-25T22:47:05.365Z,1750891625.365 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-06-25T22:47:05.366Z,1750891625.366 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-06-25T22:47:05.366Z,1750891625.366 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-06-25T22:47:05.367Z,1750891625.367 [MissionManager](INFO): Uninitializing Mission Default 2025-06-25T22:47:05.367Z,1750891625.367 [Default] Stopped 2025-06-25T22:47:05.367Z,1750891625.367 [Default](DEBUG): Aggregate::uninitialize Default 2025-06-25T22:47:05.367Z,1750891625.367 [Default:B.GoToSurface] Stopped 2025-06-25T22:47:05.367Z,1750891625.367 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-25T22:47:05.367Z,1750891625.367 [Default:CheckIn] Stopped 2025-06-25T22:47:05.367Z,1750891625.367 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-25T22:47:05.367Z,1750891625.367 [Default:CheckIn:Read_GPS] Stopped 2025-06-25T22:47:05.370Z,1750891625.370 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-06-25T22:47:05.370Z,1750891625.370 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-06-25T22:47:05.371Z,1750891625.371 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-06-25T22:47:05.371Z,1750891625.371 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-06-25T22:47:05.372Z,1750891625.372 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-06-25T22:47:05.372Z,1750891625.372 [BuoyancyServo](INFO): Powering down 2025-06-25T22:47:05.383Z,1750891625.383 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-06-25T22:47:05.383Z,1750891625.383 [ElevatorServo](INFO): Powering down 2025-06-25T22:47:05.384Z,1750891625.384 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-06-25T22:47:05.384Z,1750891625.384 [MassServo](INFO): Powering down 2025-06-25T22:47:05.385Z,1750891625.385 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-06-25T22:47:05.385Z,1750891625.385 [RudderServo](INFO): Powering down 2025-06-25T22:47:05.386Z,1750891625.386 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-06-25T22:47:05.386Z,1750891625.386 [ThrusterHE](INFO): Powering down 2025-06-25T22:47:05.387Z,1750891625.387 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-06-25T22:47:05.387Z,1750891625.387 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-06-25T22:47:05.387Z,1750891625.387 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-06-25T22:47:05.388Z,1750891625.388 [CBIT](DEBUG): Powering off loads. 2025-06-25T22:47:05.399Z,1750891625.399 [CBIT](DEBUG): Disabling WDT. 2025-06-25T22:47:05.411Z,1750891625.411 [CBIT](DEBUG): Opening all GF detection circuits. 2025-06-25T22:47:05.412Z,1750891625.412 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.454Z,1750891625.454 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.457Z,1750891625.457 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.464Z,1750891625.464 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.470Z,1750891625.470 [DATMMP ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.511Z,1750891625.511 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.684Z,1750891625.684 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.690Z,1750891625.690 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.712Z,1750891625.712 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-25T22:47:05.775Z,1750891625.775 [logger ThreadHandler](INFO): Thread cancelled.