2025-06-03T00:17:10.122Z,1748909830.122 [Supervisor](DEBUG): Initializing supervisor.
2025-06-03T00:17:10.127Z,1748909830.127 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-06-03T00:17:10.127Z,1748909830.127 [SyncHandler](INFO): Protected caller Thread ID is 6848
2025-06-03T00:17:10.128Z,1748909830.128 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-06-03T00:17:10.129Z,1748909830.129 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-06-03T00:17:10.130Z,1748909830.130 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6849
2025-06-03T00:17:10.134Z,1748909830.134 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-06-03T00:17:10.154Z,1748909830.154 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-06-03T00:17:10.155Z,1748909830.155 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-06-03T00:17:10.155Z,1748909830.155 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6850
2025-06-03T00:17:10.160Z,1748909830.160 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-06-03T00:17:10.161Z,1748909830.161 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-06-03T00:17:10.161Z,1748909830.161 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6851
2025-06-03T00:17:10.163Z,1748909830.163 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-06-03T00:17:10.164Z,1748909830.164 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-06-03T00:17:10.165Z,1748909830.165 [logger ThreadHandler](INFO): Protected caller Thread ID is 6852
2025-06-03T00:17:10.168Z,1748909830.168 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-06-03T00:17:10.169Z,1748909830.169 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-06-03T00:17:10.170Z,1748909830.170 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-06-03T00:17:10.279Z,1748909830.279 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-06-03T00:17:10.279Z,1748909830.279 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-06-03T00:17:11.024Z,1748909831.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-06-03T00:17:11.024Z,1748909831.024 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-06-03T00:17:11.269Z,1748909831.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-06-03T00:17:11.270Z,1748909831.270 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-06-03T00:17:11.360Z,1748909831.360 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-06-03T00:17:11.504Z,1748909831.504 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-06-03T00:17:11.504Z,1748909831.504 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-06-03T00:17:11.608Z,1748909831.608 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-06-03T00:17:11.608Z,1748909831.608 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-06-03T00:17:11.729Z,1748909831.729 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-06-03T00:17:11.729Z,1748909831.729 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-06-03T00:17:12.146Z,1748909832.146 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-06-03T00:17:12.146Z,1748909832.146 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-06-03T00:17:12.690Z,1748909832.690 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-06-03T00:17:12.690Z,1748909832.690 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-06-03T00:17:12.927Z,1748909832.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-06-03T00:17:12.928Z,1748909832.928 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-06-03T00:17:13.283Z,1748909833.283 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-06-03T00:17:13.283Z,1748909833.283 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-06-03T00:17:13.845Z,1748909833.845 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-06-03T00:17:13.845Z,1748909833.845 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-06-03T00:17:14.145Z,1748909834.145 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-06-03T00:17:14.145Z,1748909834.145 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-06-03T00:17:14.394Z,1748909834.394 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-06-03T00:17:14.395Z,1748909834.395 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-06-03T00:17:14.788Z,1748909834.788 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-06-03T00:17:14.788Z,1748909834.788 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-06-03T00:17:15.147Z,1748909835.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-06-03T00:17:15.149Z,1748909835.149 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2025-06-03T00:17:15.150Z,1748909835.150 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2025-06-03T00:17:15.246Z,1748909835.246 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2025-06-03T00:17:15.424Z,1748909835.424 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg
2025-06-03T00:17:15.541Z,1748909835.541 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg
2025-06-03T00:17:15.647Z,1748909835.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2025-06-03T00:17:15.767Z,1748909835.767 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2025-06-03T00:17:15.866Z,1748909835.866 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2025-06-03T00:17:15.973Z,1748909835.973 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2025-06-03T00:17:16.099Z,1748909836.099 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2025-06-03T00:17:16.376Z,1748909836.376 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-06-03T00:17:16.377Z,1748909836.377 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2025-06-03T00:17:16.472Z,1748909836.472 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2025-06-03T00:17:16.577Z,1748909836.577 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2025-06-03T00:17:16.729Z,1748909836.729 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2025-06-03T00:17:16.836Z,1748909836.836 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-06-03T00:17:16.847Z,1748909836.847 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-06-03T00:17:16.987Z,1748909836.987 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-06-03T00:17:16.987Z,1748909836.987 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-06-03T00:17:17.042Z,1748909837.042 [VerticalControl](DEBUG): Construct VerticalControl.
2025-06-03T00:17:17.103Z,1748909837.103 [VerticalControl] Loaded
2025-06-03T00:17:17.103Z,1748909837.103 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-06-03T00:17:17.106Z,1748909837.106 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-06-03T00:17:17.153Z,1748909837.153 [HorizontalControl] Loaded
2025-06-03T00:17:17.153Z,1748909837.153 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-06-03T00:17:17.156Z,1748909837.156 [SpeedControl](DEBUG): Construct SpeedControl.
2025-06-03T00:17:17.159Z,1748909837.159 [SpeedControl] Loaded
2025-06-03T00:17:17.159Z,1748909837.159 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-06-03T00:17:17.162Z,1748909837.162 [LoopControl](DEBUG): Construct LoopControl.
2025-06-03T00:17:17.162Z,1748909837.162 [LoopControl] Loaded
2025-06-03T00:17:17.162Z,1748909837.162 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-06-03T00:17:17.163Z,1748909837.163 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-06-03T00:17:17.163Z,1748909837.163 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-06-03T00:17:17.216Z,1748909837.216 [DepthRateCalculator] Loaded
2025-06-03T00:17:17.216Z,1748909837.216 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-06-03T00:17:17.221Z,1748909837.221 [PitchRateCalculator] Loaded
2025-06-03T00:17:17.221Z,1748909837.221 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-06-03T00:17:17.231Z,1748909837.231 [SpeedCalculator] Loaded
2025-06-03T00:17:17.231Z,1748909837.231 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-06-03T00:17:17.236Z,1748909837.236 [YawRateCalculator] Loaded
2025-06-03T00:17:17.236Z,1748909837.236 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-06-03T00:17:17.254Z,1748909837.254 [ElevatorOffsetCalculator] Loaded
2025-06-03T00:17:17.255Z,1748909837.255 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-06-03T00:17:17.255Z,1748909837.255 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-06-03T00:17:17.256Z,1748909837.256 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-06-03T00:17:17.286Z,1748909837.286 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-06-03T00:17:17.286Z,1748909837.286 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-06-03T00:17:17.349Z,1748909837.349 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-06-03T00:17:17.349Z,1748909837.349 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-06-03T00:17:17.705Z,1748909837.704 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-06-03T00:17:17.705Z,1748909837.705 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-06-03T00:17:17.886Z,1748909837.886 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-06-03T00:17:17.887Z,1748909837.887 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-06-03T00:17:18.512Z,1748909838.512 [AHRS_M2] Loaded
2025-06-03T00:17:18.513Z,1748909838.513 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-06-03T00:17:18.551Z,1748909838.551 [BackseatComponent] Loaded
2025-06-03T00:17:18.551Z,1748909838.551 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-06-03T00:17:18.552Z,1748909838.552 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409E84E0
2025-06-03T00:17:18.553Z,1748909838.553 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6940
2025-06-03T00:17:18.555Z,1748909838.555 [LcmUniversalReporter] Loaded
2025-06-03T00:17:18.556Z,1748909838.556 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-06-03T00:17:19.372Z,1748909839.372 [BPC1] Loaded
2025-06-03T00:17:19.372Z,1748909839.372 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-06-03T00:17:19.470Z,1748909839.470 [DAT] Loaded
2025-06-03T00:17:19.470Z,1748909839.470 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-06-03T00:17:19.471Z,1748909839.471 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A184E0
2025-06-03T00:17:19.472Z,1748909839.472 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6941
2025-06-03T00:17:19.553Z,1748909839.553 [DataOverHttps] Loaded
2025-06-03T00:17:19.553Z,1748909839.553 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-06-03T00:17:19.554Z,1748909839.554 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A484E0
2025-06-03T00:17:19.555Z,1748909839.555 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6942
2025-06-03T00:17:19.578Z,1748909839.578 [Depth_Keller] Loaded
2025-06-03T00:17:19.578Z,1748909839.578 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-06-03T00:17:19.644Z,1748909839.644 [NAL9602] Loaded
2025-06-03T00:17:19.644Z,1748909839.644 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-06-03T00:17:19.674Z,1748909839.674 [Onboard] Loaded
2025-06-03T00:17:19.674Z,1748909839.674 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-06-03T00:17:19.675Z,1748909839.675 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A784E0
2025-06-03T00:17:19.676Z,1748909839.676 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6943
2025-06-03T00:17:19.690Z,1748909839.690 [Power24vConverter] Loaded
2025-06-03T00:17:19.691Z,1748909839.691 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-06-03T00:17:19.707Z,1748909839.707 [Radio_Surface] Loaded
2025-06-03T00:17:19.707Z,1748909839.707 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-06-03T00:17:19.708Z,1748909839.708 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AA84E0
2025-06-03T00:17:19.708Z,1748909839.708 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6944
2025-06-03T00:17:19.756Z,1748909839.756 [RDI_Pathfinder] Loaded
2025-06-03T00:17:19.756Z,1748909839.756 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2025-06-03T00:17:19.772Z,1748909839.772 [Sonardyne_Nano] Loaded
2025-06-03T00:17:19.772Z,1748909839.772 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-06-03T00:17:19.772Z,1748909839.772 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-06-03T00:17:19.773Z,1748909839.773 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-06-03T00:17:19.888Z,1748909839.888 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-06-03T00:17:19.888Z,1748909839.888 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-06-03T00:17:19.902Z,1748909839.902 [NavChart] Loaded
2025-06-03T00:17:19.902Z,1748909839.902 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-06-03T00:17:19.908Z,1748909839.908 [UniversalFixResidualReporter] Loaded
2025-06-03T00:17:19.908Z,1748909839.908 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-06-03T00:17:19.909Z,1748909839.909 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-06-03T00:17:19.909Z,1748909839.909 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-06-03T00:17:20.078Z,1748909840.078 [SBIT](DEBUG): Construct Startup Built In Test.
2025-06-03T00:17:20.087Z,1748909840.087 [SBIT] Loaded
2025-06-03T00:17:20.087Z,1748909840.087 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-06-03T00:17:20.090Z,1748909840.090 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-06-03T00:17:20.103Z,1748909840.103 [IBIT] Loaded
2025-06-03T00:17:20.103Z,1748909840.103 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-06-03T00:17:20.109Z,1748909840.109 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-06-03T00:17:20.190Z,1748909840.190 [CBIT] Loaded
2025-06-03T00:17:20.190Z,1748909840.190 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-06-03T00:17:20.223Z,1748909840.223 [GFScanner] Loaded
2025-06-03T00:17:20.223Z,1748909840.223 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-06-03T00:17:20.224Z,1748909840.224 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-06-03T00:17:20.224Z,1748909840.224 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-06-03T00:17:20.364Z,1748909840.364 [BuoyancyServo] Loaded
2025-06-03T00:17:20.365Z,1748909840.365 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-06-03T00:17:20.388Z,1748909840.388 [ElevatorServo] Loaded
2025-06-03T00:17:20.388Z,1748909840.388 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-06-03T00:17:20.419Z,1748909840.419 [DockingStepper] Loaded
2025-06-03T00:17:20.419Z,1748909840.419 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread.
2025-06-03T00:17:20.441Z,1748909840.441 [MassServo] Loaded
2025-06-03T00:17:20.441Z,1748909840.441 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-06-03T00:17:20.462Z,1748909840.462 [RudderServo] Loaded
2025-06-03T00:17:20.462Z,1748909840.462 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-06-03T00:17:20.482Z,1748909840.482 [ThrusterServo] Loaded
2025-06-03T00:17:20.482Z,1748909840.482 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2025-06-03T00:17:20.482Z,1748909840.482 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-06-03T00:17:20.483Z,1748909840.483 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-06-03T00:17:20.494Z,1748909840.494 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-06-03T00:17:20.494Z,1748909840.494 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-06-03T00:17:20.670Z,1748909840.670 [CTD_Seabird] Loaded
2025-06-03T00:17:20.670Z,1748909840.670 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-06-03T00:17:20.671Z,1748909840.671 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C0A4E0
2025-06-03T00:17:20.671Z,1748909840.671 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6945
2025-06-03T00:17:20.694Z,1748909840.694 [PAR_Licor] Loaded
2025-06-03T00:17:20.695Z,1748909840.695 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-06-03T00:17:20.740Z,1748909840.740 [WetLabsBB2FL] Loaded
2025-06-03T00:17:20.740Z,1748909840.740 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-06-03T00:17:20.741Z,1748909840.741 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C3A4E0
2025-06-03T00:17:20.742Z,1748909840.742 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6946
2025-06-03T00:17:20.763Z,1748909840.763 [WetLabsUBAT] Loaded
2025-06-03T00:17:20.763Z,1748909840.763 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2025-06-03T00:17:20.764Z,1748909840.764 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C6A4E0
2025-06-03T00:17:20.765Z,1748909840.765 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 6947
2025-06-03T00:17:20.765Z,1748909840.765 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-06-03T00:17:20.772Z,1748909840.772 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-06-03T00:17:20.775Z,1748909840.775 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-06-03T00:17:20.786Z,1748909840.786 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-06-03T00:17:20.787Z,1748909840.787 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C9A4E0
2025-06-03T00:17:20.787Z,1748909840.787 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6948
2025-06-03T00:17:20.792Z,1748909840.792 [Supervisor](INFO): Main Thread ID is 6703
2025-06-03T00:17:20.792Z,1748909840.792 [Supervisor](DEBUG): Running supervisor.
2025-06-03T00:17:20.793Z,1748909840.793 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6949
2025-06-03T00:17:20.793Z,1748909840.793 [CommandExec](INFO): Initializing the command executive.
2025-06-03T00:17:20.795Z,1748909840.795 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6950
2025-06-03T00:17:20.797Z,1748909840.797 [controlThread ThreadHandler](INFO): Handler Thread ID is 6951
2025-06-03T00:17:20.798Z,1748909840.798 [controlThread](DEBUG): Initializing ControlThread
2025-06-03T00:17:20.798Z,1748909840.798 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-06-03T00:17:20.800Z,1748909840.800 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-06-03T00:17:20.801Z,1748909840.801 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-06-03T00:17:20.801Z,1748909840.801 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-06-03T00:17:20.802Z,1748909840.802 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-06-03T00:17:20.802Z,1748909840.802 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-06-03T00:17:20.802Z,1748909840.802 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-06-03T00:17:20.803Z,1748909840.803 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-06-03T00:17:20.803Z,1748909840.803 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-06-03T00:17:20.806Z,1748909840.806 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-06-03T00:17:20.806Z,1748909840.806 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-06-03T00:17:20.807Z,1748909840.807 [SBIT](INFO): Initialize SBIT Component.
2025-06-03T00:17:20.807Z,1748909840.807 [SBIT](IMPORTANT): git: 2025-06-02-8-gec96daa83
2025-06-03T00:17:20.807Z,1748909840.807 [SBIT](INFO): git hash: ec96daa838cb6ac1927da96e62739399b7e6a3fd
2025-06-03T00:17:20.808Z,1748909840.808 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-06-03T00:17:20.809Z,1748909840.809 [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
2025-06-03T00:17:20.810Z,1748909840.810 [SBIT](INFO): Beginning SBIT in 101.000000 seconds.
2025-06-03T00:17:20.811Z,1748909840.811 [IBIT](INFO): Initialize IBIT Component.
2025-06-03T00:17:20.811Z,1748909840.811 [CBIT](DEBUG): Initialize CBIT Component.
2025-06-03T00:17:20.812Z,1748909840.812 [logger ThreadHandler](INFO): Handler Thread ID is 6952
2025-06-03T00:17:20.826Z,1748909840.826 [CBIT](DEBUG): Initialized mux pins.
2025-06-03T00:17:20.826Z,1748909840.826 [CBIT](DEBUG): Initializing the watchdog timer.
2025-06-03T00:17:20.838Z,1748909840.838 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6953
2025-06-03T00:17:20.850Z,1748909840.850 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-06-03T00:17:20.850Z,1748909840.850 [CBIT](DEBUG): Initializing heartbeat.
2025-06-03T00:17:20.851Z,1748909840.851 [DAT ThreadHandler](INFO): Handler Thread ID is 6954
2025-06-03T00:17:20.851Z,1748909840.851 [DAT](INFO): Powering up
2025-06-03T00:17:20.852Z,1748909840.852 [DAT](DEBUG): Initializing DAT.
2025-06-03T00:17:20.858Z,1748909840.858 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6955
2025-06-03T00:17:20.860Z,1748909840.860 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-06-03T00:17:20.878Z,1748909840.878 [Onboard ThreadHandler](INFO): Handler Thread ID is 6956
2025-06-03T00:17:20.896Z,1748909840.896 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6957
2025-06-03T00:17:20.915Z,1748909840.915 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6958
2025-06-03T00:17:20.915Z,1748909840.915 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-06-03T00:17:20.919Z,1748909840.919 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6960
2025-06-03T00:17:20.922Z,1748909840.922 [CBIT](DEBUG): Deactivating emergency mode.
2025-06-03T00:17:20.923Z,1748909840.923 [WetLabsBB2FL](INFO): Powering up
2025-06-03T00:17:20.924Z,1748909840.924 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 6962
2025-06-03T00:17:20.926Z,1748909840.926 [WetLabsUBAT](INFO): Powering up
2025-06-03T00:17:20.927Z,1748909840.927 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6964
2025-06-03T00:17:20.931Z,1748909840.931 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-06-03T00:17:20.931Z,1748909840.931 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-06-03T00:17:20.931Z,1748909840.931 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-06-03T00:17:20.931Z,1748909840.931 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-06-03T00:17:20.932Z,1748909840.932 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-06-03T00:17:20.932Z,1748909840.932 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-06-03T00:17:20.932Z,1748909840.932 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-06-03T00:17:20.932Z,1748909840.932 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-06-03T00:17:20.962Z,1748909840.962 [CBIT](DEBUG): Backplane powered.
2025-06-03T00:17:20.962Z,1748909840.962 [GFScanner](DEBUG): Initializing GFScanner
2025-06-03T00:17:20.962Z,1748909840.962 [GFScanner](DEBUG): Deactivating GF circuits.
2025-06-03T00:17:20.971Z,1748909840.971 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-06-03T00:17:20.972Z,1748909840.972 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl
2025-06-03T00:17:20.972Z,1748909840.972 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl
2025-06-03T00:17:20.973Z,1748909840.973 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl
2025-06-03T00:17:20.983Z,1748909840.983 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="StartupUnder" />

2025-06-03T00:17:20.983Z,1748909840.983 [MissionManager](ERROR): Top node has no child nodes: Mission
2025-06-03T00:17:20.983Z,1748909840.983 [MissionManager](ERROR): Could not load startup mission.
2025-06-03T00:17:20.984Z,1748909840.984 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl
2025-06-03T00:17:20.984Z,1748909840.984 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl
2025-06-03T00:17:20.985Z,1748909840.985 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl
2025-06-03T00:17:21.302Z,1748909841.302 [Radio_Surface](INFO): Powering up
2025-06-03T00:17:21.586Z,1748909841.586 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/DefaultWithUndock.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="DefaultWithUndock">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <DefineArg Name="DetachTimeout">
        <Units:hour />
        <Value>6</Value>
    </DefineArg>
    <DefineArg Name="TransponderCode">
        <Dock:Dock.transponderCode />
    </DefineArg>
    <DefineArg Name="TrackingUpdatePeriod">
        <Units:second />
        <Value>10</Value>
    </DefineArg>
    <DefineArg Name="NumberOfPings">
        <Units:count />
        <Value>1</Value>
    </DefineArg>
    <DefineArg Name="DriftTimeout">
        <Units:minute />
        <Value>3</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>30</Value>
        </Setting>
    </Guidance:Wait>
    <Aggregate Id="LeaveDock">
        <Sequence />
        <Timeout Duration="DetachTimeout">
            <Syslog Severity="Important">
                Timed out while trying to detach from dock at current depth of 
                <Universal:depth />
                <Units:meter />
                .
            </Syslog>
        </Timeout>
        <Estimation:TrackAcousticContact>
            <While>
                <Universal:depth />
                <Gt>
                    <Control:VerticalControl.surfaceThreshold />
                </Gt>
            </While>
            <Setting>
                <Estimation:TrackAcousticContact.contactLabelSetting />
                <Arg Name="TransponderCode" />
            </Setting>
            <Setting>
                <Estimation:TrackAcousticContact.numberOfSamplesSetting />
                <Arg Name="NumberOfPings" />
            </Setting>
            <Setting>
                <Estimation:TrackAcousticContact.updatePeriodSetting />
                <Arg Name="TrackingUpdatePeriod" />
            </Setting>
        </Estimation:TrackAcousticContact>
        <Dock:Undock>
            <Sequence />
            <Setting>
                <Dock:Undock.driftTimeout />
                <Arg Name="DriftTimeout" />
            </Setting>
        </Dock:Undock>
    </Aggregate>
    <Aggregate Id="SurfaceDefault">
        <Sequence />
        <Guidance:GoToSurface>
            <Progression />
        </Guidance:GoToSurface>
        <Aggregate Id="CheckIn">
            <Sequence Repeat="288" />
            <ReadDatum Id="Read_GPS">
                <Timeout Duration="P5M" />
                <Universal:time_fix />
            </ReadDatum>
            <ReadDatum Id="Read_Iridium">
                <Timeout Duration="P2H">
                    <Guidance:Execute>
                        <Sequence />
                        <Setting>
                            <Guidance:Execute.command />
                            <String>Burn on</String>
                        </Setting>
                    </Guidance:Execute>
                    <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
                </Timeout>
                <Universal:platform_communications />
            </ReadDatum>
            <Guidance:Wait>
                <Sequence />
                <Setting>
                    <Guidance:Wait.duration />
                    <Units:minute />
                    <Value>5</Value>
                </Setting>
            </Guidance:Wait>
            <Assign>
                <Sequence />
                <Arg Name="ElapsedSinceDefaultStarted" />
                <Elapsed>
                    <Universal:mission_started />
                </Elapsed>
            </Assign>
            <Syslog Severity="Important">
                Default mission has been running for 
                <Arg Name="ElapsedSinceDefaultStarted" />
                <Units:minute />
            </Syslog>
        </Aggregate>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2025-06-03T00:17:21.609Z,1748909841.609 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2025-06-03T00:17:21.613Z,1748909841.613 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h
2025-06-03T00:17:21.634Z,1748909841.634 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count
2025-06-03T00:17:21.654Z,1748909841.654 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s
2025-06-03T00:17:21.658Z,1748909841.658 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count
2025-06-03T00:17:21.676Z,1748909841.676 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min
2025-06-03T00:17:21.678Z,1748909841.678 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2025-06-03T00:17:21.859Z,1748909841.859 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct.
2025-06-03T00:17:21.859Z,1748909841.859 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-06-03T00:17:21.913Z,1748909841.913 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-06-03T00:17:21.954Z,1748909841.954 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-06-03T00:17:21.956Z,1748909841.956 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-06-03T00:17:21.979Z,1748909841.979 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute.
2025-06-03T00:17:21.000Z,1748909842.000 [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"
  }
}


