2025-04-07T20:47:26.035Z,1744058846.035 [Supervisor](DEBUG): Initializing supervisor.
2025-04-07T20:47:26.039Z,1744058846.039 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-04-07T20:47:26.040Z,1744058846.040 [SyncHandler](INFO): Protected caller Thread ID is 617
2025-04-07T20:47:26.040Z,1744058846.040 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-04-07T20:47:26.041Z,1744058846.041 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-04-07T20:47:26.042Z,1744058846.042 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 618
2025-04-07T20:47:26.046Z,1744058846.046 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-04-07T20:47:26.066Z,1744058846.066 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-04-07T20:47:26.067Z,1744058846.067 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-04-07T20:47:26.067Z,1744058846.067 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 619
2025-04-07T20:47:26.071Z,1744058846.071 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-04-07T20:47:26.072Z,1744058846.072 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-04-07T20:47:26.072Z,1744058846.072 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 620
2025-04-07T20:47:26.075Z,1744058846.075 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-04-07T20:47:26.076Z,1744058846.076 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-04-07T20:47:26.076Z,1744058846.076 [logger ThreadHandler](INFO): Protected caller Thread ID is 621
2025-04-07T20:47:26.080Z,1744058846.080 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-04-07T20:47:26.080Z,1744058846.080 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-04-07T20:47:26.082Z,1744058846.082 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-04-07T20:47:26.445Z,1744058846.445 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-04-07T20:47:26.446Z,1744058846.446 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-04-07T20:47:26.735Z,1744058846.735 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-04-07T20:47:26.736Z,1744058846.736 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-04-07T20:47:27.267Z,1744058847.267 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-04-07T20:47:27.268Z,1744058847.268 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-04-07T20:47:27.523Z,1744058847.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-04-07T20:47:27.524Z,1744058847.524 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-04-07T20:47:27.771Z,1744058847.771 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-04-07T20:47:27.771Z,1744058847.771 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-04-07T20:47:28.715Z,1744058848.715 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-04-07T20:47:28.715Z,1744058848.715 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-04-07T20:47:29.088Z,1744058849.088 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-04-07T20:47:29.089Z,1744058849.089 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-04-07T20:47:29.215Z,1744058849.215 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-04-07T20:47:29.215Z,1744058849.215 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-04-07T20:47:29.306Z,1744058849.306 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-04-07T20:47:29.510Z,1744058849.510 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-04-07T20:47:29.511Z,1744058849.511 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-04-07T20:47:29.621Z,1744058849.621 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-04-07T20:47:29.621Z,1744058849.621 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-04-07T20:47:29.862Z,1744058849.862 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-04-07T20:47:29.862Z,1744058849.862 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-04-07T20:47:30.015Z,1744058850.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-04-07T20:47:30.016Z,1744058850.016 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-04-07T20:47:30.109Z,1744058850.109 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-04-07T20:47:30.569Z,1744058850.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-04-07T20:47:30.570Z,1744058850.570 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-04-07T20:47:31.195Z,1744058851.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-04-07T20:47:31.197Z,1744058851.197 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2025-04-07T20:47:31.198Z,1744058851.198 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2025-04-07T20:47:31.573Z,1744058851.573 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2025-04-07T20:47:32.086Z,1744058852.086 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-04-07T20:47:32.086Z,1744058852.086 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2025-04-07T20:47:32.203Z,1744058852.203 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2025-04-07T20:47:32.238Z,1744058852.238 [Config/vehicle](ERROR): Unterminated quote: "/dev/loadC3;
2025-04-07T20:47:32.311Z,1744058852.311 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2025-04-07T20:47:32.435Z,1744058852.435 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2025-04-07T20:47:32.582Z,1744058852.582 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2025-04-07T20:47:32.687Z,1744058852.687 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2025-04-07T20:47:32.810Z,1744058852.810 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2025-04-07T20:47:32.906Z,1744058852.906 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2025-04-07T20:47:33.021Z,1744058853.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2025-04-07T20:47:33.120Z,1744058853.120 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/root/
2025-04-07T20:47:33.120Z,1744058853.120 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-04-07T20:47:33.122Z,1744058853.122 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-04-07T20:47:33.133Z,1744058853.133 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-04-07T20:47:33.134Z,1744058853.134 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-04-07T20:47:33.253Z,1744058853.253 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-04-07T20:47:33.253Z,1744058853.253 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-04-07T20:47:33.293Z,1744058853.293 [DeadReckonWithRespectToSeafloor] Loaded
2025-04-07T20:47:33.293Z,1744058853.293 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2025-04-07T20:47:33.306Z,1744058853.306 [NavChart] Loaded
2025-04-07T20:47:33.307Z,1744058853.307 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-04-07T20:47:33.312Z,1744058853.312 [UniversalFixResidualReporter] Loaded
2025-04-07T20:47:33.312Z,1744058853.312 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-04-07T20:47:33.313Z,1744058853.313 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-04-07T20:47:33.313Z,1744058853.313 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-04-07T20:47:33.824Z,1744058853.824 [AHRS_M2] Loaded
2025-04-07T20:47:33.824Z,1744058853.824 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-04-07T20:47:33.864Z,1744058853.864 [BackseatComponent] Loaded
2025-04-07T20:47:33.864Z,1744058853.864 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-04-07T20:47:33.865Z,1744058853.865 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085D4E0
2025-04-07T20:47:33.865Z,1744058853.865 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 704
2025-04-07T20:47:33.868Z,1744058853.868 [LcmUniversalReporter] Loaded
2025-04-07T20:47:33.869Z,1744058853.869 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-04-07T20:47:34.691Z,1744058854.691 [BPC1] Loaded
2025-04-07T20:47:34.691Z,1744058854.691 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-04-07T20:47:34.789Z,1744058854.789 [DAT] Loaded
2025-04-07T20:47:34.789Z,1744058854.789 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-04-07T20:47:34.790Z,1744058854.790 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088D4E0
2025-04-07T20:47:34.790Z,1744058854.790 [DAT ThreadHandler](INFO): Protected caller Thread ID is 705
2025-04-07T20:47:34.863Z,1744058854.863 [DataOverHttps] Loaded
2025-04-07T20:47:34.864Z,1744058854.864 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-04-07T20:47:34.865Z,1744058854.865 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2025-04-07T20:47:34.865Z,1744058854.865 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 706
2025-04-07T20:47:34.887Z,1744058854.887 [DepthKeller33X] Loaded
2025-04-07T20:47:34.888Z,1744058854.888 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
2025-04-07T20:47:34.893Z,1744058854.893 [DropWeight] Loaded
2025-04-07T20:47:34.893Z,1744058854.893 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-04-07T20:47:34.958Z,1744058854.958 [NAL9602] Loaded
2025-04-07T20:47:34.958Z,1744058854.958 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-04-07T20:47:34.989Z,1744058854.989 [Onboard] Loaded
2025-04-07T20:47:34.989Z,1744058854.989 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-04-07T20:47:34.990Z,1744058854.990 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2025-04-07T20:47:34.990Z,1744058854.990 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 707
2025-04-07T20:47:35.005Z,1744058855.005 [Power24vConverter] Loaded
2025-04-07T20:47:35.005Z,1744058855.005 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-04-07T20:47:35.023Z,1744058855.023 [Radio_Surface] Loaded
2025-04-07T20:47:35.023Z,1744058855.023 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-04-07T20:47:35.024Z,1744058855.024 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2025-04-07T20:47:35.024Z,1744058855.024 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 708
2025-04-07T20:47:35.025Z,1744058855.025 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-04-07T20:47:35.026Z,1744058855.026 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-04-07T20:47:35.080Z,1744058855.080 [DepthRateCalculator] Loaded
2025-04-07T20:47:35.081Z,1744058855.081 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-04-07T20:47:35.086Z,1744058855.086 [PitchRateCalculator] Loaded
2025-04-07T20:47:35.086Z,1744058855.086 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-04-07T20:47:35.096Z,1744058855.096 [SpeedCalculator] Loaded
2025-04-07T20:47:35.096Z,1744058855.096 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-04-07T20:47:35.101Z,1744058855.101 [YawRateCalculator] Loaded
2025-04-07T20:47:35.101Z,1744058855.101 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-04-07T20:47:35.123Z,1744058855.123 [ElevatorOffsetCalculator] Loaded
2025-04-07T20:47:35.123Z,1744058855.123 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-04-07T20:47:35.124Z,1744058855.124 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-04-07T20:47:35.124Z,1744058855.124 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-04-07T20:47:35.189Z,1744058855.189 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-04-07T20:47:35.190Z,1744058855.190 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-04-07T20:47:35.335Z,1744058855.335 [BuoyancyServo] Loaded
2025-04-07T20:47:35.335Z,1744058855.335 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-04-07T20:47:35.359Z,1744058855.359 [ElevatorServo] Loaded
2025-04-07T20:47:35.360Z,1744058855.360 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-04-07T20:47:35.383Z,1744058855.383 [MassServo] Loaded
2025-04-07T20:47:35.383Z,1744058855.383 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-04-07T20:47:35.406Z,1744058855.406 [RudderServo] Loaded
2025-04-07T20:47:35.406Z,1744058855.406 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-04-07T20:47:35.424Z,1744058855.424 [ThrusterHE] Loaded
2025-04-07T20:47:35.425Z,1744058855.425 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-04-07T20:47:35.425Z,1744058855.425 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-04-07T20:47:35.425Z,1744058855.425 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-04-07T20:47:35.565Z,1744058855.565 [Aanderaa_O2] Loaded
2025-04-07T20:47:35.566Z,1744058855.566 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2025-04-07T20:47:35.629Z,1744058855.629 [CTD_Seabird] Loaded
2025-04-07T20:47:35.629Z,1744058855.629 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-04-07T20:47:35.630Z,1744058855.630 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A4E4E0
2025-04-07T20:47:35.631Z,1744058855.631 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 709
2025-04-07T20:47:35.666Z,1744058855.666 [ESPComponent] Loaded
2025-04-07T20:47:35.666Z,1744058855.666 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-04-07T20:47:35.712Z,1744058855.712 [WetLabsBB2FL] Loaded
2025-04-07T20:47:35.712Z,1744058855.712 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-04-07T20:47:35.713Z,1744058855.713 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A7E4E0
2025-04-07T20:47:35.713Z,1744058855.713 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 710
2025-04-07T20:47:35.714Z,1744058855.714 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-04-07T20:47:35.715Z,1744058855.715 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-04-07T20:47:35.860Z,1744058855.860 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-04-07T20:47:35.861Z,1744058855.861 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-04-07T20:47:36.056Z,1744058856.056 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-04-07T20:47:36.056Z,1744058856.056 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-04-07T20:47:36.506Z,1744058856.506 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-04-07T20:47:36.507Z,1744058856.507 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-04-07T20:47:36.754Z,1744058856.754 [VerticalControl](DEBUG): Construct VerticalControl.
2025-04-07T20:47:36.815Z,1744058856.815 [VerticalControl] Loaded
2025-04-07T20:47:36.816Z,1744058856.816 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-04-07T20:47:36.917Z,1744058856.917 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-04-07T20:47:36.964Z,1744058856.964 [HorizontalControl] Loaded
2025-04-07T20:47:36.964Z,1744058856.964 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-04-07T20:47:36.967Z,1744058856.967 [SpeedControl](DEBUG): Construct SpeedControl.
2025-04-07T20:47:36.969Z,1744058856.969 [SpeedControl] Loaded
2025-04-07T20:47:36.969Z,1744058856.969 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-04-07T20:47:36.972Z,1744058856.972 [LoopControl](DEBUG): Construct LoopControl.
2025-04-07T20:47:36.972Z,1744058856.972 [LoopControl] Loaded
2025-04-07T20:47:36.972Z,1744058856.972 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-04-07T20:47:36.973Z,1744058856.973 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-04-07T20:47:36.973Z,1744058856.973 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-04-07T20:47:37.147Z,1744058857.147 [SBIT](DEBUG): Construct Startup Built In Test.
2025-04-07T20:47:37.156Z,1744058857.156 [SBIT] Loaded
2025-04-07T20:47:37.156Z,1744058857.156 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-04-07T20:47:37.159Z,1744058857.159 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-04-07T20:47:37.172Z,1744058857.172 [IBIT] Loaded
2025-04-07T20:47:37.172Z,1744058857.172 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-04-07T20:47:37.178Z,1744058857.178 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-04-07T20:47:37.258Z,1744058857.258 [CBIT] Loaded
2025-04-07T20:47:37.258Z,1744058857.258 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-04-07T20:47:37.289Z,1744058857.289 [GFScanner] Loaded
2025-04-07T20:47:37.290Z,1744058857.290 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-04-07T20:47:37.290Z,1744058857.290 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-04-07T20:47:37.291Z,1744058857.291 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-04-07T20:47:37.321Z,1744058857.321 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-04-07T20:47:37.328Z,1744058857.328 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-04-07T20:47:37.331Z,1744058857.331 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-04-07T20:47:37.342Z,1744058857.342 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-04-07T20:47:37.343Z,1744058857.343 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0
2025-04-07T20:47:37.343Z,1744058857.343 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 711
2025-04-07T20:47:37.347Z,1744058857.347 [Supervisor](INFO): Main Thread ID is 616
2025-04-07T20:47:37.348Z,1744058857.348 [Supervisor](DEBUG): Running supervisor.
2025-04-07T20:47:37.350Z,1744058857.350 [CommandExec ThreadHandler](INFO): Handler Thread ID is 712
2025-04-07T20:47:37.351Z,1744058857.351 [CommandExec](INFO): Initializing the command executive.
2025-04-07T20:47:37.352Z,1744058857.352 [CommandLine ThreadHandler](INFO): Handler Thread ID is 713
2025-04-07T20:47:37.354Z,1744058857.354 [controlThread ThreadHandler](INFO): Handler Thread ID is 714
2025-04-07T20:47:37.355Z,1744058857.355 [controlThread](DEBUG): Initializing ControlThread
2025-04-07T20:47:37.357Z,1744058857.357 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-04-07T20:47:37.357Z,1744058857.357 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-04-07T20:47:37.360Z,1744058857.360 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-04-07T20:47:37.360Z,1744058857.360 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-04-07T20:47:37.361Z,1744058857.361 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-04-07T20:47:37.361Z,1744058857.361 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-04-07T20:47:37.361Z,1744058857.361 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-04-07T20:47:37.364Z,1744058857.364 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-04-07T20:47:37.365Z,1744058857.365 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-04-07T20:47:37.366Z,1744058857.366 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-04-07T20:47:37.366Z,1744058857.366 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-04-07T20:47:37.367Z,1744058857.367 [SBIT](INFO): Initialize SBIT Component.
2025-04-07T20:47:37.367Z,1744058857.367 [SBIT](IMPORTANT): git: 2025-03-31
2025-04-07T20:47:37.367Z,1744058857.367 [SBIT](INFO): git hash: fa5a0d22cc02557daa9f4ab77c7f518dfe223d1b
2025-04-07T20:47:37.368Z,1744058857.368 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-04-07T20:47:37.369Z,1744058857.369 [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-07T20:47:37.370Z,1744058857.370 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2025-04-07T20:47:37.371Z,1744058857.371 [IBIT](INFO): Initialize IBIT Component.
2025-04-07T20:47:37.371Z,1744058857.371 [CBIT](DEBUG): Initialize CBIT Component.
2025-04-07T20:47:37.372Z,1744058857.372 [logger ThreadHandler](INFO): Handler Thread ID is 715
2025-04-07T20:47:37.382Z,1744058857.382 [CBIT](DEBUG): Initialized mux pins.
2025-04-07T20:47:37.382Z,1744058857.382 [CBIT](DEBUG): Initializing the watchdog timer.
2025-04-07T20:47:37.390Z,1744058857.390 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 716
2025-04-07T20:47:37.406Z,1744058857.406 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-04-07T20:47:37.406Z,1744058857.406 [CBIT](DEBUG): Initializing heartbeat.
2025-04-07T20:47:37.407Z,1744058857.407 [DAT ThreadHandler](INFO): Handler Thread ID is 717
2025-04-07T20:47:37.408Z,1744058857.408 [DAT](INFO): Powering up
2025-04-07T20:47:37.408Z,1744058857.408 [DAT](DEBUG): Initializing DAT.
2025-04-07T20:47:37.411Z,1744058857.411 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 719
2025-04-07T20:47:37.413Z,1744058857.413 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-04-07T20:47:37.430Z,1744058857.430 [Onboard ThreadHandler](INFO): Handler Thread ID is 720
2025-04-07T20:47:37.448Z,1744058857.448 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 721
2025-04-07T20:47:37.466Z,1744058857.466 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 722
2025-04-07T20:47:37.467Z,1744058857.467 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-07T20:47:37.471Z,1744058857.471 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 724
2025-04-07T20:47:37.474Z,1744058857.474 [WetLabsBB2FL](INFO): Powering up
2025-04-07T20:47:37.476Z,1744058857.476 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 726
2025-04-07T20:47:37.478Z,1744058857.478 [CBIT](DEBUG): Deactivating emergency mode.
2025-04-07T20:47:37.479Z,1744058857.479 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-04-07T20:47:37.479Z,1744058857.479 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-04-07T20:47:37.479Z,1744058857.479 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-04-07T20:47:37.479Z,1744058857.479 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-04-07T20:47:37.479Z,1744058857.479 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-04-07T20:47:37.480Z,1744058857.480 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-04-07T20:47:37.480Z,1744058857.480 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-04-07T20:47:37.480Z,1744058857.480 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-04-07T20:47:37.518Z,1744058857.518 [CBIT](DEBUG): Backplane powered.
2025-04-07T20:47:37.518Z,1744058857.518 [GFScanner](DEBUG): Initializing GFScanner
2025-04-07T20:47:37.519Z,1744058857.519 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-04-07T20:47:37.520Z,1744058857.520 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-04-07T20:47:37.520Z,1744058857.520 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-04-07T20:47:37.521Z,1744058857.521 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-04-07T20:47:37.562Z,1744058857.562 [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-04-07T20:47:37.582Z,1744058857.582 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-07T20:47:37.619Z,1744058857.619 [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-07T20:47:37.619Z,1744058857.619 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-04-07T20:47:37.620Z,1744058857.620 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-04-07T20:47:37.621Z,1744058857.621 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-04-07T20:47:37.854Z,1744058857.854 [Radio_Surface](INFO): Powering up
2025-04-07T20:47:37.952Z,1744058857.952 [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-04-07T20:47:37.973Z,1744058857.973 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-04-07T20:47:37.980Z,1744058857.980 [Default:A.Wait](DEBUG): Construct Wait.
2025-04-07T20:47:37.982Z,1744058857.982 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-07T20:47:38.018Z,1744058858.018 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-07T20:47:38.036Z,1744058858.036 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-07T20:47:38.059Z,1744058858.059 [Default:E.Execute](DEBUG): Construct Execute.
2025-04-07T20:47:38.062Z,1744058858.062 [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-07T20:47:38.074Z,1744058858.074 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DepthKeller33X,DropWeight,NAL9602,Power24vConverter,Aanderaa_O2,ESPComponent,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-07T20:47:38.085Z,1744058858.085 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-07T20:47:38.158Z,1744058858.158 [DepthKeller33X](INFO): Initializing.
2025-04-07T20:47:38.179Z,1744058858.179 [Power24vConverter](INFO): Powering up.
2025-04-07T20:47:38.183Z,1744058858.183 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:38.195Z,1744058858.195 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:38.202Z,1744058858.202 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-07T20:47:38.203Z,1744058858.203 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:38.210Z,1744058858.210 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-07T20:47:38.211Z,1744058858.211 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:38.218Z,1744058858.218 [MassServo](DEBUG): Initializing MassServo.
2025-04-07T20:47:38.219Z,1744058858.219 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:38.227Z,1744058858.227 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-07T20:47:38.227Z,1744058858.227 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:38.234Z,1744058858.234 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-07T20:47:38.514Z,1744058858.514 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2025-04-07T20:47:38.514Z,1744058858.514 [DropWeight] Hardware Fault, FailCount= 1
2025-04-07T20:47:38.514Z,1744058858.514 [DropWeight](ERROR): Hardware Fault
2025-04-07T20:47:38.527Z,1744058858.527 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:38.537Z,1744058858.537 [CommandExec](FAULT): Scheduling is paused
2025-04-07T20:47:38.537Z,1744058858.537 [CBIT](INFO): Critical error at 20250407T204738
2025-04-07T20:47:38.537Z,1744058858.537 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-04-07T20:47:38.547Z,1744058858.547 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-04-07T20:47:38.548Z,1744058858.548 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-04-07T20:47:38.890Z,1744058858.890 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:38.898Z,1744058858.898 [CBIT](INFO): Critical error at 20250407T204738
2025-04-07T20:47:39.294Z,1744058859.294 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:39.686Z,1744058859.686 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2025-04-07T20:47:39.686Z,1744058859.686 [ElevatorServo](FAULT): Elevator failed to initialize
2025-04-07T20:47:39.686Z,1744058859.686 [ElevatorServo] Communications Fault, FailCount= 1
2025-04-07T20:47:39.686Z,1744058859.686 [ElevatorServo](ERROR): Communications Fault
2025-04-07T20:47:39.746Z,1744058859.746 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2025-04-07T20:47:39.766Z,1744058859.766 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-07T20:47:39.766Z,1744058859.766 [DepthKeller33X] Communications Fault, FailCount= 1
2025-04-07T20:47:39.766Z,1744058859.766 [DepthKeller33X](ERROR): Communications Fault
2025-04-07T20:47:39.769Z,1744058859.769 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:39.776Z,1744058859.776 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-07T20:47:39.776Z,1744058859.776 [ElevatorServo](INFO): Powering down
2025-04-07T20:47:39.781Z,1744058859.781 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-07T20:47:40.156Z,1744058860.156 [DepthKeller33X](INFO): Powering down
2025-04-07T20:47:40.251Z,1744058860.251 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:40.561Z,1744058860.561 [Power24vConverter](FAULT): LCB fault:  Current Limiter Activated.
2025-04-07T20:47:40.561Z,1744058860.561 [Power24vConverter] Hardware Fault, FailCount= 1
2025-04-07T20:47:40.561Z,1744058860.561 [Power24vConverter](ERROR): Hardware Fault
2025-04-07T20:47:40.562Z,1744058860.562 [Power24vConverter](INFO): Powering down.
2025-04-07T20:47:40.563Z,1744058860.563 [Power24vConverter](FAULT): 24V Power is reporting not powering/powered.
2025-04-07T20:47:40.564Z,1744058860.564 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:40.571Z,1744058860.571 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:40.691Z,1744058860.691 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-07T20:47:40.696Z,1744058860.696 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2025-04-07T20:47:40.696Z,1744058860.696 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-04-07T20:47:40.696Z,1744058860.696 [ElevatorServo] No Fault, FailCount= 1
2025-04-07T20:47:40.965Z,1744058860.965 [Power24vConverter](INFO): Powering down.
2025-04-07T20:47:40.966Z,1744058860.966 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:41.049Z,1744058861.049 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-07T20:47:41.049Z,1744058861.049 [DepthKeller33X] No Fault, FailCount= 1
2025-04-07T20:47:41.694Z,1744058861.694 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:41.695Z,1744058861.695 [DepthKeller33X](INFO): Initializing.
2025-04-07T20:47:41.711Z,1744058861.711 [Power24vConverter](FAULT):  LCB fault:  Current Limiter Activated.
2025-04-07T20:47:41.711Z,1744058861.711 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:42.030Z,1744058862.030 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2025-04-07T20:47:42.030Z,1744058862.030 [ElevatorServo](FAULT): Elevator failed to initialize
2025-04-07T20:47:42.030Z,1744058862.030 [ElevatorServo] Communications Fault, FailCount= 2
2025-04-07T20:47:42.030Z,1744058862.030 [ElevatorServo](ERROR): Communications Fault
2025-04-07T20:47:42.058Z,1744058862.058 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2025-04-07T20:47:42.390Z,1744058862.390 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:42.391Z,1744058862.391 [Power24vConverter](INFO): Powering down.
2025-04-07T20:47:42.392Z,1744058862.392 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:42.399Z,1744058862.399 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-07T20:47:42.399Z,1744058862.399 [ElevatorServo](INFO): Powering down
2025-04-07T20:47:42.427Z,1744058862.427 [MassServo](FAULT): Overload Error
2025-04-07T20:47:42.427Z,1744058862.427 [MassServo] Hardware Fault, FailCount= 1
2025-04-07T20:47:42.427Z,1744058862.427 [MassServo](ERROR): Hardware Fault
2025-04-07T20:47:42.431Z,1744058862.431 [CBIT](ERROR): Hardware Fault in component: MassServo
2025-04-07T20:47:42.782Z,1744058862.782 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:42.783Z,1744058862.783 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:42.793Z,1744058862.793 [ElevatorServo](FAULT): LCB fault:  Current Limiter Activated.
2025-04-07T20:47:42.793Z,1744058862.793 [ElevatorServo] Hardware Fault, FailCount= 2
2025-04-07T20:47:42.793Z,1744058862.793 [ElevatorServo](ERROR): Hardware Fault
2025-04-07T20:47:42.794Z,1744058862.794 [WetLabsBB2FL] Communications Fault, FailCount= 1
2025-04-07T20:47:42.794Z,1744058862.794 [WetLabsBB2FL](ERROR): Communications Fault
2025-04-07T20:47:42.795Z,1744058862.795 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-07T20:47:42.795Z,1744058862.795 [MassServo](INFO): Powering down
2025-04-07T20:47:42.935Z,1744058862.935 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2025-04-07T20:47:43.262Z,1744058863.262 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:43.274Z,1744058863.274 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-07T20:47:43.274Z,1744058863.274 [DepthKeller33X] Communications Fault, FailCount= 2
2025-04-07T20:47:43.274Z,1744058863.274 [DepthKeller33X](ERROR): Communications Fault
2025-04-07T20:47:43.275Z,1744058863.275 [Power24vConverter](INFO): Powering up.
2025-04-07T20:47:43.276Z,1744058863.276 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:43.284Z,1744058863.284 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:43.294Z,1744058863.294 [WetLabsBB2FL](INFO): Powering down
2025-04-07T20:47:43.405Z,1744058863.405 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-07T20:47:43.541Z,1744058863.541 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-07T20:47:43.541Z,1744058863.541 [CBIT](INFO): Clearing failed state for component Power24vConverter
2025-04-07T20:47:43.541Z,1744058863.541 [Power24vConverter] No Fault, FailCount= 1
2025-04-07T20:47:43.542Z,1744058863.542 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-04-07T20:47:43.542Z,1744058863.542 [ElevatorServo] No Fault, FailCount= 2
2025-04-07T20:47:43.874Z,1744058863.874 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:43.875Z,1744058863.875 [DepthKeller33X](INFO): Powering down
2025-04-07T20:47:43.971Z,1744058863.971 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:43.979Z,1744058863.979 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:44.099Z,1744058864.099 [MassServo](DEBUG): Initializing MassServo.
2025-04-07T20:47:44.100Z,1744058864.100 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-04-07T20:47:44.165Z,1744058864.165 [CBIT](INFO): Clearing failed state for component MassServo
2025-04-07T20:47:44.165Z,1744058864.165 [MassServo] No Fault, FailCount= 1
2025-04-07T20:47:44.166Z,1744058864.166 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2025-04-07T20:47:44.166Z,1744058864.166 [WetLabsBB2FL] No Fault, FailCount= 1
2025-04-07T20:47:44.490Z,1744058864.490 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:44.492Z,1744058864.492 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:44.518Z,1744058864.518 [WetLabsBB2FL](INFO): Powering up
2025-04-07T20:47:44.938Z,1744058864.938 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2025-04-07T20:47:44.938Z,1744058864.938 [ElevatorServo](FAULT): Elevator failed to initialize
2025-04-07T20:47:44.938Z,1744058864.938 [ElevatorServo] Communications Fault, FailCount= 3
2025-04-07T20:47:44.938Z,1744058864.938 [ElevatorServo](ERROR): Communications Fault
2025-04-07T20:47:45.070Z,1744058865.070 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2025-04-07T20:47:45.070Z,1744058865.070 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo
2025-04-07T20:47:45.390Z,1744058865.390 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:45.392Z,1744058865.392 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-07T20:47:45.401Z,1744058865.401 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-07T20:47:45.401Z,1744058865.401 [ElevatorServo](INFO): Powering down
2025-04-07T20:47:45.404Z,1744058865.404 [CBIT](INFO): Critical error at 20250407T204745
2025-04-07T20:47:45.407Z,1744058865.407 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-07T20:47:45.407Z,1744058865.407 [DepthKeller33X] No Fault, FailCount= 2
2025-04-07T20:47:45.798Z,1744058865.798 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:45.798Z,1744058865.798 [DepthKeller33X](INFO): Initializing.
2025-04-07T20:47:46.210Z,1744058866.210 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:46.228Z,1744058866.228 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:46.347Z,1744058866.347 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-07T20:47:46.686Z,1744058866.686 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:47.086Z,1744058867.086 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:47.490Z,1744058867.490 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:47.502Z,1744058867.502 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-07T20:47:47.502Z,1744058867.502 [DepthKeller33X] Communications Fault, FailCount= 3
2025-04-07T20:47:47.502Z,1744058867.502 [DepthKeller33X](ERROR): Communications Fault
2025-04-07T20:47:47.538Z,1744058867.538 [BuoyancyServo](FAULT): Reading outside of valid range:12047.000000

2025-04-07T20:47:47.539Z,1744058867.539 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2025-04-07T20:47:47.539Z,1744058867.539 [BuoyancyServo] Hardware Fault, FailCount= 1
2025-04-07T20:47:47.539Z,1744058867.539 [BuoyancyServo](ERROR): Hardware Fault
2025-04-07T20:47:47.578Z,1744058867.578 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-07T20:47:47.578Z,1744058867.578 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2025-04-07T20:47:47.914Z,1744058867.914 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:47.914Z,1744058867.914 [DepthKeller33X](INFO): Powering down
2025-04-07T20:47:48.046Z,1744058868.046 [MassServo](FAULT): Overload Error
2025-04-07T20:47:48.047Z,1744058868.047 [MassServo] Hardware Fault, FailCount= 2
2025-04-07T20:47:48.047Z,1744058868.047 [MassServo](ERROR): Hardware Fault
2025-04-07T20:47:48.051Z,1744058868.051 [CBIT](ERROR): Hardware Fault in component: MassServo
2025-04-07T20:47:48.382Z,1744058868.382 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:48.383Z,1744058868.383 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2025-04-07T20:47:48.384Z,1744058868.384 [Aanderaa_O2] Communications Fault, FailCount= 1
2025-04-07T20:47:48.384Z,1744058868.384 [Aanderaa_O2](ERROR): Communications Fault
2025-04-07T20:47:48.392Z,1744058868.392 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-07T20:47:48.392Z,1744058868.392 [MassServo](INFO): Powering down
2025-04-07T20:47:48.397Z,1744058868.397 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2025-04-07T20:47:48.786Z,1744058868.786 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:48.906Z,1744058868.906 [Aanderaa_O2](INFO): Powering down
2025-04-07T20:47:48.918Z,1744058868.918 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-07T20:47:48.918Z,1744058868.918 [DepthKeller33X] No Fault, FailCount= 3
2025-04-07T20:47:49.254Z,1744058869.254 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:49.255Z,1744058869.255 [DepthKeller33X](INFO): Initializing.
2025-04-07T20:47:49.282Z,1744058869.282 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:49.403Z,1744058869.403 [MassServo](DEBUG): Initializing MassServo.
2025-04-07T20:47:49.407Z,1744058869.407 [CBIT](INFO): Clearing failed state for component MassServo
2025-04-07T20:47:49.407Z,1744058869.407 [MassServo] No Fault, FailCount= 2
2025-04-07T20:47:49.734Z,1744058869.734 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:49.744Z,1744058869.744 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-07T20:47:49.744Z,1744058869.744 [BuoyancyServo](INFO): Powering down
2025-04-07T20:47:49.802Z,1744058869.802 [WetLabsBB2FL] Communications Fault, FailCount= 2
2025-04-07T20:47:49.802Z,1744058869.802 [WetLabsBB2FL](ERROR): Communications Fault
2025-04-07T20:47:49.878Z,1744058869.878 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2025-04-07T20:47:49.878Z,1744058869.878 [Aanderaa_O2] No Fault, FailCount= 1
2025-04-07T20:47:49.879Z,1744058869.879 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2025-04-07T20:47:50.210Z,1744058870.210 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:50.298Z,1744058870.298 [WetLabsBB2FL](INFO): Powering down
2025-04-07T20:47:50.654Z,1744058870.654 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:50.677Z,1744058870.677 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-04-07T20:47:50.677Z,1744058870.677 [BuoyancyServo] No Fault, FailCount= 1
2025-04-07T20:47:51.038Z,1744058871.038 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:51.038Z,1744058871.038 [AHRS_M2](FAULT): Failed to initialize within timeout.
2025-04-07T20:47:51.038Z,1744058871.038 [AHRS_M2] Communications Fault, FailCount= 1
2025-04-07T20:47:51.038Z,1744058871.038 [AHRS_M2](ERROR): Communications Fault
2025-04-07T20:47:51.050Z,1744058871.050 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-07T20:47:51.050Z,1744058871.050 [DepthKeller33X] Communications Fault, FailCount= 4
2025-04-07T20:47:51.050Z,1744058871.050 [DepthKeller33X](ERROR): Communications Fault
2025-04-07T20:47:51.059Z,1744058871.059 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:51.066Z,1744058871.066 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-07T20:47:51.070Z,1744058871.070 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2025-04-07T20:47:51.071Z,1744058871.071 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-07T20:47:51.105Z,1744058871.105 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005044
2025-04-07T20:47:51.116Z,1744058871.116 [AHRS_M2](INFO): Powering down
2025-04-07T20:47:51.187Z,1744058871.187 [DepthKeller33X](INFO): Powering down
2025-04-07T20:47:51.295Z,1744058871.295 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2025-04-07T20:47:51.295Z,1744058871.295 [WetLabsBB2FL] No Fault, FailCount= 2
2025-04-07T20:47:51.512Z,1744058871.512 [WetLabsBB2FL](INFO): Powering up
2025-04-07T20:47:51.786Z,1744058871.786 [MassServo](FAULT): Mass initialization uart error:serial timeout
2025-04-07T20:47:51.786Z,1744058871.786 [MassServo] Communications Fault, FailCount= 3
2025-04-07T20:47:51.786Z,1744058871.786 [MassServo](ERROR): Communications Fault
2025-04-07T20:47:51.790Z,1744058871.790 [CBIT](ERROR): Communications Fault in component: MassServo
2025-04-07T20:47:52.254Z,1744058872.254 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2025-04-07T20:47:52.254Z,1744058872.254 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2025-04-07T20:47:52.254Z,1744058872.254 [BuoyancyServo] Communications Fault, FailCount= 2
2025-04-07T20:47:52.254Z,1744058872.254 [BuoyancyServo](ERROR): Communications Fault
2025-04-07T20:47:52.255Z,1744058872.255 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-07T20:47:52.255Z,1744058872.255 [MassServo](INFO): Powering down
2025-04-07T20:47:52.260Z,1744058872.260 [CBIT](INFO): Clearing failed state for component AHRS_M2
2025-04-07T20:47:52.260Z,1744058872.260 [AHRS_M2] No Fault, FailCount= 1
2025-04-07T20:47:52.260Z,1744058872.260 [CBIT](INFO): Clearing failed state for component DepthKeller33X
2025-04-07T20:47:52.260Z,1744058872.260 [DepthKeller33X] No Fault, FailCount= 4
2025-04-07T20:47:52.261Z,1744058872.261 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2025-04-07T20:47:52.328Z,1744058872.328 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-07T20:47:52.336Z,1744058872.336 [DepthKeller33X](INFO): Initializing.
2025-04-07T20:47:52.742Z,1744058872.742 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:52.863Z,1744058872.863 [MassServo](DEBUG): Initializing MassServo.
2025-04-07T20:47:52.868Z,1744058872.868 [CBIT](INFO): Clearing failed state for component MassServo
2025-04-07T20:47:52.868Z,1744058872.868 [MassServo] No Fault, FailCount= 3
2025-04-07T20:47:53.958Z,1744058873.958 [DepthKeller33X](FAULT): Failed to initialize.
2025-04-07T20:47:53.958Z,1744058873.958 [DepthKeller33X] Communications Fault, FailCount= 5
2025-04-07T20:47:53.958Z,1744058873.958 [DepthKeller33X](ERROR): Communications Fault
2025-04-07T20:47:53.989Z,1744058873.989 [CBIT](ERROR): Communications Fault in component: DepthKeller33X
2025-04-07T20:47:54.002Z,1744058874.002 [CBIT](CRITICAL): Communications Fault in component: DepthKeller33X
2025-04-07T20:47:54.349Z,1744058874.349 [DepthKeller33X](INFO): Powering down
2025-04-07T20:47:54.461Z,1744058874.461 [CBIT](INFO): Critical error at 20250407T204754
2025-04-07T20:47:54.471Z,1744058874.471 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-04-07T20:47:54.471Z,1744058874.471 [BuoyancyServo] No Fault, FailCount= 2
2025-04-07T20:47:55.886Z,1744058875.886 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:56.290Z,1744058876.290 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:56.694Z,1744058876.694 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:56.703Z,1744058876.703 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:56.806Z,1744058876.806 [WetLabsBB2FL] Communications Fault, FailCount= 3
2025-04-07T20:47:56.806Z,1744058876.806 [WetLabsBB2FL](ERROR): Communications Fault
2025-04-07T20:47:56.823Z,1744058876.823 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-07T20:47:56.855Z,1744058876.855 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2025-04-07T20:47:57.186Z,1744058877.186 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:57.230Z,1744058877.230 [MassServo](FAULT): Overload Error
2025-04-07T20:47:57.230Z,1744058877.230 [MassServo] Hardware Fault, FailCount= 4
2025-04-07T20:47:57.230Z,1744058877.230 [MassServo](ERROR): Hardware Fault
2025-04-07T20:47:57.235Z,1744058877.235 [CBIT](ERROR): Hardware Fault in component: MassServo
2025-04-07T20:47:57.310Z,1744058877.310 [WetLabsBB2FL](INFO): Powering down
2025-04-07T20:47:57.548Z,1744058877.548 [CTD_Seabird](ERROR): Failed to parse device response: <!--startlogging-->
2025-04-07T20:47:57.578Z,1744058877.578 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:57.586Z,1744058877.586 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-07T20:47:57.586Z,1744058877.586 [MassServo](INFO): Powering down
2025-04-07T20:47:57.986Z,1744058877.986 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:58.406Z,1744058878.406 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:58.427Z,1744058878.427 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:47:58.547Z,1744058878.547 [MassServo](DEBUG): Initializing MassServo.
2025-04-07T20:47:58.553Z,1744058878.553 [CBIT](INFO): Clearing failed state for component MassServo
2025-04-07T20:47:58.553Z,1744058878.553 [MassServo] No Fault, FailCount= 4
2025-04-07T20:47:58.553Z,1744058878.553 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2025-04-07T20:47:58.553Z,1744058878.553 [WetLabsBB2FL] No Fault, FailCount= 3
2025-04-07T20:47:58.899Z,1744058878.899 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:58.942Z,1744058878.942 [WetLabsBB2FL](INFO): Powering up
2025-04-07T20:47:59.286Z,1744058879.286 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:47:59.687Z,1744058879.687 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:00.098Z,1744058880.098 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:00.498Z,1744058880.498 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:00.499Z,1744058880.499 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2025-04-07T20:48:00.499Z,1744058880.499 [Aanderaa_O2] Communications Fault, FailCount= 2
2025-04-07T20:48:00.499Z,1744058880.499 [Aanderaa_O2](ERROR): Communications Fault
2025-04-07T20:48:00.531Z,1744058880.531 [BuoyancyServo](FAULT): Reading outside of valid range:12048.000000

2025-04-07T20:48:00.531Z,1744058880.531 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2025-04-07T20:48:00.531Z,1744058880.531 [BuoyancyServo] Hardware Fault, FailCount= 3
2025-04-07T20:48:00.531Z,1744058880.531 [BuoyancyServo](ERROR): Hardware Fault
2025-04-07T20:48:00.536Z,1744058880.536 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2025-04-07T20:48:00.536Z,1744058880.536 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2025-04-07T20:48:00.898Z,1744058880.898 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:01.018Z,1744058881.018 [Aanderaa_O2](INFO): Powering down
2025-04-07T20:48:01.362Z,1744058881.362 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:01.762Z,1744058881.762 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:01.775Z,1744058881.775 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2025-04-07T20:48:01.775Z,1744058881.775 [Aanderaa_O2] No Fault, FailCount= 2
2025-04-07T20:48:02.178Z,1744058882.178 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:02.574Z,1744058882.574 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:02.600Z,1744058882.600 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-07T20:48:02.600Z,1744058882.600 [BuoyancyServo](INFO): Powering down
2025-04-07T20:48:03.042Z,1744058883.042 [MassServo](ERROR): isCommunicating uart error serial timeout
2025-04-07T20:48:03.042Z,1744058883.042 [MassServo](FAULT): Invalid EZ Servo response:""
2025-04-07T20:48:03.042Z,1744058883.042 [MassServo] Communications Fault, FailCount= 5
2025-04-07T20:48:03.042Z,1744058883.042 [MassServo](ERROR): Communications Fault
2025-04-07T20:48:03.043Z,1744058883.043 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout
2025-04-07T20:48:03.043Z,1744058883.043 [MassServo] Hardware Fault, FailCount= 5
2025-04-07T20:48:03.043Z,1744058883.043 [MassServo](ERROR): Hardware Fault
2025-04-07T20:48:03.054Z,1744058883.054 [MassServo](FAULT): Invalid EZ Servo response:"79\r"
2025-04-07T20:48:03.055Z,1744058883.055 [MassServo] Communications Fault, FailCount= 5
2025-04-07T20:48:03.055Z,1744058883.055 [MassServo](ERROR): Communications Fault
2025-04-07T20:48:03.060Z,1744058883.060 [CBIT](ERROR): Communications Fault in component: MassServo
2025-04-07T20:48:03.060Z,1744058883.060 [CBIT](CRITICAL): Communications Fault in component: MassServo
2025-04-07T20:48:03.395Z,1744058883.395 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:03.404Z,1744058883.404 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-07T20:48:03.404Z,1744058883.404 [MassServo](INFO): Powering down
2025-04-07T20:48:03.407Z,1744058883.407 [CBIT](INFO): Critical error at 20250407T204803
2025-04-07T20:48:03.571Z,1744058883.571 [CTD_Seabird](ERROR): Failed to parse device response: .28
2025-04-07T20:48:03.798Z,1744058883.798 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:03.810Z,1744058883.810 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-04-07T20:48:03.810Z,1744058883.810 [BuoyancyServo] No Fault, FailCount= 3
2025-04-07T20:48:04.202Z,1744058884.202 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:04.211Z,1744058884.211 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:48:04.218Z,1744058884.218 [WetLabsBB2FL] Communications Fault, FailCount= 4
2025-04-07T20:48:04.218Z,1744058884.218 [WetLabsBB2FL](ERROR): Communications Fault
2025-04-07T20:48:04.219Z,1744058884.219 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-07T20:48:04.220Z,1744058884.220 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:48:04.335Z,1744058884.335 [MassServo](DEBUG): Initializing MassServo.
2025-04-07T20:48:04.340Z,1744058884.340 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2025-04-07T20:48:04.575Z,1744058884.575 [CTD_Seabird](ERROR): Failed to parse device response: .29
2025-04-07T20:48:04.674Z,1744058884.674 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:04.726Z,1744058884.726 [WetLabsBB2FL](INFO): Powering down
2025-04-07T20:48:04.978Z,1744058884.978 [CommandExec](IMPORTANT): got command quit
2025-04-07T20:48:05.070Z,1744058885.070 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:05.071Z,1744058885.071 [NAL9602](INFO): Powering up NAL9602
2025-04-07T20:48:05.486Z,1744058885.486 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:05.486Z,1744058885.486 [AHRS_M2](FAULT): Failed to initialize within timeout.
2025-04-07T20:48:05.486Z,1744058885.486 [AHRS_M2] Communications Fault, FailCount= 2
2025-04-07T20:48:05.486Z,1744058885.486 [AHRS_M2](ERROR): Communications Fault
2025-04-07T20:48:05.525Z,1744058885.525 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2025-04-07T20:48:05.564Z,1744058885.564 [AHRS_M2](INFO): Powering down
2025-04-07T20:48:05.648Z,1744058885.648 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2025-04-07T20:48:05.648Z,1744058885.648 [WetLabsBB2FL] No Fault, FailCount= 4
2025-04-07T20:48:05.946Z,1744058885.946 [WetLabsBB2FL](INFO): Powering up
2025-04-07T20:48:05.982Z,1744058885.982 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:05.982Z,1744058885.982 [CommandExec](INFO): Uninitializing the command executive.
2025-04-07T20:48:05.983Z,1744058885.983 [CommandExec](INFO): Uninitializing the command scheduler.
2025-04-07T20:48:05.983Z,1744058885.983 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:06.158Z,1744058886.158 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-04-07T20:48:06.158Z,1744058886.158 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-04-07T20:48:06.158Z,1744058886.158 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:06.159Z,1744058886.159 [NavChartDb](INFO): Join timeout helper Thread ID is 761
2025-04-07T20:48:06.384Z,1744058886.384 [CBIT](INFO): Clearing failed state for component AHRS_M2
2025-04-07T20:48:06.384Z,1744058886.384 [AHRS_M2] No Fault, FailCount= 2
2025-04-07T20:48:06.601Z,1744058886.601 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:06.601Z,1744058886.601 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:06.614Z,1744058886.614 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-04-07T20:48:06.614Z,1744058886.614 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:06.614Z,1744058886.614 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 762
2025-04-07T20:48:06.698Z,1744058886.698 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:06.776Z,1744058886.776 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-07T20:48:06.799Z,1744058886.799 [WetLabsBB2FL](INFO): Powering down
2025-04-07T20:48:06.801Z,1744058886.801 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:06.814Z,1744058886.814 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-04-07T20:48:06.814Z,1744058886.814 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:06.815Z,1744058886.815 [CTD_Seabird](INFO): Join timeout helper Thread ID is 764
2025-04-07T20:48:07.587Z,1744058887.587 [CTD_Seabird](INFO): Powering down
2025-04-07T20:48:07.622Z,1744058887.622 [BuoyancyServo](FAULT): Reading outside of valid range:12047.000000

2025-04-07T20:48:07.622Z,1744058887.622 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2025-04-07T20:48:07.623Z,1744058887.623 [BuoyancyServo] Hardware Fault, FailCount= 4
2025-04-07T20:48:07.623Z,1744058887.623 [BuoyancyServo](ERROR): Hardware Fault
2025-04-07T20:48:07.627Z,1744058887.627 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2025-04-07T20:48:07.714Z,1744058887.714 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:07.714Z,1744058887.714 [CTD_Seabird](INFO): Powering down
2025-04-07T20:48:07.726Z,1744058887.726 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:07.730Z,1744058887.730 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-04-07T20:48:07.730Z,1744058887.730 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:07.730Z,1744058887.730 [Radio_Surface](INFO): Join timeout helper Thread ID is 765
2025-04-07T20:48:07.750Z,1744058887.750 [Radio_Surface](INFO): Powering down
2025-04-07T20:48:07.751Z,1744058887.751 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:07.751Z,1744058887.751 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:07.752Z,1744058887.752 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-04-07T20:48:07.752Z,1744058887.752 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:07.753Z,1744058887.753 [Onboard](INFO): Join timeout helper Thread ID is 766
2025-04-07T20:48:08.166Z,1744058888.166 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-04-07T20:48:09.613Z,1744058889.613 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-07T20:48:09.613Z,1744058889.613 [BuoyancyServo](INFO): Powering down
2025-04-07T20:48:10.330Z,1744058890.330 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:10.738Z,1744058890.738 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:10.751Z,1744058890.751 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2025-04-07T20:48:10.751Z,1744058890.751 [BuoyancyServo] No Fault, FailCount= 4
2025-04-07T20:48:11.142Z,1744058891.142 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:11.151Z,1744058891.151 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-07T20:48:11.152Z,1744058891.152 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-07T20:48:11.538Z,1744058891.538 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:11.950Z,1744058891.950 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:12.366Z,1744058892.366 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:12.367Z,1744058892.367 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2025-04-07T20:48:12.367Z,1744058892.367 [Aanderaa_O2] Communications Fault, FailCount= 3
2025-04-07T20:48:12.367Z,1744058892.367 [Aanderaa_O2](ERROR): Communications Fault
2025-04-07T20:48:12.396Z,1744058892.396 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2025-04-07T20:48:12.396Z,1744058892.396 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2025-04-07T20:48:12.459Z,1744058892.459 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:12.461Z,1744058892.461 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:12.480Z,1744058892.480 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-04-07T20:48:12.480Z,1744058892.480 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:12.481Z,1744058892.481 [DataOverHttps](INFO): Join timeout helper Thread ID is 768
2025-04-07T20:48:12.758Z,1744058892.758 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:12.878Z,1744058892.878 [Aanderaa_O2](INFO): Powering down
2025-04-07T20:48:13.186Z,1744058893.186 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:13.186Z,1744058893.186 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.199Z,1744058893.199 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-04-07T20:48:13.199Z,1744058893.199 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.199Z,1744058893.199 [DAT](INFO): Join timeout helper Thread ID is 769
2025-04-07T20:48:13.234Z,1744058893.234 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:13.238Z,1744058893.238 [DAT](INFO): Powering down
2025-04-07T20:48:13.310Z,1744058893.310 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:13.311Z,1744058893.311 [DAT](INFO): Powering down
2025-04-07T20:48:13.311Z,1744058893.311 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.342Z,1744058893.342 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-04-07T20:48:13.342Z,1744058893.342 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.343Z,1744058893.343 [BackseatComponent](INFO): Join timeout helper Thread ID is 770
2025-04-07T20:48:13.542Z,1744058893.542 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:13.542Z,1744058893.542 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.563Z,1744058893.563 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-04-07T20:48:13.563Z,1744058893.563 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.563Z,1744058893.563 [logger](INFO): Join timeout helper Thread ID is 771
2025-04-07T20:48:13.574Z,1744058893.574 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:13.574Z,1744058893.574 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.583Z,1744058893.583 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-04-07T20:48:13.583Z,1744058893.583 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.583Z,1744058893.583 [CommandLine](INFO): Join timeout helper Thread ID is 773
2025-04-07T20:48:13.634Z,1744058893.634 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:13.634Z,1744058893.634 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.638Z,1744058893.638 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2025-04-07T20:48:13.643Z,1744058893.643 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-04-07T20:48:13.643Z,1744058893.643 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.643Z,1744058893.643 [CommandExec](INFO): Join timeout helper Thread ID is 775
2025-04-07T20:48:13.654Z,1744058893.654 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-04-07T20:48:13.654Z,1744058893.654 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.654Z,1744058893.654 [controlThread](INFO): Join timeout helper Thread ID is 776
2025-04-07T20:48:13.680Z,1744058893.680 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-07T20:48:13.680Z,1744058893.680 [controlThread](DEBUG): Uninitializing ControlThread
2025-04-07T20:48:13.680Z,1744058893.680 [AHRS_M2](INFO): Powering down
2025-04-07T20:48:13.751Z,1744058893.751 [DepthKeller33X](INFO): Powering down
2025-04-07T20:48:13.752Z,1744058893.752 [NAL9602](INFO): Powering down
2025-04-07T20:48:13.753Z,1744058893.753 [Aanderaa_O2](INFO): Powering down
2025-04-07T20:48:13.754Z,1744058893.754 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-04-07T20:48:13.755Z,1744058893.755 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-04-07T20:48:13.756Z,1744058893.756 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-04-07T20:48:13.756Z,1744058893.756 [MissionManager](INFO): Uninitializing Mission Default
2025-04-07T20:48:13.759Z,1744058893.759 [MissionManager](INFO): Uninitializing Mission Startup
2025-04-07T20:48:13.761Z,1744058893.761 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-04-07T20:48:13.761Z,1744058893.761 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-04-07T20:48:13.761Z,1744058893.761 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-04-07T20:48:13.762Z,1744058893.762 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-04-07T20:48:13.762Z,1744058893.762 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-07T20:48:13.762Z,1744058893.762 [BuoyancyServo](INFO): Powering down
2025-04-07T20:48:13.894Z,1744058893.894 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-07T20:48:13.894Z,1744058893.894 [ElevatorServo](INFO): Powering down
2025-04-07T20:48:13.895Z,1744058893.895 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-07T20:48:13.895Z,1744058893.895 [MassServo](INFO): Powering down
2025-04-07T20:48:13.896Z,1744058893.896 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-07T20:48:13.896Z,1744058893.896 [RudderServo](INFO): Powering down
2025-04-07T20:48:13.897Z,1744058893.897 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-07T20:48:13.897Z,1744058893.897 [ThrusterHE](INFO): Powering down
2025-04-07T20:48:13.898Z,1744058893.898 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-04-07T20:48:13.898Z,1744058893.898 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-04-07T20:48:13.898Z,1744058893.898 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-04-07T20:48:13.899Z,1744058893.899 [CBIT](DEBUG): Powering off loads.
2025-04-07T20:48:13.910Z,1744058893.910 [CBIT](DEBUG): Disabling WDT.
2025-04-07T20:48:13.922Z,1744058893.922 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-07T20:48:13.923Z,1744058893.923 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.947Z,1744058893.947 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.950Z,1744058893.950 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.956Z,1744058893.956 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:13.962Z,1744058893.962 [DAT ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:14.003Z,1744058894.003 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:14.289Z,1744058894.289 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:14.293Z,1744058894.293 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:14.334Z,1744058894.334 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-07T20:48:14.352Z,1744058894.352 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-07T20:48:14.415Z,1744058894.415 [logger ThreadHandler](INFO): Thread cancelled.