2025-04-04T20:24:22.562Z,1743798262.562 [Supervisor](DEBUG): Initializing supervisor.
2025-04-04T20:24:22.567Z,1743798262.567 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-04-04T20:24:22.567Z,1743798262.567 [SyncHandler](INFO): Protected caller Thread ID is 849
2025-04-04T20:24:22.568Z,1743798262.568 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-04-04T20:24:22.569Z,1743798262.569 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-04-04T20:24:22.569Z,1743798262.569 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 850
2025-04-04T20:24:22.573Z,1743798262.573 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-04-04T20:24:22.593Z,1743798262.593 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-04-04T20:24:22.594Z,1743798262.594 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-04-04T20:24:22.594Z,1743798262.594 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 851
2025-04-04T20:24:22.599Z,1743798262.599 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-04-04T20:24:22.600Z,1743798262.600 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-04-04T20:24:22.600Z,1743798262.600 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 852
2025-04-04T20:24:22.602Z,1743798262.602 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-04-04T20:24:22.603Z,1743798262.603 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-04-04T20:24:22.604Z,1743798262.604 [logger ThreadHandler](INFO): Protected caller Thread ID is 853
2025-04-04T20:24:22.608Z,1743798262.608 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-04-04T20:24:22.608Z,1743798262.608 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-04-04T20:24:22.612Z,1743798262.612 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-04-04T20:24:22.960Z,1743798262.960 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-04-04T20:24:22.962Z,1743798262.962 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-04-04T20:24:23.240Z,1743798263.240 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-04-04T20:24:23.241Z,1743798263.241 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-04-04T20:24:23.751Z,1743798263.751 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-04-04T20:24:23.753Z,1743798263.753 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-04-04T20:24:23.998Z,1743798263.998 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-04-04T20:24:23.000Z,1743798264.000 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-04-04T20:24:24.235Z,1743798264.235 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-04-04T20:24:24.236Z,1743798264.236 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-04-04T20:24:25.068Z,1743798265.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-04-04T20:24:25.069Z,1743798265.069 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-04-04T20:24:25.428Z,1743798265.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-04-04T20:24:25.429Z,1743798265.429 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-04-04T20:24:25.554Z,1743798265.554 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-04-04T20:24:25.554Z,1743798265.554 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-04-04T20:24:25.645Z,1743798265.645 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-04-04T20:24:25.843Z,1743798265.843 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-04-04T20:24:25.844Z,1743798265.844 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-04-04T20:24:26.349Z,1743798266.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-04-04T20:24:26.350Z,1743798266.350 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-04-04T20:24:26.583Z,1743798266.583 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-04-04T20:24:26.584Z,1743798266.584 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-04-04T20:24:26.732Z,1743798266.732 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-04-04T20:24:26.733Z,1743798266.733 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-04-04T20:24:26.824Z,1743798266.824 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-04-04T20:24:27.268Z,1743798267.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-04-04T20:24:27.269Z,1743798267.269 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-04-04T20:24:27.849Z,1743798267.849 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-04-04T20:24:27.851Z,1743798267.851 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2025-04-04T20:24:27.853Z,1743798267.853 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2025-04-04T20:24:27.999Z,1743798267.999 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2025-04-04T20:24:28.279Z,1743798268.279 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-04-04T20:24:28.280Z,1743798268.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2025-04-04T20:24:28.392Z,1743798268.392 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2025-04-04T20:24:28.427Z,1743798268.427 [Config/vehicle](ERROR): Unterminated quote: "/dev/loadC3;
2025-04-04T20:24:28.499Z,1743798268.499 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2025-04-04T20:24:28.620Z,1743798268.620 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2025-04-04T20:24:28.761Z,1743798268.761 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2025-04-04T20:24:28.865Z,1743798268.865 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2025-04-04T20:24:28.984Z,1743798268.984 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2025-04-04T20:24:29.078Z,1743798269.078 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2025-04-04T20:24:29.190Z,1743798269.190 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2025-04-04T20:24:29.286Z,1743798269.286 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2025-04-04T20:24:29.290Z,1743798269.290 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-04-04T20:24:29.306Z,1743798269.306 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-04-04T20:24:29.307Z,1743798269.307 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-04-04T20:24:29.447Z,1743798269.447 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-04-04T20:24:29.448Z,1743798269.448 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-04-04T20:24:29.488Z,1743798269.488 [DeadReckonWithRespectToSeafloor] Loaded
2025-04-04T20:24:29.488Z,1743798269.488 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2025-04-04T20:24:29.503Z,1743798269.503 [NavChart] Loaded
2025-04-04T20:24:29.504Z,1743798269.504 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-04-04T20:24:29.510Z,1743798269.510 [UniversalFixResidualReporter] Loaded
2025-04-04T20:24:29.511Z,1743798269.511 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-04-04T20:24:29.511Z,1743798269.511 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-04-04T20:24:29.512Z,1743798269.512 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-04-04T20:24:30.315Z,1743798270.315 [AHRS_M2] Loaded
2025-04-04T20:24:30.315Z,1743798270.315 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-04-04T20:24:30.569Z,1743798270.569 [BackseatComponent] Loaded
2025-04-04T20:24:30.569Z,1743798270.569 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-04-04T20:24:30.570Z,1743798270.570 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085D4E0
2025-04-04T20:24:30.571Z,1743798270.571 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 935
2025-04-04T20:24:30.573Z,1743798270.573 [LcmUniversalReporter] Loaded
2025-04-04T20:24:30.574Z,1743798270.574 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-04-04T20:24:32.034Z,1743798272.034 [BPC1] Loaded
2025-04-04T20:24:32.034Z,1743798272.034 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-04-04T20:24:32.151Z,1743798272.151 [DAT] Loaded
2025-04-04T20:24:32.151Z,1743798272.151 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-04-04T20:24:32.152Z,1743798272.152 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088D4E0
2025-04-04T20:24:32.153Z,1743798272.153 [DAT ThreadHandler](INFO): Protected caller Thread ID is 936
2025-04-04T20:24:32.298Z,1743798272.298 [DataOverHttps] Loaded
2025-04-04T20:24:32.298Z,1743798272.298 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-04-04T20:24:32.299Z,1743798272.299 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2025-04-04T20:24:32.300Z,1743798272.300 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 937
2025-04-04T20:24:32.322Z,1743798272.322 [DepthKeller33X] Loaded
2025-04-04T20:24:32.322Z,1743798272.322 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
2025-04-04T20:24:32.327Z,1743798272.327 [DropWeight] Loaded
2025-04-04T20:24:32.327Z,1743798272.327 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-04-04T20:24:32.391Z,1743798272.391 [NAL9602] Loaded
2025-04-04T20:24:32.391Z,1743798272.391 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-04-04T20:24:32.421Z,1743798272.421 [Onboard] Loaded
2025-04-04T20:24:32.421Z,1743798272.421 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-04-04T20:24:32.422Z,1743798272.422 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2025-04-04T20:24:32.422Z,1743798272.422 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 938
2025-04-04T20:24:32.436Z,1743798272.436 [Power24vConverter] Loaded
2025-04-04T20:24:32.436Z,1743798272.436 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-04-04T20:24:32.454Z,1743798272.454 [Radio_Surface] Loaded
2025-04-04T20:24:32.454Z,1743798272.454 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-04-04T20:24:32.455Z,1743798272.455 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2025-04-04T20:24:32.455Z,1743798272.455 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 939
2025-04-04T20:24:32.456Z,1743798272.456 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-04-04T20:24:32.457Z,1743798272.457 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-04-04T20:24:32.530Z,1743798272.530 [DepthRateCalculator] Loaded
2025-04-04T20:24:32.530Z,1743798272.530 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-04-04T20:24:32.535Z,1743798272.535 [PitchRateCalculator] Loaded
2025-04-04T20:24:32.536Z,1743798272.536 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-04-04T20:24:32.545Z,1743798272.545 [SpeedCalculator] Loaded
2025-04-04T20:24:32.546Z,1743798272.546 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-04-04T20:24:32.550Z,1743798272.550 [YawRateCalculator] Loaded
2025-04-04T20:24:32.550Z,1743798272.550 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-04-04T20:24:32.573Z,1743798272.573 [ElevatorOffsetCalculator] Loaded
2025-04-04T20:24:32.573Z,1743798272.573 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-04-04T20:24:32.574Z,1743798272.574 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-04-04T20:24:32.574Z,1743798272.574 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-04-04T20:24:32.663Z,1743798272.663 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-04-04T20:24:32.663Z,1743798272.663 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-04-04T20:24:32.832Z,1743798272.832 [BuoyancyServo] Loaded
2025-04-04T20:24:32.832Z,1743798272.832 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-04-04T20:24:32.856Z,1743798272.856 [ElevatorServo] Loaded
2025-04-04T20:24:32.856Z,1743798272.856 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-04-04T20:24:32.879Z,1743798272.879 [MassServo] Loaded
2025-04-04T20:24:32.879Z,1743798272.879 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-04-04T20:24:32.902Z,1743798272.902 [RudderServo] Loaded
2025-04-04T20:24:32.902Z,1743798272.902 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-04-04T20:24:32.921Z,1743798272.921 [ThrusterHE] Loaded
2025-04-04T20:24:32.921Z,1743798272.921 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-04-04T20:24:32.921Z,1743798272.921 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-04-04T20:24:32.922Z,1743798272.922 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-04-04T20:24:33.103Z,1743798273.103 [Aanderaa_O2] Loaded
2025-04-04T20:24:33.103Z,1743798273.103 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2025-04-04T20:24:33.166Z,1743798273.166 [CTD_Seabird] Loaded
2025-04-04T20:24:33.167Z,1743798273.167 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-04-04T20:24:33.168Z,1743798273.168 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A4E4E0
2025-04-04T20:24:33.168Z,1743798273.168 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 940
2025-04-04T20:24:33.203Z,1743798273.203 [ESPComponent] Loaded
2025-04-04T20:24:33.204Z,1743798273.204 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-04-04T20:24:33.250Z,1743798273.250 [WetLabsBB2FL] Loaded
2025-04-04T20:24:33.250Z,1743798273.250 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-04-04T20:24:33.251Z,1743798273.251 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A7E4E0
2025-04-04T20:24:33.251Z,1743798273.251 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 941
2025-04-04T20:24:33.252Z,1743798273.252 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-04-04T20:24:33.253Z,1743798273.253 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-04-04T20:24:33.421Z,1743798273.421 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-04-04T20:24:33.422Z,1743798273.422 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-04-04T20:24:33.646Z,1743798273.646 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-04-04T20:24:33.646Z,1743798273.646 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-04-04T20:24:34.061Z,1743798274.061 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-04-04T20:24:34.063Z,1743798274.063 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-04-04T20:24:34.135Z,1743798274.135 [VerticalControl](DEBUG): Construct VerticalControl.
2025-04-04T20:24:34.189Z,1743798274.189 [VerticalControl] Loaded
2025-04-04T20:24:34.189Z,1743798274.189 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-04-04T20:24:34.192Z,1743798274.192 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-04-04T20:24:34.240Z,1743798274.240 [HorizontalControl] Loaded
2025-04-04T20:24:34.240Z,1743798274.240 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-04-04T20:24:34.242Z,1743798274.242 [SpeedControl](DEBUG): Construct SpeedControl.
2025-04-04T20:24:34.244Z,1743798274.244 [SpeedControl] Loaded
2025-04-04T20:24:34.244Z,1743798274.244 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-04-04T20:24:34.247Z,1743798274.247 [LoopControl](DEBUG): Construct LoopControl.
2025-04-04T20:24:34.248Z,1743798274.248 [LoopControl] Loaded
2025-04-04T20:24:34.248Z,1743798274.248 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-04-04T20:24:34.248Z,1743798274.248 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-04-04T20:24:34.249Z,1743798274.249 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-04-04T20:24:34.446Z,1743798274.446 [SBIT](DEBUG): Construct Startup Built In Test.
2025-04-04T20:24:34.455Z,1743798274.455 [SBIT] Loaded
2025-04-04T20:24:34.456Z,1743798274.456 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-04-04T20:24:34.458Z,1743798274.458 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-04-04T20:24:34.472Z,1743798274.472 [IBIT] Loaded
2025-04-04T20:24:34.472Z,1743798274.472 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-04-04T20:24:34.477Z,1743798274.477 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-04-04T20:24:34.560Z,1743798274.560 [CBIT] Loaded
2025-04-04T20:24:34.560Z,1743798274.560 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-04-04T20:24:34.592Z,1743798274.592 [GFScanner] Loaded
2025-04-04T20:24:34.592Z,1743798274.592 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-04-04T20:24:34.593Z,1743798274.593 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-04-04T20:24:34.593Z,1743798274.593 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-04-04T20:24:34.642Z,1743798274.642 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-04-04T20:24:34.648Z,1743798274.648 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-04-04T20:24:34.651Z,1743798274.651 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-04-04T20:24:34.662Z,1743798274.662 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-04-04T20:24:34.663Z,1743798274.663 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0
2025-04-04T20:24:34.663Z,1743798274.663 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 942
2025-04-04T20:24:34.668Z,1743798274.668 [Supervisor](INFO): Main Thread ID is 831
2025-04-04T20:24:34.668Z,1743798274.668 [Supervisor](DEBUG): Running supervisor.
2025-04-04T20:24:34.668Z,1743798274.668 [CommandExec ThreadHandler](INFO): Handler Thread ID is 943
2025-04-04T20:24:34.669Z,1743798274.669 [CommandExec](INFO): Initializing the command executive.
2025-04-04T20:24:34.671Z,1743798274.671 [CommandLine ThreadHandler](INFO): Handler Thread ID is 944
2025-04-04T20:24:34.673Z,1743798274.673 [controlThread ThreadHandler](INFO): Handler Thread ID is 945
2025-04-04T20:24:34.673Z,1743798274.673 [controlThread](DEBUG): Initializing ControlThread
2025-04-04T20:24:34.675Z,1743798274.675 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-04-04T20:24:34.675Z,1743798274.675 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-04-04T20:24:34.678Z,1743798274.678 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-04-04T20:24:34.678Z,1743798274.678 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-04-04T20:24:34.679Z,1743798274.679 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-04-04T20:24:34.679Z,1743798274.679 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-04-04T20:24:34.679Z,1743798274.679 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-04-04T20:24:34.681Z,1743798274.681 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-04-04T20:24:34.683Z,1743798274.683 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-04-04T20:24:34.683Z,1743798274.683 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-04-04T20:24:34.684Z,1743798274.684 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-04-04T20:24:34.684Z,1743798274.684 [SBIT](INFO): Initialize SBIT Component.
2025-04-04T20:24:34.685Z,1743798274.685 [SBIT](IMPORTANT): git: 2025-03-31
2025-04-04T20:24:34.685Z,1743798274.685 [SBIT](INFO): git hash: fa5a0d22cc02557daa9f4ab77c7f518dfe223d1b
2025-04-04T20:24:34.685Z,1743798274.685 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-04-04T20:24:34.686Z,1743798274.686 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Mon Nov 27 01:04:18 PST 2023
2025-04-04T20:24:34.687Z,1743798274.687 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2025-04-04T20:24:34.688Z,1743798274.688 [IBIT](INFO): Initialize IBIT Component.
2025-04-04T20:24:34.688Z,1743798274.688 [CBIT](DEBUG): Initialize CBIT Component.
2025-04-04T20:24:34.689Z,1743798274.689 [logger ThreadHandler](INFO): Handler Thread ID is 946
2025-04-04T20:24:34.701Z,1743798274.701 [CBIT](DEBUG): Initialized mux pins.
2025-04-04T20:24:34.701Z,1743798274.701 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2025-04-04T20:24:34.701Z,1743798274.701 [CBIT](DEBUG): Initializing the watchdog timer.
2025-04-04T20:24:34.710Z,1743798274.710 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 947
2025-04-04T20:24:34.725Z,1743798274.725 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-04-04T20:24:34.725Z,1743798274.725 [CBIT](DEBUG): Initializing heartbeat.
2025-04-04T20:24:34.726Z,1743798274.726 [DAT ThreadHandler](INFO): Handler Thread ID is 948
2025-04-04T20:24:34.727Z,1743798274.727 [DAT](INFO): Powering up
2025-04-04T20:24:34.727Z,1743798274.727 [DAT](DEBUG): Initializing DAT.
2025-04-04T20:24:34.730Z,1743798274.730 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 950
2025-04-04T20:24:34.732Z,1743798274.732 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-04-04T20:24:34.753Z,1743798274.753 [Onboard ThreadHandler](INFO): Handler Thread ID is 951
2025-04-04T20:24:34.771Z,1743798274.771 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 952
2025-04-04T20:24:34.789Z,1743798274.789 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 953
2025-04-04T20:24:34.790Z,1743798274.790 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-04T20:24:34.794Z,1743798274.794 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 955
2025-04-04T20:24:34.797Z,1743798274.797 [CBIT](DEBUG): Deactivating emergency mode.
2025-04-04T20:24:34.798Z,1743798274.798 [WetLabsBB2FL](INFO): Powering up
2025-04-04T20:24:34.799Z,1743798274.799 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 957
2025-04-04T20:24:34.808Z,1743798274.808 [NavChartDb](FAULT): Change detected in ENC collection. Wiping NavChart Directory
2025-04-04T20:24:34.826Z,1743798274.826 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-04-04T20:24:34.828Z,1743798274.828 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US1WC07M.000
2025-04-04T20:24:34.828Z,1743798274.828 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-04-04T20:24:34.829Z,1743798274.829 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2WC11M.000
2025-04-04T20:24:34.830Z,1743798274.830 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-04-04T20:24:34.831Z,1743798274.831 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3CA52M.000
2025-04-04T20:24:34.831Z,1743798274.831 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-04-04T20:24:34.833Z,1743798274.833 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA50M.000
2025-04-04T20:24:34.837Z,1743798274.837 [CBIT](DEBUG): Backplane powered.
2025-04-04T20:24:34.838Z,1743798274.838 [GFScanner](DEBUG): Initializing GFScanner
2025-04-04T20:24:34.838Z,1743798274.838 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-04-04T20:24:34.839Z,1743798274.839 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-04-04T20:24:34.839Z,1743798274.839 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-04-04T20:24:34.844Z,1743798274.844 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-04-04T20:24:34.889Z,1743798274.889 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Startup">
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="StartupSatComms">
        <Sequence />
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix />
        </ReadDatum>
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications />
        </ReadDatum>
    </Aggregate>