2025-06-03T00:17:22.005Z,1748909842.005 [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,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-06-03T00:17:22.032Z,1748909842.032 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-06-03T00:17:22.090Z,1748909842.090 [Depth_Keller](INFO): Initializing.
2025-06-03T00:17:22.091Z,1748909842.091 [Power24vConverter](INFO): Powering up.
2025-06-03T00:17:22.092Z,1748909842.092 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-06-03T00:17:22.093Z,1748909842.093 [Sonardyne_Nano](INFO): Initializing.
2025-06-03T00:17:22.119Z,1748909842.119 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-06-03T00:17:22.154Z,1748909842.154 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-06-03T00:17:22.154Z,1748909842.154 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-06-03T00:17:22.155Z,1748909842.155 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-06-03T00:17:22.162Z,1748909842.162 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-06-03T00:17:22.163Z,1748909842.163 [DockingStepper](INFO): Start
2025-06-03T00:17:22.163Z,1748909842.163 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-06-03T00:17:22.163Z,1748909842.163 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-06-03T00:17:22.164Z,1748909842.164 [MassServo](DEBUG): Initializing EZServoServo.
2025-06-03T00:17:22.164Z,1748909842.164 [MassServo](DEBUG): Initializing MassServo.
2025-06-03T00:17:22.165Z,1748909842.165 [RudderServo](DEBUG): Initializing EZServoServo.
2025-06-03T00:17:22.174Z,1748909842.174 [RudderServo](DEBUG): Initializing RudderServo.
2025-06-03T00:17:22.175Z,1748909842.175 [ThrusterServo](DEBUG): Initializing EZServoServo.
2025-06-03T00:17:22.175Z,1748909842.175 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2025-06-03T00:17:22.455Z,1748909842.455 [Depth_Keller](ERROR): Pressure or depth reading out of range: 824.648376 decibar, 0.000000 m
2025-06-03T00:17:22.467Z,1748909842.467 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-06-03T00:17:22.490Z,1748909842.490 [DockingStepper](INFO): Starting
2025-06-03T00:17:22.836Z,1748909842.836 [DockingStepper](INFO): Starting
2025-06-03T00:17:23.366Z,1748909843.366 [DockingStepper](INFO): Starting
2025-06-03T00:17:23.415Z,1748909843.415 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50
2025-06-03T00:17:23.530Z,1748909843.530 [WetLabsBB2FL](INFO): Powering down
2025-06-03T00:17:23.679Z,1748909843.679 [DockingStepper](INFO): Starting
2025-06-03T00:17:24.036Z,1748909844.036 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-06-03T00:17:24.077Z,1748909844.077 [DockingStepper](INFO): Starting
2025-06-03T00:17:24.457Z,1748909844.457 [DockingStepper](INFO): Starting
2025-06-03T00:17:24.954Z,1748909844.954 [DockingStepper](INFO): Starting
2025-06-03T00:17:25.405Z,1748909845.405 [DockingStepper](INFO): Starting
2025-06-03T00:17:25.439Z,1748909845.439 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2025-06-03T00:17:25.695Z,1748909845.695 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103
2025-06-03T00:17:25.744Z,1748909845.744 [DockingStepper](INFO): Starting
2025-06-03T00:17:26.558Z,1748909846.558 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10
2025-06-03T00:17:26.559Z,1748909846.559 [Radio_Surface](INFO): Found local IP address 10.89.10.2 for eth0
2025-06-03T00:17:26.687Z,1748909846.687 [DockingStepper](INFO): Pause
2025-06-03T00:17:30.174Z,1748909850.174 [WetLabsUBAT](INFO): Powering down
2025-06-03T00:17:32.946Z,1748909852.946 [DAT](INFO): DAT read: 

2025-06-03T00:17:32.948Z,1748909852.948 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2025-06-03T00:17:38.491Z,1748909858.491 [DAT](INFO): DAT read: MF Frequency Band

2025-06-03T00:17:38.492Z,1748909858.492 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2

2025-06-03T00:17:38.493Z,1748909858.493 [DAT](INFO): DAT read: Jun  3 2025 00:17:28 

2025-06-03T00:17:39.499Z,1748909859.499 [DAT](INFO): DAT read: Features enabled [Bearing]

2025-06-03T00:17:39.500Z,1748909859.500 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP

2025-06-03T00:17:39.501Z,1748909859.501 [DAT](INFO): commRate: 600
2025-06-03T00:17:41.568Z,1748909861.568 [DAT](INFO): entering command mode
2025-06-03T00:17:41.766Z,1748909861.766 [DAT](INFO): DAT read: 

2025-06-03T00:17:41.767Z,1748909861.767 [DAT](INFO): DAT read: user:1>

2025-06-03T00:17:41.767Z,1748909861.767 [DAT](INFO): setting verbose to 3
2025-06-03T00:17:42.019Z,1748909862.019 [DAT](INFO): DAT read: user:1>

2025-06-03T00:17:42.020Z,1748909862.020 [DAT](INFO): DAT read: Verbose         | 3           

2025-06-03T00:17:42.020Z,1748909862.020 [DAT](INFO): set verbose to 3
2025-06-03T00:17:42.020Z,1748909862.020 [DAT](INFO): setting DatVerbose to 27440
2025-06-03T00:17:42.271Z,1748909862.271 [DAT](INFO): DAT read: user:2>

2025-06-03T00:17:42.272Z,1748909862.272 [DAT](INFO): DAT read: DatVerbose      | 27440       

2025-06-03T00:17:42.272Z,1748909862.272 [DAT](INFO): set DatVerbose to 27440
2025-06-03T00:17:42.272Z,1748909862.272 [DAT](INFO): setting transmit power to 8
2025-06-03T00:17:42.523Z,1748909862.523 [DAT](INFO): DAT read: user:3>

2025-06-03T00:17:42.523Z,1748909862.523 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2025-06-03T00:17:42.524Z,1748909862.524 [DAT](INFO): set transmit power to 8
2025-06-03T00:17:42.524Z,1748909862.524 [DAT](INFO): setting local address to 10
2025-06-03T00:17:42.775Z,1748909862.775 [DAT](INFO): DAT read: user:4>

2025-06-03T00:17:42.775Z,1748909862.775 [DAT](INFO): DAT read: LocalAddr       | 10          

2025-06-03T00:17:42.776Z,1748909862.776 [DAT](INFO): set local address to 10
2025-06-03T00:17:42.777Z,1748909862.777 [DAT](INFO): Setting time to: 0:17:42 And date to:6/3/2025
2025-06-03T00:17:43.026Z,1748909863.026 [DAT](INFO): DAT read: user:5>

2025-06-03T00:17:43.027Z,1748909863.027 [DAT](INFO): DAT read: Tue Jun 3, 2025  00:17:42  

2025-06-03T00:17:43.028Z,1748909863.028 [DAT](INFO): Local DAT time set to Tue Jun 3, 2025  00:17:42  

2025-06-03T00:17:49.895Z,1748909869.895 [NAL9602](INFO): Powering up NAL9602
2025-06-03T00:17:51.982Z,1748909871.982 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:18:00.811Z,1748909880.811 [NAL9602](INFO): NAL9602 initialized
2025-06-03T00:18:23.106Z,1748909903.106 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:18:54.235Z,1748909934.235 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:19:02.290Z,1748909942.290 [SBIT](IMPORTANT): Beginning Startup BIT
2025-06-03T00:19:02.295Z,1748909942.295 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-06-03T00:19:06.778Z,1748909946.778 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010537
CHAN A1 (24V): -0.022171
CHAN A2 (12V): -0.005031
CHAN A3 (5V): -0.002946
CHAN B0 (3.3V): 0.000403
CHAN B1 (3.15aV): -0.000137
CHAN B2 (3.15bV): 0.000558
CHAN B3 (GND): 0.000162
OPEN: 0.004790
Full Scale: +/- 1 mA
2025-06-03T00:19:25.362Z,1748909965.362 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:19:56.065Z,1748909996.065 [SBIT](IMPORTANT): SBIT PASSED
2025-06-03T00:19:56.065Z,1748909996.065 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-06-03T00:19:56.066Z,1748909996.066 [SBIT](IMPORTANT): CBIT.gf24Offset=173 microampere;

2025-06-03T00:19:56.066Z,1748909996.066 [SBIT](IMPORTANT): DockingStepper.closedValue=16450 count;

2025-06-03T00:19:56.066Z,1748909996.066 [SBIT](IMPORTANT): DockingStepper.slideValue=10700 count;

2025-06-03T00:19:56.067Z,1748909996.067 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2025-06-03T00:19:56.067Z,1748909996.067 [SBIT](IMPORTANT): RudderServo.offsetAngle=0.2 degree;

2025-06-03T00:19:56.067Z,1748909996.067 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=460.5 cubic_centimeter;

2025-06-03T00:19:56.067Z,1748909996.067 [SBIT](IMPORTANT): VerticalControl.massDefault=20.377216 millimeter;

2025-06-03T00:19:56.463Z,1748909996.463 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2025-06-03T00:19:56.464Z,1748909996.464 [DefaultWithUndock] Running Loop=1
2025-06-03T00:19:56.464Z,1748909996.464 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2025-06-03T00:19:56.464Z,1748909996.464 [DefaultWithUndock:A.Wait] Running Loop=1
2025-06-03T00:19:56.464Z,1748909996.464 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2025-06-03T00:19:56.487Z,1748909996.487 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:20:04.084Z,1748910004.084 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004636
2025-06-03T00:20:05.082Z,1748910005.082 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:20:13.538Z,1748910013.538 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:20:21.099Z,1748910021.099 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-06-03T00:20:21.099Z,1748910021.099 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-06-03T00:20:21.109Z,1748910021.109 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-06-03T00:20:21.511Z,1748910021.511 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-06-03T00:20:21.511Z,1748910021.511 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-06-03T00:20:21.974Z,1748910021.974 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:20:26.771Z,1748910026.771 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2025-06-03T00:20:26.772Z,1748910026.772 [DefaultWithUndock:A.Wait] Stopped
2025-06-03T00:20:26.772Z,1748910026.772 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2025-06-03T00:20:26.772Z,1748910026.772 [DefaultWithUndock:LeaveDock] Running Loop=1
2025-06-03T00:20:26.772Z,1748910026.772 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock
2025-06-03T00:20:26.772Z,1748910026.772 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2025-06-03T00:20:26.772Z,1748910026.772 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact.
2025-06-03T00:20:26.772Z,1748910026.772 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1
2025-06-03T00:20:26.772Z,1748910026.772 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-06-03T00:20:26.773Z,1748910026.773 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-06-03T00:20:27.176Z,1748910027.176 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-06-03T00:20:27.176Z,1748910027.176 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-06-03T00:20:27.182Z,1748910027.182 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth -0.237607 m.
2025-06-03T00:20:27.182Z,1748910027.182 [DefaultWithUndock:LeaveDock:A.] Stopped
2025-06-03T00:20:27.182Z,1748910027.182 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact.
2025-06-03T00:20:27.187Z,1748910027.187 [DockingStepper](INFO): Resume
2025-06-03T00:20:27.643Z,1748910027.643 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer.
2025-06-03T00:20:27.649Z,1748910027.649 [DockingStepper](INFO): Resuming
2025-06-03T00:20:27.999Z,1748910027.999 [DockingStepper](INFO): Start
2025-06-03T00:20:27.999Z,1748910027.999 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-06-03T00:20:27.000Z,1748910028.000 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-06-03T00:20:28.384Z,1748910028.384 [DockingStepper](INFO): Starting
2025-06-03T00:20:28.777Z,1748910028.777 [DockingStepper](INFO): Starting
2025-06-03T00:20:29.343Z,1748910029.343 [DockingStepper](INFO): Starting
2025-06-03T00:20:29.398Z,1748910029.398 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50
2025-06-03T00:20:29.695Z,1748910029.695 [DockingStepper](INFO): Starting
2025-06-03T00:20:30.055Z,1748910030.055 [DockingStepper](INFO): Starting
2025-06-03T00:20:30.465Z,1748910030.465 [DockingStepper](INFO): Starting
2025-06-03T00:20:30.474Z,1748910030.474 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:20:30.875Z,1748910030.875 [DockingStepper](INFO): Starting
2025-06-03T00:20:30.902Z,1748910030.902 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2025-06-03T00:20:31.255Z,1748910031.255 [DockingStepper](INFO): Starting
2025-06-03T00:20:39.330Z,1748910039.330 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:20:47.797Z,1748910047.797 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning docking module to standby.
2025-06-03T00:20:48.102Z,1748910048.102 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:20:48.190Z,1748910048.190 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Docking module at standby.
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete.
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:LeaveDock:B.Undock] Stopped
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:LeaveDock] Stopped
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:SurfaceDefault] Running Loop=1
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Running Loop=1
2025-06-03T00:20:48.572Z,1748910048.572 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-06-03T00:20:48.573Z,1748910048.573 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-06-03T00:20:48.573Z,1748910048.573 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-06-03T00:20:48.574Z,1748910048.574 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-06-03T00:20:48.574Z,1748910048.574 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-06-03T00:20:48.575Z,1748910048.575 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-06-03T00:20:48.575Z,1748910048.575 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-06-03T00:20:49.036Z,1748910049.036 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1
2025-06-03T00:20:49.036Z,1748910049.036 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-03T00:20:49.037Z,1748910049.037 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-03T00:20:49.199Z,1748910049.199 [DockingStepper](INFO): Pause
2025-06-03T00:20:49.398Z,1748910049.398 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-06-03T00:20:56.734Z,1748910056.734 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:21:06.131Z,1748910066.131 [BuoyancyServo](FAULT): Invalid EZ Servo response:"\r"
2025-06-03T00:21:06.131Z,1748910066.131 [BuoyancyServo] Communications Fault, FailCount= 1
2025-06-03T00:21:06.131Z,1748910066.131 [BuoyancyServo](ERROR): Communications Fault
2025-06-03T00:21:06.131Z,1748910066.131 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2025-06-03T00:21:06.131Z,1748910066.131 [BuoyancyServo] Hardware Fault, FailCount= 1
2025-06-03T00:21:06.131Z,1748910066.131 [BuoyancyServo](ERROR): Hardware Fault
2025-06-03T00:21:06.152Z,1748910066.152 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2025-06-03T00:21:08.047Z,1748910068.047 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-06-03T00:21:08.047Z,1748910068.047 [BuoyancyServo](INFO): Powering down
2025-06-03T00:21:08.838Z,1748910068.838 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-06-03T00:21:08.838Z,1748910068.838 [BuoyancyServo] No Fault, FailCount= 1
2025-06-03T00:21:09.238Z,1748910069.238 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-06-03T00:21:09.238Z,1748910069.238 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-06-03T00:21:10.274Z,1748910070.274 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:21:23.798Z,1748910083.798 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:21:36.954Z,1748910096.954 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:21:49.666Z,1748910109.666 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:21:58.078Z,1748910118.078 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:22:06.594Z,1748910126.594 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:22:15.118Z,1748910135.118 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:22:23.639Z,1748910143.639 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:22:32.166Z,1748910152.166 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:22:40.550Z,1748910160.550 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:22:48.998Z,1748910168.998 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:22:53.967Z,1748910173.967 [CommandExec](IMPORTANT): got command strobe off
2025-06-03T00:22:53.967Z,1748910173.967 [CommandExec](IMPORTANT): Deactivating strobe
2025-06-03T00:22:57.591Z,1748910177.591 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:23:04.767Z,1748910184.767 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-06-03T00:23:06.038Z,1748910186.038 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:23:14.522Z,1748910194.522 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:23:22.182Z,1748910202.182 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-06-03T00:23:22.182Z,1748910202.182 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-06-03T00:23:22.193Z,1748910202.193 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-06-03T00:23:22.575Z,1748910202.575 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-06-03T00:23:22.576Z,1748910202.576 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-06-03T00:23:23.014Z,1748910203.014 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:23:31.487Z,1748910211.487 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:23:40.076Z,1748910220.076 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:23:48.446Z,1748910228.446 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:23:56.918Z,1748910236.918 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:24:05.462Z,1748910245.462 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:24:13.946Z,1748910253.946 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:24:21.913Z,1748910261.913 [CommandExec](IMPORTANT): got command get platform_communications
2025-06-03T00:24:21.913Z,1748910261.913 [CommandExec](FAULT): Element has no value
2025-06-03T00:24:23.191Z,1748910263.191 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:24:31.746Z,1748910271.746 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:24:40.146Z,1748910280.146 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:24:48.542Z,1748910288.542 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:24:57.062Z,1748910297.062 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:25:05.583Z,1748910305.583 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:25:11.747Z,1748910311.747 [CommandExec](IMPORTANT): got command show stack
2025-06-03T00:25:11.748Z,1748910311.747 [CommandExec](IMPORTANT): Behavior Stack:

2025-06-03T00:25:11.748Z,1748910311.748 [DefaultWithUndock:SurfaceDefault](IMPORTANT): Priority 0: DefaultWithUndock:SurfaceDefault:A.GoToSurface
2025-06-03T00:25:11.748Z,1748910311.748 [DefaultWithUndock:SurfaceDefault:CheckIn](IMPORTANT): Priority 1: DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS
2025-06-03T00:25:14.166Z,1748910314.166 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:25:22.614Z,1748910322.614 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:25:31.094Z,1748910331.094 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:25:41.662Z,1748910341.662 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:25:49.244Z,1748910349.244 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](INFO): Timed out from 2025-06-03T00:20:49.0Z
2025-06-03T00:25:49.244Z,1748910349.244 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-03T00:25:49.244Z,1748910349.244 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-03T00:25:49.677Z,1748910349.677 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-06-03T00:25:59.517Z,1748910359.517 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.latitude_fix 36.8 degree
2025-06-03T00:25:59.544Z,1748910359.544 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.latitude_fix" handled in the control thread.
2025-06-03T00:25:59.544Z,1748910359.544 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.longitude_fix -122.9 degree
2025-06-03T00:25:59.552Z,1748910359.552 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.longitude_fix" handled in the control thread.
2025-06-03T00:25:59.553Z,1748910359.553 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1748910261 second
2025-06-03T00:25:59.784Z,1748910359.784 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-06-03T00:26:02.123Z,1748910362.123 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20250522T225235/Courier0004.lzma
2025-06-03T00:26:03.124Z,1748910363.124 [DataOverHttps](INFO): Moved sent file to Logs/20250522T225235/Courier0004.lzma.bak
2025-06-03T00:26:03.124Z,1748910363.124 [DataOverHttps](INFO): SBD MOMSN=25076393
2025-06-03T00:26:26.779Z,1748910386.779 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20250528T002557/Courier0000.lzma
2025-06-03T00:26:27.780Z,1748910387.780 [DataOverHttps](INFO): Moved sent file to Logs/20250528T002557/Courier0000.lzma.bak
2025-06-03T00:26:27.780Z,1748910387.780 [DataOverHttps](INFO): SBD MOMSN=25076395
2025-06-03T00:26:33.240Z,1748910393.240 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-03T00:26:47.738Z,1748910407.738 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250603T001155/Courier0000.lzma
2025-06-03T00:26:48.740Z,1748910408.740 [DataOverHttps](INFO): Moved sent file to Logs/20250603T001155/Courier0000.lzma.bak
2025-06-03T00:26:48.740Z,1748910408.740 [DataOverHttps](INFO): SBD MOMSN=25076398
2025-06-03T00:27:11.126Z,1748910431.126 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250603T001710/Courier0000.lzma
2025-06-03T00:27:12.128Z,1748910432.128 [DataOverHttps](INFO): Moved sent file to Logs/20250603T001710/Courier0000.lzma.bak
2025-06-03T00:27:12.129Z,1748910432.129 [DataOverHttps](INFO): SBD MOMSN=25076401
2025-06-03T00:27:34.175Z,1748910454.175 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20250522T225235/Express0005.lzma
2025-06-03T00:27:35.176Z,1748910455.176 [DataOverHttps](INFO): Moved sent file to Logs/20250522T225235/Express0005.lzma.bak
2025-06-03T00:27:35.176Z,1748910455.176 [DataOverHttps](INFO): SBD MOMSN=25076404
2025-06-03T00:27:59.127Z,1748910479.127 [CommandExec](IMPORTANT): got command docking arm
2025-06-03T00:27:59.128Z,1748910479.128 [CommandExec](IMPORTANT): Switching docking module to ARM.
2025-06-03T00:27:59.797Z,1748910479.797 [DockingStepper](INFO): Resume
2025-06-03T00:28:00.025Z,1748910480.025 [DataOverHttps](INFO): Sending 1176 bytes from file Logs/20250528T002557/Express0001.lzma
2025-06-03T00:28:00.135Z,1748910480.135 [DockingStepper](INFO): Resuming
2025-06-03T00:28:00.529Z,1748910480.529 [DockingStepper](INFO): Start
2025-06-03T00:28:00.530Z,1748910480.530 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-06-03T00:28:00.530Z,1748910480.530 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-06-03T00:28:00.944Z,1748910480.944 [DockingStepper](INFO): Starting
2025-06-03T00:28:01.024Z,1748910481.024 [DataOverHttps](INFO): Moved sent file to Logs/20250528T002557/Express0001.lzma.bak
2025-06-03T00:28:01.024Z,1748910481.024 [DataOverHttps](INFO): SBD MOMSN=25076409
2025-06-03T00:28:01.359Z,1748910481.359 [DockingStepper](INFO): Starting
2025-06-03T00:28:01.834Z,1748910481.834 [DockingStepper](INFO): Starting
2025-06-03T00:28:01.890Z,1748910481.890 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50
2025-06-03T00:28:02.187Z,1748910482.187 [DockingStepper](INFO): Starting
2025-06-03T00:28:02.572Z,1748910482.572 [DockingStepper](INFO): Starting
2025-06-03T00:28:02.984Z,1748910482.984 [DockingStepper](INFO): Starting
2025-06-03T00:28:03.391Z,1748910483.391 [DockingStepper](INFO): Starting
2025-06-03T00:28:03.418Z,1748910483.418 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2025-06-03T00:28:03.862Z,1748910483.862 [DockingStepper](INFO): Starting
2025-06-03T00:28:04.228Z,1748910484.228 [DockingStepper](INFO): Changing to mode: 2
2025-06-03T00:28:04.228Z,1748910484.228 [DockingStepper](INFO): Armed mode.
2025-06-03T00:28:04.290Z,1748910484.290 [DockingStepper](INFO): Commanding negative:54599
2025-06-03T00:28:11.663Z,1748910491.663 [CommandExec](IMPORTANT): got command docking standby
2025-06-03T00:28:11.663Z,1748910491.663 [CommandExec](IMPORTANT): Switching docking module to STANDBY.
2025-06-03T00:28:11.952Z,1748910491.952 [DockingStepper](INFO): Changing to mode: 1
2025-06-03T00:28:11.952Z,1748910491.952 [DockingStepper](INFO): Standby mode.
2025-06-03T00:28:12.022Z,1748910492.022 [DockingStepper](INFO): Commanding positive:54488
2025-06-03T00:28:25.622Z,1748910505.622 [DataOverHttps](INFO): Sending 1175 bytes from file Logs/20250603T001155/Express0001.lzma
2025-06-03T00:28:26.600Z,1748910506.600 [DataOverHttps](INFO): Moved sent file to Logs/20250603T001155/Express0001.lzma.bak
2025-06-03T00:28:26.600Z,1748910506.600 [DataOverHttps](INFO): SBD MOMSN=25076489
2025-06-03T00:28:52.912Z,1748910532.912 [DataOverHttps](INFO): Sending 1282 bytes from file Logs/20250603T001710/Express0001.lzma
2025-06-03T00:28:53.884Z,1748910533.884 [DataOverHttps](INFO): Moved sent file to Logs/20250603T001710/Express0001.lzma.bak
2025-06-03T00:28:53.884Z,1748910533.884 [DataOverHttps](INFO): SBD MOMSN=25076522
2025-06-03T00:29:00.943Z,1748910540.943 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-03T00:29:00.943Z,1748910540.943 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-03T00:29:00.943Z,1748910540.943 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-03T00:29:24.782Z,1748910564.782 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:29:37.007Z,1748910577.007 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:29:46.382Z,1748910586.382 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:29:55.910Z,1748910595.910 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:30:05.603Z,1748910605.603 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:30:15.286Z,1748910615.286 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:30:23.934Z,1748910623.934 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:30:33.338Z,1748910633.338 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:30:42.850Z,1748910642.850 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:30:52.366Z,1748910652.366 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:31:01.805Z,1748910661.805 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA,  0.00,   0.00,   0.00,   0.00
2025-06-03T00:31:01.834Z,1748910661.834 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:31:12.016Z,1748910672.016 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD,        +0.0  +0.00,        +0.00,  20.00,819.99
2025-06-03T00:31:16.158Z,1748910676.158 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:31:21.714Z,1748910681.714 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD,        +0.00,     ,        +0.00,  20.00,829.99
2025-06-03T00:31:32.194Z,1748910692.194 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:31:41.958Z,1748910701.958 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-32768,-32768V
2025-06-03T00:31:44.354Z,1748910704.354 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:31:55.246Z,1748910715.246 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:32:06.518Z,1748910726.518 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:32:16.075Z,1748910736.075 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:32:25.686Z,1748910745.686 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:32:35.142Z,1748910755.142 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:32:44.574Z,1748910764.574 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:32:54.130Z,1748910774.130 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:33:03.624Z,1748910783.624 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:33:13.082Z,1748910793.082 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:33:22.762Z,1748910802.762 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:33:32.286Z,1748910812.286 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:33:41.802Z,1748910821.802 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:33:51.414Z,1748910831.414 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:34:00.994Z,1748910840.994 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:34:01.688Z,1748910841.688 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-03T00:34:01.688Z,1748910841.688 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-03T00:34:01.688Z,1748910841.688 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-03T00:34:01.688Z,1748910841.688 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-03T00:34:02.072Z,1748910842.072 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-03T00:34:02.072Z,1748910842.072 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for  14.093462 min 
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-03T00:34:02.467Z,1748910842.467 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-03T00:34:04.075Z,1748910844.075 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-06-03T00:34:04.075Z,1748910844.075 [NAL9602] Data Fault, FailCount= 1
2025-06-03T00:34:04.075Z,1748910844.075 [NAL9602](ERROR): Data Fault
2025-06-03T00:34:04.171Z,1748910844.171 [CBIT](ERROR): Data Fault in component: NAL9602
2025-06-03T00:34:04.479Z,1748910844.479 [NAL9602](INFO): Powering down
2025-06-03T00:34:05.395Z,1748910845.395 [CBIT](INFO): Clearing failed state for component NAL9602
2025-06-03T00:34:05.395Z,1748910845.395 [NAL9602] No Fault, FailCount= 1
2025-06-03T00:34:10.490Z,1748910850.490 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:34:20.098Z,1748910860.098 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:34:28.526Z,1748910868.526 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:34:34.791Z,1748910874.791 [NAL9602](INFO): Powering up NAL9602
2025-06-03T00:34:38.002Z,1748910878.002 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:34:45.695Z,1748910885.695 [NAL9602](INFO): NAL9602 initialized
2025-06-03T00:34:47.458Z,1748910887.458 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:34:57.126Z,1748910897.126 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:35:06.706Z,1748910906.707 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:35:16.286Z,1748910916.286 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:35:25.802Z,1748910925.802 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:35:34.270Z,1748910934.270 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:35:43.742Z,1748910943.742 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:35:50.567Z,1748910950.567 [CommandExec](IMPORTANT): got command get CBIT.shorePowerOn
2025-06-03T00:35:50.567Z,1748910950.567 [CommandExec](IMPORTANT): CBIT.shorePowerOn 1 bool
2025-06-03T00:35:51.956Z,1748910951.956 [NAL9602](INFO): SBD MO Status=2, MOMSN=47966, MT Status=2, MTMSN=0
2025-06-03T00:35:51.956Z,1748910951.956 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-06-03T00:35:54.902Z,1748910954.902 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:36:00.673Z,1748910960.673 [DockingStepper](ERROR): getADC uart error serial timeout
2025-06-03T00:36:00.673Z,1748910960.673 [DockingStepper](FAULT): uart error - getPosition..serial timeout
2025-06-03T00:36:00.673Z,1748910960.673 [DockingStepper] Communications Fault, FailCount= 1
2025-06-03T00:36:00.673Z,1748910960.673 [DockingStepper](ERROR): Communications Fault
2025-06-03T00:36:00.677Z,1748910960.677 [CBIT](ERROR): Communications Fault in component: DockingStepper
2025-06-03T00:36:00.919Z,1748910960.919 [DockingStepper](INFO): Stop
2025-06-03T00:36:00.919Z,1748910960.919 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2025-06-03T00:36:00.919Z,1748910960.919 [DockingStepper](INFO): Powering down
2025-06-03T00:36:01.288Z,1748910961.288 [DockingStepper](INFO): Stopping
2025-06-03T00:36:01.717Z,1748910961.717 [DockingStepper](INFO): Stopping
2025-06-03T00:36:02.064Z,1748910962.064 [DockingStepper](INFO): Stopping
2025-06-03T00:36:02.489Z,1748910962.489 [DockingStepper](INFO): Stopping
2025-06-03T00:36:02.872Z,1748910962.872 [DockingStepper](INFO): Stopping
2025-06-03T00:36:03.284Z,1748910963.284 [DockingStepper](INFO): Stopping
2025-06-03T00:36:03.711Z,1748910963.711 [DockingStepper](INFO): Stopping
2025-06-03T00:36:04.109Z,1748910964.109 [DockingStepper](INFO): Stopping
2025-06-03T00:36:04.489Z,1748910964.489 [DockingStepper](INFO): Stopping
2025-06-03T00:36:04.490Z,1748910964.490 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:36:04.907Z,1748910964.907 [DockingStepper](INFO): Stopping
2025-06-03T00:36:05.296Z,1748910965.296 [DockingStepper](INFO): Stopping
2025-06-03T00:36:05.719Z,1748910965.719 [DockingStepper](INFO): Stopping
2025-06-03T00:36:06.116Z,1748910966.116 [DockingStepper](INFO): Stopping
2025-06-03T00:36:06.541Z,1748910966.541 [DockingStepper](INFO): Stopping
2025-06-03T00:36:06.941Z,1748910966.941 [DockingStepper](INFO): Stopping
2025-06-03T00:36:07.335Z,1748910967.335 [DockingStepper](INFO): Stopping
2025-06-03T00:36:07.770Z,1748910967.770 [DockingStepper](INFO): Stopping
2025-06-03T00:36:08.128Z,1748910968.128 [DockingStepper](INFO): Stopping
2025-06-03T00:36:08.540Z,1748910968.540 [DockingStepper](INFO): Stopping
2025-06-03T00:36:08.952Z,1748910968.952 [DockingStepper](INFO): Stopping
2025-06-03T00:36:09.365Z,1748910969.365 [DockingStepper](INFO): Stopping
2025-06-03T00:36:09.794Z,1748910969.794 [DockingStepper](INFO): Stopping
2025-06-03T00:36:10.165Z,1748910970.165 [DockingStepper](INFO): Stopping
2025-06-03T00:36:10.568Z,1748910970.568 [DockingStepper](INFO): Stopping
2025-06-03T00:36:10.952Z,1748910970.952 [DockingStepper](INFO): Stopping
2025-06-03T00:36:11.360Z,1748910971.360 [DockingStepper](INFO): Stopping
2025-06-03T00:36:11.780Z,1748910971.780 [DockingStepper](INFO): Stopping
2025-06-03T00:36:12.192Z,1748910972.192 [DockingStepper](INFO): Stopping
2025-06-03T00:36:12.588Z,1748910972.588 [DockingStepper](INFO): Stopping
2025-06-03T00:36:12.988Z,1748910972.988 [DockingStepper](INFO): Stopping
2025-06-03T00:36:13.375Z,1748910973.375 [DockingStepper](INFO): Stopping
2025-06-03T00:36:13.846Z,1748910973.846 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:36:13.879Z,1748910973.879 [DockingStepper](INFO): Stopping
2025-06-03T00:36:14.211Z,1748910974.211 [DockingStepper](INFO): Stopping
2025-06-03T00:36:14.624Z,1748910974.624 [DockingStepper](INFO): Stopping
2025-06-03T00:36:15.016Z,1748910975.016 [DockingStepper](INFO): Stopping
2025-06-03T00:36:15.407Z,1748910975.407 [DockingStepper](INFO): Stopping
2025-06-03T00:36:15.842Z,1748910975.842 [DockingStepper](INFO): Stopping
2025-06-03T00:36:16.229Z,1748910976.229 [DockingStepper](INFO): Stopping
2025-06-03T00:36:16.639Z,1748910976.639 [DockingStepper](INFO): Stopping
2025-06-03T00:36:17.067Z,1748910977.067 [DockingStepper](INFO): Stopping
2025-06-03T00:36:17.433Z,1748910977.433 [DockingStepper](INFO): Stopping
2025-06-03T00:36:17.887Z,1748910977.887 [DockingStepper](INFO): Stopping
2025-06-03T00:36:18.252Z,1748910978.252 [DockingStepper](INFO): Stopping
2025-06-03T00:36:18.636Z,1748910978.636 [DockingStepper](INFO): Stopping
2025-06-03T00:36:19.048Z,1748910979.048 [DockingStepper](INFO): Stopping
2025-06-03T00:36:19.456Z,1748910979.456 [DockingStepper](INFO): Stopping
2025-06-03T00:36:19.914Z,1748910979.914 [DockingStepper](INFO): Stopping
2025-06-03T00:36:20.241Z,1748910980.241 [DockingStepper](INFO): Stopping
2025-06-03T00:36:20.640Z,1748910980.640 [DockingStepper](INFO): Stopping
2025-06-03T00:36:21.076Z,1748910981.076 [DockingStepper](INFO): Stopping
2025-06-03T00:36:21.480Z,1748910981.480 [DockingStepper](INFO): Stopped
2025-06-03T00:36:21.484Z,1748910981.484 [CBIT](INFO): Clearing failed state for component DockingStepper
2025-06-03T00:36:21.484Z,1748910981.484 [DockingStepper] No Fault, FailCount= 1
2025-06-03T00:36:21.917Z,1748910981.917 [DockingStepper](INFO): Start
2025-06-03T00:36:21.917Z,1748910981.917 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-06-03T00:36:21.917Z,1748910981.917 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-06-03T00:36:22.277Z,1748910982.277 [DockingStepper](INFO): Starting
2025-06-03T00:36:22.668Z,1748910982.668 [DockingStepper](INFO): Starting
2025-06-03T00:36:23.065Z,1748910983.065 [DockingStepper](INFO): Starting
2025-06-03T00:36:23.115Z,1748910983.115 [DockingStepper](INFO): Init string: /1z16352aE13561N3m50
2025-06-03T00:36:23.210Z,1748910983.210 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:36:23.488Z,1748910983.488 [DockingStepper](INFO): Starting
2025-06-03T00:36:23.912Z,1748910983.912 [DockingStepper](INFO): Starting
2025-06-03T00:36:24.311Z,1748910984.311 [DockingStepper](INFO): Starting
2025-06-03T00:36:24.696Z,1748910984.696 [DockingStepper](INFO): Starting
2025-06-03T00:36:24.734Z,1748910984.734 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2025-06-03T00:36:25.108Z,1748910985.108 [DockingStepper](INFO): Starting
2025-06-03T00:36:25.534Z,1748910985.534 [DockingStepper](INFO): Changing to mode: 1
2025-06-03T00:36:25.534Z,1748910985.534 [DockingStepper](INFO): Standby mode.
2025-06-03T00:36:33.086Z,1748910993.086 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:36:42.554Z,1748911002.554 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:36:52.090Z,1748911012.090 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:37:00.762Z,1748911020.762 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:37:10.259Z,1748911030.259 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:37:19.722Z,1748911039.722 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:37:29.394Z,1748911049.394 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:37:35.703Z,1748911055.703 [CommandExec](IMPORTANT): got command show stack
2025-06-03T00:37:35.703Z,1748911055.703 [CommandExec](IMPORTANT): Behavior Stack:

