2024-09-04T19:42:11.295Z,1725478931.295 [Supervisor](DEBUG): Initializing supervisor. 2024-09-04T19:42:11.299Z,1725478931.299 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-09-04T19:42:11.300Z,1725478931.300 [SyncHandler](INFO): Protected caller Thread ID is 839 2024-09-04T19:42:11.300Z,1725478931.300 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-09-04T19:42:11.301Z,1725478931.301 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-09-04T19:42:11.302Z,1725478931.302 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 840 2024-09-04T19:42:11.305Z,1725478931.305 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-09-04T19:42:11.323Z,1725478931.323 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-09-04T19:42:11.324Z,1725478931.324 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-09-04T19:42:11.324Z,1725478931.324 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 841 2024-09-04T19:42:11.329Z,1725478931.329 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-09-04T19:42:11.330Z,1725478931.330 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-09-04T19:42:11.330Z,1725478931.330 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 842 2024-09-04T19:42:11.332Z,1725478931.332 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-09-04T19:42:11.333Z,1725478931.333 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-09-04T19:42:11.333Z,1725478931.333 [logger ThreadHandler](INFO): Protected caller Thread ID is 843 2024-09-04T19:42:11.337Z,1725478931.337 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-09-04T19:42:11.337Z,1725478931.337 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-09-04T19:42:11.342Z,1725478931.342 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-09-04T19:42:11.451Z,1725478931.451 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-09-04T19:42:11.453Z,1725478931.453 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-09-04T19:42:12.268Z,1725478932.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-09-04T19:42:12.270Z,1725478932.270 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-09-04T19:42:12.526Z,1725478932.526 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-09-04T19:42:12.528Z,1725478932.528 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-09-04T19:42:12.621Z,1725478932.621 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-09-04T19:42:12.768Z,1725478932.768 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-09-04T19:42:12.770Z,1725478932.770 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-09-04T19:42:12.864Z,1725478932.864 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-09-04T19:42:12.986Z,1725478932.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-09-04T19:42:12.988Z,1725478932.988 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-09-04T19:42:13.423Z,1725478933.423 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-09-04T19:42:13.425Z,1725478933.425 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-09-04T19:42:13.999Z,1725478933.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-09-04T19:42:14.001Z,1725478934.001 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-09-04T19:42:14.243Z,1725478934.243 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-09-04T19:42:14.245Z,1725478934.245 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-09-04T19:42:14.454Z,1725478934.454 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-09-04T19:42:14.456Z,1725478934.456 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-09-04T19:42:15.030Z,1725478935.030 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-09-04T19:42:15.589Z,1725478935.589 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-09-04T19:42:16.110Z,1725478936.110 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-09-04T19:42:16.112Z,1725478936.112 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-09-04T19:42:16.620Z,1725478936.620 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-09-04T19:42:16.621Z,1725478936.621 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-09-04T19:42:17.025Z,1725478937.025 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-09-04T19:42:17.025Z,1725478937.025 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-09-04T19:42:17.415Z,1725478937.415 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-09-04T19:42:17.417Z,1725478937.417 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-09-04T19:42:17.419Z,1725478937.419 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-09-04T19:42:17.516Z,1725478937.516 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-09-04T19:42:17.705Z,1725478937.705 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2024-09-04T19:42:17.858Z,1725478937.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-09-04T19:42:17.968Z,1725478937.968 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-09-04T19:42:18.090Z,1725478938.090 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-09-04T19:42:18.189Z,1725478938.189 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-09-04T19:42:18.298Z,1725478938.298 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-09-04T19:42:18.426Z,1725478938.426 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-09-04T19:42:18.704Z,1725478938.704 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-09-04T19:42:18.704Z,1725478938.704 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-09-04T19:42:18.812Z,1725478938.812 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-09-04T19:42:18.918Z,1725478938.918 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-09-04T19:42:19.077Z,1725478939.077 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-09-04T19:42:19.191Z,1725478939.191 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2024-09-04T19:42:19.196Z,1725478939.196 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-09-04T19:42:19.363Z,1725478939.363 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-09-04T19:42:19.364Z,1725478939.364 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-09-04T19:42:19.435Z,1725478939.435 [VerticalControl](DEBUG): Construct VerticalControl. 2024-09-04T19:42:19.496Z,1725478939.496 [VerticalControl] Loaded 2024-09-04T19:42:19.496Z,1725478939.496 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-09-04T19:42:19.499Z,1725478939.499 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-09-04T19:42:19.546Z,1725478939.546 [HorizontalControl] Loaded 2024-09-04T19:42:19.546Z,1725478939.546 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-09-04T19:42:19.549Z,1725478939.549 [SpeedControl](DEBUG): Construct SpeedControl. 2024-09-04T19:42:19.552Z,1725478939.552 [SpeedControl] Loaded 2024-09-04T19:42:19.552Z,1725478939.552 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-09-04T19:42:19.555Z,1725478939.555 [LoopControl](DEBUG): Construct LoopControl. 2024-09-04T19:42:19.555Z,1725478939.555 [LoopControl] Loaded 2024-09-04T19:42:19.555Z,1725478939.555 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-09-04T19:42:19.556Z,1725478939.556 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-09-04T19:42:19.556Z,1725478939.556 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-09-04T19:42:19.626Z,1725478939.626 [DepthRateCalculator] Loaded 2024-09-04T19:42:19.626Z,1725478939.626 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-09-04T19:42:19.631Z,1725478939.631 [PitchRateCalculator] Loaded 2024-09-04T19:42:19.631Z,1725478939.631 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-09-04T19:42:19.641Z,1725478939.641 [SpeedCalculator] Loaded 2024-09-04T19:42:19.641Z,1725478939.641 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-09-04T19:42:19.646Z,1725478939.646 [YawRateCalculator] Loaded 2024-09-04T19:42:19.646Z,1725478939.646 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-09-04T19:42:19.664Z,1725478939.664 [ElevatorOffsetCalculator] Loaded 2024-09-04T19:42:19.665Z,1725478939.665 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-09-04T19:42:19.665Z,1725478939.665 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-09-04T19:42:19.666Z,1725478939.666 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-09-04T19:42:19.709Z,1725478939.709 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-09-04T19:42:19.710Z,1725478939.710 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-09-04T19:42:19.792Z,1725478939.792 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-09-04T19:42:19.793Z,1725478939.793 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-09-04T19:42:20.196Z,1725478940.196 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-09-04T19:42:20.197Z,1725478940.197 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-09-04T19:42:20.411Z,1725478940.411 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-09-04T19:42:20.412Z,1725478940.412 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-09-04T19:42:21.201Z,1725478941.201 [AHRS_M2] Loaded 2024-09-04T19:42:21.201Z,1725478941.201 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-09-04T19:42:21.453Z,1725478941.453 [BackseatComponent] Loaded 2024-09-04T19:42:21.454Z,1725478941.454 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-09-04T19:42:21.455Z,1725478941.455 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409CB4E0 2024-09-04T19:42:21.455Z,1725478941.455 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 931 2024-09-04T19:42:21.458Z,1725478941.458 [LcmUniversalReporter] Loaded 2024-09-04T19:42:21.458Z,1725478941.458 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-09-04T19:42:22.262Z,1725478942.262 [BPC1] Loaded 2024-09-04T19:42:22.263Z,1725478942.263 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-09-04T19:42:22.410Z,1725478942.410 [DataOverHttps] Loaded 2024-09-04T19:42:22.411Z,1725478942.411 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-09-04T19:42:22.412Z,1725478942.412 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409FB4E0 2024-09-04T19:42:22.412Z,1725478942.412 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 932 2024-09-04T19:42:22.435Z,1725478942.435 [Depth_Keller] Loaded 2024-09-04T19:42:22.435Z,1725478942.435 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-09-04T19:42:22.440Z,1725478942.440 [DropWeight] Loaded 2024-09-04T19:42:22.440Z,1725478942.440 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-09-04T19:42:22.505Z,1725478942.505 [NAL9602] Loaded 2024-09-04T19:42:22.505Z,1725478942.505 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-09-04T19:42:22.536Z,1725478942.536 [Onboard] Loaded 2024-09-04T19:42:22.536Z,1725478942.536 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-09-04T19:42:22.537Z,1725478942.537 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A2B4E0 2024-09-04T19:42:22.537Z,1725478942.537 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 933 2024-09-04T19:42:22.551Z,1725478942.551 [Power24vConverter] Loaded 2024-09-04T19:42:22.552Z,1725478942.552 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-09-04T19:42:22.568Z,1725478942.568 [Radio_Surface] Loaded 2024-09-04T19:42:22.568Z,1725478942.568 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-09-04T19:42:22.569Z,1725478942.569 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A5B4E0 2024-09-04T19:42:22.569Z,1725478942.569 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 934 2024-09-04T19:42:22.617Z,1725478942.617 [RDI_Pathfinder] Loaded 2024-09-04T19:42:22.617Z,1725478942.617 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-09-04T19:42:22.632Z,1725478942.632 [Sonardyne_Nano] Loaded 2024-09-04T19:42:22.633Z,1725478942.633 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-09-04T19:42:22.728Z,1725478942.728 [DAT] Loaded 2024-09-04T19:42:22.728Z,1725478942.728 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-09-04T19:42:22.729Z,1725478942.729 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A8B4E0 2024-09-04T19:42:22.729Z,1725478942.729 [DAT ThreadHandler](INFO): Protected caller Thread ID is 935 2024-09-04T19:42:22.730Z,1725478942.730 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-09-04T19:42:22.730Z,1725478942.730 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-09-04T19:42:22.957Z,1725478942.957 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-09-04T19:42:22.958Z,1725478942.958 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-09-04T19:42:22.977Z,1725478942.977 [NavChart] Loaded 2024-09-04T19:42:22.977Z,1725478942.977 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-09-04T19:42:23.010Z,1725478943.010 [UniversalFixResidualReporter] Loaded 2024-09-04T19:42:23.010Z,1725478943.010 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-09-04T19:42:23.011Z,1725478943.011 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-09-04T19:42:23.011Z,1725478943.011 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-09-04T19:42:23.604Z,1725478943.604 [SBIT](DEBUG): Construct Startup Built In Test. 2024-09-04T19:42:23.613Z,1725478943.613 [SBIT] Loaded 2024-09-04T19:42:23.613Z,1725478943.613 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-09-04T19:42:23.616Z,1725478943.616 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-09-04T19:42:23.629Z,1725478943.629 [IBIT] Loaded 2024-09-04T19:42:23.629Z,1725478943.629 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-09-04T19:42:23.635Z,1725478943.635 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-09-04T19:42:23.742Z,1725478943.742 [CBIT] Loaded 2024-09-04T19:42:23.742Z,1725478943.742 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-09-04T19:42:23.743Z,1725478943.743 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-09-04T19:42:23.743Z,1725478943.743 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-09-04T19:42:23.908Z,1725478943.908 [BuoyancyServo] Loaded 2024-09-04T19:42:23.908Z,1725478943.908 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-09-04T19:42:23.931Z,1725478943.931 [ElevatorServo] Loaded 2024-09-04T19:42:23.932Z,1725478943.932 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-09-04T19:42:23.962Z,1725478943.962 [DockingStepper] Loaded 2024-09-04T19:42:23.962Z,1725478943.962 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-09-04T19:42:23.984Z,1725478943.984 [MassServo] Loaded 2024-09-04T19:42:23.984Z,1725478943.984 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-09-04T19:42:24.005Z,1725478944.005 [RudderServo] Loaded 2024-09-04T19:42:24.005Z,1725478944.005 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-09-04T19:42:24.025Z,1725478944.025 [ThrusterServo] Loaded 2024-09-04T19:42:24.025Z,1725478944.025 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-09-04T19:42:24.025Z,1725478944.025 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-09-04T19:42:24.026Z,1725478944.026 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-09-04T19:42:24.042Z,1725478944.042 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-09-04T19:42:24.043Z,1725478944.043 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-09-04T19:42:24.268Z,1725478944.268 [CTD_Seabird] Loaded 2024-09-04T19:42:24.268Z,1725478944.268 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-09-04T19:42:24.269Z,1725478944.269 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BDF4E0 2024-09-04T19:42:24.269Z,1725478944.269 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 937 2024-09-04T19:42:24.292Z,1725478944.292 [PAR_Licor] Loaded 2024-09-04T19:42:24.293Z,1725478944.293 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-09-04T19:42:24.338Z,1725478944.338 [WetLabsBB2FL] Loaded 2024-09-04T19:42:24.338Z,1725478944.338 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-09-04T19:42:24.339Z,1725478944.339 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C0F4E0 2024-09-04T19:42:24.339Z,1725478944.339 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 938 2024-09-04T19:42:24.361Z,1725478944.361 [WetLabsUBAT] Loaded 2024-09-04T19:42:24.361Z,1725478944.361 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-09-04T19:42:24.362Z,1725478944.362 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C3F4E0 2024-09-04T19:42:24.363Z,1725478944.363 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 939 2024-09-04T19:42:24.363Z,1725478944.363 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-09-04T19:42:24.369Z,1725478944.369 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-09-04T19:42:24.372Z,1725478944.372 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-09-04T19:42:24.384Z,1725478944.384 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-09-04T19:42:24.385Z,1725478944.385 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6F4E0 2024-09-04T19:42:24.385Z,1725478944.385 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 940 2024-09-04T19:42:24.389Z,1725478944.389 [Supervisor](INFO): Main Thread ID is 830 2024-09-04T19:42:24.390Z,1725478944.390 [Supervisor](DEBUG): Running supervisor. 2024-09-04T19:42:24.390Z,1725478944.390 [CommandExec ThreadHandler](INFO): Handler Thread ID is 941 2024-09-04T19:42:24.391Z,1725478944.391 [CommandExec](INFO): Initializing the command executive. 2024-09-04T19:42:24.392Z,1725478944.392 [CommandLine ThreadHandler](INFO): Handler Thread ID is 942 2024-09-04T19:42:24.394Z,1725478944.394 [controlThread ThreadHandler](INFO): Handler Thread ID is 943 2024-09-04T19:42:24.395Z,1725478944.395 [controlThread](DEBUG): Initializing ControlThread 2024-09-04T19:42:24.396Z,1725478944.396 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-09-04T19:42:24.397Z,1725478944.397 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-09-04T19:42:24.398Z,1725478944.398 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-09-04T19:42:24.398Z,1725478944.398 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-09-04T19:42:24.399Z,1725478944.399 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-09-04T19:42:24.399Z,1725478944.399 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-09-04T19:42:24.399Z,1725478944.399 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-09-04T19:42:24.400Z,1725478944.400 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-09-04T19:42:24.400Z,1725478944.400 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-09-04T19:42:24.405Z,1725478944.405 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-09-04T19:42:24.405Z,1725478944.405 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-09-04T19:42:24.406Z,1725478944.406 [SBIT](INFO): Initialize SBIT Component. 2024-09-04T19:42:24.406Z,1725478944.406 [SBIT](IMPORTANT): git: 2024-08-29 2024-09-04T19:42:24.406Z,1725478944.406 [SBIT](INFO): git hash: b6a3129d58f87efb4e011c6249ec1e1f26126c7a 2024-09-04T19:42:24.407Z,1725478944.407 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-09-04T19:42:24.408Z,1725478944.408 [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-09-04T19:42:24.409Z,1725478944.409 [SBIT](INFO): Beginning SBIT in 46.000000 seconds. 2024-09-04T19:42:24.409Z,1725478944.409 [IBIT](INFO): Initialize IBIT Component. 2024-09-04T19:42:24.410Z,1725478944.410 [CBIT](DEBUG): Initialize CBIT Component. 2024-09-04T19:42:24.411Z,1725478944.411 [logger ThreadHandler](INFO): Handler Thread ID is 944 2024-09-04T19:42:24.422Z,1725478944.422 [CBIT](DEBUG): Initialized mux pins. 2024-09-04T19:42:24.422Z,1725478944.422 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2024-09-04T19:42:24.422Z,1725478944.422 [CBIT](DEBUG): Initializing the watchdog timer. 2024-09-04T19:42:24.431Z,1725478944.431 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 945 2024-09-04T19:42:24.443Z,1725478944.443 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 946 2024-09-04T19:42:24.444Z,1725478944.444 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-09-04T19:42:24.446Z,1725478944.446 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-09-04T19:42:24.447Z,1725478944.447 [CBIT](DEBUG): Initializing heartbeat. 2024-09-04T19:42:24.455Z,1725478944.455 [Onboard ThreadHandler](INFO): Handler Thread ID is 947 2024-09-04T19:42:24.472Z,1725478944.472 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 948 2024-09-04T19:42:24.491Z,1725478944.491 [DAT ThreadHandler](INFO): Handler Thread ID is 949 2024-09-04T19:42:24.491Z,1725478944.491 [DAT](INFO): Powering up 2024-09-04T19:42:24.492Z,1725478944.492 [DAT](DEBUG): Initializing DAT. 2024-09-04T19:42:24.496Z,1725478944.496 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 951 2024-09-04T19:42:24.497Z,1725478944.497 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-09-04T19:42:24.503Z,1725478944.503 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 953 2024-09-04T19:42:24.507Z,1725478944.507 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 955 2024-09-04T19:42:24.509Z,1725478944.509 [WetLabsBB2FL](INFO): Powering up 2024-09-04T19:42:24.511Z,1725478944.511 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 957 2024-09-04T19:42:24.512Z,1725478944.512 [WetLabsUBAT](INFO): Powering up 2024-09-04T19:42:24.518Z,1725478944.518 [CBIT](DEBUG): Deactivating GF circuits. 2024-09-04T19:42:24.518Z,1725478944.518 [CBIT](DEBUG): Deactivating emergency mode. 2024-09-04T19:42:24.521Z,1725478944.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-09-04T19:42:24.521Z,1725478944.521 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-09-04T19:42:24.521Z,1725478944.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-09-04T19:42:24.521Z,1725478944.521 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-09-04T19:42:24.521Z,1725478944.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-09-04T19:42:24.521Z,1725478944.521 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-09-04T19:42:24.521Z,1725478944.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-09-04T19:42:24.522Z,1725478944.522 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-09-04T19:42:24.558Z,1725478944.558 [CBIT](DEBUG): Backplane powered. 2024-09-04T19:42:24.563Z,1725478944.563 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-09-04T19:42:24.564Z,1725478944.564 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2024-09-04T19:42:24.564Z,1725478944.564 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2024-09-04T19:42:24.573Z,1725478944.573 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2024-09-04T19:42:24.588Z,1725478944.588 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2024-09-04T19:42:24.590Z,1725478944.590 [MissionManager](ERROR): Top node has no child nodes: Mission 2024-09-04T19:42:24.591Z,1725478944.591 [MissionManager](ERROR): Could not load startup mission. 2024-09-04T19:42:24.591Z,1725478944.591 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl 2024-09-04T19:42:24.591Z,1725478944.591 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl 2024-09-04T19:42:24.594Z,1725478944.594 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl 2024-09-04T19:42:24.878Z,1725478944.878 [Radio_Surface](INFO): Powering up 2024-09-04T19:42:25.107Z,1725478945.107 [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-09-04T19:42:25.114Z,1725478945.114 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min 2024-09-04T19:42:25.138Z,1725478945.138 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h 2024-09-04T19:42:25.158Z,1725478945.158 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count 2024-09-04T19:42:25.162Z,1725478945.162 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s 2024-09-04T19:42:25.165Z,1725478945.165 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count 2024-09-04T19:42:25.179Z,1725478945.179 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min 2024-09-04T19:42:25.181Z,1725478945.181 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait. 2024-09-04T19:42:25.336Z,1725478945.336 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct. 2024-09-04T19:42:25.336Z,1725478945.336 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-09-04T19:42:25.390Z,1725478945.390 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-09-04T19:42:25.419Z,1725478945.419 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-09-04T19:42:25.421Z,1725478945.421 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-09-04T19:42:25.443Z,1725478945.443 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute. 2024-09-04T19:42:25.461Z,1725478945.461 [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-09-04T19:42:25.482Z,1725478945.482 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-09-04T19:42:25.489Z,1725478945.489 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-09-04T19:42:25.624Z,1725478945.624 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-09-04T19:42:25.625Z,1725478945.625 [Power24vConverter](INFO): Powering up. 2024-09-04T19:42:25.626Z,1725478945.626 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-09-04T19:42:25.631Z,1725478945.631 [Sonardyne_Nano](INFO): Initializing. 2024-09-04T19:42:25.691Z,1725478945.691 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-09-04T19:42:25.708Z,1725478945.708 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-09-04T19:42:25.715Z,1725478945.715 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-09-04T19:42:25.716Z,1725478945.716 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-09-04T19:42:25.722Z,1725478945.722 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-09-04T19:42:25.723Z,1725478945.723 [DockingStepper](INFO): Start 2024-09-04T19:42:25.724Z,1725478945.724 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-09-04T19:42:25.730Z,1725478945.730 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-09-04T19:42:25.731Z,1725478945.731 [MassServo](DEBUG): Initializing EZServoServo. 2024-09-04T19:42:25.739Z,1725478945.739 [MassServo](DEBUG): Initializing MassServo. 2024-09-04T19:42:25.739Z,1725478945.739 [RudderServo](DEBUG): Initializing EZServoServo. 2024-09-04T19:42:25.747Z,1725478945.747 [RudderServo](DEBUG): Initializing RudderServo. 2024-09-04T19:42:25.747Z,1725478945.747 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-09-04T19:42:25.755Z,1725478945.755 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-09-04T19:42:25.940Z,1725478945.940 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-09-04T19:42:25.940Z,1725478945.940 [DropWeight] Hardware Fault, FailCount= 1 2024-09-04T19:42:25.940Z,1725478945.940 [DropWeight](ERROR): Hardware Fault 2024-09-04T19:42:26.009Z,1725478946.009 [DockingStepper](INFO): Starting 2024-09-04T19:42:26.012Z,1725478946.012 [CommandExec](FAULT): Scheduling is paused 2024-09-04T19:42:26.012Z,1725478946.012 [CBIT](INFO): Critical error at 20240904T194225 2024-09-04T19:42:26.012Z,1725478946.012 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-09-04T19:42:26.023Z,1725478946.023 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-09-04T19:42:26.023Z,1725478946.023 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-09-04T19:42:26.318Z,1725478946.318 [DockingStepper](INFO): Starting 2024-09-04T19:42:26.320Z,1725478946.320 [CBIT](INFO): Critical error at 20240904T194226 2024-09-04T19:42:26.835Z,1725478946.835 [DockingStepper](INFO): Starting 2024-09-04T19:42:26.883Z,1725478946.883 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50 2024-09-04T19:42:27.118Z,1725478947.118 [WetLabsBB2FL](INFO): Powering down 2024-09-04T19:42:27.143Z,1725478947.143 [DockingStepper](INFO): Starting 2024-09-04T19:42:27.563Z,1725478947.563 [DockingStepper](INFO): Starting 2024-09-04T19:42:27.917Z,1725478947.917 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-09-04T19:42:27.950Z,1725478947.950 [DockingStepper](INFO): Starting 2024-09-04T19:42:28.387Z,1725478948.387 [DockingStepper](INFO): Starting 2024-09-04T19:42:28.411Z,1725478948.411 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-09-04T19:42:28.842Z,1725478948.842 [DockingStepper](INFO): Starting 2024-09-04T19:42:29.167Z,1725478949.167 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-09-04T19:42:29.596Z,1725478949.596 [DockingStepper](INFO): Pause 2024-09-04T19:42:30.131Z,1725478950.131 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-09-04T19:42:30.132Z,1725478950.132 [Radio_Surface](INFO): No local IP found 2024-09-04T19:42:33.834Z,1725478953.834 [WetLabsUBAT](INFO): Powering down 2024-09-04T19:42:34.084Z,1725478954.084 [CommandExec](IMPORTANT): got command quit 2024-09-04T19:42:35.086Z,1725478955.086 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:35.086Z,1725478955.086 [CommandExec](INFO): Uninitializing the command executive. 2024-09-04T19:42:35.087Z,1725478955.087 [CommandExec](INFO): Uninitializing the command scheduler. 2024-09-04T19:42:35.087Z,1725478955.087 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:35.130Z,1725478955.130 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-09-04T19:42:35.130Z,1725478955.130 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-09-04T19:42:35.130Z,1725478955.130 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:35.131Z,1725478955.131 [NavChartDb](INFO): Join timeout helper Thread ID is 968 2024-09-04T19:42:38.351Z,1725478958.351 [DAT](INFO): DAT read: 2024-09-04T19:42:38.352Z,1725478958.352 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-09-04T19:42:40.115Z,1725478960.115 [DAT](INFO): DAT read: MF Frequency Band 2024-09-04T19:42:40.116Z,1725478960.116 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-09-04T19:42:40.117Z,1725478960.117 [DAT](INFO): DAT read: Sep 4 2024 19:41:03 2024-09-04T19:42:40.931Z,1725478960.931 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:40.931Z,1725478960.931 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:40.934Z,1725478960.934 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-09-04T19:42:40.934Z,1725478960.934 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:40.935Z,1725478960.935 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 969 2024-09-04T19:42:41.015Z,1725478961.015 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:41.015Z,1725478961.015 [WetLabsUBAT](INFO): Powering down 2024-09-04T19:42:41.016Z,1725478961.016 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.034Z,1725478961.034 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-09-04T19:42:41.034Z,1725478961.034 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.035Z,1725478961.035 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 970 2024-09-04T19:42:41.138Z,1725478961.138 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:41.139Z,1725478961.139 [WetLabsBB2FL](INFO): Powering down 2024-09-04T19:42:41.139Z,1725478961.139 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.154Z,1725478961.154 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-09-04T19:42:41.154Z,1725478961.154 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.155Z,1725478961.155 [CTD_Seabird](INFO): Join timeout helper Thread ID is 971 2024-09-04T19:42:41.375Z,1725478961.375 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-09-04T19:42:41.376Z,1725478961.376 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-09-04T19:42:41.377Z,1725478961.377 [DAT](INFO): commRate: 800 2024-09-04T19:42:41.562Z,1725478961.562 [CTD_Seabird](INFO): Powering down 2024-09-04T19:42:41.574Z,1725478961.574 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:41.574Z,1725478961.574 [CTD_Seabird](INFO): Powering down 2024-09-04T19:42:41.586Z,1725478961.586 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.598Z,1725478961.598 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-09-04T19:42:41.598Z,1725478961.598 [DAT ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.599Z,1725478961.599 [DAT](INFO): Join timeout helper Thread ID is 972 2024-09-04T19:42:41.626Z,1725478961.626 [DAT](INFO): Powering down 2024-09-04T19:42:41.695Z,1725478961.695 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:41.695Z,1725478961.695 [DAT](INFO): Powering down 2024-09-04T19:42:41.696Z,1725478961.696 [DAT ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.711Z,1725478961.711 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-09-04T19:42:41.711Z,1725478961.711 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.712Z,1725478961.712 [Radio_Surface](INFO): Join timeout helper Thread ID is 973 2024-09-04T19:42:41.847Z,1725478961.847 [Radio_Surface](INFO): Powering down 2024-09-04T19:42:41.847Z,1725478961.847 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:41.848Z,1725478961.848 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.863Z,1725478961.863 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-09-04T19:42:41.863Z,1725478961.863 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:41.864Z,1725478961.864 [Onboard](INFO): Join timeout helper Thread ID is 974 2024-09-04T19:42:44.471Z,1725478964.471 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:44.471Z,1725478964.471 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.475Z,1725478964.475 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-09-04T19:42:44.475Z,1725478964.475 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.475Z,1725478964.475 [DataOverHttps](INFO): Join timeout helper Thread ID is 975 2024-09-04T19:42:44.535Z,1725478964.535 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:44.535Z,1725478964.535 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.555Z,1725478964.555 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-09-04T19:42:44.555Z,1725478964.555 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.555Z,1725478964.555 [BackseatComponent](INFO): Join timeout helper Thread ID is 976 2024-09-04T19:42:44.627Z,1725478964.627 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:44.627Z,1725478964.627 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.647Z,1725478964.647 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-09-04T19:42:44.647Z,1725478964.647 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.648Z,1725478964.648 [logger](INFO): Join timeout helper Thread ID is 977 2024-09-04T19:42:44.678Z,1725478964.678 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:44.679Z,1725478964.679 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.687Z,1725478964.687 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-09-04T19:42:44.687Z,1725478964.687 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.687Z,1725478964.687 [CommandLine](INFO): Join timeout helper Thread ID is 978 2024-09-04T19:42:44.731Z,1725478964.731 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:44.731Z,1725478964.731 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.747Z,1725478964.747 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-09-04T19:42:44.747Z,1725478964.747 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.747Z,1725478964.747 [CommandExec](INFO): Join timeout helper Thread ID is 979 2024-09-04T19:42:44.748Z,1725478964.748 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-09-04T19:42:44.749Z,1725478964.749 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:44.749Z,1725478964.749 [controlThread](INFO): Join timeout helper Thread ID is 980 2024-09-04T19:42:44.882Z,1725478964.882 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-04T19:42:44.883Z,1725478964.883 [controlThread](DEBUG): Uninitializing ControlThread 2024-09-04T19:42:44.883Z,1725478964.883 [AHRS_M2](INFO): Powering down 2024-09-04T19:42:44.956Z,1725478964.956 [NAL9602](INFO): Powering down 2024-09-04T19:42:45.026Z,1725478965.026 [RDI_Pathfinder](INFO): Powering down 2024-09-04T19:42:45.027Z,1725478965.027 [Sonardyne_Nano](INFO): Powering down 2024-09-04T19:42:45.147Z,1725478965.147 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-09-04T19:42:45.148Z,1725478965.148 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-09-04T19:42:45.148Z,1725478965.148 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-09-04T19:42:45.149Z,1725478965.149 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2024-09-04T19:42:45.156Z,1725478965.156 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-09-04T19:42:45.157Z,1725478965.157 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-09-04T19:42:45.157Z,1725478965.157 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-09-04T19:42:45.157Z,1725478965.157 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-09-04T19:42:45.158Z,1725478965.158 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-09-04T19:42:45.158Z,1725478965.158 [BuoyancyServo](INFO): Powering down 2024-09-04T19:42:45.170Z,1725478965.170 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-09-04T19:42:45.170Z,1725478965.170 [ElevatorServo](INFO): Powering down 2024-09-04T19:42:45.171Z,1725478965.171 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-09-04T19:42:45.171Z,1725478965.171 [DockingStepper](INFO): Powering down 2024-09-04T19:42:45.172Z,1725478965.172 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-09-04T19:42:45.172Z,1725478965.172 [MassServo](INFO): Powering down 2024-09-04T19:42:45.173Z,1725478965.173 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-04T19:42:45.173Z,1725478965.173 [RudderServo](INFO): Powering down 2024-09-04T19:42:45.174Z,1725478965.174 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-09-04T19:42:45.174Z,1725478965.174 [ThrusterServo](INFO): Powering down 2024-09-04T19:42:45.175Z,1725478965.175 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-09-04T19:42:45.175Z,1725478965.175 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-09-04T19:42:45.176Z,1725478965.176 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-09-04T19:42:45.176Z,1725478965.176 [CBIT](DEBUG): Powering off loads. 2024-09-04T19:42:45.186Z,1725478965.186 [CBIT](DEBUG): Disabling WDT. 2024-09-04T19:42:45.198Z,1725478965.198 [CBIT](DEBUG): Opening all GF detection circuits. 2024-09-04T19:42:45.199Z,1725478965.199 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.260Z,1725478965.260 [DAT ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.268Z,1725478965.268 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.270Z,1725478965.270 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.276Z,1725478965.276 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.322Z,1725478965.322 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.499Z,1725478965.499 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.501Z,1725478965.501 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.505Z,1725478965.505 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.513Z,1725478965.513 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-04T19:42:45.579Z,1725478965.579 [logger ThreadHandler](INFO): Thread cancelled.