</Mission>

2025-04-04T20:24:34.906Z,1743798274.906 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-04T20:24:34.930Z,1743798274.930 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA50M.000
2025-04-04T20:24:34.938Z,1743798274.938 [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-04T20:24:34.939Z,1743798274.939 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-04-04T20:24:34.939Z,1743798274.939 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-04-04T20:24:34.943Z,1743798274.943 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-04-04T20:24:35.177Z,1743798275.177 [Radio_Surface](INFO): Powering up
2025-04-04T20:24:35.236Z,1743798275.236 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Default">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>13</Value>
        </Setting>
    </Guidance:Wait>
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="CheckIn">
        <Sequence Repeat="288" />
        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M" />
            <Universal:time_fix />
        </ReadDatum>
        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence />
                    <Setting>
                        <Guidance:Execute.command />
                        <String>Burn on</String>
                    </Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications />
        </ReadDatum>
        <Guidance:Wait>
            <Sequence />
            <Setting>
                <Guidance:Wait.duration />
                <Units:minute />
                <Value>5</Value>
            </Setting>
        </Guidance:Wait>
        <Assign>
            <Sequence />
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Elapsed>
                <Universal:mission_started />
            </Elapsed>
        </Assign>
        <Syslog Severity="Important">
            Default mission has been running for 
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Units:minute />
        </Syslog>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2025-04-04T20:24:35.275Z,1743798275.275 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-04-04T20:24:35.276Z,1743798275.276 [Default:A.Wait](DEBUG): Construct Wait.
2025-04-04T20:24:35.278Z,1743798275.278 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-04T20:24:35.312Z,1743798275.312 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-04T20:24:35.315Z,1743798275.315 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-04T20:24:35.321Z,1743798275.321 [Default:E.Execute](DEBUG): Construct Execute.
2025-04-04T20:24:35.336Z,1743798275.336 [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-04T20:24:35.341Z,1743798275.341 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DepthKeller33X,DropWeight,NAL9602,Power24vConverter,Aanderaa_O2,ESPComponent,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-04T20:24:35.368Z,1743798275.368 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-04T20:24:35.474Z,1743798275.474 [DepthKeller33X](INFO): Initializing.
2025-04-04T20:24:35.494Z,1743798275.494 [Power24vConverter](INFO): Powering up.
2025-04-04T20:24:35.502Z,1743798275.502 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-04T20:24:35.550Z,1743798275.550 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-04T20:24:35.574Z,1743798275.574 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-04T20:24:35.575Z,1743798275.575 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-04T20:24:35.585Z,1743798275.585 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-04T20:24:35.586Z,1743798275.586 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-04T20:24:35.593Z,1743798275.593 [MassServo](DEBUG): Initializing MassServo.
2025-04-04T20:24:35.594Z,1743798275.594 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-04T20:24:35.601Z,1743798275.601 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-04T20:24:35.602Z,1743798275.602 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-04T20:24:35.607Z,1743798275.607 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-04T20:24:35.794Z,1743798275.794 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2025-04-04T20:24:35.794Z,1743798275.794 [DropWeight] Hardware Fault, FailCount= 1
2025-04-04T20:24:35.794Z,1743798275.794 [DropWeight](ERROR): Hardware Fault
2025-04-04T20:24:35.811Z,1743798275.811 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-04T20:24:35.826Z,1743798275.826 [CommandExec](FAULT): Scheduling is paused
2025-04-04T20:24:35.826Z,1743798275.826 [CBIT](INFO): Critical error at 20250404T202435
2025-04-04T20:24:35.827Z,1743798275.827 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-04-04T20:24:35.829Z,1743798275.829 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-04-04T20:24:35.829Z,1743798275.829 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-04-04T20:24:36.156Z,1743798276.156 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-04T20:24:36.165Z,1743798276.165 [CBIT](INFO): Critical error at 20250404T202435
2025-04-04T20:24:36.561Z,1743798276.561 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-04T20:24:37.001Z,1743798277.001 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2025-04-04T20:24:37.001Z,1743798277.001 [RudderServo](FAULT): Rudder failed to initialize
2025-04-04T20:24:37.001Z,1743798277.001 [RudderServo] Communications Fault, FailCount= 1
2025-04-04T20:24:37.002Z,1743798277.002 [RudderServo](ERROR): Communications Fault
2025-04-04T20:24:37.006Z,1743798277.006 [CBIT](ERROR): Communications Fault in component: RudderServo
2025-04-04T20:24:37.037Z,1743798277.037 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-04T20:24:37.037Z,1743798277.037 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-04T20:24:37.037Z,1743798277.037 [DepthKeller33X](ERROR): Communications Fault
2025-04-04T20:24:37.039Z,1743798277.039 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-04T20:24:37.047Z,1743798277.047 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-04T20:24:37.047Z,1743798277.047 [RudderServo](INFO): Powering down
2025-04-04T20:24:37.059Z,1743798277.059 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-04T20:24:37.415Z,1743798277.415 [DepthKeller33X](INFO): Powering down
2025-04-04T20:24:37.511Z,1743798277.511 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-04T20:24:37.519Z,1743798277.519 [RudderServo](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-04T20:24:37.519Z,1743798277.519 [RudderServo] Hardware Fault, FailCount= 1
2025-04-04T20:24:37.519Z,1743798277.519 [RudderServo](ERROR): Hardware Fault
2025-04-04T20:24:37.821Z,1743798277.821 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-04T20:24:37.821Z,1743798277.821 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-04T20:24:37.821Z,1743798277.821 [Power24vConverter](ERROR): Hardware Fault
2025-04-04T20:24:37.822Z,1743798277.822 [Power24vConverter](INFO): Powering down.
2025-04-04T20:24:37.822Z,1743798277.822 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-04T20:24:37.823Z,1743798277.823 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-04T20:24:38.141Z,1743798278.141 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2025-04-04T20:24:38.141Z,1743798278.141 [MassServo] Communications Fault, FailCount= 1
2025-04-04T20:24:38.141Z,1743798278.141 [MassServo](ERROR): Communications Fault
2025-04-04T20:24:38.142Z,1743798278.142 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-04T20:24:40.085Z,1743798280.085 [WetLabsBB2FL] Communications Fault, FailCount= 1
2025-04-04T20:24:40.085Z,1743798280.085 [WetLabsBB2FL](ERROR): Communications Fault
2025-04-04T20:24:40.585Z,1743798280.585 [WetLabsBB2FL](INFO): Powering down
2025-04-04T20:24:41.288Z,1743798281.288 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA50M.000
2025-04-04T20:24:46.644Z,1743798286.644 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004868
2025-04-04T20:24:47.841Z,1743798287.841 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2025-04-04T20:24:47.841Z,1743798287.841 [CTD_Seabird] Communications Fault, FailCount= 1
2025-04-04T20:24:47.841Z,1743798287.841 [CTD_Seabird](ERROR): Communications Fault
2025-04-04T20:24:48.246Z,1743798288.246 [CTD_Seabird](INFO): Powering down
2025-04-04T20:24:49.186Z,1743798289.186 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-04T20:24:55.701Z,1743798295.701 [NavChartDb](INFO): # of records loaded: 5000
2025-04-04T20:25:02.000Z,1743798302.000 [NavChartDb](INFO): # of records loaded: 10000
2025-04-04T20:25:04.214Z,1743798304.214 [CommandExec](IMPORTANT): got command quit
2025-04-04T20:25:05.218Z,1743798305.218 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-04T20:25:05.218Z,1743798305.218 [CommandExec](INFO): Uninitializing the command executive.
2025-04-04T20:25:05.218Z,1743798305.218 [CommandExec](INFO): Uninitializing the command scheduler.
2025-04-04T20:25:05.218Z,1743798305.218 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-04T20:25:05.413Z,1743798305.413 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-04-04T20:25:05.413Z,1743798305.413 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-04-04T20:25:05.413Z,1743798305.413 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-04T20:25:05.414Z,1743798305.414 [NavChartDb](INFO): Join timeout helper Thread ID is 968
2025-04-04T20:25:05.682Z,1743798305.682 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-04T20:25:05.682Z,1743798305.682 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-04T20:25:05.685Z,1743798305.685 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-04-04T20:25:05.685Z,1743798305.685 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-04T20:25:05.686Z,1743798305.686 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 969
2025-04-04T20:25:06.041Z,1743798306.041 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller threa