2025-03-20T17:49:34.543Z,1742492974.543 [Supervisor](DEBUG): Initializing supervisor. 2025-03-20T17:49:34.548Z,1742492974.548 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-03-20T17:49:34.548Z,1742492974.548 [SyncHandler](INFO): Protected caller Thread ID is 549 2025-03-20T17:49:34.549Z,1742492974.549 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-03-20T17:49:34.549Z,1742492974.549 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-03-20T17:49:34.550Z,1742492974.550 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 550 2025-03-20T17:49:34.554Z,1742492974.554 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-03-20T17:49:34.572Z,1742492974.572 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-03-20T17:49:34.573Z,1742492974.573 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-03-20T17:49:34.574Z,1742492974.574 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 551 2025-03-20T17:49:34.578Z,1742492974.578 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-03-20T17:49:34.579Z,1742492974.579 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-03-20T17:49:34.579Z,1742492974.579 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 552 2025-03-20T17:49:34.581Z,1742492974.581 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-03-20T17:49:34.582Z,1742492974.582 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-03-20T17:49:34.583Z,1742492974.583 [logger ThreadHandler](INFO): Protected caller Thread ID is 553 2025-03-20T17:49:34.587Z,1742492974.587 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-03-20T17:49:34.587Z,1742492974.587 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-03-20T17:49:34.589Z,1742492974.589 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-03-20T17:49:34.811Z,1742492974.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-03-20T17:49:34.812Z,1742492974.812 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-03-20T17:49:34.930Z,1742492974.930 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-03-20T17:49:34.931Z,1742492974.931 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-03-20T17:49:35.040Z,1742492975.040 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-03-20T17:49:35.040Z,1742492975.040 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-03-20T17:49:35.623Z,1742492975.623 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-03-20T17:49:35.624Z,1742492975.624 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-03-20T17:49:35.985Z,1742492975.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-03-20T17:49:35.986Z,1742492975.986 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-03-20T17:49:36.342Z,1742492976.342 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-03-20T17:49:36.342Z,1742492976.342 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-03-20T17:49:36.541Z,1742492976.541 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-03-20T17:49:36.542Z,1742492976.542 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-03-20T17:49:36.631Z,1742492976.631 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-03-20T17:49:36.723Z,1742492976.723 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-03-20T17:49:37.147Z,1742492977.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-03-20T17:49:37.148Z,1742492977.148 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-03-20T17:49:37.450Z,1742492977.450 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-03-20T17:49:37.450Z,1742492977.450 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-03-20T17:49:38.018Z,1742492978.018 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-03-20T17:49:38.018Z,1742492978.018 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-03-20T17:49:38.272Z,1742492978.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-03-20T17:49:38.273Z,1742492978.273 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-03-20T17:49:38.529Z,1742492978.529 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-03-20T17:49:38.530Z,1742492978.530 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-03-20T17:49:38.681Z,1742492978.681 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-03-20T17:49:38.681Z,1742492978.681 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-03-20T17:49:39.607Z,1742492979.607 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-03-20T17:49:39.609Z,1742492979.609 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2025-03-20T17:49:39.610Z,1742492979.610 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2025-03-20T17:49:39.918Z,1742492979.918 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2025-03-20T17:49:40.441Z,1742492980.441 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2025-03-20T17:49:40.722Z,1742492980.722 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-03-20T17:49:40.723Z,1742492980.723 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2025-03-20T17:49:40.859Z,1742492980.859 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2025-03-20T17:49:40.966Z,1742492980.966 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2025-03-20T17:49:41.070Z,1742492981.070 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2025-03-20T17:49:41.189Z,1742492981.189 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2025-03-20T17:49:41.284Z,1742492981.284 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2025-03-20T17:49:41.382Z,1742492981.382 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2025-03-20T17:49:41.483Z,1742492981.483 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2025-03-20T17:49:41.663Z,1742492981.663 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2025-03-20T17:49:41.663Z,1742492981.663 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-03-20T17:49:41.676Z,1742492981.676 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-03-20T17:49:41.727Z,1742492981.727 [DepthRateCalculator] Loaded 2025-03-20T17:49:41.728Z,1742492981.728 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-03-20T17:49:41.733Z,1742492981.733 [PitchRateCalculator] Loaded 2025-03-20T17:49:41.733Z,1742492981.733 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-03-20T17:49:41.744Z,1742492981.744 [SpeedCalculator] Loaded 2025-03-20T17:49:41.744Z,1742492981.744 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-03-20T17:49:41.749Z,1742492981.749 [YawRateCalculator] Loaded 2025-03-20T17:49:41.750Z,1742492981.750 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-03-20T17:49:41.771Z,1742492981.771 [ElevatorOffsetCalculator] Loaded 2025-03-20T17:49:41.771Z,1742492981.771 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-03-20T17:49:41.772Z,1742492981.772 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-03-20T17:49:41.772Z,1742492981.772 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-03-20T17:49:41.801Z,1742492981.801 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-03-20T17:49:41.801Z,1742492981.801 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-03-20T17:49:41.812Z,1742492981.812 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-03-20T17:49:41.812Z,1742492981.812 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-03-20T17:49:42.281Z,1742492982.281 [AHRS_M2] Loaded 2025-03-20T17:49:42.281Z,1742492982.281 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-03-20T17:49:42.320Z,1742492982.320 [BackseatComponent] Loaded 2025-03-20T17:49:42.320Z,1742492982.320 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-03-20T17:49:42.322Z,1742492982.322 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408754E0 2025-03-20T17:49:42.322Z,1742492982.322 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 636 2025-03-20T17:49:42.325Z,1742492982.325 [LcmUniversalReporter] Loaded 2025-03-20T17:49:42.325Z,1742492982.325 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-03-20T17:49:43.118Z,1742492983.118 [BPC1] Loaded 2025-03-20T17:49:43.118Z,1742492983.118 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-03-20T17:49:43.215Z,1742492983.215 [DAT] Loaded 2025-03-20T17:49:43.215Z,1742492983.215 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-03-20T17:49:43.216Z,1742492983.216 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0 2025-03-20T17:49:43.216Z,1742492983.216 [DAT ThreadHandler](INFO): Protected caller Thread ID is 637 2025-03-20T17:49:43.291Z,1742492983.291 [DataOverHttps] Loaded 2025-03-20T17:49:43.291Z,1742492983.291 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-03-20T17:49:43.292Z,1742492983.292 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0 2025-03-20T17:49:43.293Z,1742492983.293 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 638 2025-03-20T17:49:43.315Z,1742492983.315 [Depth_Keller] Loaded 2025-03-20T17:49:43.315Z,1742492983.315 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-03-20T17:49:43.320Z,1742492983.320 [DropWeight] Loaded 2025-03-20T17:49:43.321Z,1742492983.321 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-03-20T17:49:43.342Z,1742492983.342 [MultiRay](INFO): Found secondary power supply at: /dev/loadC7 2025-03-20T17:49:43.342Z,1742492983.342 [MultiRay] Loaded 2025-03-20T17:49:43.342Z,1742492983.342 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2025-03-20T17:49:43.406Z,1742492983.406 [NAL9602] Loaded 2025-03-20T17:49:43.407Z,1742492983.407 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-03-20T17:49:43.436Z,1742492983.436 [Onboard] Loaded 2025-03-20T17:49:43.436Z,1742492983.436 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-03-20T17:49:43.437Z,1742492983.437 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409054E0 2025-03-20T17:49:43.438Z,1742492983.438 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 639 2025-03-20T17:49:43.444Z,1742492983.444 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2025-03-20T17:49:43.457Z,1742492983.457 [PowerOnly] Loaded 2025-03-20T17:49:43.457Z,1742492983.457 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-03-20T17:49:43.471Z,1742492983.471 [Power24vConverter] Loaded 2025-03-20T17:49:43.471Z,1742492983.471 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-03-20T17:49:43.489Z,1742492983.489 [Radio_Surface] Loaded 2025-03-20T17:49:43.489Z,1742492983.489 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-03-20T17:49:43.490Z,1742492983.490 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409354E0 2025-03-20T17:49:43.490Z,1742492983.490 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 640 2025-03-20T17:49:43.515Z,1742492983.515 [Waterlinked] Loaded 2025-03-20T17:49:43.515Z,1742492983.515 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2025-03-20T17:49:43.515Z,1742492983.515 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-03-20T17:49:43.516Z,1742492983.516 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-03-20T17:49:43.627Z,1742492983.627 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-03-20T17:49:43.627Z,1742492983.627 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-03-20T17:49:43.641Z,1742492983.641 [NavChart] Loaded 2025-03-20T17:49:43.641Z,1742492983.641 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-03-20T17:49:43.647Z,1742492983.647 [UniversalFixResidualReporter] Loaded 2025-03-20T17:49:43.647Z,1742492983.647 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-03-20T17:49:43.648Z,1742492983.648 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-03-20T17:49:43.648Z,1742492983.648 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-03-20T17:49:43.808Z,1742492983.808 [SBIT](DEBUG): Construct Startup Built In Test. 2025-03-20T17:49:43.822Z,1742492983.822 [SBIT] Loaded 2025-03-20T17:49:43.822Z,1742492983.822 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-03-20T17:49:43.825Z,1742492983.825 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-03-20T17:49:43.838Z,1742492983.838 [IBIT] Loaded 2025-03-20T17:49:43.838Z,1742492983.838 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-03-20T17:49:43.843Z,1742492983.843 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-03-20T17:49:43.922Z,1742492983.922 [CBIT] Loaded 2025-03-20T17:49:43.922Z,1742492983.922 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-03-20T17:49:43.953Z,1742492983.953 [GFScanner] Loaded 2025-03-20T17:49:43.954Z,1742492983.954 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-03-20T17:49:43.954Z,1742492983.954 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-03-20T17:49:43.955Z,1742492983.955 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-03-20T17:49:44.123Z,1742492984.123 [CTD_Seabird] Loaded 2025-03-20T17:49:44.124Z,1742492984.124 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-03-20T17:49:44.125Z,1742492984.125 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A474E0 2025-03-20T17:49:44.125Z,1742492984.125 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 641 2025-03-20T17:49:44.147Z,1742492984.147 [PAR_Licor] Loaded 2025-03-20T17:49:44.148Z,1742492984.148 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-03-20T17:49:44.193Z,1742492984.193 [WetLabsBB2FL] Loaded 2025-03-20T17:49:44.193Z,1742492984.193 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-03-20T17:49:44.194Z,1742492984.194 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0 2025-03-20T17:49:44.195Z,1742492984.195 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 642 2025-03-20T17:49:44.195Z,1742492984.195 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-03-20T17:49:44.196Z,1742492984.196 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-03-20T17:49:44.334Z,1742492984.334 [BuoyancyServo] Loaded 2025-03-20T17:49:44.334Z,1742492984.334 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-03-20T17:49:44.358Z,1742492984.358 [ElevatorServo] Loaded 2025-03-20T17:49:44.358Z,1742492984.358 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-03-20T17:49:44.381Z,1742492984.381 [MassServo] Loaded 2025-03-20T17:49:44.381Z,1742492984.381 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-03-20T17:49:44.404Z,1742492984.404 [RudderServo] Loaded 2025-03-20T17:49:44.405Z,1742492984.405 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-03-20T17:49:44.423Z,1742492984.423 [ThrusterHE] Loaded 2025-03-20T17:49:44.423Z,1742492984.423 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-03-20T17:49:44.423Z,1742492984.423 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-03-20T17:49:44.424Z,1742492984.424 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-03-20T17:49:44.478Z,1742492984.478 [VerticalControl](DEBUG): Construct VerticalControl. 2025-03-20T17:49:44.529Z,1742492984.529 [VerticalControl] Loaded 2025-03-20T17:49:44.530Z,1742492984.530 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-03-20T17:49:44.532Z,1742492984.532 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-03-20T17:49:44.576Z,1742492984.576 [HorizontalControl] Loaded 2025-03-20T17:49:44.576Z,1742492984.576 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-03-20T17:49:44.578Z,1742492984.578 [SpeedControl](DEBUG): Construct SpeedControl. 2025-03-20T17:49:44.580Z,1742492984.580 [SpeedControl] Loaded 2025-03-20T17:49:44.581Z,1742492984.581 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-03-20T17:49:44.583Z,1742492984.583 [LoopControl](DEBUG): Construct LoopControl. 2025-03-20T17:49:44.584Z,1742492984.584 [LoopControl] Loaded 2025-03-20T17:49:44.584Z,1742492984.584 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-03-20T17:49:44.585Z,1742492984.585 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-03-20T17:49:44.585Z,1742492984.585 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-03-20T17:49:45.069Z,1742492985.069 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-03-20T17:49:45.069Z,1742492985.069 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-03-20T17:49:45.406Z,1742492985.406 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-03-20T17:49:45.406Z,1742492985.406 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-03-20T17:49:45.754Z,1742492985.754 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-03-20T17:49:45.755Z,1742492985.755 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-03-20T17:49:45.813Z,1742492985.813 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-03-20T17:49:45.819Z,1742492985.819 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-03-20T17:49:45.822Z,1742492985.822 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-03-20T17:49:45.834Z,1742492985.834 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-03-20T17:49:45.835Z,1742492985.835 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0 2025-03-20T17:49:45.835Z,1742492985.835 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 643 2025-03-20T17:49:45.839Z,1742492985.839 [Supervisor](INFO): Main Thread ID is 548 2025-03-20T17:49:45.840Z,1742492985.840 [Supervisor](DEBUG): Running supervisor. 2025-03-20T17:49:45.840Z,1742492985.840 [CommandExec ThreadHandler](INFO): Handler Thread ID is 644 2025-03-20T17:49:45.841Z,1742492985.841 [CommandExec](INFO): Initializing the command executive. 2025-03-20T17:49:45.842Z,1742492985.842 [CommandLine ThreadHandler](INFO): Handler Thread ID is 645 2025-03-20T17:49:45.846Z,1742492985.846 [controlThread ThreadHandler](INFO): Handler Thread ID is 646 2025-03-20T17:49:45.846Z,1742492985.846 [controlThread](DEBUG): Initializing ControlThread 2025-03-20T17:49:45.847Z,1742492985.847 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-03-20T17:49:45.848Z,1742492985.848 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-03-20T17:49:45.848Z,1742492985.848 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-03-20T17:49:45.848Z,1742492985.848 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-03-20T17:49:45.849Z,1742492985.849 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-03-20T17:49:45.855Z,1742492985.855 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-03-20T17:49:45.855Z,1742492985.855 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-03-20T17:49:45.855Z,1742492985.855 [SBIT](INFO): Initialize SBIT Component. 2025-03-20T17:49:45.856Z,1742492985.856 [SBIT](IMPORTANT): git: 2025-03-12_C 2025-03-20T17:49:45.856Z,1742492985.856 [SBIT](INFO): git hash: c930cdb2e5c1f1ff3673ee566a0d82f2333fbba8 2025-03-20T17:49:45.856Z,1742492985.856 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-03-20T17:49:45.858Z,1742492985.858 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2025-03-20T17:49:45.859Z,1742492985.859 [SBIT](INFO): Beginning SBIT in 47.000000 seconds. 2025-03-20T17:49:45.859Z,1742492985.859 [IBIT](INFO): Initialize IBIT Component. 2025-03-20T17:49:45.860Z,1742492985.860 [CBIT](DEBUG): Initialize CBIT Component. 2025-03-20T17:49:45.861Z,1742492985.861 [logger ThreadHandler](INFO): Handler Thread ID is 647 2025-03-20T17:49:45.872Z,1742492985.872 [CBIT](DEBUG): Initialized mux pins. 2025-03-20T17:49:45.872Z,1742492985.872 [CBIT](DEBUG): Initializing the watchdog timer. 2025-03-20T17:49:45.880Z,1742492985.880 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 648 2025-03-20T17:49:45.892Z,1742492985.892 [DAT ThreadHandler](INFO): Handler Thread ID is 649 2025-03-20T17:49:45.893Z,1742492985.893 [DAT](INFO): Powering up 2025-03-20T17:49:45.893Z,1742492985.893 [DAT](DEBUG): Initializing DAT. 2025-03-20T17:49:45.896Z,1742492985.896 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-03-20T17:49:45.896Z,1742492985.896 [CBIT](DEBUG): Initializing heartbeat. 2025-03-20T17:49:45.898Z,1742492985.898 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 651 2025-03-20T17:49:45.900Z,1742492985.900 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-03-20T17:49:45.909Z,1742492985.909 [Onboard ThreadHandler](INFO): Handler Thread ID is 652 2025-03-20T17:49:45.925Z,1742492985.925 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 653 2025-03-20T17:49:45.945Z,1742492985.945 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 654 2025-03-20T17:49:45.945Z,1742492985.945 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-20T17:49:45.949Z,1742492985.949 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 656 2025-03-20T17:49:45.952Z,1742492985.952 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:49:45.954Z,1742492985.954 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 658 2025-03-20T17:49:45.956Z,1742492985.956 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-03-20T17:49:45.956Z,1742492985.956 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-03-20T17:49:45.956Z,1742492985.956 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-03-20T17:49:45.957Z,1742492985.957 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-03-20T17:49:45.957Z,1742492985.957 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-03-20T17:49:45.957Z,1742492985.957 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-03-20T17:49:45.957Z,1742492985.957 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-03-20T17:49:45.957Z,1742492985.957 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-03-20T17:49:45.968Z,1742492985.968 [CBIT](DEBUG): Deactivating emergency mode. 2025-03-20T17:49:46.008Z,1742492986.008 [CBIT](DEBUG): Backplane powered. 2025-03-20T17:49:46.008Z,1742492986.008 [GFScanner](DEBUG): Initializing GFScanner 2025-03-20T17:49:46.008Z,1742492986.008 [GFScanner](DEBUG): Deactivating GF circuits. 2025-03-20T17:49:46.017Z,1742492986.017 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-03-20T17:49:46.019Z,1742492986.019 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-03-20T17:49:46.020Z,1742492986.020 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-03-20T17:49:46.020Z,1742492986.020 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-03-20T17:49:46.021Z,1742492986.021 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-03-20T17:49:46.022Z,1742492986.022 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-03-20T17:49:46.022Z,1742492986.022 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-03-20T17:49:46.023Z,1742492986.023 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-03-20T17:49:46.098Z,1742492986.098 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-03-20T17:49:46.102Z,1742492986.102 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-03-20T17:49:46.114Z,1742492986.114 [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-03-20T17:49:46.115Z,1742492986.115 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-03-20T17:49:46.115Z,1742492986.115 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-03-20T17:49:46.116Z,1742492986.116 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-03-20T17:49:46.332Z,1742492986.332 [Radio_Surface](INFO): Powering up 2025-03-20T17:49:46.362Z,1742492986.362 [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-03-20T17:49:46.368Z,1742492986.368 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-03-20T17:49:46.369Z,1742492986.369 [Default:A.Wait](DEBUG): Construct Wait. 2025-03-20T17:49:46.371Z,1742492986.371 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-03-20T17:49:46.384Z,1742492986.384 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-03-20T17:49:46.386Z,1742492986.386 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-03-20T17:49:46.416Z,1742492986.416 [Default:E.Execute](DEBUG): Construct Execute. 2025-03-20T17:49:46.419Z,1742492986.419 [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-03-20T17:49:46.436Z,1742492986.436 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter, 2025-03-20T17:49:46.443Z,1742492986.443 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:49:46.498Z,1742492986.498 [MultiRay](INFO): Powering up MultiRay Lights 2025-03-20T17:49:46.498Z,1742492986.498 [MultiRay](INFO): Powering up secondary power supply. 2025-03-20T17:49:46.537Z,1742492986.537 [Power24vConverter](INFO): Powering up. 2025-03-20T17:49:46.577Z,1742492986.577 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-03-20T17:49:46.584Z,1742492986.584 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-03-20T17:49:46.585Z,1742492986.585 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-03-20T17:49:46.592Z,1742492986.592 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-03-20T17:49:46.593Z,1742492986.593 [MassServo](DEBUG): Initializing EZServoServo. 2025-03-20T17:49:46.600Z,1742492986.600 [MassServo](DEBUG): Initializing MassServo. 2025-03-20T17:49:46.601Z,1742492986.601 [RudderServo](DEBUG): Initializing EZServoServo. 2025-03-20T17:49:46.620Z,1742492986.620 [RudderServo](DEBUG): Initializing RudderServo. 2025-03-20T17:49:46.621Z,1742492986.621 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-03-20T17:49:46.628Z,1742492986.628 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-03-20T17:49:46.897Z,1742492986.897 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-03-20T17:49:46.897Z,1742492986.897 [DropWeight] Hardware Fault, FailCount= 1 2025-03-20T17:49:46.897Z,1742492986.897 [DropWeight](ERROR): Hardware Fault 2025-03-20T17:49:46.964Z,1742492986.964 [CommandExec](FAULT): Scheduling is paused 2025-03-20T17:49:46.965Z,1742492986.965 [CBIT](INFO): Critical error at 20250320T174946 2025-03-20T17:49:46.965Z,1742492986.965 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-03-20T17:49:46.967Z,1742492986.967 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-03-20T17:49:46.972Z,1742492986.972 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-03-20T17:49:47.281Z,1742492987.281 [CBIT](INFO): Critical error at 20250320T174946 2025-03-20T17:49:50.088Z,1742492990.088 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:50.584Z,1742492990.584 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:50.988Z,1742492990.988 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:51.244Z,1742492991.244 [WetLabsBB2FL] Communications Fault, FailCount= 1 2025-03-20T17:49:51.244Z,1742492991.244 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:49:51.317Z,1742492991.317 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:49:51.652Z,1742492991.652 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:51.744Z,1742492991.744 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:49:52.096Z,1742492992.096 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:52.588Z,1742492992.588 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:52.864Z,1742492992.864 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:49:52.864Z,1742492992.864 [WetLabsBB2FL] No Fault, FailCount= 1 2025-03-20T17:49:52.964Z,1742492992.964 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:49:53.192Z,1742492993.192 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:53.876Z,1742492993.876 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:54.304Z,1742492994.304 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:54.728Z,1742492994.728 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:55.116Z,1742492995.116 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:55.520Z,1742492995.520 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:55.920Z,1742492995.920 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:56.336Z,1742492996.336 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:56.651Z,1742492996.651 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005199 2025-03-20T17:49:56.741Z,1742492996.741 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:57.132Z,1742492997.132 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:57.548Z,1742492997.548 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:57.952Z,1742492997.952 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:58.248Z,1742492998.248 [WetLabsBB2FL] Communications Fault, FailCount= 2 2025-03-20T17:49:58.248Z,1742492998.248 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:49:58.253Z,1742492998.253 [DAT](INFO): DAT read: 2025-03-20T17:49:58.254Z,1742492998.254 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-03-20T17:49:58.356Z,1742492998.356 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:58.448Z,1742492998.448 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:49:58.748Z,1742492998.748 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:49:58.768Z,1742492998.768 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:58.996Z,1742492998.996 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-03-20T17:49:58.996Z,1742492998.996 [CTD_Seabird] Communications Fault, FailCount= 1 2025-03-20T17:49:58.996Z,1742492998.996 [CTD_Seabird](ERROR): Communications Fault 2025-03-20T17:49:59.196Z,1742492999.196 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:59.259Z,1742492999.259 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-03-20T17:49:59.401Z,1742492999.401 [CTD_Seabird](INFO): Powering down 2025-03-20T17:49:59.608Z,1742492999.608 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:49:59.608Z,1742492999.608 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-03-20T17:49:59.608Z,1742492999.608 [AHRS_M2] Communications Fault, FailCount= 1 2025-03-20T17:49:59.608Z,1742492999.608 [AHRS_M2](ERROR): Communications Fault 2025-03-20T17:49:59.765Z,1742492999.765 [DAT](INFO): DAT read: MF Frequency Band 2025-03-20T17:49:59.766Z,1742492999.766 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-03-20T17:49:59.767Z,1742492999.767 [DAT](INFO): DAT read: Mar 20 2025 17:49:55 2025-03-20T17:49:59.816Z,1742492999.816 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-03-20T17:49:59.817Z,1742492999.817 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:49:59.817Z,1742492999.817 [WetLabsBB2FL] No Fault, FailCount= 2 2025-03-20T17:49:59.849Z,1742492999.849 [AHRS_M2](INFO): Powering down 2025-03-20T17:49:59.962Z,1742492999.962 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:50:00.680Z,1742493000.680 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-03-20T17:50:00.680Z,1742493000.680 [AHRS_M2] No Fault, FailCount= 1 2025-03-20T17:50:00.681Z,1742493000.681 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-03-20T17:50:00.681Z,1742493000.681 [CTD_Seabird] No Fault, FailCount= 1 2025-03-20T17:50:00.744Z,1742493000.744 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-20T17:50:00.773Z,1742493000.773 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-03-20T17:50:00.774Z,1742493000.774 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-03-20T17:50:00.775Z,1742493000.775 [DAT](INFO): commRate: 800 2025-03-20T17:50:01.034Z,1742493001.034 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:50:02.840Z,1742493002.840 [DAT](INFO): entering command mode 2025-03-20T17:50:03.040Z,1742493003.040 [DAT](INFO): DAT read: 2025-03-20T17:50:03.041Z,1742493003.041 [DAT](INFO): DAT read: user:1> 2025-03-20T17:50:03.041Z,1742493003.041 [DAT](INFO): setting verbose to 3 2025-03-20T17:50:03.293Z,1742493003.293 [DAT](INFO): DAT read: user:1> 2025-03-20T17:50:03.294Z,1742493003.294 [DAT](INFO): DAT read: Verbose | 3 2025-03-20T17:50:03.294Z,1742493003.294 [DAT](INFO): set verbose to 3 2025-03-20T17:50:03.294Z,1742493003.294 [DAT](INFO): setting DatVerbose to 27440 2025-03-20T17:50:03.545Z,1742493003.545 [DAT](INFO): DAT read: user:2> 2025-03-20T17:50:03.546Z,1742493003.546 [DAT](INFO): DAT read: DatVerbose | 27440 2025-03-20T17:50:03.546Z,1742493003.546 [DAT](INFO): set DatVerbose to 27440 2025-03-20T17:50:03.546Z,1742493003.546 [DAT](INFO): setting transmit power to 8 2025-03-20T17:50:03.797Z,1742493003.797 [DAT](INFO): DAT read: user:3> 2025-03-20T17:50:03.797Z,1742493003.797 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-03-20T17:50:03.798Z,1742493003.798 [DAT](INFO): set transmit power to 8 2025-03-20T17:50:03.798Z,1742493003.798 [DAT](INFO): setting local address to 9 2025-03-20T17:50:04.049Z,1742493004.049 [DAT](INFO): DAT read: user:4> 2025-03-20T17:50:04.049Z,1742493004.049 [DAT](INFO): DAT read: LocalAddr | 9 2025-03-20T17:50:04.050Z,1742493004.050 [DAT](INFO): set local address to 9 2025-03-20T17:50:04.051Z,1742493004.051 [DAT](INFO): Setting time to: 17:50:4 And date to:3/20/2025 2025-03-20T17:50:04.304Z,1742493004.304 [DAT](INFO): DAT read: user:5> 2025-03-20T17:50:04.308Z,1742493004.308 [DAT](INFO): DAT read: Thu Mar 20, 2025 17:50:04 2025-03-20T17:50:04.308Z,1742493004.308 [DAT](INFO): Local DAT time set to Thu Mar 20, 2025 17:50:04 2025-03-20T17:50:04.592Z,1742493004.592 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:04.996Z,1742493004.996 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:05.260Z,1742493005.260 [WetLabsBB2FL] Communications Fault, FailCount= 3 2025-03-20T17:50:05.260Z,1742493005.260 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:50:05.400Z,1742493005.400 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:05.463Z,1742493005.463 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:50:05.760Z,1742493005.760 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:50:05.832Z,1742493005.832 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:06.236Z,1742493006.236 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:06.636Z,1742493006.636 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:06.708Z,1742493006.708 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:50:06.708Z,1742493006.708 [WetLabsBB2FL] No Fault, FailCount= 3 2025-03-20T17:50:06.973Z,1742493006.973 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:50:07.052Z,1742493007.052 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:07.460Z,1742493007.460 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:07.856Z,1742493007.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:08.272Z,1742493008.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:08.672Z,1742493008.672 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:09.080Z,1742493009.080 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:09.564Z,1742493009.564 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:09.968Z,1742493009.968 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:10.372Z,1742493010.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:10.832Z,1742493010.832 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:11.220Z,1742493011.220 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:11.632Z,1742493011.632 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:12.036Z,1742493012.036 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:12.268Z,1742493012.268 [WetLabsBB2FL] Communications Fault, FailCount= 4 2025-03-20T17:50:12.268Z,1742493012.268 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:50:12.444Z,1742493012.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:12.469Z,1742493012.469 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:50:12.768Z,1742493012.768 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:50:12.840Z,1742493012.840 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:13.248Z,1742493013.248 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:13.652Z,1742493013.652 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:13.662Z,1742493013.662 [NAL9602](INFO): Powering up NAL9602 2025-03-20T17:50:13.710Z,1742493013.710 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:50:13.710Z,1742493013.710 [WetLabsBB2FL] No Fault, FailCount= 4 2025-03-20T17:50:13.796Z,1742493013.796 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-03-20T17:50:13.796Z,1742493013.796 [CTD_Seabird] Communications Fault, FailCount= 2 2025-03-20T17:50:13.796Z,1742493013.796 [CTD_Seabird](ERROR): Communications Fault 2025-03-20T17:50:13.981Z,1742493013.981 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:50:14.068Z,1742493014.068 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:14.068Z,1742493014.068 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-03-20T17:50:14.068Z,1742493014.068 [AHRS_M2] Communications Fault, FailCount= 2 2025-03-20T17:50:14.068Z,1742493014.068 [AHRS_M2](ERROR): Communications Fault 2025-03-20T17:50:14.119Z,1742493014.119 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-03-20T17:50:14.119Z,1742493014.119 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-03-20T17:50:14.158Z,1742493014.158 [AHRS_M2](INFO): Powering down 2025-03-20T17:50:14.200Z,1742493014.200 [CTD_Seabird](INFO): Powering down 2025-03-20T17:50:14.550Z,1742493014.550 [Waterlinked](FAULT): Could not initialize. 2025-03-20T17:50:14.550Z,1742493014.550 [Waterlinked] Communications Fault, FailCount= 1 2025-03-20T17:50:14.550Z,1742493014.550 [Waterlinked](ERROR): Communications Fault 2025-03-20T17:50:14.597Z,1742493014.597 [CBIT](ERROR): Communications Fault in component: Waterlinked 2025-03-20T17:50:15.040Z,1742493015.040 [Waterlinked](INFO): Powering down 2025-03-20T17:50:15.061Z,1742493015.061 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-03-20T17:50:15.061Z,1742493015.061 [AHRS_M2] No Fault, FailCount= 2 2025-03-20T17:50:15.354Z,1742493015.354 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:50:15.380Z,1742493015.380 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-03-20T17:50:15.380Z,1742493015.380 [CTD_Seabird] No Fault, FailCount= 2 2025-03-20T17:50:15.544Z,1742493015.544 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-20T17:50:15.789Z,1742493015.789 [CBIT](INFO): Clearing failed state for component Waterlinked 2025-03-20T17:50:15.789Z,1742493015.789 [Waterlinked] No Fault, FailCount= 1 2025-03-20T17:50:18.912Z,1742493018.912 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:19.272Z,1742493019.272 [WetLabsBB2FL] Communications Fault, FailCount= 5 2025-03-20T17:50:19.272Z,1742493019.272 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:50:19.306Z,1742493019.306 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:19.413Z,1742493019.413 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:50:19.413Z,1742493019.413 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:50:19.748Z,1742493019.748 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:19.772Z,1742493019.772 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:50:20.156Z,1742493020.156 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:20.560Z,1742493020.560 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:20.956Z,1742493020.956 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:21.364Z,1742493021.364 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:21.768Z,1742493021.768 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:22.172Z,1742493022.172 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:22.576Z,1742493022.576 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:22.984Z,1742493022.984 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:23.384Z,1742493023.384 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:23.788Z,1742493023.788 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:24.192Z,1742493024.192 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:24.608Z,1742493024.608 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:24.614Z,1742493024.614 [NAL9602](INFO): NAL9602 initialized 2025-03-20T17:50:25.012Z,1742493025.012 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:25.412Z,1742493025.412 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:25.828Z,1742493025.828 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:26.236Z,1742493026.236 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:26.644Z,1742493026.644 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:27.044Z,1742493027.044 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:27.456Z,1742493027.456 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:27.856Z,1742493027.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:28.260Z,1742493028.260 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:28.260Z,1742493028.260 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-03-20T17:50:28.260Z,1742493028.260 [AHRS_M2] Communications Fault, FailCount= 3 2025-03-20T17:50:28.260Z,1742493028.260 [AHRS_M2](ERROR): Communications Fault 2025-03-20T17:50:28.325Z,1742493028.325 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-03-20T17:50:28.351Z,1742493028.351 [AHRS_M2](INFO): Powering down 2025-03-20T17:50:28.596Z,1742493028.596 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-03-20T17:50:28.596Z,1742493028.596 [CTD_Seabird] Communications Fault, FailCount= 3 2025-03-20T17:50:28.596Z,1742493028.596 [CTD_Seabird](ERROR): Communications Fault 2025-03-20T17:50:28.774Z,1742493028.774 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-03-20T17:50:28.775Z,1742493028.775 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2025-03-20T17:50:29.001Z,1742493029.001 [CTD_Seabird](INFO): Powering down 2025-03-20T17:50:29.170Z,1742493029.170 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-03-20T17:50:29.170Z,1742493029.170 [AHRS_M2] No Fault, FailCount= 3 2025-03-20T17:50:29.550Z,1742493029.550 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:50:32.525Z,1742493032.525 [CommandExec](IMPORTANT): got command show stack 2025-03-20T17:50:32.525Z,1742493032.525 [CommandExec](IMPORTANT): Behavior Stack: 2025-03-20T17:50:32.525Z,1742493032.525 [MissionManager](IMPORTANT): Mission loaded, but not running. 2025-03-20T17:50:33.100Z,1742493033.100 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:33.520Z,1742493033.520 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:33.543Z,1742493033.543 [SBIT](IMPORTANT): Beginning Startup BIT 2025-03-20T17:50:33.568Z,1742493033.568 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-03-20T17:50:33.916Z,1742493033.916 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:34.416Z,1742493034.416 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:34.896Z,1742493034.896 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:35.156Z,1742493035.156 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:35.788Z,1742493035.788 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:36.436Z,1742493036.436 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:36.988Z,1742493036.988 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:37.640Z,1742493037.640 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:38.284Z,1742493038.284 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:38.900Z,1742493038.900 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:39.524Z,1742493039.524 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-03-20T17:50:39.605Z,1742493039.605 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.018958 CHAN A1 (24V): 0.000631 CHAN A2 (12V): -0.005641 CHAN A3 (5V): -0.002777 CHAN B0 (3.3V): -0.001187 CHAN B1 (3.15aV): -0.000990 CHAN B2 (3.15bV): -0.001470 CHAN B3 (GND): 0.000027 OPEN: 0.005295 Full Scale: +/- 1 mA 2025-03-20T17:50:40.340Z,1742493040.340 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:40.748Z,1742493040.748 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:41.152Z,1742493041.152 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:41.556Z,1742493041.556 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:41.964Z,1742493041.964 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:42.368Z,1742493042.368 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:42.772Z,1742493042.772 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:42.772Z,1742493042.772 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-03-20T17:50:42.772Z,1742493042.772 [AHRS_M2] Communications Fault, FailCount= 4 2025-03-20T17:50:42.772Z,1742493042.772 [AHRS_M2](ERROR): Communications Fault 2025-03-20T17:50:42.865Z,1742493042.865 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-03-20T17:50:42.874Z,1742493042.874 [AHRS_M2](INFO): Powering down 2025-03-20T17:50:43.740Z,1742493043.740 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-03-20T17:50:43.740Z,1742493043.740 [AHRS_M2] No Fault, FailCount= 4 2025-03-20T17:50:44.082Z,1742493044.082 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:50:44.494Z,1742493044.494 [Waterlinked](FAULT): Could not initialize. 2025-03-20T17:50:44.494Z,1742493044.494 [Waterlinked] Communications Fault, FailCount= 2 2025-03-20T17:50:44.494Z,1742493044.494 [Waterlinked](ERROR): Communications Fault 2025-03-20T17:50:44.573Z,1742493044.573 [CBIT](ERROR): Communications Fault in component: Waterlinked 2025-03-20T17:50:44.984Z,1742493044.984 [Waterlinked](INFO): Powering down 2025-03-20T17:50:45.745Z,1742493045.745 [CBIT](INFO): Clearing failed state for component Waterlinked 2025-03-20T17:50:45.746Z,1742493045.746 [Waterlinked] No Fault, FailCount= 2 2025-03-20T17:50:47.640Z,1742493047.640 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:48.036Z,1742493048.036 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:48.444Z,1742493048.444 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:48.844Z,1742493048.844 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:49.640Z,1742493049.640 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:50.212Z,1742493050.212 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:50.676Z,1742493050.676 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:51.136Z,1742493051.136 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:51.604Z,1742493051.604 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:52.056Z,1742493052.056 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:52.528Z,1742493052.528 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:53.008Z,1742493053.008 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:53.480Z,1742493053.480 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:54.008Z,1742493054.008 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:54.632Z,1742493054.632 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:55.134Z,1742493055.134 [CommandExec](IMPORTANT): got command set platform_communications 1 bool 2025-03-20T17:50:55.300Z,1742493055.300 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:55.720Z,1742493055.720 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:56.124Z,1742493056.124 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:56.532Z,1742493056.532 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:56.940Z,1742493056.940 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:50:56.940Z,1742493056.940 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-03-20T17:50:56.940Z,1742493056.940 [AHRS_M2] Communications Fault, FailCount= 5 2025-03-20T17:50:56.940Z,1742493056.940 [AHRS_M2](ERROR): Communications Fault 2025-03-20T17:50:57.017Z,1742493057.017 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-03-20T17:50:57.017Z,1742493057.017 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2025-03-20T17:50:57.042Z,1742493057.042 [AHRS_M2](INFO): Powering down 2025-03-20T17:50:57.163Z,1742493057.163 [CBIT](INFO): Critical error at 20250320T175057 2025-03-20T17:51:14.421Z,1742493074.421 [Waterlinked](FAULT): Could not initialize. 2025-03-20T17:51:14.421Z,1742493074.421 [Waterlinked] Communications Fault, FailCount= 3 2025-03-20T17:51:14.421Z,1742493074.421 [Waterlinked](ERROR): Communications Fault 2025-03-20T17:51:14.525Z,1742493074.525 [CBIT](ERROR): Communications Fault in component: Waterlinked 2025-03-20T17:51:14.525Z,1742493074.525 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2025-03-20T17:51:14.912Z,1742493074.912 [Waterlinked](INFO): Powering down 2025-03-20T17:51:14.947Z,1742493074.947 [CBIT](INFO): Critical error at 20250320T175114 2025-03-20T17:51:19.090Z,1742493079.090 [CommandExec](IMPORTANT): got command set platform_communications 1 bool 2025-03-20T17:51:25.557Z,1742493085.557 [CommandExec](IMPORTANT): got command show stack 2025-03-20T17:51:25.557Z,1742493085.557 [CommandExec](IMPORTANT): Behavior Stack: 2025-03-20T17:51:25.557Z,1742493085.557 [MissionManager](IMPORTANT): Mission loaded, but not running. 2025-03-20T17:51:27.383Z,1742493087.383 [SBIT](IMPORTANT): SBIT PASSED 2025-03-20T17:51:27.383Z,1742493087.383 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-03-20T17:51:27.384Z,1742493087.384 [SBIT](IMPORTANT): BuoyancyServo.limitLo=490 count; 2025-03-20T17:51:27.384Z,1742493087.384 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 10.000000 meter; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=1 bool; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=0 bool; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=373.087254 cubic_centimeter; 2025-03-20T17:51:27.385Z,1742493087.385 [SBIT](IMPORTANT): VerticalControl.elevDeadband=0.1 degree; 2025-03-20T17:51:27.386Z,1742493087.386 [SBIT](IMPORTANT): VerticalControl.kdDepth=0.2 radian_per_second_per_meter; 2025-03-20T17:51:27.386Z,1742493087.386 [SBIT](IMPORTANT): VerticalControl.kpDepth=0.15 radian_per_meter; 2025-03-20T17:51:27.386Z,1742493087.386 [SBIT](IMPORTANT): VerticalControl.massDefault=6.846363 millimeter; 2025-03-20T17:51:27.784Z,1742493087.784 [MissionManager](IMPORTANT): Started mission Startup 2025-03-20T17:51:27.784Z,1742493087.784 [Startup] Running Loop=1 2025-03-20T17:51:27.784Z,1742493087.784 [Startup](DEBUG): Aggregate::initialize Startup 2025-03-20T17:51:27.785Z,1742493087.785 [Startup:A.GoToSurface] Running Loop=1 2025-03-20T17:51:27.785Z,1742493087.785 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-20T17:51:27.785Z,1742493087.785 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-03-20T17:51:27.786Z,1742493087.786 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-03-20T17:51:27.786Z,1742493087.786 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-03-20T17:51:27.786Z,1742493087.786 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-03-20T17:51:27.787Z,1742493087.787 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-20T17:51:27.787Z,1742493087.787 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-20T17:51:27.813Z,1742493087.813 [Startup:StartupSatComms] Running Loop=1 2025-03-20T17:51:27.813Z,1742493087.813 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-03-20T17:51:27.813Z,1742493087.813 [Startup:StartupSatComms:A] Running Loop=1 2025-03-20T17:51:28.182Z,1742493088.182 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-03-20T17:51:42.119Z,1742493102.119 [CommandExec](IMPORTANT): got command set platform_communications 1 bool 2025-03-20T17:51:46.081Z,1742493106.081 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-03-20T17:51:46.081Z,1742493106.081 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-03-20T17:51:46.081Z,1742493106.081 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-20T17:51:46.121Z,1742493106.121 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-20T17:51:46.528Z,1742493106.528 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-20T17:51:46.528Z,1742493106.528 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-03-20T17:51:53.634Z,1742493113.634 [CommandExec](IMPORTANT): got command set platform_communications 1 bool 2025-03-20T17:52:28.006Z,1742493148.006 [CommandExec](IMPORTANT): got command show stack 2025-03-20T17:52:28.006Z,1742493148.006 [CommandExec](IMPORTANT): Behavior Stack: 2025-03-20T17:52:28.006Z,1742493148.006 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface 2025-03-20T17:52:28.007Z,1742493148.007 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A 2025-03-20T17:52:28.115Z,1742493148.115 [Startup:StartupSatComms:A](INFO): Timed out from 2025-03-20T17:51:27.8Z 2025-03-20T17:52:28.115Z,1742493148.115 [Startup:StartupSatComms:A] Stopped 2025-03-20T17:52:28.115Z,1742493148.115 [Startup:StartupSatComms:B] Running Loop=1 2025-03-20T17:52:28.637Z,1742493148.637 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-03-20T17:52:35.693Z,1742493155.693 [DataOverHttps](INFO): Sending 109 bytes from file Logs/20250320T171437/Courier0010.lzma 2025-03-20T17:52:36.694Z,1742493156.694 [DataOverHttps](INFO): Moved sent file to Logs/20250320T171437/Courier0010.lzma.bak 2025-03-20T17:52:36.694Z,1742493156.694 [DataOverHttps](INFO): SBD MOMSN=24424989 2025-03-20T17:52:41.308Z,1742493161.308 [CommandExec](IMPORTANT): got command set platform_communications 1 bool 2025-03-20T17:52:49.598Z,1742493169.598 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:52:49.598Z,1742493169.598 [WetLabsBB2FL] No Fault, FailCount= 5 2025-03-20T17:52:49.837Z,1742493169.837 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:52:53.822Z,1742493173.822 [CommandExec](IMPORTANT): got command set platform_communications 1 bool 2025-03-20T17:52:55.128Z,1742493175.128 [WetLabsBB2FL] Communications Fault, FailCount= 1 2025-03-20T17:52:55.128Z,1742493175.128 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:52:55.258Z,1742493175.258 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:52:55.632Z,1742493175.632 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:52:55.992Z,1742493175.992 [DataOverHttps](INFO): Sending 286 bytes from file Logs/20250320T174934/Courier0000.lzma 2025-03-20T17:52:56.825Z,1742493176.825 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:52:56.826Z,1742493176.826 [WetLabsBB2FL] No Fault, FailCount= 1 2025-03-20T17:52:56.845Z,1742493176.845 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:52:56.994Z,1742493176.994 [DataOverHttps](INFO): Moved sent file to Logs/20250320T174934/Courier0000.lzma.bak 2025-03-20T17:52:56.994Z,1742493176.994 [DataOverHttps](INFO): SBD MOMSN=24424995 2025-03-20T17:52:58.826Z,1742493178.826 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-03-20T17:52:58.827Z,1742493178.827 [CTD_Seabird] No Fault, FailCount= 3 2025-03-20T17:52:59.152Z,1742493179.152 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-20T17:53:02.148Z,1742493182.148 [WetLabsBB2FL] Communications Fault, FailCount= 2 2025-03-20T17:53:02.148Z,1742493182.148 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:53:02.469Z,1742493182.469 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:53:02.648Z,1742493182.648 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:53:03.682Z,1742493183.682 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:53:03.682Z,1742493183.682 [WetLabsBB2FL] No Fault, FailCount= 2 2025-03-20T17:53:03.861Z,1742493183.861 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:53:09.152Z,1742493189.152 [WetLabsBB2FL] Communications Fault, FailCount= 3 2025-03-20T17:53:09.152Z,1742493189.152 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:53:09.206Z,1742493189.206 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:53:09.652Z,1742493189.652 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:53:10.570Z,1742493190.570 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:53:10.570Z,1742493190.570 [WetLabsBB2FL] No Fault, FailCount= 3 2025-03-20T17:53:10.872Z,1742493190.872 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:53:12.217Z,1742493192.217 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-03-20T17:53:12.217Z,1742493192.217 [CTD_Seabird] Communications Fault, FailCount= 1 2025-03-20T17:53:12.217Z,1742493192.217 [CTD_Seabird](ERROR): Communications Fault 2025-03-20T17:53:12.563Z,1742493192.563 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-03-20T17:53:12.620Z,1742493192.620 [CTD_Seabird](INFO): Powering down 2025-03-20T17:53:12.912Z,1742493192.912 [DataOverHttps](INFO): Sending 376 bytes from file Logs/20250320T171437/Express0011.lzma 2025-03-20T17:53:13.787Z,1742493193.787 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-03-20T17:53:13.787Z,1742493193.787 [CTD_Seabird] No Fault, FailCount= 1 2025-03-20T17:53:13.914Z,1742493193.914 [DataOverHttps](INFO): Moved sent file to Logs/20250320T171437/Express0011.lzma.bak 2025-03-20T17:53:13.914Z,1742493193.914 [DataOverHttps](INFO): SBD MOMSN=24425002 2025-03-20T17:53:13.964Z,1742493193.964 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-20T17:53:16.168Z,1742493196.168 [WetLabsBB2FL] Communications Fault, FailCount= 4 2025-03-20T17:53:16.168Z,1742493196.168 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:53:16.243Z,1742493196.243 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:53:16.676Z,1742493196.676 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:53:17.819Z,1742493197.819 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:53:17.819Z,1742493197.819 [WetLabsBB2FL] No Fault, FailCount= 4 2025-03-20T17:53:17.890Z,1742493197.890 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:53:19.981Z,1742493199.981 [CommandExec](IMPORTANT): got command show stack 2025-03-20T17:53:19.981Z,1742493199.981 [CommandExec](IMPORTANT): Behavior Stack: 2025-03-20T17:53:19.981Z,1742493199.981 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface 2025-03-20T17:53:19.982Z,1742493199.982 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B 2025-03-20T17:53:23.180Z,1742493203.180 [WetLabsBB2FL] Communications Fault, FailCount= 5 2025-03-20T17:53:23.180Z,1742493203.180 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:53:23.499Z,1742493203.499 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:53:23.499Z,1742493203.499 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:53:23.680Z,1742493203.680 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:53:27.024Z,1742493207.024 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-03-20T17:53:27.024Z,1742493207.024 [CTD_Seabird] Communications Fault, FailCount= 2 2025-03-20T17:53:27.024Z,1742493207.024 [CTD_Seabird](ERROR): Communications Fault 2025-03-20T17:53:27.198Z,1742493207.198 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-03-20T17:53:27.428Z,1742493207.428 [CTD_Seabird](INFO): Powering down 2025-03-20T17:53:28.328Z,1742493208.328 [Startup:StartupSatComms:B](INFO): Timed out from 2025-03-20T17:52:28.1Z 2025-03-20T17:53:28.328Z,1742493208.328 [Startup:StartupSatComms:B] Stopped 2025-03-20T17:53:28.329Z,1742493208.329 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-03-20T17:53:28.329Z,1742493208.329 [Startup:StartupSatComms] Stopped 2025-03-20T17:53:28.329Z,1742493208.329 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-03-20T17:53:28.330Z,1742493208.330 [Startup](INFO): Completed Startup 2025-03-20T17:53:28.330Z,1742493208.330 [MissionManager](INFO): Startup is completed. 2025-03-20T17:53:28.330Z,1742493208.330 [MissionManager](INFO): Uninitializing Mission Startup 2025-03-20T17:53:28.330Z,1742493208.330 [Startup] Stopped 2025-03-20T17:53:28.330Z,1742493208.330 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-03-20T17:53:28.330Z,1742493208.330 [Startup:A.GoToSurface] Stopped 2025-03-20T17:53:28.330Z,1742493208.330 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-20T17:53:28.720Z,1742493208.720 [MissionManager](IMPORTANT): Started mission Default 2025-03-20T17:53:28.720Z,1742493208.720 [Default] Running Loop=1 2025-03-20T17:53:28.720Z,1742493208.720 [Default](DEBUG): Aggregate::initialize Default 2025-03-20T17:53:28.720Z,1742493208.720 [Default:B.GoToSurface] Running Loop=1 2025-03-20T17:53:28.721Z,1742493208.721 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-20T17:53:28.721Z,1742493208.721 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-03-20T17:53:28.721Z,1742493208.721 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-03-20T17:53:28.721Z,1742493208.721 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-03-20T17:53:28.722Z,1742493208.722 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-03-20T17:53:28.722Z,1742493208.722 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-20T17:53:28.722Z,1742493208.722 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-20T17:53:28.722Z,1742493208.722 [Default:A.Wait] Running Loop=1 2025-03-20T17:53:28.723Z,1742493208.723 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-03-20T17:53:28.733Z,1742493208.733 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-03-20T17:53:28.733Z,1742493208.733 [CTD_Seabird] No Fault, FailCount= 2 2025-03-20T17:53:28.772Z,1742493208.772 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-20T17:53:29.561Z,1742493209.561 [DataOverHttps](INFO): Sending 1438 bytes from file Logs/20250320T174934/Express0001.lzma 2025-03-20T17:53:30.558Z,1742493210.558 [DataOverHttps](INFO): Moved sent file to Logs/20250320T174934/Express0001.lzma.bak 2025-03-20T17:53:30.558Z,1742493210.558 [DataOverHttps](INFO): SBD MOMSN=24425024 2025-03-20T17:53:34.719Z,1742493214.719 [CommandExec](IMPORTANT): got command run ./Missions/Engineering/multiray_test.tl 2025-03-20T17:53:34.719Z,1742493214.719 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/multiray_test.tl 2025-03-20T17:53:34.719Z,1742493214.719 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/multiray_test.tl 2025-03-20T17:53:34.724Z,1742493214.724 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/multiray_test.tl 2025-03-20T17:53:35.361Z,1742493215.361 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/multiray_test.tl translated into: 5 5 0 1 2 2025-03-20T17:53:35.375Z,1742493215.375 [MissionManager](INFO): DefineArg multiray_test.MissionTimeout = 5.000000 min 2025-03-20T17:53:35.394Z,1742493215.394 [MissionManager](INFO): DefineArg multiray_test.LightDuration = 5.000000 s 2025-03-20T17:53:35.402Z,1742493215.402 [MissionManager](INFO): DefineArg multiray_test.LightMode0 = 0.000000 count 2025-03-20T17:53:35.414Z,1742493215.414 [MissionManager](INFO): DefineArg multiray_test.LightMode1 = 1.000000 count 2025-03-20T17:53:35.441Z,1742493215.441 [MissionManager](INFO): DefineArg multiray_test.LightMode2 = 2.000000 count 2025-03-20T17:53:35.449Z,1742493215.449 [MissionManager](INFO): DefineArg multiray_test.EnabledMultiray = 1 bool 2025-03-20T17:53:35.457Z,1742493215.457 [multiray_test:C.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.465Z,1742493215.465 [multiray_test:E.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.475Z,1742493215.475 [multiray_test:G.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.482Z,1742493215.482 [multiray_test:I.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.493Z,1742493215.493 [multiray_test:K.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.505Z,1742493215.505 [multiray_test:M.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.532Z,1742493215.532 [multiray_test:O.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.535Z,1742493215.535 [multiray_test:Q.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.554Z,1742493215.554 [multiray_test:R.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.610Z,1742493215.610 [multiray_test:T.Wait](DEBUG): Construct Wait. 2025-03-20T17:53:35.627Z,1742493215.627 [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 multiray_test { """ This mission is designed to run in the lab only. Cycles through MultiRay light modes """ arguments { MissionTimeout = 5 minute """ How long to let the mission run. """ LightDuration = 5 second """ How long to wait before changing light modes """ LightMode0 = 0 count """ Light mode = 0 """ LightMode1 = 1 count """ Light mode = 1 """ LightMode2 = 2 count """ Light mode = 2 """ EnabledMultiray = Sensor:MultiRay.loadAtStartup """ Automatically set to true if the Multiray is enabled. """ } timeout duration=MissionTimeout readData strategy="MinError" { while ( EnabledMultiray ) Sensor:MultiRay.lightModeLog } # # # assign in sequence Sensor:MultiRay.lightModeCommand = LightMode0 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode1 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode2 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode0 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode1 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode2 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode0 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode1 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode2 behavior Guidance:Wait { run in sequence set duration = LightDuration } assign in sequence Sensor:MultiRay.lightModeCommand = LightMode0 behavior Guidance:Wait { run in sequence set duration = LightDuration } } 2025-03-20T17:53:35.641Z,1742493215.641 [CommandExec](IMPORTANT): Running ./Missions/Engineering/multiray_test.tl 2025-03-20T17:53:36.253Z,1742493216.253 [Default] Stopped 2025-03-20T17:53:36.253Z,1742493216.253 [Default](DEBUG): Aggregate::uninitialize Default 2025-03-20T17:53:36.253Z,1742493216.253 [Default:A.Wait] Stopped 2025-03-20T17:53:36.253Z,1742493216.253 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-03-20T17:53:36.253Z,1742493216.253 [Default:B.GoToSurface] Stopped 2025-03-20T17:53:36.253Z,1742493216.253 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-20T17:53:36.254Z,1742493216.254 [MissionManager](IMPORTANT): Started mission multiray_test 2025-03-20T17:53:36.254Z,1742493216.254 [multiray_test] Running Loop=1 2025-03-20T17:53:36.254Z,1742493216.254 [multiray_test](DEBUG): Aggregate::initialize multiray_test 2025-03-20T17:53:36.254Z,1742493216.254 [multiray_test:A] Running Loop=1 2025-03-20T17:53:36.254Z,1742493216.254 [multiray_test:B] Running Loop=1 2025-03-20T17:53:36.255Z,1742493216.255 [multiray_test:B] Stopped 2025-03-20T17:53:36.255Z,1742493216.255 [multiray_test:C.Wait] Running Loop=1 2025-03-20T17:53:36.255Z,1742493216.255 [multiray_test:C.Wait](DEBUG): Initialize Wait Component. 2025-03-20T17:53:36.255Z,1742493216.255 [multiray_test:A] Running Loop=1 2025-03-20T17:53:36.278Z,1742493216.278 [multiray_test:A](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog 2025-03-20T17:53:37.657Z,1742493217.657 [MultiRay](INFO): All lights off failed! Try again next cycle 2025-03-20T17:53:38.469Z,1742493218.469 [MultiRay](INFO): All lights off failed! Try again next cycle 2025-03-20T17:53:39.277Z,1742493219.277 [MultiRay](INFO): All lights off failed! Try again next cycle 2025-03-20T17:53:40.085Z,1742493220.085 [MultiRay](INFO): All lights off failed! Try again next cycle 2025-03-20T17:53:40.894Z,1742493220.894 [MultiRay](INFO): All lights off failed! Try again next cycle 2025-03-20T17:53:41.701Z,1742493221.701 [MultiRay](INFO): All lights off failed! Try again next cycle 2025-03-20T17:53:41.749Z,1742493221.749 [multiray_test:C.Wait](INFO): Done Waiting. 2025-03-20T17:53:41.749Z,1742493221.749 [multiray_test:C.Wait] Stopped 2025-03-20T17:53:41.749Z,1742493221.749 [multiray_test:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-20T17:53:41.750Z,1742493221.750 [multiray_test:D] Running Loop=1 2025-03-20T17:53:41.836Z,1742493221.836 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-03-20T17:53:41.836Z,1742493221.836 [CTD_Seabird] Communications Fault, FailCount= 3 2025-03-20T17:53:41.836Z,1742493221.836 [CTD_Seabird](ERROR): Communications Fault 2025-03-20T17:53:42.159Z,1742493222.159 [multiray_test:D] Stopped 2025-03-20T17:53:42.159Z,1742493222.159 [multiray_test:E.Wait] Running Loop=1 2025-03-20T17:53:42.160Z,1742493222.160 [multiray_test:E.Wait](DEBUG): Initialize Wait Component. 2025-03-20T17:53:42.169Z,1742493222.169 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-03-20T17:53:42.169Z,1742493222.169 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2025-03-20T17:53:42.240Z,1742493222.240 [CTD_Seabird](INFO): Powering down 2025-03-20T17:53:46.976Z,1742493226.976 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-03-20T17:53:46.977Z,1742493226.977 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-03-20T17:53:46.977Z,1742493226.977 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-20T17:53:46.987Z,1742493226.987 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-20T17:53:47.421Z,1742493227.421 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-20T17:53:47.421Z,1742493227.421 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-03-20T17:53:47.789Z,1742493227.789 [multiray_test:E.Wait](INFO): Done Waiting. 2025-03-20T17:53:47.789Z,1742493227.789 [multiray_test:E.Wait] Stopped 2025-03-20T17:53:47.789Z,1742493227.789 [multiray_test:E.Wait](DEBUG): Uninitialize Wait Component. 2025-03-20T17:53:47.789Z,1742493227.789 [multiray_test:F] Running Loop=1 2025-03-20T17:53:48.214Z,1742493228.214 [multiray_test:F] Stopped 2025-03-20T17:53:48.214Z,1742493228.214 [multiray_test:G.Wait] Running Loop=1 2025-03-20T17:53:48.214Z,1742493228.214 [multiray_test:G.Wait](DEBUG): Initialize Wait Component. 2025-03-20T17:53:50.017Z,1742493230.017 [CommandExec](IMPORTANT): got command stop 2025-03-20T17:53:50.017Z,1742493230.017 [CommandExec](IMPORTANT): Scheduling is paused 2025-03-20T17:53:50.017Z,1742493230.017 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2025-03-20T17:53:50.257Z,1742493230.257 [MissionManager](INFO): MissionManager is completed. 2025-03-20T17:53:50.257Z,1742493230.257 [MissionManager](INFO): Uninitializing Mission multiray_test 2025-03-20T17:53:50.257Z,1742493230.257 [multiray_test] Stopped 2025-03-20T17:53:50.257Z,1742493230.257 [multiray_test](DEBUG): Aggregate::uninitialize multiray_test 2025-03-20T17:53:50.257Z,1742493230.257 [multiray_test:A] Stopped 2025-03-20T17:53:50.257Z,1742493230.257 [multiray_test:G.Wait] Stopped 2025-03-20T17:53:50.257Z,1742493230.257 [multiray_test:G.Wait](DEBUG): Uninitialize Wait Component. 2025-03-20T17:53:50.624Z,1742493230.624 [MissionManager](IMPORTANT): Started mission Default 2025-03-20T17:53:50.624Z,1742493230.624 [Default] Running Loop=1 2025-03-20T17:53:50.625Z,1742493230.625 [Default](DEBUG): Aggregate::initialize Default 2025-03-20T17:53:50.625Z,1742493230.625 [Default:B.GoToSurface] Running Loop=1 2025-03-20T17:53:50.625Z,1742493230.625 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-20T17:53:50.625Z,1742493230.625 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-03-20T17:53:50.625Z,1742493230.625 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-03-20T17:53:50.625Z,1742493230.625 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-03-20T17:53:50.626Z,1742493230.626 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-03-20T17:53:50.626Z,1742493230.626 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-20T17:53:50.626Z,1742493230.626 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-20T17:53:50.627Z,1742493230.627 [Default:A.Wait] Running Loop=1 2025-03-20T17:53:50.627Z,1742493230.627 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-03-20T17:54:03.957Z,1742493243.957 [Default:A.Wait](INFO): Done Waiting. 2025-03-20T17:54:03.957Z,1742493243.957 [Default:A.Wait] Stopped 2025-03-20T17:54:03.957Z,1742493243.957 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-03-20T17:54:04.334Z,1742493244.334 [Default:CheckIn] Running Loop=1 2025-03-20T17:54:04.334Z,1742493244.334 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-20T17:54:04.334Z,1742493244.334 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-20T17:54:04.741Z,1742493244.741 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-03-20T17:54:14.442Z,1742493254.442 [CBIT](INFO): Clearing failed state for component Waterlinked 2025-03-20T17:54:14.442Z,1742493254.442 [Waterlinked] No Fault, FailCount= 3 2025-03-20T17:54:43.226Z,1742493283.226 [Waterlinked](FAULT): Could not initialize. 2025-03-20T17:54:43.226Z,1742493283.226 [Waterlinked] Communications Fault, FailCount= 1 2025-03-20T17:54:43.226Z,1742493283.226 [Waterlinked](ERROR): Communications Fault 2025-03-20T17:54:43.241Z,1742493283.241 [CBIT](ERROR): Communications Fault in component: Waterlinked 2025-03-20T17:54:43.608Z,1742493283.608 [Waterlinked](INFO): Powering down 2025-03-20T17:54:44.391Z,1742493284.391 [CBIT](INFO): Clearing failed state for component Waterlinked 2025-03-20T17:54:44.391Z,1742493284.391 [Waterlinked] No Fault, FailCount= 1 2025-03-20T17:55:13.007Z,1742493313.007 [Waterlinked](FAULT): Could not initialize. 2025-03-20T17:55:13.007Z,1742493313.007 [Waterlinked] Communications Fault, FailCount= 2 2025-03-20T17:55:13.007Z,1742493313.007 [Waterlinked](ERROR): Communications Fault 2025-03-20T17:55:13.022Z,1742493313.022 [CBIT](ERROR): Communications Fault in component: Waterlinked 2025-03-20T17:55:13.496Z,1742493313.496 [Waterlinked](INFO): Powering down 2025-03-20T17:55:14.241Z,1742493314.241 [CBIT](INFO): Clearing failed state for component Waterlinked 2025-03-20T17:55:14.241Z,1742493314.241 [Waterlinked] No Fault, FailCount= 2 2025-03-20T17:55:27.145Z,1742493327.145 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-20T17:55:42.917Z,1742493342.917 [Waterlinked](FAULT): Could not initialize. 2025-03-20T17:55:42.917Z,1742493342.917 [Waterlinked] Communications Fault, FailCount= 3 2025-03-20T17:55:42.917Z,1742493342.917 [Waterlinked](ERROR): Communications Fault 2025-03-20T17:55:42.939Z,1742493342.939 [CBIT](ERROR): Communications Fault in component: Waterlinked 2025-03-20T17:55:42.939Z,1742493342.939 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2025-03-20T17:55:43.400Z,1742493343.400 [Waterlinked](INFO): Powering down 2025-03-20T17:55:43.440Z,1742493343.440 [CommandExec](FAULT): Scheduling is paused 2025-03-20T17:55:43.441Z,1742493343.441 [CBIT](INFO): Critical error at 20250320T175542 2025-03-20T17:55:48.180Z,1742493348.180 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-03-20T17:55:48.180Z,1742493348.180 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-03-20T17:55:48.180Z,1742493348.180 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-20T17:55:48.192Z,1742493348.192 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-20T17:55:48.594Z,1742493348.594 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-20T17:55:48.594Z,1742493348.594 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-03-20T17:55:53.422Z,1742493353.422 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:55:53.422Z,1742493353.422 [WetLabsBB2FL] No Fault, FailCount= 5 2025-03-20T17:55:53.565Z,1742493353.565 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:55:57.097Z,1742493357.097 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-03-20T17:55:57.098Z,1742493357.098 [AHRS_M2] No Fault, FailCount= 5 2025-03-20T17:55:57.439Z,1742493357.439 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:55:58.856Z,1742493358.856 [WetLabsBB2FL] Communications Fault, FailCount= 1 2025-03-20T17:55:58.856Z,1742493358.856 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:55:59.081Z,1742493359.081 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:55:59.356Z,1742493359.356 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:56:00.320Z,1742493360.320 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:56:00.320Z,1742493360.320 [WetLabsBB2FL] No Fault, FailCount= 1 2025-03-20T17:56:00.569Z,1742493360.569 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:56:00.996Z,1742493360.996 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:01.392Z,1742493361.392 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:01.828Z,1742493361.828 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:02.212Z,1742493362.212 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:02.628Z,1742493362.628 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:03.040Z,1742493363.040 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:03.464Z,1742493363.464 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:03.872Z,1742493363.872 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:04.276Z,1742493364.276 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:04.680Z,1742493364.680 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:05.084Z,1742493365.084 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:05.492Z,1742493365.492 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:05.860Z,1742493365.860 [WetLabsBB2FL] Communications Fault, FailCount= 2 2025-03-20T17:56:05.860Z,1742493365.860 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:56:05.900Z,1742493365.900 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:05.942Z,1742493365.942 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:56:06.292Z,1742493366.292 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:06.360Z,1742493366.360 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:56:06.688Z,1742493366.688 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:07.100Z,1742493367.100 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:07.508Z,1742493367.508 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:07.558Z,1742493367.558 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:56:07.558Z,1742493367.558 [WetLabsBB2FL] No Fault, FailCount= 2 2025-03-20T17:56:07.573Z,1742493367.573 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:56:07.904Z,1742493367.904 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:08.320Z,1742493368.320 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:08.720Z,1742493368.720 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:09.128Z,1742493369.128 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:09.532Z,1742493369.532 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:09.932Z,1742493369.932 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:10.336Z,1742493370.336 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:10.336Z,1742493370.336 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-03-20T17:56:10.336Z,1742493370.336 [AHRS_M2] Communications Fault, FailCount= 1 2025-03-20T17:56:10.336Z,1742493370.336 [AHRS_M2](ERROR): Communications Fault 2025-03-20T17:56:10.376Z,1742493370.376 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-03-20T17:56:10.421Z,1742493370.421 [AHRS_M2](INFO): Powering down 2025-03-20T17:56:11.272Z,1742493371.272 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-03-20T17:56:11.272Z,1742493371.272 [AHRS_M2] No Fault, FailCount= 1 2025-03-20T17:56:11.626Z,1742493371.626 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:56:12.055Z,1742493372.055 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-03-20T17:56:12.055Z,1742493372.055 [CTD_Seabird] No Fault, FailCount= 3 2025-03-20T17:56:12.272Z,1742493372.272 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-20T17:56:12.868Z,1742493372.868 [WetLabsBB2FL] Communications Fault, FailCount= 3 2025-03-20T17:56:12.868Z,1742493372.868 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:56:12.877Z,1742493372.877 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:56:13.364Z,1742493373.364 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:56:14.489Z,1742493374.489 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:56:14.489Z,1742493374.489 [WetLabsBB2FL] No Fault, FailCount= 3 2025-03-20T17:56:14.578Z,1742493374.578 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:56:15.184Z,1742493375.184 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:15.592Z,1742493375.592 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:15.992Z,1742493375.992 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:16.392Z,1742493376.392 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:16.800Z,1742493376.800 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:17.248Z,1742493377.248 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:17.640Z,1742493377.640 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:18.048Z,1742493378.048 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:18.460Z,1742493378.460 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:18.860Z,1742493378.860 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:19.252Z,1742493379.252 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:19.660Z,1742493379.660 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:19.872Z,1742493379.872 [WetLabsBB2FL] Communications Fault, FailCount= 4 2025-03-20T17:56:19.872Z,1742493379.872 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:56:20.064Z,1742493380.064 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:20.089Z,1742493380.089 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:56:20.372Z,1742493380.372 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:56:20.464Z,1742493380.464 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:20.868Z,1742493380.868 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:21.272Z,1742493381.272 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:21.318Z,1742493381.318 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-03-20T17:56:21.318Z,1742493381.318 [WetLabsBB2FL] No Fault, FailCount= 4 2025-03-20T17:56:21.585Z,1742493381.585 [WetLabsBB2FL](INFO): Powering up 2025-03-20T17:56:21.684Z,1742493381.684 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:22.084Z,1742493382.084 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:22.480Z,1742493382.480 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:22.892Z,1742493382.892 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:23.300Z,1742493383.300 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:23.712Z,1742493383.712 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:24.104Z,1742493384.104 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:24.508Z,1742493384.508 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:24.508Z,1742493384.508 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-03-20T17:56:24.508Z,1742493384.508 [AHRS_M2] Communications Fault, FailCount= 2 2025-03-20T17:56:24.508Z,1742493384.508 [AHRS_M2](ERROR): Communications Fault 2025-03-20T17:56:24.549Z,1742493384.549 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-03-20T17:56:24.586Z,1742493384.586 [AHRS_M2](INFO): Powering down 2025-03-20T17:56:25.324Z,1742493385.324 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-03-20T17:56:25.324Z,1742493385.324 [CTD_Seabird] Communications Fault, FailCount= 1 2025-03-20T17:56:25.324Z,1742493385.324 [CTD_Seabird](ERROR): Communications Fault 2025-03-20T17:56:25.438Z,1742493385.438 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-03-20T17:56:25.438Z,1742493385.438 [AHRS_M2] No Fault, FailCount= 2 2025-03-20T17:56:25.439Z,1742493385.439 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-03-20T17:56:25.728Z,1742493385.728 [CTD_Seabird](INFO): Powering down 2025-03-20T17:56:25.798Z,1742493385.798 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:56:26.876Z,1742493386.876 [WetLabsBB2FL] Communications Fault, FailCount= 5 2025-03-20T17:56:26.876Z,1742493386.876 [WetLabsBB2FL](ERROR): Communications Fault 2025-03-20T17:56:27.037Z,1742493387.037 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-03-20T17:56:27.037Z,1742493387.037 [CTD_Seabird] No Fault, FailCount= 1 2025-03-20T17:56:27.037Z,1742493387.037 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:56:27.038Z,1742493387.038 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2025-03-20T17:56:27.072Z,1742493387.072 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-20T17:56:27.376Z,1742493387.376 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:56:29.348Z,1742493389.348 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:29.752Z,1742493389.752 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:30.164Z,1742493390.164 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:30.572Z,1742493390.572 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:31.084Z,1742493391.084 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:31.512Z,1742493391.512 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:31.912Z,1742493391.912 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:32.316Z,1742493392.316 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:32.712Z,1742493392.712 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:33.128Z,1742493393.128 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:33.544Z,1742493393.544 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:33.964Z,1742493393.964 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:34.353Z,1742493394.353 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:34.764Z,1742493394.764 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:35.164Z,1742493395.164 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:35.557Z,1742493395.557 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:35.964Z,1742493395.964 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:36.376Z,1742493396.376 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:36.784Z,1742493396.784 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:37.196Z,1742493397.196 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:37.588Z,1742493397.588 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:37.996Z,1742493397.996 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:38.065Z,1742493398.065 [CommandExec](IMPORTANT): got command restart application 2025-03-20T17:56:38.416Z,1742493398.416 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:38.820Z,1742493398.820 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2025-03-20T17:56:38.820Z,1742493398.820 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-03-20T17:56:38.820Z,1742493398.820 [AHRS_M2] Communications Fault, FailCount= 3 2025-03-20T17:56:38.820Z,1742493398.820 [AHRS_M2](ERROR): Communications Fault 2025-03-20T17:56:38.878Z,1742493398.878 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-03-20T17:56:38.895Z,1742493398.895 [AHRS_M2](INFO): Powering down 2025-03-20T17:56:39.068Z,1742493399.068 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:39.068Z,1742493399.068 [CommandExec](INFO): Uninitializing the command executive. 2025-03-20T17:56:39.068Z,1742493399.068 [CommandExec](INFO): Uninitializing the command scheduler. 2025-03-20T17:56:39.068Z,1742493399.068 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:39.148Z,1742493399.148 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-03-20T17:56:39.148Z,1742493399.148 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-03-20T17:56:39.148Z,1742493399.148 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:39.149Z,1742493399.149 [NavChartDb](INFO): Join timeout helper Thread ID is 721 2025-03-20T17:56:39.205Z,1742493399.205 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:39.206Z,1742493399.206 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:39.208Z,1742493399.208 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-03-20T17:56:39.208Z,1742493399.208 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:39.208Z,1742493399.208 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 722 2025-03-20T17:56:39.496Z,1742493399.496 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:39.496Z,1742493399.496 [WetLabsBB2FL](INFO): Powering down 2025-03-20T17:56:39.497Z,1742493399.497 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:39.522Z,1742493399.522 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-03-20T17:56:39.522Z,1742493399.522 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:39.523Z,1742493399.523 [CTD_Seabird](INFO): Join timeout helper Thread ID is 723 2025-03-20T17:56:39.749Z,1742493399.749 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-03-20T17:56:39.749Z,1742493399.749 [AHRS_M2] No Fault, FailCount= 3 2025-03-20T17:56:40.102Z,1742493400.102 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-20T17:56:40.124Z,1742493400.124 [CTD_Seabird](INFO): Powering down 2025-03-20T17:56:40.256Z,1742493400.256 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:40.256Z,1742493400.256 [CTD_Seabird](INFO): Powering down 2025-03-20T17:56:40.268Z,1742493400.268 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:40.284Z,1742493400.284 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-03-20T17:56:40.284Z,1742493400.284 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:40.284Z,1742493400.284 [Radio_Surface](INFO): Join timeout helper Thread ID is 725 2025-03-20T17:56:40.380Z,1742493400.380 [Radio_Surface](INFO): Powering down 2025-03-20T17:56:40.381Z,1742493400.381 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:40.381Z,1742493400.381 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:40.400Z,1742493400.400 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-03-20T17:56:40.400Z,1742493400.400 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:40.400Z,1742493400.400 [Onboard](INFO): Join timeout helper Thread ID is 726 2025-03-20T17:56:40.796Z,1742493400.796 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-03-20T17:56:41.248Z,1742493401.248 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:41.248Z,1742493401.248 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:41.261Z,1742493401.261 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-03-20T17:56:41.261Z,1742493401.261 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:41.261Z,1742493401.261 [DataOverHttps](INFO): Join timeout helper Thread ID is 727 2025-03-20T17:56:41.800Z,1742493401.800 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:41.800Z,1742493401.800 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:41.836Z,1742493401.836 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-03-20T17:56:41.836Z,1742493401.836 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:41.837Z,1742493401.837 [DAT](INFO): Join timeout helper Thread ID is 728 2025-03-20T17:56:41.972Z,1742493401.972 [DAT](INFO): Powering down 2025-03-20T17:56:42.048Z,1742493402.048 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:42.049Z,1742493402.049 [DAT](INFO): Powering down 2025-03-20T17:56:42.049Z,1742493402.049 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.064Z,1742493402.064 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-03-20T17:56:42.065Z,1742493402.065 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.065Z,1742493402.065 [BackseatComponent](INFO): Join timeout helper Thread ID is 729 2025-03-20T17:56:42.084Z,1742493402.084 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:42.085Z,1742493402.085 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.086Z,1742493402.086 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-03-20T17:56:42.086Z,1742493402.086 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.087Z,1742493402.087 [logger](INFO): Join timeout helper Thread ID is 730 2025-03-20T17:56:42.138Z,1742493402.138 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:42.139Z,1742493402.139 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.153Z,1742493402.153 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-03-20T17:56:42.153Z,1742493402.153 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.153Z,1742493402.153 [CommandLine](INFO): Join timeout helper Thread ID is 731 2025-03-20T17:56:42.236Z,1742493402.236 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:42.236Z,1742493402.236 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.256Z,1742493402.256 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-03-20T17:56:42.257Z,1742493402.257 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.257Z,1742493402.257 [CommandExec](INFO): Join timeout helper Thread ID is 732 2025-03-20T17:56:42.258Z,1742493402.258 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-03-20T17:56:42.258Z,1742493402.258 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.259Z,1742493402.259 [controlThread](INFO): Join timeout helper Thread ID is 733 2025-03-20T17:56:42.520Z,1742493402.520 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-20T17:56:42.520Z,1742493402.520 [controlThread](DEBUG): Uninitializing ControlThread 2025-03-20T17:56:42.521Z,1742493402.521 [AHRS_M2](INFO): Powering down 2025-03-20T17:56:42.594Z,1742493402.594 [MultiRay](INFO): Powering down. 2025-03-20T17:56:42.595Z,1742493402.595 [NAL9602](INFO): Powering down 2025-03-20T17:56:42.596Z,1742493402.596 [Waterlinked](INFO): Powering down 2025-03-20T17:56:42.598Z,1742493402.598 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-03-20T17:56:42.598Z,1742493402.598 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-03-20T17:56:42.599Z,1742493402.599 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-03-20T17:56:42.599Z,1742493402.599 [MissionManager](INFO): Uninitializing Mission Default 2025-03-20T17:56:42.599Z,1742493402.599 [Default] Stopped 2025-03-20T17:56:42.599Z,1742493402.599 [Default](DEBUG): Aggregate::uninitialize Default 2025-03-20T17:56:42.600Z,1742493402.600 [Default:B.GoToSurface] Stopped 2025-03-20T17:56:42.600Z,1742493402.600 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-20T17:56:42.600Z,1742493402.600 [Default:CheckIn] Stopped 2025-03-20T17:56:42.600Z,1742493402.600 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-20T17:56:42.600Z,1742493402.600 [Default:CheckIn:Read_GPS] Stopped 2025-03-20T17:56:42.603Z,1742493402.603 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-03-20T17:56:42.603Z,1742493402.603 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-03-20T17:56:42.604Z,1742493402.604 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-03-20T17:56:42.604Z,1742493402.604 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-03-20T17:56:42.604Z,1742493402.604 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-03-20T17:56:42.605Z,1742493402.605 [BuoyancyServo](INFO): Powering down 2025-03-20T17:56:42.616Z,1742493402.616 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-03-20T17:56:42.616Z,1742493402.616 [ElevatorServo](INFO): Powering down 2025-03-20T17:56:42.617Z,1742493402.617 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-03-20T17:56:42.617Z,1742493402.617 [MassServo](INFO): Powering down 2025-03-20T17:56:42.618Z,1742493402.618 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-03-20T17:56:42.618Z,1742493402.618 [RudderServo](INFO): Powering down 2025-03-20T17:56:42.619Z,1742493402.619 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-03-20T17:56:42.619Z,1742493402.619 [ThrusterHE](INFO): Powering down 2025-03-20T17:56:42.620Z,1742493402.620 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-03-20T17:56:42.620Z,1742493402.620 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-03-20T17:56:42.620Z,1742493402.620 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-03-20T17:56:42.621Z,1742493402.621 [CBIT](DEBUG): Powering off loads. 2025-03-20T17:56:42.632Z,1742493402.632 [CBIT](DEBUG): Disabling WDT. 2025-03-20T17:56:42.644Z,1742493402.644 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-20T17:56:42.644Z,1742493402.644 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-03-20T17:56:42.645Z,1742493402.645 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.671Z,1742493402.671 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.675Z,1742493402.675 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.682Z,1742493402.682 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.689Z,1742493402.689 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.732Z,1742493402.732 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.767Z,1742493402.767 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-20T17:56:42.767Z,1742493402.767 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-03-20T17:56:42.782Z,1742493402.782 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.787Z,1742493402.787 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.841Z,1742493402.841 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-20T17:56:42.890Z,1742493402.890 [logger ThreadHandler](INFO): Thread cancelled.