2024-10-18T19:25:27.176Z,1729279527.176 [Supervisor](DEBUG): Initializing supervisor. 2024-10-18T19:25:27.180Z,1729279527.180 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-10-18T19:25:27.180Z,1729279527.180 [SyncHandler](INFO): Protected caller Thread ID is 5135 2024-10-18T19:25:27.181Z,1729279527.181 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-10-18T19:25:27.182Z,1729279527.182 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-10-18T19:25:27.182Z,1729279527.182 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5136 2024-10-18T19:25:27.186Z,1729279527.186 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-10-18T19:25:27.204Z,1729279527.204 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-10-18T19:25:27.205Z,1729279527.205 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-10-18T19:25:27.205Z,1729279527.205 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 5137 2024-10-18T19:25:27.209Z,1729279527.209 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-10-18T19:25:27.210Z,1729279527.210 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-10-18T19:25:27.211Z,1729279527.211 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5138 2024-10-18T19:25:27.213Z,1729279527.213 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-10-18T19:25:27.213Z,1729279527.213 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-10-18T19:25:27.214Z,1729279527.214 [logger ThreadHandler](INFO): Protected caller Thread ID is 5139 2024-10-18T19:25:27.217Z,1729279527.217 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-10-18T19:25:27.218Z,1729279527.218 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-10-18T19:25:27.220Z,1729279527.220 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-10-18T19:25:27.330Z,1729279527.330 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-10-18T19:25:27.331Z,1729279527.331 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-10-18T19:25:28.169Z,1729279528.169 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-10-18T19:25:28.169Z,1729279528.169 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-10-18T19:25:28.429Z,1729279528.429 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-10-18T19:25:28.430Z,1729279528.430 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-10-18T19:25:28.524Z,1729279528.524 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-10-18T19:25:28.757Z,1729279528.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-10-18T19:25:28.757Z,1729279528.757 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-10-18T19:25:28.853Z,1729279528.853 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-10-18T19:25:28.977Z,1729279528.977 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-10-18T19:25:28.977Z,1729279528.977 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-10-18T19:25:29.422Z,1729279529.422 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-10-18T19:25:29.422Z,1729279529.422 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-10-18T19:25:30.041Z,1729279530.041 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-10-18T19:25:30.042Z,1729279530.042 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-10-18T19:25:30.296Z,1729279530.296 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-10-18T19:25:30.297Z,1729279530.297 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-10-18T19:25:30.512Z,1729279530.512 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-10-18T19:25:30.512Z,1729279530.512 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-10-18T19:25:31.103Z,1729279531.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-10-18T19:25:31.104Z,1729279531.104 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-10-18T19:25:31.427Z,1729279531.427 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-10-18T19:25:31.427Z,1729279531.427 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-10-18T19:25:31.685Z,1729279531.685 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-10-18T19:25:31.686Z,1729279531.686 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-10-18T19:25:32.098Z,1729279532.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-10-18T19:25:32.099Z,1729279532.099 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-10-18T19:25:32.509Z,1729279532.509 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-10-18T19:25:32.512Z,1729279532.512 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-10-18T19:25:32.512Z,1729279532.512 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-10-18T19:25:32.737Z,1729279532.737 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-10-18T19:25:33.251Z,1729279533.251 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2024-10-18T19:25:33.383Z,1729279533.383 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-10-18T19:25:33.499Z,1729279533.499 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-10-18T19:25:33.624Z,1729279533.624 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-10-18T19:25:33.725Z,1729279533.725 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-10-18T19:25:33.836Z,1729279533.836 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-10-18T19:25:33.967Z,1729279533.967 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-10-18T19:25:34.247Z,1729279534.247 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-10-18T19:25:34.247Z,1729279534.247 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-10-18T19:25:34.359Z,1729279534.359 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-10-18T19:25:34.468Z,1729279534.468 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-10-18T19:25:34.631Z,1729279534.631 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-10-18T19:25:34.749Z,1729279534.749 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-10-18T19:25:34.749Z,1729279534.749 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-10-18T19:25:34.763Z,1729279534.763 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-10-18T19:25:34.871Z,1729279534.871 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-10-18T19:25:34.871Z,1729279534.871 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-10-18T19:25:34.922Z,1729279534.922 [VerticalControl](DEBUG): Construct VerticalControl. 2024-10-18T19:25:34.981Z,1729279534.981 [VerticalControl] Loaded 2024-10-18T19:25:34.981Z,1729279534.981 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-10-18T19:25:34.985Z,1729279534.985 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-10-18T19:25:35.031Z,1729279535.031 [HorizontalControl] Loaded 2024-10-18T19:25:35.031Z,1729279535.031 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-10-18T19:25:35.034Z,1729279535.034 [SpeedControl](DEBUG): Construct SpeedControl. 2024-10-18T19:25:35.037Z,1729279535.037 [SpeedControl] Loaded 2024-10-18T19:25:35.037Z,1729279535.037 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-10-18T19:25:35.040Z,1729279535.040 [LoopControl](DEBUG): Construct LoopControl. 2024-10-18T19:25:35.040Z,1729279535.040 [LoopControl] Loaded 2024-10-18T19:25:35.040Z,1729279535.040 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-10-18T19:25:35.041Z,1729279535.041 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-10-18T19:25:35.041Z,1729279535.041 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-10-18T19:25:35.089Z,1729279535.089 [DepthRateCalculator] Loaded 2024-10-18T19:25:35.089Z,1729279535.089 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-10-18T19:25:35.094Z,1729279535.094 [PitchRateCalculator] Loaded 2024-10-18T19:25:35.094Z,1729279535.094 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-10-18T19:25:35.104Z,1729279535.104 [SpeedCalculator] Loaded 2024-10-18T19:25:35.104Z,1729279535.104 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-10-18T19:25:35.108Z,1729279535.108 [YawRateCalculator] Loaded 2024-10-18T19:25:35.108Z,1729279535.108 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-10-18T19:25:35.126Z,1729279535.126 [ElevatorOffsetCalculator] Loaded 2024-10-18T19:25:35.126Z,1729279535.126 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-10-18T19:25:35.127Z,1729279535.127 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-10-18T19:25:35.127Z,1729279535.127 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-10-18T19:25:35.153Z,1729279535.153 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-10-18T19:25:35.154Z,1729279535.154 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-10-18T19:25:35.209Z,1729279535.209 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-10-18T19:25:35.209Z,1729279535.209 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-10-18T19:25:35.537Z,1729279535.537 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-10-18T19:25:35.537Z,1729279535.537 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-10-18T19:25:35.704Z,1729279535.704 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-10-18T19:25:35.704Z,1729279535.704 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-10-18T19:25:36.167Z,1729279536.167 [AHRS_M2] Loaded 2024-10-18T19:25:36.168Z,1729279536.168 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-10-18T19:25:36.206Z,1729279536.206 [BackseatComponent] Loaded 2024-10-18T19:25:36.206Z,1729279536.206 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-10-18T19:25:36.207Z,1729279536.207 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409CE4E0 2024-10-18T19:25:36.208Z,1729279536.208 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5228 2024-10-18T19:25:36.210Z,1729279536.210 [LcmUniversalReporter] Loaded 2024-10-18T19:25:36.211Z,1729279536.211 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-10-18T19:25:37.017Z,1729279537.017 [BPC1] Loaded 2024-10-18T19:25:37.017Z,1729279537.017 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-10-18T19:25:37.112Z,1729279537.112 [DAT] Loaded 2024-10-18T19:25:37.112Z,1729279537.112 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-10-18T19:25:37.113Z,1729279537.113 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409FE4E0 2024-10-18T19:25:37.113Z,1729279537.113 [DAT ThreadHandler](INFO): Protected caller Thread ID is 5229 2024-10-18T19:25:37.187Z,1729279537.187 [DataOverHttps] Loaded 2024-10-18T19:25:37.187Z,1729279537.187 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-10-18T19:25:37.188Z,1729279537.188 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A2E4E0 2024-10-18T19:25:37.189Z,1729279537.189 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5230 2024-10-18T19:25:37.211Z,1729279537.211 [Depth_Keller] Loaded 2024-10-18T19:25:37.211Z,1729279537.211 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-10-18T19:25:37.275Z,1729279537.275 [NAL9602] Loaded 2024-10-18T19:25:37.276Z,1729279537.276 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-10-18T19:25:37.305Z,1729279537.305 [Onboard] Loaded 2024-10-18T19:25:37.305Z,1729279537.305 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-10-18T19:25:37.306Z,1729279537.306 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A5E4E0 2024-10-18T19:25:37.307Z,1729279537.307 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5231 2024-10-18T19:25:37.320Z,1729279537.320 [Power24vConverter] Loaded 2024-10-18T19:25:37.321Z,1729279537.321 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-10-18T19:25:37.335Z,1729279537.335 [Radio_Surface] Loaded 2024-10-18T19:25:37.336Z,1729279537.336 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-10-18T19:25:37.337Z,1729279537.337 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A8E4E0 2024-10-18T19:25:37.337Z,1729279537.337 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5232 2024-10-18T19:25:37.384Z,1729279537.384 [RDI_Pathfinder] Loaded 2024-10-18T19:25:37.384Z,1729279537.384 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-10-18T19:25:37.399Z,1729279537.399 [Sonardyne_Nano] Loaded 2024-10-18T19:25:37.399Z,1729279537.399 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-10-18T19:25:37.458Z,1729279537.458 [TrnDataBridge] Loaded 2024-10-18T19:25:37.458Z,1729279537.458 [ComponentRegistry](DEBUG): Component "TrnDataBridge" handled in its own thread. 2024-10-18T19:25:37.459Z,1729279537.459 [TrnDataBridge ThreadHandler](DEBUG): Created PCaller Thread at 40ABE4E0 2024-10-18T19:25:37.459Z,1729279537.459 [TrnDataBridge ThreadHandler](INFO): Protected caller Thread ID is 5233 2024-10-18T19:25:37.460Z,1729279537.460 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-10-18T19:25:37.461Z,1729279537.461 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-10-18T19:25:37.569Z,1729279537.569 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-10-18T19:25:37.570Z,1729279537.570 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-10-18T19:25:37.583Z,1729279537.583 [NavChart] Loaded 2024-10-18T19:25:37.584Z,1729279537.584 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-10-18T19:25:37.590Z,1729279537.590 [UniversalFixResidualReporter] Loaded 2024-10-18T19:25:37.590Z,1729279537.590 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-10-18T19:25:37.590Z,1729279537.590 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-10-18T19:25:37.591Z,1729279537.591 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-10-18T19:25:37.986Z,1729279537.986 [SBIT](DEBUG): Construct Startup Built In Test. 2024-10-18T19:25:37.995Z,1729279537.995 [SBIT] Loaded 2024-10-18T19:25:37.995Z,1729279537.995 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-10-18T19:25:37.998Z,1729279537.998 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-10-18T19:25:38.010Z,1729279538.010 [IBIT] Loaded 2024-10-18T19:25:38.011Z,1729279538.011 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-10-18T19:25:38.016Z,1729279538.016 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-10-18T19:25:38.297Z,1729279538.297 [CBIT] Loaded 2024-10-18T19:25:38.297Z,1729279538.297 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-10-18T19:25:38.297Z,1729279538.297 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-10-18T19:25:38.298Z,1729279538.298 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-10-18T19:25:38.429Z,1729279538.429 [BuoyancyServo] Loaded 2024-10-18T19:25:38.429Z,1729279538.429 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-10-18T19:25:38.453Z,1729279538.453 [ElevatorServo] Loaded 2024-10-18T19:25:38.453Z,1729279538.453 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-10-18T19:25:38.482Z,1729279538.482 [DockingStepper] Loaded 2024-10-18T19:25:38.483Z,1729279538.483 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-10-18T19:25:38.505Z,1729279538.505 [MassServo] Loaded 2024-10-18T19:25:38.505Z,1729279538.505 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-10-18T19:25:38.525Z,1729279538.525 [RudderServo] Loaded 2024-10-18T19:25:38.525Z,1729279538.525 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-10-18T19:25:38.544Z,1729279538.544 [ThrusterServo] Loaded 2024-10-18T19:25:38.545Z,1729279538.545 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-10-18T19:25:38.545Z,1729279538.545 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-10-18T19:25:38.546Z,1729279538.546 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-10-18T19:25:38.556Z,1729279538.556 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-10-18T19:25:38.556Z,1729279538.556 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-10-18T19:25:38.729Z,1729279538.729 [CTD_Seabird] Loaded 2024-10-18T19:25:38.730Z,1729279538.730 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-10-18T19:25:38.731Z,1729279538.731 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C124E0 2024-10-18T19:25:38.731Z,1729279538.731 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5234 2024-10-18T19:25:38.754Z,1729279538.754 [PAR_Licor] Loaded 2024-10-18T19:25:38.755Z,1729279538.755 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-10-18T19:25:38.799Z,1729279538.799 [WetLabsBB2FL] Loaded 2024-10-18T19:25:38.799Z,1729279538.799 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-10-18T19:25:38.800Z,1729279538.800 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C424E0 2024-10-18T19:25:38.801Z,1729279538.801 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5235 2024-10-18T19:25:38.822Z,1729279538.822 [WetLabsUBAT] Loaded 2024-10-18T19:25:38.822Z,1729279538.822 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-10-18T19:25:38.823Z,1729279538.823 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C724E0 2024-10-18T19:25:38.824Z,1729279538.824 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 5236 2024-10-18T19:25:38.824Z,1729279538.824 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-10-18T19:25:38.831Z,1729279538.831 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-10-18T19:25:38.834Z,1729279538.833 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-10-18T19:25:38.845Z,1729279538.845 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-10-18T19:25:38.846Z,1729279538.846 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40CA24E0 2024-10-18T19:25:38.846Z,1729279538.846 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5237 2024-10-18T19:25:38.851Z,1729279538.851 [Supervisor](INFO): Main Thread ID is 5134 2024-10-18T19:25:38.851Z,1729279538.851 [Supervisor](DEBUG): Running supervisor. 2024-10-18T19:25:38.851Z,1729279538.851 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5238 2024-10-18T19:25:38.852Z,1729279538.852 [CommandExec](INFO): Initializing the command executive. 2024-10-18T19:25:38.853Z,1729279538.853 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5239 2024-10-18T19:25:38.856Z,1729279538.856 [controlThread ThreadHandler](INFO): Handler Thread ID is 5240 2024-10-18T19:25:38.856Z,1729279538.856 [controlThread](DEBUG): Initializing ControlThread 2024-10-18T19:25:38.857Z,1729279538.857 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-10-18T19:25:38.858Z,1729279538.858 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-10-18T19:25:38.859Z,1729279538.859 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-10-18T19:25:38.860Z,1729279538.860 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-10-18T19:25:38.860Z,1729279538.860 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-10-18T19:25:38.860Z,1729279538.860 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-10-18T19:25:38.861Z,1729279538.861 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-10-18T19:25:38.861Z,1729279538.861 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-10-18T19:25:38.861Z,1729279538.861 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-10-18T19:25:38.868Z,1729279538.868 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-10-18T19:25:38.868Z,1729279538.868 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-10-18T19:25:38.868Z,1729279538.868 [SBIT](INFO): Initialize SBIT Component. 2024-10-18T19:25:38.869Z,1729279538.869 [SBIT](IMPORTANT): git: 2024-10-12-3-gfe0a8a3a0 2024-10-18T19:25:38.869Z,1729279538.869 [SBIT](INFO): git hash: fe0a8a3a0341275697510044f36f602884fe5bc4 2024-10-18T19:25:38.869Z,1729279538.869 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-10-18T19:25:38.871Z,1729279538.871 [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-18T19:25:38.872Z,1729279538.872 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2024-10-18T19:25:38.872Z,1729279538.872 [IBIT](INFO): Initialize IBIT Component. 2024-10-18T19:25:38.873Z,1729279538.873 [CBIT](DEBUG): Initialize CBIT Component. 2024-10-18T19:25:38.874Z,1729279538.874 [logger ThreadHandler](INFO): Handler Thread ID is 5241 2024-10-18T19:25:38.886Z,1729279538.886 [CBIT](DEBUG): Initialized mux pins. 2024-10-18T19:25:38.886Z,1729279538.886 [CBIT](DEBUG): Initializing the watchdog timer. 2024-10-18T19:25:38.891Z,1729279538.891 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 5242 2024-10-18T19:25:38.899Z,1729279538.899 [DAT ThreadHandler](INFO): Handler Thread ID is 5243 2024-10-18T19:25:38.900Z,1729279538.900 [DAT](INFO): Powering up 2024-10-18T19:25:38.900Z,1729279538.900 [DAT](DEBUG): Initializing DAT. 2024-10-18T19:25:38.904Z,1729279538.904 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5245 2024-10-18T19:25:38.906Z,1729279538.906 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-10-18T19:25:38.910Z,1729279538.910 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-10-18T19:25:38.911Z,1729279538.911 [CBIT](DEBUG): Initializing heartbeat. 2024-10-18T19:25:38.919Z,1729279538.919 [Onboard ThreadHandler](INFO): Handler Thread ID is 5246 2024-10-18T19:25:38.936Z,1729279538.936 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5247 2024-10-18T19:25:38.955Z,1729279538.955 [TrnDataBridge ThreadHandler](INFO): Handler Thread ID is 5248 2024-10-18T19:25:38.956Z,1729279538.956 [TrnDataBridge](INFO): Start 2024-10-18T19:25:38.956Z,1729279538.956 [TrnDataBridge](IMPORTANT): LCM Instance1 2024-10-18T19:25:38.982Z,1729279538.982 [CBIT](DEBUG): Deactivating GF circuits. 2024-10-18T19:25:38.982Z,1729279538.982 [CBIT](DEBUG): Deactivating emergency mode. 2024-10-18T19:25:38.988Z,1729279538.988 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5250 2024-10-18T19:25:38.988Z,1729279538.988 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-10-18T19:25:38.991Z,1729279538.991 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5252 2024-10-18T19:25:38.995Z,1729279538.995 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 5254 2024-10-18T19:25:38.997Z,1729279538.997 [WetLabsBB2FL](INFO): Powering up 2024-10-18T19:25:39.003Z,1729279539.003 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5256 2024-10-18T19:25:39.006Z,1729279539.006 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-10-18T19:25:39.006Z,1729279539.006 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-10-18T19:25:39.006Z,1729279539.006 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-10-18T19:25:39.006Z,1729279539.006 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-10-18T19:25:39.007Z,1729279539.007 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-10-18T19:25:39.007Z,1729279539.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-10-18T19:25:39.007Z,1729279539.007 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-10-18T19:25:39.007Z,1729279539.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-10-18T19:25:39.023Z,1729279539.023 [CBIT](DEBUG): Backplane powered. 2024-10-18T19:25:39.027Z,1729279539.027 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-10-18T19:25:39.028Z,1729279539.028 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2024-10-18T19:25:39.028Z,1729279539.028 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2024-10-18T19:25:39.029Z,1729279539.029 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2024-10-18T19:25:39.034Z,1729279539.034 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2024-10-18T19:25:39.035Z,1729279539.035 [MissionManager](ERROR): Top node has no child nodes: Mission 2024-10-18T19:25:39.035Z,1729279539.035 [MissionManager](ERROR): Could not load startup mission. 2024-10-18T19:25:39.035Z,1729279539.035 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl 2024-10-18T19:25:39.035Z,1729279539.035 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl 2024-10-18T19:25:39.037Z,1729279539.037 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl 2024-10-18T19:25:39.043Z,1729279539.043 [WetLabsUBAT](INFO): Powering up 2024-10-18T19:25:39.342Z,1729279539.342 [Radio_Surface](INFO): Powering up 2024-10-18T19:25:39.612Z,1729279539.612 [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-18T19:25:39.634Z,1729279539.634 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min 2024-10-18T19:25:39.638Z,1729279539.638 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h 2024-10-18T19:25:39.655Z,1729279539.655 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count 2024-10-18T19:25:39.675Z,1729279539.675 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s 2024-10-18T19:25:39.679Z,1729279539.679 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count 2024-10-18T19:25:39.689Z,1729279539.689 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min 2024-10-18T19:25:39.692Z,1729279539.692 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait. 2024-10-18T19:25:39.840Z,1729279539.840 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct. 2024-10-18T19:25:39.840Z,1729279539.840 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-10-18T19:25:39.895Z,1729279539.895 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-18T19:25:39.952Z,1729279539.952 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-10-18T19:25:39.954Z,1729279539.954 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-10-18T19:25:39.974Z,1729279539.974 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute. 2024-10-18T19:25:39.995Z,1729279539.995 [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-18T19:25:40.000Z,1729279540.000 [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-18T19:25:40.023Z,1729279540.023 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-18T19:25:40.097Z,1729279540.097 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-10-18T19:25:40.098Z,1729279540.098 [Power24vConverter](INFO): Powering up. 2024-10-18T19:25:40.099Z,1729279540.099 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-10-18T19:25:40.107Z,1729279540.107 [Sonardyne_Nano](INFO): Initializing. 2024-10-18T19:25:40.155Z,1729279540.155 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-10-18T19:25:40.176Z,1729279540.176 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-10-18T19:25:40.183Z,1729279540.183 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-10-18T19:25:40.184Z,1729279540.184 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-10-18T19:25:40.191Z,1729279540.191 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-10-18T19:25:40.192Z,1729279540.192 [DockingStepper](INFO): Start 2024-10-18T19:25:40.192Z,1729279540.192 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-10-18T19:25:40.199Z,1729279540.199 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-10-18T19:25:40.199Z,1729279540.199 [MassServo](DEBUG): Initializing EZServoServo. 2024-10-18T19:25:40.207Z,1729279540.207 [MassServo](DEBUG): Initializing MassServo. 2024-10-18T19:25:40.208Z,1729279540.208 [RudderServo](DEBUG): Initializing EZServoServo. 2024-10-18T19:25:40.215Z,1729279540.215 [RudderServo](DEBUG): Initializing RudderServo. 2024-10-18T19:25:40.216Z,1729279540.216 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-10-18T19:25:40.223Z,1729279540.223 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-10-18T19:25:40.483Z,1729279540.483 [DockingStepper](INFO): Starting 2024-10-18T19:25:40.834Z,1729279540.834 [DockingStepper](INFO): Starting 2024-10-18T19:25:41.359Z,1729279541.359 [DockingStepper](INFO): Starting 2024-10-18T19:25:41.407Z,1729279541.407 [DockingStepper](INFO): Init string: /1z15024aE13561N3m50 2024-10-18T19:25:41.606Z,1729279541.606 [WetLabsBB2FL](INFO): Powering down 2024-10-18T19:25:41.651Z,1729279541.651 [DockingStepper](INFO): Starting 2024-10-18T19:25:41.658Z,1729279541.658 [TrnDataBridge](INFO): LCM listener timed out. 2024-10-18T19:25:42.041Z,1729279542.041 [DockingStepper](INFO): Starting 2024-10-18T19:25:42.434Z,1729279542.434 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-10-18T19:25:42.494Z,1729279542.494 [DockingStepper](INFO): Starting 2024-10-18T19:25:42.903Z,1729279542.903 [DockingStepper](INFO): Starting 2024-10-18T19:25:42.927Z,1729279542.927 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-10-18T19:25:43.452Z,1729279543.452 [DockingStepper](INFO): Starting 2024-10-18T19:25:43.688Z,1729279543.688 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-10-18T19:25:44.103Z,1729279544.103 [DockingStepper](INFO): Pause 2024-10-18T19:25:44.158Z,1729279544.158 [TrnDataBridge](INFO): LCM listener timed out. 2024-10-18T19:25:46.658Z,1729279546.658 [TrnDataBridge](INFO): LCM listener timed out. 2024-10-18T19:25:48.290Z,1729279548.290 [WetLabsUBAT](INFO): Powering down 2024-10-18T19:25:49.158Z,1729279549.158 [TrnDataBridge](INFO): LCM listener timed out. 2024-10-18T19:25:51.659Z,1729279551.659 [TrnDataBridge](INFO): LCM listener timed out. 2024-10-18T19:25:51.751Z,1729279551.751 [DAT](INFO): DAT read: 2024-10-18T19:25:51.752Z,1729279551.752 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-10-18T19:25:52.579Z,1729279552.579 [CommandExec](IMPORTANT): got command quit 2024-10-18T19:25:53.517Z,1729279553.517 [DAT](INFO): DAT read: MF Frequency Band 2024-10-18T19:25:53.583Z,1729279553.583 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-10-18T19:25:53.584Z,1729279553.584 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:25:53.584Z,1729279553.584 [CommandExec](INFO): Uninitializing the command executive. 2024-10-18T19:25:53.585Z,1729279553.585 [CommandExec](INFO): Uninitializing the command scheduler. 2024-10-18T19:25:53.586Z,1729279553.586 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:53.768Z,1729279553.768 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-10-18T19:25:53.769Z,1729279553.769 [DAT](INFO): DAT read: Oct 18 2024 19:25:47 2024-10-18T19:25:53.770Z,1729279553.770 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-10-18T19:25:53.771Z,1729279553.771 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-10-18T19:25:53.771Z,1729279553.771 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:53.771Z,1729279553.771 [NavChartDb](INFO): Join timeout helper Thread ID is 5266 2024-10-18T19:25:54.166Z,1729279554.166 [TrnDataBridge](INFO): LCM listener timed out. 2024-10-18T19:25:54.776Z,1729279554.776 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-10-18T19:25:54.777Z,1729279554.777 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2024-10-18T19:25:54.777Z,1729279554.777 [DAT](INFO): commRate: 600 2024-10-18T19:25:56.666Z,1729279556.666 [TrnDataBridge](INFO): LCM listener timed out. 2024-10-18T19:25:56.846Z,1729279556.846 [DAT](INFO): entering command mode 2024-10-18T19:25:57.043Z,1729279557.043 [DAT](INFO): DAT read: 2024-10-18T19:25:57.044Z,1729279557.044 [DAT](INFO): DAT read: user:1> 2024-10-18T19:25:57.044Z,1729279557.044 [DAT](INFO): setting verbose to 3 2024-10-18T19:25:57.295Z,1729279557.295 [DAT](INFO): DAT read: user:1> 2024-10-18T19:25:57.296Z,1729279557.296 [DAT](INFO): DAT read: Verbose | 3 2024-10-18T19:25:57.296Z,1729279557.296 [DAT](INFO): set verbose to 3 2024-10-18T19:25:57.297Z,1729279557.297 [DAT](INFO): setting DatVerbose to 27440 2024-10-18T19:25:57.503Z,1729279557.503 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:25:57.503Z,1729279557.503 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:57.506Z,1729279557.506 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-10-18T19:25:57.507Z,1729279557.507 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:57.507Z,1729279557.507 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 5267 2024-10-18T19:25:57.547Z,1729279557.547 [DAT](INFO): DAT read: user:2> 2024-10-18T19:25:57.548Z,1729279557.548 [DAT](INFO): DAT read: DatVerbose | 27440 2024-10-18T19:25:57.548Z,1729279557.548 [DAT](INFO): set DatVerbose to 27440 2024-10-18T19:25:57.549Z,1729279557.549 [DAT](INFO): setting transmit power to 8 2024-10-18T19:25:57.799Z,1729279557.799 [DAT](INFO): DAT read: user:3> 2024-10-18T19:25:57.800Z,1729279557.800 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-10-18T19:25:57.800Z,1729279557.800 [DAT](INFO): set transmit power to 8 2024-10-18T19:25:57.800Z,1729279557.800 [DAT](INFO): setting local address to 10 2024-10-18T19:25:57.891Z,1729279557.891 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:25:57.891Z,1729279557.891 [WetLabsUBAT](INFO): Powering down 2024-10-18T19:25:57.892Z,1729279557.892 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:57.910Z,1729279557.910 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-10-18T19:25:57.910Z,1729279557.910 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:57.911Z,1729279557.911 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5268 2024-10-18T19:25:58.051Z,1729279558.051 [DAT](INFO): DAT read: user:4> 2024-10-18T19:25:58.052Z,1729279558.052 [DAT](INFO): DAT read: LocalAddr | 10 2024-10-18T19:25:58.052Z,1729279558.052 [DAT](INFO): set local address to 10 2024-10-18T19:25:58.053Z,1729279558.053 [DAT](INFO): Setting time to: 19:25:58 And date to:10/18/2024 2024-10-18T19:25:58.143Z,1729279558.143 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:25:58.143Z,1729279558.143 [WetLabsBB2FL](INFO): Powering down 2024-10-18T19:25:58.144Z,1729279558.144 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:58.162Z,1729279558.162 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-10-18T19:25:58.163Z,1729279558.163 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:58.163Z,1729279558.163 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5269 2024-10-18T19:25:58.303Z,1729279558.303 [DAT](INFO): DAT read: user:5> 2024-10-18T19:25:58.304Z,1729279558.304 [DAT](INFO): DAT read: Fri Oct 18, 2024 19:25:58 2024-10-18T19:25:58.304Z,1729279558.304 [DAT](INFO): Local DAT time set to Fri Oct 18, 2024 19:25:58 2024-10-18T19:25:59.071Z,1729279559.071 [CTD_Seabird](INFO): Powering down 2024-10-18T19:25:59.083Z,1729279559.083 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:25:59.083Z,1729279559.083 [CTD_Seabird](INFO): Powering down 2024-10-18T19:25:59.094Z,1729279559.094 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:59.103Z,1729279559.103 [ComponentRegistry](INFO): Shutting down TrnDataBridge ThreadHandler 2024-10-18T19:25:59.103Z,1729279559.103 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:59.103Z,1729279559.103 [TrnDataBridge](INFO): Join timeout helper Thread ID is 5270 2024-10-18T19:25:59.166Z,1729279559.166 [TrnDataBridge](INFO): LCM listener timed out. 2024-10-18T19:25:59.168Z,1729279559.168 [TrnDataBridge ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:25:59.168Z,1729279559.168 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:59.183Z,1729279559.183 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-10-18T19:25:59.183Z,1729279559.183 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:59.184Z,1729279559.184 [Radio_Surface](INFO): Join timeout helper Thread ID is 5271 2024-10-18T19:25:59.459Z,1729279559.459 [SBIT](IMPORTANT): Beginning Startup BIT 2024-10-18T19:25:59.472Z,1729279559.472 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-18T19:25:59.542Z,1729279559.542 [Radio_Surface](INFO): Powering down 2024-10-18T19:25:59.543Z,1729279559.543 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:25:59.544Z,1729279559.544 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:59.547Z,1729279559.547 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-10-18T19:25:59.547Z,1729279559.547 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:25:59.548Z,1729279559.548 [Onboard](INFO): Join timeout helper Thread ID is 5272 2024-10-18T19:26:03.939Z,1729279563.939 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:26:03.940Z,1729279563.940 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:03.960Z,1729279563.960 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-10-18T19:26:03.960Z,1729279563.960 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:03.960Z,1729279563.960 [DataOverHttps](INFO): Join timeout helper Thread ID is 5275 2024-10-18T19:26:04.007Z,1729279564.007 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:26:04.007Z,1729279564.007 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.015Z,1729279564.015 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-10-18T19:26:04.015Z,1729279564.015 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.015Z,1729279564.015 [DAT](INFO): Join timeout helper Thread ID is 5276 2024-10-18T19:26:04.098Z,1729279564.098 [DAT](INFO): Powering down 2024-10-18T19:26:04.175Z,1729279564.175 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:26:04.175Z,1729279564.175 [DAT](INFO): Powering down 2024-10-18T19:26:04.176Z,1729279564.176 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.177Z,1729279564.177 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-10-18T19:26:04.177Z,1729279564.177 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.178Z,1729279564.178 [BackseatComponent](INFO): Join timeout helper Thread ID is 5277 2024-10-18T19:26:04.187Z,1729279564.187 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:26:04.187Z,1729279564.187 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.203Z,1729279564.203 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-10-18T19:26:04.203Z,1729279564.203 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.204Z,1729279564.204 [logger](INFO): Join timeout helper Thread ID is 5278 2024-10-18T19:26:04.219Z,1729279564.219 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:26:04.219Z,1729279564.219 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.223Z,1729279564.223 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-10-18T19:26:04.223Z,1729279564.223 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.224Z,1729279564.224 [CommandLine](INFO): Join timeout helper Thread ID is 5279 2024-10-18T19:26:04.323Z,1729279564.323 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:26:04.323Z,1729279564.323 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.339Z,1729279564.339 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-10-18T19:26:04.339Z,1729279564.339 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.340Z,1729279564.340 [CommandExec](INFO): Join timeout helper Thread ID is 5280 2024-10-18T19:26:04.341Z,1729279564.341 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-10-18T19:26:04.341Z,1729279564.341 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.341Z,1729279564.341 [controlThread](INFO): Join timeout helper Thread ID is 5281 2024-10-18T19:26:04.356Z,1729279564.356 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-18T19:26:04.357Z,1729279564.357 [controlThread](DEBUG): Uninitializing ControlThread 2024-10-18T19:26:04.357Z,1729279564.357 [AHRS_M2](INFO): Powering down 2024-10-18T19:26:04.428Z,1729279564.428 [NAL9602](INFO): Powering down 2024-10-18T19:26:04.498Z,1729279564.498 [RDI_Pathfinder](INFO): Powering down 2024-10-18T19:26:04.499Z,1729279564.499 [Sonardyne_Nano](INFO): Powering down 2024-10-18T19:26:04.619Z,1729279564.619 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-10-18T19:26:04.620Z,1729279564.620 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-10-18T19:26:04.620Z,1729279564.620 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-10-18T19:26:04.621Z,1729279564.621 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2024-10-18T19:26:04.628Z,1729279564.628 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-10-18T19:26:04.628Z,1729279564.628 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-10-18T19:26:04.629Z,1729279564.629 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-10-18T19:26:04.629Z,1729279564.629 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-10-18T19:26:04.629Z,1729279564.629 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-10-18T19:26:04.629Z,1729279564.629 [BuoyancyServo](INFO): Powering down 2024-10-18T19:26:04.642Z,1729279564.642 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-10-18T19:26:04.643Z,1729279564.643 [ElevatorServo](INFO): Powering down 2024-10-18T19:26:04.643Z,1729279564.643 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-10-18T19:26:04.643Z,1729279564.643 [DockingStepper](INFO): Powering down 2024-10-18T19:26:04.644Z,1729279564.644 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-10-18T19:26:04.644Z,1729279564.644 [MassServo](INFO): Powering down 2024-10-18T19:26:04.645Z,1729279564.645 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-10-18T19:26:04.645Z,1729279564.645 [RudderServo](INFO): Powering down 2024-10-18T19:26:04.646Z,1729279564.646 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-10-18T19:26:04.646Z,1729279564.646 [ThrusterServo](INFO): Powering down 2024-10-18T19:26:04.647Z,1729279564.647 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-10-18T19:26:04.647Z,1729279564.647 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-10-18T19:26:04.648Z,1729279564.648 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-10-18T19:26:04.648Z,1729279564.648 [CBIT](DEBUG): Powering off loads. 2024-10-18T19:26:04.658Z,1729279564.658 [CBIT](DEBUG): Disabling WDT. 2024-10-18T19:26:04.670Z,1729279564.670 [CBIT](DEBUG): Opening all GF detection circuits. 2024-10-18T19:26:04.671Z,1729279564.671 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.734Z,1729279564.734 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.743Z,1729279564.743 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.745Z,1729279564.745 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.750Z,1729279564.750 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.757Z,1729279564.757 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:04.797Z,1729279564.797 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:05.094Z,1729279565.094 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:05.096Z,1729279565.096 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:05.100Z,1729279565.100 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:05.113Z,1729279565.113 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-18T19:26:05.288Z,1729279565.288 [logger ThreadHandler](INFO): Thread cancelled.