2024-10-29T21:27:18.414Z,1730237238.414 [Supervisor](DEBUG): Initializing supervisor. 2024-10-29T21:27:18.419Z,1730237238.419 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-10-29T21:27:18.419Z,1730237238.419 [SyncHandler](INFO): Protected caller Thread ID is 1034 2024-10-29T21:27:18.420Z,1730237238.420 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-10-29T21:27:18.421Z,1730237238.421 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-10-29T21:27:18.421Z,1730237238.421 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1035 2024-10-29T21:27:18.426Z,1730237238.426 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-10-29T21:27:18.444Z,1730237238.444 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-10-29T21:27:18.445Z,1730237238.445 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-10-29T21:27:18.445Z,1730237238.445 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1036 2024-10-29T21:27:18.449Z,1730237238.449 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-10-29T21:27:18.450Z,1730237238.450 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-10-29T21:27:18.451Z,1730237238.451 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1037 2024-10-29T21:27:18.453Z,1730237238.453 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-10-29T21:27:18.454Z,1730237238.454 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-10-29T21:27:18.454Z,1730237238.454 [logger ThreadHandler](INFO): Protected caller Thread ID is 1038 2024-10-29T21:27:18.458Z,1730237238.458 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-10-29T21:27:18.458Z,1730237238.458 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-10-29T21:27:18.460Z,1730237238.460 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-10-29T21:27:18.571Z,1730237238.571 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-10-29T21:27:18.572Z,1730237238.572 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-10-29T21:27:19.412Z,1730237239.412 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-10-29T21:27:19.412Z,1730237239.412 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-10-29T21:27:19.674Z,1730237239.674 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-10-29T21:27:19.675Z,1730237239.675 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-10-29T21:27:19.768Z,1730237239.768 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-10-29T21:27:19.916Z,1730237239.916 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-10-29T21:27:19.917Z,1730237239.917 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-10-29T21:27:20.012Z,1730237240.012 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-10-29T21:27:20.136Z,1730237240.136 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-10-29T21:27:20.137Z,1730237240.137 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-10-29T21:27:20.583Z,1730237240.583 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-10-29T21:27:20.583Z,1730237240.583 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-10-29T21:27:21.269Z,1730237241.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-10-29T21:27:21.270Z,1730237241.270 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-10-29T21:27:21.549Z,1730237241.549 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-10-29T21:27:21.550Z,1730237241.550 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-10-29T21:27:21.765Z,1730237241.765 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-10-29T21:27:21.766Z,1730237241.766 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-10-29T21:27:22.360Z,1730237242.360 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-10-29T21:27:22.361Z,1730237242.361 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-10-29T21:27:22.685Z,1730237242.685 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-10-29T21:27:22.685Z,1730237242.685 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-10-29T21:27:22.943Z,1730237242.943 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-10-29T21:27:22.944Z,1730237242.944 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-10-29T21:27:23.357Z,1730237243.357 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-10-29T21:27:23.358Z,1730237243.358 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-10-29T21:27:23.747Z,1730237243.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-10-29T21:27:23.749Z,1730237243.749 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-10-29T21:27:23.750Z,1730237243.750 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-10-29T21:27:23.848Z,1730237243.848 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-10-29T21:27:24.042Z,1730237244.042 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2024-10-29T21:27:24.166Z,1730237244.166 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-10-29T21:27:24.277Z,1730237244.277 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-10-29T21:27:24.402Z,1730237244.402 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-10-29T21:27:24.502Z,1730237244.502 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-10-29T21:27:24.613Z,1730237244.613 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-10-29T21:27:24.743Z,1730237244.743 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-10-29T21:27:25.024Z,1730237245.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-10-29T21:27:25.025Z,1730237245.025 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-10-29T21:27:25.136Z,1730237245.136 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-10-29T21:27:25.244Z,1730237245.244 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-10-29T21:27:25.407Z,1730237245.407 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-10-29T21:27:25.523Z,1730237245.523 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-10-29T21:27:25.524Z,1730237245.524 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-10-29T21:27:25.541Z,1730237245.541 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-10-29T21:27:25.676Z,1730237245.676 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-10-29T21:27:25.676Z,1730237245.676 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-10-29T21:27:25.729Z,1730237245.729 [VerticalControl](DEBUG): Construct VerticalControl. 2024-10-29T21:27:25.791Z,1730237245.791 [VerticalControl] Loaded 2024-10-29T21:27:25.791Z,1730237245.791 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-10-29T21:27:25.794Z,1730237245.794 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-10-29T21:27:25.841Z,1730237245.841 [HorizontalControl] Loaded 2024-10-29T21:27:25.842Z,1730237245.842 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-10-29T21:27:25.844Z,1730237245.844 [SpeedControl](DEBUG): Construct SpeedControl. 2024-10-29T21:27:25.847Z,1730237245.847 [SpeedControl] Loaded 2024-10-29T21:27:25.847Z,1730237245.847 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-10-29T21:27:25.850Z,1730237245.850 [LoopControl](DEBUG): Construct LoopControl. 2024-10-29T21:27:25.850Z,1730237245.850 [LoopControl] Loaded 2024-10-29T21:27:25.850Z,1730237245.850 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-10-29T21:27:25.851Z,1730237245.851 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-10-29T21:27:25.851Z,1730237245.851 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-10-29T21:27:25.901Z,1730237245.901 [DepthRateCalculator] Loaded 2024-10-29T21:27:25.901Z,1730237245.901 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-10-29T21:27:25.906Z,1730237245.906 [PitchRateCalculator] Loaded 2024-10-29T21:27:25.907Z,1730237245.907 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-10-29T21:27:25.917Z,1730237245.917 [SpeedCalculator] Loaded 2024-10-29T21:27:25.917Z,1730237245.917 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-10-29T21:27:25.921Z,1730237245.921 [YawRateCalculator] Loaded 2024-10-29T21:27:25.922Z,1730237245.922 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-10-29T21:27:25.940Z,1730237245.940 [ElevatorOffsetCalculator] Loaded 2024-10-29T21:27:25.940Z,1730237245.940 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-10-29T21:27:25.941Z,1730237245.941 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-10-29T21:27:25.941Z,1730237245.941 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-10-29T21:27:25.968Z,1730237245.968 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-10-29T21:27:25.968Z,1730237245.968 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-10-29T21:27:26.024Z,1730237246.024 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-10-29T21:27:26.025Z,1730237246.025 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-10-29T21:27:26.363Z,1730237246.363 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-10-29T21:27:26.364Z,1730237246.364 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-10-29T21:27:26.816Z,1730237246.816 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-10-29T21:27:26.816Z,1730237246.816 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-10-29T21:27:27.437Z,1730237247.437 [AHRS_M2] Loaded 2024-10-29T21:27:27.437Z,1730237247.437 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-10-29T21:27:27.476Z,1730237247.476 [BackseatComponent] Loaded 2024-10-29T21:27:27.476Z,1730237247.476 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-10-29T21:27:27.477Z,1730237247.477 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409CA4E0 2024-10-29T21:27:27.478Z,1730237247.478 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1126 2024-10-29T21:27:27.480Z,1730237247.480 [LcmUniversalReporter] Loaded 2024-10-29T21:27:27.481Z,1730237247.481 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-10-29T21:27:28.292Z,1730237248.292 [BPC1] Loaded 2024-10-29T21:27:28.292Z,1730237248.292 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-10-29T21:27:28.365Z,1730237248.365 [DataOverHttps] Loaded 2024-10-29T21:27:28.366Z,1730237248.366 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-10-29T21:27:28.367Z,1730237248.367 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409FA4E0 2024-10-29T21:27:28.367Z,1730237248.367 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1127 2024-10-29T21:27:28.389Z,1730237248.389 [Depth_Keller] Loaded 2024-10-29T21:27:28.390Z,1730237248.390 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-10-29T21:27:28.454Z,1730237248.454 [NAL9602] Loaded 2024-10-29T21:27:28.454Z,1730237248.454 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-10-29T21:27:28.484Z,1730237248.484 [Onboard] Loaded 2024-10-29T21:27:28.484Z,1730237248.484 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-10-29T21:27:28.485Z,1730237248.485 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A2A4E0 2024-10-29T21:27:28.485Z,1730237248.485 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1128 2024-10-29T21:27:28.499Z,1730237248.499 [Power24vConverter] Loaded 2024-10-29T21:27:28.499Z,1730237248.499 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-10-29T21:27:28.515Z,1730237248.515 [Radio_Surface] Loaded 2024-10-29T21:27:28.515Z,1730237248.515 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-10-29T21:27:28.516Z,1730237248.516 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A5A4E0 2024-10-29T21:27:28.517Z,1730237248.517 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1129 2024-10-29T21:27:28.563Z,1730237248.563 [RDI_Pathfinder] Loaded 2024-10-29T21:27:28.563Z,1730237248.563 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-10-29T21:27:28.578Z,1730237248.578 [Sonardyne_Nano] Loaded 2024-10-29T21:27:28.579Z,1730237248.579 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-10-29T21:27:28.673Z,1730237248.673 [DAT] Loaded 2024-10-29T21:27:28.673Z,1730237248.673 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-10-29T21:27:28.674Z,1730237248.674 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A8A4E0 2024-10-29T21:27:28.674Z,1730237248.674 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1130 2024-10-29T21:27:28.675Z,1730237248.675 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-10-29T21:27:28.676Z,1730237248.676 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-10-29T21:27:28.788Z,1730237248.788 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-10-29T21:27:28.788Z,1730237248.788 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-10-29T21:27:28.802Z,1730237248.802 [NavChart] Loaded 2024-10-29T21:27:28.802Z,1730237248.802 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-10-29T21:27:28.808Z,1730237248.808 [UniversalFixResidualReporter] Loaded 2024-10-29T21:27:28.808Z,1730237248.808 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-10-29T21:27:28.808Z,1730237248.808 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-10-29T21:27:28.809Z,1730237248.809 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-10-29T21:27:28.952Z,1730237248.952 [SBIT](DEBUG): Construct Startup Built In Test. 2024-10-29T21:27:28.961Z,1730237248.961 [SBIT] Loaded 2024-10-29T21:27:28.961Z,1730237248.961 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-10-29T21:27:28.964Z,1730237248.964 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-10-29T21:27:28.977Z,1730237248.977 [IBIT] Loaded 2024-10-29T21:27:28.977Z,1730237248.977 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-10-29T21:27:28.983Z,1730237248.983 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-10-29T21:27:29.090Z,1730237249.090 [CBIT] Loaded 2024-10-29T21:27:29.090Z,1730237249.090 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-10-29T21:27:29.091Z,1730237249.091 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-10-29T21:27:29.091Z,1730237249.091 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-10-29T21:27:29.227Z,1730237249.227 [BuoyancyServo] Loaded 2024-10-29T21:27:29.227Z,1730237249.227 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-10-29T21:27:29.251Z,1730237249.251 [ElevatorServo] Loaded 2024-10-29T21:27:29.251Z,1730237249.251 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-10-29T21:27:29.281Z,1730237249.281 [DockingStepper] Loaded 2024-10-29T21:27:29.281Z,1730237249.281 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-10-29T21:27:29.303Z,1730237249.303 [MassServo] Loaded 2024-10-29T21:27:29.303Z,1730237249.303 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-10-29T21:27:29.323Z,1730237249.323 [RudderServo] Loaded 2024-10-29T21:27:29.323Z,1730237249.323 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-10-29T21:27:29.342Z,1730237249.342 [ThrusterServo] Loaded 2024-10-29T21:27:29.343Z,1730237249.343 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-10-29T21:27:29.343Z,1730237249.343 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-10-29T21:27:29.344Z,1730237249.344 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-10-29T21:27:29.354Z,1730237249.354 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-10-29T21:27:29.354Z,1730237249.354 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-10-29T21:27:29.529Z,1730237249.529 [CTD_Seabird] Loaded 2024-10-29T21:27:29.530Z,1730237249.530 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-10-29T21:27:29.531Z,1730237249.531 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BDE4E0 2024-10-29T21:27:29.531Z,1730237249.531 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1131 2024-10-29T21:27:29.554Z,1730237249.554 [PAR_Licor] Loaded 2024-10-29T21:27:29.554Z,1730237249.554 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-10-29T21:27:29.599Z,1730237249.599 [WetLabsBB2FL] Loaded 2024-10-29T21:27:29.600Z,1730237249.600 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-10-29T21:27:29.601Z,1730237249.601 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C0E4E0 2024-10-29T21:27:29.601Z,1730237249.601 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1132 2024-10-29T21:27:29.622Z,1730237249.622 [WetLabsUBAT] Loaded 2024-10-29T21:27:29.623Z,1730237249.623 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-10-29T21:27:29.624Z,1730237249.624 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C3E4E0 2024-10-29T21:27:29.624Z,1730237249.624 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 1133 2024-10-29T21:27:29.625Z,1730237249.625 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-10-29T21:27:29.631Z,1730237249.631 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-10-29T21:27:29.634Z,1730237249.634 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-10-29T21:27:29.646Z,1730237249.646 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-10-29T21:27:29.647Z,1730237249.647 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6E4E0 2024-10-29T21:27:29.647Z,1730237249.647 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1134 2024-10-29T21:27:29.652Z,1730237249.652 [Supervisor](INFO): Main Thread ID is 830 2024-10-29T21:27:29.652Z,1730237249.652 [Supervisor](DEBUG): Running supervisor. 2024-10-29T21:27:29.652Z,1730237249.652 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1135 2024-10-29T21:27:29.653Z,1730237249.653 [CommandExec](INFO): Initializing the command executive. 2024-10-29T21:27:29.654Z,1730237249.654 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1136 2024-10-29T21:27:29.656Z,1730237249.656 [controlThread ThreadHandler](INFO): Handler Thread ID is 1137 2024-10-29T21:27:29.657Z,1730237249.657 [controlThread](DEBUG): Initializing ControlThread 2024-10-29T21:27:29.658Z,1730237249.658 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-10-29T21:27:29.659Z,1730237249.659 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-10-29T21:27:29.660Z,1730237249.660 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-10-29T21:27:29.661Z,1730237249.661 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-10-29T21:27:29.661Z,1730237249.661 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-10-29T21:27:29.661Z,1730237249.661 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-10-29T21:27:29.662Z,1730237249.662 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-10-29T21:27:29.662Z,1730237249.662 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-10-29T21:27:29.662Z,1730237249.662 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-10-29T21:27:29.669Z,1730237249.669 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-10-29T21:27:29.669Z,1730237249.669 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-10-29T21:27:29.670Z,1730237249.670 [SBIT](INFO): Initialize SBIT Component. 2024-10-29T21:27:29.670Z,1730237249.670 [SBIT](IMPORTANT): git: 2024-10-08_A-1-gd8541c08e 2024-10-29T21:27:29.670Z,1730237249.670 [SBIT](INFO): git hash: d8541c08e5b9954ca0b5a715681f71c182fc7331 2024-10-29T21:27:29.671Z,1730237249.671 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-10-29T21:27:29.672Z,1730237249.672 [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-10-29T21:27:29.673Z,1730237249.673 [SBIT](INFO): Beginning SBIT in 114.000000 seconds. 2024-10-29T21:27:29.674Z,1730237249.674 [IBIT](INFO): Initialize IBIT Component. 2024-10-29T21:27:29.674Z,1730237249.674 [CBIT](DEBUG): Initialize CBIT Component. 2024-10-29T21:27:29.675Z,1730237249.675 [logger ThreadHandler](INFO): Handler Thread ID is 1138 2024-10-29T21:27:29.688Z,1730237249.688 [CBIT](DEBUG): Initialized mux pins. 2024-10-29T21:27:29.688Z,1730237249.688 [CBIT](DEBUG): Initializing the watchdog timer. 2024-10-29T21:27:29.696Z,1730237249.696 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1139 2024-10-29T21:27:29.708Z,1730237249.708 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1140 2024-10-29T21:27:29.710Z,1730237249.710 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-10-29T21:27:29.712Z,1730237249.712 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-10-29T21:27:29.712Z,1730237249.712 [CBIT](DEBUG): Initializing heartbeat. 2024-10-29T21:27:29.720Z,1730237249.720 [Onboard ThreadHandler](INFO): Handler Thread ID is 1141 2024-10-29T21:27:29.744Z,1730237249.744 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1142 2024-10-29T21:27:29.768Z,1730237249.768 [DAT ThreadHandler](INFO): Handler Thread ID is 1143 2024-10-29T21:27:29.769Z,1730237249.769 [DAT](INFO): Powering up 2024-10-29T21:27:29.769Z,1730237249.769 [DAT](DEBUG): Initializing DAT. 2024-10-29T21:27:29.773Z,1730237249.773 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1145 2024-10-29T21:27:29.774Z,1730237249.774 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-10-29T21:27:29.777Z,1730237249.777 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1147 2024-10-29T21:27:29.780Z,1730237249.780 [WetLabsBB2FL](INFO): Powering up 2024-10-29T21:27:29.781Z,1730237249.781 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 1149 2024-10-29T21:27:29.784Z,1730237249.784 [CBIT](DEBUG): Deactivating GF circuits. 2024-10-29T21:27:29.784Z,1730237249.784 [CBIT](DEBUG): Deactivating emergency mode. 2024-10-29T21:27:29.785Z,1730237249.785 [WetLabsUBAT](INFO): Powering up 2024-10-29T21:27:29.786Z,1730237249.786 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1151 2024-10-29T21:27:29.789Z,1730237249.789 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-10-29T21:27:29.789Z,1730237249.789 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-10-29T21:27:29.790Z,1730237249.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-10-29T21:27:29.790Z,1730237249.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-10-29T21:27:29.790Z,1730237249.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-10-29T21:27:29.790Z,1730237249.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-10-29T21:27:29.790Z,1730237249.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-10-29T21:27:29.790Z,1730237249.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-10-29T21:27:29.824Z,1730237249.824 [CBIT](DEBUG): Backplane powered. 2024-10-29T21:27:29.828Z,1730237249.828 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-10-29T21:27:29.829Z,1730237249.829 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2024-10-29T21:27:29.829Z,1730237249.829 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2024-10-29T21:27:29.830Z,1730237249.830 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2024-10-29T21:27:29.835Z,1730237249.835 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2024-10-29T21:27:29.844Z,1730237249.844 [MissionManager](ERROR): Top node has no child nodes: Mission 2024-10-29T21:27:29.844Z,1730237249.844 [MissionManager](ERROR): Could not load startup mission. 2024-10-29T21:27:29.844Z,1730237249.844 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl 2024-10-29T21:27:29.844Z,1730237249.844 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl 2024-10-29T21:27:29.846Z,1730237249.846 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl 2024-10-29T21:27:30.148Z,1730237250.148 [Radio_Surface](INFO): Powering up 2024-10-29T21:27:30.410Z,1730237250.410 [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-10-29T21:27:30.429Z,1730237250.429 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min 2024-10-29T21:27:30.457Z,1730237250.457 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h 2024-10-29T21:27:30.461Z,1730237250.461 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count 2024-10-29T21:27:30.465Z,1730237250.465 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s 2024-10-29T21:27:30.492Z,1730237250.492 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count 2024-10-29T21:27:30.496Z,1730237250.496 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min 2024-10-29T21:27:30.497Z,1730237250.497 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait. 2024-10-29T21:27:30.655Z,1730237250.655 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct. 2024-10-29T21:27:30.655Z,1730237250.655 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-10-29T21:27:30.704Z,1730237250.704 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-29T21:27:30.761Z,1730237250.761 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-10-29T21:27:30.764Z,1730237250.764 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-10-29T21:27:30.786Z,1730237250.786 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute. 2024-10-29T21:27:30.790Z,1730237250.790 [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-10-29T21:27:30.800Z,1730237250.800 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,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-10-29T21:27:30.808Z,1730237250.808 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-29T21:27:30.877Z,1730237250.877 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-10-29T21:27:30.878Z,1730237250.878 [Power24vConverter](INFO): Powering up. 2024-10-29T21:27:30.879Z,1730237250.879 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-10-29T21:27:30.888Z,1730237250.888 [Sonardyne_Nano](INFO): Initializing. 2024-10-29T21:27:30.936Z,1730237250.936 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-10-29T21:27:30.958Z,1730237250.958 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-10-29T21:27:30.964Z,1730237250.964 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-10-29T21:27:30.965Z,1730237250.965 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-10-29T21:27:30.972Z,1730237250.972 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-10-29T21:27:30.973Z,1730237250.973 [DockingStepper](INFO): Start 2024-10-29T21:27:30.973Z,1730237250.973 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-10-29T21:27:30.980Z,1730237250.980 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-10-29T21:27:30.981Z,1730237250.981 [MassServo](DEBUG): Initializing EZServoServo. 2024-10-29T21:27:30.988Z,1730237250.988 [MassServo](DEBUG): Initializing MassServo. 2024-10-29T21:27:30.989Z,1730237250.989 [RudderServo](DEBUG): Initializing EZServoServo. 2024-10-29T21:27:30.996Z,1730237250.996 [RudderServo](DEBUG): Initializing RudderServo. 2024-10-29T21:27:30.997Z,1730237250.997 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-10-29T21:27:31.004Z,1730237251.004 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-10-29T21:27:31.293Z,1730237251.293 [DockingStepper](INFO): Starting 2024-10-29T21:27:31.636Z,1730237251.636 [DockingStepper](INFO): Starting 2024-10-29T21:27:32.164Z,1730237252.164 [DockingStepper](INFO): Starting 2024-10-29T21:27:32.212Z,1730237252.212 [DockingStepper](INFO): Init string: /1z16337aE13561N3m50 2024-10-29T21:27:32.392Z,1730237252.392 [WetLabsBB2FL](INFO): Powering down 2024-10-29T21:27:32.454Z,1730237252.454 [DockingStepper](INFO): Starting 2024-10-29T21:27:32.830Z,1730237252.830 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-10-29T21:27:32.878Z,1730237252.878 [DockingStepper](INFO): Starting 2024-10-29T21:27:33.251Z,1730237253.251 [DockingStepper](INFO): Starting 2024-10-29T21:27:33.740Z,1730237253.740 [DockingStepper](INFO): Starting 2024-10-29T21:27:33.768Z,1730237253.768 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-10-29T21:27:34.179Z,1730237254.179 [DockingStepper](INFO): Starting 2024-10-29T21:27:34.484Z,1730237254.484 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-10-29T21:27:34.955Z,1730237254.955 [DockingStepper](INFO): Pause 2024-10-29T21:27:35.400Z,1730237255.400 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-10-29T21:27:35.401Z,1730237255.401 [Radio_Surface](INFO): Found local IP address 10.89.10.2 for eth0 2024-10-29T21:27:36.808Z,1730237256.808 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-10-29T21:27:39.052Z,1730237259.052 [WetLabsUBAT](INFO): Powering down 2024-10-29T21:27:42.620Z,1730237262.620 [DAT](INFO): DAT read: 2024-10-29T21:27:42.622Z,1730237262.622 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-10-29T21:27:44.389Z,1730237264.389 [DAT](INFO): DAT read: MF Frequency Band 2024-10-29T21:27:44.637Z,1730237264.637 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-10-29T21:27:44.638Z,1730237264.638 [DAT](INFO): DAT read: Oct 29 2024 21:27:37 2024-10-29T21:27:45.645Z,1730237265.645 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-10-29T21:27:45.646Z,1730237265.646 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2024-10-29T21:27:45.646Z,1730237265.646 [DAT](INFO): commRate: 600 2024-10-29T21:27:47.712Z,1730237267.712 [DAT](INFO): entering command mode 2024-10-29T21:27:47.912Z,1730237267.912 [DAT](INFO): DAT read: 2024-10-29T21:27:47.913Z,1730237267.913 [DAT](INFO): DAT read: user:1> 2024-10-29T21:27:47.913Z,1730237267.913 [DAT](INFO): setting verbose to 3 2024-10-29T21:27:48.164Z,1730237268.164 [DAT](INFO): DAT read: user:1> 2024-10-29T21:27:48.166Z,1730237268.166 [DAT](INFO): DAT read: Verbose | 3 2024-10-29T21:27:48.166Z,1730237268.166 [DAT](INFO): set verbose to 3 2024-10-29T21:27:48.166Z,1730237268.166 [DAT](INFO): setting DatVerbose to 27440 2024-10-29T21:27:48.418Z,1730237268.418 [DAT](INFO): DAT read: user:2> 2024-10-29T21:27:48.421Z,1730237268.421 [DAT](INFO): DAT read: DatVerbose | 27440 2024-10-29T21:27:48.422Z,1730237268.422 [DAT](INFO): set DatVerbose to 27440 2024-10-29T21:27:48.423Z,1730237268.423 [DAT](INFO): setting transmit power to 8 2024-10-29T21:27:48.668Z,1730237268.668 [DAT](INFO): DAT read: user:3> 2024-10-29T21:27:48.669Z,1730237268.669 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-10-29T21:27:48.669Z,1730237268.669 [DAT](INFO): set transmit power to 8 2024-10-29T21:27:48.670Z,1730237268.670 [DAT](INFO): setting local address to 10 2024-10-29T21:27:48.920Z,1730237268.920 [DAT](INFO): DAT read: user:4> 2024-10-29T21:27:48.921Z,1730237268.921 [DAT](INFO): DAT read: LocalAddr | 10 2024-10-29T21:27:48.922Z,1730237268.922 [DAT](INFO): set local address to 10 2024-10-29T21:27:48.923Z,1730237268.923 [DAT](INFO): Setting time to: 21:27:48 And date to:10/29/2024 2024-10-29T21:27:49.172Z,1730237269.172 [DAT](INFO): DAT read: user:5> 2024-10-29T21:27:49.173Z,1730237269.173 [DAT](INFO): DAT read: Tue Oct 29, 2024 21:27:48 2024-10-29T21:27:49.174Z,1730237269.174 [DAT](INFO): Local DAT time set to Tue Oct 29, 2024 21:27:48 2024-10-29T21:27:58.745Z,1730237278.745 [NAL9602](INFO): Powering up NAL9602 2024-10-29T21:28:00.852Z,1730237280.852 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:28:09.653Z,1730237289.653 [NAL9602](INFO): NAL9602 initialized 2024-10-29T21:28:12.209Z,1730237292.209 [CommandExec](IMPORTANT): got command strobe off 2024-10-29T21:28:12.209Z,1730237292.209 [CommandExec](IMPORTANT): Deactivating strobe 2024-10-29T21:28:31.976Z,1730237311.976 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:29:03.100Z,1730237343.100 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:29:24.463Z,1730237364.463 [SBIT](IMPORTANT): Beginning Startup BIT 2024-10-29T21:29:24.467Z,1730237364.467 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-29T21:29:34.236Z,1730237374.236 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:29:35.947Z,1730237375.947 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.445254 CHAN A1 (24V): 0.614723 CHAN A2 (12V): 0.165075 CHAN A3 (5V): 0.034004 CHAN B0 (3.3V): 0.020269 CHAN B1 (3.15aV): 0.019965 CHAN B2 (3.15bV): 0.021180 CHAN B3 (GND): -0.015055 OPEN: 0.008510 Full Scale: +/- 1 mA 2024-10-29T21:30:05.360Z,1730237405.360 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:30:13.254Z,1730237413.254 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004946 2024-10-29T21:30:14.252Z,1730237414.252 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:30:18.255Z,1730237418.255 [SBIT](IMPORTANT): SBIT PASSED 2024-10-29T21:30:18.260Z,1730237418.260 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): DockingStepper.closedValue=16450 count; 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): DockingStepper.slideValue=10800 count; 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 5.000000 meter; 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): LineCapture.interceptTimeout=5 second; 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): LineCapture.kiHeadingFinalApproach=0.02 reciprocal_second; 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): LineCapture.kiHeadingTerminalGuidance=0.02 reciprocal_second; 2024-10-29T21:30:18.261Z,1730237418.261 [SBIT](IMPORTANT): LineCapture.navigationGain=3 none; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): LineCapture.rolloutSpeed=0 meter_per_second; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): RudderServo.offsetAngle=0.2 degree; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): Undock.reverseThrustTimeout=20 second; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=317.403036 cubic_centimeter; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): VerticalControl.kdPitchMass=1.25 second; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): VerticalControl.kiPitchMass=1.25 reciprocal_second; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): VerticalControl.kpPitchMass=1.25 none; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): VerticalControl.massDeadband=0.05 centimeter; 2024-10-29T21:30:18.262Z,1730237418.262 [SBIT](IMPORTANT): VerticalControl.massDefault=23.583194 millimeter; 2024-10-29T21:30:18.263Z,1730237418.263 [SBIT](IMPORTANT): VerticalControl.massOnlyForceInt=0 bool; 2024-10-29T21:30:18.719Z,1730237418.719 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2024-10-29T21:30:18.726Z,1730237418.726 [DefaultWithUndock] Running Loop=1 2024-10-29T21:30:18.726Z,1730237418.726 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2024-10-29T21:30:18.726Z,1730237418.726 [DefaultWithUndock:A.Wait] Running Loop=1 2024-10-29T21:30:18.726Z,1730237418.726 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2024-10-29T21:30:22.977Z,1730237422.977 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:30:29.987Z,1730237429.987 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-10-29T21:30:29.990Z,1730237429.990 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-29T21:30:30.022Z,1730237430.022 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-29T21:30:30.431Z,1730237430.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-29T21:30:30.432Z,1730237430.432 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-10-29T21:30:31.572Z,1730237431.572 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:30:40.004Z,1730237440.004 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:30:48.959Z,1730237448.959 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2024-10-29T21:30:48.959Z,1730237448.959 [DefaultWithUndock:A.Wait] Stopped 2024-10-29T21:30:48.959Z,1730237448.959 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2024-10-29T21:30:48.959Z,1730237448.959 [DefaultWithUndock:LeaveDock] Running Loop=1 2024-10-29T21:30:48.959Z,1730237448.959 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2024-10-29T21:30:48.960Z,1730237448.960 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2024-10-29T21:30:48.960Z,1730237448.960 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2024-10-29T21:30:48.960Z,1730237448.960 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2024-10-29T21:30:48.960Z,1730237448.960 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2024-10-29T21:30:48.960Z,1730237448.960 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-10-29T21:30:49.367Z,1730237449.367 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2024-10-29T21:30:49.367Z,1730237449.367 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-10-29T21:30:49.376Z,1730237449.376 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth -0.323192 m. 2024-10-29T21:30:49.377Z,1730237449.377 [DefaultWithUndock:LeaveDock:A.] Stopped 2024-10-29T21:30:49.377Z,1730237449.377 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact. 2024-10-29T21:30:49.382Z,1730237449.382 [DockingStepper](INFO): Resume 2024-10-29T21:30:49.766Z,1730237449.766 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2024-10-29T21:30:49.801Z,1730237449.801 [DockingStepper](INFO): Resuming 2024-10-29T21:30:50.136Z,1730237450.136 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:30:50.176Z,1730237450.176 [DockingStepper](INFO): Start 2024-10-29T21:30:50.176Z,1730237450.176 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-10-29T21:30:50.293Z,1730237450.293 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-10-29T21:30:50.640Z,1730237450.640 [DockingStepper](INFO): Starting 2024-10-29T21:30:51.122Z,1730237451.122 [DockingStepper](INFO): Starting 2024-10-29T21:30:51.429Z,1730237451.429 [DockingStepper](INFO): Starting 2024-10-29T21:30:51.480Z,1730237451.480 [DockingStepper](INFO): Init string: /1z16335aE13561N3m50 2024-10-29T21:30:51.827Z,1730237451.827 [DockingStepper](INFO): Starting 2024-10-29T21:30:52.299Z,1730237452.299 [DockingStepper](INFO): Starting 2024-10-29T21:30:52.910Z,1730237452.910 [DockingStepper](INFO): Starting 2024-10-29T21:30:53.329Z,1730237453.329 [DockingStepper](INFO): Starting 2024-10-29T21:30:53.356Z,1730237453.356 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-10-29T21:30:53.583Z,1730237453.583 [DockingStepper](INFO): Starting 2024-10-29T21:31:02.432Z,1730237462.432 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:31:10.034Z,1730237470.034 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning docking module to standby. 2024-10-29T21:31:10.495Z,1730237470.495 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Docking module at standby. 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:LeaveDock] Stopped 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Running Loop=1 2024-10-29T21:31:10.855Z,1730237470.855 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-10-29T21:31:10.870Z,1730237470.870 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-10-29T21:31:10.871Z,1730237470.871 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-10-29T21:31:10.871Z,1730237470.871 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-10-29T21:31:10.871Z,1730237470.871 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-10-29T21:31:10.912Z,1730237470.912 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-10-29T21:31:10.912Z,1730237470.912 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-10-29T21:31:11.234Z,1730237471.234 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2024-10-29T21:31:11.234Z,1730237471.234 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2024-10-29T21:31:11.234Z,1730237471.234 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2024-10-29T21:31:11.397Z,1730237471.397 [DockingStepper](INFO): Pause 2024-10-29T21:31:11.661Z,1730237471.661 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-10-29T21:31:14.933Z,1730237474.933 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:31:23.788Z,1730237483.788 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:31:32.732Z,1730237492.732 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:31:41.492Z,1730237501.492 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:31:50.060Z,1730237510.060 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:31:58.532Z,1730237518.532 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:32:07.036Z,1730237527.036 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:32:14.872Z,1730237534.872 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:32:23.484Z,1730237543.484 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:32:32.188Z,1730237552.188 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:32:42.968Z,1730237562.968 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:32:53.553Z,1730237573.553 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:33:02.357Z,1730237582.357 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:33:12.068Z,1730237592.068 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:33:13.658Z,1730237593.658 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-10-29T21:33:21.752Z,1730237601.752 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:33:30.460Z,1730237610.460 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:33:31.068Z,1730237611.068 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-10-29T21:33:31.068Z,1730237611.068 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-29T21:33:31.079Z,1730237611.079 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-29T21:33:31.490Z,1730237611.490 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-29T21:33:31.490Z,1730237611.490 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-10-29T21:33:38.988Z,1730237618.988 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:33:47.320Z,1730237627.320 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:33:55.832Z,1730237635.832 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:34:04.399Z,1730237644.399 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:34:12.768Z,1730237652.768 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:34:21.448Z,1730237661.448 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:34:24.764Z,1730237664.764 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 0.00, 0.00 2024-10-29T21:34:30.084Z,1730237670.084 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:34:38.524Z,1730237678.524 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:34:47.080Z,1730237687.080 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:34:55.532Z,1730237695.532 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:34:56.676Z,1730237696.676 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2024-10-29T21:34:56.679Z,1730237696.679 [BPC1](INFO): Received data from all battery sticks. 2024-10-29T21:35:03.988Z,1730237703.988 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:35:12.398Z,1730237712.398 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:35:20.852Z,1730237720.852 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:35:29.260Z,1730237729.260 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:35:37.688Z,1730237737.688 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:35:46.164Z,1730237746.164 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:35:54.585Z,1730237754.585 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:36:02.908Z,1730237762.908 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:36:11.332Z,1730237771.332 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T21:36:11.425Z,1730237771.425 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](INFO): Timed out from 2024-10-29T21:31:11.2Z 2024-10-29T21:36:11.426Z,1730237771.426 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2024-10-29T21:36:11.426Z,1730237771.426 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2024-10-29T21:36:11.831Z,1730237771.831 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-10-29T21:36:17.930Z,1730237777.930 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241029T204701/Courier0010.lzma 2024-10-29T21:36:18.830Z,1730237778.830 [DataOverHttps](INFO): Moved sent file to Logs/20241029T204701/Courier0010.lzma.bak 2024-10-29T21:36:18.830Z,1730237778.830 [DataOverHttps](INFO): SBD MOMSN=23348671 2024-10-29T21:36:32.035Z,1730237792.035 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-10-29T21:36:32.035Z,1730237792.035 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-29T21:36:32.079Z,1730237792.079 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-29T21:36:32.542Z,1730237792.542 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-29T21:36:32.542Z,1730237792.542 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-10-29T21:36:34.912Z,1730237794.912 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20241029T212718/Courier0000.lzma 2024-10-29T21:36:35.913Z,1730237795.913 [DataOverHttps](INFO): Moved sent file to Logs/20241029T212718/Courier0000.lzma.bak 2024-10-29T21:36:35.914Z,1730237795.914 [DataOverHttps](INFO): SBD MOMSN=23348673 2024-10-29T21:36:51.803Z,1730237811.803 [DataOverHttps](INFO): Sending 199 bytes from file Logs/20241029T204701/Express0011.lzma 2024-10-29T21:36:52.805Z,1730237812.805 [DataOverHttps](INFO): Moved sent file to Logs/20241029T204701/Express0011.lzma.bak 2024-10-29T21:36:52.806Z,1730237812.806 [DataOverHttps](INFO): SBD MOMSN=23348676 2024-10-29T21:36:55.285Z,1730237815.285 [CommandExec](IMPORTANT): got command restart application 2024-10-29T21:36:56.288Z,1730237816.288 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-10-29T21:36:56.288Z,1730237816.288 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:36:56.288Z,1730237816.288 [CommandExec](INFO): Uninitializing the command executive. 2024-10-29T21:36:56.288Z,1730237816.288 [CommandExec](INFO): Uninitializing the command scheduler. 2024-10-29T21:36:56.289Z,1730237816.289 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:56.424Z,1730237816.424 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-10-29T21:36:56.424Z,1730237816.424 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-10-29T21:36:56.425Z,1730237816.425 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:56.426Z,1730237816.426 [NavChartDb](INFO): Join timeout helper Thread ID is 1189 2024-10-29T21:36:56.776Z,1730237816.776 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:36:56.776Z,1730237816.776 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:56.780Z,1730237816.780 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-10-29T21:36:56.780Z,1730237816.780 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:56.780Z,1730237816.780 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1190 2024-10-29T21:36:56.812Z,1730237816.812 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:36:56.812Z,1730237816.812 [WetLabsUBAT](INFO): Powering down 2024-10-29T21:36:56.813Z,1730237816.813 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:56.837Z,1730237816.837 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-10-29T21:36:56.837Z,1730237816.837 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:56.838Z,1730237816.838 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1191 2024-10-29T21:36:57.144Z,1730237817.144 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:36:57.144Z,1730237817.144 [WetLabsBB2FL](INFO): Powering down 2024-10-29T21:36:57.145Z,1730237817.145 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:57.160Z,1730237817.160 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-10-29T21:36:57.160Z,1730237817.160 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:57.160Z,1730237817.160 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1192 2024-10-29T21:36:57.204Z,1730237817.204 [CTD_Seabird](INFO): Powering down 2024-10-29T21:36:57.216Z,1730237817.216 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:36:57.216Z,1730237817.216 [CTD_Seabird](INFO): Powering down 2024-10-29T21:36:57.228Z,1730237817.228 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:57.240Z,1730237817.240 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-10-29T21:36:57.240Z,1730237817.240 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:57.240Z,1730237817.240 [DAT](INFO): Join timeout helper Thread ID is 1193 2024-10-29T21:36:57.380Z,1730237817.380 [DAT](INFO): Powering down 2024-10-29T21:36:57.452Z,1730237817.452 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:36:57.452Z,1730237817.452 [DAT](INFO): Powering down 2024-10-29T21:36:57.453Z,1730237817.453 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:57.465Z,1730237817.465 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-10-29T21:36:57.465Z,1730237817.465 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:57.465Z,1730237817.465 [Radio_Surface](INFO): Join timeout helper Thread ID is 1194 2024-10-29T21:36:57.620Z,1730237817.620 [Radio_Surface](INFO): Powering down 2024-10-29T21:36:57.621Z,1730237817.621 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:36:57.621Z,1730237817.621 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:57.628Z,1730237817.628 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-10-29T21:36:57.629Z,1730237817.629 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:36:57.629Z,1730237817.629 [Onboard](INFO): Join timeout helper Thread ID is 1195 2024-10-29T21:37:00.200Z,1730237820.200 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:37:00.200Z,1730237820.200 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.208Z,1730237820.208 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-10-29T21:37:00.208Z,1730237820.208 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.209Z,1730237820.209 [DataOverHttps](INFO): Join timeout helper Thread ID is 1196 2024-10-29T21:37:00.684Z,1730237820.684 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:37:00.687Z,1730237820.687 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.716Z,1730237820.716 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-10-29T21:37:00.716Z,1730237820.716 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.716Z,1730237820.716 [BackseatComponent](INFO): Join timeout helper Thread ID is 1197 2024-10-29T21:37:00.845Z,1730237820.845 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:37:00.845Z,1730237820.845 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.856Z,1730237820.856 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-10-29T21:37:00.857Z,1730237820.857 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.857Z,1730237820.857 [logger](INFO): Join timeout helper Thread ID is 1198 2024-10-29T21:37:00.896Z,1730237820.896 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:37:00.896Z,1730237820.896 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.916Z,1730237820.916 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-10-29T21:37:00.916Z,1730237820.916 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.917Z,1730237820.917 [CommandLine](INFO): Join timeout helper Thread ID is 1199 2024-10-29T21:37:00.948Z,1730237820.948 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:37:00.948Z,1730237820.948 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.956Z,1730237820.956 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-10-29T21:37:00.956Z,1730237820.956 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.957Z,1730237820.957 [CommandExec](INFO): Join timeout helper Thread ID is 1200 2024-10-29T21:37:00.958Z,1730237820.958 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-10-29T21:37:00.958Z,1730237820.958 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:00.959Z,1730237820.959 [controlThread](INFO): Join timeout helper Thread ID is 1201 2024-10-29T21:37:01.104Z,1730237821.104 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T21:37:01.104Z,1730237821.104 [controlThread](DEBUG): Uninitializing ControlThread 2024-10-29T21:37:01.105Z,1730237821.105 [AHRS_M2](INFO): Powering down 2024-10-29T21:37:01.177Z,1730237821.177 [NAL9602](INFO): Powering down 2024-10-29T21:37:01.248Z,1730237821.248 [RDI_Pathfinder](INFO): Powering down 2024-10-29T21:37:01.249Z,1730237821.249 [Sonardyne_Nano](INFO): Powering down 2024-10-29T21:37:01.368Z,1730237821.368 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-10-29T21:37:01.369Z,1730237821.369 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-10-29T21:37:01.370Z,1730237821.370 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-10-29T21:37:01.370Z,1730237821.370 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2024-10-29T21:37:01.370Z,1730237821.370 [DefaultWithUndock] Stopped 2024-10-29T21:37:01.370Z,1730237821.370 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2024-10-29T21:37:01.370Z,1730237821.370 [DefaultWithUndock:SurfaceDefault] Stopped 2024-10-29T21:37:01.371Z,1730237821.371 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2024-10-29T21:37:01.371Z,1730237821.371 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Stopped 2024-10-29T21:37:01.371Z,1730237821.371 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-10-29T21:37:01.371Z,1730237821.371 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2024-10-29T21:37:01.371Z,1730237821.371 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2024-10-29T21:37:01.371Z,1730237821.371 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2024-10-29T21:37:01.379Z,1730237821.379 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-10-29T21:37:01.379Z,1730237821.379 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-10-29T21:37:01.379Z,1730237821.379 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-10-29T21:37:01.380Z,1730237821.380 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-10-29T21:37:01.380Z,1730237821.380 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-10-29T21:37:01.380Z,1730237821.380 [BuoyancyServo](INFO): Powering down 2024-10-29T21:37:01.392Z,1730237821.392 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-10-29T21:37:01.392Z,1730237821.392 [ElevatorServo](INFO): Powering down 2024-10-29T21:37:01.393Z,1730237821.393 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-10-29T21:37:01.393Z,1730237821.393 [DockingStepper](INFO): Powering down 2024-10-29T21:37:01.394Z,1730237821.394 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-10-29T21:37:01.394Z,1730237821.394 [MassServo](INFO): Powering down 2024-10-29T21:37:01.395Z,1730237821.395 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-10-29T21:37:01.395Z,1730237821.395 [RudderServo](INFO): Powering down 2024-10-29T21:37:01.396Z,1730237821.396 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-10-29T21:37:01.396Z,1730237821.396 [ThrusterServo](INFO): Powering down 2024-10-29T21:37:01.397Z,1730237821.397 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-10-29T21:37:01.397Z,1730237821.397 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-10-29T21:37:01.397Z,1730237821.397 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-10-29T21:37:01.397Z,1730237821.397 [CBIT](DEBUG): Powering off loads. 2024-10-29T21:37:01.411Z,1730237821.411 [CBIT](DEBUG): Disabling WDT. 2024-10-29T21:37:01.423Z,1730237821.423 [CBIT](DEBUG): Opening all GF detection circuits. 2024-10-29T21:37:01.425Z,1730237821.425 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.482Z,1730237821.482 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.490Z,1730237821.490 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.492Z,1730237821.492 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.497Z,1730237821.497 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.542Z,1730237821.542 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.603Z,1730237821.603 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.606Z,1730237821.606 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.610Z,1730237821.610 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.618Z,1730237821.618 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-29T21:37:01.686Z,1730237821.686 [logger ThreadHandler](INFO): Thread cancelled.