2025-06-03T00:37:35.703Z,1748911055.703 [DefaultWithUndock:SurfaceDefault](IMPORTANT): Priority 0: DefaultWithUndock:SurfaceDefault:A.GoToSurface
2025-06-03T00:37:35.704Z,1748911055.704 [DefaultWithUndock:SurfaceDefault:CheckIn](IMPORTANT): Priority 1: DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS
2025-06-03T00:37:39.274Z,1748911059.274 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:37:50.814Z,1748911070.814 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:37:58.379Z,1748911078.379 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1748911055 second
2025-06-03T00:37:58.474Z,1748911078.474 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-03T00:37:58.474Z,1748911078.474 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-03T00:38:03.320Z,1748911083.320 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250603T001710/Courier0004.lzma
2025-06-03T00:38:04.328Z,1748911084.328 [DataOverHttps](INFO): Moved sent file to Logs/20250603T001710/Courier0004.lzma.bak
2025-06-03T00:38:04.328Z,1748911084.328 [DataOverHttps](INFO): SBD MOMSN=25076586
2025-06-03T00:38:29.266Z,1748911109.266 [DataOverHttps](INFO): Sending 717 bytes from file Logs/20250603T001710/Express0005.lzma
2025-06-03T00:38:30.252Z,1748911110.252 [DataOverHttps](INFO): Moved sent file to Logs/20250603T001710/Express0005.lzma.bak
2025-06-03T00:38:30.252Z,1748911110.252 [DataOverHttps](INFO): SBD MOMSN=25076589
2025-06-03T00:38:36.974Z,1748911116.974 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-03T00:38:36.974Z,1748911116.974 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-03T00:38:36.974Z,1748911116.974 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-03T00:39:03.066Z,1748911143.066 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:39:12.698Z,1748911152.698 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:39:22.278Z,1748911162.278 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:39:31.978Z,1748911171.978 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:39:41.415Z,1748911181.415 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:39:49.431Z,1748911189.431 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-06-03T00:39:51.078Z,1748911191.078 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:40:00.746Z,1748911200.746 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:40:10.335Z,1748911210.335 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:40:19.786Z,1748911219.786 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:40:20.109Z,1748911220.109 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-03T00:40:30.254Z,1748911230.254 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:40:39.627Z,1748911239.627 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:40:49.070Z,1748911249.070 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:40:58.570Z,1748911258.570 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:41:08.027Z,1748911268.027 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:41:22.450Z,1748911282.450 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:41:37.926Z,1748911297.926 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:41:50.802Z,1748911310.802 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:42:00.102Z,1748911320.102 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:42:09.370Z,1748911329.370 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:42:19.448Z,1748911339.448 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:42:28.982Z,1748911348.982 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:42:38.466Z,1748911358.466 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:42:47.918Z,1748911367.918 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:42:57.458Z,1748911377.458 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:43:07.002Z,1748911387.002 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:43:16.470Z,1748911396.470 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:43:26.088Z,1748911406.088 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:43:35.526Z,1748911415.526 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:43:37.502Z,1748911417.502 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-03T00:43:37.503Z,1748911417.503 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-03T00:43:37.503Z,1748911417.503 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-03T00:43:37.503Z,1748911417.503 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-03T00:43:37.969Z,1748911417.969 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-03T00:43:37.969Z,1748911417.969 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for  23.691754 min 
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #3
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=3
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-03T00:43:38.319Z,1748911418.319 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-03T00:43:45.138Z,1748911425.138 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:43:53.643Z,1748911433.643 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:44:03.274Z,1748911443.274 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:44:11.019Z,1748911451.019 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-06-03T00:44:11.094Z,1748911451.094 [NAL9602](ERROR): received: 
+CSQ:0

