2025-04-28T17:25:23.069Z,1745861123.069 [Supervisor](DEBUG): Initializing supervisor.
2025-04-28T17:25:23.073Z,1745861123.073 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-04-28T17:25:23.073Z,1745861123.073 [SyncHandler](INFO): Protected caller Thread ID is 1282
2025-04-28T17:25:23.074Z,1745861123.074 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-04-28T17:25:23.075Z,1745861123.075 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-04-28T17:25:23.075Z,1745861123.075 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1283
2025-04-28T17:25:23.079Z,1745861123.079 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-04-28T17:25:23.100Z,1745861123.100 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-04-28T17:25:23.101Z,1745861123.101 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-04-28T17:25:23.101Z,1745861123.101 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1284
2025-04-28T17:25:23.105Z,1745861123.105 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-04-28T17:25:23.106Z,1745861123.106 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-04-28T17:25:23.107Z,1745861123.107 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1285
2025-04-28T17:25:23.109Z,1745861123.109 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-04-28T17:25:23.110Z,1745861123.110 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-04-28T17:25:23.110Z,1745861123.110 [logger ThreadHandler](INFO): Protected caller Thread ID is 1286
2025-04-28T17:25:23.114Z,1745861123.114 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-04-28T17:25:23.115Z,1745861123.115 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-04-28T17:25:23.116Z,1745861123.116 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-04-28T17:25:23.467Z,1745861123.467 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-04-28T17:25:23.467Z,1745861123.467 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-04-28T17:25:23.750Z,1745861123.750 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-04-28T17:25:23.750Z,1745861123.750 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-04-28T17:25:24.264Z,1745861124.264 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-04-28T17:25:24.265Z,1745861124.265 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-04-28T17:25:24.512Z,1745861124.512 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-04-28T17:25:24.513Z,1745861124.513 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-04-28T17:25:24.826Z,1745861124.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-04-28T17:25:24.827Z,1745861124.827 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-04-28T17:25:25.661Z,1745861125.661 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-04-28T17:25:25.662Z,1745861125.662 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-04-28T17:25:26.024Z,1745861126.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-04-28T17:25:26.024Z,1745861126.024 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-04-28T17:25:26.147Z,1745861126.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-04-28T17:25:26.148Z,1745861126.148 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-04-28T17:25:26.238Z,1745861126.238 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-04-28T17:25:26.435Z,1745861126.435 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-04-28T17:25:26.436Z,1745861126.436 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-04-28T17:25:26.544Z,1745861126.544 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-04-28T17:25:26.544Z,1745861126.544 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-04-28T17:25:26.779Z,1745861126.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-04-28T17:25:26.780Z,1745861126.780 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-04-28T17:25:26.930Z,1745861126.930 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-04-28T17:25:26.931Z,1745861126.931 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-04-28T17:25:27.023Z,1745861127.023 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-04-28T17:25:27.467Z,1745861127.467 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-04-28T17:25:27.467Z,1745861127.467 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-04-28T17:25:28.068Z,1745861128.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-04-28T17:25:28.071Z,1745861128.071 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2025-04-28T17:25:28.071Z,1745861128.071 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2025-04-28T17:25:28.603Z,1745861128.603 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2025-04-28T17:25:29.076Z,1745861129.076 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-04-28T17:25:29.077Z,1745861129.077 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2025-04-28T17:25:29.191Z,1745861129.191 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2025-04-28T17:25:29.299Z,1745861129.299 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2025-04-28T17:25:29.420Z,1745861129.420 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2025-04-28T17:25:29.563Z,1745861129.563 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2025-04-28T17:25:29.674Z,1745861129.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2025-04-28T17:25:29.795Z,1745861129.795 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2025-04-28T17:25:29.890Z,1745861129.890 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2025-04-28T17:25:30.017Z,1745861130.017 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2025-04-28T17:25:30.114Z,1745861130.114 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/root/
2025-04-28T17:25:30.115Z,1745861130.115 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-04-28T17:25:30.122Z,1745861130.122 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-04-28T17:25:30.133Z,1745861130.133 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-04-28T17:25:30.133Z,1745861130.133 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-04-28T17:25:30.250Z,1745861130.250 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-04-28T17:25:30.250Z,1745861130.250 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-04-28T17:25:30.290Z,1745861130.290 [DeadReckonWithRespectToSeafloor] Loaded
2025-04-28T17:25:30.290Z,1745861130.290 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2025-04-28T17:25:30.303Z,1745861130.303 [NavChart] Loaded
2025-04-28T17:25:30.304Z,1745861130.304 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-04-28T17:25:30.309Z,1745861130.309 [UniversalFixResidualReporter] Loaded
2025-04-28T17:25:30.310Z,1745861130.310 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-04-28T17:25:30.310Z,1745861130.310 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-04-28T17:25:30.311Z,1745861130.311 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-04-28T17:25:30.805Z,1745861130.805 [AHRS_M2] Loaded
2025-04-28T17:25:30.805Z,1745861130.805 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-04-28T17:25:30.844Z,1745861130.844 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3
2025-04-28T17:25:30.844Z,1745861130.844 [BackseatComponent] Loaded
2025-04-28T17:25:30.845Z,1745861130.845 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-04-28T17:25:30.846Z,1745861130.846 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085D4E0
2025-04-28T17:25:30.846Z,1745861130.846 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1369
2025-04-28T17:25:30.849Z,1745861130.849 [LcmUniversalReporter] Loaded
2025-04-28T17:25:30.849Z,1745861130.849 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-04-28T17:25:30.946Z,1745861130.946 [DAT] Loaded
2025-04-28T17:25:30.946Z,1745861130.946 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-04-28T17:25:30.947Z,1745861130.947 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088D4E0
2025-04-28T17:25:30.948Z,1745861130.948 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1370
2025-04-28T17:25:31.021Z,1745861131.021 [DataOverHttps] Loaded
2025-04-28T17:25:31.022Z,1745861131.022 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-04-28T17:25:31.023Z,1745861131.023 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2025-04-28T17:25:31.023Z,1745861131.023 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1371
2025-04-28T17:25:31.045Z,1745861131.045 [DepthKeller33X] Loaded
2025-04-28T17:25:31.045Z,1745861131.045 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
2025-04-28T17:25:31.110Z,1745861131.110 [NAL9602] Loaded
2025-04-28T17:25:31.110Z,1745861131.110 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-04-28T17:25:31.140Z,1745861131.140 [Onboard] Loaded
2025-04-28T17:25:31.141Z,1745861131.141 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-04-28T17:25:31.142Z,1745861131.142 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2025-04-28T17:25:31.142Z,1745861131.142 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1372
2025-04-28T17:25:31.156Z,1745861131.156 [Power24vConverter] Loaded
2025-04-28T17:25:31.157Z,1745861131.157 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-04-28T17:25:31.174Z,1745861131.174 [Radio_Surface] Loaded
2025-04-28T17:25:31.174Z,1745861131.174 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-04-28T17:25:31.175Z,1745861131.175 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2025-04-28T17:25:31.175Z,1745861131.175 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1373
2025-04-28T17:25:31.222Z,1745861131.222 [RDI_Pathfinder] Loaded
2025-04-28T17:25:31.222Z,1745861131.222 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2025-04-28T17:25:31.223Z,1745861131.223 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-04-28T17:25:31.224Z,1745861131.224 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-04-28T17:25:31.277Z,1745861131.277 [DepthRateCalculator] Loaded
2025-04-28T17:25:31.278Z,1745861131.278 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-04-28T17:25:31.283Z,1745861131.283 [PitchRateCalculator] Loaded
2025-04-28T17:25:31.283Z,1745861131.283 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-04-28T17:25:31.292Z,1745861131.292 [SpeedCalculator] Loaded
2025-04-28T17:25:31.293Z,1745861131.293 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-04-28T17:25:31.298Z,1745861131.298 [YawRateCalculator] Loaded
2025-04-28T17:25:31.298Z,1745861131.298 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-04-28T17:25:31.320Z,1745861131.320 [ElevatorOffsetCalculator] Loaded
2025-04-28T17:25:31.320Z,1745861131.320 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-04-28T17:25:31.321Z,1745861131.321 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-04-28T17:25:31.321Z,1745861131.321 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-04-28T17:25:31.382Z,1745861131.382 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-04-28T17:25:31.382Z,1745861131.382 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-04-28T17:25:31.525Z,1745861131.525 [BuoyancyServo] Loaded
2025-04-28T17:25:31.525Z,1745861131.525 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-04-28T17:25:31.549Z,1745861131.549 [ElevatorServo] Loaded
2025-04-28T17:25:31.550Z,1745861131.550 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-04-28T17:25:31.573Z,1745861131.573 [MassServo] Loaded
2025-04-28T17:25:31.573Z,1745861131.573 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-04-28T17:25:31.596Z,1745861131.596 [RudderServo] Loaded
2025-04-28T17:25:31.596Z,1745861131.596 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-04-28T17:25:31.614Z,1745861131.614 [ThrusterHE] Loaded
2025-04-28T17:25:31.614Z,1745861131.614 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-04-28T17:25:31.615Z,1745861131.615 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-04-28T17:25:31.615Z,1745861131.615 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-04-28T17:25:31.788Z,1745861131.788 [CTD_Seabird] Loaded
2025-04-28T17:25:31.788Z,1745861131.788 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-04-28T17:25:31.789Z,1745861131.789 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A4E4E0
2025-04-28T17:25:31.790Z,1745861131.790 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1374
2025-04-28T17:25:31.791Z,1745861131.791 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-04-28T17:25:31.791Z,1745861131.791 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-04-28T17:25:31.927Z,1745861131.927 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-04-28T17:25:31.928Z,1745861131.928 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-04-28T17:25:32.112Z,1745861132.112 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-04-28T17:25:32.113Z,1745861132.113 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-04-28T17:25:32.475Z,1745861132.475 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-04-28T17:25:32.475Z,1745861132.475 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-04-28T17:25:32.532Z,1745861132.532 [VerticalControl](DEBUG): Construct VerticalControl.
2025-04-28T17:25:32.585Z,1745861132.585 [VerticalControl] Loaded
2025-04-28T17:25:32.585Z,1745861132.585 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-04-28T17:25:32.588Z,1745861132.588 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-04-28T17:25:32.635Z,1745861132.635 [HorizontalControl] Loaded
2025-04-28T17:25:32.635Z,1745861132.635 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-04-28T17:25:32.637Z,1745861132.637 [SpeedControl](DEBUG): Construct SpeedControl.
2025-04-28T17:25:32.639Z,1745861132.639 [SpeedControl] Loaded
2025-04-28T17:25:32.639Z,1745861132.639 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-04-28T17:25:32.642Z,1745861132.642 [LoopControl](DEBUG): Construct LoopControl.
2025-04-28T17:25:32.643Z,1745861132.643 [LoopControl] Loaded
2025-04-28T17:25:32.643Z,1745861132.643 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-04-28T17:25:32.643Z,1745861132.643 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-04-28T17:25:32.644Z,1745861132.644 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-04-28T17:25:32.814Z,1745861132.814 [SBIT](DEBUG): Construct Startup Built In Test.
2025-04-28T17:25:32.823Z,1745861132.823 [SBIT] Loaded
2025-04-28T17:25:32.824Z,1745861132.824 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-04-28T17:25:32.827Z,1745861132.827 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-04-28T17:25:32.840Z,1745861132.840 [IBIT] Loaded
2025-04-28T17:25:32.840Z,1745861132.840 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-04-28T17:25:32.845Z,1745861132.845 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-04-28T17:25:33.048Z,1745861133.048 [CBIT] Loaded
2025-04-28T17:25:33.048Z,1745861133.048 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-04-28T17:25:33.080Z,1745861133.080 [GFScanner] Loaded
2025-04-28T17:25:33.080Z,1745861133.080 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-04-28T17:25:33.081Z,1745861133.081 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-04-28T17:25:33.081Z,1745861133.081 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-04-28T17:25:33.250Z,1745861133.250 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-04-28T17:25:33.272Z,1745861133.272 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-04-28T17:25:33.275Z,1745861133.275 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-04-28T17:25:33.326Z,1745861133.326 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-04-28T17:25:33.327Z,1745861133.327 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C354E0
2025-04-28T17:25:33.327Z,1745861133.327 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1375
2025-04-28T17:25:33.332Z,1745861133.332 [Supervisor](INFO): Main Thread ID is 1281
2025-04-28T17:25:33.332Z,1745861133.332 [Supervisor](DEBUG): Running supervisor.
2025-04-28T17:25:33.332Z,1745861133.332 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1376
2025-04-28T17:25:33.333Z,1745861133.333 [CommandExec](INFO): Initializing the command executive.
2025-04-28T17:25:33.353Z,1745861133.353 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1377
2025-04-28T17:25:33.419Z,1745861133.419 [controlThread ThreadHandler](INFO): Handler Thread ID is 1378
2025-04-28T17:25:33.419Z,1745861133.419 [controlThread](DEBUG): Initializing ControlThread
2025-04-28T17:25:33.421Z,1745861133.421 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-04-28T17:25:33.422Z,1745861133.422 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-04-28T17:25:33.423Z,1745861133.423 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-04-28T17:25:33.424Z,1745861133.424 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-04-28T17:25:33.424Z,1745861133.424 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-04-28T17:25:33.424Z,1745861133.424 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-04-28T17:25:33.425Z,1745861133.425 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-04-28T17:25:33.427Z,1745861133.427 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-04-28T17:25:33.429Z,1745861133.429 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-04-28T17:25:33.434Z,1745861133.434 [logger ThreadHandler](INFO): Handler Thread ID is 1379
2025-04-28T17:25:33.458Z,1745861133.458 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1380
2025-04-28T17:25:33.462Z,1745861133.462 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-04-28T17:25:33.463Z,1745861133.463 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-04-28T17:25:33.463Z,1745861133.463 [SBIT](INFO): Initialize SBIT Component.
2025-04-28T17:25:33.463Z,1745861133.463 [SBIT](IMPORTANT): git: 2025-04-24
2025-04-28T17:25:33.464Z,1745861133.464 [SBIT](INFO): git hash: ed8b2699e10264a13705e958152987274a27a0ee
2025-04-28T17:25:33.464Z,1745861133.464 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-04-28T17:25:33.465Z,1745861133.465 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Mon Nov 27 01:04:18 PST 2023
2025-04-28T17:25:33.466Z,1745861133.466 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2025-04-28T17:25:33.467Z,1745861133.467 [IBIT](INFO): Initialize IBIT Component.
2025-04-28T17:25:33.468Z,1745861133.468 [CBIT](DEBUG): Initialize CBIT Component.
2025-04-28T17:25:33.470Z,1745861133.470 [DAT ThreadHandler](INFO): Handler Thread ID is 1381
2025-04-28T17:25:33.471Z,1745861133.471 [DAT](INFO): Powering up
2025-04-28T17:25:33.471Z,1745861133.471 [DAT](DEBUG): Initializing DAT.
2025-04-28T17:25:33.473Z,1745861133.473 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1383
2025-04-28T17:25:33.475Z,1745861133.475 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-04-28T17:25:33.477Z,1745861133.477 [Onboard ThreadHandler](INFO): Handler Thread ID is 1384
2025-04-28T17:25:33.483Z,1745861133.483 [CBIT](DEBUG): Initialized mux pins.
2025-04-28T17:25:33.483Z,1745861133.483 [CBIT](DEBUG): Initializing the watchdog timer.
2025-04-28T17:25:33.506Z,1745861133.506 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-04-28T17:25:33.506Z,1745861133.506 [CBIT](DEBUG): Initializing heartbeat.
2025-04-28T17:25:33.518Z,1745861133.518 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1386
2025-04-28T17:25:33.519Z,1745861133.519 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-28T17:25:33.521Z,1745861133.521 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1388
2025-04-28T17:25:33.523Z,1745861133.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-04-28T17:25:33.523Z,1745861133.523 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-04-28T17:25:33.524Z,1745861133.524 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-04-28T17:25:33.524Z,1745861133.524 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-04-28T17:25:33.524Z,1745861133.524 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-04-28T17:25:33.524Z,1745861133.524 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-04-28T17:25:33.524Z,1745861133.524 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-04-28T17:25:33.524Z,1745861133.524 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-04-28T17:25:33.562Z,1745861133.562 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1385
2025-04-28T17:25:33.578Z,1745861133.578 [CBIT](DEBUG): Deactivating emergency mode.
2025-04-28T17:25:33.618Z,1745861133.618 [CBIT](DEBUG): Backplane powered.
2025-04-28T17:25:33.618Z,1745861133.618 [GFScanner](DEBUG): Initializing GFScanner
2025-04-28T17:25:33.618Z,1745861133.618 [GFScanner](DEBUG): Deactivating GF circuits.
2025-04-28T17:25:33.623Z,1745861133.623 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-04-28T17:25:33.624Z,1745861133.624 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-04-28T17:25:33.624Z,1745861133.624 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-04-28T17:25:33.625Z,1745861133.625 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-04-28T17:25:33.730Z,1745861133.730 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-04-28T17:25:33.751Z,1745861133.751 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-28T17:25:33.835Z,1745861133.835 [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 Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2025-04-28T17:25:33.836Z,1745861133.836 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-04-28T17:25:33.836Z,1745861133.836 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-04-28T17:25:33.837Z,1745861133.837 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-04-28T17:25:33.966Z,1745861133.966 [Radio_Surface](INFO): Powering up
2025-04-28T17:25:34.173Z,1745861134.173 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2025-04-28T17:25:34.187Z,1745861134.187 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-04-28T17:25:34.188Z,1745861134.188 [Default:A.Wait](DEBUG): Construct Wait.
2025-04-28T17:25:34.213Z,1745861134.213 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-28T17:25:34.265Z,1745861134.265 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-28T17:25:34.267Z,1745861134.267 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-28T17:25:34.282Z,1745861134.282 [Default:E.Execute](DEBUG): Construct Execute.
2025-04-28T17:25:34.285Z,1745861134.285 [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 Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
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 = 13 second
}
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=P4H {
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-04-28T17:25:34.321Z,1745861134.321 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DepthKeller33X,NAL9602,Power24vConverter,RDI_Pathfinder,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-28T17:25:34.329Z,1745861134.329 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-28T17:25:34.359Z,1745861134.359 [DepthKeller33X](INFO): Initializing.
2025-04-28T17:25:34.378Z,1745861134.378 [Power24vConverter](INFO): Powering up.
2025-04-28T17:25:34.379Z,1745861134.379 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-04-28T17:25:34.386Z,1745861134.386 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T17:25:34.414Z,1745861134.414 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-28T17:25:34.422Z,1745861134.422 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-28T17:25:34.423Z,1745861134.423 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-28T17:25:34.430Z,1745861134.430 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-28T17:25:34.431Z,1745861134.431 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-28T17:25:34.438Z,1745861134.438 [MassServo](DEBUG): Initializing MassServo.
2025-04-28T17:25:34.439Z,1745861134.439 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-28T17:25:34.446Z,1745861134.446 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-28T17:25:34.447Z,1745861134.447 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-28T17:25:34.454Z,1745861134.454 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-28T17:25:34.775Z,1745861134.775 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T17:25:35.137Z,1745861135.137 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T17:25:35.543Z,1745861135.543 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T17:25:35.967Z,1745861135.967 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-28T17:25:40.072Z,1745861140.072 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-04-28T17:25:41.554Z,1745861141.554 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-04-28T17:25:46.582Z,1745861146.582 [DAT](INFO): DAT read:
2025-04-28T17:25:46.584Z,1745861146.584 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-04-28T17:25:48.100Z,1745861148.100 [DAT](INFO): DAT read: MF Frequency Band
2025-04-28T17:25:48.102Z,1745861148.102 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.0
2025-04-28T17:25:48.102Z,1745861148.102 [DAT](INFO): DAT read: Apr 28 2025 17:11:38
2025-04-28T17:25:48.620Z,1745861148.620 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004752
2025-04-28T17:25:49.107Z,1745861149.107 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-04-28T17:25:49.108Z,1745861149.108 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:25:49.108Z,1745861149.108 [DAT](INFO): commRate: 800
2025-04-28T17:25:51.174Z,1745861151.174 [DAT](INFO): entering command mode
2025-04-28T17:25:51.376Z,1745861151.376 [DAT](INFO): DAT read:
2025-04-28T17:25:51.378Z,1745861151.378 [DAT](INFO): DAT read: user:1>
2025-04-28T17:25:51.379Z,1745861151.379 [DAT](INFO): setting verbose to 3
2025-04-28T17:25:51.626Z,1745861151.626 [DAT](INFO): DAT read: user:1>
2025-04-28T17:25:51.627Z,1745861151.627 [DAT](INFO): DAT read: Verbose | 3
2025-04-28T17:25:51.628Z,1745861151.628 [DAT](INFO): set verbose to 3
2025-04-28T17:25:51.628Z,1745861151.628 [DAT](INFO): setting DatVerbose to 27440
2025-04-28T17:25:51.878Z,1745861151.878 [DAT](INFO): DAT read: user:2>
2025-04-28T17:25:51.879Z,1745861151.879 [DAT](INFO): DAT read: DatVerbose | 27440
2025-04-28T17:25:51.880Z,1745861151.880 [DAT](INFO): set DatVerbose to 27440
2025-04-28T17:25:51.880Z,1745861151.880 [DAT](INFO): setting transmit power to 8
2025-04-28T17:25:52.130Z,1745861152.130 [DAT](INFO): DAT read: user:3>
2025-04-28T17:25:52.131Z,1745861152.131 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-04-28T17:25:52.132Z,1745861152.132 [DAT](INFO): set transmit power to 8
2025-04-28T17:25:52.132Z,1745861152.132 [DAT](INFO): setting local address to 3
2025-04-28T17:25:52.383Z,1745861152.383 [DAT](INFO): DAT read: user:4>
2025-04-28T17:25:52.385Z,1745861152.385 [DAT](INFO): DAT read: LocalAddr | 3
2025-04-28T17:25:52.385Z,1745861152.385 [DAT](INFO): set local address to 3
2025-04-28T17:25:52.387Z,1745861152.387 [DAT](INFO): Setting time to: 17:25:52 And date to:4/28/2025
2025-04-28T17:25:52.586Z,1745861152.586 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position
2025-04-28T17:25:52.634Z,1745861152.634 [DAT](INFO): DAT read: user:5>
2025-04-28T17:25:52.635Z,1745861152.635 [DAT](INFO): DAT read: Mon Apr 28, 2025 17:25:52
2025-04-28T17:25:52.636Z,1745861152.636 [DAT](INFO): Local DAT time set to Mon Apr 28, 2025 17:25:52
2025-04-28T17:25:52.784Z,1745861152.784 [Reporter](INFO): platform_buoyancy_position 1958.064453 cc
2025-04-28T17:26:01.251Z,1745861161.251 [NAL9602](INFO): Powering up NAL9602
2025-04-28T17:26:04.238Z,1745861164.238 [CommandExec](IMPORTANT): got command get depth
2025-04-28T17:26:04.239Z,1745861164.239 [CommandExec](IMPORTANT): depth 0.222337 m
2025-04-28T17:26:07.470Z,1745861167.470 [CommandExec](IMPORTANT): got command show best depth
2025-04-28T17:26:07.471Z,1745861167.471 [CommandExec](IMPORTANT): depth best is DepthKeller33X.depth
2025-04-28T17:26:09.875Z,1745861169.875 [CommandExec](IMPORTANT): got command failComponent
2025-04-28T17:26:09.875Z,1745861169.875 [CommandExec](IMPORTANT): Failed components:
2025-04-28T17:26:09.876Z,1745861169.876 [CommandExec](IMPORTANT): No failed Components.
2025-04-28T17:26:12.161Z,1745861172.161 [NAL9602](INFO): NAL9602 initialized
2025-04-28T17:26:13.006Z,1745861173.006 [SBIT](IMPORTANT): Beginning Startup BIT
2025-04-28T17:26:13.013Z,1745861173.013 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-28T17:26:14.148Z,1745861174.148 [CommandExec](IMPORTANT): got command strobe off
2025-04-28T17:26:14.148Z,1745861174.148 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-28T17:26:17.686Z,1745861177.686 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.003606
CHAN A1 (24V): -0.003777
CHAN A2 (12V): -0.000262
CHAN A3 (5V): -0.021501
CHAN B0 (3.3V): -0.000593
CHAN B1 (3.15aV): -0.000206
CHAN B2 (3.15bV): -0.000508
CHAN B3 (GND): 0.000034
OPEN: 0.004731
Full Scale: +/- 1 mA
2025-04-28T17:26:22.187Z,1745861182.187 [CommandExec](IMPORTANT): got command show variable limitlocc
2025-04-28T17:26:22.305Z,1745861182.305 [CommandExec](IMPORTANT): VerticalControl.buoyancyLimitLoCC (cubic_centimeter)
2025-04-28T17:26:30.528Z,1745861190.528 [CommandExec](IMPORTANT): got command get VerticalControl.buoyancyLimitLoCC
2025-04-28T17:26:30.529Z,1745861190.529 [CommandExec](IMPORTANT): VerticalControl.buoyancyLimitLoCC 500.000031 cc
2025-04-28T17:26:40.572Z,1745861200.572 [CommandExec](IMPORTANT): got command get platform_buoyancy_position
2025-04-28T17:26:40.573Z,1745861200.573 [CommandExec](IMPORTANT): platform_buoyancy_position 1958.064453 cc
2025-04-28T17:27:06.350Z,1745861226.350 [SBIT](IMPORTANT): SBIT PASSED
2025-04-28T17:27:06.350Z,1745861226.350 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-04-28T17:27:06.351Z,1745861226.351 [SBIT](IMPORTANT): BPC1.loadAtStartup=0 bool;
2025-04-28T17:27:06.351Z,1745861226.351 [SBIT](IMPORTANT): DepthKeller33X.maxPressBound=2500 decibar;
2025-04-28T17:27:06.351Z,1745861226.351 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2025-04-28T17:27:06.351Z,1745861226.351 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool;
2025-04-28T17:27:06.351Z,1745861226.351 [SBIT](IMPORTANT): MassServo.limitLo=-700000 count;
2025-04-28T17:27:06.351Z,1745861226.351 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-5.5 centimeter;
2025-04-28T17:27:06.750Z,1745861226.750 [MissionManager](IMPORTANT): Started mission Startup
2025-04-28T17:27:06.750Z,1745861226.750 [Startup] Running Loop=1
2025-04-28T17:27:06.750Z,1745861226.750 [Startup](DEBUG): Aggregate::initialize Startup
2025-04-28T17:27:06.750Z,1745861226.750 [Startup:A.GoToSurface] Running Loop=1
2025-04-28T17:27:06.751Z,1745861226.751 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-28T17:27:06.751Z,1745861226.751 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-28T17:27:06.752Z,1745861226.752 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-28T17:27:06.752Z,1745861226.752 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-28T17:27:06.752Z,1745861226.752 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-28T17:27:06.753Z,1745861226.753 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-28T17:27:06.753Z,1745861226.753 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-28T17:27:06.755Z,1745861226.755 [Startup:StartupSatComms] Running Loop=1
2025-04-28T17:27:06.756Z,1745861226.756 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-04-28T17:27:06.756Z,1745861226.756 [Startup:StartupSatComms:A] Running Loop=1
2025-04-28T17:27:07.123Z,1745861227.123 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-04-28T17:27:08.563Z,1745861228.563 [Reporter](INFO): platform_buoyancy_position 1967.741821 cc
2025-04-28T17:27:09.557Z,1745861229.557 [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-04-28T17:27:09.748Z,1745861229.748 [Reporter](INFO): platform_buoyancy_position 1970.766113 cc
2025-04-28T17:27:10.008Z,1745861230.008 [Reporter](INFO): platform_buoyancy_position 1970.967773 cc
2025-04-28T17:27:10.412Z,1745861230.412 [Reporter](INFO): platform_buoyancy_position 1974.193604 cc
2025-04-28T17:27:10.812Z,1745861230.812 [Reporter](INFO): platform_buoyancy_position 1961.693604 cc
2025-04-28T17:27:11.233Z,1745861231.233 [Reporter](INFO): platform_buoyancy_position 1967.136963 cc
2025-04-28T17:27:11.649Z,1745861231.649 [Reporter](INFO): platform_buoyancy_position 1971.572388 cc
2025-04-28T17:27:12.117Z,1745861232.117 [Reporter](INFO): platform_buoyancy_position 1977.419434 cc
2025-04-28T17:27:12.530Z,1745861232.530 [Reporter](INFO): platform_buoyancy_position 1980.645386 cc
2025-04-28T17:27:12.966Z,1745861232.966 [Reporter](INFO): platform_buoyancy_position 1983.870728 cc
2025-04-28T17:27:13.372Z,1745861233.372 [Reporter](INFO): platform_buoyancy_position 1986.895264 cc
2025-04-28T17:27:13.824Z,1745861233.824 [Reporter](INFO): platform_buoyancy_position 1990.120850 cc
2025-04-28T17:27:22.322Z,1745861242.322 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 500 cubic_centimeter
2025-04-28T17:27:22.327Z,1745861242.327 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2025-04-28T17:27:22.495Z,1745861242.495 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DepthKeller33X,NAL9602,Power24vConverter,RDI_Pathfinder,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-28T17:27:25.060Z,1745861245.060 [Reporter](INFO): platform_buoyancy_position 2009.677490 cc
2025-04-28T17:27:25.376Z,1745861245.376 [Reporter](INFO): platform_buoyancy_position 2009.475830 cc
2025-04-28T17:27:25.788Z,1745861245.788 [Reporter](INFO): platform_buoyancy_position 2009.677490 cc
2025-04-28T17:27:26.144Z,1745861246.144 [Reporter](INFO): platform_buoyancy_position 2009.475830 cc
2025-04-28T17:27:26.553Z,1745861246.553 [Reporter](INFO): platform_buoyancy_position 2006.451660 cc
2025-04-28T17:27:26.976Z,1745861246.976 [Reporter](INFO): platform_buoyancy_position 2003.225708 cc
2025-04-28T17:27:27.402Z,1745861247.402 [Reporter](INFO): platform_buoyancy_position 1990.120850 cc
2025-04-28T17:27:28.169Z,1745861248.169 [Reporter](INFO): platform_buoyancy_position 1986.895264 cc
2025-04-28T17:27:28.589Z,1745861248.589 [Reporter](INFO): platform_buoyancy_position 1984.677490 cc
2025-04-28T17:27:28.997Z,1745861248.997 [Reporter](INFO): platform_buoyancy_position 1983.266113 cc
2025-04-28T17:27:29.456Z,1745861249.456 [Reporter](INFO): platform_buoyancy_position 1980.443726 cc
2025-04-28T17:27:29.833Z,1745861249.833 [Reporter](INFO): platform_buoyancy_position 1977.217896 cc
2025-04-28T17:27:30.233Z,1745861250.233 [Reporter](INFO): platform_buoyancy_position 1975.403442 cc
2025-04-28T17:27:30.600Z,1745861250.600 [Reporter](INFO): platform_buoyancy_position 1973.991943 cc
2025-04-28T17:27:31.001Z,1745861251.001 [Reporter](INFO): platform_buoyancy_position 1970.967773 cc
2025-04-28T17:27:31.457Z,1745861251.457 [Reporter](INFO): platform_buoyancy_position 1970.766113 cc
2025-04-28T17:27:31.876Z,1745861251.876 [Reporter](INFO): platform_buoyancy_position 1967.540283 cc
2025-04-28T17:27:32.608Z,1745861252.608 [Reporter](INFO): platform_buoyancy_position 1964.314331 cc
2025-04-28T17:27:33.019Z,1745861253.019 [Reporter](INFO): platform_buoyancy_position 1961.088745 cc
2025-04-28T17:27:33.489Z,1745861253.489 [Reporter](INFO): platform_buoyancy_position 1960.886841 cc
2025-04-28T17:27:33.857Z,1745861253.857 [Reporter](INFO): platform_buoyancy_position 1958.064453 cc
2025-04-28T17:27:34.264Z,1745861254.264 [Reporter](INFO): platform_buoyancy_position 1955.040283 cc
2025-04-28T17:27:34.648Z,1745861254.648 [Reporter](INFO): platform_buoyancy_position 1954.636963 cc
2025-04-28T17:27:35.054Z,1745861255.054 [Reporter](INFO): platform_buoyancy_position 1951.612793 cc
2025-04-28T17:27:35.480Z,1745861255.480 [Reporter](INFO): platform_buoyancy_position 1951.411377 cc
2025-04-28T17:27:35.860Z,1745861255.860 [Reporter](INFO): platform_buoyancy_position 1948.185547 cc
2025-04-28T17:27:36.295Z,1745861256.295 [Reporter](INFO): platform_buoyancy_position 1948.386963 cc
2025-04-28T17:27:36.668Z,1745861256.668 [Reporter](INFO): platform_buoyancy_position 1945.161377 cc
2025-04-28T17:27:37.064Z,1745861257.064 [Reporter](INFO): platform_buoyancy_position 1944.758057 cc
2025-04-28T17:27:37.518Z,1745861257.518 [Reporter](INFO): platform_buoyancy_position 1941.935547 cc
2025-04-28T17:27:37.874Z,1745861257.874 [Reporter](INFO): platform_buoyancy_position 1938.709717 cc
2025-04-28T17:27:38.287Z,1745861258.287 [Reporter](INFO): platform_buoyancy_position 1938.508057 cc
2025-04-28T17:27:38.714Z,1745861258.714 [Reporter](INFO): platform_buoyancy_position 1935.483887 cc
2025-04-28T17:27:39.111Z,1745861259.111 [Reporter](INFO): platform_buoyancy_position 1935.080566 cc
2025-04-28T17:27:39.548Z,1745861259.548 [Reporter](INFO): platform_buoyancy_position 1932.056396 cc
2025-04-28T17:27:39.907Z,1745861259.907 [Reporter](INFO): platform_buoyancy_position 1931.854736 cc
2025-04-28T17:27:40.321Z,1745861260.321 [Reporter](INFO): platform_buoyancy_position 1929.032227 cc
2025-04-28T17:27:40.721Z,1745861260.721 [Reporter](INFO): platform_buoyancy_position 1925.604736 cc
2025-04-28T17:27:41.114Z,1745861261.114 [Reporter](INFO): platform_buoyancy_position 1925.806396 cc
2025-04-28T17:27:41.527Z,1745861261.527 [Reporter](INFO): platform_buoyancy_position 1922.580566 cc
2025-04-28T17:27:41.916Z,1745861261.916 [Reporter](INFO): platform_buoyancy_position 1922.177490 cc
2025-04-28T17:27:42.324Z,1745861262.324 [Reporter](INFO): platform_buoyancy_position 1919.153320 cc
2025-04-28T17:27:42.748Z,1745861262.748 [Reporter](INFO): platform_buoyancy_position 1918.346680 cc
2025-04-28T17:27:43.171Z,1745861263.171 [Reporter](INFO): platform_buoyancy_position 1916.330566 cc
2025-04-28T17:27:43.736Z,1745861263.736 [Reporter](INFO): platform_buoyancy_position 1912.903320 cc
2025-04-28T17:27:43.922Z,1745861263.922 [BuoyancyServo](FAULT): Overload Error
2025-04-28T17:27:43.922Z,1745861263.922 [BuoyancyServo] Hardware Fault, FailCount= 1
2025-04-28T17:27:43.922Z,1745861263.922 [BuoyancyServo](ERROR): Hardware Fault
2025-04-28T17:27:44.030Z,1745861264.030 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2025-04-28T17:27:45.909Z,1745861265.909 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-28T17:27:45.909Z,1745861265.909 [BuoyancyServo](INFO): Powering down
2025-04-28T17:27:46.732Z,1745861266.732 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-04-28T17:27:46.732Z,1745861266.732 [BuoyancyServo] No Fault, FailCount= 1
2025-04-28T17:27:47.146Z,1745861267.146 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-28T17:27:47.147Z,1745861267.147 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-28T17:27:50.384Z,1745861270.384 [Reporter](INFO): platform_buoyancy_position 1912.701660 cc
2025-04-28T17:27:50.943Z,1745861270.943 [Reporter](INFO): platform_buoyancy_position 1919.354736 cc
2025-04-28T17:27:51.215Z,1745861271.215 [Reporter](INFO): platform_buoyancy_position 1919.153320 cc
2025-04-28T17:27:51.645Z,1745861271.645 [Reporter](INFO): platform_buoyancy_position 1919.354736 cc
2025-04-28T17:27:52.004Z,1745861272.004 [Reporter](INFO): platform_buoyancy_position 1916.128906 cc
2025-04-28T17:27:52.416Z,1745861272.416 [Reporter](INFO): platform_buoyancy_position 1915.927490 cc
2025-04-28T17:27:52.819Z,1745861272.819 [Reporter](INFO): platform_buoyancy_position 1912.903320 cc
2025-04-28T17:27:53.244Z,1745861273.244 [Reporter](INFO): platform_buoyancy_position 1896.975830 cc
2025-04-28T17:27:53.706Z,1745861273.706 [Reporter](INFO): platform_buoyancy_position 1896.774170 cc
2025-04-28T17:27:54.449Z,1745861274.449 [Reporter](INFO): platform_buoyancy_position 1893.548340 cc
2025-04-28T17:27:54.844Z,1745861274.844 [Reporter](INFO): platform_buoyancy_position 1892.136963 cc
2025-04-28T17:27:55.266Z,1745861275.266 [Reporter](INFO): platform_buoyancy_position 1890.120850 cc
2025-04-28T17:27:55.708Z,1745861275.708 [Reporter](INFO): platform_buoyancy_position 1886.895264 cc
2025-04-28T17:27:56.456Z,1745861276.456 [Reporter](INFO): platform_buoyancy_position 1883.870850 cc
2025-04-28T17:27:56.836Z,1745861276.836 [CommandExec](IMPORTANT): got command maintain clear
2025-04-28T17:27:56.855Z,1745861276.855 [Reporter](INFO): platform_buoyancy_position 1883.467773 cc
2025-04-28T17:27:56.859Z,1745861276.859 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DepthKeller33X,NAL9602,Power24vConverter,RDI_Pathfinder,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-28T17:27:57.395Z,1745861277.395 [Reporter](INFO): platform_buoyancy_position 1880.443604 cc
2025-04-28T17:27:57.825Z,1745861277.825 [Reporter](INFO): platform_buoyancy_position 1877.419434 cc
2025-04-28T17:27:58.076Z,1745861278.076 [Reporter](INFO): platform_buoyancy_position 1877.217773 cc
2025-04-28T17:27:58.472Z,1745861278.472 [Reporter](INFO): platform_buoyancy_position 1874.193604 cc
2025-04-28T17:27:58.875Z,1745861278.875 [Reporter](INFO): platform_buoyancy_position 1873.991943 cc
2025-04-28T17:27:59.293Z,1745861279.293 [Reporter](INFO): platform_buoyancy_position 1874.193604 cc
2025-04-28T17:27:59.758Z,1745861279.758 [Reporter](INFO): platform_buoyancy_position 1873.991943 cc
2025-04-28T17:28:00.112Z,1745861280.112 [Reporter](INFO): platform_buoyancy_position 1874.193604 cc
2025-04-28T17:28:00.501Z,1745861280.501 [Reporter](INFO): platform_buoyancy_position 1873.991943 cc
2025-04-28T17:28:00.908Z,1745861280.908 [Reporter](INFO): platform_buoyancy_position 1874.193604 cc
2025-04-28T17:28:01.326Z,1745861281.326 [Reporter](INFO): platform_buoyancy_position 1877.217773 cc
2025-04-28T17:28:01.752Z,1745861281.752 [Reporter](INFO): platform_buoyancy_position 1880.443604 cc
2025-04-28T17:28:02.154Z,1745861282.154 [Reporter](INFO): platform_buoyancy_position 1883.467773 cc
2025-04-28T17:28:02.537Z,1745861282.537 [Reporter](INFO): platform_buoyancy_position 1885.483887 cc
2025-04-28T17:28:02.920Z,1745861282.920 [Reporter](INFO): platform_buoyancy_position 1887.096680 cc
2025-04-28T17:28:03.316Z,1745861283.316 [Reporter](INFO): platform_buoyancy_position 1890.524170 cc
2025-04-28T17:28:03.772Z,1745861283.772 [Reporter](INFO): platform_buoyancy_position 1896.572510 cc
2025-04-28T17:28:04.152Z,1745861284.152 [Reporter](INFO): platform_buoyancy_position 1899.798340 cc
2025-04-28T17:28:04.549Z,1745861284.549 [Reporter](INFO): platform_buoyancy_position 1903.225830 cc
2025-04-28T17:28:04.956Z,1745861284.956 [Reporter](INFO): platform_buoyancy_position 1906.250000 cc
2025-04-28T17:28:05.386Z,1745861285.386 [Reporter](INFO): platform_buoyancy_position 1909.677490 cc
2025-04-28T17:28:05.807Z,1745861285.807 [Reporter](INFO): platform_buoyancy_position 1915.927490 cc
2025-04-28T17:28:06.177Z,1745861286.177 [Reporter](INFO): platform_buoyancy_position 1919.153320 cc
2025-04-28T17:28:06.590Z,1745861286.590 [Reporter](INFO): platform_buoyancy_position 1922.378906 cc
2025-04-28T17:28:06.912Z,1745861286.912 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-28T17:27:06.8Z
2025-04-28T17:28:06.912Z,1745861286.912 [Startup:StartupSatComms:A] Stopped
2025-04-28T17:28:06.913Z,1745861286.913 [Startup:StartupSatComms:B] Running Loop=1
2025-04-28T17:28:06.973Z,1745861286.973 [Reporter](INFO): platform_buoyancy_position 1925.604736 cc
2025-04-28T17:28:07.326Z,1745861287.326 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-28T17:28:07.399Z,1745861287.399 [Reporter](INFO): platform_buoyancy_position 1932.056396 cc
2025-04-28T17:28:07.813Z,1745861287.813 [Reporter](INFO): platform_buoyancy_position 1935.282227 cc
2025-04-28T17:28:08.172Z,1745861288.172 [Reporter](INFO): platform_buoyancy_position 1938.709717 cc
2025-04-28T17:28:08.596Z,1745861288.596 [Reporter](INFO): platform_buoyancy_position 1941.733887 cc
2025-04-28T17:28:08.972Z,1745861288.972 [Reporter](INFO): platform_buoyancy_position 1945.161377 cc
2025-04-28T17:28:09.453Z,1745861289.453 [Reporter](INFO): platform_buoyancy_position 1951.612793 cc
2025-04-28T17:28:09.856Z,1745861289.856 [Reporter](INFO): platform_buoyancy_position 1954.838623 cc
2025-04-28T17:28:10.215Z,1745861290.215 [Reporter](INFO): platform_buoyancy_position 1958.064453 cc
2025-04-28T17:28:10.631Z,1745861290.631 [Reporter](INFO): platform_buoyancy_position 1961.290405 cc
2025-04-28T17:28:11.001Z,1745861291.001 [Reporter](INFO): platform_buoyancy_position 1965.322510 cc
2025-04-28T17:28:11.521Z,1745861291.521 [Reporter](INFO): platform_buoyancy_position 1970.967773 cc
2025-04-28T17:28:11.804Z,1745861291.804 [Reporter](INFO): platform_buoyancy_position 1973.991943 cc
2025-04-28T17:28:12.221Z,1745861292.221 [Reporter](INFO): platform_buoyancy_position 1977.217896 cc
2025-04-28T17:28:12.737Z,1745861292.737 [Reporter](INFO): platform_buoyancy_position 1980.645386 cc
2025-04-28T17:28:13.174Z,1745861293.174 [Reporter](INFO): platform_buoyancy_position 1985.483765 cc
2025-04-28T17:28:13.286Z,1745861293.286 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20250428T165834/Courier0004.lzma
2025-04-28T17:28:13.584Z,1745861293.584 [Reporter](INFO): platform_buoyancy_position 1990.120850 cc
2025-04-28T17:28:14.288Z,1745861294.288 [DataOverHttps](INFO): Moved sent file to Logs/20250428T165834/Courier0004.lzma.bak
2025-04-28T17:28:14.288Z,1745861294.288 [DataOverHttps](INFO): SBD MOMSN=24739149
2025-04-28T17:28:30.458Z,1745861310.458 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250428T172523/Courier0000.lzma
2025-04-28T17:28:31.460Z,1745861311.460 [DataOverHttps](INFO): Moved sent file to Logs/20250428T172523/Courier0000.lzma.bak
2025-04-28T17:28:31.461Z,1745861311.461 [DataOverHttps](INFO): SBD MOMSN=24739164
2025-04-28T17:28:33.598Z,1745861313.598 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-04-28T17:28:33.598Z,1745861313.598 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-28T17:28:33.599Z,1745861313.599 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2025-04-28T17:28:33.599Z,1745861313.599 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-04-28T17:28:33.610Z,1745861313.610 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-28T17:28:33.610Z,1745861313.610 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-04-28T17:28:33.986Z,1745861313.986 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-28T17:28:33.986Z,1745861313.986 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-04-28T17:28:33.986Z,1745861313.986 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-04-28T17:28:33.987Z,1745861313.987 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2025-04-28T17:28:35.802Z,1745861315.802 [CommandExec](IMPORTANT): got command failComponent
2025-04-28T17:28:35.802Z,1745861315.802 [CommandExec](IMPORTANT): Failed components:
2025-04-28T17:28:35.803Z,1745861315.803 [CommandExec](IMPORTANT): No failed Components.
2025-04-28T17:28:48.685Z,1745861328.685 [DataOverHttps](INFO): Sending 1100 bytes from file Logs/20250428T165834/Express0005.lzma
2025-04-28T17:28:49.684Z,1745861329.684 [DataOverHttps](INFO): Moved sent file to Logs/20250428T165834/Express0005.lzma.bak
2025-04-28T17:28:49.684Z,1745861329.684 [DataOverHttps](INFO): SBD MOMSN=24739170
2025-04-28T17:28:52.635Z,1745861332.635 [DAT](INFO): DAT read: user:6>Lowpower
2025-04-28T17:28:52.635Z,1745861332.635 [DAT](DEBUG): Re-entering command mode due to deviceResponse_: user:6>Lowpower
2025-04-28T17:29:07.146Z,1745861347.146 [Startup:StartupSatComms:B](INFO): Timed out from 2025-04-28T17:28:06.9Z
2025-04-28T17:29:07.146Z,1745861347.146 [Startup:StartupSatComms:B] Stopped
2025-04-28T17:29:07.146Z,1745861347.146 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-04-28T17:29:07.146Z,1745861347.146 [Startup:StartupSatComms] Stopped
2025-04-28T17:29:07.146Z,1745861347.146 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-04-28T17:29:07.147Z,1745861347.147 [Startup](INFO): Completed Startup
2025-04-28T17:29:07.147Z,1745861347.147 [MissionManager](INFO): Startup is completed.
2025-04-28T17:29:07.147Z,1745861347.147 [MissionManager](INFO): Uninitializing Mission Startup
2025-04-28T17:29:07.147Z,1745861347.147 [Startup] Stopped
2025-04-28T17:29:07.147Z,1745861347.147 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-04-28T17:29:07.148Z,1745861347.148 [Startup:A.GoToSurface] Stopped
2025-04-28T17:29:07.148Z,1745861347.148 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-28T17:29:07.538Z,1745861347.538 [MissionManager](IMPORTANT): Started mission Default
2025-04-28T17:29:07.539Z,1745861347.539 [Default] Running Loop=1
2025-04-28T17:29:07.539Z,1745861347.539 [Default](DEBUG): Aggregate::initialize Default
2025-04-28T17:29:07.539Z,1745861347.539 [Default:B.GoToSurface] Running Loop=1
2025-04-28T17:29:07.539Z,1745861347.539 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-28T17:29:07.539Z,1745861347.539 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-28T17:29:07.539Z,1745861347.539 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-28T17:29:07.540Z,1745861347.540 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-28T17:29:07.540Z,1745861347.540 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-28T17:29:07.540Z,1745861347.540 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-28T17:29:07.541Z,1745861347.541 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-28T17:29:07.541Z,1745861347.541 [Default:A.Wait] Running Loop=1
2025-04-28T17:29:07.541Z,1745861347.541 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-28T17:29:07.872Z,1745861347.872 [DataOverHttps](INFO): Sending 1140 bytes from file Logs/20250428T172523/Express0001.lzma
2025-04-28T17:29:08.872Z,1745861348.872 [DataOverHttps](INFO): Moved sent file to Logs/20250428T172523/Express0001.lzma.bak
2025-04-28T17:29:08.873Z,1745861348.873 [DataOverHttps](INFO): SBD MOMSN=24739235
2025-04-28T17:29:11.543Z,1745861351.543 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:29:11.543Z,1745861351.543 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:29:11.544Z,1745861351.544 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:29:11.545Z,1745861351.545 [DAT](INFO): commRate: 800
2025-04-28T17:29:12.551Z,1745861352.551 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:29:12.551Z,1745861352.551 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:29:20.854Z,1745861360.854 [Default:A.Wait](INFO): Done Waiting.
2025-04-28T17:29:20.854Z,1745861360.854 [Default:A.Wait] Stopped
2025-04-28T17:29:20.855Z,1745861360.855 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-28T17:29:21.263Z,1745861361.263 [Default:CheckIn] Running Loop=1
2025-04-28T17:29:21.263Z,1745861361.263 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-28T17:29:21.263Z,1745861361.263 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-28T17:29:21.694Z,1745861361.694 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-28T17:29:25.655Z,1745861365.655 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:29:25.655Z,1745861365.655 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:29:25.656Z,1745861365.656 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:29:25.657Z,1745861365.657 [DAT](INFO): commRate: 800
2025-04-28T17:29:26.411Z,1745861366.411 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:29:26.411Z,1745861366.411 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:29:31.703Z,1745861371.703 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:29:31.703Z,1745861371.703 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:29:31.704Z,1745861371.704 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:29:31.705Z,1745861371.705 [DAT](INFO): commRate: 800
2025-04-28T17:29:32.458Z,1745861372.458 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:29:32.459Z,1745861372.459 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:30:41.654Z,1745861441.654 [DepthKeller33X](FAULT): Failed to receive valid data within the specified timeout.
2025-04-28T17:30:41.654Z,1745861441.654 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-28T17:30:41.654Z,1745861441.654 [DepthKeller33X](ERROR): Communications Fault
2025-04-28T17:30:41.694Z,1745861441.694 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-28T17:30:42.046Z,1745861442.046 [DepthKeller33X](INFO): Powering down
2025-04-28T17:30:43.138Z,1745861443.138 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-28T17:30:43.138Z,1745861443.138 [DepthKeller33X] No Fault, FailCount= 1
2025-04-28T17:30:43.258Z,1745861443.258 [DepthKeller33X](INFO): Initializing.
2025-04-28T17:31:01.711Z,1745861461.711 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:31:01.711Z,1745861461.711 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:31:01.712Z,1745861461.712 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:31:01.712Z,1745861461.712 [DAT](INFO): commRate: 800
2025-04-28T17:31:02.467Z,1745861462.467 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:31:02.467Z,1745861462.467 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:31:15.984Z,1745861475.984 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-28T17:31:21.860Z,1745861481.860 [CommandExec](IMPORTANT): got command show best depth
2025-04-28T17:31:21.861Z,1745861481.861 [CommandExec](IMPORTANT): depth best is DepthKeller33X.depth
2025-04-28T17:31:31.715Z,1745861491.715 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:31:31.715Z,1745861491.715 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:31:31.716Z,1745861491.716 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:31:31.716Z,1745861491.716 [DAT](INFO): commRate: 800
2025-04-28T17:31:32.470Z,1745861492.470 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:31:32.471Z,1745861492.471 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:31:34.573Z,1745861494.573 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-04-28T17:31:34.573Z,1745861494.573 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-28T17:31:34.582Z,1745861494.582 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2025-04-28T17:31:34.582Z,1745861494.582 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-04-28T17:31:34.610Z,1745861494.610 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-28T17:31:34.610Z,1745861494.610 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-04-28T17:31:34.987Z,1745861494.987 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-28T17:31:34.987Z,1745861494.987 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-04-28T17:31:34.988Z,1745861494.988 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-04-28T17:31:34.988Z,1745861494.988 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2025-04-28T17:31:37.521Z,1745861497.521 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:31:37.521Z,1745861497.521 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:31:37.522Z,1745861497.522 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:31:37.523Z,1745861497.523 [DAT](INFO): commRate: 800
2025-04-28T17:31:38.528Z,1745861498.528 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:31:38.528Z,1745861498.528 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:32:35.519Z,1745861555.519 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:32:35.519Z,1745861555.519 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:32:35.521Z,1745861555.521 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:32:35.522Z,1745861555.522 [DAT](INFO): commRate: 800
2025-04-28T17:32:36.528Z,1745861556.528 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:32:36.528Z,1745861556.528 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:32:37.536Z,1745861557.536 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:32:37.536Z,1745861557.536 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:32:37.537Z,1745861557.537 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:32:37.538Z,1745861557.538 [DAT](INFO): commRate: 800
2025-04-28T17:32:38.544Z,1745861558.544 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:32:38.545Z,1745861558.545 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:32:48.231Z,1745861568.231 [CommandExec](IMPORTANT): got command maintain
2025-04-28T17:32:51.155Z,1745861571.155 [CommandExec](IMPORTANT): got command report
2025-04-28T17:32:51.155Z,1745861571.155 [Reporter](INFO): platform_buoyancy_position reporting changes
2025-04-28T17:33:25.695Z,1745861605.695 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:33:25.695Z,1745861605.695 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:33:25.696Z,1745861605.696 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:33:25.697Z,1745861605.697 [DAT](INFO): commRate: 800
2025-04-28T17:33:26.451Z,1745861606.451 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:33:26.451Z,1745861606.451 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:33:38.942Z,1745861618.942 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 500 cubic_centimeter
2025-04-28T17:33:38.944Z,1745861618.944 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2025-04-28T17:33:39.049Z,1745861619.049 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DepthKeller33X,NAL9602,Power24vConverter,RDI_Pathfinder,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-28T17:33:39.555Z,1745861619.555 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:33:39.555Z,1745861619.555 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:33:39.556Z,1745861619.556 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:33:39.556Z,1745861619.556 [DAT](INFO): commRate: 800
2025-04-28T17:33:40.563Z,1745861620.563 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:33:40.563Z,1745861620.563 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:33:41.094Z,1745861621.094 [BuoyancyServo](FAULT): Reading outside of valid range:0.000000
2025-04-28T17:33:41.095Z,1745861621.095 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2025-04-28T17:33:41.095Z,1745861621.095 [BuoyancyServo] Hardware Fault, FailCount= 1
2025-04-28T17:33:41.095Z,1745861621.095 [BuoyancyServo](ERROR): Hardware Fault
2025-04-28T17:33:41.100Z,1745861621.100 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2025-04-28T17:33:43.086Z,1745861623.086 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-28T17:33:43.086Z,1745861623.086 [BuoyancyServo](INFO): Powering down
2025-04-28T17:33:43.934Z,1745861623.934 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-04-28T17:33:43.934Z,1745861623.934 [BuoyancyServo] No Fault, FailCount= 1
2025-04-28T17:33:44.264Z,1745861624.264 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-28T17:33:44.265Z,1745861624.265 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-28T17:33:47.718Z,1745861627.718 [Reporter](INFO): platform_buoyancy_position 1938.508057 cc
2025-04-28T17:33:48.400Z,1745861628.400 [Reporter](INFO): platform_buoyancy_position 1938.709717 cc
2025-04-28T17:33:48.771Z,1745861628.771 [Reporter](INFO): platform_buoyancy_position 1935.483887 cc
2025-04-28T17:33:49.147Z,1745861629.147 [Reporter](INFO): platform_buoyancy_position 1935.282227 cc
2025-04-28T17:33:49.617Z,1745861629.617 [Reporter](INFO): platform_buoyancy_position 1932.258057 cc
2025-04-28T17:33:49.984Z,1745861629.984 [Reporter](INFO): platform_buoyancy_position 1916.128906 cc
2025-04-28T17:33:50.775Z,1745861630.775 [Reporter](INFO): platform_buoyancy_position 1915.927490 cc
2025-04-28T17:33:51.178Z,1745861631.178 [Reporter](INFO): platform_buoyancy_position 1912.701660 cc
2025-04-28T17:33:51.601Z,1745861631.601 [Reporter](INFO): platform_buoyancy_position 1909.677490 cc
2025-04-28T17:33:52.417Z,1745861632.417 [Reporter](INFO): platform_buoyancy_position 1906.250000 cc
2025-04-28T17:33:52.796Z,1745861632.796 [Reporter](INFO): platform_buoyancy_position 1903.225830 cc
2025-04-28T17:33:53.209Z,1745861633.209 [Reporter](INFO): platform_buoyancy_position 1903.024170 cc
2025-04-28T17:33:53.632Z,1745861633.632 [Reporter](INFO): platform_buoyancy_position 1900.000000 cc
2025-04-28T17:33:54.040Z,1745861634.040 [Reporter](INFO): platform_buoyancy_position 1896.774170 cc
2025-04-28T17:33:54.438Z,1745861634.438 [Reporter](INFO): platform_buoyancy_position 1896.572510 cc
2025-04-28T17:33:54.840Z,1745861634.840 [Reporter](INFO): platform_buoyancy_position 1893.548340 cc
2025-04-28T17:33:55.223Z,1745861635.223 [Reporter](INFO): platform_buoyancy_position 1893.346680 cc
2025-04-28T17:33:55.652Z,1745861635.652 [Reporter](INFO): platform_buoyancy_position 1890.322510 cc
2025-04-28T17:33:56.057Z,1745861636.057 [Reporter](INFO): platform_buoyancy_position 1888.104736 cc
2025-04-28T17:33:56.467Z,1745861636.467 [Reporter](INFO): platform_buoyancy_position 1886.895264 cc
2025-04-28T17:33:56.864Z,1745861636.864 [Reporter](INFO): platform_buoyancy_position 1883.870850 cc
2025-04-28T17:33:57.670Z,1745861637.670 [Reporter](INFO): platform_buoyancy_position 1880.645264 cc
2025-04-28T17:33:58.054Z,1745861638.054 [Reporter](INFO): platform_buoyancy_position 1880.443604 cc
2025-04-28T17:33:58.471Z,1745861638.471 [Reporter](INFO): platform_buoyancy_position 1877.419434 cc
2025-04-28T17:33:59.297Z,1745861639.297 [Reporter](INFO): platform_buoyancy_position 1874.193604 cc
2025-04-28T17:33:59.690Z,1745861639.690 [Reporter](INFO): platform_buoyancy_position 1873.991943 cc
2025-04-28T17:34:00.087Z,1745861640.087 [Reporter](INFO): platform_buoyancy_position 1871.169434 cc
2025-04-28T17:34:00.470Z,1745861640.470 [Reporter](INFO): platform_buoyancy_position 1870.967773 cc
2025-04-28T17:34:00.908Z,1745861640.908 [Reporter](INFO): platform_buoyancy_position 1867.741943 cc
2025-04-28T17:34:01.715Z,1745861641.715 [Reporter](INFO): platform_buoyancy_position 1864.516113 cc
2025-04-28T17:34:02.512Z,1745861642.512 [Reporter](INFO): platform_buoyancy_position 1861.290283 cc
2025-04-28T17:34:02.920Z,1745861642.920 [Reporter](INFO): platform_buoyancy_position 1861.088623 cc
2025-04-28T17:34:03.322Z,1745861643.322 [Reporter](INFO): platform_buoyancy_position 1858.064453 cc
2025-04-28T17:34:03.737Z,1745861643.737 [Reporter](INFO): platform_buoyancy_position 1857.661377 cc
2025-04-28T17:34:04.115Z,1745861644.115 [Reporter](INFO): platform_buoyancy_position 1854.636963 cc
2025-04-28T17:34:04.526Z,1745861644.526 [Reporter](INFO): platform_buoyancy_position 1851.814453 cc
2025-04-28T17:34:04.933Z,1745861644.933 [Reporter](INFO): platform_buoyancy_position 1851.411377 cc
2025-04-28T17:34:05.380Z,1745861645.380 [Reporter](INFO): platform_buoyancy_position 1848.588623 cc
2025-04-28T17:34:05.767Z,1745861645.767 [Reporter](INFO): platform_buoyancy_position 1848.185547 cc
2025-04-28T17:34:06.130Z,1745861646.130 [Reporter](INFO): platform_buoyancy_position 1845.161377 cc
2025-04-28T17:34:06.519Z,1745861646.519 [Reporter](INFO): platform_buoyancy_position 1844.758057 cc
2025-04-28T17:34:06.950Z,1745861646.950 [BuoyancyServo](FAULT): Overload Error
2025-04-28T17:34:06.950Z,1745861646.950 [BuoyancyServo] Hardware Fault, FailCount= 2
2025-04-28T17:34:06.950Z,1745861646.950 [BuoyancyServo](ERROR): Hardware Fault
2025-04-28T17:34:07.063Z,1745861647.063 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2025-04-28T17:34:08.965Z,1745861648.965 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-28T17:34:08.965Z,1745861648.965 [BuoyancyServo](INFO): Powering down
2025-04-28T17:34:09.571Z,1745861649.571 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:34:09.572Z,1745861649.572 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:34:09.573Z,1745861649.573 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:34:09.580Z,1745861649.580 [DAT](INFO): commRate: 800
2025-04-28T17:34:09.801Z,1745861649.801 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-04-28T17:34:09.801Z,1745861649.801 [BuoyancyServo] No Fault, FailCount= 2
2025-04-28T17:34:10.125Z,1745861650.125 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-28T17:34:10.126Z,1745861650.126 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-28T17:34:10.578Z,1745861650.578 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:34:10.579Z,1745861650.579 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:34:12.991Z,1745861652.991 [Reporter](INFO): platform_buoyancy_position 1844.959717 cc
2025-04-28T17:34:13.606Z,1745861653.606 [Reporter](INFO): platform_buoyancy_position 1851.411377 cc
2025-04-28T17:34:14.212Z,1745861654.212 [Reporter](INFO): platform_buoyancy_position 1851.209717 cc
2025-04-28T17:34:14.601Z,1745861654.601 [Reporter](INFO): platform_buoyancy_position 1848.386963 cc
2025-04-28T17:34:15.017Z,1745861655.017 [Reporter](INFO): platform_buoyancy_position 1848.185547 cc
2025-04-28T17:34:15.533Z,1745861655.533 [Reporter](INFO): platform_buoyancy_position 1845.161377 cc
2025-04-28T17:34:15.619Z,1745861655.619 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:34:15.620Z,1745861655.620 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:34:15.621Z,1745861655.621 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:34:15.622Z,1745861655.622 [DAT](INFO): commRate: 800
2025-04-28T17:34:15.849Z,1745861655.849 [Reporter](INFO): platform_buoyancy_position 1829.032227 cc
2025-04-28T17:34:16.627Z,1745861656.627 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:34:16.627Z,1745861656.627 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:34:17.036Z,1745861657.036 [Reporter](INFO): platform_buoyancy_position 1825.806396 cc
2025-04-28T17:34:17.472Z,1745861657.472 [Reporter](INFO): platform_buoyancy_position 1825.000000 cc
2025-04-28T17:34:17.857Z,1745861657.857 [Reporter](INFO): platform_buoyancy_position 1822.580566 cc
2025-04-28T17:34:18.289Z,1745861658.289 [Reporter](INFO): platform_buoyancy_position 1819.354736 cc
2025-04-28T17:34:18.708Z,1745861658.708 [Reporter](INFO): platform_buoyancy_position 1819.153320 cc
2025-04-28T17:34:19.057Z,1745861659.057 [Reporter](INFO): platform_buoyancy_position 1816.128906 cc
2025-04-28T17:34:19.511Z,1745861659.511 [Reporter](INFO): platform_buoyancy_position 1812.903320 cc
2025-04-28T17:34:20.280Z,1745861660.280 [Reporter](INFO): platform_buoyancy_position 1809.677490 cc
2025-04-28T17:34:20.698Z,1745861660.698 [Reporter](INFO): platform_buoyancy_position 1809.475830 cc
2025-04-28T17:34:21.107Z,1745861661.107 [Reporter](INFO): platform_buoyancy_position 1806.250000 cc
2025-04-28T17:34:21.485Z,1745861661.485 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-28T17:29:21.3Z
2025-04-28T17:34:21.485Z,1745861661.485 [Default:CheckIn:Read_GPS] Stopped
2025-04-28T17:34:21.485Z,1745861661.485 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-28T17:34:21.537Z,1745861661.537 [Reporter](INFO): platform_buoyancy_position 1803.830566 cc
2025-04-28T17:34:21.862Z,1745861661.862 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-28T17:34:21.904Z,1745861661.904 [Reporter](INFO): platform_buoyancy_position 1803.225830 cc
2025-04-28T17:34:22.434Z,1745861662.434 [Reporter](INFO): platform_buoyancy_position 1800.201660 cc
2025-04-28T17:34:22.786Z,1745861662.786 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250428T172523/Courier0004.lzma
2025-04-28T17:34:22.835Z,1745861662.835 [Reporter](INFO): platform_buoyancy_position 1799.798340 cc
2025-04-28T17:34:23.237Z,1745861663.237 [Reporter](INFO): platform_buoyancy_position 1796.572510 cc
2025-04-28T17:34:23.283Z,1745861663.283 [DataOverHttps](INFO): Moved sent file to Logs/20250428T172523/Courier0004.lzma.bak
2025-04-28T17:34:23.284Z,1745861663.284 [DataOverHttps](INFO): SBD MOMSN=24739287
2025-04-28T17:34:23.656Z,1745861663.656 [Reporter](INFO): platform_buoyancy_position 1796.370850 cc
2025-04-28T17:34:24.033Z,1745861664.033 [Reporter](INFO): platform_buoyancy_position 1793.548340 cc
2025-04-28T17:34:24.432Z,1745861664.432 [Reporter](INFO): platform_buoyancy_position 1790.524170 cc
2025-04-28T17:34:24.866Z,1745861664.866 [Reporter](INFO): platform_buoyancy_position 1790.322510 cc
2025-04-28T17:34:25.256Z,1745861665.256 [Reporter](INFO): platform_buoyancy_position 1787.096680 cc
2025-04-28T17:34:26.032Z,1745861666.032 [Reporter](INFO): platform_buoyancy_position 1783.669434 cc
2025-04-28T17:34:26.443Z,1745861666.443 [Reporter](INFO): platform_buoyancy_position 1783.467773 cc
2025-04-28T17:34:26.862Z,1745861666.862 [Reporter](INFO): platform_buoyancy_position 1780.645264 cc
2025-04-28T17:34:27.276Z,1745861667.276 [Reporter](INFO): platform_buoyancy_position 1777.419434 cc
2025-04-28T17:34:27.738Z,1745861667.738 [Reporter](INFO): platform_buoyancy_position 1777.217773 cc
2025-04-28T17:34:28.073Z,1745861668.073 [Reporter](INFO): platform_buoyancy_position 1773.991943 cc
2025-04-28T17:34:28.474Z,1745861668.474 [Reporter](INFO): platform_buoyancy_position 1774.193604 cc
2025-04-28T17:34:28.878Z,1745861668.878 [Reporter](INFO): platform_buoyancy_position 1770.766113 cc
2025-04-28T17:34:29.319Z,1745861669.319 [Reporter](INFO): platform_buoyancy_position 1770.967773 cc
2025-04-28T17:34:29.480Z,1745861669.480 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:34:29.480Z,1745861669.480 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:34:29.732Z,1745861669.732 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:34:29.732Z,1745861669.732 [DAT](INFO): commRate: 800
2025-04-28T17:34:29.740Z,1745861669.740 [Reporter](INFO): platform_buoyancy_position 1767.741943 cc
2025-04-28T17:34:30.103Z,1745861670.103 [Reporter](INFO): platform_buoyancy_position 1767.338623 cc
2025-04-28T17:34:30.487Z,1745861670.487 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:34:30.488Z,1745861670.488 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:34:30.516Z,1745861670.516 [Reporter](INFO): platform_buoyancy_position 1764.516113 cc
2025-04-28T17:34:30.917Z,1745861670.917 [Reporter](INFO): platform_buoyancy_position 1764.314453 cc
2025-04-28T17:34:31.333Z,1745861671.333 [Reporter](INFO): platform_buoyancy_position 1761.290283 cc
2025-04-28T17:34:31.758Z,1745861671.758 [Reporter](INFO): platform_buoyancy_position 1758.266113 cc
2025-04-28T17:34:32.104Z,1745861672.104 [Reporter](INFO): platform_buoyancy_position 1758.064453 cc
2025-04-28T17:34:32.490Z,1745861672.490 [BuoyancyServo](FAULT): Overload Error
2025-04-28T17:34:32.490Z,1745861672.490 [BuoyancyServo] Hardware Fault, FailCount= 3
2025-04-28T17:34:32.490Z,1745861672.490 [BuoyancyServo](ERROR): Hardware Fault
2025-04-28T17:34:32.606Z,1745861672.606 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2025-04-28T17:34:34.487Z,1745861674.487 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-28T17:34:34.487Z,1745861674.487 [BuoyancyServo](INFO): Powering down
2025-04-28T17:34:35.404Z,1745861675.404 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-04-28T17:34:35.404Z,1745861675.404 [BuoyancyServo] No Fault, FailCount= 3
2025-04-28T17:34:35.660Z,1745861675.660 [CommandExec](IMPORTANT): got command maintain clear
2025-04-28T17:34:35.777Z,1745861675.777 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-04-28T17:34:35.777Z,1745861675.777 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-28T17:34:35.783Z,1745861675.783 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2025-04-28T17:34:35.783Z,1745861675.783 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2025-04-28T17:34:35.799Z,1745861675.799 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-28T17:34:35.807Z,1745861675.807 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-28T17:34:35.821Z,1745861675.821 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-28T17:34:35.821Z,1745861675.821 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2025-04-28T17:34:35.831Z,1745861675.831 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DepthKeller33X,NAL9602,Power24vConverter,RDI_Pathfinder,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-28T17:34:36.104Z,1745861676.104 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-28T17:34:36.104Z,1745861676.104 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-04-28T17:34:36.104Z,1745861676.104 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2025-04-28T17:34:36.104Z,1745861676.104 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2025-04-28T17:34:38.984Z,1745861678.984 [Reporter](INFO): platform_buoyancy_position 1757.862793 cc
2025-04-28T17:34:39.563Z,1745861679.563 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:34:39.564Z,1745861679.564 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:34:39.565Z,1745861679.565 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:34:39.565Z,1745861679.565 [DAT](INFO): commRate: 800
2025-04-28T17:34:39.617Z,1745861679.617 [Reporter](INFO): platform_buoyancy_position 1764.112793 cc
2025-04-28T17:34:39.860Z,1745861679.860 [Reporter](INFO): platform_buoyancy_position 1764.314453 cc
2025-04-28T17:34:40.571Z,1745861680.571 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:34:40.572Z,1745861680.572 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:34:41.003Z,1745861681.003 [Reporter](INFO): platform_buoyancy_position 1767.338623 cc
2025-04-28T17:34:41.023Z,1745861681.023 [DataOverHttps](INFO): Sending 483 bytes from file Logs/20250428T172523/Express0005.lzma
2025-04-28T17:34:41.452Z,1745861681.452 [Reporter](INFO): platform_buoyancy_position 1768.145264 cc
2025-04-28T17:34:41.833Z,1745861681.833 [Reporter](INFO): platform_buoyancy_position 1757.862793 cc
2025-04-28T17:34:42.024Z,1745861682.024 [DataOverHttps](INFO): Moved sent file to Logs/20250428T172523/Express0005.lzma.bak
2025-04-28T17:34:42.024Z,1745861682.024 [DataOverHttps](INFO): SBD MOMSN=24739289
2025-04-28T17:34:42.222Z,1745861682.222 [Reporter](INFO): platform_buoyancy_position 1763.508057 cc
2025-04-28T17:34:42.596Z,1745861682.596 [Reporter](INFO): platform_buoyancy_position 1766.935547 cc
2025-04-28T17:34:43.025Z,1745861683.025 [Reporter](INFO): platform_buoyancy_position 1773.790283 cc
2025-04-28T17:34:43.539Z,1745861683.539 [Reporter](INFO): platform_buoyancy_position 1777.419434 cc
2025-04-28T17:34:43.838Z,1745861683.838 [Reporter](INFO): platform_buoyancy_position 1781.048340 cc
2025-04-28T17:34:44.206Z,1745861684.206 [Default:CheckIn:Read_Iridium] Stopped
2025-04-28T17:34:44.206Z,1745861684.206 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-28T17:34:44.206Z,1745861684.206 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-28T17:34:44.259Z,1745861684.259 [Reporter](INFO): platform_buoyancy_position 1787.096680 cc
2025-04-28T17:34:44.616Z,1745861684.616 [Reporter](INFO): platform_buoyancy_position 1790.120850 cc
2025-04-28T17:34:45.033Z,1745861685.033 [Reporter](INFO): platform_buoyancy_position 1794.758057 cc
2025-04-28T17:34:45.523Z,1745861685.523 [Reporter](INFO): platform_buoyancy_position 1800.000000 cc
2025-04-28T17:34:45.841Z,1745861685.841 [Reporter](INFO): platform_buoyancy_position 1803.225830 cc
2025-04-28T17:34:46.281Z,1745861686.281 [Reporter](INFO): platform_buoyancy_position 1809.475830 cc
2025-04-28T17:34:46.656Z,1745861686.656 [Reporter](INFO): platform_buoyancy_position 1812.701660 cc
2025-04-28T17:34:47.079Z,1745861687.079 [Reporter](INFO): platform_buoyancy_position 1815.927490 cc
2025-04-28T17:34:47.520Z,1745861687.520 [Reporter](INFO): platform_buoyancy_position 1822.378906 cc
2025-04-28T17:34:47.869Z,1745861687.869 [Reporter](INFO): platform_buoyancy_position 1825.604736 cc
2025-04-28T17:34:48.291Z,1745861688.291 [Reporter](INFO): platform_buoyancy_position 1828.830566 cc
2025-04-28T17:34:48.703Z,1745861688.703 [Reporter](INFO): platform_buoyancy_position 1832.258057 cc
2025-04-28T17:34:49.076Z,1745861689.076 [Reporter](INFO): platform_buoyancy_position 1835.685547 cc
2025-04-28T17:34:49.525Z,1745861689.525 [Reporter](INFO): platform_buoyancy_position 1841.733887 cc
2025-04-28T17:34:49.904Z,1745861689.904 [Reporter](INFO): platform_buoyancy_position 1845.161377 cc
2025-04-28T17:34:50.301Z,1745861690.301 [Reporter](INFO): platform_buoyancy_position 1848.386963 cc
2025-04-28T17:34:50.713Z,1745861690.713 [Reporter](INFO): platform_buoyancy_position 1854.435547 cc
2025-04-28T17:34:51.084Z,1745861691.084 [Reporter](INFO): platform_buoyancy_position 1857.862793 cc
2025-04-28T17:34:51.527Z,1745861691.527 [Reporter](INFO): platform_buoyancy_position 1861.290283 cc
2025-04-28T17:34:51.892Z,1745861691.892 [Reporter](INFO): platform_buoyancy_position 1864.516113 cc
2025-04-28T17:34:52.324Z,1745861692.324 [Reporter](INFO): platform_buoyancy_position 1870.766113 cc
2025-04-28T17:34:52.748Z,1745861692.748 [Reporter](INFO): platform_buoyancy_position 1873.991943 cc
2025-04-28T17:34:53.117Z,1745861693.117 [Reporter](INFO): platform_buoyancy_position 1877.217773 cc
2025-04-28T17:34:53.563Z,1745861693.563 [Reporter](INFO): platform_buoyancy_position 1880.645264 cc
2025-04-28T17:34:53.977Z,1745861693.977 [Reporter](INFO): platform_buoyancy_position 1883.870850 cc
2025-04-28T17:34:54.348Z,1745861694.348 [Reporter](INFO): platform_buoyancy_position 1887.096680 cc
2025-04-28T17:34:54.751Z,1745861694.751 [Reporter](INFO): platform_buoyancy_position 1893.346680 cc
2025-04-28T17:34:55.177Z,1745861695.177 [Reporter](INFO): platform_buoyancy_position 1896.774170 cc
2025-04-28T17:34:55.654Z,1745861695.654 [Reporter](INFO): platform_buoyancy_position 1903.024170 cc
2025-04-28T17:34:55.696Z,1745861695.696 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:34:55.697Z,1745861695.697 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:34:55.698Z,1745861695.698 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:34:55.698Z,1745861695.698 [DAT](INFO): commRate: 800
2025-04-28T17:34:55.945Z,1745861695.945 [Reporter](INFO): platform_buoyancy_position 1906.250000 cc
2025-04-28T17:34:56.369Z,1745861696.369 [Reporter](INFO): platform_buoyancy_position 1909.475830 cc
2025-04-28T17:34:56.451Z,1745861696.451 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:34:56.451Z,1745861696.451 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:34:56.777Z,1745861696.777 [Reporter](INFO): platform_buoyancy_position 1912.903320 cc
2025-04-28T17:34:57.175Z,1745861697.175 [Reporter](INFO): platform_buoyancy_position 1915.927490 cc
2025-04-28T17:34:57.623Z,1745861697.623 [Reporter](INFO): platform_buoyancy_position 1922.378906 cc
2025-04-28T17:34:57.989Z,1745861697.989 [Reporter](INFO): platform_buoyancy_position 1925.806396 cc
2025-04-28T17:34:58.393Z,1745861698.393 [Reporter](INFO): platform_buoyancy_position 1929.032227 cc
2025-04-28T17:34:58.796Z,1745861698.796 [Reporter](INFO): platform_buoyancy_position 1933.266113 cc
2025-04-28T17:34:59.199Z,1745861699.198 [Reporter](INFO): platform_buoyancy_position 1938.508057 cc
2025-04-28T17:34:59.614Z,1745861699.614 [Reporter](INFO): platform_buoyancy_position 1941.935547 cc
2025-04-28T17:34:59.988Z,1745861699.988 [Reporter](INFO): platform_buoyancy_position 1945.161377 cc
2025-04-28T17:35:00.395Z,1745861700.395 [Reporter](INFO): platform_buoyancy_position 1948.588623 cc
2025-04-28T17:35:00.809Z,1745861700.809 [Reporter](INFO): platform_buoyancy_position 1954.636963 cc
2025-04-28T17:35:01.228Z,1745861701.228 [Reporter](INFO): platform_buoyancy_position 1958.064453 cc
2025-04-28T17:35:01.640Z,1745861701.640 [Reporter](INFO): platform_buoyancy_position 1961.290405 cc
2025-04-28T17:35:02.019Z,1745861702.019 [Reporter](INFO): platform_buoyancy_position 1964.515991 cc
2025-04-28T17:35:02.409Z,1745861702.409 [Reporter](INFO): platform_buoyancy_position 1967.741821 cc
2025-04-28T17:35:02.820Z,1745861702.820 [Reporter](INFO): platform_buoyancy_position 1973.991943 cc
2025-04-28T17:35:03.240Z,1745861703.240 [Reporter](INFO): platform_buoyancy_position 1977.217896 cc
2025-04-28T17:35:03.791Z,1745861703.791 [Reporter](INFO): platform_buoyancy_position 1980.443726 cc
2025-04-28T17:35:04.172Z,1745861704.172 [Reporter](INFO): platform_buoyancy_position 1983.669312 cc
2025-04-28T17:35:04.553Z,1745861704.553 [Reporter](INFO): platform_buoyancy_position 1987.096680 cc
2025-04-28T17:35:04.952Z,1745861704.952 [Reporter](INFO): platform_buoyancy_position 1990.322510 cc
2025-04-28T17:35:23.683Z,1745861723.683 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:35:23.683Z,1745861723.683 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:35:23.684Z,1745861723.684 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:35:23.684Z,1745861723.684 [DAT](INFO): commRate: 800
2025-04-28T17:35:24.439Z,1745861724.439 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:35:24.439Z,1745861724.439 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:35:37.543Z,1745861737.543 [DAT](INFO): DAT read: Acoustic Wakeup
2025-04-28T17:35:37.543Z,1745861737.543 [DAT](INFO): unknown deviceResponse_: Acoustic Wakeup
2025-04-28T17:35:37.544Z,1745861737.544 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-04-28T17:35:37.545Z,1745861737.545 [DAT](INFO): commRate: 800
2025-04-28T17:35:38.550Z,1745861738.550 [DAT](INFO): DAT read: Lowpower
2025-04-28T17:35:38.551Z,1745861738.551 [DAT](INFO): unknown deviceResponse_: Lowpower
2025-04-28T17:35:58.531Z,1745861758.531 [CommandExec](IMPORTANT): got command restart application
2025-04-28T17:35:59.534Z,1745861759.534 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2025-04-28T17:35:59.534Z,1745861759.534 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:35:59.534Z,1745861759.534 [CommandExec](INFO): Uninitializing the command executive.
2025-04-28T17:35:59.534Z,1745861759.534 [CommandExec](INFO): Uninitializing the command scheduler.
2025-04-28T17:35:59.534Z,1745861759.534 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:35:59.714Z,1745861759.714 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-04-28T17:35:59.714Z,1745861759.714 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-04-28T17:35:59.714Z,1745861759.714 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:35:59.715Z,1745861759.715 [NavChartDb](INFO): Join timeout helper Thread ID is 1435
2025-04-28T17:35:59.914Z,1745861759.914 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:35:59.914Z,1745861759.914 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:35:59.934Z,1745861759.934 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-04-28T17:35:59.934Z,1745861759.934 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:35:59.935Z,1745861759.935 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1436
2025-04-28T17:36:00.122Z,1745861760.122 [CTD_Seabird](INFO): Powering down
2025-04-28T17:36:00.136Z,1745861760.136 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:00.137Z,1745861760.137 [CTD_Seabird](INFO): Powering down
2025-04-28T17:36:00.158Z,1745861760.158 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:00.174Z,1745861760.174 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-04-28T17:36:00.174Z,1745861760.174 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:00.174Z,1745861760.174 [Radio_Surface](INFO): Join timeout helper Thread ID is 1437
2025-04-28T17:36:00.242Z,1745861760.242 [Radio_Surface](INFO): Powering down
2025-04-28T17:36:00.243Z,1745861760.243 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:00.243Z,1745861760.243 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:00.250Z,1745861760.250 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-04-28T17:36:00.250Z,1745861760.250 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:00.250Z,1745861760.250 [Onboard](INFO): Join timeout helper Thread ID is 1438
2025-04-28T17:36:01.106Z,1745861761.106 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-04-28T17:36:04.010Z,1745861764.010 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:04.011Z,1745861764.011 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.026Z,1745861764.026 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-04-28T17:36:04.026Z,1745861764.026 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.026Z,1745861764.026 [DataOverHttps](INFO): Join timeout helper Thread ID is 1439
2025-04-28T17:36:04.118Z,1745861764.118 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:04.118Z,1745861764.118 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.135Z,1745861764.135 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-04-28T17:36:04.135Z,1745861764.135 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.135Z,1745861764.135 [DAT](INFO): Join timeout helper Thread ID is 1440
2025-04-28T17:36:04.266Z,1745861764.266 [DAT](INFO): Powering down
2025-04-28T17:36:04.334Z,1745861764.334 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:04.335Z,1745861764.335 [DAT](INFO): Powering down
2025-04-28T17:36:04.335Z,1745861764.335 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.354Z,1745861764.354 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-04-28T17:36:04.355Z,1745861764.355 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.355Z,1745861764.355 [BackseatComponent](INFO): Join timeout helper Thread ID is 1441
2025-04-28T17:36:04.446Z,1745861764.446 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:04.446Z,1745861764.446 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.455Z,1745861764.455 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-04-28T17:36:04.455Z,1745861764.455 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.455Z,1745861764.455 [logger](INFO): Join timeout helper Thread ID is 1442
2025-04-28T17:36:04.462Z,1745861764.462 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:04.462Z,1745861764.462 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.475Z,1745861764.475 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-04-28T17:36:04.475Z,1745861764.475 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.475Z,1745861764.475 [CommandLine](INFO): Join timeout helper Thread ID is 1443
2025-04-28T17:36:04.486Z,1745861764.486 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:04.486Z,1745861764.486 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.494Z,1745861764.494 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-04-28T17:36:04.494Z,1745861764.494 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.495Z,1745861764.495 [CommandExec](INFO): Join timeout helper Thread ID is 1444
2025-04-28T17:36:04.496Z,1745861764.496 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-04-28T17:36:04.496Z,1745861764.496 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.497Z,1745861764.497 [controlThread](INFO): Join timeout helper Thread ID is 1445
2025-04-28T17:36:04.582Z,1745861764.582 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-28T17:36:04.583Z,1745861764.583 [controlThread](DEBUG): Uninitializing ControlThread
2025-04-28T17:36:04.583Z,1745861764.583 [AHRS_M2](INFO): Powering down
2025-04-28T17:36:04.654Z,1745861764.654 [DepthKeller33X](INFO): Powering down
2025-04-28T17:36:04.750Z,1745861764.750 [NAL9602](INFO): Powering down
2025-04-28T17:36:04.822Z,1745861764.822 [RDI_Pathfinder](INFO): Powering down
2025-04-28T17:36:04.823Z,1745861764.823 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-04-28T17:36:04.824Z,1745861764.824 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-04-28T17:36:04.824Z,1745861764.824 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-04-28T17:36:04.825Z,1745861764.825 [MissionManager](INFO): Uninitializing Mission Default
2025-04-28T17:36:04.825Z,1745861764.825 [Default] Stopped
2025-04-28T17:36:04.825Z,1745861764.825 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-28T17:36:04.825Z,1745861764.825 [Default:B.GoToSurface] Stopped
2025-04-28T17:36:04.825Z,1745861764.825 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-28T17:36:04.825Z,1745861764.825 [Default:CheckIn] Stopped
2025-04-28T17:36:04.825Z,1745861764.825 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-28T17:36:04.825Z,1745861764.825 [Default:CheckIn:C.Wait] Stopped
2025-04-28T17:36:04.825Z,1745861764.825 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-28T17:36:04.829Z,1745861764.829 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-04-28T17:36:04.829Z,1745861764.829 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-04-28T17:36:04.829Z,1745861764.829 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-04-28T17:36:04.830Z,1745861764.830 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-04-28T17:36:04.830Z,1745861764.830 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-28T17:36:04.830Z,1745861764.830 [BuoyancyServo](INFO): Powering down
2025-04-28T17:36:04.842Z,1745861764.842 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-28T17:36:04.842Z,1745861764.842 [ElevatorServo](INFO): Powering down
2025-04-28T17:36:04.843Z,1745861764.843 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-28T17:36:04.843Z,1745861764.843 [MassServo](INFO): Powering down
2025-04-28T17:36:04.844Z,1745861764.844 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-28T17:36:04.844Z,1745861764.844 [RudderServo](INFO): Powering down
2025-04-28T17:36:04.844Z,1745861764.844 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-28T17:36:04.845Z,1745861764.845 [ThrusterHE](INFO): Powering down
2025-04-28T17:36:04.845Z,1745861764.845 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-04-28T17:36:04.846Z,1745861764.846 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-04-28T17:36:04.846Z,1745861764.846 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-04-28T17:36:04.846Z,1745861764.846 [CBIT](DEBUG): Powering off loads.
2025-04-28T17:36:04.858Z,1745861764.858 [CBIT](DEBUG): Disabling WDT.
2025-04-28T17:36:04.870Z,1745861764.870 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-28T17:36:04.870Z,1745861764.870 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-28T17:36:04.871Z,1745861764.871 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.893Z,1745861764.893 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.896Z,1745861764.896 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.902Z,1745861764.902 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.908Z,1745861764.908 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.912Z,1745861764.912 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.959Z,1745861764.959 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:04.000Z,1745861765.000 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-28T17:36:04.000Z,1745861765.000 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-28T17:36:05.018Z,1745861765.018 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-28T17:36:05.082Z,1745861765.082 [logger ThreadHandler](INFO): Thread cancelled.