2024-11-18T17:34:40.059Z,1731951280.059 [Supervisor](DEBUG): Initializing supervisor. 2024-11-18T17:34:40.064Z,1731951280.064 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-11-18T17:34:40.064Z,1731951280.064 [SyncHandler](INFO): Protected caller Thread ID is 4344 2024-11-18T17:34:40.065Z,1731951280.065 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-11-18T17:34:40.065Z,1731951280.065 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-11-18T17:34:40.066Z,1731951280.066 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4345 2024-11-18T17:34:40.070Z,1731951280.070 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-11-18T17:34:40.087Z,1731951280.087 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-11-18T17:34:40.088Z,1731951280.088 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-11-18T17:34:40.088Z,1731951280.088 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4346 2024-11-18T17:34:40.092Z,1731951280.092 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-11-18T17:34:40.093Z,1731951280.093 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-11-18T17:34:40.093Z,1731951280.093 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4347 2024-11-18T17:34:40.095Z,1731951280.095 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-11-18T17:34:40.096Z,1731951280.096 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-11-18T17:34:40.097Z,1731951280.097 [logger ThreadHandler](INFO): Protected caller Thread ID is 4348 2024-11-18T17:34:40.100Z,1731951280.100 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-11-18T17:34:40.100Z,1731951280.100 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-11-18T17:34:40.102Z,1731951280.102 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-11-18T17:34:40.210Z,1731951280.210 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-11-18T17:34:40.211Z,1731951280.211 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-11-18T17:34:41.020Z,1731951281.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-11-18T17:34:41.020Z,1731951281.020 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-11-18T17:34:41.277Z,1731951281.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-11-18T17:34:41.278Z,1731951281.278 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-11-18T17:34:41.440Z,1731951281.440 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-11-18T17:34:41.587Z,1731951281.587 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-11-18T17:34:41.587Z,1731951281.587 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-11-18T17:34:41.680Z,1731951281.680 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-11-18T17:34:41.801Z,1731951281.801 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-11-18T17:34:41.802Z,1731951281.802 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-11-18T17:34:42.225Z,1731951282.225 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-11-18T17:34:42.226Z,1731951282.226 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-11-18T17:34:42.787Z,1731951282.787 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-11-18T17:34:42.787Z,1731951282.787 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-11-18T17:34:43.024Z,1731951283.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-11-18T17:34:43.025Z,1731951283.025 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-11-18T17:34:43.226Z,1731951283.226 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-11-18T17:34:43.227Z,1731951283.227 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-11-18T17:34:43.794Z,1731951283.794 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-11-18T17:34:43.795Z,1731951283.795 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-11-18T17:34:44.103Z,1731951284.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-11-18T17:34:44.104Z,1731951284.104 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-11-18T17:34:44.350Z,1731951284.350 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-11-18T17:34:44.350Z,1731951284.350 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-11-18T17:34:44.747Z,1731951284.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-11-18T17:34:44.747Z,1731951284.747 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-11-18T17:34:45.118Z,1731951285.118 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-11-18T17:34:45.120Z,1731951285.120 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-11-18T17:34:45.120Z,1731951285.120 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-11-18T17:34:45.216Z,1731951285.216 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-11-18T17:34:45.401Z,1731951285.401 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2024-11-18T17:34:45.520Z,1731951285.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-11-18T17:34:45.628Z,1731951285.628 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-11-18T17:34:45.748Z,1731951285.748 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-11-18T17:34:45.847Z,1731951285.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-11-18T17:34:45.955Z,1731951285.955 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-11-18T17:34:46.280Z,1731951286.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-11-18T17:34:46.740Z,1731951286.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-11-18T17:34:46.741Z,1731951286.741 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-11-18T17:34:46.981Z,1731951286.981 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-11-18T17:34:47.087Z,1731951287.087 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-11-18T17:34:47.244Z,1731951287.244 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-11-18T17:34:47.356Z,1731951287.356 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-11-18T17:34:47.357Z,1731951287.357 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2024-11-18T17:34:47.358Z,1731951287.358 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-11-18T17:34:47.489Z,1731951287.489 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-11-18T17:34:47.490Z,1731951287.490 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-11-18T17:34:47.542Z,1731951287.542 [VerticalControl](DEBUG): Construct VerticalControl. 2024-11-18T17:34:47.599Z,1731951287.599 [VerticalControl] Loaded 2024-11-18T17:34:47.600Z,1731951287.600 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-11-18T17:34:47.602Z,1731951287.602 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-11-18T17:34:47.648Z,1731951287.648 [HorizontalControl] Loaded 2024-11-18T17:34:47.648Z,1731951287.648 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-11-18T17:34:47.651Z,1731951287.651 [SpeedControl](DEBUG): Construct SpeedControl. 2024-11-18T17:34:47.654Z,1731951287.654 [SpeedControl] Loaded 2024-11-18T17:34:47.654Z,1731951287.654 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-11-18T17:34:47.656Z,1731951287.656 [LoopControl](DEBUG): Construct LoopControl. 2024-11-18T17:34:47.657Z,1731951287.657 [LoopControl] Loaded 2024-11-18T17:34:47.657Z,1731951287.657 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-11-18T17:34:47.657Z,1731951287.657 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-11-18T17:34:47.658Z,1731951287.658 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-11-18T17:34:47.705Z,1731951287.705 [DepthRateCalculator] Loaded 2024-11-18T17:34:47.706Z,1731951287.706 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-11-18T17:34:47.710Z,1731951287.710 [PitchRateCalculator] Loaded 2024-11-18T17:34:47.710Z,1731951287.710 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-11-18T17:34:47.720Z,1731951287.720 [SpeedCalculator] Loaded 2024-11-18T17:34:47.720Z,1731951287.720 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-11-18T17:34:47.724Z,1731951287.724 [YawRateCalculator] Loaded 2024-11-18T17:34:47.725Z,1731951287.725 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-11-18T17:34:47.742Z,1731951287.742 [ElevatorOffsetCalculator] Loaded 2024-11-18T17:34:47.743Z,1731951287.743 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-11-18T17:34:47.743Z,1731951287.743 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-11-18T17:34:47.744Z,1731951287.744 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-11-18T17:34:47.769Z,1731951287.769 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-11-18T17:34:47.770Z,1731951287.770 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-11-18T17:34:47.825Z,1731951287.825 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-11-18T17:34:47.826Z,1731951287.826 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-11-18T17:34:48.149Z,1731951288.149 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-11-18T17:34:48.150Z,1731951288.150 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-11-18T17:34:48.316Z,1731951288.316 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-11-18T17:34:48.317Z,1731951288.317 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-11-18T17:34:48.765Z,1731951288.765 [AHRS_M2] Loaded 2024-11-18T17:34:48.765Z,1731951288.765 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-11-18T17:34:48.803Z,1731951288.803 [BackseatComponent] Loaded 2024-11-18T17:34:48.804Z,1731951288.804 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-11-18T17:34:48.805Z,1731951288.805 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409DD4E0 2024-11-18T17:34:48.805Z,1731951288.805 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4437 2024-11-18T17:34:48.808Z,1731951288.808 [LcmUniversalReporter] Loaded 2024-11-18T17:34:48.809Z,1731951288.809 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-11-18T17:34:49.614Z,1731951289.614 [BPC1] Loaded 2024-11-18T17:34:49.614Z,1731951289.614 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-11-18T17:34:49.709Z,1731951289.709 [DAT] Loaded 2024-11-18T17:34:49.709Z,1731951289.709 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-11-18T17:34:49.710Z,1731951289.710 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A0D4E0 2024-11-18T17:34:49.710Z,1731951289.710 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4438 2024-11-18T17:34:49.789Z,1731951289.789 [DataOverHttps] Loaded 2024-11-18T17:34:49.789Z,1731951289.789 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-11-18T17:34:49.790Z,1731951289.790 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A3D4E0 2024-11-18T17:34:49.790Z,1731951289.790 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4439 2024-11-18T17:34:49.813Z,1731951289.813 [Depth_Keller] Loaded 2024-11-18T17:34:49.814Z,1731951289.814 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-11-18T17:34:49.818Z,1731951289.818 [DropWeight] Loaded 2024-11-18T17:34:49.819Z,1731951289.819 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-11-18T17:34:49.883Z,1731951289.883 [NAL9602] Loaded 2024-11-18T17:34:49.883Z,1731951289.883 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-11-18T17:34:49.912Z,1731951289.912 [Onboard] Loaded 2024-11-18T17:34:49.913Z,1731951289.913 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-11-18T17:34:49.914Z,1731951289.914 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A6D4E0 2024-11-18T17:34:49.914Z,1731951289.914 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4440 2024-11-18T17:34:49.928Z,1731951289.928 [Power24vConverter] Loaded 2024-11-18T17:34:49.928Z,1731951289.928 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-11-18T17:34:49.944Z,1731951289.944 [Radio_Surface] Loaded 2024-11-18T17:34:49.944Z,1731951289.944 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-11-18T17:34:49.945Z,1731951289.945 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A9D4E0 2024-11-18T17:34:49.946Z,1731951289.946 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4441 2024-11-18T17:34:49.992Z,1731951289.992 [RDI_Pathfinder] Loaded 2024-11-18T17:34:49.992Z,1731951289.992 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-11-18T17:34:50.007Z,1731951290.007 [Sonardyne_Nano] Loaded 2024-11-18T17:34:50.007Z,1731951290.007 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-11-18T17:34:50.008Z,1731951290.008 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-11-18T17:34:50.008Z,1731951290.008 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-11-18T17:34:50.118Z,1731951290.118 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-11-18T17:34:50.119Z,1731951290.119 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-11-18T17:34:50.132Z,1731951290.132 [NavChart] Loaded 2024-11-18T17:34:50.132Z,1731951290.132 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-11-18T17:34:50.138Z,1731951290.138 [UniversalFixResidualReporter] Loaded 2024-11-18T17:34:50.138Z,1731951290.138 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-11-18T17:34:50.138Z,1731951290.138 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-11-18T17:34:50.139Z,1731951290.139 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-11-18T17:34:50.274Z,1731951290.274 [SBIT](DEBUG): Construct Startup Built In Test. 2024-11-18T17:34:50.283Z,1731951290.283 [SBIT] Loaded 2024-11-18T17:34:50.283Z,1731951290.283 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-11-18T17:34:50.286Z,1731951290.286 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-11-18T17:34:50.298Z,1731951290.298 [IBIT] Loaded 2024-11-18T17:34:50.298Z,1731951290.298 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-11-18T17:34:50.304Z,1731951290.304 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-11-18T17:34:50.406Z,1731951290.406 [CBIT] Loaded 2024-11-18T17:34:50.406Z,1731951290.406 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-11-18T17:34:50.407Z,1731951290.407 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-11-18T17:34:50.407Z,1731951290.407 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-11-18T17:34:50.537Z,1731951290.537 [BuoyancyServo] Loaded 2024-11-18T17:34:50.538Z,1731951290.538 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-11-18T17:34:50.560Z,1731951290.560 [ElevatorServo] Loaded 2024-11-18T17:34:50.561Z,1731951290.561 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-11-18T17:34:50.590Z,1731951290.590 [DockingStepper] Loaded 2024-11-18T17:34:50.590Z,1731951290.590 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-11-18T17:34:50.611Z,1731951290.611 [MassServo] Loaded 2024-11-18T17:34:50.612Z,1731951290.612 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-11-18T17:34:50.632Z,1731951290.632 [RudderServo] Loaded 2024-11-18T17:34:50.632Z,1731951290.632 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-11-18T17:34:50.650Z,1731951290.650 [ThrusterServo] Loaded 2024-11-18T17:34:50.651Z,1731951290.651 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-11-18T17:34:50.651Z,1731951290.651 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-11-18T17:34:50.652Z,1731951290.652 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-11-18T17:34:50.662Z,1731951290.662 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-11-18T17:34:50.662Z,1731951290.662 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-11-18T17:34:50.834Z,1731951290.834 [CTD_Seabird] Loaded 2024-11-18T17:34:50.834Z,1731951290.834 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-11-18T17:34:50.835Z,1731951290.835 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BF14E0 2024-11-18T17:34:50.835Z,1731951290.835 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4442 2024-11-18T17:34:50.857Z,1731951290.857 [PAR_Licor] Loaded 2024-11-18T17:34:50.858Z,1731951290.858 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-11-18T17:34:50.902Z,1731951290.902 [WetLabsBB2FL] Loaded 2024-11-18T17:34:50.902Z,1731951290.902 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-11-18T17:34:50.903Z,1731951290.903 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C214E0 2024-11-18T17:34:50.903Z,1731951290.903 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4443 2024-11-18T17:34:50.924Z,1731951290.924 [WetLabsUBAT] Loaded 2024-11-18T17:34:50.924Z,1731951290.924 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-11-18T17:34:50.925Z,1731951290.925 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C514E0 2024-11-18T17:34:50.926Z,1731951290.926 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 4444 2024-11-18T17:34:50.926Z,1731951290.926 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-11-18T17:34:50.932Z,1731951290.932 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-11-18T17:34:50.935Z,1731951290.935 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-11-18T17:34:50.947Z,1731951290.947 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-11-18T17:34:50.948Z,1731951290.948 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C814E0 2024-11-18T17:34:50.948Z,1731951290.948 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4445 2024-11-18T17:34:50.952Z,1731951290.952 [Supervisor](INFO): Main Thread ID is 4343 2024-11-18T17:34:50.952Z,1731951290.952 [Supervisor](DEBUG): Running supervisor. 2024-11-18T17:34:50.953Z,1731951290.953 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4446 2024-11-18T17:34:50.954Z,1731951290.954 [CommandExec](INFO): Initializing the command executive. 2024-11-18T17:34:50.955Z,1731951290.955 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4447 2024-11-18T17:34:50.957Z,1731951290.957 [controlThread ThreadHandler](INFO): Handler Thread ID is 4448 2024-11-18T17:34:50.958Z,1731951290.958 [controlThread](DEBUG): Initializing ControlThread 2024-11-18T17:34:50.959Z,1731951290.959 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-11-18T17:34:50.960Z,1731951290.960 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-11-18T17:34:50.961Z,1731951290.961 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-11-18T17:34:50.962Z,1731951290.962 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-11-18T17:34:50.962Z,1731951290.962 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-11-18T17:34:50.962Z,1731951290.962 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-11-18T17:34:50.963Z,1731951290.963 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-11-18T17:34:50.963Z,1731951290.963 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-11-18T17:34:50.963Z,1731951290.963 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-11-18T17:34:50.968Z,1731951290.968 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-11-18T17:34:50.968Z,1731951290.968 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-11-18T17:34:50.969Z,1731951290.969 [SBIT](INFO): Initialize SBIT Component. 2024-11-18T17:34:50.969Z,1731951290.969 [SBIT](IMPORTANT): git: 2024-11-05_A-2-gedc59b07c 2024-11-18T17:34:50.969Z,1731951290.969 [SBIT](INFO): git hash: edc59b07c1740f324217f4d9e3ec4a619054a3a2 2024-11-18T17:34:50.970Z,1731951290.970 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-11-18T17:34:50.971Z,1731951290.971 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-11-18T17:34:50.972Z,1731951290.972 [SBIT](INFO): Beginning SBIT in 46.000000 seconds. 2024-11-18T17:34:50.972Z,1731951290.972 [IBIT](INFO): Initialize IBIT Component. 2024-11-18T17:34:50.973Z,1731951290.973 [CBIT](DEBUG): Initialize CBIT Component. 2024-11-18T17:34:50.974Z,1731951290.974 [logger ThreadHandler](INFO): Handler Thread ID is 4449 2024-11-18T17:34:50.985Z,1731951290.985 [CBIT](DEBUG): Initialized mux pins. 2024-11-18T17:34:50.985Z,1731951290.985 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2024-11-18T17:34:50.986Z,1731951290.986 [CBIT](DEBUG): Initializing the watchdog timer. 2024-11-18T17:34:50.994Z,1731951290.994 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4450 2024-11-18T17:34:51.006Z,1731951291.006 [DAT ThreadHandler](INFO): Handler Thread ID is 4451 2024-11-18T17:34:51.006Z,1731951291.006 [DAT](INFO): Powering up 2024-11-18T17:34:51.007Z,1731951291.007 [DAT](DEBUG): Initializing DAT. 2024-11-18T17:34:51.009Z,1731951291.009 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-11-18T17:34:51.010Z,1731951291.010 [CBIT](DEBUG): Initializing heartbeat. 2024-11-18T17:34:51.011Z,1731951291.011 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4453 2024-11-18T17:34:51.013Z,1731951291.013 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-11-18T17:34:51.022Z,1731951291.022 [Onboard ThreadHandler](INFO): Handler Thread ID is 4454 2024-11-18T17:34:51.039Z,1731951291.039 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4455 2024-11-18T17:34:51.058Z,1731951291.058 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4456 2024-11-18T17:34:51.058Z,1731951291.058 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-11-18T17:34:51.063Z,1731951291.063 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4458 2024-11-18T17:34:51.066Z,1731951291.066 [WetLabsBB2FL](INFO): Powering up 2024-11-18T17:34:51.067Z,1731951291.067 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 4460 2024-11-18T17:34:51.070Z,1731951291.070 [WetLabsUBAT](INFO): Powering up 2024-11-18T17:34:51.071Z,1731951291.071 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4462 2024-11-18T17:34:51.075Z,1731951291.075 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-11-18T17:34:51.075Z,1731951291.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-11-18T17:34:51.075Z,1731951291.075 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-11-18T17:34:51.075Z,1731951291.075 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-11-18T17:34:51.076Z,1731951291.076 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-11-18T17:34:51.076Z,1731951291.076 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-11-18T17:34:51.076Z,1731951291.076 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-11-18T17:34:51.076Z,1731951291.076 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-11-18T17:34:51.081Z,1731951291.081 [CBIT](DEBUG): Deactivating GF circuits. 2024-11-18T17:34:51.081Z,1731951291.081 [CBIT](DEBUG): Deactivating emergency mode. 2024-11-18T17:34:51.121Z,1731951291.121 [CBIT](DEBUG): Backplane powered. 2024-11-18T17:34:51.126Z,1731951291.126 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-11-18T17:34:51.127Z,1731951291.127 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2024-11-18T17:34:51.127Z,1731951291.127 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2024-11-18T17:34:51.128Z,1731951291.128 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2024-11-18T17:34:51.133Z,1731951291.133 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2024-11-18T17:34:51.141Z,1731951291.141 [MissionManager](ERROR): Top node has no child nodes: Mission 2024-11-18T17:34:51.142Z,1731951291.142 [MissionManager](ERROR): Could not load startup mission. 2024-11-18T17:34:51.142Z,1731951291.142 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl 2024-11-18T17:34:51.142Z,1731951291.142 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl 2024-11-18T17:34:51.143Z,1731951291.143 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl 2024-11-18T17:34:51.445Z,1731951291.445 [Radio_Surface](INFO): Powering up 2024-11-18T17:34:51.845Z,1731951291.845 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/DefaultWithUndock.tl translated into: 0 6 10 1 3 30 Timed out while trying to detach from dock at current depth of . Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-11-18T17:34:51.864Z,1731951291.864 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min 2024-11-18T17:34:51.868Z,1731951291.868 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h 2024-11-18T17:34:51.889Z,1731951291.889 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count 2024-11-18T17:34:51.904Z,1731951291.904 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s 2024-11-18T17:34:51.908Z,1731951291.908 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count 2024-11-18T17:34:51.928Z,1731951291.928 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min 2024-11-18T17:34:51.929Z,1731951291.929 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait. 2024-11-18T17:34:52.079Z,1731951292.079 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct. 2024-11-18T17:34:52.079Z,1731951292.079 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-11-18T17:34:52.128Z,1731951292.128 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-11-18T17:34:52.173Z,1731951292.173 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-11-18T17:34:52.192Z,1731951292.192 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-11-18T17:34:52.214Z,1731951292.214 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute. 2024-11-18T17:34:52.226Z,1731951292.226 [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 DefaultWithUndock { arguments { ElapsedSinceDefaultStarted = 0 minute DetachTimeout = 6 hour """ Maximum time duration for the vehicle to detach form the dock. """ TransponderCode = Dock:Dock.transponderCode """ Dock transponder address. """ TrackingUpdatePeriod = 10 second """ Time duration between acoustic range queries while the mission is detaching from the dock. """ NumberOfPings = 1 count """ Number of pings requested each time. """ DriftTimeout = 3 minute """ How long to allow vehicle to drift away from dock before retrying reverse """ } 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 = 30 second } aggregate LeaveDock { run in sequence timeout duration=DetachTimeout { syslog important "Timed out while trying to detach from dock at current depth of " + Universal:depth~meter + "." } # Acoustic tracking directives behavior Estimation:TrackAcousticContact { run while ( Universal:depth > Control:VerticalControl.surfaceThreshold ) set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } # Leave the dock behavior Dock:Undock { run in sequence set driftTimeout = DriftTimeout } } aggregate SurfaceDefault { run in sequence # This mission assumes open water so from here on it's the same old default that's always used 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=P2H { 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" } } 2024-11-18T17:34:52.231Z,1731951292.231 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-11-18T17:34:52.250Z,1731951292.250 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-11-18T17:34:52.319Z,1731951292.319 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-11-18T17:34:52.320Z,1731951292.320 [Power24vConverter](INFO): Powering up. 2024-11-18T17:34:52.321Z,1731951292.321 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-11-18T17:34:52.330Z,1731951292.330 [Sonardyne_Nano](INFO): Initializing. 2024-11-18T17:34:52.358Z,1731951292.358 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-11-18T17:34:52.398Z,1731951292.398 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-11-18T17:34:52.406Z,1731951292.406 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-11-18T17:34:52.407Z,1731951292.407 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-18T17:34:52.414Z,1731951292.414 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-18T17:34:52.414Z,1731951292.414 [DockingStepper](INFO): Start 2024-11-18T17:34:52.415Z,1731951292.415 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-11-18T17:34:52.422Z,1731951292.422 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-11-18T17:34:52.423Z,1731951292.423 [MassServo](DEBUG): Initializing EZServoServo. 2024-11-18T17:34:52.430Z,1731951292.430 [MassServo](DEBUG): Initializing MassServo. 2024-11-18T17:34:52.430Z,1731951292.430 [RudderServo](DEBUG): Initializing EZServoServo. 2024-11-18T17:34:52.438Z,1731951292.438 [RudderServo](DEBUG): Initializing RudderServo. 2024-11-18T17:34:52.438Z,1731951292.438 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-11-18T17:34:52.446Z,1731951292.446 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-11-18T17:34:52.679Z,1731951292.679 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-11-18T17:34:52.679Z,1731951292.679 [DropWeight] Hardware Fault, FailCount= 1 2024-11-18T17:34:52.679Z,1731951292.679 [DropWeight](ERROR): Hardware Fault 2024-11-18T17:34:52.706Z,1731951292.706 [DockingStepper](INFO): Starting 2024-11-18T17:34:52.708Z,1731951292.708 [CommandExec](FAULT): Scheduling is paused 2024-11-18T17:34:52.709Z,1731951292.709 [CBIT](INFO): Critical error at 20241118T173452 2024-11-18T17:34:52.709Z,1731951292.709 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-11-18T17:34:52.719Z,1731951292.719 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-11-18T17:34:52.720Z,1731951292.720 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-11-18T17:34:53.074Z,1731951293.074 [DockingStepper](INFO): Starting 2024-11-18T17:34:53.076Z,1731951293.076 [CBIT](INFO): Critical error at 20241118T173452 2024-11-18T17:34:53.590Z,1731951293.590 [DockingStepper](INFO): Starting 2024-11-18T17:34:53.638Z,1731951293.638 [DockingStepper](INFO): Init string: /1z16367aE13561N3m50 2024-11-18T17:34:53.678Z,1731951293.678 [WetLabsBB2FL](INFO): Powering down 2024-11-18T17:34:53.950Z,1731951293.950 [DockingStepper](INFO): Starting 2024-11-18T17:34:54.260Z,1731951294.260 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-11-18T17:34:54.309Z,1731951294.309 [DockingStepper](INFO): Starting 2024-11-18T17:34:54.681Z,1731951294.681 [DockingStepper](INFO): Starting 2024-11-18T17:34:55.142Z,1731951295.142 [DockingStepper](INFO): Starting 2024-11-18T17:34:55.166Z,1731951295.166 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-11-18T17:34:55.632Z,1731951295.632 [DockingStepper](INFO): Starting 2024-11-18T17:34:55.914Z,1731951295.914 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-11-18T17:34:56.367Z,1731951296.367 [DockingStepper](INFO): Pause 2024-11-18T17:34:56.706Z,1731951296.706 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-11-18T17:34:56.707Z,1731951296.707 [Radio_Surface](INFO): Found local IP address 10.89.10.2 for eth0 2024-11-18T17:35:00.317Z,1731951300.317 [WetLabsUBAT](INFO): Powering down 2024-11-18T17:35:04.110Z,1731951304.110 [DAT](INFO): DAT read: 2024-11-18T17:35:04.111Z,1731951304.111 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-11-18T17:35:04.283Z,1731951304.283 [CommandExec](IMPORTANT): got command restart application 2024-11-18T17:35:05.286Z,1731951305.286 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:05.286Z,1731951305.286 [CommandExec](INFO): Uninitializing the command executive. 2024-11-18T17:35:05.286Z,1731951305.286 [CommandExec](INFO): Uninitializing the command scheduler. 2024-11-18T17:35:05.286Z,1731951305.286 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:05.385Z,1731951305.385 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-11-18T17:35:05.386Z,1731951305.386 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-11-18T17:35:05.386Z,1731951305.386 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:05.386Z,1731951305.386 [NavChartDb](INFO): Join timeout helper Thread ID is 4472 2024-11-18T17:35:05.874Z,1731951305.874 [DAT](INFO): DAT read: MF Frequency Band 2024-11-18T17:35:05.876Z,1731951305.876 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-11-18T17:35:05.876Z,1731951305.876 [DAT](INFO): DAT read: Nov 18 2024 17:34:28 2024-11-18T17:35:06.883Z,1731951306.883 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-11-18T17:35:06.884Z,1731951306.884 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2024-11-18T17:35:06.884Z,1731951306.884 [DAT](INFO): commRate: 600 2024-11-18T17:35:08.949Z,1731951308.949 [DAT](INFO): entering command mode 2024-11-18T17:35:09.150Z,1731951309.150 [DAT](INFO): DAT read: 2024-11-18T17:35:09.151Z,1731951309.151 [DAT](INFO): DAT read: user:1> 2024-11-18T17:35:09.151Z,1731951309.151 [DAT](INFO): setting verbose to 3 2024-11-18T17:35:09.402Z,1731951309.402 [DAT](INFO): DAT read: user:1> 2024-11-18T17:35:09.403Z,1731951309.403 [DAT](INFO): DAT read: Verbose | 3 2024-11-18T17:35:09.404Z,1731951309.404 [DAT](INFO): set verbose to 3 2024-11-18T17:35:09.404Z,1731951309.404 [DAT](INFO): setting DatVerbose to 27440 2024-11-18T17:35:09.654Z,1731951309.654 [DAT](INFO): DAT read: user:2> 2024-11-18T17:35:09.655Z,1731951309.655 [DAT](INFO): DAT read: DatVerbose | 27440 2024-11-18T17:35:09.655Z,1731951309.655 [DAT](INFO): set DatVerbose to 27440 2024-11-18T17:35:09.655Z,1731951309.655 [DAT](INFO): setting transmit power to 8 2024-11-18T17:35:09.906Z,1731951309.906 [DAT](INFO): DAT read: user:3> 2024-11-18T17:35:09.907Z,1731951309.907 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-11-18T17:35:09.907Z,1731951309.907 [DAT](INFO): set transmit power to 8 2024-11-18T17:35:09.908Z,1731951309.908 [DAT](INFO): setting local address to 10 2024-11-18T17:35:10.014Z,1731951310.014 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:10.014Z,1731951310.014 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:10.029Z,1731951310.029 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-11-18T17:35:10.029Z,1731951310.029 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:10.030Z,1731951310.030 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 4473 2024-11-18T17:35:10.158Z,1731951310.158 [DAT](INFO): DAT read: user:4> 2024-11-18T17:35:10.159Z,1731951310.159 [DAT](INFO): DAT read: LocalAddr | 10 2024-11-18T17:35:10.160Z,1731951310.160 [DAT](INFO): set local address to 10 2024-11-18T17:35:10.161Z,1731951310.161 [DAT](INFO): Setting time to: 17:35:10 And date to:11/18/2024 2024-11-18T17:35:10.322Z,1731951310.322 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:10.322Z,1731951310.322 [WetLabsUBAT](INFO): Powering down 2024-11-18T17:35:10.323Z,1731951310.323 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:10.329Z,1731951310.329 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-11-18T17:35:10.329Z,1731951310.329 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:10.330Z,1731951310.330 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4474 2024-11-18T17:35:10.410Z,1731951310.410 [DAT](INFO): DAT read: user:5> 2024-11-18T17:35:10.411Z,1731951310.411 [DAT](INFO): DAT read: Mon Nov 18, 2024 17:35:10 2024-11-18T17:35:10.411Z,1731951310.411 [DAT](INFO): Local DAT time set to Mon Nov 18, 2024 17:35:10 2024-11-18T17:35:10.718Z,1731951310.718 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:10.718Z,1731951310.718 [WetLabsBB2FL](INFO): Powering down 2024-11-18T17:35:10.719Z,1731951310.719 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:10.733Z,1731951310.733 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-11-18T17:35:10.734Z,1731951310.734 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:10.734Z,1731951310.734 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4475 2024-11-18T17:35:11.138Z,1731951311.138 [CTD_Seabird](INFO): Powering down 2024-11-18T17:35:11.149Z,1731951311.149 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:11.150Z,1731951311.150 [CTD_Seabird](INFO): Powering down 2024-11-18T17:35:11.161Z,1731951311.161 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:11.177Z,1731951311.177 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-11-18T17:35:11.177Z,1731951311.177 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:11.178Z,1731951311.178 [Radio_Surface](INFO): Join timeout helper Thread ID is 4476 2024-11-18T17:35:11.250Z,1731951311.250 [Radio_Surface](INFO): Powering down 2024-11-18T17:35:11.250Z,1731951311.250 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:11.251Z,1731951311.251 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:11.258Z,1731951311.258 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-11-18T17:35:11.259Z,1731951311.259 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:11.259Z,1731951311.259 [Onboard](INFO): Join timeout helper Thread ID is 4477 2024-11-18T17:35:16.041Z,1731951316.041 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:16.042Z,1731951316.042 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.058Z,1731951316.058 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-11-18T17:35:16.058Z,1731951316.058 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.058Z,1731951316.058 [DataOverHttps](INFO): Join timeout helper Thread ID is 4478 2024-11-18T17:35:16.109Z,1731951316.109 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:16.110Z,1731951316.110 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.114Z,1731951316.114 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-11-18T17:35:16.114Z,1731951316.114 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.115Z,1731951316.115 [DAT](INFO): Join timeout helper Thread ID is 4479 2024-11-18T17:35:16.214Z,1731951316.214 [DAT](INFO): Powering down 2024-11-18T17:35:16.286Z,1731951316.286 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:16.286Z,1731951316.286 [DAT](INFO): Powering down 2024-11-18T17:35:16.287Z,1731951316.287 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.290Z,1731951316.290 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-11-18T17:35:16.290Z,1731951316.290 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.291Z,1731951316.291 [BackseatComponent](INFO): Join timeout helper Thread ID is 4480 2024-11-18T17:35:16.322Z,1731951316.322 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:16.323Z,1731951316.323 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.330Z,1731951316.330 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-11-18T17:35:16.330Z,1731951316.330 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.331Z,1731951316.331 [logger](INFO): Join timeout helper Thread ID is 4481 2024-11-18T17:35:16.353Z,1731951316.353 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:16.353Z,1731951316.353 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.362Z,1731951316.362 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-11-18T17:35:16.362Z,1731951316.362 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.362Z,1731951316.362 [CommandLine](INFO): Join timeout helper Thread ID is 4482 2024-11-18T17:35:16.390Z,1731951316.390 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:16.390Z,1731951316.390 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.402Z,1731951316.402 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-11-18T17:35:16.402Z,1731951316.402 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.402Z,1731951316.402 [CommandExec](INFO): Join timeout helper Thread ID is 4483 2024-11-18T17:35:16.404Z,1731951316.404 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-11-18T17:35:16.404Z,1731951316.404 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.404Z,1731951316.404 [controlThread](INFO): Join timeout helper Thread ID is 4484 2024-11-18T17:35:16.498Z,1731951316.498 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-18T17:35:16.498Z,1731951316.498 [controlThread](DEBUG): Uninitializing ControlThread 2024-11-18T17:35:16.499Z,1731951316.499 [AHRS_M2](INFO): Powering down 2024-11-18T17:35:16.571Z,1731951316.571 [NAL9602](INFO): Powering down 2024-11-18T17:35:16.641Z,1731951316.641 [RDI_Pathfinder](INFO): Powering down 2024-11-18T17:35:16.642Z,1731951316.642 [Sonardyne_Nano](INFO): Powering down 2024-11-18T17:35:16.762Z,1731951316.762 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-11-18T17:35:16.763Z,1731951316.763 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-11-18T17:35:16.763Z,1731951316.763 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-11-18T17:35:16.764Z,1731951316.764 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2024-11-18T17:35:16.771Z,1731951316.771 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-11-18T17:35:16.772Z,1731951316.772 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-11-18T17:35:16.772Z,1731951316.772 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-11-18T17:35:16.772Z,1731951316.772 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-11-18T17:35:16.773Z,1731951316.773 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-11-18T17:35:16.773Z,1731951316.773 [BuoyancyServo](INFO): Powering down 2024-11-18T17:35:16.785Z,1731951316.785 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-18T17:35:16.786Z,1731951316.786 [ElevatorServo](INFO): Powering down 2024-11-18T17:35:16.786Z,1731951316.786 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-11-18T17:35:16.787Z,1731951316.787 [DockingStepper](INFO): Powering down 2024-11-18T17:35:16.787Z,1731951316.787 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-11-18T17:35:16.787Z,1731951316.787 [MassServo](INFO): Powering down 2024-11-18T17:35:16.788Z,1731951316.788 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-11-18T17:35:16.788Z,1731951316.788 [RudderServo](INFO): Powering down 2024-11-18T17:35:16.789Z,1731951316.789 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-11-18T17:35:16.789Z,1731951316.789 [ThrusterServo](INFO): Powering down 2024-11-18T17:35:16.790Z,1731951316.790 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-11-18T17:35:16.790Z,1731951316.790 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-11-18T17:35:16.791Z,1731951316.791 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-11-18T17:35:16.791Z,1731951316.791 [CBIT](DEBUG): Powering off loads. 2024-11-18T17:35:16.801Z,1731951316.801 [CBIT](DEBUG): Disabling WDT. 2024-11-18T17:35:16.813Z,1731951316.813 [CBIT](DEBUG): Opening all GF detection circuits. 2024-11-18T17:35:16.814Z,1731951316.814 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.871Z,1731951316.871 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.874Z,1731951316.874 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.879Z,1731951316.879 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.885Z,1731951316.885 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:16.925Z,1731951316.925 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:17.103Z,1731951317.103 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:17.104Z,1731951317.104 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:17.109Z,1731951317.109 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:17.117Z,1731951317.117 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-18T17:35:17.180Z,1731951317.180 [logger ThreadHandler](INFO): Thread cancelled.