2025-06-17T21:54:18.328Z,1750197258.328 [Supervisor](DEBUG): Initializing supervisor.
2025-06-17T21:54:18.333Z,1750197258.333 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-06-17T21:54:18.334Z,1750197258.334 [SyncHandler](INFO): Protected caller Thread ID is 1007
2025-06-17T21:54:18.334Z,1750197258.334 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-06-17T21:54:18.336Z,1750197258.336 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-06-17T21:54:18.336Z,1750197258.336 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1008
2025-06-17T21:54:18.341Z,1750197258.341 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-06-17T21:54:18.361Z,1750197258.361 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-06-17T21:54:18.362Z,1750197258.362 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-06-17T21:54:18.363Z,1750197258.363 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1009
2025-06-17T21:54:18.367Z,1750197258.367 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-06-17T21:54:18.368Z,1750197258.368 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-06-17T21:54:18.368Z,1750197258.368 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1010
2025-06-17T21:54:18.371Z,1750197258.371 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-06-17T21:54:18.372Z,1750197258.372 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-06-17T21:54:18.372Z,1750197258.372 [logger ThreadHandler](INFO): Protected caller Thread ID is 1011
2025-06-17T21:54:18.376Z,1750197258.376 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-06-17T21:54:18.376Z,1750197258.376 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-06-17T21:54:18.378Z,1750197258.378 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-06-17T21:54:18.483Z,1750197258.483 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-06-17T21:54:18.483Z,1750197258.483 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-06-17T21:54:18.714Z,1750197258.714 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-06-17T21:54:18.715Z,1750197258.715 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-06-17T21:54:18.983Z,1750197258.983 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-06-17T21:54:18.984Z,1750197258.984 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-06-17T21:54:19.100Z,1750197259.100 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-06-17T21:54:19.100Z,1750197259.100 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-06-17T21:54:19.860Z,1750197259.860 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-06-17T21:54:19.861Z,1750197259.861 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-06-17T21:54:20.381Z,1750197260.381 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-06-17T21:54:20.382Z,1750197260.382 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-06-17T21:54:20.935Z,1750197260.935 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-06-17T21:54:20.936Z,1750197260.936 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-06-17T21:54:21.360Z,1750197261.360 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-06-17T21:54:21.361Z,1750197261.361 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-06-17T21:54:21.721Z,1750197261.721 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-06-17T21:54:21.722Z,1750197261.722 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-06-17T21:54:22.110Z,1750197262.110 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-06-17T21:54:22.111Z,1750197262.111 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-06-17T21:54:22.345Z,1750197262.345 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-06-17T21:54:22.346Z,1750197262.346 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-06-17T21:54:22.522Z,1750197262.522 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-06-17T21:54:22.522Z,1750197262.522 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-06-17T21:54:22.767Z,1750197262.767 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-06-17T21:54:22.768Z,1750197262.768 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-06-17T21:54:23.002Z,1750197263.002 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-06-17T21:54:23.329Z,1750197263.329 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-06-17T21:54:23.330Z,1750197263.330 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-06-17T21:54:23.586Z,1750197263.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-06-17T21:54:23.588Z,1750197263.588 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2025-06-17T21:54:23.589Z,1750197263.589 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2025-06-17T21:54:23.681Z,1750197263.681 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2025-06-17T21:54:23.957Z,1750197263.957 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-06-17T21:54:23.957Z,1750197263.957 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2025-06-17T21:54:24.052Z,1750197264.052 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2025-06-17T21:54:24.231Z,1750197264.231 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2025-06-17T21:54:24.341Z,1750197264.341 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2025-06-17T21:54:24.461Z,1750197264.461 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2025-06-17T21:54:24.583Z,1750197264.583 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2025-06-17T21:54:24.687Z,1750197264.687 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2025-06-17T21:54:24.858Z,1750197264.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg
2025-06-17T21:54:24.965Z,1750197264.965 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg
2025-06-17T21:54:25.059Z,1750197265.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2025-06-17T21:54:25.166Z,1750197265.166 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2025-06-17T21:54:25.264Z,1750197265.264 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2025-06-17T21:54:25.264Z,1750197265.264 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-06-17T21:54:25.275Z,1750197265.275 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-06-17T21:54:25.462Z,1750197265.462 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-06-17T21:54:25.462Z,1750197265.462 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-06-17T21:54:25.630Z,1750197265.630 [BuoyancyServo] Loaded
2025-06-17T21:54:25.630Z,1750197265.630 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-06-17T21:54:25.654Z,1750197265.654 [ElevatorServo] Loaded
2025-06-17T21:54:25.654Z,1750197265.654 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-06-17T21:54:25.677Z,1750197265.677 [MassServo] Loaded
2025-06-17T21:54:25.677Z,1750197265.677 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-06-17T21:54:25.699Z,1750197265.699 [RudderServo] Loaded
2025-06-17T21:54:25.699Z,1750197265.699 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-06-17T21:54:25.717Z,1750197265.717 [ThrusterHE] Loaded
2025-06-17T21:54:25.717Z,1750197265.717 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-06-17T21:54:25.718Z,1750197265.718 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-06-17T21:54:25.718Z,1750197265.718 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-06-17T21:54:25.888Z,1750197265.888 [SBIT](DEBUG): Construct Startup Built In Test.
2025-06-17T21:54:25.904Z,1750197265.904 [SBIT] Loaded
2025-06-17T21:54:25.904Z,1750197265.904 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-06-17T21:54:25.907Z,1750197265.907 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-06-17T21:54:25.928Z,1750197265.928 [IBIT] Loaded
2025-06-17T21:54:25.928Z,1750197265.928 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-06-17T21:54:25.934Z,1750197265.934 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-06-17T21:54:26.130Z,1750197266.130 [CBIT] Loaded
2025-06-17T21:54:26.130Z,1750197266.130 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-06-17T21:54:26.161Z,1750197266.161 [GFScanner] Loaded
2025-06-17T21:54:26.161Z,1750197266.161 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-06-17T21:54:26.162Z,1750197266.162 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-06-17T21:54:26.162Z,1750197266.162 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-06-17T21:54:26.336Z,1750197266.336 [CTD_Seabird] Loaded
2025-06-17T21:54:26.337Z,1750197266.337 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-06-17T21:54:26.338Z,1750197266.338 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406864E0
2025-06-17T21:54:26.338Z,1750197266.338 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1099
2025-06-17T21:54:26.373Z,1750197266.373 [ESPComponent] Loaded
2025-06-17T21:54:26.373Z,1750197266.373 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-06-17T21:54:26.395Z,1750197266.395 [PAR_Licor] Loaded
2025-06-17T21:54:26.396Z,1750197266.396 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-06-17T21:54:26.441Z,1750197266.441 [WetLabsBB2FL] Loaded
2025-06-17T21:54:26.441Z,1750197266.441 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-06-17T21:54:26.442Z,1750197266.442 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B64E0
2025-06-17T21:54:26.443Z,1750197266.443 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1100
2025-06-17T21:54:26.443Z,1750197266.443 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-06-17T21:54:26.444Z,1750197266.444 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-06-17T21:54:26.497Z,1750197266.497 [DepthRateCalculator] Loaded
2025-06-17T21:54:26.497Z,1750197266.497 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-06-17T21:54:26.502Z,1750197266.502 [PitchRateCalculator] Loaded
2025-06-17T21:54:26.503Z,1750197266.503 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-06-17T21:54:26.513Z,1750197266.513 [SpeedCalculator] Loaded
2025-06-17T21:54:26.513Z,1750197266.513 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-06-17T21:54:26.518Z,1750197266.518 [YawRateCalculator] Loaded
2025-06-17T21:54:26.518Z,1750197266.518 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-06-17T21:54:26.538Z,1750197266.538 [ElevatorOffsetCalculator] Loaded
2025-06-17T21:54:26.539Z,1750197266.539 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-06-17T21:54:26.539Z,1750197266.539 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-06-17T21:54:26.540Z,1750197266.540 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-06-17T21:54:26.683Z,1750197266.683 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-06-17T21:54:26.683Z,1750197266.683 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-06-17T21:54:26.714Z,1750197266.714 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-06-17T21:54:26.714Z,1750197266.714 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-06-17T21:54:26.830Z,1750197266.830 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-06-17T21:54:26.830Z,1750197266.830 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-06-17T21:54:26.844Z,1750197266.844 [NavChart] Loaded
2025-06-17T21:54:26.845Z,1750197266.845 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-06-17T21:54:26.850Z,1750197266.850 [UniversalFixResidualReporter] Loaded
2025-06-17T21:54:26.851Z,1750197266.851 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-06-17T21:54:26.851Z,1750197266.851 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-06-17T21:54:26.852Z,1750197266.852 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-06-17T21:54:27.349Z,1750197267.349 [AHRS_M2] Loaded
2025-06-17T21:54:27.349Z,1750197267.349 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-06-17T21:54:27.388Z,1750197267.388 [BackseatComponent] Loaded
2025-06-17T21:54:27.389Z,1750197267.389 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-06-17T21:54:27.390Z,1750197267.390 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A824E0
2025-06-17T21:54:27.390Z,1750197267.390 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1101
2025-06-17T21:54:27.393Z,1750197267.393 [LcmUniversalReporter] Loaded
2025-06-17T21:54:27.393Z,1750197267.393 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-06-17T21:54:28.138Z,1750197268.138 [BPC1] Loaded
2025-06-17T21:54:28.139Z,1750197268.139 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-06-17T21:54:28.240Z,1750197268.240 [DAT] Loaded
2025-06-17T21:54:28.240Z,1750197268.240 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-06-17T21:54:28.241Z,1750197268.241 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AB24E0
2025-06-17T21:54:28.241Z,1750197268.241 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1102
2025-06-17T21:54:28.315Z,1750197268.315 [DataOverHttps] Loaded
2025-06-17T21:54:28.316Z,1750197268.316 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-06-17T21:54:28.317Z,1750197268.317 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AE24E0
2025-06-17T21:54:28.317Z,1750197268.317 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1103
2025-06-17T21:54:28.341Z,1750197268.341 [Depth_Keller] Loaded
2025-06-17T21:54:28.341Z,1750197268.341 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-06-17T21:54:28.346Z,1750197268.346 [DropWeight] Loaded
2025-06-17T21:54:28.346Z,1750197268.346 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-06-17T21:54:28.388Z,1750197268.388 [DVL_micro] Loaded
2025-06-17T21:54:28.388Z,1750197268.388 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2025-06-17T21:54:28.451Z,1750197268.451 [NAL9602] Loaded
2025-06-17T21:54:28.451Z,1750197268.451 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-06-17T21:54:28.477Z,1750197268.477 [Onboard] Loaded
2025-06-17T21:54:28.478Z,1750197268.478 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-06-17T21:54:28.479Z,1750197268.479 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B124E0
2025-06-17T21:54:28.479Z,1750197268.479 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1104
2025-06-17T21:54:28.485Z,1750197268.485 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1
2025-06-17T21:54:28.499Z,1750197268.499 [PowerOnly] Loaded
2025-06-17T21:54:28.499Z,1750197268.499 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2025-06-17T21:54:28.513Z,1750197268.513 [Power24vConverter] Loaded
2025-06-17T21:54:28.514Z,1750197268.514 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-06-17T21:54:28.530Z,1750197268.530 [Radio_Surface] Loaded
2025-06-17T21:54:28.530Z,1750197268.530 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-06-17T21:54:28.531Z,1750197268.531 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B424E0
2025-06-17T21:54:28.532Z,1750197268.532 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1105
2025-06-17T21:54:28.547Z,1750197268.547 [Sonardyne_Nano] Loaded
2025-06-17T21:54:28.548Z,1750197268.548 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-06-17T21:54:28.548Z,1750197268.548 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-06-17T21:54:28.549Z,1750197268.549 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-06-17T21:54:28.781Z,1750197268.781 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-06-17T21:54:28.782Z,1750197268.782 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-06-17T21:54:28.925Z,1750197268.925 [VerticalControl](DEBUG): Construct VerticalControl.
2025-06-17T21:54:29.064Z,1750197269.064 [VerticalControl] Loaded
2025-06-17T21:54:29.064Z,1750197269.064 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-06-17T21:54:29.067Z,1750197269.067 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-06-17T21:54:29.141Z,1750197269.141 [HorizontalControl] Loaded
2025-06-17T21:54:29.141Z,1750197269.141 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-06-17T21:54:29.144Z,1750197269.144 [SpeedControl](DEBUG): Construct SpeedControl.
2025-06-17T21:54:29.145Z,1750197269.145 [SpeedControl] Loaded
2025-06-17T21:54:29.146Z,1750197269.146 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-06-17T21:54:29.154Z,1750197269.154 [LoopControl](DEBUG): Construct LoopControl.
2025-06-17T21:54:29.154Z,1750197269.154 [LoopControl] Loaded
2025-06-17T21:54:29.155Z,1750197269.155 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-06-17T21:54:29.155Z,1750197269.155 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-06-17T21:54:29.155Z,1750197269.155 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-06-17T21:54:29.166Z,1750197269.166 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-06-17T21:54:29.167Z,1750197269.167 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-06-17T21:54:29.537Z,1750197269.537 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-06-17T21:54:29.544Z,1750197269.544 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-06-17T21:54:29.547Z,1750197269.547 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-06-17T21:54:29.558Z,1750197269.558 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-06-17T21:54:29.559Z,1750197269.559 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0
2025-06-17T21:54:29.560Z,1750197269.560 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1106
2025-06-17T21:54:29.564Z,1750197269.564 [Supervisor](INFO): Main Thread ID is 827
2025-06-17T21:54:29.564Z,1750197269.564 [Supervisor](DEBUG): Running supervisor.
2025-06-17T21:54:29.565Z,1750197269.565 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1107
2025-06-17T21:54:29.566Z,1750197269.566 [CommandExec](INFO): Initializing the command executive.
2025-06-17T21:54:29.567Z,1750197269.567 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1108
2025-06-17T21:54:29.569Z,1750197269.569 [controlThread ThreadHandler](INFO): Handler Thread ID is 1109
2025-06-17T21:54:29.570Z,1750197269.570 [controlThread](DEBUG): Initializing ControlThread
2025-06-17T21:54:29.572Z,1750197269.572 [SBIT](INFO): Initialize SBIT Component.
2025-06-17T21:54:29.572Z,1750197269.572 [SBIT](IMPORTANT): git: 2025-05-29
2025-06-17T21:54:29.572Z,1750197269.572 [SBIT](INFO): git hash: c78c975c7bb2a66b27244d2837f68dff299fa024
2025-06-17T21:54:29.573Z,1750197269.573 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-06-17T21:54:29.574Z,1750197269.574 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2025-06-17T21:54:29.575Z,1750197269.575 [SBIT](INFO): Beginning SBIT in 151.000000 seconds.
2025-06-17T21:54:29.576Z,1750197269.576 [IBIT](INFO): Initialize IBIT Component.
2025-06-17T21:54:29.577Z,1750197269.577 [CBIT](DEBUG): Initialize CBIT Component.
2025-06-17T21:54:29.577Z,1750197269.577 [logger ThreadHandler](INFO): Handler Thread ID is 1110
2025-06-17T21:54:29.588Z,1750197269.588 [CBIT](DEBUG): Initialized mux pins.
2025-06-17T21:54:29.588Z,1750197269.588 [CBIT](DEBUG): Initializing the watchdog timer.
2025-06-17T21:54:29.596Z,1750197269.596 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1111
2025-06-17T21:54:29.597Z,1750197269.597 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-06-17T21:54:29.602Z,1750197269.602 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1113
2025-06-17T21:54:29.604Z,1750197269.604 [WetLabsBB2FL](INFO): Powering up
2025-06-17T21:54:29.605Z,1750197269.605 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1115
2025-06-17T21:54:29.612Z,1750197269.612 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-06-17T21:54:29.612Z,1750197269.612 [CBIT](DEBUG): Initializing heartbeat.
2025-06-17T21:54:29.613Z,1750197269.613 [DAT ThreadHandler](INFO): Handler Thread ID is 1116
2025-06-17T21:54:29.614Z,1750197269.614 [DAT](INFO): Powering up
2025-06-17T21:54:29.614Z,1750197269.614 [DAT](DEBUG): Initializing DAT.
2025-06-17T21:54:29.617Z,1750197269.617 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1118
2025-06-17T21:54:29.619Z,1750197269.619 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-06-17T21:54:29.629Z,1750197269.629 [Onboard ThreadHandler](INFO): Handler Thread ID is 1119
2025-06-17T21:54:29.646Z,1750197269.646 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1120
2025-06-17T21:54:29.664Z,1750197269.664 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1121
2025-06-17T21:54:29.670Z,1750197269.670 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-06-17T21:54:29.671Z,1750197269.671 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-06-17T21:54:29.671Z,1750197269.671 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-06-17T21:54:29.671Z,1750197269.671 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-06-17T21:54:29.671Z,1750197269.671 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-06-17T21:54:29.671Z,1750197269.671 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-06-17T21:54:29.672Z,1750197269.672 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-06-17T21:54:29.672Z,1750197269.672 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-06-17T21:54:29.684Z,1750197269.684 [CBIT](DEBUG): Deactivating emergency mode.
2025-06-17T21:54:29.724Z,1750197269.724 [CBIT](DEBUG): Backplane powered.
2025-06-17T21:54:29.724Z,1750197269.724 [GFScanner](DEBUG): Initializing GFScanner
2025-06-17T21:54:29.724Z,1750197269.724 [GFScanner](DEBUG): Deactivating GF circuits.
2025-06-17T21:54:29.732Z,1750197269.732 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-06-17T21:54:29.733Z,1750197269.733 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-06-17T21:54:29.733Z,1750197269.733 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-06-17T21:54:29.733Z,1750197269.733 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-06-17T21:54:29.734Z,1750197269.734 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-06-17T21:54:29.735Z,1750197269.735 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-06-17T21:54:29.735Z,1750197269.735 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-06-17T21:54:29.739Z,1750197269.739 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-06-17T21:54:29.749Z,1750197269.749 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-06-17T21:54:29.749Z,1750197269.749 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-06-17T21:54:29.750Z,1750197269.750 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-06-17T21:54:29.751Z,1750197269.751 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-06-17T21:54:29.751Z,1750197269.751 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-06-17T21:54:29.751Z,1750197269.751 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-06-17T21:54:29.761Z,1750197269.761 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-06-17T21:54:29.850Z,1750197269.850 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Startup">
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="StartupSatComms">
        <Sequence />
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix />
        </ReadDatum>
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications />
        </ReadDatum>
    </Aggregate>
