2024-04-12T17:03:55.868Z,1712941435.868 [Supervisor](DEBUG): Initializing supervisor. 2024-04-12T17:03:55.873Z,1712941435.873 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-04-12T17:03:55.873Z,1712941435.873 [SyncHandler](INFO): Protected caller Thread ID is 9028 2024-04-12T17:03:55.874Z,1712941435.874 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-04-12T17:03:55.875Z,1712941435.875 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-04-12T17:03:55.875Z,1712941435.875 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9029 2024-04-12T17:03:55.879Z,1712941435.879 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-04-12T17:03:55.897Z,1712941435.897 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-04-12T17:03:55.898Z,1712941435.898 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-04-12T17:03:55.898Z,1712941435.898 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 9030 2024-04-12T17:03:55.902Z,1712941435.902 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-04-12T17:03:55.903Z,1712941435.903 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-04-12T17:03:55.903Z,1712941435.903 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9031 2024-04-12T17:03:55.906Z,1712941435.906 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-04-12T17:03:55.906Z,1712941435.906 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-04-12T17:03:55.907Z,1712941435.907 [logger ThreadHandler](INFO): Protected caller Thread ID is 9032 2024-04-12T17:03:55.910Z,1712941435.910 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-04-12T17:03:55.911Z,1712941435.911 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-04-12T17:03:55.912Z,1712941435.912 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-04-12T17:03:56.020Z,1712941436.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-04-12T17:03:56.021Z,1712941436.021 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-04-12T17:03:56.776Z,1712941436.776 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-04-12T17:03:56.776Z,1712941436.776 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-04-12T17:03:57.021Z,1712941437.021 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-04-12T17:03:57.022Z,1712941437.022 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-04-12T17:03:57.112Z,1712941437.112 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-04-12T17:03:57.256Z,1712941437.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-04-12T17:03:57.256Z,1712941437.256 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-04-12T17:03:57.349Z,1712941437.349 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-04-12T17:03:57.470Z,1712941437.470 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-04-12T17:03:57.470Z,1712941437.470 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-04-12T17:03:57.881Z,1712941437.881 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-04-12T17:03:57.882Z,1712941437.882 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-04-12T17:03:58.437Z,1712941438.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-04-12T17:03:58.438Z,1712941438.438 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-04-12T17:03:58.676Z,1712941438.676 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-04-12T17:03:58.677Z,1712941438.677 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-04-12T17:03:58.882Z,1712941438.882 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-04-12T17:03:58.882Z,1712941438.882 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-04-12T17:03:59.428Z,1712941439.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-04-12T17:03:59.429Z,1712941439.429 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-04-12T17:03:59.747Z,1712941439.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-04-12T17:03:59.747Z,1712941439.747 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-04-12T17:03:59.986Z,1712941439.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-04-12T17:03:59.987Z,1712941439.987 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-04-12T17:04:00.380Z,1712941440.380 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-04-12T17:04:00.380Z,1712941440.380 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-04-12T17:04:00.778Z,1712941440.778 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-04-12T17:04:00.780Z,1712941440.780 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-04-12T17:04:00.781Z,1712941440.781 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-04-12T17:04:01.044Z,1712941441.044 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-04-12T17:04:01.452Z,1712941441.452 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-04-12T17:04:01.566Z,1712941441.566 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-04-12T17:04:01.664Z,1712941441.664 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-04-12T17:04:01.771Z,1712941441.771 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-04-12T17:04:01.893Z,1712941441.893 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-04-12T17:04:02.166Z,1712941442.166 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-04-12T17:04:02.167Z,1712941442.167 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-04-12T17:04:02.273Z,1712941442.273 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-04-12T17:04:02.378Z,1712941442.378 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-04-12T17:04:02.613Z,1712941442.613 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-04-12T17:04:02.806Z,1712941442.806 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-04-12T17:04:02.817Z,1712941442.817 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-04-12T17:04:03.018Z,1712941443.018 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-04-12T17:04:03.019Z,1712941443.019 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-04-12T17:04:03.095Z,1712941443.095 [VerticalControl](DEBUG): Construct VerticalControl. 2024-04-12T17:04:03.188Z,1712941443.188 [VerticalControl] Loaded 2024-04-12T17:04:03.188Z,1712941443.188 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-04-12T17:04:03.191Z,1712941443.191 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-04-12T17:04:03.286Z,1712941443.286 [HorizontalControl] Loaded 2024-04-12T17:04:03.286Z,1712941443.286 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-04-12T17:04:03.289Z,1712941443.289 [SpeedControl](DEBUG): Construct SpeedControl. 2024-04-12T17:04:03.292Z,1712941443.292 [SpeedControl] Loaded 2024-04-12T17:04:03.304Z,1712941443.304 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-04-12T17:04:03.307Z,1712941443.307 [LoopControl](DEBUG): Construct LoopControl. 2024-04-12T17:04:03.307Z,1712941443.307 [LoopControl] Loaded 2024-04-12T17:04:03.307Z,1712941443.307 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-04-12T17:04:03.308Z,1712941443.308 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-04-12T17:04:03.308Z,1712941443.308 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-04-12T17:04:03.411Z,1712941443.411 [DepthRateCalculator] Loaded 2024-04-12T17:04:03.411Z,1712941443.411 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-04-12T17:04:03.428Z,1712941443.428 [PitchRateCalculator] Loaded 2024-04-12T17:04:03.428Z,1712941443.428 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-04-12T17:04:03.438Z,1712941443.438 [SpeedCalculator] Loaded 2024-04-12T17:04:03.438Z,1712941443.438 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-04-12T17:04:03.455Z,1712941443.455 [YawRateCalculator] Loaded 2024-04-12T17:04:03.455Z,1712941443.455 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-04-12T17:04:03.486Z,1712941443.486 [ElevatorOffsetCalculator] Loaded 2024-04-12T17:04:03.486Z,1712941443.486 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-04-12T17:04:03.486Z,1712941443.486 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-04-12T17:04:03.487Z,1712941443.487 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-04-12T17:04:03.550Z,1712941443.550 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-04-12T17:04:03.550Z,1712941443.550 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-04-12T17:04:03.655Z,1712941443.655 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-04-12T17:04:03.655Z,1712941443.655 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-04-12T17:04:04.371Z,1712941444.371 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-04-12T17:04:04.371Z,1712941444.371 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-04-12T17:04:04.616Z,1712941444.616 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-04-12T17:04:04.616Z,1712941444.616 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-04-12T17:04:05.042Z,1712941445.042 [AHRS_M2] Loaded 2024-04-12T17:04:05.042Z,1712941445.042 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-04-12T17:04:05.078Z,1712941445.078 [BackseatComponent] Loaded 2024-04-12T17:04:05.078Z,1712941445.078 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-04-12T17:04:05.079Z,1712941445.079 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C14E0 2024-04-12T17:04:05.079Z,1712941445.079 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 9121 2024-04-12T17:04:05.082Z,1712941445.082 [LcmUniversalReporter] Loaded 2024-04-12T17:04:05.082Z,1712941445.082 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-04-12T17:04:05.887Z,1712941445.887 [BPC1] Loaded 2024-04-12T17:04:05.888Z,1712941445.888 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-04-12T17:04:05.961Z,1712941445.961 [DataOverHttps] Loaded 2024-04-12T17:04:05.962Z,1712941445.962 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-04-12T17:04:05.963Z,1712941445.963 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F14E0 2024-04-12T17:04:05.963Z,1712941445.963 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9122 2024-04-12T17:04:05.984Z,1712941445.984 [Depth_Keller] Loaded 2024-04-12T17:04:05.984Z,1712941445.984 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-04-12T17:04:06.047Z,1712941446.047 [NAL9602] Loaded 2024-04-12T17:04:06.047Z,1712941446.047 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-04-12T17:04:06.077Z,1712941446.077 [Onboard] Loaded 2024-04-12T17:04:06.077Z,1712941446.077 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-04-12T17:04:06.078Z,1712941446.078 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A214E0 2024-04-12T17:04:06.078Z,1712941446.078 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9123 2024-04-12T17:04:06.090Z,1712941446.090 [Power24vConverter] Loaded 2024-04-12T17:04:06.091Z,1712941446.091 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-04-12T17:04:06.104Z,1712941446.104 [Radio_Surface] Loaded 2024-04-12T17:04:06.104Z,1712941446.104 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-04-12T17:04:06.105Z,1712941446.105 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A514E0 2024-04-12T17:04:06.105Z,1712941446.105 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9124 2024-04-12T17:04:06.256Z,1712941446.256 [RDI_Pathfinder] Loaded 2024-04-12T17:04:06.256Z,1712941446.256 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-04-12T17:04:06.592Z,1712941446.592 [DAT] Loaded 2024-04-12T17:04:06.592Z,1712941446.592 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-04-12T17:04:06.593Z,1712941446.593 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A814E0 2024-04-12T17:04:06.594Z,1712941446.594 [DAT ThreadHandler](INFO): Protected caller Thread ID is 9125 2024-04-12T17:04:06.594Z,1712941446.594 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-04-12T17:04:06.595Z,1712941446.595 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-04-12T17:04:06.705Z,1712941446.705 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-04-12T17:04:06.705Z,1712941446.705 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-04-12T17:04:06.719Z,1712941446.719 [NavChart] Loaded 2024-04-12T17:04:06.720Z,1712941446.720 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-04-12T17:04:06.725Z,1712941446.725 [UniversalFixResidualReporter] Loaded 2024-04-12T17:04:06.726Z,1712941446.726 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-04-12T17:04:06.726Z,1712941446.726 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-04-12T17:04:06.727Z,1712941446.727 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-04-12T17:04:06.865Z,1712941446.865 [SBIT](DEBUG): Construct Startup Built In Test. 2024-04-12T17:04:06.874Z,1712941446.874 [SBIT] Loaded 2024-04-12T17:04:06.874Z,1712941446.874 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-04-12T17:04:06.877Z,1712941446.877 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-04-12T17:04:06.890Z,1712941446.890 [IBIT] Loaded 2024-04-12T17:04:06.890Z,1712941446.890 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-04-12T17:04:06.896Z,1712941446.896 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-04-12T17:04:07.011Z,1712941447.011 [CBIT] Loaded 2024-04-12T17:04:07.011Z,1712941447.011 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-04-12T17:04:07.012Z,1712941447.012 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-04-12T17:04:07.012Z,1712941447.012 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-04-12T17:04:07.141Z,1712941447.141 [BuoyancyServo] Loaded 2024-04-12T17:04:07.141Z,1712941447.141 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-04-12T17:04:07.162Z,1712941447.162 [ElevatorServo] Loaded 2024-04-12T17:04:07.162Z,1712941447.162 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-04-12T17:04:07.184Z,1712941447.184 [MassServo] Loaded 2024-04-12T17:04:07.184Z,1712941447.184 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-04-12T17:04:07.203Z,1712941447.203 [RudderServo] Loaded 2024-04-12T17:04:07.203Z,1712941447.203 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-04-12T17:04:07.221Z,1712941447.221 [ThrusterServo] Loaded 2024-04-12T17:04:07.221Z,1712941447.221 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-04-12T17:04:07.222Z,1712941447.222 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-04-12T17:04:07.222Z,1712941447.222 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-04-12T17:04:07.232Z,1712941447.232 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-04-12T17:04:07.233Z,1712941447.233 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-04-12T17:04:07.405Z,1712941447.405 [CTD_Seabird] Loaded 2024-04-12T17:04:07.405Z,1712941447.405 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-04-12T17:04:07.406Z,1712941447.406 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD54E0 2024-04-12T17:04:07.407Z,1712941447.407 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9126 2024-04-12T17:04:07.427Z,1712941447.427 [PAR_Licor] Loaded 2024-04-12T17:04:07.427Z,1712941447.427 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-04-12T17:04:07.471Z,1712941447.471 [WetLabsBB2FL] Loaded 2024-04-12T17:04:07.471Z,1712941447.471 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-04-12T17:04:07.473Z,1712941447.473 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C054E0 2024-04-12T17:04:07.473Z,1712941447.473 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9127 2024-04-12T17:04:07.493Z,1712941447.493 [WetLabsUBAT] Loaded 2024-04-12T17:04:07.493Z,1712941447.493 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-04-12T17:04:07.494Z,1712941447.494 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C354E0 2024-04-12T17:04:07.494Z,1712941447.494 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 9128 2024-04-12T17:04:07.495Z,1712941447.495 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-04-12T17:04:07.501Z,1712941447.501 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-04-12T17:04:07.504Z,1712941447.504 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-04-12T17:04:07.515Z,1712941447.515 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-04-12T17:04:07.516Z,1712941447.516 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0 2024-04-12T17:04:07.517Z,1712941447.517 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9129 2024-04-12T17:04:07.521Z,1712941447.521 [Supervisor](INFO): Main Thread ID is 9027 2024-04-12T17:04:07.521Z,1712941447.521 [Supervisor](DEBUG): Running supervisor. 2024-04-12T17:04:07.522Z,1712941447.522 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9130 2024-04-12T17:04:07.522Z,1712941447.522 [CommandExec](INFO): Initializing the command executive. 2024-04-12T17:04:07.524Z,1712941447.524 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9131 2024-04-12T17:04:07.526Z,1712941447.526 [controlThread ThreadHandler](INFO): Handler Thread ID is 9132 2024-04-12T17:04:07.526Z,1712941447.526 [controlThread](DEBUG): Initializing ControlThread 2024-04-12T17:04:07.527Z,1712941447.527 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-04-12T17:04:07.529Z,1712941447.529 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-04-12T17:04:07.530Z,1712941447.530 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-04-12T17:04:07.530Z,1712941447.530 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-04-12T17:04:07.530Z,1712941447.530 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-04-12T17:04:07.531Z,1712941447.531 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-04-12T17:04:07.531Z,1712941447.531 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-04-12T17:04:07.531Z,1712941447.531 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-04-12T17:04:07.532Z,1712941447.532 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-04-12T17:04:07.537Z,1712941447.537 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-04-12T17:04:07.538Z,1712941447.538 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-04-12T17:04:07.538Z,1712941447.538 [SBIT](INFO): Initialize SBIT Component. 2024-04-12T17:04:07.538Z,1712941447.538 [SBIT](IMPORTANT): git: 2024-04-11 2024-04-12T17:04:07.539Z,1712941447.539 [SBIT](INFO): git hash: 8b14ac3cbe1df2c95d6505c0066306c41245f1d7 2024-04-12T17:04:07.539Z,1712941447.539 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-04-12T17:04:07.540Z,1712941447.540 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-04-12T17:04:07.541Z,1712941447.541 [SBIT](INFO): Beginning SBIT in 99.000000 seconds. 2024-04-12T17:04:07.542Z,1712941447.542 [IBIT](INFO): Initialize IBIT Component. 2024-04-12T17:04:07.543Z,1712941447.543 [CBIT](DEBUG): Initialize CBIT Component. 2024-04-12T17:04:07.544Z,1712941447.544 [logger ThreadHandler](INFO): Handler Thread ID is 9133 2024-04-12T17:04:07.556Z,1712941447.556 [CBIT](DEBUG): Initialized mux pins. 2024-04-12T17:04:07.556Z,1712941447.556 [CBIT](DEBUG): Initializing the watchdog timer. 2024-04-12T17:04:07.561Z,1712941447.561 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 9134 2024-04-12T17:04:07.569Z,1712941447.569 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9135 2024-04-12T17:04:07.570Z,1712941447.570 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-04-12T17:04:07.577Z,1712941447.577 [Onboard ThreadHandler](INFO): Handler Thread ID is 9136 2024-04-12T17:04:07.581Z,1712941447.581 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-04-12T17:04:07.581Z,1712941447.581 [CBIT](DEBUG): Initializing heartbeat. 2024-04-12T17:04:07.612Z,1712941447.612 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9137 2024-04-12T17:04:07.613Z,1712941447.613 [DAT ThreadHandler](INFO): Handler Thread ID is 9138 2024-04-12T17:04:07.614Z,1712941447.614 [DAT](INFO): Powering up 2024-04-12T17:04:07.614Z,1712941447.614 [DAT](DEBUG): Initializing DAT. 2024-04-12T17:04:07.618Z,1712941447.618 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9140 2024-04-12T17:04:07.618Z,1712941447.618 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-12T17:04:07.621Z,1712941447.621 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9142 2024-04-12T17:04:07.625Z,1712941447.625 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:04:07.626Z,1712941447.626 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 9144 2024-04-12T17:04:07.629Z,1712941447.629 [WetLabsUBAT](INFO): Powering up 2024-04-12T17:04:07.630Z,1712941447.630 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9146 2024-04-12T17:04:07.633Z,1712941447.633 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-04-12T17:04:07.634Z,1712941447.634 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-04-12T17:04:07.634Z,1712941447.634 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-04-12T17:04:07.634Z,1712941447.634 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-04-12T17:04:07.634Z,1712941447.634 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-04-12T17:04:07.634Z,1712941447.634 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-04-12T17:04:07.634Z,1712941447.634 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-04-12T17:04:07.635Z,1712941447.635 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-04-12T17:04:07.652Z,1712941447.652 [CBIT](DEBUG): Deactivating GF circuits. 2024-04-12T17:04:07.653Z,1712941447.653 [CBIT](DEBUG): Deactivating emergency mode. 2024-04-12T17:04:07.692Z,1712941447.692 [CBIT](DEBUG): Backplane powered. 2024-04-12T17:04:07.697Z,1712941447.697 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-04-12T17:04:07.698Z,1712941447.698 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Startup.tx 2024-04-12T17:04:07.727Z,1712941447.727 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-12T17:04:07.773Z,1712941447.773 [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 } } } 2024-04-12T17:04:07.774Z,1712941447.774 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-04-12T17:04:07.774Z,1712941447.774 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Default.tx 2024-04-12T17:04:07.862Z,1712941447.862 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-04-12T17:04:07.864Z,1712941447.864 [Default:A.Wait](DEBUG): Construct Wait. 2024-04-12T17:04:07.870Z,1712941447.870 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-12T17:04:07.891Z,1712941447.891 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-04-12T17:04:07.920Z,1712941447.920 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-04-12T17:04:07.957Z,1712941447.957 [Default:E.Execute](DEBUG): Construct Execute. 2024-04-12T17:04:07.960Z,1712941447.960 [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" } } 2024-04-12T17:04:07.965Z,1712941447.965 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-12T17:04:07.988Z,1712941447.988 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-12T17:04:08.016Z,1712941448.016 [Radio_Surface](INFO): Powering up 2024-04-12T17:04:08.054Z,1712941448.054 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993016 m 2024-04-12T17:04:08.055Z,1712941448.055 [Power24vConverter](INFO): Powering up. 2024-04-12T17:04:08.055Z,1712941448.055 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-04-12T17:04:08.059Z,1712941448.059 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-04-12T17:04:08.094Z,1712941448.094 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-04-12T17:04:08.100Z,1712941448.100 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-04-12T17:04:08.101Z,1712941448.101 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-04-12T17:04:08.117Z,1712941448.117 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-04-12T17:04:08.118Z,1712941448.118 [MassServo](DEBUG): Initializing EZServoServo. 2024-04-12T17:04:08.125Z,1712941448.125 [MassServo](DEBUG): Initializing MassServo. 2024-04-12T17:04:08.126Z,1712941448.126 [RudderServo](DEBUG): Initializing EZServoServo. 2024-04-12T17:04:08.132Z,1712941448.132 [RudderServo](DEBUG): Initializing RudderServo. 2024-04-12T17:04:08.133Z,1712941448.133 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-04-12T17:04:08.140Z,1712941448.140 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-04-12T17:04:12.916Z,1712941452.916 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-04-12T17:04:12.916Z,1712941452.916 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:04:13.144Z,1712941453.144 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:13.229Z,1712941453.229 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:04:13.416Z,1712941453.416 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:04:13.572Z,1712941453.572 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:13.984Z,1712941453.984 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:14.520Z,1712941454.520 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:14.608Z,1712941454.608 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:04:14.608Z,1712941454.608 [WetLabsBB2FL] No Fault, FailCount= 1 2024-04-12T17:04:14.630Z,1712941454.630 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:04:14.932Z,1712941454.932 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:15.372Z,1712941455.372 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:15.800Z,1712941455.800 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:16.204Z,1712941456.204 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:16.648Z,1712941456.648 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:17.088Z,1712941457.088 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:17.500Z,1712941457.500 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:17.573Z,1712941457.573 [CBIT](CRITICAL): Environmental Failure. Press:14.339661 PSI. Humidity:36%. Temp:25 C. ABORTING MISSION 2024-04-12T17:04:17.573Z,1712941457.573 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2024-04-12T17:04:17.940Z,1712941457.940 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:18.026Z,1712941458.026 [CommandExec](FAULT): Scheduling is paused 2024-04-12T17:04:18.027Z,1712941458.027 [CBIT](INFO): Critical error at 20240412T170417 2024-04-12T17:04:18.380Z,1712941458.380 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:18.764Z,1712941458.764 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:19.168Z,1712941459.168 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:19.572Z,1712941459.572 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:19.924Z,1712941459.924 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-04-12T17:04:19.924Z,1712941459.924 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:04:19.976Z,1712941459.976 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:20.041Z,1712941460.041 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:04:20.384Z,1712941460.384 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:20.424Z,1712941460.424 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:04:20.555Z,1712941460.555 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004817 2024-04-12T17:04:20.672Z,1712941460.672 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-04-12T17:04:20.672Z,1712941460.672 [CTD_Seabird] Communications Fault, FailCount= 1 2024-04-12T17:04:20.673Z,1712941460.673 [CTD_Seabird](ERROR): Communications Fault 2024-04-12T17:04:20.784Z,1712941460.784 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:20.885Z,1712941460.885 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-04-12T17:04:21.077Z,1712941461.077 [CTD_Seabird](INFO): Powering down 2024-04-12T17:04:21.236Z,1712941461.236 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:21.236Z,1712941461.236 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-04-12T17:04:21.236Z,1712941461.236 [AHRS_M2] Communications Fault, FailCount= 1 2024-04-12T17:04:21.236Z,1712941461.236 [AHRS_M2](ERROR): Communications Fault 2024-04-12T17:04:21.329Z,1712941461.329 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-04-12T17:04:21.329Z,1712941461.329 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:04:21.329Z,1712941461.329 [WetLabsBB2FL] No Fault, FailCount= 2 2024-04-12T17:04:21.345Z,1712941461.345 [AHRS_M2](INFO): Powering down 2024-04-12T17:04:21.638Z,1712941461.638 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:04:22.201Z,1712941462.201 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-04-12T17:04:22.201Z,1712941462.201 [AHRS_M2] No Fault, FailCount= 1 2024-04-12T17:04:22.201Z,1712941462.201 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-04-12T17:04:22.201Z,1712941462.201 [CTD_Seabird] No Fault, FailCount= 1 2024-04-12T17:04:22.420Z,1712941462.420 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-12T17:04:22.546Z,1712941462.546 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-12T17:04:26.104Z,1712941466.104 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:26.528Z,1712941466.528 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:26.932Z,1712941466.932 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:26.944Z,1712941466.944 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-04-12T17:04:26.944Z,1712941466.944 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:04:27.000Z,1712941467.000 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:04:27.332Z,1712941467.332 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:27.444Z,1712941467.444 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:04:27.748Z,1712941467.748 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:28.172Z,1712941468.172 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:28.273Z,1712941468.273 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:04:28.273Z,1712941468.273 [WetLabsBB2FL] No Fault, FailCount= 3 2024-04-12T17:04:28.620Z,1712941468.620 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:28.669Z,1712941468.669 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:04:29.048Z,1712941469.048 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:29.512Z,1712941469.512 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:29.952Z,1712941469.952 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:30.376Z,1712941470.376 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:30.788Z,1712941470.788 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:30.794Z,1712941470.794 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2024-04-12T17:04:30.794Z,1712941470.794 [RDI_Pathfinder] Communications Fault, FailCount= 1 2024-04-12T17:04:30.794Z,1712941470.794 [RDI_Pathfinder](ERROR): Communications Fault 2024-04-12T17:04:30.855Z,1712941470.855 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2024-04-12T17:04:31.204Z,1712941471.204 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:31.276Z,1712941471.276 [RDI_Pathfinder](INFO): Powering down 2024-04-12T17:04:31.668Z,1712941471.668 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:32.072Z,1712941472.072 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:32.140Z,1712941472.140 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2024-04-12T17:04:32.140Z,1712941472.140 [RDI_Pathfinder] No Fault, FailCount= 1 2024-04-12T17:04:32.477Z,1712941472.477 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:32.480Z,1712941472.480 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-04-12T17:04:32.908Z,1712941472.908 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:33.317Z,1712941473.317 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:33.728Z,1712941473.728 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:33.948Z,1712941473.948 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-04-12T17:04:33.948Z,1712941473.948 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:04:34.132Z,1712941474.132 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:34.211Z,1712941474.211 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:04:34.448Z,1712941474.448 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:04:34.540Z,1712941474.540 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:34.941Z,1712941474.941 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:35.364Z,1712941475.364 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:35.449Z,1712941475.449 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:04:35.449Z,1712941475.449 [WetLabsBB2FL] No Fault, FailCount= 4 2024-04-12T17:04:35.473Z,1712941475.473 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-04-12T17:04:35.473Z,1712941475.473 [CTD_Seabird] Communications Fault, FailCount= 2 2024-04-12T17:04:35.473Z,1712941475.473 [CTD_Seabird](ERROR): Communications Fault 2024-04-12T17:04:35.662Z,1712941475.662 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:04:35.784Z,1712941475.784 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:35.784Z,1712941475.784 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-04-12T17:04:35.784Z,1712941475.784 [AHRS_M2] Communications Fault, FailCount= 2 2024-04-12T17:04:35.784Z,1712941475.784 [AHRS_M2](ERROR): Communications Fault 2024-04-12T17:04:35.872Z,1712941475.872 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-04-12T17:04:35.873Z,1712941475.873 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-04-12T17:04:35.876Z,1712941475.876 [CTD_Seabird](INFO): Powering down 2024-04-12T17:04:35.882Z,1712941475.882 [AHRS_M2](INFO): Powering down 2024-04-12T17:04:36.289Z,1712941476.289 [NAL9602](INFO): Powering up NAL9602 2024-04-12T17:04:36.755Z,1712941476.755 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-04-12T17:04:36.755Z,1712941476.755 [AHRS_M2] No Fault, FailCount= 2 2024-04-12T17:04:37.090Z,1712941477.090 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-12T17:04:37.181Z,1712941477.181 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-04-12T17:04:37.181Z,1712941477.181 [CTD_Seabird] No Fault, FailCount= 2 2024-04-12T17:04:37.220Z,1712941477.220 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-12T17:04:37.788Z,1712941477.788 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout upon startup. 2024-04-12T17:04:37.788Z,1712941477.788 [WetLabsUBAT] Communications Fault, FailCount= 1 2024-04-12T17:04:37.788Z,1712941477.788 [WetLabsUBAT](ERROR): Communications Fault 2024-04-12T17:04:37.949Z,1712941477.949 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2024-04-12T17:04:38.288Z,1712941478.288 [WetLabsUBAT](INFO): Powering down 2024-04-12T17:04:39.241Z,1712941479.241 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2024-04-12T17:04:39.241Z,1712941479.241 [WetLabsUBAT] No Fault, FailCount= 1 2024-04-12T17:04:39.502Z,1712941479.502 [WetLabsUBAT](INFO): Powering up 2024-04-12T17:04:40.648Z,1712941480.648 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:40.952Z,1712941480.952 [WetLabsBB2FL] Communications Fault, FailCount= 5 2024-04-12T17:04:40.952Z,1712941480.952 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:04:41.068Z,1712941481.068 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:41.177Z,1712941481.177 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:04:41.177Z,1712941481.177 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:04:41.448Z,1712941481.448 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:04:41.540Z,1712941481.540 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:42.016Z,1712941482.016 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:42.460Z,1712941482.460 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:42.767Z,1712941482.767 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-12T17:04:42.779Z,1712941482.779 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread. 2024-04-12T17:04:42.908Z,1712941482.908 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:43.016Z,1712941483.016 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-12T17:04:43.352Z,1712941483.352 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:43.796Z,1712941483.796 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:44.228Z,1712941484.228 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:44.668Z,1712941484.668 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:45.128Z,1712941485.128 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:45.592Z,1712941485.592 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:46.028Z,1712941486.028 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:46.536Z,1712941486.536 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:46.940Z,1712941486.940 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:47.412Z,1712941487.412 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:47.418Z,1712941487.418 [NAL9602](INFO): NAL9602 initialized 2024-04-12T17:04:47.876Z,1712941487.876 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:48.352Z,1712941488.352 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:48.510Z,1712941488.510 [CommandExec](IMPORTANT): got command get VerticalControl.massPositionLimitFwd millimeter 2024-04-12T17:04:48.510Z,1712941488.510 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitFwd 40.000000 mm 2024-04-12T17:04:48.788Z,1712941488.788 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:49.272Z,1712941489.272 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:49.752Z,1712941489.752 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:50.192Z,1712941490.192 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:50.192Z,1712941490.192 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-04-12T17:04:50.192Z,1712941490.192 [AHRS_M2] Communications Fault, FailCount= 3 2024-04-12T17:04:50.192Z,1712941490.192 [AHRS_M2](ERROR): Communications Fault 2024-04-12T17:04:50.272Z,1712941490.272 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-04-12T17:04:50.272Z,1712941490.272 [CTD_Seabird] Communications Fault, FailCount= 3 2024-04-12T17:04:50.272Z,1712941490.272 [CTD_Seabird](ERROR): Communications Fault 2024-04-12T17:04:50.337Z,1712941490.337 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-04-12T17:04:50.337Z,1712941490.337 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-04-12T17:04:50.337Z,1712941490.337 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2024-04-12T17:04:50.356Z,1712941490.356 [AHRS_M2](INFO): Powering down 2024-04-12T17:04:50.676Z,1712941490.676 [CTD_Seabird](INFO): Powering down 2024-04-12T17:04:51.265Z,1712941491.265 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-04-12T17:04:51.265Z,1712941491.265 [AHRS_M2] No Fault, FailCount= 3 2024-04-12T17:04:51.554Z,1712941491.554 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-12T17:04:55.112Z,1712941495.112 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:55.134Z,1712941495.134 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2024-04-12T17:04:55.134Z,1712941495.134 [RDI_Pathfinder] Communications Fault, FailCount= 2 2024-04-12T17:04:55.134Z,1712941495.134 [RDI_Pathfinder](ERROR): Communications Fault 2024-04-12T17:04:55.269Z,1712941495.269 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2024-04-12T17:04:55.604Z,1712941495.604 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:55.688Z,1712941495.688 [RDI_Pathfinder](INFO): Powering down 2024-04-12T17:04:56.152Z,1712941496.152 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:56.644Z,1712941496.644 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:56.780Z,1712941496.780 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2024-04-12T17:04:56.781Z,1712941496.781 [RDI_Pathfinder] No Fault, FailCount= 2 2024-04-12T17:04:57.108Z,1712941497.108 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:57.114Z,1712941497.114 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-04-12T17:04:57.600Z,1712941497.600 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:58.096Z,1712941498.096 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:58.572Z,1712941498.572 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:59.004Z,1712941499.004 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:59.484Z,1712941499.484 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:04:59.976Z,1712941499.976 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:00.444Z,1712941500.444 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:00.731Z,1712941500.731 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 40 millimeter 2024-04-12T17:05:00.735Z,1712941500.735 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2024-04-12T17:05:00.908Z,1712941500.908 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:01.063Z,1712941501.063 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-12T17:05:01.384Z,1712941501.384 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:01.860Z,1712941501.860 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:02.328Z,1712941502.328 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:02.812Z,1712941502.812 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:03.264Z,1712941503.264 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:03.744Z,1712941503.744 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:03.919Z,1712941503.919 [CommandExec](IMPORTANT): got command get VerticalControl.massPositionLimitAft millimeter 2024-04-12T17:05:03.919Z,1712941503.919 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitAft -25.000000 mm 2024-04-12T17:05:04.196Z,1712941504.196 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:04.632Z,1712941504.632 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:04.632Z,1712941504.632 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-04-12T17:05:04.632Z,1712941504.632 [AHRS_M2] Communications Fault, FailCount= 4 2024-04-12T17:05:04.632Z,1712941504.632 [AHRS_M2](ERROR): Communications Fault 2024-04-12T17:05:04.745Z,1712941504.745 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-04-12T17:05:04.752Z,1712941504.752 [AHRS_M2](INFO): Powering down 2024-04-12T17:05:05.700Z,1712941505.700 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-04-12T17:05:05.701Z,1712941505.701 [AHRS_M2] No Fault, FailCount= 4 2024-04-12T17:05:05.962Z,1712941505.962 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-12T17:05:07.849Z,1712941507.849 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-04-12T17:05:07.849Z,1712941507.849 [DAT] Communications Fault, FailCount= 1 2024-04-12T17:05:07.849Z,1712941507.849 [DAT](ERROR): Communications Fault 2024-04-12T17:05:08.093Z,1712941508.093 [CBIT](ERROR): Communications Fault in component: DAT 2024-04-12T17:05:08.252Z,1712941508.252 [DAT](INFO): Powering down 2024-04-12T17:05:09.521Z,1712941509.521 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:09.626Z,1712941509.626 [CBIT](INFO): Clearing failed state for component DAT 2024-04-12T17:05:09.626Z,1712941509.626 [DAT] No Fault, FailCount= 1 2024-04-12T17:05:09.668Z,1712941509.668 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout upon startup. 2024-04-12T17:05:09.668Z,1712941509.668 [WetLabsUBAT] Communications Fault, FailCount= 2 2024-04-12T17:05:09.668Z,1712941509.668 [WetLabsUBAT](ERROR): Communications Fault 2024-04-12T17:05:09.956Z,1712941509.956 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:10.042Z,1712941510.042 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2024-04-12T17:05:10.168Z,1712941510.168 [WetLabsUBAT](INFO): Powering down 2024-04-12T17:05:10.372Z,1712941510.372 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:10.792Z,1712941510.792 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:11.244Z,1712941511.244 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:11.342Z,1712941511.342 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2024-04-12T17:05:11.342Z,1712941511.342 [WetLabsUBAT] No Fault, FailCount= 2 2024-04-12T17:05:11.382Z,1712941511.382 [WetLabsUBAT](INFO): Powering up 2024-04-12T17:05:11.452Z,1712941511.452 [DAT](INFO): Powering up 2024-04-12T17:05:11.453Z,1712941511.453 [DAT](DEBUG): Initializing DAT. 2024-04-12T17:05:11.668Z,1712941511.668 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:12.128Z,1712941512.128 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:12.604Z,1712941512.604 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:13.064Z,1712941513.064 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:13.496Z,1712941513.496 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:13.908Z,1712941513.908 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:14.344Z,1712941514.344 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:14.776Z,1712941514.776 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:15.204Z,1712941515.204 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:15.632Z,1712941515.632 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:16.048Z,1712941516.048 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:16.493Z,1712941516.493 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:16.928Z,1712941516.928 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:17.372Z,1712941517.372 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:17.804Z,1712941517.804 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:18.228Z,1712941518.228 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:18.652Z,1712941518.652 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:19.068Z,1712941519.068 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:05:19.068Z,1712941519.068 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-04-12T17:05:19.068Z,1712941519.068 [AHRS_M2] Communications Fault, FailCount= 5 2024-04-12T17:05:19.068Z,1712941519.068 [AHRS_M2](ERROR): Communications Fault 2024-04-12T17:05:19.161Z,1712941519.161 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-04-12T17:05:19.161Z,1712941519.161 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2024-04-12T17:05:19.170Z,1712941519.170 [AHRS_M2](INFO): Powering down 2024-04-12T17:05:19.326Z,1712941519.326 [CBIT](INFO): Critical error at 20240412T170519 2024-04-12T17:05:19.582Z,1712941519.582 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2024-04-12T17:05:19.582Z,1712941519.582 [RDI_Pathfinder] Communications Fault, FailCount= 3 2024-04-12T17:05:19.583Z,1712941519.583 [RDI_Pathfinder](ERROR): Communications Fault 2024-04-12T17:05:19.665Z,1712941519.665 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2024-04-12T17:05:19.665Z,1712941519.665 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder 2024-04-12T17:05:20.048Z,1712941520.048 [RDI_Pathfinder](INFO): Powering down 2024-04-12T17:05:20.131Z,1712941520.131 [CBIT](INFO): Critical error at 20240412T170519 2024-04-12T17:05:36.539Z,1712941536.539 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:05:41.511Z,1712941541.511 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout upon startup. 2024-04-12T17:05:41.511Z,1712941541.511 [WetLabsUBAT] Communications Fault, FailCount= 3 2024-04-12T17:05:41.511Z,1712941541.511 [WetLabsUBAT](ERROR): Communications Fault 2024-04-12T17:05:41.865Z,1712941541.865 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2024-04-12T17:05:42.012Z,1712941542.012 [WetLabsUBAT](INFO): Powering down 2024-04-12T17:05:43.117Z,1712941543.117 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2024-04-12T17:05:43.117Z,1712941543.117 [WetLabsUBAT] No Fault, FailCount= 3 2024-04-12T17:05:43.225Z,1712941543.225 [WetLabsUBAT](INFO): Powering up 2024-04-12T17:05:47.122Z,1712941547.122 [SBIT](IMPORTANT): Beginning Startup BIT 2024-04-12T17:05:47.126Z,1712941547.126 [CBIT](IMPORTANT): Beginning ground fault scan 2024-04-12T17:05:52.698Z,1712941552.698 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:05:58.060Z,1712941558.060 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.027194 CHAN A1 (24V): 0.000186 CHAN A2 (12V): -0.007607 CHAN A3 (5V): -0.002458 CHAN B0 (3.3V): -0.000278 CHAN B1 (3.15aV): -0.000510 CHAN B2 (3.15bV): 0.000454 CHAN B3 (GND): 0.001782 OPEN: -0.000620 Full Scale: +/- 1 mA 2024-04-12T17:06:00.430Z,1712941560.430 [SBIT](FAULT): Mass: EXPECTED:-0.011999 ACTUAL:0.028445 2024-04-12T17:06:07.657Z,1712941567.657 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-04-12T17:06:07.657Z,1712941567.657 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-04-12T17:06:07.657Z,1712941567.657 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-12T17:06:07.805Z,1712941567.805 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-12T17:06:08.357Z,1712941568.357 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-12T17:06:08.357Z,1712941568.357 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-04-12T17:06:09.669Z,1712941569.669 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:06:11.473Z,1712941571.473 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-04-12T17:06:11.473Z,1712941571.473 [DAT] Communications Fault, FailCount= 2 2024-04-12T17:06:11.473Z,1712941571.473 [DAT](ERROR): Communications Fault 2024-04-12T17:06:11.741Z,1712941571.741 [CBIT](ERROR): Communications Fault in component: DAT 2024-04-12T17:06:11.876Z,1712941571.876 [DAT](INFO): Powering down 2024-04-12T17:06:12.963Z,1712941572.963 [CBIT](INFO): Clearing failed state for component DAT 2024-04-12T17:06:12.963Z,1712941572.963 [DAT] No Fault, FailCount= 2 2024-04-12T17:06:13.320Z,1712941573.320 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout upon startup. 2024-04-12T17:06:13.320Z,1712941573.320 [WetLabsUBAT] Communications Fault, FailCount= 4 2024-04-12T17:06:13.320Z,1712941573.320 [WetLabsUBAT](ERROR): Communications Fault 2024-04-12T17:06:13.390Z,1712941573.390 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2024-04-12T17:06:13.820Z,1712941573.820 [WetLabsUBAT](INFO): Powering down 2024-04-12T17:06:14.181Z,1712941574.181 [MassServo](FAULT): Reading outside of valid range:427054.000000 2024-04-12T17:06:14.926Z,1712941574.926 [DAT](INFO): Powering up 2024-04-12T17:06:14.926Z,1712941574.926 [DAT](DEBUG): Initializing DAT. 2024-04-12T17:06:15.001Z,1712941575.001 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2024-04-12T17:06:15.001Z,1712941575.001 [WetLabsUBAT] No Fault, FailCount= 4 2024-04-12T17:06:15.034Z,1712941575.034 [WetLabsUBAT](INFO): Powering up 2024-04-12T17:06:27.158Z,1712941587.158 [SBIT](FAULT): Mass: EXPECTED:-0.023571 ACTUAL:0.039172 2024-04-12T17:06:27.159Z,1712941587.159 [SBIT](FAULT): Control surface position failure. 2024-04-12T17:06:27.442Z,1712941587.442 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:06:40.870Z,1712941600.870 [SBIT](FAULT): Mass: EXPECTED:-0.019999 ACTUAL:0.039172 2024-04-12T17:06:40.870Z,1712941600.870 [SBIT](FAULT): Control surface position failure. 2024-04-12T17:06:41.253Z,1712941601.253 [SBIT](CRITICAL): SBIT FAILED 2024-04-12T17:06:41.254Z,1712941601.254 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-04-12T17:06:41.255Z,1712941601.255 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count; 2024-04-12T17:06:41.255Z,1712941601.255 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-04-12T17:06:41.255Z,1712941601.255 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second; 2024-04-12T17:06:41.255Z,1712941601.255 [SBIT](IMPORTANT): Express linearApproximation downwelling_photosynthetic_photon_flux_in_sea_water 100.000000 micromole_per_second_per_square_meter; 2024-04-12T17:06:41.255Z,1712941601.255 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=0 bool; 2024-04-12T17:06:41.255Z,1712941601.255 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=700 cubic_centimeter; 2024-04-12T17:06:41.255Z,1712941601.255 [SBIT](IMPORTANT): VerticalControl.kpDepth=0.09 radian_per_meter; 2024-04-12T17:06:41.255Z,1712941601.255 [SBIT](IMPORTANT): VerticalControl.kpPitchElevator=0.5 none; 2024-04-12T17:06:41.256Z,1712941601.256 [SBIT](IMPORTANT): VerticalControl.massDefault=-19.999430 millimeter; 2024-04-12T17:06:41.256Z,1712941601.256 [SBIT](IMPORTANT): VerticalControl.stopDepthExcursion=20 meter; 2024-04-12T17:06:41.258Z,1712941601.258 [CBIT](INFO): Critical error at 20240412T170641 2024-04-12T17:06:41.603Z,1712941601.603 [MissionManager](IMPORTANT): Started mission Startup 2024-04-12T17:06:41.603Z,1712941601.603 [Startup] Running Loop=1 2024-04-12T17:06:41.603Z,1712941601.603 [Startup](DEBUG): Aggregate::initialize Startup 2024-04-12T17:06:41.603Z,1712941601.603 [Startup:A.GoToSurface] Running Loop=1 2024-04-12T17:06:41.603Z,1712941601.603 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-12T17:06:41.604Z,1712941601.604 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-12T17:06:41.605Z,1712941601.605 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-12T17:06:41.605Z,1712941601.605 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-12T17:06:41.606Z,1712941601.606 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-12T17:06:41.606Z,1712941601.606 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-12T17:06:41.607Z,1712941601.607 [Startup:StartupSatComms] Running Loop=1 2024-04-12T17:06:41.608Z,1712941601.608 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-04-12T17:06:41.608Z,1712941601.608 [Startup:StartupSatComms:A] Running Loop=1 2024-04-12T17:06:42.002Z,1712941602.002 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-04-12T17:06:44.410Z,1712941604.410 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:06:45.140Z,1712941605.140 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout upon startup. 2024-04-12T17:06:45.140Z,1712941605.140 [WetLabsUBAT] Communications Fault, FailCount= 5 2024-04-12T17:06:45.140Z,1712941605.140 [WetLabsUBAT](ERROR): Communications Fault 2024-04-12T17:06:45.333Z,1712941605.333 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2024-04-12T17:06:45.333Z,1712941605.333 [CBIT](CRITICAL): Communications Fault in component: WetLabsUBAT 2024-04-12T17:06:45.640Z,1712941605.640 [WetLabsUBAT](INFO): Powering down 2024-04-12T17:06:45.723Z,1712941605.723 [CBIT](INFO): Critical error at 20240412T170645 2024-04-12T17:06:56.413Z,1712941616.413 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -25 millimeter 2024-04-12T17:07:01.782Z,1712941621.782 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:07:11.180Z,1712941631.180 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:07:11.180Z,1712941631.180 [WetLabsBB2FL] No Fault, FailCount= 5 2024-04-12T17:07:11.358Z,1712941631.358 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:07:14.949Z,1712941634.949 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-04-12T17:07:14.949Z,1712941634.949 [DAT] Communications Fault, FailCount= 3 2024-04-12T17:07:14.949Z,1712941634.949 [DAT](ERROR): Communications Fault 2024-04-12T17:07:15.177Z,1712941635.177 [CBIT](ERROR): Communications Fault in component: DAT 2024-04-12T17:07:15.352Z,1712941635.352 [DAT](INFO): Powering down 2024-04-12T17:07:16.397Z,1712941636.397 [CBIT](INFO): Clearing failed state for component DAT 2024-04-12T17:07:16.397Z,1712941636.397 [DAT] No Fault, FailCount= 3 2024-04-12T17:07:16.660Z,1712941636.660 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-04-12T17:07:16.660Z,1712941636.660 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:07:16.818Z,1712941636.818 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:07:17.160Z,1712941637.160 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:07:17.993Z,1712941637.993 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:07:17.993Z,1712941637.993 [WetLabsBB2FL] No Fault, FailCount= 1 2024-04-12T17:07:18.374Z,1712941638.374 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:07:18.400Z,1712941638.400 [DAT](INFO): Powering up 2024-04-12T17:07:18.400Z,1712941638.400 [DAT](DEBUG): Initializing DAT. 2024-04-12T17:07:19.154Z,1712941639.154 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:07:20.422Z,1712941640.422 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-04-12T17:07:20.422Z,1712941640.422 [CTD_Seabird] No Fault, FailCount= 3 2024-04-12T17:07:20.696Z,1712941640.696 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-12T17:07:23.664Z,1712941643.664 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-04-12T17:07:23.664Z,1712941643.664 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:07:23.713Z,1712941643.713 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:07:24.164Z,1712941644.164 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:07:25.270Z,1712941645.270 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:07:25.270Z,1712941645.270 [WetLabsBB2FL] No Fault, FailCount= 2 2024-04-12T17:07:25.378Z,1712941645.378 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:07:30.672Z,1712941650.672 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-04-12T17:07:30.672Z,1712941650.672 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:07:30.921Z,1712941650.921 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:07:31.172Z,1712941651.172 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:07:32.165Z,1712941652.165 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:07:32.165Z,1712941652.165 [WetLabsBB2FL] No Fault, FailCount= 3 2024-04-12T17:07:32.387Z,1712941652.387 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:07:33.752Z,1712941653.752 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-04-12T17:07:33.752Z,1712941653.752 [CTD_Seabird] Communications Fault, FailCount= 1 2024-04-12T17:07:33.752Z,1712941653.752 [CTD_Seabird](ERROR): Communications Fault 2024-04-12T17:07:33.768Z,1712941653.768 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-04-12T17:07:34.172Z,1712941654.172 [CTD_Seabird](INFO): Powering down 2024-04-12T17:07:35.369Z,1712941655.369 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-04-12T17:07:35.369Z,1712941655.369 [CTD_Seabird] No Fault, FailCount= 1 2024-04-12T17:07:35.516Z,1712941655.516 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-12T17:07:36.123Z,1712941656.123 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:07:37.684Z,1712941657.684 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-04-12T17:07:37.684Z,1712941657.684 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:07:37.849Z,1712941657.849 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:07:38.184Z,1712941658.184 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:07:39.020Z,1712941659.020 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:07:39.020Z,1712941659.020 [WetLabsBB2FL] No Fault, FailCount= 4 2024-04-12T17:07:39.398Z,1712941659.398 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:07:41.792Z,1712941661.792 [Startup:StartupSatComms:A](INFO): Timed out from 2024-04-12T17:06:41.6Z 2024-04-12T17:07:41.792Z,1712941661.792 [Startup:StartupSatComms:A] Stopped 2024-04-12T17:07:41.792Z,1712941661.792 [Startup:StartupSatComms:B] Running Loop=1 2024-04-12T17:07:42.214Z,1712941662.214 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-04-12T17:07:44.688Z,1712941664.688 [WetLabsBB2FL] Communications Fault, FailCount= 5 2024-04-12T17:07:44.688Z,1712941664.688 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:07:44.837Z,1712941664.837 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:07:44.838Z,1712941664.838 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:07:45.188Z,1712941665.188 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:07:46.728Z,1712941666.728 [DataOverHttps](INFO): Sending 128 bytes from file Logs/19991201T050413/Courier0010.lzma 2024-04-12T17:07:47.730Z,1712941667.730 [DataOverHttps](INFO): Moved sent file to Logs/19991201T050413/Courier0010.lzma.bak 2024-04-12T17:07:47.730Z,1712941667.730 [DataOverHttps](INFO): SBD MOMSN=19403365 2024-04-12T17:07:48.572Z,1712941668.572 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-04-12T17:07:48.572Z,1712941668.572 [CTD_Seabird] Communications Fault, FailCount= 2 2024-04-12T17:07:48.572Z,1712941668.572 [CTD_Seabird](ERROR): Communications Fault 2024-04-12T17:07:48.861Z,1712941668.861 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-04-12T17:07:48.976Z,1712941668.976 [CTD_Seabird](INFO): Powering down 2024-04-12T17:07:50.057Z,1712941670.057 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-04-12T17:07:50.057Z,1712941670.057 [CTD_Seabird] No Fault, FailCount= 2 2024-04-12T17:07:50.316Z,1712941670.316 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-12T17:07:53.239Z,1712941673.239 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-12T17:08:03.368Z,1712941683.368 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-04-12T17:08:03.368Z,1712941683.368 [CTD_Seabird] Communications Fault, FailCount= 3 2024-04-12T17:08:03.368Z,1712941683.368 [CTD_Seabird](ERROR): Communications Fault 2024-04-12T17:08:03.461Z,1712941683.461 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-04-12T17:08:03.461Z,1712941683.461 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2024-04-12T17:08:03.772Z,1712941683.772 [CTD_Seabird](INFO): Powering down 2024-04-12T17:08:04.725Z,1712941684.725 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree 2024-04-12T17:08:04.733Z,1712941684.733 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread. 2024-04-12T17:08:05.057Z,1712941685.057 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-12T17:08:06.349Z,1712941686.349 [DataOverHttps](INFO): Sending 442 bytes from file Logs/19991201T053447/Courier0000.lzma 2024-04-12T17:08:07.350Z,1712941687.350 [DataOverHttps](INFO): Moved sent file to Logs/19991201T053447/Courier0000.lzma.bak 2024-04-12T17:08:07.350Z,1712941687.350 [DataOverHttps](INFO): SBD MOMSN=19403372 2024-04-12T17:08:08.620Z,1712941688.620 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-04-12T17:08:08.620Z,1712941688.620 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-04-12T17:08:08.620Z,1712941688.620 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-12T17:08:08.721Z,1712941688.721 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-12T17:08:09.099Z,1712941689.099 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-12T17:08:09.099Z,1712941689.099 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-04-12T17:08:18.441Z,1712941698.441 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-04-12T17:08:18.441Z,1712941698.441 [DAT] Communications Fault, FailCount= 4 2024-04-12T17:08:18.441Z,1712941698.441 [DAT](ERROR): Communications Fault 2024-04-12T17:08:18.797Z,1712941698.797 [CBIT](ERROR): Communications Fault in component: DAT 2024-04-12T17:08:18.844Z,1712941698.844 [DAT](INFO): Powering down 2024-04-12T17:08:20.007Z,1712941700.007 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2024-04-12T17:08:20.007Z,1712941700.007 [RDI_Pathfinder] No Fault, FailCount= 3 2024-04-12T17:08:20.008Z,1712941700.008 [CBIT](INFO): Clearing failed state for component DAT 2024-04-12T17:08:20.008Z,1712941700.008 [DAT] No Fault, FailCount= 4 2024-04-12T17:08:20.329Z,1712941700.329 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-04-12T17:08:21.896Z,1712941701.896 [DAT](INFO): Powering up 2024-04-12T17:08:21.896Z,1712941701.896 [DAT](DEBUG): Initializing DAT. 2024-04-12T17:08:24.590Z,1712941704.590 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree 2024-04-12T17:08:26.885Z,1712941706.885 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2024-04-12T17:08:26.889Z,1712941706.889 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread. 2024-04-12T17:08:27.258Z,1712941707.258 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,Maintain_VerticalControl.elevatorAngleAction,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-12T17:08:27.480Z,1712941707.480 [DataOverHttps](INFO): Sending 39 bytes from file Logs/19991201T053447/Courier0004.lzma 2024-04-12T17:08:28.482Z,1712941708.482 [DataOverHttps](INFO): Moved sent file to Logs/19991201T053447/Courier0004.lzma.bak 2024-04-12T17:08:28.482Z,1712941708.482 [DataOverHttps](INFO): SBD MOMSN=19403384 2024-04-12T17:08:31.620Z,1712941711.620 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-12T17:08:32.834Z,1712941712.834 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout. 2024-04-12T17:08:32.834Z,1712941712.834 [RDI_Pathfinder] Data Fault, FailCount= 1 2024-04-12T17:08:32.834Z,1712941712.834 [RDI_Pathfinder](ERROR): Data Fault 2024-04-12T17:08:32.934Z,1712941712.934 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder 2024-04-12T17:08:33.316Z,1712941713.316 [RDI_Pathfinder](INFO): Powering down 2024-04-12T17:08:34.098Z,1712941714.098 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2024-04-12T17:08:34.098Z,1712941714.098 [RDI_Pathfinder] No Fault, FailCount= 1 2024-04-12T17:08:34.450Z,1712941714.450 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-04-12T17:08:41.796Z,1712941721.796 [Startup:StartupSatComms:B](INFO): Timed out from 2024-04-12T17:07:41.8Z 2024-04-12T17:08:41.796Z,1712941721.796 [Startup:StartupSatComms:B] Stopped 2024-04-12T17:08:41.796Z,1712941721.796 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-04-12T17:08:41.796Z,1712941721.796 [Startup:StartupSatComms] Stopped 2024-04-12T17:08:41.796Z,1712941721.796 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-04-12T17:08:41.797Z,1712941721.797 [Startup](INFO): Completed Startup 2024-04-12T17:08:41.798Z,1712941721.798 [MissionManager](INFO): Startup is completed. 2024-04-12T17:08:41.798Z,1712941721.798 [MissionManager](INFO): Uninitializing Mission Startup 2024-04-12T17:08:41.798Z,1712941721.798 [Startup] Stopped 2024-04-12T17:08:41.798Z,1712941721.798 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-04-12T17:08:41.798Z,1712941721.798 [Startup:A.GoToSurface] Stopped 2024-04-12T17:08:41.798Z,1712941721.798 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-12T17:08:42.165Z,1712941722.165 [MissionManager](IMPORTANT): Started mission Default 2024-04-12T17:08:42.165Z,1712941722.165 [Default] Running Loop=1 2024-04-12T17:08:42.165Z,1712941722.165 [Default](DEBUG): Aggregate::initialize Default 2024-04-12T17:08:42.165Z,1712941722.165 [Default:B.GoToSurface] Running Loop=1 2024-04-12T17:08:42.165Z,1712941722.165 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-12T17:08:42.166Z,1712941722.166 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-12T17:08:42.166Z,1712941722.166 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-12T17:08:42.166Z,1712941722.166 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-12T17:08:42.167Z,1712941722.167 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-12T17:08:42.167Z,1712941722.167 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-12T17:08:42.167Z,1712941722.167 [Default:A.Wait] Running Loop=1 2024-04-12T17:08:42.167Z,1712941722.167 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-04-12T17:08:43.433Z,1712941723.433 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2024-04-12T17:08:45.264Z,1712941725.264 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300 revolution_per_minute 2024-04-12T17:08:45.271Z,1712941725.271 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread. 2024-04-12T17:08:45.458Z,1712941725.458 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,Maintain_VerticalControl.elevatorAngleAction,Maintain_HorizontalControl.rudderAngleAction,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-12T17:08:46.970Z,1712941726.970 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-12T17:08:47.404Z,1712941727.404 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20240411T205131/Courier0000.lzma 2024-04-12T17:08:49.185Z,1712941729.185 [DataOverHttps](INFO): Moved sent file to Logs/20240411T205131/Courier0000.lzma.bak 2024-04-12T17:08:49.185Z,1712941729.185 [DataOverHttps](INFO): SBD MOMSN=19403390 2024-04-12T17:08:55.505Z,1712941735.505 [Default:A.Wait](INFO): Done Waiting. 2024-04-12T17:08:55.506Z,1712941735.506 [Default:A.Wait] Stopped 2024-04-12T17:08:55.506Z,1712941735.506 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-04-12T17:08:55.911Z,1712941735.911 [Default:CheckIn] Running Loop=1 2024-04-12T17:08:55.911Z,1712941735.911 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-12T17:08:55.911Z,1712941735.911 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-12T17:08:56.302Z,1712941736.302 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-04-12T17:08:56.682Z,1712941736.682 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2024-04-12T17:08:56.682Z,1712941736.682 [RDI_Pathfinder] Communications Fault, FailCount= 2 2024-04-12T17:08:56.682Z,1712941736.682 [RDI_Pathfinder](ERROR): Communications Fault 2024-04-12T17:08:56.741Z,1712941736.741 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2024-04-12T17:08:57.148Z,1712941737.148 [RDI_Pathfinder](INFO): Powering down 2024-04-12T17:08:57.928Z,1712941737.928 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2024-04-12T17:08:57.928Z,1712941737.928 [RDI_Pathfinder] No Fault, FailCount= 2 2024-04-12T17:08:58.287Z,1712941738.286 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-04-12T17:09:00.970Z,1712941740.970 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction -300 revolution_per_minute 2024-04-12T17:09:01.973Z,1712941741.973 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-04-12T17:09:03.636Z,1712941743.636 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 0 revolution_per_minute 2024-04-12T17:09:03.639Z,1712941743.639 [CommandExec](IMPORTANT): got command maintain clear 2024-04-12T17:09:03.663Z,1712941743.663 [CommandExec](IMPORTANT): got command report clear 2024-04-12T17:09:04.006Z,1712941744.006 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-12T17:09:16.939Z,1712941756.939 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-04-12T17:09:17.075Z,1712941757.075 [CommandExec](IMPORTANT): got command get depth 2024-04-12T17:09:17.075Z,1712941757.075 [CommandExec](IMPORTANT): depth -0.309903 m 2024-04-12T17:09:20.515Z,1712941760.515 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2024-04-12T17:09:20.515Z,1712941760.515 [RDI_Pathfinder] Communications Fault, FailCount= 3 2024-04-12T17:09:20.515Z,1712941760.515 [RDI_Pathfinder](ERROR): Communications Fault 2024-04-12T17:09:20.600Z,1712941760.600 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2024-04-12T17:09:20.609Z,1712941760.609 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder 2024-04-12T17:09:20.980Z,1712941760.980 [RDI_Pathfinder](INFO): Powering down 2024-04-12T17:09:21.062Z,1712941761.062 [CBIT](INFO): Critical error at 20240412T170920 2024-04-12T17:09:21.905Z,1712941761.905 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-04-12T17:09:21.905Z,1712941761.905 [DAT] Communications Fault, FailCount= 5 2024-04-12T17:09:21.905Z,1712941761.905 [DAT](ERROR): Communications Fault 2024-04-12T17:09:22.308Z,1712941762.308 [DAT](INFO): Powering down 2024-04-12T17:09:22.333Z,1712941762.333 [CBIT](ERROR): Communications Fault in component: DAT 2024-04-12T17:09:23.415Z,1712941763.415 [CBIT](INFO): Clearing failed state for component DAT 2024-04-12T17:09:23.415Z,1712941763.415 [DAT] No Fault, FailCount= 5 2024-04-12T17:09:24.212Z,1712941764.212 [CommandExec](IMPORTANT): got command report mod PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 2024-04-12T17:09:24.611Z,1712941764.611 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.862746 umol/s/m2 2024-04-12T17:09:25.003Z,1712941765.003 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.879253 umol/s/m2 2024-04-12T17:09:25.360Z,1712941765.360 [DAT](INFO): Powering up 2024-04-12T17:09:25.361Z,1712941765.361 [DAT](DEBUG): Initializing DAT. 2024-04-12T17:09:25.811Z,1712941765.811 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.882555 umol/s/m2 2024-04-12T17:09:26.207Z,1712941766.207 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.894110 umol/s/m2 2024-04-12T17:09:26.623Z,1712941766.623 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.841286 umol/s/m2 2024-04-12T17:09:27.043Z,1712941767.043 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.834683 umol/s/m2 2024-04-12T17:09:27.443Z,1712941767.443 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.875952 umol/s/m2 2024-04-12T17:09:27.938Z,1712941767.938 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.880904 umol/s/m2 2024-04-12T17:09:28.262Z,1712941768.262 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.872650 umol/s/m2 2024-04-12T17:09:28.639Z,1712941768.639 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.894110 umol/s/m2 2024-04-12T17:09:29.065Z,1712941769.065 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.908966 umol/s/m2 2024-04-12T17:09:29.309Z,1712941769.309 [CommandExec](IMPORTANT): got command report clear 2024-04-12T17:09:33.027Z,1712941773.027 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-12T17:09:48.783Z,1712941788.783 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-12T17:09:50.421Z,1712941790.421 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-04-12T17:10:04.538Z,1712941804.538 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-12T17:10:09.824Z,1712941809.824 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-04-12T17:10:09.824Z,1712941809.824 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-04-12T17:10:09.824Z,1712941809.824 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-12T17:10:09.873Z,1712941809.873 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-12T17:10:10.265Z,1712941810.265 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-12T17:10:10.265Z,1712941810.265 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-04-12T17:10:15.094Z,1712941815.094 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:10:15.094Z,1712941815.094 [WetLabsBB2FL] No Fault, FailCount= 5 2024-04-12T17:10:15.142Z,1712941815.142 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:10:16.670Z,1712941816.670 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-04-12T17:10:19.109Z,1712941819.109 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-04-12T17:10:19.109Z,1712941819.109 [AHRS_M2] No Fault, FailCount= 5 2024-04-12T17:10:19.486Z,1712941819.486 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-12T17:10:19.523Z,1712941819.523 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-04-12T17:10:20.444Z,1712941820.444 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-04-12T17:10:20.444Z,1712941820.444 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:10:20.754Z,1712941820.754 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:10:20.945Z,1712941820.945 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:10:21.948Z,1712941821.948 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:10:21.948Z,1712941821.948 [WetLabsBB2FL] No Fault, FailCount= 1 2024-04-12T17:10:22.158Z,1712941822.158 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:10:23.036Z,1712941823.036 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:23.448Z,1712941823.448 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:23.852Z,1712941823.852 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:24.256Z,1712941824.256 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:24.672Z,1712941824.672 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:25.064Z,1712941825.064 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:25.385Z,1712941825.385 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2024-04-12T17:10:25.385Z,1712941825.385 [DAT] Communications Fault, FailCount= 6 2024-04-12T17:10:25.385Z,1712941825.385 [DAT](ERROR): Communications Fault 2024-04-12T17:10:25.468Z,1712941825.468 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:25.498Z,1712941825.498 [CBIT](ERROR): Communications Fault in component: DAT 2024-04-12T17:10:25.789Z,1712941825.789 [DAT](INFO): Powering down 2024-04-12T17:10:25.876Z,1712941825.876 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:26.280Z,1712941826.280 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:26.684Z,1712941826.684 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:26.742Z,1712941826.742 [CBIT](INFO): Clearing failed state for component DAT 2024-04-12T17:10:26.742Z,1712941826.742 [DAT] No Fault, FailCount= 6 2024-04-12T17:10:27.096Z,1712941827.096 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:27.448Z,1712941827.448 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-04-12T17:10:27.448Z,1712941827.448 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:10:27.492Z,1712941827.492 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:27.528Z,1712941827.528 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:10:27.900Z,1712941827.900 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:27.948Z,1712941827.948 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:10:28.304Z,1712941828.304 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:28.692Z,1712941828.692 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:28.836Z,1712941828.836 [DAT](INFO): Powering up 2024-04-12T17:10:28.836Z,1712941828.836 [DAT](DEBUG): Initializing DAT. 2024-04-12T17:10:29.104Z,1712941829.104 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:29.142Z,1712941829.142 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:10:29.142Z,1712941829.142 [WetLabsBB2FL] No Fault, FailCount= 2 2024-04-12T17:10:29.162Z,1712941829.162 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:10:29.512Z,1712941829.512 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:29.924Z,1712941829.924 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:30.352Z,1712941830.352 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:30.764Z,1712941830.764 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:31.192Z,1712941831.192 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:31.560Z,1712941831.560 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:31.964Z,1712941831.964 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:32.372Z,1712941832.372 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:32.372Z,1712941832.372 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-04-12T17:10:32.372Z,1712941832.372 [AHRS_M2] Communications Fault, FailCount= 1 2024-04-12T17:10:32.372Z,1712941832.372 [AHRS_M2](ERROR): Communications Fault 2024-04-12T17:10:32.431Z,1712941832.431 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-04-12T17:10:32.454Z,1712941832.454 [AHRS_M2](INFO): Powering down 2024-04-12T17:10:33.292Z,1712941833.292 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-04-12T17:10:33.292Z,1712941833.292 [AHRS_M2] No Fault, FailCount= 1 2024-04-12T17:10:33.658Z,1712941833.658 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-12T17:10:33.685Z,1712941833.685 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-04-12T17:10:33.685Z,1712941833.685 [CTD_Seabird] No Fault, FailCount= 3 2024-04-12T17:10:33.804Z,1712941833.804 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-12T17:10:34.452Z,1712941834.452 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-04-12T17:10:34.452Z,1712941834.452 [WetLabsBB2FL](ERROR): Communications Fault 2024-04-12T17:10:34.511Z,1712941834.511 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-04-12T17:10:34.952Z,1712941834.952 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:10:35.275Z,1712941835.275 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-12T17:10:35.529Z,1712941835.529 [CommandExec](IMPORTANT): got command quit 2024-04-12T17:10:36.121Z,1712941836.121 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-04-12T17:10:36.121Z,1712941836.121 [WetLabsBB2FL] No Fault, FailCount= 3 2024-04-12T17:10:36.166Z,1712941836.166 [WetLabsBB2FL](INFO): Powering up 2024-04-12T17:10:36.532Z,1712941836.532 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:36.532Z,1712941836.532 [CommandExec](INFO): Uninitializing the command executive. 2024-04-12T17:10:36.532Z,1712941836.532 [CommandExec](INFO): Uninitializing the command scheduler. 2024-04-12T17:10:36.533Z,1712941836.533 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:36.612Z,1712941836.612 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-04-12T17:10:36.612Z,1712941836.612 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-04-12T17:10:36.612Z,1712941836.612 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:36.613Z,1712941836.613 [NavChartDb](INFO): Join timeout helper Thread ID is 9268 2024-04-12T17:10:36.632Z,1712941836.632 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:36.633Z,1712941836.633 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:36.652Z,1712941836.652 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-04-12T17:10:36.652Z,1712941836.652 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:36.653Z,1712941836.653 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 9269 2024-04-12T17:10:36.800Z,1712941836.800 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:36.800Z,1712941836.800 [WetLabsUBAT](INFO): Powering down 2024-04-12T17:10:36.801Z,1712941836.801 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:36.825Z,1712941836.825 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-04-12T17:10:36.825Z,1712941836.825 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:36.825Z,1712941836.825 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9270 2024-04-12T17:10:36.928Z,1712941836.928 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:37.024Z,1712941837.024 [WetLabsBB2FL](INFO): Powering down 2024-04-12T17:10:37.025Z,1712941837.025 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:37.032Z,1712941837.032 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-04-12T17:10:37.032Z,1712941837.032 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:37.033Z,1712941837.033 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9271 2024-04-12T17:10:37.208Z,1712941837.208 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:37.620Z,1712941837.620 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:37.820Z,1712941837.820 [CTD_Seabird](INFO): Powering down 2024-04-12T17:10:37.948Z,1712941837.948 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:37.948Z,1712941837.948 [CTD_Seabird](INFO): Powering down 2024-04-12T17:10:37.960Z,1712941837.960 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:37.961Z,1712941837.961 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-04-12T17:10:37.961Z,1712941837.961 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:37.961Z,1712941837.961 [DAT](INFO): Join timeout helper Thread ID is 9272 2024-04-12T17:10:38.024Z,1712941838.024 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:38.160Z,1712941838.160 [DAT](INFO): Powering down 2024-04-12T17:10:38.232Z,1712941838.232 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:38.233Z,1712941838.233 [DAT](INFO): Powering down 2024-04-12T17:10:38.234Z,1712941838.234 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:38.249Z,1712941838.249 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-04-12T17:10:38.249Z,1712941838.249 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:38.249Z,1712941838.249 [Radio_Surface](INFO): Join timeout helper Thread ID is 9273 2024-04-12T17:10:38.308Z,1712941838.308 [Radio_Surface](INFO): Powering down 2024-04-12T17:10:38.309Z,1712941838.309 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:38.309Z,1712941838.309 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:38.317Z,1712941838.317 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-04-12T17:10:38.317Z,1712941838.317 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:38.317Z,1712941838.317 [Onboard](INFO): Join timeout helper Thread ID is 9274 2024-04-12T17:10:38.444Z,1712941838.444 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:38.840Z,1712941838.840 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:39.248Z,1712941839.248 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:39.652Z,1712941839.652 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:40.064Z,1712941840.064 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:40.476Z,1712941840.476 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:40.896Z,1712941840.896 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:41.308Z,1712941841.308 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:41.696Z,1712941841.696 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:42.120Z,1712941842.120 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:42.532Z,1712941842.532 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:42.916Z,1712941842.916 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:42.916Z,1712941842.916 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:42.929Z,1712941842.929 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-04-12T17:10:42.929Z,1712941842.929 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:42.929Z,1712941842.929 [DataOverHttps](INFO): Join timeout helper Thread ID is 9275 2024-04-12T17:10:42.936Z,1712941842.936 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:43.296Z,1712941843.296 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:43.299Z,1712941843.299 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.313Z,1712941843.313 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-04-12T17:10:43.313Z,1712941843.313 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.313Z,1712941843.313 [BackseatComponent](INFO): Join timeout helper Thread ID is 9276 2024-04-12T17:10:43.336Z,1712941843.336 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:43.360Z,1712941843.360 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:43.361Z,1712941843.361 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.365Z,1712941843.365 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-04-12T17:10:43.365Z,1712941843.365 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.365Z,1712941843.365 [logger](INFO): Join timeout helper Thread ID is 9277 2024-04-12T17:10:43.372Z,1712941843.372 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:43.373Z,1712941843.373 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.377Z,1712941843.377 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-04-12T17:10:43.377Z,1712941843.377 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.377Z,1712941843.377 [CommandLine](INFO): Join timeout helper Thread ID is 9278 2024-04-12T17:10:43.440Z,1712941843.440 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:43.441Z,1712941843.441 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.461Z,1712941843.461 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-04-12T17:10:43.461Z,1712941843.461 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.461Z,1712941843.461 [CommandExec](INFO): Join timeout helper Thread ID is 9279 2024-04-12T17:10:43.462Z,1712941843.462 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-04-12T17:10:43.462Z,1712941843.462 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:43.463Z,1712941843.463 [controlThread](INFO): Join timeout helper Thread ID is 9280 2024-04-12T17:10:43.736Z,1712941843.736 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2024-04-12T17:10:43.837Z,1712941843.837 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-12T17:10:43.837Z,1712941843.837 [controlThread](DEBUG): Uninitializing ControlThread 2024-04-12T17:10:43.837Z,1712941843.837 [AHRS_M2](INFO): Powering down 2024-04-12T17:10:43.909Z,1712941843.909 [NAL9602](INFO): Powering down 2024-04-12T17:10:43.911Z,1712941843.911 [RDI_Pathfinder](INFO): Powering down 2024-04-12T17:10:43.912Z,1712941843.912 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-04-12T17:10:43.913Z,1712941843.913 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-04-12T17:10:43.913Z,1712941843.913 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-04-12T17:10:43.914Z,1712941843.914 [MissionManager](INFO): Uninitializing Mission Default 2024-04-12T17:10:43.914Z,1712941843.914 [Default] Stopped 2024-04-12T17:10:43.914Z,1712941843.914 [Default](DEBUG): Aggregate::uninitialize Default 2024-04-12T17:10:43.914Z,1712941843.914 [Default:B.GoToSurface] Stopped 2024-04-12T17:10:43.914Z,1712941843.914 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-12T17:10:43.914Z,1712941843.914 [Default:CheckIn] Stopped 2024-04-12T17:10:43.914Z,1712941843.914 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-12T17:10:43.914Z,1712941843.914 [Default:CheckIn:Read_GPS] Stopped 2024-04-12T17:10:43.917Z,1712941843.917 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-04-12T17:10:43.918Z,1712941843.918 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-04-12T17:10:43.918Z,1712941843.918 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-04-12T17:10:43.918Z,1712941843.918 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-04-12T17:10:43.919Z,1712941843.919 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-04-12T17:10:43.919Z,1712941843.919 [BuoyancyServo](INFO): Powering down 2024-04-12T17:10:43.932Z,1712941843.932 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-04-12T17:10:43.932Z,1712941843.932 [ElevatorServo](INFO): Powering down 2024-04-12T17:10:43.933Z,1712941843.933 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-04-12T17:10:43.933Z,1712941843.933 [MassServo](INFO): Powering down 2024-04-12T17:10:43.934Z,1712941843.934 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-04-12T17:10:43.934Z,1712941843.934 [RudderServo](INFO): Powering down 2024-04-12T17:10:43.935Z,1712941843.935 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-04-12T17:10:43.935Z,1712941843.935 [ThrusterServo](INFO): Powering down 2024-04-12T17:10:43.936Z,1712941843.936 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-04-12T17:10:43.936Z,1712941843.936 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-04-12T17:10:43.937Z,1712941843.937 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-04-12T17:10:43.937Z,1712941843.937 [CBIT](DEBUG): Powering off loads. 2024-04-12T17:10:43.948Z,1712941843.948 [CBIT](DEBUG): Disabling WDT. 2024-04-12T17:10:43.960Z,1712941843.960 [CBIT](DEBUG): Opening all GF detection circuits. 2024-04-12T17:10:43.961Z,1712941843.961 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.015Z,1712941844.015 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.022Z,1712941844.022 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.024Z,1712941844.024 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.029Z,1712941844.029 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.074Z,1712941844.074 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.134Z,1712941844.134 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.136Z,1712941844.136 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.140Z,1712941844.140 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.149Z,1712941844.149 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-12T17:10:44.214Z,1712941844.214 [logger ThreadHandler](INFO): Thread cancelled.