2025-04-04T21:37:36.029Z,1743802656.029 [Supervisor](DEBUG): Initializing supervisor. 2025-04-04T21:37:36.033Z,1743802656.033 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-04-04T21:37:36.034Z,1743802656.034 [SyncHandler](INFO): Protected caller Thread ID is 4590 2025-04-04T21:37:36.034Z,1743802656.034 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-04-04T21:37:36.035Z,1743802656.035 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-04-04T21:37:36.035Z,1743802656.035 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4591 2025-04-04T21:37:36.039Z,1743802656.039 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-04-04T21:37:36.059Z,1743802656.059 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-04-04T21:37:36.060Z,1743802656.060 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-04-04T21:37:36.061Z,1743802656.061 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4592 2025-04-04T21:37:36.065Z,1743802656.065 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-04-04T21:37:36.066Z,1743802656.066 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-04-04T21:37:36.066Z,1743802656.066 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4593 2025-04-04T21:37:36.068Z,1743802656.068 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-04-04T21:37:36.069Z,1743802656.069 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-04-04T21:37:36.070Z,1743802656.070 [logger ThreadHandler](INFO): Protected caller Thread ID is 4594 2025-04-04T21:37:36.074Z,1743802656.074 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-04-04T21:37:36.074Z,1743802656.074 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-04-04T21:37:36.076Z,1743802656.076 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-04-04T21:37:36.297Z,1743802656.297 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-04-04T21:37:36.297Z,1743802656.297 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-04-04T21:37:36.414Z,1743802656.414 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-04-04T21:37:36.415Z,1743802656.415 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-04-04T21:37:36.521Z,1743802656.521 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-04-04T21:37:36.522Z,1743802656.522 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-04-04T21:37:37.021Z,1743802657.021 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-04-04T21:37:37.021Z,1743802657.021 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-04-04T21:37:37.382Z,1743802657.382 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-04-04T21:37:37.383Z,1743802657.383 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-04-04T21:37:37.740Z,1743802657.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-04-04T21:37:37.741Z,1743802657.741 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-04-04T21:37:37.941Z,1743802657.941 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-04-04T21:37:37.942Z,1743802657.942 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-04-04T21:37:38.031Z,1743802658.031 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-04-04T21:37:38.122Z,1743802658.122 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-04-04T21:37:38.547Z,1743802658.547 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-04-04T21:37:38.548Z,1743802658.548 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-04-04T21:37:38.851Z,1743802658.851 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-04-04T21:37:38.852Z,1743802658.852 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-04-04T21:37:39.417Z,1743802659.417 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-04-04T21:37:39.418Z,1743802659.418 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-04-04T21:37:39.673Z,1743802659.673 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-04-04T21:37:39.673Z,1743802659.673 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-04-04T21:37:39.929Z,1743802659.929 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-04-04T21:37:39.929Z,1743802659.929 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-04-04T21:37:40.155Z,1743802660.155 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-04-04T21:37:40.156Z,1743802660.156 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-04-04T21:37:41.066Z,1743802661.066 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-04-04T21:37:41.068Z,1743802661.068 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2025-04-04T21:37:41.069Z,1743802661.069 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2025-04-04T21:37:41.302Z,1743802661.302 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2025-04-04T21:37:41.494Z,1743802661.494 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2025-04-04T21:37:41.965Z,1743802661.965 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-04-04T21:37:41.965Z,1743802661.965 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2025-04-04T21:37:42.100Z,1743802662.100 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2025-04-04T21:37:42.208Z,1743802662.208 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2025-04-04T21:37:42.312Z,1743802662.312 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2025-04-04T21:37:42.431Z,1743802662.431 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2025-04-04T21:37:42.526Z,1743802662.526 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2025-04-04T21:37:42.623Z,1743802662.623 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2025-04-04T21:37:42.724Z,1743802662.724 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2025-04-04T21:37:42.904Z,1743802662.904 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2025-04-04T21:37:42.904Z,1743802662.904 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-04-04T21:37:42.917Z,1743802662.917 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-04-04T21:37:42.968Z,1743802662.968 [DepthRateCalculator] Loaded 2025-04-04T21:37:42.969Z,1743802662.969 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-04-04T21:37:42.974Z,1743802662.974 [PitchRateCalculator] Loaded 2025-04-04T21:37:42.974Z,1743802662.974 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-04-04T21:37:42.984Z,1743802662.984 [SpeedCalculator] Loaded 2025-04-04T21:37:42.985Z,1743802662.985 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-04-04T21:37:42.990Z,1743802662.990 [YawRateCalculator] Loaded 2025-04-04T21:37:42.990Z,1743802662.990 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-04-04T21:37:43.011Z,1743802663.011 [ElevatorOffsetCalculator] Loaded 2025-04-04T21:37:43.012Z,1743802663.012 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-04-04T21:37:43.012Z,1743802663.012 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-04-04T21:37:43.012Z,1743802663.012 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-04-04T21:37:43.042Z,1743802663.042 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-04-04T21:37:43.042Z,1743802663.042 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-04-04T21:37:43.053Z,1743802663.053 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-04-04T21:37:43.054Z,1743802663.053 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-04-04T21:37:43.530Z,1743802663.530 [AHRS_M2] Loaded 2025-04-04T21:37:43.531Z,1743802663.531 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-04-04T21:37:43.569Z,1743802663.569 [BackseatComponent] Loaded 2025-04-04T21:37:43.569Z,1743802663.569 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-04-04T21:37:43.571Z,1743802663.571 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408754E0 2025-04-04T21:37:43.571Z,1743802663.571 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4677 2025-04-04T21:37:43.574Z,1743802663.574 [LcmUniversalReporter] Loaded 2025-04-04T21:37:43.574Z,1743802663.574 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-04-04T21:37:44.363Z,1743802664.363 [BPC1] Loaded 2025-04-04T21:37:44.363Z,1743802664.363 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-04-04T21:37:44.458Z,1743802664.458 [DAT] Loaded 2025-04-04T21:37:44.458Z,1743802664.458 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-04-04T21:37:44.459Z,1743802664.459 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0 2025-04-04T21:37:44.460Z,1743802664.460 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4678 2025-04-04T21:37:44.534Z,1743802664.534 [DataOverHttps] Loaded 2025-04-04T21:37:44.534Z,1743802664.534 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-04-04T21:37:44.535Z,1743802664.535 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0 2025-04-04T21:37:44.536Z,1743802664.536 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4679 2025-04-04T21:37:44.558Z,1743802664.558 [Depth_Keller] Loaded 2025-04-04T21:37:44.558Z,1743802664.558 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-04-04T21:37:44.563Z,1743802664.563 [DropWeight] Loaded 2025-04-04T21:37:44.564Z,1743802664.564 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-04-04T21:37:44.585Z,1743802664.585 [MultiRay](INFO): Found secondary power supply at: /dev/loadC7 2025-04-04T21:37:44.585Z,1743802664.585 [MultiRay] Loaded 2025-04-04T21:37:44.585Z,1743802664.585 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2025-04-04T21:37:44.649Z,1743802664.649 [NAL9602] Loaded 2025-04-04T21:37:44.649Z,1743802664.649 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-04-04T21:37:44.678Z,1743802664.678 [Onboard] Loaded 2025-04-04T21:37:44.679Z,1743802664.679 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-04-04T21:37:44.680Z,1743802664.680 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409054E0 2025-04-04T21:37:44.680Z,1743802664.680 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4680 2025-04-04T21:37:44.686Z,1743802664.686 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2025-04-04T21:37:44.699Z,1743802664.699 [PowerOnly] Loaded 2025-04-04T21:37:44.699Z,1743802664.699 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-04-04T21:37:44.713Z,1743802664.713 [Power24vConverter] Loaded 2025-04-04T21:37:44.713Z,1743802664.713 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-04-04T21:37:44.730Z,1743802664.730 [Radio_Surface] Loaded 2025-04-04T21:37:44.730Z,1743802664.730 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-04-04T21:37:44.732Z,1743802664.732 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409354E0 2025-04-04T21:37:44.732Z,1743802664.732 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4681 2025-04-04T21:37:44.757Z,1743802664.757 [Waterlinked] Loaded 2025-04-04T21:37:44.757Z,1743802664.757 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2025-04-04T21:37:44.757Z,1743802664.757 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-04-04T21:37:44.758Z,1743802664.758 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-04-04T21:37:44.871Z,1743802664.871 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-04-04T21:37:44.871Z,1743802664.871 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-04-04T21:37:44.884Z,1743802664.884 [NavChart] Loaded 2025-04-04T21:37:44.885Z,1743802664.885 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-04-04T21:37:44.891Z,1743802664.891 [UniversalFixResidualReporter] Loaded 2025-04-04T21:37:44.891Z,1743802664.891 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-04-04T21:37:44.892Z,1743802664.892 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-04-04T21:37:44.892Z,1743802664.892 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-04-04T21:37:45.054Z,1743802665.054 [SBIT](DEBUG): Construct Startup Built In Test. 2025-04-04T21:37:45.068Z,1743802665.068 [SBIT] Loaded 2025-04-04T21:37:45.068Z,1743802665.068 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-04-04T21:37:45.071Z,1743802665.071 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-04-04T21:37:45.084Z,1743802665.084 [IBIT] Loaded 2025-04-04T21:37:45.084Z,1743802665.084 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-04-04T21:37:45.089Z,1743802665.089 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-04-04T21:37:45.168Z,1743802665.168 [CBIT] Loaded 2025-04-04T21:37:45.168Z,1743802665.168 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-04-04T21:37:45.199Z,1743802665.199 [GFScanner] Loaded 2025-04-04T21:37:45.200Z,1743802665.200 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-04-04T21:37:45.200Z,1743802665.200 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-04-04T21:37:45.201Z,1743802665.201 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-04-04T21:37:45.367Z,1743802665.367 [CTD_Seabird] Loaded 2025-04-04T21:37:45.368Z,1743802665.368 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-04-04T21:37:45.369Z,1743802665.369 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A474E0 2025-04-04T21:37:45.369Z,1743802665.369 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4682 2025-04-04T21:37:45.392Z,1743802665.392 [PAR_Licor] Loaded 2025-04-04T21:37:45.392Z,1743802665.392 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-04-04T21:37:45.437Z,1743802665.437 [WetLabsBB2FL] Loaded 2025-04-04T21:37:45.437Z,1743802665.437 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-04-04T21:37:45.438Z,1743802665.438 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0 2025-04-04T21:37:45.438Z,1743802665.438 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4683 2025-04-04T21:37:45.439Z,1743802665.439 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-04-04T21:37:45.440Z,1743802665.440 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-04-04T21:37:45.579Z,1743802665.579 [BuoyancyServo] Loaded 2025-04-04T21:37:45.579Z,1743802665.579 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-04-04T21:37:45.603Z,1743802665.603 [ElevatorServo] Loaded 2025-04-04T21:37:45.603Z,1743802665.603 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-04-04T21:37:45.626Z,1743802665.626 [MassServo] Loaded 2025-04-04T21:37:45.627Z,1743802665.627 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-04-04T21:37:45.649Z,1743802665.649 [RudderServo] Loaded 2025-04-04T21:37:45.649Z,1743802665.649 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-04-04T21:37:45.667Z,1743802665.667 [ThrusterHE] Loaded 2025-04-04T21:37:45.667Z,1743802665.667 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-04-04T21:37:45.668Z,1743802665.668 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-04-04T21:37:45.668Z,1743802665.668 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-04-04T21:37:45.722Z,1743802665.722 [VerticalControl](DEBUG): Construct VerticalControl. 2025-04-04T21:37:45.774Z,1743802665.774 [VerticalControl] Loaded 2025-04-04T21:37:45.775Z,1743802665.775 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-04-04T21:37:45.778Z,1743802665.778 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-04-04T21:37:45.822Z,1743802665.822 [HorizontalControl] Loaded 2025-04-04T21:37:45.822Z,1743802665.822 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-04-04T21:37:45.824Z,1743802665.824 [SpeedControl](DEBUG): Construct SpeedControl. 2025-04-04T21:37:45.826Z,1743802665.826 [SpeedControl] Loaded 2025-04-04T21:37:45.826Z,1743802665.826 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-04-04T21:37:45.829Z,1743802665.829 [LoopControl](DEBUG): Construct LoopControl. 2025-04-04T21:37:45.830Z,1743802665.830 [LoopControl] Loaded 2025-04-04T21:37:45.830Z,1743802665.830 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-04-04T21:37:45.830Z,1743802665.830 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-04-04T21:37:45.831Z,1743802665.831 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-04-04T21:37:45.963Z,1743802665.963 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-04-04T21:37:45.964Z,1743802665.964 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-04-04T21:37:46.142Z,1743802666.142 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-04-04T21:37:46.142Z,1743802666.142 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-04-04T21:37:46.828Z,1743802666.828 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-04-04T21:37:46.829Z,1743802666.829 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-04-04T21:37:46.887Z,1743802666.887 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-04-04T21:37:46.894Z,1743802666.894 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-04-04T21:37:46.897Z,1743802666.897 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-04-04T21:37:46.908Z,1743802666.908 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-04-04T21:37:46.909Z,1743802666.909 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0 2025-04-04T21:37:46.910Z,1743802666.910 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4684 2025-04-04T21:37:46.914Z,1743802666.914 [Supervisor](INFO): Main Thread ID is 4589 2025-04-04T21:37:46.914Z,1743802666.914 [Supervisor](DEBUG): Running supervisor. 2025-04-04T21:37:46.915Z,1743802666.915 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4685 2025-04-04T21:37:46.915Z,1743802666.915 [CommandExec](INFO): Initializing the command executive. 2025-04-04T21:37:46.917Z,1743802666.917 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4686 2025-04-04T21:37:46.919Z,1743802666.919 [controlThread ThreadHandler](INFO): Handler Thread ID is 4687 2025-04-04T21:37:46.920Z,1743802666.920 [controlThread](DEBUG): Initializing ControlThread 2025-04-04T21:37:46.921Z,1743802666.921 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-04-04T21:37:46.921Z,1743802666.921 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-04-04T21:37:46.921Z,1743802666.921 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-04-04T21:37:46.922Z,1743802666.922 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-04-04T21:37:46.922Z,1743802666.922 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-04-04T21:37:46.926Z,1743802666.926 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-04-04T21:37:46.926Z,1743802666.926 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-04-04T21:37:46.927Z,1743802666.927 [SBIT](INFO): Initialize SBIT Component. 2025-04-04T21:37:46.927Z,1743802666.927 [SBIT](IMPORTANT): git: 2025-03-26-1-g1815535cc 2025-04-04T21:37:46.927Z,1743802666.927 [SBIT](INFO): git hash: 1815535cca105e464bdb7831f6233b5043f0283f 2025-04-04T21:37:46.928Z,1743802666.928 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-04-04T21:37:46.929Z,1743802666.929 [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-04T21:37:46.930Z,1743802666.930 [SBIT](INFO): Beginning SBIT in 61.000000 seconds. 2025-04-04T21:37:46.930Z,1743802666.930 [IBIT](INFO): Initialize IBIT Component. 2025-04-04T21:37:46.931Z,1743802666.931 [CBIT](DEBUG): Initialize CBIT Component. 2025-04-04T21:37:46.932Z,1743802666.932 [logger ThreadHandler](INFO): Handler Thread ID is 4688 2025-04-04T21:37:46.943Z,1743802666.943 [CBIT](DEBUG): Initialized mux pins. 2025-04-04T21:37:46.943Z,1743802666.943 [CBIT](DEBUG): Initializing the watchdog timer. 2025-04-04T21:37:46.952Z,1743802666.952 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4689 2025-04-04T21:37:46.967Z,1743802666.967 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-04-04T21:37:46.968Z,1743802666.968 [CBIT](DEBUG): Initializing heartbeat. 2025-04-04T21:37:46.968Z,1743802666.968 [DAT ThreadHandler](INFO): Handler Thread ID is 4690 2025-04-04T21:37:46.969Z,1743802666.969 [DAT](INFO): Powering up 2025-04-04T21:37:46.969Z,1743802666.969 [DAT](DEBUG): Initializing DAT. 2025-04-04T21:37:46.973Z,1743802666.973 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4692 2025-04-04T21:37:46.975Z,1743802666.975 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-04-04T21:37:46.996Z,1743802666.996 [Onboard ThreadHandler](INFO): Handler Thread ID is 4693 2025-04-04T21:37:47.013Z,1743802667.013 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4694 2025-04-04T21:37:47.035Z,1743802667.035 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4695 2025-04-04T21:37:47.039Z,1743802667.039 [CBIT](DEBUG): Deactivating emergency mode. 2025-04-04T21:37:47.040Z,1743802667.040 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-04T21:37:47.044Z,1743802667.044 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4697 2025-04-04T21:37:47.048Z,1743802667.048 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4699 2025-04-04T21:37:47.050Z,1743802667.050 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-04-04T21:37:47.051Z,1743802667.051 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-04-04T21:37:47.051Z,1743802667.051 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-04-04T21:37:47.051Z,1743802667.051 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-04-04T21:37:47.051Z,1743802667.051 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-04-04T21:37:47.052Z,1743802667.052 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-04-04T21:37:47.052Z,1743802667.052 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-04-04T21:37:47.052Z,1743802667.052 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-04-04T21:37:47.055Z,1743802667.055 [WetLabsBB2FL](INFO): Powering up 2025-04-04T21:37:47.079Z,1743802667.079 [CBIT](DEBUG): Backplane powered. 2025-04-04T21:37:47.080Z,1743802667.080 [GFScanner](DEBUG): Initializing GFScanner 2025-04-04T21:37:47.080Z,1743802667.080 [GFScanner](DEBUG): Deactivating GF circuits. 2025-04-04T21:37:47.089Z,1743802667.089 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-04-04T21:37:47.090Z,1743802667.090 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-04-04T21:37:47.091Z,1743802667.091 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-04-04T21:37:47.096Z,1743802667.096 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-04-04T21:37:47.097Z,1743802667.097 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-04-04T21:37:47.097Z,1743802667.097 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-04-04T21:37:47.098Z,1743802667.098 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-04-04T21:37:47.099Z,1743802667.099 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-04-04T21:37:47.163Z,1743802667.163 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-04-04T21:37:47.173Z,1743802667.173 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-04T21:37:47.197Z,1743802667.197 [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-04T21:37:47.198Z,1743802667.198 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-04-04T21:37:47.198Z,1743802667.198 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-04-04T21:37:47.199Z,1743802667.199 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-04-04T21:37:47.420Z,1743802667.420 [Radio_Surface](INFO): Powering up 2025-04-04T21:37:47.430Z,1743802667.430 [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-04T21:37:47.448Z,1743802667.448 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-04-04T21:37:47.449Z,1743802667.449 [Default:A.Wait](DEBUG): Construct Wait. 2025-04-04T21:37:47.452Z,1743802667.452 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-04T21:37:47.477Z,1743802667.477 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-04-04T21:37:47.480Z,1743802667.480 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-04-04T21:37:47.498Z,1743802667.498 [Default:E.Execute](DEBUG): Construct Execute. 2025-04-04T21:37:47.501Z,1743802667.501 [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-04T21:37:47.506Z,1743802667.506 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,Waterlinked,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-04T21:37:47.527Z,1743802667.527 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-04T21:37:47.576Z,1743802667.576 [Depth_Keller](INFO): Initializing. 2025-04-04T21:37:47.577Z,1743802667.577 [MultiRay](INFO): Powering up MultiRay Lights 2025-04-04T21:37:47.577Z,1743802667.577 [MultiRay](INFO): Powering up secondary power supply. 2025-04-04T21:37:47.621Z,1743802667.621 [Power24vConverter](INFO): Powering up. 2025-04-04T21:37:47.630Z,1743802667.630 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-04T21:37:47.652Z,1743802667.652 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-04-04T21:37:47.660Z,1743802667.660 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-04-04T21:37:47.661Z,1743802667.661 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-04-04T21:37:47.668Z,1743802667.668 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-04-04T21:37:47.669Z,1743802667.669 [MassServo](DEBUG): Initializing EZServoServo. 2025-04-04T21:37:47.676Z,1743802667.676 [MassServo](DEBUG): Initializing MassServo. 2025-04-04T21:37:47.676Z,1743802667.676 [RudderServo](DEBUG): Initializing EZServoServo. 2025-04-04T21:37:47.684Z,1743802667.684 [RudderServo](DEBUG): Initializing RudderServo. 2025-04-04T21:37:47.685Z,1743802667.685 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-04-04T21:37:47.692Z,1743802667.692 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-04-04T21:37:47.960Z,1743802667.960 [Depth_Keller](ERROR): Pressure or depth reading out of range: 816.065491 decibar, 0.000000 m 2025-04-04T21:37:48.017Z,1743802668.017 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-04T21:37:49.660Z,1743802669.660 [WetLabsBB2FL](INFO): Powering down 2025-04-04T21:37:54.092Z,1743802674.092 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2025-04-04T21:37:58.006Z,1743802678.006 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005125 2025-04-04T21:37:58.812Z,1743802678.812 [DAT](INFO): DAT read: 2025-04-04T21:37:58.813Z,1743802678.813 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-04-04T21:38:00.325Z,1743802680.325 [DAT](INFO): DAT read: MF Frequency Band 2025-04-04T21:38:00.326Z,1743802680.326 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-04-04T21:38:00.326Z,1743802680.326 [DAT](INFO): DAT read: Apr 4 2025 20:15:18 2025-04-04T21:38:01.333Z,1743802681.333 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-04-04T21:38:01.334Z,1743802681.334 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-04-04T21:38:01.334Z,1743802681.334 [DAT](INFO): commRate: 800 2025-04-04T21:38:03.403Z,1743802683.403 [DAT](INFO): entering command mode 2025-04-04T21:38:03.604Z,1743802683.604 [DAT](INFO): DAT read: 2025-04-04T21:38:03.604Z,1743802683.604 [DAT](INFO): DAT read: user:1> 2025-04-04T21:38:03.605Z,1743802683.605 [DAT](INFO): setting verbose to 3 2025-04-04T21:38:03.856Z,1743802683.856 [DAT](INFO): DAT read: user:1> 2025-04-04T21:38:03.857Z,1743802683.857 [DAT](INFO): DAT read: Verbose | 3 2025-04-04T21:38:03.858Z,1743802683.858 [DAT](INFO): set verbose to 3 2025-04-04T21:38:03.858Z,1743802683.858 [DAT](INFO): setting DatVerbose to 27440 2025-04-04T21:38:04.108Z,1743802684.108 [DAT](INFO): DAT read: user:2> 2025-04-04T21:38:04.109Z,1743802684.109 [DAT](INFO): DAT read: DatVerbose | 27440 2025-04-04T21:38:04.109Z,1743802684.109 [DAT](INFO): set DatVerbose to 27440 2025-04-04T21:38:04.110Z,1743802684.110 [DAT](INFO): setting transmit power to 8 2025-04-04T21:38:04.363Z,1743802684.363 [DAT](INFO): DAT read: user:3> 2025-04-04T21:38:04.364Z,1743802684.364 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-04-04T21:38:04.364Z,1743802684.364 [DAT](INFO): set transmit power to 8 2025-04-04T21:38:04.364Z,1743802684.364 [DAT](INFO): setting local address to 9 2025-04-04T21:38:04.616Z,1743802684.616 [DAT](INFO): DAT read: user:4> 2025-04-04T21:38:04.617Z,1743802684.617 [DAT](INFO): DAT read: LocalAddr | 9 2025-04-04T21:38:04.617Z,1743802684.617 [DAT](INFO): set local address to 9 2025-04-04T21:38:04.619Z,1743802684.619 [DAT](INFO): Setting time to: 21:38:4 And date to:4/4/2025 2025-04-04T21:38:04.871Z,1743802684.871 [DAT](INFO): DAT read: user:5> 2025-04-04T21:38:04.872Z,1743802684.872 [DAT](INFO): DAT read: Fri Apr 4, 2025 21:38:04 2025-04-04T21:38:04.872Z,1743802684.872 [DAT](INFO): Local DAT time set to Fri Apr 4, 2025 21:38:04 2025-04-04T21:38:14.708Z,1743802694.708 [NAL9602](INFO): Powering up NAL9602 2025-04-04T21:38:24.888Z,1743802704.888 [Waterlinked](INFO): Powering down 2025-04-04T21:38:25.577Z,1743802705.577 [NAL9602](INFO): NAL9602 initialized 2025-04-04T21:38:48.658Z,1743802728.658 [SBIT](IMPORTANT): Beginning Startup BIT 2025-04-04T21:38:48.663Z,1743802728.663 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-04-04T21:38:53.180Z,1743802733.180 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.010376 CHAN A1 (24V): 0.005601 CHAN A2 (12V): -0.006888 CHAN A3 (5V): -0.008472 CHAN B0 (3.3V): -0.002681 CHAN B1 (3.15aV): -0.002641 CHAN B2 (3.15bV): -0.000941 CHAN B3 (GND): -0.003019 OPEN: 0.005030 Full Scale: +/- 1 mA 2025-04-04T21:38:53.517Z,1743802733.517 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:04.486Z,1743802744.486 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:08.518Z,1743802748.518 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:15.803Z,1743802755.803 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:21.046Z,1743802761.046 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:26.706Z,1743802766.706 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:37.707Z,1743802777.707 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:42.858Z,1743802782.858 [SBIT](IMPORTANT): SBIT PASSED 2025-04-04T21:39:42.858Z,1743802782.858 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-04-04T21:39:42.860Z,1743802782.860 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2025-04-04T21:39:42.860Z,1743802782.860 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter; 2025-04-04T21:39:42.860Z,1743802782.860 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-04-04T21:39:42.860Z,1743802782.860 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-04-04T21:39:42.860Z,1743802782.860 [SBIT](IMPORTANT): MultiRay.brightnessWhite=100 none; 2025-04-04T21:39:42.863Z,1743802782.863 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool; 2025-04-04T21:39:42.863Z,1743802782.863 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=1 bool; 2025-04-04T21:39:42.863Z,1743802782.863 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=0 bool; 2025-04-04T21:39:42.863Z,1743802782.863 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=241.314617 cubic_centimeter; 2025-04-04T21:39:42.863Z,1743802782.863 [SBIT](IMPORTANT): VerticalControl.elevLimit=10 degree; 2025-04-04T21:39:42.863Z,1743802782.863 [SBIT](IMPORTANT): VerticalControl.kdDepth=0.2 radian_per_second_per_meter; 2025-04-04T21:39:42.864Z,1743802782.864 [SBIT](IMPORTANT): VerticalControl.kpDepth=0.15 radian_per_meter; 2025-04-04T21:39:42.864Z,1743802782.864 [SBIT](IMPORTANT): VerticalControl.massDefault=10.352381 millimeter; 2025-04-04T21:39:43.254Z,1743802783.254 [MissionManager](IMPORTANT): Started mission Startup 2025-04-04T21:39:43.254Z,1743802783.254 [Startup] Running Loop=1 2025-04-04T21:39:43.255Z,1743802783.255 [Startup](DEBUG): Aggregate::initialize Startup 2025-04-04T21:39:43.255Z,1743802783.255 [Startup:A.GoToSurface] Running Loop=1 2025-04-04T21:39:43.255Z,1743802783.255 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-04T21:39:43.280Z,1743802783.280 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-04T21:39:43.280Z,1743802783.280 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-04T21:39:43.280Z,1743802783.280 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-04T21:39:43.281Z,1743802783.281 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-04T21:39:43.281Z,1743802783.281 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-04T21:39:43.281Z,1743802783.281 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-04T21:39:43.288Z,1743802783.288 [Startup:StartupSatComms] Running Loop=1 2025-04-04T21:39:43.288Z,1743802783.288 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-04-04T21:39:43.288Z,1743802783.288 [Startup:StartupSatComms:A] Running Loop=1 2025-04-04T21:39:43.650Z,1743802783.650 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-04-04T21:39:48.571Z,1743802788.571 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:59.053Z,1743802799.053 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:39:59.460Z,1743802799.460 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:09.561Z,1743802809.561 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:10.859Z,1743802810.859 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:20.476Z,1743802820.476 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:21.684Z,1743802821.684 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:31.377Z,1743802831.377 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:32.591Z,1743802832.591 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:42.291Z,1743802842.291 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:43.097Z,1743802843.097 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:43.460Z,1743802843.460 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-04T21:39:43.3Z 2025-04-04T21:40:43.460Z,1743802843.460 [Startup:StartupSatComms:A] Stopped 2025-04-04T21:40:43.460Z,1743802843.460 [Startup:StartupSatComms:B] Running Loop=1 2025-04-04T21:40:43.858Z,1743802843.858 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-04T21:40:47.089Z,1743802847.089 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-04-04T21:40:47.089Z,1743802847.089 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-04T21:40:47.155Z,1743802847.155 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-04T21:40:47.519Z,1743802847.519 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-04T21:40:47.519Z,1743802847.519 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-04-04T21:40:50.727Z,1743802850.727 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250404T190816/Courier0043.lzma 2025-04-04T21:40:51.729Z,1743802851.729 [DataOverHttps](INFO): Moved sent file to Logs/20250404T190816/Courier0043.lzma.bak 2025-04-04T21:40:51.730Z,1743802851.730 [DataOverHttps](INFO): SBD MOMSN=24541209 2025-04-04T21:40:53.192Z,1743802853.192 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:40:54.410Z,1743802854.410 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:04.561Z,1743802864.561 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:05.362Z,1743802865.362 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:08.052Z,1743802868.052 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250404T213736/Courier0000.lzma 2025-04-04T21:41:09.053Z,1743802869.053 [DataOverHttps](INFO): Moved sent file to Logs/20250404T213736/Courier0000.lzma.bak 2025-04-04T21:41:09.053Z,1743802869.053 [DataOverHttps](INFO): SBD MOMSN=24541211 2025-04-04T21:41:15.445Z,1743802875.445 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:16.634Z,1743802876.634 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:23.912Z,1743802883.912 [DataOverHttps](INFO): Sending 345 bytes from file Logs/20250404T190816/Express0044.lzma 2025-04-04T21:41:24.913Z,1743802884.913 [DataOverHttps](INFO): Moved sent file to Logs/20250404T190816/Express0044.lzma.bak 2025-04-04T21:41:24.913Z,1743802884.913 [DataOverHttps](INFO): SBD MOMSN=24541215 2025-04-04T21:41:27.530Z,1743802887.530 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:33.981Z,1743802893.981 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:38.490Z,1743802898.490 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:40.689Z,1743802900.689 [DataOverHttps](INFO): Sending 924 bytes from file Logs/20250404T213736/Express0001.lzma 2025-04-04T21:41:41.689Z,1743802901.689 [DataOverHttps](INFO): Moved sent file to Logs/20250404T213736/Express0001.lzma.bak 2025-04-04T21:41:41.689Z,1743802901.689 [DataOverHttps](INFO): SBD MOMSN=24541227 2025-04-04T21:41:43.238Z,1743802903.238 [Startup:StartupSatComms:B] Stopped 2025-04-04T21:41:43.239Z,1743802903.239 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-04-04T21:41:43.239Z,1743802903.239 [Startup:StartupSatComms] Stopped 2025-04-04T21:41:43.239Z,1743802903.239 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-04-04T21:41:43.240Z,1743802903.240 [Startup](INFO): Completed Startup 2025-04-04T21:41:43.240Z,1743802903.240 [MissionManager](INFO): Startup is completed. 2025-04-04T21:41:43.240Z,1743802903.240 [MissionManager](INFO): Uninitializing Mission Startup 2025-04-04T21:41:43.240Z,1743802903.240 [Startup] Stopped 2025-04-04T21:41:43.240Z,1743802903.240 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-04-04T21:41:43.241Z,1743802903.241 [Startup:A.GoToSurface] Stopped 2025-04-04T21:41:43.241Z,1743802903.241 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-04T21:41:43.637Z,1743802903.637 [MissionManager](IMPORTANT): Started mission Default 2025-04-04T21:41:43.637Z,1743802903.637 [Default] Running Loop=1 2025-04-04T21:41:43.638Z,1743802903.638 [Default](DEBUG): Aggregate::initialize Default 2025-04-04T21:41:43.638Z,1743802903.638 [Default:B.GoToSurface] Running Loop=1 2025-04-04T21:41:43.638Z,1743802903.638 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-04T21:41:43.638Z,1743802903.638 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-04T21:41:43.638Z,1743802903.638 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-04T21:41:43.639Z,1743802903.639 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-04T21:41:43.639Z,1743802903.639 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-04T21:41:43.639Z,1743802903.639 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-04T21:41:43.640Z,1743802903.640 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-04T21:41:43.640Z,1743802903.640 [Default:A.Wait] Running Loop=1 2025-04-04T21:41:43.640Z,1743802903.640 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-04-04T21:41:48.951Z,1743802908.951 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:41:56.975Z,1743802916.975 [Default:A.Wait](INFO): Done Waiting. 2025-04-04T21:41:56.975Z,1743802916.975 [Default:A.Wait] Stopped 2025-04-04T21:41:56.975Z,1743802916.975 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-04-04T21:41:57.393Z,1743802917.393 [Default:CheckIn] Running Loop=1 2025-04-04T21:41:57.394Z,1743802917.394 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-04-04T21:41:57.394Z,1743802917.394 [Default:CheckIn:Read_GPS] Running Loop=1 2025-04-04T21:41:57.806Z,1743802917.806 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-04-04T21:41:59.856Z,1743802919.856 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:42:10.760Z,1743802930.760 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:42:10.822Z,1743802930.822 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:42:22.497Z,1743802942.497 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:42:28.922Z,1743802948.922 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:42:40.642Z,1743802960.642 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:43:28.669Z,1743803008.669 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-04-04T21:43:42.830Z,1743803022.830 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:43:48.093Z,1743803028.093 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-04-04T21:43:48.093Z,1743803028.093 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-04T21:43:48.106Z,1743803028.106 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-04T21:43:48.514Z,1743803028.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-04T21:43:48.514Z,1743803028.514 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-04-04T21:43:53.781Z,1743803033.781 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:44:04.696Z,1743803044.696 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:44:15.596Z,1743803055.596 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:44:26.509Z,1743803066.509 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:44:37.433Z,1743803077.433 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:44:42.715Z,1743803082.715 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:44:48.350Z,1743803088.350 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:44:53.594Z,1743803093.594 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:44:59.248Z,1743803099.248 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:04.093Z,1743803104.093 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:09.759Z,1743803109.759 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:15.407Z,1743803115.407 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:19.700Z,1743803119.700 [CommandExec](IMPORTANT): got command failComponent 2025-04-04T21:45:19.700Z,1743803119.700 [CommandExec](IMPORTANT): Failed components: 2025-04-04T21:45:19.701Z,1743803119.701 [CommandExec](IMPORTANT): No failed Components. 2025-04-04T21:45:20.716Z,1743803120.716 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:26.320Z,1743803126.320 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:31.573Z,1743803131.573 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:32.101Z,1743803132.101 [CommandExec](IMPORTANT): got command strobe off 2025-04-04T21:45:32.101Z,1743803132.101 [CommandExec](IMPORTANT): Deactivating strobe 2025-04-04T21:45:37.229Z,1743803137.229 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:37.520Z,1743803137.520 [CommandExec](IMPORTANT): got command gfscan 2025-04-04T21:45:37.620Z,1743803137.620 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-04-04T21:45:42.074Z,1743803142.074 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.011053 CHAN A1 (24V): 0.005339 CHAN A2 (12V): -0.008427 CHAN A3 (5V): -0.006577 CHAN B0 (3.3V): -0.002814 CHAN B1 (3.15aV): -0.002832 CHAN B2 (3.15bV): -0.001664 CHAN B3 (GND): -0.002720 OPEN: 0.005164 Full Scale: +/- 1 mA 2025-04-04T21:45:42.498Z,1743803142.498 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:46.584Z,1743803146.584 [CommandExec](IMPORTANT): got command quit 2025-04-04T21:45:47.587Z,1743803147.587 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2025-04-04T21:45:47.588Z,1743803147.588 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:47.588Z,1743803147.588 [CommandExec](INFO): Uninitializing the command executive. 2025-04-04T21:45:47.588Z,1743803147.588 [CommandExec](INFO): Uninitializing the command scheduler. 2025-04-04T21:45:47.588Z,1743803147.588 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:47.788Z,1743803147.788 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-04-04T21:45:47.789Z,1743803147.789 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-04-04T21:45:47.789Z,1743803147.789 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:47.789Z,1743803147.789 [NavChartDb](INFO): Join timeout helper Thread ID is 4718 2025-04-04T21:45:47.944Z,1743803147.944 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:47.944Z,1743803147.944 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:47.947Z,1743803147.947 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-04-04T21:45:47.947Z,1743803147.947 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:47.948Z,1743803147.948 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4719 2025-04-04T21:45:47.000Z,1743803148.000 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:48.000Z,1743803148.000 [WetLabsBB2FL](INFO): Powering down 2025-04-04T21:45:48.001Z,1743803148.001 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:48.016Z,1743803148.016 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-04-04T21:45:48.016Z,1743803148.016 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:48.016Z,1743803148.016 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4720 2025-04-04T21:45:48.067Z,1743803148.067 [CTD_Seabird](INFO): Powering down 2025-04-04T21:45:48.079Z,1743803148.079 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:48.080Z,1743803148.080 [CTD_Seabird](INFO): Powering down 2025-04-04T21:45:48.092Z,1743803148.092 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:48.112Z,1743803148.112 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-04-04T21:45:48.112Z,1743803148.112 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:48.112Z,1743803148.112 [Radio_Surface](INFO): Join timeout helper Thread ID is 4721 2025-04-04T21:45:48.192Z,1743803148.192 [Radio_Surface](INFO): Powering down 2025-04-04T21:45:48.192Z,1743803148.192 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:48.193Z,1743803148.193 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:48.208Z,1743803148.208 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-04-04T21:45:48.208Z,1743803148.208 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:48.208Z,1743803148.208 [Onboard](INFO): Join timeout helper Thread ID is 4722 2025-04-04T21:45:48.566Z,1743803148.566 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-04T21:45:48.704Z,1743803148.704 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-04-04T21:45:52.384Z,1743803152.384 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:52.384Z,1743803152.384 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:52.404Z,1743803152.404 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-04-04T21:45:52.404Z,1743803152.404 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:52.405Z,1743803152.405 [DataOverHttps](INFO): Join timeout helper Thread ID is 4723 2025-04-04T21:45:52.720Z,1743803152.720 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:52.720Z,1743803152.720 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:52.736Z,1743803152.736 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-04-04T21:45:52.736Z,1743803152.736 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:52.737Z,1743803152.737 [DAT](INFO): Join timeout helper Thread ID is 4724 2025-04-04T21:45:52.832Z,1743803152.832 [DAT](INFO): Powering down 2025-04-04T21:45:52.912Z,1743803152.912 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:52.913Z,1743803152.913 [DAT](INFO): Powering down 2025-04-04T21:45:52.913Z,1743803152.913 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:52.924Z,1743803152.924 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-04-04T21:45:52.924Z,1743803152.924 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:52.925Z,1743803152.925 [BackseatComponent](INFO): Join timeout helper Thread ID is 4725 2025-04-04T21:45:53.084Z,1743803153.084 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:53.084Z,1743803153.084 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.104Z,1743803153.104 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-04-04T21:45:53.104Z,1743803153.104 [logger ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.105Z,1743803153.105 [logger](INFO): Join timeout helper Thread ID is 4726 2025-04-04T21:45:53.128Z,1743803153.128 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:53.129Z,1743803153.129 [logger ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.144Z,1743803153.144 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-04-04T21:45:53.144Z,1743803153.144 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.145Z,1743803153.145 [CommandLine](INFO): Join timeout helper Thread ID is 4727 2025-04-04T21:45:53.244Z,1743803153.244 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:53.244Z,1743803153.244 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.264Z,1743803153.264 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-04-04T21:45:53.264Z,1743803153.264 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.265Z,1743803153.265 [CommandExec](INFO): Join timeout helper Thread ID is 4728 2025-04-04T21:45:53.266Z,1743803153.266 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-04-04T21:45:53.266Z,1743803153.266 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.266Z,1743803153.266 [controlThread](INFO): Join timeout helper Thread ID is 4729 2025-04-04T21:45:53.304Z,1743803153.304 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-04T21:45:53.304Z,1743803153.304 [controlThread](DEBUG): Uninitializing ControlThread 2025-04-04T21:45:53.305Z,1743803153.305 [AHRS_M2](INFO): Powering down 2025-04-04T21:45:53.384Z,1743803153.384 [MultiRay](INFO): Powering down. 2025-04-04T21:45:53.385Z,1743803153.385 [NAL9602](INFO): Powering down 2025-04-04T21:45:53.387Z,1743803153.387 [Waterlinked](INFO): Powering down 2025-04-04T21:45:53.388Z,1743803153.388 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-04-04T21:45:53.389Z,1743803153.389 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-04-04T21:45:53.390Z,1743803153.390 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-04-04T21:45:53.390Z,1743803153.390 [MissionManager](INFO): Uninitializing Mission Default 2025-04-04T21:45:53.390Z,1743803153.390 [Default] Stopped 2025-04-04T21:45:53.390Z,1743803153.390 [Default](DEBUG): Aggregate::uninitialize Default 2025-04-04T21:45:53.390Z,1743803153.390 [Default:B.GoToSurface] Stopped 2025-04-04T21:45:53.390Z,1743803153.390 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-04T21:45:53.390Z,1743803153.390 [Default:CheckIn] Stopped 2025-04-04T21:45:53.391Z,1743803153.391 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-04-04T21:45:53.391Z,1743803153.391 [Default:CheckIn:Read_GPS] Stopped 2025-04-04T21:45:53.394Z,1743803153.394 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-04-04T21:45:53.394Z,1743803153.394 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-04-04T21:45:53.394Z,1743803153.394 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-04-04T21:45:53.395Z,1743803153.395 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-04-04T21:45:53.395Z,1743803153.395 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-04-04T21:45:53.395Z,1743803153.395 [BuoyancyServo](INFO): Powering down 2025-04-04T21:45:53.408Z,1743803153.408 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-04-04T21:45:53.408Z,1743803153.408 [ElevatorServo](INFO): Powering down 2025-04-04T21:45:53.409Z,1743803153.409 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-04-04T21:45:53.409Z,1743803153.409 [MassServo](INFO): Powering down 2025-04-04T21:45:53.409Z,1743803153.409 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-04-04T21:45:53.410Z,1743803153.410 [RudderServo](INFO): Powering down 2025-04-04T21:45:53.410Z,1743803153.410 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-04-04T21:45:53.410Z,1743803153.410 [ThrusterHE](INFO): Powering down 2025-04-04T21:45:53.411Z,1743803153.411 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-04-04T21:45:53.412Z,1743803153.412 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-04-04T21:45:53.412Z,1743803153.412 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-04-04T21:45:53.412Z,1743803153.412 [CBIT](DEBUG): Powering off loads. 2025-04-04T21:45:53.423Z,1743803153.423 [CBIT](DEBUG): Disabling WDT. 2025-04-04T21:45:53.435Z,1743803153.435 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-04-04T21:45:53.436Z,1743803153.436 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-04-04T21:45:53.437Z,1743803153.437 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.459Z,1743803153.459 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.463Z,1743803153.463 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.470Z,1743803153.470 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.476Z,1743803153.476 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.519Z,1743803153.519 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.553Z,1743803153.553 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-04-04T21:45:53.553Z,1743803153.553 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-04-04T21:45:53.569Z,1743803153.569 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.573Z,1743803153.573 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.627Z,1743803153.627 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-04T21:45:53.676Z,1743803153.676 [logger ThreadHandler](INFO): Thread cancelled.