2025-05-22T21:18:54.125Z,1747948734.125 [Supervisor](DEBUG): Initializing supervisor. 2025-05-22T21:18:54.166Z,1747948734.166 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-05-22T21:18:54.167Z,1747948734.167 [SyncHandler](INFO): Protected caller Thread ID is 7449 2025-05-22T21:18:54.167Z,1747948734.167 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-05-22T21:18:54.183Z,1747948734.183 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-05-22T21:18:54.184Z,1747948734.184 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7450 2025-05-22T21:18:54.225Z,1747948734.225 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-05-22T21:18:54.339Z,1747948734.339 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-05-22T21:18:54.354Z,1747948734.354 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-05-22T21:18:54.354Z,1747948734.354 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7451 2025-05-22T21:18:54.363Z,1747948734.363 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-05-22T21:18:54.370Z,1747948734.370 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-05-22T21:18:54.371Z,1747948734.371 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7452 2025-05-22T21:18:54.373Z,1747948734.373 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-05-22T21:18:54.386Z,1747948734.386 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-05-22T21:18:54.387Z,1747948734.387 [logger ThreadHandler](INFO): Protected caller Thread ID is 7453 2025-05-22T21:18:54.396Z,1747948734.396 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-05-22T21:18:54.396Z,1747948734.396 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-05-22T21:18:54.401Z,1747948734.401 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-05-22T21:18:55.824Z,1747948735.824 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-05-22T21:18:55.826Z,1747948735.826 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-05-22T21:18:56.744Z,1747948736.744 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-05-22T21:18:56.746Z,1747948736.746 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-05-22T21:18:57.671Z,1747948737.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-05-22T21:18:57.673Z,1747948737.673 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-05-22T21:18:58.110Z,1747948738.110 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-05-22T21:18:58.112Z,1747948738.112 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-05-22T21:18:58.544Z,1747948738.544 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-05-22T21:18:58.546Z,1747948738.546 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-05-22T21:18:59.926Z,1747948739.926 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-05-22T21:18:59.929Z,1747948739.929 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-05-22T21:19:00.539Z,1747948740.539 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-05-22T21:19:00.540Z,1747948740.540 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-05-22T21:19:00.818Z,1747948740.818 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-05-22T21:19:00.819Z,1747948740.819 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-05-22T21:19:00.932Z,1747948740.932 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-05-22T21:19:01.263Z,1747948741.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-05-22T21:19:01.264Z,1747948741.264 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-05-22T21:19:01.460Z,1747948741.460 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-05-22T21:19:01.460Z,1747948741.460 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-05-22T21:19:01.770Z,1747948741.770 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-05-22T21:19:01.770Z,1747948741.770 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-05-22T21:19:02.035Z,1747948742.035 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-05-22T21:19:02.036Z,1747948742.036 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-05-22T21:19:02.165Z,1747948742.165 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-05-22T21:19:02.166Z,1747948742.166 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-05-22T21:19:03.021Z,1747948743.021 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-05-22T21:19:03.022Z,1747948743.022 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-05-22T21:19:04.775Z,1747948744.775 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-05-22T21:19:04.778Z,1747948744.778 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/ 2025-05-22T21:19:04.781Z,1747948744.781 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg 2025-05-22T21:19:04.926Z,1747948744.926 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg 2025-05-22T21:19:05.376Z,1747948745.376 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-05-22T21:19:05.378Z,1747948745.378 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg 2025-05-22T21:19:05.615Z,1747948745.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg 2025-05-22T21:19:05.773Z,1747948745.773 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg 2025-05-22T21:19:05.998Z,1747948745.998 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg 2025-05-22T21:19:06.192Z,1747948746.192 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg 2025-05-22T21:19:06.466Z,1747948746.466 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg 2025-05-22T21:19:06.621Z,1747948746.621 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg 2025-05-22T21:19:06.868Z,1747948746.868 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg 2025-05-22T21:19:07.033Z,1747948747.033 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg 2025-05-22T21:19:07.261Z,1747948747.261 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2025-05-22T21:19:07.263Z,1747948747.263 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-05-22T21:19:07.280Z,1747948747.280 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-05-22T21:19:07.281Z,1747948747.281 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-05-22T21:19:07.563Z,1747948747.563 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-05-22T21:19:07.563Z,1747948747.563 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-05-22T21:19:07.620Z,1747948747.620 [DeadReckonWithRespectToSeafloor] Loaded 2025-05-22T21:19:07.620Z,1747948747.620 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2025-05-22T21:19:07.686Z,1747948747.686 [NavChart] Loaded 2025-05-22T21:19:07.686Z,1747948747.686 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-05-22T21:19:07.697Z,1747948747.697 [UniversalFixResidualReporter] Loaded 2025-05-22T21:19:07.697Z,1747948747.697 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-05-22T21:19:07.698Z,1747948747.698 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-05-22T21:19:07.703Z,1747948747.703 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-05-22T21:19:09.408Z,1747948749.408 [AHRS_M2] Loaded 2025-05-22T21:19:09.408Z,1747948749.408 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-05-22T21:19:09.603Z,1747948749.603 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3 2025-05-22T21:19:09.603Z,1747948749.603 [BackseatComponent] Loaded 2025-05-22T21:19:09.604Z,1747948749.604 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-05-22T21:19:09.605Z,1747948749.605 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085D4E0 2025-05-22T21:19:09.605Z,1747948749.605 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7536 2025-05-22T21:19:09.613Z,1747948749.613 [LcmUniversalReporter] Loaded 2025-05-22T21:19:09.613Z,1747948749.613 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-05-22T21:19:10.938Z,1747948750.938 [BPC1] Loaded 2025-05-22T21:19:10.939Z,1747948750.939 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-05-22T21:19:11.058Z,1747948751.058 [DAT] Loaded 2025-05-22T21:19:11.059Z,1747948751.059 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-05-22T21:19:11.060Z,1747948751.060 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088D4E0 2025-05-22T21:19:11.060Z,1747948751.060 [DAT ThreadHandler](INFO): Protected caller Thread ID is 7537 2025-05-22T21:19:11.219Z,1747948751.219 [DataOverHttps] Loaded 2025-05-22T21:19:11.220Z,1747948751.220 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-05-22T21:19:11.225Z,1747948751.225 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0 2025-05-22T21:19:11.225Z,1747948751.225 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7538 2025-05-22T21:19:11.253Z,1747948751.253 [DepthKeller33X] Loaded 2025-05-22T21:19:11.253Z,1747948751.253 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread. 2025-05-22T21:19:11.260Z,1747948751.260 [DropWeight] Loaded 2025-05-22T21:19:11.260Z,1747948751.260 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-05-22T21:19:11.340Z,1747948751.340 [NAL9602] Loaded 2025-05-22T21:19:11.340Z,1747948751.340 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-05-22T21:19:11.376Z,1747948751.376 [Onboard] Loaded 2025-05-22T21:19:11.376Z,1747948751.376 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-05-22T21:19:11.377Z,1747948751.377 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0 2025-05-22T21:19:11.378Z,1747948751.378 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7539 2025-05-22T21:19:11.394Z,1747948751.394 [Power24vConverter] Loaded 2025-05-22T21:19:11.394Z,1747948751.394 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-05-22T21:19:11.416Z,1747948751.416 [Radio_Surface] Loaded 2025-05-22T21:19:11.417Z,1747948751.417 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-05-22T21:19:11.418Z,1747948751.418 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0 2025-05-22T21:19:11.418Z,1747948751.418 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7540 2025-05-22T21:19:11.476Z,1747948751.476 [RDI_Pathfinder] Loaded 2025-05-22T21:19:11.477Z,1747948751.477 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2025-05-22T21:19:11.495Z,1747948751.495 [Sonardyne_Nano] Loaded 2025-05-22T21:19:11.495Z,1747948751.495 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-05-22T21:19:11.495Z,1747948751.495 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-05-22T21:19:11.496Z,1747948751.496 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-05-22T21:19:11.632Z,1747948751.632 [DepthRateCalculator] Loaded 2025-05-22T21:19:11.632Z,1747948751.632 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-05-22T21:19:11.647Z,1747948751.647 [PitchRateCalculator] Loaded 2025-05-22T21:19:11.647Z,1747948751.647 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-05-22T21:19:11.664Z,1747948751.664 [SpeedCalculator] Loaded 2025-05-22T21:19:11.664Z,1747948751.664 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-05-22T21:19:11.674Z,1747948751.674 [YawRateCalculator] Loaded 2025-05-22T21:19:11.675Z,1747948751.675 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-05-22T21:19:11.700Z,1747948751.700 [ElevatorOffsetCalculator] Loaded 2025-05-22T21:19:11.701Z,1747948751.701 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-05-22T21:19:11.701Z,1747948751.701 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-05-22T21:19:11.703Z,1747948751.703 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-05-22T21:19:11.792Z,1747948751.792 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-05-22T21:19:11.793Z,1747948751.793 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-05-22T21:19:12.055Z,1747948752.055 [BuoyancyServo] Loaded 2025-05-22T21:19:12.056Z,1747948752.056 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-05-22T21:19:12.088Z,1747948752.088 [ElevatorServo] Loaded 2025-05-22T21:19:12.088Z,1747948752.088 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-05-22T21:19:12.116Z,1747948752.116 [MassServo] Loaded 2025-05-22T21:19:12.117Z,1747948752.117 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-05-22T21:19:12.145Z,1747948752.145 [RudderServo] Loaded 2025-05-22T21:19:12.146Z,1747948752.146 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-05-22T21:19:12.166Z,1747948752.166 [ThrusterHE] Loaded 2025-05-22T21:19:12.167Z,1747948752.167 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-05-22T21:19:12.167Z,1747948752.167 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-05-22T21:19:12.168Z,1747948752.168 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-05-22T21:19:12.579Z,1747948752.579 [CTD_Seabird] Loaded 2025-05-22T21:19:12.580Z,1747948752.580 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-05-22T21:19:12.581Z,1747948752.581 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A514E0 2025-05-22T21:19:12.581Z,1747948752.581 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7541 2025-05-22T21:19:12.610Z,1747948752.610 [RBRTridente] Loaded 2025-05-22T21:19:12.610Z,1747948752.610 [ComponentRegistry](DEBUG): Component "RBRTridente" handled in its own thread. 2025-05-22T21:19:12.611Z,1747948752.611 [RBRTridente ThreadHandler](DEBUG): Created PCaller Thread at 40A814E0 2025-05-22T21:19:12.612Z,1747948752.612 [RBRTridente ThreadHandler](INFO): Protected caller Thread ID is 7542 2025-05-22T21:19:12.613Z,1747948752.613 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-05-22T21:19:12.613Z,1747948752.613 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-05-22T21:19:13.017Z,1747948753.017 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-05-22T21:19:13.018Z,1747948753.018 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-05-22T21:19:13.416Z,1747948753.416 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-05-22T21:19:13.416Z,1747948753.416 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-05-22T21:19:14.001Z,1747948754.001 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-05-22T21:19:14.002Z,1747948754.002 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-05-22T21:19:14.097Z,1747948754.097 [VerticalControl](DEBUG): Construct VerticalControl. 2025-05-22T21:19:14.168Z,1747948754.168 [VerticalControl] Loaded 2025-05-22T21:19:14.168Z,1747948754.168 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-05-22T21:19:14.171Z,1747948754.171 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-05-22T21:19:14.225Z,1747948754.225 [HorizontalControl] Loaded 2025-05-22T21:19:14.227Z,1747948754.227 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-05-22T21:19:14.229Z,1747948754.229 [SpeedControl](DEBUG): Construct SpeedControl. 2025-05-22T21:19:14.231Z,1747948754.231 [SpeedControl] Loaded 2025-05-22T21:19:14.232Z,1747948754.232 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-05-22T21:19:14.236Z,1747948754.236 [LoopControl](DEBUG): Construct LoopControl. 2025-05-22T21:19:14.236Z,1747948754.236 [LoopControl] Loaded 2025-05-22T21:19:14.237Z,1747948754.237 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-05-22T21:19:14.237Z,1747948754.237 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-05-22T21:19:14.238Z,1747948754.238 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-05-22T21:19:14.625Z,1747948754.625 [SBIT](DEBUG): Construct Startup Built In Test. 2025-05-22T21:19:14.635Z,1747948754.635 [SBIT] Loaded 2025-05-22T21:19:14.636Z,1747948754.636 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-05-22T21:19:14.639Z,1747948754.639 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-05-22T21:19:14.656Z,1747948754.656 [IBIT] Loaded 2025-05-22T21:19:14.656Z,1747948754.656 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-05-22T21:19:14.662Z,1747948754.662 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-05-22T21:19:14.842Z,1747948754.842 [CBIT] Loaded 2025-05-22T21:19:14.842Z,1747948754.842 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-05-22T21:19:14.889Z,1747948754.889 [GFScanner] Loaded 2025-05-22T21:19:14.890Z,1747948754.890 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-05-22T21:19:14.890Z,1747948754.890 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-05-22T21:19:14.891Z,1747948754.891 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-05-22T21:19:14.941Z,1747948754.941 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-05-22T21:19:14.948Z,1747948754.948 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-05-22T21:19:14.951Z,1747948754.951 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-05-22T21:19:14.970Z,1747948754.970 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-05-22T21:19:14.971Z,1747948754.971 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0 2025-05-22T21:19:14.972Z,1747948754.972 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7544 2025-05-22T21:19:14.977Z,1747948754.977 [Supervisor](INFO): Main Thread ID is 7447 2025-05-22T21:19:14.977Z,1747948754.977 [Supervisor](DEBUG): Running supervisor. 2025-05-22T21:19:14.977Z,1747948754.977 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7545 2025-05-22T21:19:14.978Z,1747948754.978 [CommandExec](INFO): Initializing the command executive. 2025-05-22T21:19:14.980Z,1747948754.980 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7546 2025-05-22T21:19:14.984Z,1747948754.984 [controlThread ThreadHandler](INFO): Handler Thread ID is 7547 2025-05-22T21:19:14.984Z,1747948754.984 [controlThread](DEBUG): Initializing ControlThread 2025-05-22T21:19:14.986Z,1747948754.986 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-05-22T21:19:14.987Z,1747948754.987 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-05-22T21:19:14.990Z,1747948754.990 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-05-22T21:19:14.991Z,1747948754.991 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-05-22T21:19:14.991Z,1747948754.991 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-05-22T21:19:14.992Z,1747948754.992 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-05-22T21:19:14.992Z,1747948754.992 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-05-22T21:19:14.994Z,1747948754.994 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-05-22T21:19:14.995Z,1747948754.995 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-05-22T21:19:14.996Z,1747948754.996 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-05-22T21:19:14.997Z,1747948754.997 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-05-22T21:19:14.997Z,1747948754.997 [SBIT](INFO): Initialize SBIT Component. 2025-05-22T21:19:14.997Z,1747948754.997 [SBIT](IMPORTANT): git: 2025-05-16-18-g9c601af6d 2025-05-22T21:19:14.998Z,1747948754.998 [SBIT](INFO): git hash: 9c601af6dd40e15398b518924185b67aae63bffa 2025-05-22T21:19:14.998Z,1747948754.998 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-05-22T21:19:14.999Z,1747948754.999 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Mon Nov 27 01:04:18 PST 2023 2025-05-22T21:19:15.000Z,1747948755.000 [SBIT](INFO): Beginning SBIT in 39.000000 seconds. 2025-05-22T21:19:15.001Z,1747948755.001 [IBIT](INFO): Initialize IBIT Component. 2025-05-22T21:19:15.002Z,1747948755.002 [CBIT](DEBUG): Initialize CBIT Component. 2025-05-22T21:19:15.003Z,1747948755.003 [logger ThreadHandler](INFO): Handler Thread ID is 7548 2025-05-22T21:19:15.015Z,1747948755.015 [CBIT](DEBUG): Initialized mux pins. 2025-05-22T21:19:15.015Z,1747948755.015 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2025-05-22T21:19:15.015Z,1747948755.015 [CBIT](DEBUG): Initializing the watchdog timer. 2025-05-22T21:19:15.023Z,1747948755.023 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7549 2025-05-22T21:19:15.035Z,1747948755.035 [DAT ThreadHandler](INFO): Handler Thread ID is 7550 2025-05-22T21:19:15.036Z,1747948755.036 [DAT](INFO): Powering up 2025-05-22T21:19:15.036Z,1747948755.036 [DAT](DEBUG): Initializing DAT. 2025-05-22T21:19:15.038Z,1747948755.038 [CBIT](CRITICAL): Watchdog Timer failed to initialize. 2025-05-22T21:19:15.038Z,1747948755.038 [CBIT] Hardware Fault, FailCount= 1 2025-05-22T21:19:15.038Z,1747948755.038 [CBIT](ERROR): Hardware Fault 2025-05-22T21:19:15.039Z,1747948755.039 [CBIT](DEBUG): Initializing heartbeat. 2025-05-22T21:19:15.047Z,1747948755.047 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7551 2025-05-22T21:19:15.048Z,1747948755.048 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-05-22T21:19:15.059Z,1747948755.059 [Onboard ThreadHandler](INFO): Handler Thread ID is 7552 2025-05-22T21:19:15.094Z,1747948755.094 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7553 2025-05-22T21:19:15.103Z,1747948755.103 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7554 2025-05-22T21:19:15.103Z,1747948755.103 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-05-22T21:19:15.107Z,1747948755.107 [RBRTridente ThreadHandler](INFO): Handler Thread ID is 7556 2025-05-22T21:19:15.108Z,1747948755.108 [RBRTridente](INFO): Start 2025-05-22T21:19:15.110Z,1747948755.110 [CBIT](DEBUG): Deactivating emergency mode. 2025-05-22T21:19:15.111Z,1747948755.111 [RBRTridente](INFO): Powering up 2025-05-22T21:19:15.112Z,1747948755.112 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7558 2025-05-22T21:19:15.124Z,1747948755.124 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-05-22T21:19:15.124Z,1747948755.124 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-05-22T21:19:15.124Z,1747948755.124 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-05-22T21:19:15.125Z,1747948755.125 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-05-22T21:19:15.125Z,1747948755.125 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-05-22T21:19:15.125Z,1747948755.125 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-05-22T21:19:15.125Z,1747948755.125 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-05-22T21:19:15.125Z,1747948755.125 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-05-22T21:19:15.216Z,1747948755.216 [CBIT](DEBUG): Backplane powered. 2025-05-22T21:19:15.219Z,1747948755.219 [GFScanner](DEBUG): Initializing GFScanner 2025-05-22T21:19:15.219Z,1747948755.219 [GFScanner](DEBUG): Deactivating GF circuits. 2025-05-22T21:19:15.243Z,1747948755.243 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-05-22T21:19:15.244Z,1747948755.244 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-05-22T21:19:15.244Z,1747948755.244 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-05-22T21:19:15.251Z,1747948755.251 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-05-22T21:19:15.356Z,1747948755.356 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-05-22T21:19:15.369Z,1747948755.369 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-05-22T21:19:15.425Z,1747948755.425 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2025-05-22T21:19:15.439Z,1747948755.439 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-05-22T21:19:15.439Z,1747948755.439 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-05-22T21:19:15.455Z,1747948755.455 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-05-22T21:19:15.499Z,1747948755.499 [Radio_Surface](INFO): Powering up 2025-05-22T21:19:15.510Z,1747948755.510 [RBRTridente](INFO): Starting 2025-05-22T21:19:15.848Z,1747948755.848 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2025-05-22T21:19:15.873Z,1747948755.873 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-05-22T21:19:15.883Z,1747948755.883 [Default:A.Wait](DEBUG): Construct Wait. 2025-05-22T21:19:15.885Z,1747948755.885 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-05-22T21:19:15.915Z,1747948755.915 [RBRTridente](INFO): Stop 2025-05-22T21:19:15.932Z,1747948755.932 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-05-22T21:19:15.983Z,1747948755.983 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-05-22T21:19:15.986Z,1747948755.986 [RBRTridente](INFO): Powering down 2025-05-22T21:19:15.997Z,1747948755.997 [Default:E.Execute](DEBUG): Construct Execute. 2025-05-22T21:19:16.041Z,1747948756.041 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2025-05-22T21:19:16.048Z,1747948756.048 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DepthKeller33X,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter, 2025-05-22T21:19:16.100Z,1747948756.100 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-05-22T21:19:16.187Z,1747948756.187 [DepthKeller33X](INFO): Initializing. 2025-05-22T21:19:16.203Z,1747948756.203 [Power24vConverter](INFO): Powering up. 2025-05-22T21:19:16.204Z,1747948756.204 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2025-05-22T21:19:16.205Z,1747948756.205 [Sonardyne_Nano](INFO): Initializing. 2025-05-22T21:19:16.219Z,1747948756.219 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:16.234Z,1747948756.234 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-05-22T21:19:16.242Z,1747948756.242 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-05-22T21:19:16.243Z,1747948756.243 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-05-22T21:19:16.251Z,1747948756.251 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-05-22T21:19:16.252Z,1747948756.252 [MassServo](DEBUG): Initializing EZServoServo. 2025-05-22T21:19:16.258Z,1747948756.258 [MassServo](DEBUG): Initializing MassServo. 2025-05-22T21:19:16.259Z,1747948756.259 [RudderServo](DEBUG): Initializing EZServoServo. 2025-05-22T21:19:16.267Z,1747948756.267 [RudderServo](DEBUG): Initializing RudderServo. 2025-05-22T21:19:16.271Z,1747948756.271 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-05-22T21:19:16.278Z,1747948756.278 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-05-22T21:19:16.280Z,1747948756.280 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-05-22T21:19:16.280Z,1747948756.280 [CBIT](DEBUG): Powering off loads. 2025-05-22T21:19:16.305Z,1747948756.305 [CBIT](DEBUG): Disabling WDT. 2025-05-22T21:19:16.330Z,1747948756.330 [RBRTridente](INFO): Stopping 2025-05-22T21:19:16.608Z,1747948756.608 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-05-22T21:19:16.608Z,1747948756.608 [DropWeight] Hardware Fault, FailCount= 1 2025-05-22T21:19:16.608Z,1747948756.608 [DropWeight](ERROR): Hardware Fault 2025-05-22T21:19:16.623Z,1747948756.623 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:16.863Z,1747948756.863 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:17.270Z,1747948757.270 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:17.608Z,1747948757.608 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2025-05-22T21:19:17.608Z,1747948757.608 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2025-05-22T21:19:17.608Z,1747948757.608 [BuoyancyServo] Communications Fault, FailCount= 1 2025-05-22T21:19:17.608Z,1747948757.608 [BuoyancyServo](ERROR): Communications Fault 2025-05-22T21:19:17.930Z,1747948757.930 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2025-05-22T21:19:17.930Z,1747948757.930 [ElevatorServo](FAULT): Elevator failed to initialize 2025-05-22T21:19:17.930Z,1747948757.930 [ElevatorServo] Communications Fault, FailCount= 1 2025-05-22T21:19:17.930Z,1747948757.930 [ElevatorServo](ERROR): Communications Fault 2025-05-22T21:19:18.234Z,1747948758.234 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2025-05-22T21:19:18.234Z,1747948758.234 [RudderServo](FAULT): Rudder failed to initialize 2025-05-22T21:19:18.234Z,1747948758.234 [RudderServo] Communications Fault, FailCount= 1 2025-05-22T21:19:18.234Z,1747948758.234 [RudderServo](ERROR): Communications Fault 2025-05-22T21:19:18.254Z,1747948758.254 [DepthKeller33X](FAULT): Failed to initialize. 2025-05-22T21:19:18.254Z,1747948758.254 [DepthKeller33X] Communications Fault, FailCount= 1 2025-05-22T21:19:18.254Z,1747948758.254 [DepthKeller33X](ERROR): Communications Fault 2025-05-22T21:19:18.256Z,1747948758.256 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:18.306Z,1747948758.306 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-05-22T21:19:18.318Z,1747948758.318 [ElevatorServo](INFO): Powering down 2025-05-22T21:19:18.320Z,1747948758.320 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-05-22T21:19:18.320Z,1747948758.320 [RudderServo](INFO): Powering down 2025-05-22T21:19:18.321Z,1747948758.321 [ThrusterHE](FAULT): Thruster failed to initialize 2025-05-22T21:19:18.321Z,1747948758.321 [ThrusterHE] Communications Fault, FailCount= 1 2025-05-22T21:19:18.321Z,1747948758.321 [ThrusterHE](ERROR): Communications Fault 2025-05-22T21:19:18.645Z,1747948758.645 [DepthKeller33X](INFO): Powering down 2025-05-22T21:19:18.741Z,1747948758.741 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:18.752Z,1747948758.752 [ElevatorServo](FAULT): LCB fault: Current Limiter Activated. 2025-05-22T21:19:18.752Z,1747948758.752 [ElevatorServo] Hardware Fault, FailCount= 1 2025-05-22T21:19:18.752Z,1747948758.752 [ElevatorServo](ERROR): Hardware Fault 2025-05-22T21:19:18.753Z,1747948758.753 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-05-22T21:19:18.753Z,1747948758.753 [ThrusterHE](INFO): Powering down 2025-05-22T21:19:19.053Z,1747948759.053 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:19.064Z,1747948759.064 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-05-22T21:19:19.193Z,1747948759.193 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-05-22T21:19:19.498Z,1747948759.498 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2025-05-22T21:19:19.498Z,1747948759.498 [MassServo] Communications Fault, FailCount= 1 2025-05-22T21:19:19.498Z,1747948759.498 [MassServo](ERROR): Communications Fault 2025-05-22T21:19:19.499Z,1747948759.499 [RudderServo](DEBUG): Initializing EZServoServo. 2025-05-22T21:19:19.622Z,1747948759.622 [RudderServo](DEBUG): Initializing RudderServo. 2025-05-22T21:19:19.623Z,1747948759.623 [ThrusterHE](FAULT): LCB fault: Current Limiter Activated. 2025-05-22T21:19:19.624Z,1747948759.624 [ThrusterHE] Hardware Fault, FailCount= 1 2025-05-22T21:19:19.624Z,1747948759.624 [ThrusterHE](ERROR): Hardware Fault 2025-05-22T21:19:19.702Z,1747948759.702 [Sonardyne_Nano](FAULT): LCB fault: Current Limiter Activated. 2025-05-22T21:19:19.702Z,1747948759.702 [Sonardyne_Nano] Hardware Fault, FailCount= 1 2025-05-22T21:19:19.702Z,1747948759.702 [Sonardyne_Nano](ERROR): Hardware Fault 2025-05-22T21:19:19.702Z,1747948759.702 [Sonardyne_Nano](INFO): Powering down 2025-05-22T21:19:19.703Z,1747948759.703 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:19.711Z,1747948759.711 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-05-22T21:19:19.711Z,1747948759.711 [MassServo](INFO): Powering down 2025-05-22T21:19:20.060Z,1747948760.060 [Sonardyne_Nano](INFO): Powering down 2025-05-22T21:19:20.061Z,1747948760.061 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:20.111Z,1747948760.111 [MassServo](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2025-05-22T21:19:20.112Z,1747948760.112 [MassServo] Hardware Fault, FailCount= 1 2025-05-22T21:19:20.112Z,1747948760.112 [MassServo](ERROR): Hardware Fault 2025-05-22T21:19:20.464Z,1747948760.464 [Sonardyne_Nano](FAULT): LCB fault: Current Limiter Activated. 2025-05-22T21:19:20.464Z,1747948760.464 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:20.486Z,1747948760.486 [MassServo](DEBUG): Initializing EZServoServo. 2025-05-22T21:19:20.607Z,1747948760.607 [MassServo](DEBUG): Initializing MassServo. 2025-05-22T21:19:20.916Z,1747948760.916 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:21.559Z,1747948761.559 [AHRS_M2](ERROR): Subscribe Roll UART error: serial timeout 2025-05-22T21:19:21.561Z,1747948761.561 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:21.696Z,1747948761.696 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:22.104Z,1747948762.104 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:22.484Z,1747948762.484 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:22.900Z,1747948762.900 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:23.582Z,1747948763.582 [AHRS_M2](ERROR): Subscribe Gyro UART error: serial timeout 2025-05-22T21:19:23.584Z,1747948763.584 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:23.717Z,1747948763.717 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:24.116Z,1747948764.116 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:24.576Z,1747948764.576 [AHRS_M2](ERROR): Subscribe Temperature UART error: serial timeout 2025-05-22T21:19:24.577Z,1747948764.577 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:24.924Z,1747948764.924 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:25.402Z,1747948765.402 [AHRS_M2](ERROR): Subscribe MagBufferActiveIndex UART error: serial timeout 2025-05-22T21:19:25.403Z,1747948765.403 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:25.732Z,1747948765.732 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:26.120Z,1747948766.120 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:26.512Z,1747948766.512 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:26.947Z,1747948766.947 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:27.344Z,1747948767.344 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:27.743Z,1747948767.743 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:28.148Z,1747948768.148 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:28.162Z,1747948768.162 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-05-22T21:19:28.162Z,1747948768.162 [CTD_Seabird] Communications Fault, FailCount= 1 2025-05-22T21:19:28.163Z,1747948768.163 [CTD_Seabird](ERROR): Communications Fault 2025-05-22T21:19:28.553Z,1747948768.553 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:28.567Z,1747948768.567 [CTD_Seabird](INFO): Powering down 2025-05-22T21:19:28.956Z,1747948768.956 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:29.102Z,1747948769.102 [CTD_Seabird](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2025-05-22T21:19:29.103Z,1747948769.103 [CTD_Seabird] Hardware Fault, FailCount= 1 2025-05-22T21:19:29.103Z,1747948769.103 [CTD_Seabird](ERROR): Hardware Fault 2025-05-22T21:19:29.359Z,1747948769.359 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:29.506Z,1747948769.506 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-05-22T21:19:29.772Z,1747948769.772 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:30.168Z,1747948770.168 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:30.572Z,1747948770.572 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:30.976Z,1747948770.976 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:31.395Z,1747948771.395 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:31.796Z,1747948771.796 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:32.200Z,1747948772.200 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:32.604Z,1747948772.604 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:33.007Z,1747948773.007 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:33.412Z,1747948773.412 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:33.817Z,1747948773.817 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:34.220Z,1747948774.220 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:34.623Z,1747948774.623 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:35.030Z,1747948775.030 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:35.432Z,1747948775.432 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:35.836Z,1747948775.836 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:36.238Z,1747948776.238 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2025-05-22T21:19:36.238Z,1747948776.238 [AHRS_M2] Data Fault, FailCount= 1 2025-05-22T21:19:36.238Z,1747948776.238 [AHRS_M2](ERROR): Data Fault 2025-05-22T21:19:36.240Z,1747948776.240 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:36.628Z,1747948776.628 [AHRS_M2](INFO): Powering down 2025-05-22T21:19:36.700Z,1747948776.700 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:37.033Z,1747948777.033 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:37.437Z,1747948777.437 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:37.844Z,1747948777.844 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:38.246Z,1747948778.246 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:38.650Z,1747948778.650 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2025-05-22T21:19:38.651Z,1747948778.651 [RDI_Pathfinder] Communications Fault, FailCount= 1 2025-05-22T21:19:38.651Z,1747948778.651 [RDI_Pathfinder](ERROR): Communications Fault 2025-05-22T21:19:38.652Z,1747948778.652 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:39.126Z,1747948779.126 [RDI_Pathfinder](INFO): Powering down 2025-05-22T21:19:39.127Z,1747948779.127 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:39.459Z,1747948779.459 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:39.862Z,1747948779.862 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:40.268Z,1747948780.268 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:40.670Z,1747948780.670 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:41.075Z,1747948781.075 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:41.477Z,1747948781.477 [NAL9602](INFO): Powering up NAL9602 2025-05-22T21:19:41.478Z,1747948781.478 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:41.884Z,1747948781.884 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:42.285Z,1747948782.285 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:42.691Z,1747948782.691 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:43.093Z,1747948783.093 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:43.499Z,1747948783.499 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:43.904Z,1747948783.904 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:44.305Z,1747948784.305 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:44.709Z,1747948784.709 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:45.117Z,1747948785.118 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:45.519Z,1747948785.519 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:45.923Z,1747948785.923 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:46.325Z,1747948786.325 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:46.730Z,1747948786.730 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:47.133Z,1747948787.133 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:47.537Z,1747948787.537 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:47.941Z,1747948787.941 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:48.347Z,1747948788.347 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:48.750Z,1747948788.750 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:49.155Z,1747948789.155 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:49.558Z,1747948789.558 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:49.963Z,1747948789.963 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:50.366Z,1747948790.366 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:50.770Z,1747948790.770 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:51.173Z,1747948791.173 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:51.579Z,1747948791.579 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:51.996Z,1747948791.996 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:52.386Z,1747948792.386 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:52.793Z,1747948792.793 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:53.194Z,1747948793.194 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:53.599Z,1747948793.599 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:54.002Z,1747948794.002 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:54.414Z,1747948794.414 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:54.421Z,1747948794.421 [SBIT](IMPORTANT): Beginning Startup BIT 2025-05-22T21:19:54.447Z,1747948794.447 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-05-22T21:19:54.818Z,1747948794.818 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:55.222Z,1747948795.222 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:55.631Z,1747948795.631 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:56.031Z,1747948796.031 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:56.435Z,1747948796.435 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:56.838Z,1747948796.838 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:57.242Z,1747948797.242 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:57.646Z,1747948797.646 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:58.049Z,1747948798.049 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:58.453Z,1747948798.453 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:58.857Z,1747948798.857 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-22T21:19:58.869Z,1747948798.869 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): -0.001868 CHAN A1 (24V): -0.164463 CHAN A2 (12V): -0.079988 CHAN A3 (5V): -0.011309