OK966, 2, 0, 0, 0

OK
2025-06-03T00:44:12.767Z,1748911452.767 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:44:22.422Z,1748911462.422 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:44:31.898Z,1748911471.898 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:44:41.322Z,1748911481.322 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:44:50.998Z,1748911490.998 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:44:59.643Z,1748911499.643 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:45:09.162Z,1748911509.162 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:45:18.714Z,1748911518.714 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:45:28.244Z,1748911528.244 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:45:37.942Z,1748911537.942 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:45:47.503Z,1748911547.503 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:45:57.114Z,1748911557.114 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:46:06.870Z,1748911566.870 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:46:16.558Z,1748911576.558 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:46:26.134Z,1748911586.134 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:46:35.587Z,1748911595.587 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:46:45.318Z,1748911605.318 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:46:55.047Z,1748911615.047 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:47:04.482Z,1748911624.482 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:47:14.066Z,1748911634.066 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:47:23.730Z,1748911643.730 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:47:33.354Z,1748911653.354 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:47:42.902Z,1748911662.902 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:47:52.638Z,1748911672.638 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:48:02.171Z,1748911682.171 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:48:11.754Z,1748911691.754 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:48:21.283Z,1748911701.283 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:48:22.371Z,1748911702.371 [BPC1](INFO): Calculating totals. Valid battery stick count: 42. Valid reserve battery stick count: 5.
2025-06-03T00:48:22.374Z,1748911702.374 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2025-06-03T00:48:30.866Z,1748911710.866 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:48:38.543Z,1748911718.543 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](INFO): Timed out from 2025-06-03T00:43:38.3Z
2025-06-03T00:48:38.543Z,1748911718.543 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-03T00:48:38.543Z,1748911718.543 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-03T00:48:42.592Z,1748911722.592 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-06-03T00:48:49.906Z,1748911729.906 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20250603T001710/Courier0007.lzma
2025-06-03T00:48:50.908Z,1748911730.908 [DataOverHttps](INFO): Moved sent file to Logs/20250603T001710/Courier0007.lzma.bak
2025-06-03T00:48:50.908Z,1748911730.908 [DataOverHttps](INFO): SBD MOMSN=25076671
2025-06-03T00:49:13.279Z,1748911753.279 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-03T00:49:15.624Z,1748911755.624 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20250603T001710/Express0008.lzma
2025-06-03T00:49:16.608Z,1748911756.608 [DataOverHttps](INFO): Moved sent file to Logs/20250603T001710/Express0008.lzma.bak
2025-06-03T00:49:16.608Z,1748911756.608 [DataOverHttps](INFO): SBD MOMSN=25076680
2025-06-03T00:49:23.409Z,1748911763.409 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-03T00:49:23.414Z,1748911763.414 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-03T00:49:23.414Z,1748911763.414 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-03T00:49:37.934Z,1748911777.934 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-32768,-3268,V
2025-06-03T00:49:49.786Z,1748911789.786 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:49:59.206Z,1748911799.206 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:50:07.678Z,1748911807.678 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:50:17.218Z,1748911817.218 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:50:26.698Z,1748911826.698 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-03T00:50:29.942Z,1748911829.942 [CommandExec](IMPORTANT): got command quit
2025-06-03T00:50:30.946Z,1748911830.946 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2025-06-03T00:50:30.946Z,1748911830.946 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:30.946Z,1748911830.946 [CommandExec](INFO): Uninitializing the command executive.
2025-06-03T00:50:30.947Z,1748911830.947 [CommandExec](INFO): Uninitializing the command scheduler.
2025-06-03T00:50:30.947Z,1748911830.947 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:30.966Z,1748911830.966 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-06-03T00:50:30.966Z,1748911830.966 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-06-03T00:50:30.966Z,1748911830.966 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:30.967Z,1748911830.967 [NavChartDb](INFO): Join timeout helper Thread ID is 6990
2025-06-03T00:50:31.038Z,1748911831.038 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:31.038Z,1748911831.038 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.054Z,1748911831.054 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler
2025-06-03T00:50:31.054Z,1748911831.054 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.054Z,1748911831.054 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 6991
2025-06-03T00:50:31.414Z,1748911831.414 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:31.414Z,1748911831.414 [WetLabsUBAT](INFO): Powering down
2025-06-03T00:50:31.417Z,1748911831.417 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.434Z,1748911831.434 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-06-03T00:50:31.434Z,1748911831.434 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.434Z,1748911831.434 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6992
2025-06-03T00:50:31.470Z,1748911831.470 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:31.470Z,1748911831.470 [WetLabsBB2FL](INFO): Powering down
2025-06-03T00:50:31.471Z,1748911831.471 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.475Z,1748911831.475 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-06-03T00:50:31.475Z,1748911831.475 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.475Z,1748911831.475 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6993
2025-06-03T00:50:31.702Z,1748911831.702 [CTD_Seabird](INFO): Powering down
2025-06-03T00:50:31.714Z,1748911831.714 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:31.714Z,1748911831.714 [CTD_Seabird](INFO): Powering down
2025-06-03T00:50:31.726Z,1748911831.726 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.734Z,1748911831.734 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-06-03T00:50:31.734Z,1748911831.734 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.734Z,1748911831.734 [Radio_Surface](INFO): Join timeout helper Thread ID is 6994
2025-06-03T00:50:31.858Z,1748911831.858 [Radio_Surface](INFO): Powering down
2025-06-03T00:50:31.859Z,1748911831.859 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:31.859Z,1748911831.859 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.875Z,1748911831.875 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-06-03T00:50:31.875Z,1748911831.875 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:31.875Z,1748911831.875 [Onboard](INFO): Join timeout helper Thread ID is 6995
2025-06-03T00:50:32.630Z,1748911832.630 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:32.631Z,1748911832.631 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:32.643Z,1748911832.643 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-06-03T00:50:32.643Z,1748911832.643 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:32.643Z,1748911832.643 [DataOverHttps](INFO): Join timeout helper Thread ID is 6996
2025-06-03T00:50:33.170Z,1748911833.170 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:33.173Z,1748911833.173 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.186Z,1748911833.186 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-06-03T00:50:33.187Z,1748911833.187 [DAT ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.187Z,1748911833.187 [DAT](INFO): Join timeout helper Thread ID is 6997
2025-06-03T00:50:33.402Z,1748911833.402 [DAT](INFO): Powering down
2025-06-03T00:50:33.403Z,1748911833.403 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:33.403Z,1748911833.403 [DAT](INFO): Powering down
2025-06-03T00:50:33.404Z,1748911833.404 [DAT ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.410Z,1748911833.410 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-06-03T00:50:33.410Z,1748911833.410 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.411Z,1748911833.411 [BackseatComponent](INFO): Join timeout helper Thread ID is 6998
2025-06-03T00:50:33.579Z,1748911833.579 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:33.580Z,1748911833.580 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.596Z,1748911833.596 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-06-03T00:50:33.597Z,1748911833.597 [logger ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.598Z,1748911833.598 [logger](INFO): Join timeout helper Thread ID is 6999
2025-06-03T00:50:33.623Z,1748911833.623 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:33.624Z,1748911833.624 [logger ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.641Z,1748911833.641 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-06-03T00:50:33.641Z,1748911833.641 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.643Z,1748911833.643 [CommandLine](INFO): Join timeout helper Thread ID is 7000
2025-06-03T00:50:33.650Z,1748911833.650 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:33.650Z,1748911833.650 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.675Z,1748911833.675 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-06-03T00:50:33.675Z,1748911833.675 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.675Z,1748911833.675 [CommandExec](INFO): Join timeout helper Thread ID is 7001
2025-06-03T00:50:33.682Z,1748911833.682 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-06-03T00:50:33.683Z,1748911833.683 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.683Z,1748911833.683 [controlThread](INFO): Join timeout helper Thread ID is 7002
2025-06-03T00:50:33.768Z,1748911833.768 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-03T00:50:33.769Z,1748911833.769 [controlThread](DEBUG): Uninitializing ControlThread
2025-06-03T00:50:33.769Z,1748911833.769 [AHRS_M2](INFO): Powering down
2025-06-03T00:50:33.778Z,1748911833.778 [NAL9602](INFO): Powering down
2025-06-03T00:50:33.779Z,1748911833.779 [RDI_Pathfinder](INFO): Powering down
2025-06-03T00:50:33.780Z,1748911833.780 [Sonardyne_Nano](INFO): Powering down
2025-06-03T00:50:33.782Z,1748911833.782 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-06-03T00:50:33.783Z,1748911833.783 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-06-03T00:50:33.784Z,1748911833.784 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-06-03T00:50:33.786Z,1748911833.786 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock
2025-06-03T00:50:33.787Z,1748911833.787 [DefaultWithUndock] Stopped
2025-06-03T00:50:33.787Z,1748911833.787 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2025-06-03T00:50:33.787Z,1748911833.787 [DefaultWithUndock:SurfaceDefault] Stopped
2025-06-03T00:50:33.788Z,1748911833.788 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault
2025-06-03T00:50:33.788Z,1748911833.788 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Stopped
2025-06-03T00:50:33.789Z,1748911833.789 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-06-03T00:50:33.789Z,1748911833.789 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-03T00:50:33.789Z,1748911833.789 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-03T00:50:33.790Z,1748911833.790 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-03T00:50:33.790Z,1748911833.790 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-03T00:50:33.798Z,1748911833.798 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-06-03T00:50:33.798Z,1748911833.798 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-06-03T00:50:33.799Z,1748911833.799 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-06-03T00:50:33.799Z,1748911833.799 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-06-03T00:50:33.799Z,1748911833.799 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-06-03T00:50:33.799Z,1748911833.799 [BuoyancyServo](INFO): Powering down
2025-06-03T00:50:33.814Z,1748911833.814 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-06-03T00:50:33.814Z,1748911833.814 [ElevatorServo](INFO): Powering down
2025-06-03T00:50:33.815Z,1748911833.815 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2025-06-03T00:50:33.815Z,1748911833.815 [DockingStepper](INFO): Powering down
2025-06-03T00:50:33.816Z,1748911833.816 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-06-03T00:50:33.816Z,1748911833.816 [MassServo](INFO): Powering down
2025-06-03T00:50:33.817Z,1748911833.817 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-06-03T00:50:33.817Z,1748911833.817 [RudderServo](INFO): Powering down
2025-06-03T00:50:33.817Z,1748911833.817 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2025-06-03T00:50:33.818Z,1748911833.818 [ThrusterServo](INFO): Powering down
2025-06-03T00:50:33.818Z,1748911833.818 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-06-03T00:50:33.819Z,1748911833.819 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-06-03T00:50:33.819Z,1748911833.819 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-06-03T00:50:33.819Z,1748911833.819 [CBIT](DEBUG): Powering off loads.
2025-06-03T00:50:33.830Z,1748911833.830 [CBIT](DEBUG): Disabling WDT.
2025-06-03T00:50:33.842Z,1748911833.842 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-06-03T00:50:33.842Z,1748911833.842 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-06-03T00:50:33.843Z,1748911833.843 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.901Z,1748911833.901 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.904Z,1748911833.904 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.910Z,1748911833.910 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.916Z,1748911833.916 [DAT ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.959Z,1748911833.959 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:33.996Z,1748911833.996 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-06-03T00:50:33.996Z,1748911833.996 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-06-03T00:50:34.025Z,1748911834.025 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:34.027Z,1748911834.027 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:34.032Z,1748911834.032 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:34.041Z,1748911834.041 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-06-03T00:50:34.117Z,1748911834.117 [logger ThreadHandler](INFO): Thread cancelled.