</Mission>

2025-06-17T21:54:29.871Z,1750197269.871 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-06-17T21:54:29.917Z,1750197269.917 [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-06-17T21:54:29.917Z,1750197269.917 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-06-17T21:54:29.917Z,1750197269.917 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-06-17T21:54:29.918Z,1750197269.918 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-06-17T21:54:30.052Z,1750197270.052 [Radio_Surface](INFO): Powering up
2025-06-17T21:54:30.267Z,1750197270.267 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Default">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>13</Value>
        </Setting>
    </Guidance:Wait>
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="CheckIn">
        <Sequence Repeat="288" />
        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M" />
            <Universal:time_fix />
        </ReadDatum>
        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence />
                    <Setting>
                        <Guidance:Execute.command />
                        <String>Burn on</String>
                    </Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications />
        </ReadDatum>
        <Guidance:Wait>
            <Sequence />
            <Setting>
                <Guidance:Wait.duration />
                <Units:minute />
                <Value>5</Value>
            </Setting>
        </Guidance:Wait>
        <Assign>
            <Sequence />
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Elapsed>
                <Universal:mission_started />
            </Elapsed>
        </Assign>
        <Syslog Severity="Important">
            Default mission has been running for 
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Units:minute />
        </Syslog>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2025-06-17T21:54:30.282Z,1750197270.282 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-06-17T21:54:30.284Z,1750197270.284 [Default:A.Wait](DEBUG): Construct Wait.
2025-06-17T21:54:30.286Z,1750197270.286 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-06-17T21:54:30.342Z,1750197270.342 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-06-17T21:54:30.345Z,1750197270.345 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-06-17T21:54:30.364Z,1750197270.364 [Default:E.Execute](DEBUG): Construct Execute.
2025-06-17T21:54:30.367Z,1750197270.367 [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-06-17T21:54:30.380Z,1750197270.380 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-06-17T21:54:30.417Z,1750197270.417 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-06-17T21:54:30.476Z,1750197270.476 [Depth_Keller](INFO): Initializing.
2025-06-17T21:54:30.485Z,1750197270.485 [PowerOnly](INFO): Powering up loadControl
2025-06-17T21:54:30.504Z,1750197270.504 [Power24vConverter](INFO): Powering up.
2025-06-17T21:54:30.505Z,1750197270.505 [Sonardyne_Nano](INFO): Initializing.
2025-06-17T21:54:30.532Z,1750197270.532 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-06-17T21:54:30.555Z,1750197270.555 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-06-17T21:54:30.560Z,1750197270.560 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-06-17T21:54:30.561Z,1750197270.561 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-06-17T21:54:30.568Z,1750197270.568 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-06-17T21:54:30.569Z,1750197270.569 [MassServo](DEBUG): Initializing EZServoServo.
2025-06-17T21:54:30.580Z,1750197270.580 [MassServo](DEBUG): Initializing MassServo.
2025-06-17T21:54:30.581Z,1750197270.581 [RudderServo](DEBUG): Initializing EZServoServo.
2025-06-17T21:54:30.588Z,1750197270.588 [RudderServo](DEBUG): Initializing RudderServo.
2025-06-17T21:54:30.589Z,1750197270.589 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-06-17T21:54:30.596Z,1750197270.596 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-06-17T21:54:32.216Z,1750197272.216 [WetLabsBB2FL](INFO): Powering down
2025-06-17T21:54:32.819Z,1750197272.819 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-06-17T21:54:34.069Z,1750197274.069 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213
2025-06-17T21:54:41.718Z,1750197281.718 [DAT](INFO): DAT read: 

2025-06-17T21:54:41.720Z,1750197281.720 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2025-06-17T21:54:43.481Z,1750197283.481 [DAT](INFO): DAT read: MF Frequency Band

2025-06-17T21:54:43.482Z,1750197283.482 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2025-06-17T21:54:43.483Z,1750197283.483 [DAT](INFO): DAT read: Jun 17 2025 21:54:38 

2025-06-17T21:54:44.741Z,1750197284.741 [DAT](INFO): DAT read: Features enabled [Bearing]

2025-06-17T21:54:44.742Z,1750197284.742 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2025-06-17T21:54:44.742Z,1750197284.742 [DAT](INFO): commRate: 1200
2025-06-17T21:54:46.808Z,1750197286.808 [DAT](INFO): entering command mode
2025-06-17T21:54:47.009Z,1750197287.009 [DAT](INFO): DAT read: 

2025-06-17T21:54:47.009Z,1750197287.009 [DAT](INFO): DAT read: user:1>

2025-06-17T21:54:47.009Z,1750197287.009 [DAT](INFO): setting verbose to 3
2025-06-17T21:54:47.261Z,1750197287.261 [DAT](INFO): DAT read: user:1>

2025-06-17T21:54:47.262Z,1750197287.262 [DAT](INFO): DAT read: Verbose         | 3           

2025-06-17T21:54:47.262Z,1750197287.262 [DAT](INFO): set verbose to 3
2025-06-17T21:54:47.262Z,1750197287.262 [DAT](INFO): setting DatVerbose to 27440
2025-06-17T21:54:47.513Z,1750197287.513 [DAT](INFO): DAT read: user:2>

2025-06-17T21:54:47.514Z,1750197287.514 [DAT](INFO): DAT read: DatVerbose      | 27440       

2025-06-17T21:54:47.514Z,1750197287.514 [DAT](INFO): set DatVerbose to 27440
2025-06-17T21:54:47.514Z,1750197287.514 [DAT](INFO): setting transmit power to 8
2025-06-17T21:54:47.764Z,1750197287.764 [DAT](INFO): DAT read: user:3>

2025-06-17T21:54:47.765Z,1750197287.765 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2025-06-17T21:54:47.766Z,1750197287.766 [DAT](INFO): set transmit power to 8
2025-06-17T21:54:47.766Z,1750197287.766 [DAT](INFO): setting local address to 5
2025-06-17T21:54:48.017Z,1750197288.017 [DAT](INFO): DAT read: user:4>

2025-06-17T21:54:48.018Z,1750197288.018 [DAT](INFO): DAT read: LocalAddr       | 5           

2025-06-17T21:54:48.018Z,1750197288.018 [DAT](INFO): set local address to 5
2025-06-17T21:54:48.019Z,1750197288.019 [DAT](INFO): Setting time to: 21:54:48 And date to:6/17/2025
2025-06-17T21:54:48.269Z,1750197288.269 [DAT](INFO): DAT read: user:5>

2025-06-17T21:54:48.271Z,1750197288.271 [DAT](INFO): DAT read: Tue Jun 17, 2025  21:54:48  

2025-06-17T21:54:48.271Z,1750197288.271 [DAT](INFO): Local DAT time set to Tue Jun 17, 2025  21:54:48  

2025-06-17T21:54:58.682Z,1750197298.682 [NAL9602](INFO): Powering up NAL9602
2025-06-17T21:55:09.595Z,1750197309.595 [NAL9602](INFO): NAL9602 initialized
2025-06-17T21:55:14.830Z,1750197314.830 [CommandExec](IMPORTANT): got command strobe off
2025-06-17T21:55:14.830Z,1750197314.830 [CommandExec](IMPORTANT): Deactivating strobe
2025-06-17T21:55:21.384Z,1750197321.384 [CommandExec](IMPORTANT): got command failComponent
2025-06-17T21:55:21.385Z,1750197321.385 [CommandExec](IMPORTANT): Failed components:
2025-06-17T21:55:21.385Z,1750197321.385 [CommandExec](IMPORTANT): No failed Components.
2025-06-17T21:56:23.578Z,1750197383.578 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-06-17T21:56:41.642Z,1750197401.642 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004453
2025-06-17T21:56:51.866Z,1750197411.866 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-06-17T21:57:01.117Z,1750197421.117 [SBIT](IMPORTANT): Beginning Startup BIT
2025-06-17T21:57:01.137Z,1750197421.137 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-06-17T21:57:05.701Z,1750197425.701 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.087915
CHAN A1 (24V): 0.099143
CHAN A2 (12V): -0.001773
CHAN A3 (5V): -0.035372
CHAN B0 (3.3V): -0.024599
CHAN B1 (3.15aV): -0.019882
CHAN B2 (3.15bV): -0.014371
CHAN B3 (GND): -0.026592
OPEN: 0.007519
Full Scale: +/- 1 mA
2025-06-17T21:57:29.857Z,1750197449.857 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-06-17T21:57:29.857Z,1750197449.857 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-06-17T21:57:29.868Z,1750197449.868 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-06-17T21:57:30.284Z,1750197450.284 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-06-17T21:57:30.284Z,1750197450.284 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-06-17T21:57:55.040Z,1750197475.040 [SBIT](IMPORTANT): SBIT PASSED
2025-06-17T21:57:55.040Z,1750197475.040 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-06-17T21:57:55.041Z,1750197475.041 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count;

2025-06-17T21:57:55.041Z,1750197475.041 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=1 bool;

2025-06-17T21:57:55.041Z,1750197475.041 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=1 bool;

2025-06-17T21:57:55.041Z,1750197475.041 [SBIT](IMPORTANT): ElevatorServo.currLimit=20 percent;

2025-06-17T21:57:55.041Z,1750197475.041 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere;

2025-06-17T21:57:55.041Z,1750197475.041 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=-20 ampere_hour;

2025-06-17T21:57:55.042Z,1750197475.042 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=10 volt;

2025-06-17T21:57:55.042Z,1750197475.042 [SBIT](IMPORTANT): ThrusterHE.bestEffortMode=1 bool;

2025-06-17T21:57:55.042Z,1750197475.042 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=269.964190 cubic_centimeter;

2025-06-17T21:57:55.042Z,1750197475.042 [SBIT](IMPORTANT): VerticalControl.massDefault=32.772906 millimeter;

2025-06-17T21:57:55.042Z,1750197475.042 [SBIT](IMPORTANT): Waypoint.wptRecalcBearing=1 bool;

2025-06-17T21:57:55.421Z,1750197475.421 [MissionManager](IMPORTANT): Started mission Startup
2025-06-17T21:57:55.421Z,1750197475.421 [Startup] Running Loop=1
2025-06-17T21:57:55.422Z,1750197475.422 [Startup](DEBUG): Aggregate::initialize Startup
2025-06-17T21:57:55.422Z,1750197475.422 [Startup:A.GoToSurface] Running Loop=1
2025-06-17T21:57:55.422Z,1750197475.422 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-06-17T21:57:55.422Z,1750197475.422 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-06-17T21:57:55.423Z,1750197475.423 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-06-17T21:57:55.423Z,1750197475.423 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-06-17T21:57:55.423Z,1750197475.423 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-06-17T21:57:55.424Z,1750197475.424 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-06-17T21:57:55.424Z,1750197475.424 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-06-17T21:57:55.426Z,1750197475.426 [Startup:StartupSatComms] Running Loop=1
2025-06-17T21:57:55.426Z,1750197475.426 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-06-17T21:57:55.426Z,1750197475.426 [Startup:StartupSatComms:A] Running Loop=1
2025-06-17T21:57:55.823Z,1750197475.823 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-06-17T21:57:58.283Z,1750197478.283 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-06-17T21:58:04.935Z,1750197484.935 [CommandExec](IMPORTANT): got command configSet ElevatorServo.currLimit 0 percent
2025-06-17T21:58:29.197Z,1750197509.197 [CommandExec](IMPORTANT): got command ibit
2025-06-17T21:58:29.364Z,1750197509.364 [IBIT](IMPORTANT): Beginning Initiated BIT
2025-06-17T21:58:29.364Z,1750197509.364 [IBIT](IMPORTANT): Beginning control surface checks.
2025-06-17T21:58:29.367Z,1750197509.367 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-06-17T21:58:33.952Z,1750197513.952 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.092156
CHAN A1 (24V): 0.096659
CHAN A2 (12V): -0.003346
CHAN A3 (5V): -0.033916
CHAN B0 (3.3V): -0.023441
CHAN B1 (3.15aV): -0.020622
CHAN B2 (3.15bV): -0.015089
CHAN B3 (GND): -0.028259
OPEN: 0.007557
Full Scale: +/- 1 mA
2025-06-17T21:59:05.361Z,1750197545.361 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-06-17T21:59:32.058Z,1750197572.058 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-06-17T22:00:12.899Z,1750197612.899 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-06-17T22:00:20.456Z,1750197620.456 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2025-06-17T22:00:20.890Z,1750197620.890 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2025-06-17T22:00:21.346Z,1750197621.346 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2025-06-17T22:00:21.347Z,1750197621.347 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2025-06-17T22:00:21.347Z,1750197621.347 [IBIT](IMPORTANT): Pressure:10.521704 PSI
2025-06-17T22:00:21.347Z,1750197621.347 [IBIT](IMPORTANT): Humidity:6.781834 %
2025-06-17T22:00:21.718Z,1750197621.718 [IBIT](IMPORTANT): Vehicle Pitch:-2.776783 degrees
2025-06-17T22:00:21.718Z,1750197621.718 [IBIT](IMPORTANT): Vehicle  Roll:0.503995 degrees
2025-06-17T22:00:21.719Z,1750197621.719 [IBIT](IMPORTANT): Vehicle  Heading:253.191116 degrees
2025-06-17T22:00:22.095Z,1750197622.095 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2025-06-17T22:00:22.095Z,1750197622.095 [IBIT](IMPORTANT): buoyancyNeutral: 269.964203 cc
2025-06-17T22:00:22.095Z,1750197622.095 [IBIT](IMPORTANT): massDefault: 3.277291 cm
2025-06-17T22:00:22.097Z,1750197622.097 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2025-06-17T22:00:22.097Z,1750197622.097 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2025-06-17T22:00:22.097Z,1750197622.097 [IBIT](IMPORTANT): IBIT FAILED
2025-06-17T22:00:22.500Z,1750197622.500 [Startup:StartupSatComms:A](INFO): Timed out from 2025-06-17T21:57:55.4Z
2025-06-17T22:00:22.500Z,1750197622.500 [Startup:StartupSatComms:A] Stopped
2025-06-17T22:00:22.500Z,1750197622.500 [Startup:StartupSatComms:B] Running Loop=1
2025-06-17T22:00:22.880Z,1750197622.880 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-06-17T22:00:26.307Z,1750197626.307 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-06-17T22:00:29.580Z,1750197629.580 [DataOverHttps](INFO): Sending 90 bytes from file Logs/20250617T214836/Courier0004.lzma
2025-06-17T22:00:30.582Z,1750197630.582 [DataOverHttps](INFO): Moved sent file to Logs/20250617T214836/Courier0004.lzma.bak
2025-06-17T22:00:30.582Z,1750197630.582 [DataOverHttps](INFO): SBD MOMSN=25223303
2025-06-17T22:00:30.700Z,1750197630.700 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-06-17T22:00:30.700Z,1750197630.700 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-06-17T22:00:30.711Z,1750197630.711 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-06-17T22:00:31.069Z,1750197631.069 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-06-17T22:00:31.069Z,1750197631.069 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-06-17T22:00:36.564Z,1750197636.564 [CommandExec](IMPORTANT): got command failComponent
2025-06-17T22:00:36.565Z,1750197636.565 [CommandExec](IMPORTANT): Failed components:
2025-06-17T22:00:36.565Z,1750197636.565 [CommandExec](IMPORTANT): No failed Components.
2025-06-17T22:00:46.086Z,1750197646.086 [CommandExec](IMPORTANT): got command configSet list
2025-06-17T22:00:46.086Z,1750197646.086 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-06-17T22:00:46.087Z,1750197646.087 [CommandExec](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count;

2025-06-17T22:00:46.116Z,1750197646.116 [CommandExec](IMPORTANT): CBIT.runNavErrorCritical=1 bool;

2025-06-17T22:00:46.117Z,1750197646.117 [CommandExec](IMPORTANT): DVL_micro.loadAtStartup=1 bool;

2025-06-17T22:00:46.118Z,1750197646.118 [CommandExec](IMPORTANT): ElevatorServo.currLimit=20 percent;

2025-06-17T22:00:46.118Z,1750197646.118 [CommandExec](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere;

2025-06-17T22:00:46.119Z,1750197646.119 [CommandExec](IMPORTANT): IBIT.batteryCapacityThreshold=-20 ampere_hour;

2025-06-17T22:00:46.148Z,1750197646.148 [CommandExec](IMPORTANT): IBIT.batteryVoltageThreshold=10 volt;

2025-06-17T22:00:46.149Z,1750197646.149 [CommandExec](IMPORTANT): ThrusterHE.bestEffortMode=1 bool;

2025-06-17T22:00:46.150Z,1750197646.150 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=269.964190 cubic_centimeter;

2025-06-17T22:00:46.150Z,1750197646.150 [CommandExec](IMPORTANT): VerticalControl.massDefault=32.772906 millimeter;

2025-06-17T22:00:46.151Z,1750197646.151 [CommandExec](IMPORTANT): Waypoint.wptRecalcBearing=1 bool;

2025-06-17T22:00:49.824Z,1750197649.824 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250617T215418/Courier0000.lzma
2025-06-17T22:00:50.826Z,1750197650.826 [DataOverHttps](INFO): Moved sent file to Logs/20250617T215418/Courier0000.lzma.bak
2025-06-17T22:00:50.826Z,1750197650.826 [DataOverHttps](INFO): SBD MOMSN=25223309
2025-06-17T22:00:59.364Z,1750197659.364 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 5.
2025-06-17T22:00:59.367Z,1750197659.367 [BPC1](INFO): Received data from all battery sticks.
2025-06-17T22:01:06.991Z,1750197666.991 [DataOverHttps](INFO): Sending 1446 bytes from file Logs/20250617T214836/Express0001.lzma
2025-06-17T22:01:07.990Z,1750197667.990 [DataOverHttps](INFO): Moved sent file to Logs/20250617T214836/Express0001.lzma.bak
2025-06-17T22:01:07.990Z,1750197667.990 [DataOverHttps](INFO): SBD MOMSN=25223312
2025-06-17T22:01:17.060Z,1750197677.060 [CommandExec](IMPORTANT): got command configSet ElevatorServo.currLimit 0 percent persist
2025-06-17T22:01:22.821Z,1750197682.821 [Startup:StartupSatComms:B](INFO): Timed out from 2025-06-17T22:00:22.5Z
2025-06-17T22:01:22.821Z,1750197682.821 [Startup:StartupSatComms:B] Stopped
2025-06-17T22:01:22.821Z,1750197682.821 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-06-17T22:01:22.821Z,1750197682.821 [Startup:StartupSatComms] Stopped
2025-06-17T22:01:22.822Z,1750197682.822 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-06-17T22:01:22.823Z,1750197682.823 [Startup](INFO): Completed Startup
2025-06-17T22:01:22.823Z,1750197682.823 [MissionManager](INFO): Startup is completed.
2025-06-17T22:01:22.823Z,1750197682.823 [MissionManager](INFO): Uninitializing Mission Startup
2025-06-17T22:01:22.823Z,1750197682.823 [Startup] Stopped
2025-06-17T22:01:22.823Z,1750197682.823 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-06-17T22:01:22.823Z,1750197682.823 [Startup:A.GoToSurface] Stopped
2025-06-17T22:01:22.823Z,1750197682.823 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-06-17T22:01:23.206Z,1750197683.206 [MissionManager](IMPORTANT): Started mission Default
2025-06-17T22:01:23.206Z,1750197683.206 [Default] Running Loop=1
2025-06-17T22:01:23.206Z,1750197683.206 [Default](DEBUG): Aggregate::initialize Default
2025-06-17T22:01:23.206Z,1750197683.206 [Default:B.GoToSurface] Running Loop=1
2025-06-17T22:01:23.206Z,1750197683.206 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-06-17T22:01:23.207Z,1750197683.207 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-06-17T22:01:23.207Z,1750197683.207 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-06-17T22:01:23.207Z,1750197683.207 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-06-17T22:01:23.207Z,1750197683.207 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-06-17T22:01:23.208Z,1750197683.208 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-06-17T22:01:23.208Z,1750197683.208 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-06-17T22:01:23.209Z,1750197683.209 [Default:A.Wait] Running Loop=1
2025-06-17T22:01:23.209Z,1750197683.209 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-06-17T22:01:23.849Z,1750197683.849 [DataOverHttps](INFO): Sending 656 bytes from file Logs/20250617T214836/Express0005.lzma
2025-06-17T22:01:24.653Z,1750197684.653 [CommandExec](IMPORTANT): got command ibit
2025-06-17T22:01:24.844Z,1750197684.844 [IBIT](IMPORTANT): Beginning Initiated BIT
2025-06-17T22:01:24.844Z,1750197684.844 [IBIT](IMPORTANT): Beginning control surface checks.
2025-06-17T22:01:24.862Z,1750197684.862 [DataOverHttps](INFO): Moved sent file to Logs/20250617T214836/Express0005.lzma.bak
2025-06-17T22:01:24.863Z,1750197684.863 [DataOverHttps](INFO): SBD MOMSN=25223370
2025-06-17T22:01:24.888Z,1750197684.888 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-06-17T22:01:29.457Z,1750197689.457 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.091959
CHAN A1 (24V): 0.093359
CHAN A2 (12V): -0.005016
CHAN A3 (5V): -0.034092
CHAN B0 (3.3V): -0.029084
CHAN B1 (3.15aV): -0.018870
CHAN B2 (3.15bV): -0.014612
CHAN B3 (GND): -0.024663
OPEN: 0.007649
Full Scale: +/- 1 mA
2025-06-17T22:03:15.917Z,1750197795.917 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2025-06-17T22:03:16.327Z,1750197796.327 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.144000
2025-06-17T22:03:16.327Z,1750197796.327 [IBIT](IMPORTANT): batteryCapacityThreshold: -20.000000 Ah
2025-06-17T22:03:16.328Z,1750197796.328 [IBIT](IMPORTANT): batteryVoltageThreshold: 10.000000 V
2025-06-17T22:03:16.750Z,1750197796.750 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2025-06-17T22:03:16.751Z,1750197796.751 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2025-06-17T22:03:16.751Z,1750197796.751 [IBIT](IMPORTANT): Pressure:10.554138 PSI
2025-06-17T22:03:16.751Z,1750197796.751 [IBIT](IMPORTANT): Humidity:6.781834 %
2025-06-17T22:03:17.158Z,1750197797.158 [IBIT](IMPORTANT): Vehicle Pitch:-2.779400 degrees
2025-06-17T22:03:17.159Z,1750197797.159 [IBIT](IMPORTANT): Vehicle  Roll:0.501309 degrees
2025-06-17T22:03:17.159Z,1750197797.159 [IBIT](IMPORTANT): Vehicle  Heading:253.003159 degrees
2025-06-17T22:03:17.582Z,1750197797.582 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2025-06-17T22:03:17.582Z,1750197797.582 [IBIT](IMPORTANT): buoyancyNeutral: 269.964203 cc
2025-06-17T22:03:17.582Z,1750197797.582 [IBIT](IMPORTANT): massDefault: 3.277291 cm
2025-06-17T22:03:17.583Z,1750197797.583 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2025-06-17T22:03:17.583Z,1750197797.583 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2025-06-17T22:03:17.583Z,1750197797.583 [IBIT](IMPORTANT): IBIT FAILED
2025-06-17T22:03:17.939Z,1750197797.939 [Default:A.Wait](INFO): Done Waiting.
2025-06-17T22:03:17.939Z,1750197797.939 [Default:A.Wait] Stopped
2025-06-17T22:03:17.939Z,1750197797.939 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-06-17T22:03:18.455Z,1750197798.455 [Default:CheckIn] Running Loop=1
2025-06-17T22:03:18.455Z,1750197798.455 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-06-17T22:03:18.455Z,1750197798.455 [Default:CheckIn:Read_GPS] Running Loop=1
2025-06-17T22:03:18.786Z,1750197798.786 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-06-17T22:03:22.401Z,1750197802.401 [CommandExec](IMPORTANT): got command failComponent
2025-06-17T22:03:22.401Z,1750197802.401 [CommandExec](IMPORTANT): Failed components:
2025-06-17T22:03:22.401Z,1750197802.401 [CommandExec](IMPORTANT): No failed Components.
2025-06-17T22:03:27.739Z,1750197807.739 [CommandExec](IMPORTANT): got command configSet list
2025-06-17T22:03:27.740Z,1750197807.740 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-06-17T22:03:27.741Z,1750197807.741 [CommandExec](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count;

2025-06-17T22:03:27.741Z,1750197807.741 [CommandExec](IMPORTANT): CBIT.runNavErrorCritical=1 bool;

2025-06-17T22:03:27.742Z,1750197807.742 [CommandExec](IMPORTANT): DVL_micro.loadAtStartup=1 bool;

2025-06-17T22:03:27.743Z,1750197807.743 [CommandExec](IMPORTANT): ElevatorServo.currLimit=0 percent;

2025-06-17T22:03:27.743Z,1750197807.743 [CommandExec](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere;

2025-06-17T22:03:27.744Z,1750197807.744 [CommandExec](IMPORTANT): IBIT.batteryCapacityThreshold=-20 ampere_hour;

2025-06-17T22:03:27.745Z,1750197807.745 [CommandExec](IMPORTANT): IBIT.batteryVoltageThreshold=10 volt;

2025-06-17T22:03:27.746Z,1750197807.746 [CommandExec](IMPORTANT): ThrusterHE.bestEffortMode=1 bool;

2025-06-17T22:03:27.747Z,1750197807.747 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=269.964190 cubic_centimeter;

2025-06-17T22:03:27.747Z,1750197807.747 [CommandExec](IMPORTANT): VerticalControl.massDefault=32.772906 millimeter;

2025-06-17T22:03:27.748Z,1750197807.748 [CommandExec](IMPORTANT): Waypoint.wptRecalcBearing=1 bool;

2025-06-17T22:03:31.692Z,1750197811.692 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-06-17T22:03:31.692Z,1750197811.692 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-06-17T22:03:31.707Z,1750197811.707 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-06-17T22:03:32.109Z,1750197812.109 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-06-17T22:03:32.109Z,1750197812.109 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-06-17T22:04:11.185Z,1750197851.185 [CommandExec](IMPORTANT): got command restart application
2025-06-17T22:04:12.188Z,1750197852.188 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2025-06-17T22:04:12.188Z,1750197852.188 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:12.188Z,1750197852.188 [CommandExec](INFO): Uninitializing the command executive.
2025-06-17T22:04:12.188Z,1750197852.188 [CommandExec](INFO): Uninitializing the command scheduler.
2025-06-17T22:04:12.189Z,1750197852.189 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:12.260Z,1750197852.260 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-06-17T22:04:12.260Z,1750197852.260 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-06-17T22:04:12.260Z,1750197852.260 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:12.261Z,1750197852.261 [NavChartDb](INFO): Join timeout helper Thread ID is 1193
2025-06-17T22:04:12.352Z,1750197852.352 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:12.352Z,1750197852.352 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:12.360Z,1750197852.360 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-06-17T22:04:12.360Z,1750197852.360 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:12.361Z,1750197852.361 [Radio_Surface](INFO): Join timeout helper Thread ID is 1194
2025-06-17T22:04:12.376Z,1750197852.376 [Radio_Surface](INFO): Powering down
2025-06-17T22:04:12.377Z,1750197852.377 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:12.377Z,1750197852.377 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:12.380Z,1750197852.380 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-06-17T22:04:12.380Z,1750197852.380 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:12.380Z,1750197852.380 [Onboard](INFO): Join timeout helper Thread ID is 1195
2025-06-17T22:04:13.016Z,1750197853.016 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-06-17T22:04:15.108Z,1750197855.108 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:15.108Z,1750197855.108 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:15.116Z,1750197855.116 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-06-17T22:04:15.116Z,1750197855.116 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:15.116Z,1750197855.116 [DataOverHttps](INFO): Join timeout helper Thread ID is 1196
2025-06-17T22:04:16.028Z,1750197856.028 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:16.028Z,1750197856.028 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:16.048Z,1750197856.048 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-06-17T22:04:16.048Z,1750197856.048 [DAT ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:16.048Z,1750197856.048 [DAT](INFO): Join timeout helper Thread ID is 1197
2025-06-17T22:04:16.110Z,1750197856.110 [DAT](INFO): Powering down
2025-06-17T22:04:16.181Z,1750197856.181 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:16.181Z,1750197856.181 [DAT](INFO): Powering down
2025-06-17T22:04:16.182Z,1750197856.182 [DAT ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:16.197Z,1750197856.197 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-06-17T22:04:16.197Z,1750197856.197 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:16.197Z,1750197856.197 [BackseatComponent](INFO): Join timeout helper Thread ID is 1198
2025-06-17T22:04:16.285Z,1750197856.285 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:16.286Z,1750197856.286 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:16.291Z,1750197856.291 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-06-17T22:04:16.291Z,1750197856.291 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:16.304Z,1750197856.304 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1199
2025-06-17T22:04:16.536Z,1750197856.536 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:16.536Z,1750197856.536 [WetLabsBB2FL](INFO): Powering down
2025-06-17T22:04:16.537Z,1750197856.537 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:16.545Z,1750197856.545 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-06-17T22:04:16.545Z,1750197856.545 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:16.545Z,1750197856.545 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1200
2025-06-17T22:04:17.064Z,1750197857.064 [CTD_Seabird](INFO): Powering down
2025-06-17T22:04:17.076Z,1750197857.076 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:17.076Z,1750197857.076 [CTD_Seabird](INFO): Powering down
2025-06-17T22:04:17.089Z,1750197857.089 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.101Z,1750197857.101 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-06-17T22:04:17.101Z,1750197857.101 [logger ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.101Z,1750197857.101 [logger](INFO): Join timeout helper Thread ID is 1201
2025-06-17T22:04:17.114Z,1750197857.114 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:17.114Z,1750197857.114 [logger ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.116Z,1750197857.116 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-06-17T22:04:17.116Z,1750197857.116 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.116Z,1750197857.116 [CommandLine](INFO): Join timeout helper Thread ID is 1202
2025-06-17T22:04:17.148Z,1750197857.148 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:17.148Z,1750197857.148 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.156Z,1750197857.156 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-06-17T22:04:17.157Z,1750197857.157 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.157Z,1750197857.157 [CommandExec](INFO): Join timeout helper Thread ID is 1203
2025-06-17T22:04:17.158Z,1750197857.158 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-06-17T22:04:17.158Z,1750197857.158 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.159Z,1750197857.159 [controlThread](INFO): Join timeout helper Thread ID is 1204
2025-06-17T22:04:17.316Z,1750197857.316 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-06-17T22:04:17.316Z,1750197857.316 [controlThread](DEBUG): Uninitializing ControlThread
2025-06-17T22:04:17.317Z,1750197857.317 [AHRS_M2](INFO): Powering down
2025-06-17T22:04:17.492Z,1750197857.492 [DVL_micro](INFO): Powering down
2025-06-17T22:04:17.493Z,1750197857.493 [NAL9602](INFO): Powering down
2025-06-17T22:04:17.494Z,1750197857.494 [Sonardyne_Nano](INFO): Powering down
2025-06-17T22:04:17.620Z,1750197857.620 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-06-17T22:04:17.621Z,1750197857.621 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-06-17T22:04:17.621Z,1750197857.621 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-06-17T22:04:17.622Z,1750197857.622 [MissionManager](INFO): Uninitializing Mission Default
2025-06-17T22:04:17.622Z,1750197857.622 [Default] Stopped
2025-06-17T22:04:17.622Z,1750197857.622 [Default](DEBUG): Aggregate::uninitialize Default
2025-06-17T22:04:17.622Z,1750197857.622 [Default:B.GoToSurface] Stopped
2025-06-17T22:04:17.622Z,1750197857.622 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-06-17T22:04:17.622Z,1750197857.622 [Default:CheckIn] Stopped
2025-06-17T22:04:17.622Z,1750197857.622 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-06-17T22:04:17.622Z,1750197857.622 [Default:CheckIn:Read_GPS] Stopped
2025-06-17T22:04:17.626Z,1750197857.626 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-06-17T22:04:17.626Z,1750197857.626 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-06-17T22:04:17.626Z,1750197857.626 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-06-17T22:04:17.626Z,1750197857.626 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-06-17T22:04:17.627Z,1750197857.627 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-06-17T22:04:17.627Z,1750197857.627 [BuoyancyServo](INFO): Powering down
2025-06-17T22:04:17.640Z,1750197857.640 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-06-17T22:04:17.640Z,1750197857.640 [ElevatorServo](INFO): Powering down
2025-06-17T22:04:17.641Z,1750197857.641 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-06-17T22:04:17.641Z,1750197857.641 [MassServo](INFO): Powering down
2025-06-17T22:04:17.642Z,1750197857.642 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-06-17T22:04:17.642Z,1750197857.642 [RudderServo](INFO): Powering down
2025-06-17T22:04:17.643Z,1750197857.643 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-06-17T22:04:17.643Z,1750197857.643 [ThrusterHE](INFO): Powering down
2025-06-17T22:04:17.644Z,1750197857.644 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-06-17T22:04:17.644Z,1750197857.644 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-06-17T22:04:17.644Z,1750197857.644 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-06-17T22:04:17.645Z,1750197857.645 [CBIT](DEBUG): Powering off loads.
2025-06-17T22:04:17.656Z,1750197857.656 [CBIT](DEBUG): Disabling WDT.
2025-06-17T22:04:17.668Z,1750197857.668 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-06-17T22:04:17.668Z,1750197857.668 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-06-17T22:04:17.669Z,1750197857.669 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.702Z,1750197857.702 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-06-17T22:04:17.703Z,1750197857.703 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-06-17T22:04:17.718Z,1750197857.718 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.725Z,1750197857.725 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.755Z,1750197857.755 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.758Z,1750197857.758 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.766Z,1750197857.766 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.772Z,1750197857.772 [DAT ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.815Z,1750197857.815 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.868Z,1750197857.868 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-06-17T22:04:17.933Z,1750197857.934 [logger ThreadHandler](INFO): Thread cancelled.