2024-10-01T17:52:08.596Z,1727805128.596 [Supervisor](DEBUG): Initializing supervisor. 2024-10-01T17:52:08.601Z,1727805128.601 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-10-01T17:52:08.601Z,1727805128.601 [SyncHandler](INFO): Protected caller Thread ID is 971 2024-10-01T17:52:08.602Z,1727805128.602 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-10-01T17:52:08.603Z,1727805128.603 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-10-01T17:52:08.603Z,1727805128.603 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 972 2024-10-01T17:52:08.608Z,1727805128.608 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-10-01T17:52:08.625Z,1727805128.625 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-10-01T17:52:08.626Z,1727805128.626 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-10-01T17:52:08.627Z,1727805128.627 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 973 2024-10-01T17:52:08.631Z,1727805128.631 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-10-01T17:52:08.632Z,1727805128.632 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-10-01T17:52:08.632Z,1727805128.632 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 974 2024-10-01T17:52:08.634Z,1727805128.634 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-10-01T17:52:08.635Z,1727805128.635 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-10-01T17:52:08.635Z,1727805128.635 [logger ThreadHandler](INFO): Protected caller Thread ID is 975 2024-10-01T17:52:08.639Z,1727805128.639 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-10-01T17:52:08.639Z,1727805128.639 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-10-01T17:52:08.641Z,1727805128.641 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-10-01T17:52:08.885Z,1727805128.885 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-10-01T17:52:08.886Z,1727805128.886 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-10-01T17:52:09.121Z,1727805129.121 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-10-01T17:52:09.122Z,1727805129.122 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-10-01T17:52:09.229Z,1727805129.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-10-01T17:52:09.229Z,1727805129.229 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-10-01T17:52:09.432Z,1727805129.432 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-10-01T17:52:09.433Z,1727805129.433 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-10-01T17:52:09.960Z,1727805129.960 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-10-01T17:52:09.961Z,1727805129.961 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-10-01T17:52:10.081Z,1727805130.081 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-10-01T17:52:10.081Z,1727805130.081 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-10-01T17:52:10.374Z,1727805130.374 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-10-01T17:52:10.375Z,1727805130.375 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-10-01T17:52:10.602Z,1727805130.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-10-01T17:52:10.602Z,1727805130.602 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-10-01T17:52:11.172Z,1727805131.172 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-10-01T17:52:11.173Z,1727805131.173 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-10-01T17:52:11.614Z,1727805131.614 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-10-01T17:52:11.615Z,1727805131.615 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-10-01T17:52:11.705Z,1727805131.705 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-10-01T17:52:12.095Z,1727805132.095 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-10-01T17:52:12.096Z,1727805132.096 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-10-01T17:52:12.249Z,1727805132.249 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-10-01T17:52:12.249Z,1727805132.249 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-10-01T17:52:13.149Z,1727805133.149 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-10-01T17:52:13.150Z,1727805133.150 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-10-01T17:52:13.552Z,1727805133.552 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-10-01T17:52:13.552Z,1727805133.552 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-10-01T17:52:13.646Z,1727805133.646 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2024-10-01T17:52:13.647Z,1727805133.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2024-10-01T17:52:13.742Z,1727805133.742 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2024-10-01T17:52:13.860Z,1727805133.860 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2024-10-01T17:52:13.976Z,1727805133.976 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg 2024-10-01T17:52:14.174Z,1727805134.174 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2024-10-01T17:52:14.273Z,1727805134.273 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2024-10-01T17:52:14.369Z,1727805134.369 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2024-10-01T17:52:14.485Z,1727805134.485 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2024-10-01T17:52:14.629Z,1727805134.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2024-10-01T17:52:14.806Z,1727805134.806 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2024-10-01T17:52:14.926Z,1727805134.926 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2024-10-01T17:52:15.206Z,1727805135.206 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-10-01T17:52:15.208Z,1727805135.208 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/ 2024-10-01T17:52:15.208Z,1727805135.208 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-10-01T17:52:15.219Z,1727805135.219 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-10-01T17:52:15.567Z,1727805135.567 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-10-01T17:52:15.567Z,1727805135.567 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-10-01T17:52:16.047Z,1727805136.047 [AHRS_M2] Loaded 2024-10-01T17:52:16.047Z,1727805136.047 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-10-01T17:52:16.974Z,1727805136.974 [BPC1] Loaded 2024-10-01T17:52:16.975Z,1727805136.975 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-10-01T17:52:17.050Z,1727805137.050 [DataOverHttps] Loaded 2024-10-01T17:52:17.050Z,1727805137.050 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-10-01T17:52:17.051Z,1727805137.051 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408914E0 2024-10-01T17:52:17.052Z,1727805137.052 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1057 2024-10-01T17:52:17.075Z,1727805137.075 [Depth_Keller] Loaded 2024-10-01T17:52:17.075Z,1727805137.075 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-10-01T17:52:17.138Z,1727805137.138 [NAL9602] Loaded 2024-10-01T17:52:17.139Z,1727805137.139 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-10-01T17:52:17.168Z,1727805137.168 [Onboard] Loaded 2024-10-01T17:52:17.168Z,1727805137.168 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-10-01T17:52:17.169Z,1727805137.169 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408C14E0 2024-10-01T17:52:17.169Z,1727805137.169 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1058 2024-10-01T17:52:17.184Z,1727805137.184 [Power24vConverter] Loaded 2024-10-01T17:52:17.185Z,1727805137.185 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-10-01T17:52:17.201Z,1727805137.201 [Radio_Surface] Loaded 2024-10-01T17:52:17.201Z,1727805137.201 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-10-01T17:52:17.202Z,1727805137.202 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408F14E0 2024-10-01T17:52:17.202Z,1727805137.202 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1059 2024-10-01T17:52:17.218Z,1727805137.218 [Sonardyne_Nano] Loaded 2024-10-01T17:52:17.218Z,1727805137.218 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-10-01T17:52:17.218Z,1727805137.218 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-10-01T17:52:17.219Z,1727805137.219 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-10-01T17:52:17.334Z,1727805137.334 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-10-01T17:52:17.334Z,1727805137.334 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-10-01T17:52:17.387Z,1727805137.387 [VerticalControl](DEBUG): Construct VerticalControl. 2024-10-01T17:52:17.447Z,1727805137.447 [VerticalControl] Loaded 2024-10-01T17:52:17.448Z,1727805137.448 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-10-01T17:52:17.450Z,1727805137.450 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-10-01T17:52:17.498Z,1727805137.498 [HorizontalControl] Loaded 2024-10-01T17:52:17.499Z,1727805137.499 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-10-01T17:52:17.501Z,1727805137.501 [SpeedControl](DEBUG): Construct SpeedControl. 2024-10-01T17:52:17.504Z,1727805137.504 [SpeedControl] Loaded 2024-10-01T17:52:17.505Z,1727805137.505 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-10-01T17:52:17.507Z,1727805137.507 [LoopControl](DEBUG): Construct LoopControl. 2024-10-01T17:52:17.508Z,1727805137.508 [LoopControl] Loaded 2024-10-01T17:52:17.508Z,1727805137.508 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-10-01T17:52:17.509Z,1727805137.509 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-10-01T17:52:17.509Z,1727805137.509 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-10-01T17:52:17.520Z,1727805137.520 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-10-01T17:52:17.520Z,1727805137.520 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-10-01T17:52:17.547Z,1727805137.547 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-10-01T17:52:17.547Z,1727805137.547 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-10-01T17:52:17.729Z,1727805137.729 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-10-01T17:52:17.729Z,1727805137.729 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-10-01T17:52:17.771Z,1727805137.771 [DeadReckonUsingSpeedCalculator] Loaded 2024-10-01T17:52:17.772Z,1727805137.772 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-10-01T17:52:17.814Z,1727805137.814 [DeadReckonWithRespectToSeafloor] Loaded 2024-10-01T17:52:17.814Z,1727805137.814 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-10-01T17:52:17.828Z,1727805137.828 [NavChart] Loaded 2024-10-01T17:52:17.829Z,1727805137.829 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-10-01T17:52:17.834Z,1727805137.834 [UniversalFixResidualReporter] Loaded 2024-10-01T17:52:17.835Z,1727805137.835 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-10-01T17:52:17.835Z,1727805137.835 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-10-01T17:52:17.836Z,1727805137.836 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-10-01T17:52:17.980Z,1727805137.980 [SBIT](DEBUG): Construct Startup Built In Test. 2024-10-01T17:52:17.989Z,1727805137.989 [SBIT] Loaded 2024-10-01T17:52:17.989Z,1727805137.989 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-10-01T17:52:17.992Z,1727805137.992 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-10-01T17:52:18.005Z,1727805138.005 [IBIT] Loaded 2024-10-01T17:52:18.005Z,1727805138.005 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-10-01T17:52:18.011Z,1727805138.011 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-10-01T17:52:18.117Z,1727805138.117 [CBIT] Loaded 2024-10-01T17:52:18.118Z,1727805138.118 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-10-01T17:52:18.118Z,1727805138.118 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-10-01T17:52:18.118Z,1727805138.118 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-10-01T17:52:18.300Z,1727805138.300 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-10-01T17:52:18.301Z,1727805138.301 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-10-01T17:52:18.436Z,1727805138.436 [BuoyancyServo] Loaded 2024-10-01T17:52:18.436Z,1727805138.436 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-10-01T17:52:18.459Z,1727805138.459 [ElevatorServo] Loaded 2024-10-01T17:52:18.460Z,1727805138.460 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-10-01T17:52:18.481Z,1727805138.481 [MassServo] Loaded 2024-10-01T17:52:18.482Z,1727805138.482 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-10-01T17:52:18.502Z,1727805138.502 [RudderServo] Loaded 2024-10-01T17:52:18.503Z,1727805138.503 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-10-01T17:52:18.519Z,1727805138.519 [ThrusterHE] Loaded 2024-10-01T17:52:18.520Z,1727805138.520 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-10-01T17:52:18.520Z,1727805138.520 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-10-01T17:52:18.521Z,1727805138.521 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-10-01T17:52:18.682Z,1727805138.682 [ESPComponent] Loaded 2024-10-01T17:52:18.682Z,1727805138.682 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-10-01T17:52:18.705Z,1727805138.705 [PAR_Licor] Loaded 2024-10-01T17:52:18.705Z,1727805138.705 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-10-01T17:52:18.706Z,1727805138.706 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-10-01T17:52:18.706Z,1727805138.706 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-10-01T17:52:18.757Z,1727805138.757 [DepthRateCalculator] Loaded 2024-10-01T17:52:18.757Z,1727805138.757 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-10-01T17:52:18.762Z,1727805138.762 [PitchRateCalculator] Loaded 2024-10-01T17:52:18.762Z,1727805138.762 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-10-01T17:52:18.771Z,1727805138.771 [SpeedCalculator] Loaded 2024-10-01T17:52:18.772Z,1727805138.772 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-10-01T17:52:18.776Z,1727805138.776 [YawRateCalculator] Loaded 2024-10-01T17:52:18.776Z,1727805138.776 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-10-01T17:52:18.796Z,1727805138.796 [ElevatorOffsetCalculator] Loaded 2024-10-01T17:52:18.796Z,1727805138.796 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-10-01T17:52:18.797Z,1727805138.797 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-10-01T17:52:18.797Z,1727805138.797 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-10-01T17:52:18.854Z,1727805138.854 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-10-01T17:52:18.860Z,1727805138.860 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-10-01T17:52:18.863Z,1727805138.863 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-10-01T17:52:18.874Z,1727805138.874 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-10-01T17:52:18.875Z,1727805138.875 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B774E0 2024-10-01T17:52:18.875Z,1727805138.875 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1060 2024-10-01T17:52:18.880Z,1727805138.880 [Supervisor](INFO): Main Thread ID is 819 2024-10-01T17:52:18.880Z,1727805138.880 [Supervisor](DEBUG): Running supervisor. 2024-10-01T17:52:18.881Z,1727805138.881 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1061 2024-10-01T17:52:18.881Z,1727805138.881 [CommandExec](INFO): Initializing the command executive. 2024-10-01T17:52:18.883Z,1727805138.883 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1062 2024-10-01T17:52:18.885Z,1727805138.885 [controlThread ThreadHandler](INFO): Handler Thread ID is 1063 2024-10-01T17:52:18.885Z,1727805138.885 [controlThread](DEBUG): Initializing ControlThread 2024-10-01T17:52:18.889Z,1727805138.889 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-10-01T17:52:18.890Z,1727805138.890 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-10-01T17:52:18.891Z,1727805138.891 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-10-01T17:52:18.891Z,1727805138.891 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-10-01T17:52:18.892Z,1727805138.892 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-10-01T17:52:18.893Z,1727805138.893 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-10-01T17:52:18.893Z,1727805138.893 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-10-01T17:52:18.894Z,1727805138.894 [SBIT](INFO): Initialize SBIT Component. 2024-10-01T17:52:18.894Z,1727805138.894 [SBIT](IMPORTANT): git: 2024-09-16-2-g9a6e6361e 2024-10-01T17:52:18.894Z,1727805138.894 [SBIT](INFO): git hash: 9a6e6361ee0225b4338ccb03ae7adeebd6db69cf 2024-10-01T17:52:18.895Z,1727805138.895 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-10-01T17:52:18.896Z,1727805138.896 [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 2024-10-01T17:52:18.897Z,1727805138.897 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2024-10-01T17:52:18.898Z,1727805138.898 [IBIT](INFO): Initialize IBIT Component. 2024-10-01T17:52:18.899Z,1727805138.899 [CBIT](DEBUG): Initialize CBIT Component. 2024-10-01T17:52:18.899Z,1727805138.899 [logger ThreadHandler](INFO): Handler Thread ID is 1064 2024-10-01T17:52:18.912Z,1727805138.912 [CBIT](DEBUG): Initialized mux pins. 2024-10-01T17:52:18.912Z,1727805138.912 [CBIT](DEBUG): Initializing the watchdog timer. 2024-10-01T17:52:18.921Z,1727805138.921 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1065 2024-10-01T17:52:18.922Z,1727805138.922 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-10-01T17:52:18.933Z,1727805138.933 [Onboard ThreadHandler](INFO): Handler Thread ID is 1066 2024-10-01T17:52:18.937Z,1727805138.937 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-10-01T17:52:18.937Z,1727805138.937 [CBIT](DEBUG): Initializing heartbeat. 2024-10-01T17:52:18.953Z,1727805138.953 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1067 2024-10-01T17:52:18.969Z,1727805138.969 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1068 2024-10-01T17:52:18.971Z,1727805138.971 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-10-01T17:52:18.971Z,1727805138.971 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-10-01T17:52:18.971Z,1727805138.971 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-10-01T17:52:18.972Z,1727805138.972 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-10-01T17:52:18.972Z,1727805138.972 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-10-01T17:52:18.972Z,1727805138.972 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-10-01T17:52:18.972Z,1727805138.972 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-10-01T17:52:18.972Z,1727805138.972 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-10-01T17:52:18.973Z,1727805138.973 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-10-01T17:52:18.973Z,1727805138.973 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-10-01T17:52:18.973Z,1727805138.973 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-10-01T17:52:18.973Z,1727805138.973 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-10-01T17:52:19.008Z,1727805139.008 [CBIT](DEBUG): Deactivating GF circuits. 2024-10-01T17:52:19.008Z,1727805139.008 [CBIT](DEBUG): Deactivating emergency mode. 2024-10-01T17:52:19.048Z,1727805139.048 [CBIT](DEBUG): Backplane powered. 2024-10-01T17:52:19.053Z,1727805139.053 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-10-01T17:52:19.053Z,1727805139.053 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-10-01T17:52:19.054Z,1727805139.054 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-10-01T17:52:19.054Z,1727805139.054 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-10-01T17:52:19.055Z,1727805139.055 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-10-01T17:52:19.056Z,1727805139.056 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-10-01T17:52:19.057Z,1727805139.057 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-10-01T17:52:19.057Z,1727805139.057 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-10-01T17:52:19.058Z,1727805139.058 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-10-01T17:52:19.104Z,1727805139.104 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-10-01T17:52:19.108Z,1727805139.108 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-01T17:52:19.147Z,1727805139.147 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-10-01T17:52:19.148Z,1727805139.148 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-10-01T17:52:19.148Z,1727805139.148 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-10-01T17:52:19.149Z,1727805139.149 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-10-01T17:52:19.353Z,1727805139.353 [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 2024-10-01T17:52:19.356Z,1727805139.356 [Radio_Surface](INFO): Powering up 2024-10-01T17:52:19.367Z,1727805139.367 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-10-01T17:52:19.368Z,1727805139.368 [Default:A.Wait](DEBUG): Construct Wait. 2024-10-01T17:52:19.370Z,1727805139.370 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-01T17:52:19.408Z,1727805139.408 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-10-01T17:52:19.411Z,1727805139.411 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-10-01T17:52:19.448Z,1727805139.448 [Default:E.Execute](DEBUG): Construct Execute. 2024-10-01T17:52:19.451Z,1727805139.451 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-10-01T17:52:19.456Z,1727805139.456 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2024-10-01T17:52:19.471Z,1727805139.471 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-01T17:52:19.537Z,1727805139.537 [Power24vConverter](INFO): Powering up. 2024-10-01T17:52:19.537Z,1727805139.537 [Sonardyne_Nano](INFO): Initializing. 2024-10-01T17:52:19.593Z,1727805139.593 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-10-01T17:52:19.601Z,1727805139.601 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-10-01T17:52:19.602Z,1727805139.602 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-10-01T17:52:19.609Z,1727805139.609 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-10-01T17:52:19.610Z,1727805139.610 [MassServo](DEBUG): Initializing EZServoServo. 2024-10-01T17:52:19.617Z,1727805139.617 [MassServo](DEBUG): Initializing MassServo. 2024-10-01T17:52:19.617Z,1727805139.617 [RudderServo](DEBUG): Initializing EZServoServo. 2024-10-01T17:52:19.625Z,1727805139.625 [RudderServo](DEBUG): Initializing RudderServo. 2024-10-01T17:52:19.625Z,1727805139.625 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-10-01T17:52:19.632Z,1727805139.632 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-10-01T17:52:23.020Z,1727805143.020 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:23.424Z,1727805143.424 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:23.920Z,1727805143.920 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:24.388Z,1727805144.388 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:24.824Z,1727805144.824 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:25.440Z,1727805145.440 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:25.888Z,1727805145.888 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:26.504Z,1727805146.504 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:26.908Z,1727805146.908 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:27.312Z,1727805147.312 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:27.704Z,1727805147.704 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:28.116Z,1727805148.116 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:28.520Z,1727805148.520 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:28.924Z,1727805148.924 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:29.316Z,1727805149.316 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:29.732Z,1727805149.732 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:30.136Z,1727805150.136 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:30.540Z,1727805150.540 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:30.944Z,1727805150.944 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:31.344Z,1727805151.344 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:31.748Z,1727805151.748 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:32.156Z,1727805152.156 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:32.556Z,1727805152.556 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:32.556Z,1727805152.556 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-10-01T17:52:32.556Z,1727805152.556 [AHRS_M2] Communications Fault, FailCount= 1 2024-10-01T17:52:32.556Z,1727805152.556 [AHRS_M2](ERROR): Communications Fault 2024-10-01T17:52:32.585Z,1727805152.585 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-10-01T17:52:32.637Z,1727805152.637 [AHRS_M2](INFO): Powering down 2024-10-01T17:52:33.467Z,1727805153.467 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-10-01T17:52:33.467Z,1727805153.467 [AHRS_M2] No Fault, FailCount= 1 2024-10-01T17:52:33.850Z,1727805153.850 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-01T17:52:37.404Z,1727805157.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:37.808Z,1727805157.808 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:38.208Z,1727805158.208 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:38.616Z,1727805158.616 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:39.020Z,1727805159.020 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:39.428Z,1727805159.428 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:39.454Z,1727805159.454 [SBIT](IMPORTANT): Beginning Startup BIT 2024-10-01T17:52:39.457Z,1727805159.457 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-01T17:52:39.832Z,1727805159.832 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:40.256Z,1727805160.256 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:40.648Z,1727805160.648 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:41.060Z,1727805161.060 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:41.616Z,1727805161.616 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:42.088Z,1727805162.088 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:42.536Z,1727805162.536 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:43.076Z,1727805163.076 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:43.604Z,1727805163.604 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:44.028Z,1727805164.028 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:44.680Z,1727805164.680 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:45.192Z,1727805165.192 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:45.588Z,1727805165.588 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:46.064Z,1727805166.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:46.476Z,1727805166.476 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:46.880Z,1727805166.880 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:46.880Z,1727805166.880 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-10-01T17:52:46.880Z,1727805166.880 [AHRS_M2] Communications Fault, FailCount= 2 2024-10-01T17:52:46.880Z,1727805166.880 [AHRS_M2](ERROR): Communications Fault 2024-10-01T17:52:46.962Z,1727805166.962 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-10-01T17:52:46.969Z,1727805166.969 [AHRS_M2](INFO): Powering down 2024-10-01T17:52:47.379Z,1727805167.379 [NAL9602](INFO): Powering up NAL9602 2024-10-01T17:52:47.833Z,1727805167.833 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-10-01T17:52:47.833Z,1727805167.833 [AHRS_M2] No Fault, FailCount= 2 2024-10-01T17:52:48.177Z,1727805168.177 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-01T17:52:51.736Z,1727805171.736 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:51.818Z,1727805171.818 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.014807 CHAN A1 (24V): -0.000613 CHAN A2 (12V): 0.000478 CHAN A3 (5V): -0.002039 CHAN B0 (3.3V): -0.001184 CHAN B1 (3.15aV): -0.000937 CHAN B2 (3.15bV): -0.001064 CHAN B3 (GND): -0.002034 OPEN: 0.003510 Full Scale: +/- 1 mA 2024-10-01T17:52:52.000Z,1727805172.000 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:52.324Z,1727805172.324 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:52.724Z,1727805172.724 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:53.352Z,1727805173.352 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:53.532Z,1727805173.532 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:53.940Z,1727805173.940 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:54.572Z,1727805174.572 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:54.968Z,1727805174.968 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:55.492Z,1727805175.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:55.952Z,1727805175.952 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:56.408Z,1727805176.408 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:56.856Z,1727805176.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:57.304Z,1727805177.304 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:57.764Z,1727805177.764 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:58.204Z,1727805178.204 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:58.672Z,1727805178.672 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:58.682Z,1727805178.682 [NAL9602](INFO): NAL9602 initialized 2024-10-01T17:52:59.132Z,1727805179.132 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:52:59.588Z,1727805179.588 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:00.064Z,1727805180.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:00.560Z,1727805180.560 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:01.204Z,1727805181.204 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:01.204Z,1727805181.204 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-10-01T17:53:01.204Z,1727805181.204 [AHRS_M2] Communications Fault, FailCount= 3 2024-10-01T17:53:01.204Z,1727805181.204 [AHRS_M2](ERROR): Communications Fault 2024-10-01T17:53:01.258Z,1727805181.258 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-10-01T17:53:01.277Z,1727805181.277 [AHRS_M2](INFO): Powering down 2024-10-01T17:53:02.165Z,1727805182.165 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-10-01T17:53:02.165Z,1727805182.165 [AHRS_M2] No Fault, FailCount= 3 2024-10-01T17:53:02.490Z,1727805182.490 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-01T17:53:06.044Z,1727805186.044 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:06.452Z,1727805186.452 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:06.860Z,1727805186.860 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:07.276Z,1727805187.276 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:07.680Z,1727805187.680 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:08.188Z,1727805188.188 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:08.600Z,1727805188.600 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:08.996Z,1727805188.996 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:09.400Z,1727805189.400 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:09.800Z,1727805189.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:10.208Z,1727805190.208 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:10.612Z,1727805190.612 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:11.012Z,1727805191.012 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:11.420Z,1727805191.420 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:11.824Z,1727805191.824 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:12.228Z,1727805192.228 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:12.636Z,1727805192.636 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:13.036Z,1727805193.036 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:13.440Z,1727805193.440 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:13.844Z,1727805193.844 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:14.248Z,1727805194.248 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:14.664Z,1727805194.664 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:15.064Z,1727805195.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:15.468Z,1727805195.468 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:15.468Z,1727805195.468 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-10-01T17:53:15.468Z,1727805195.468 [AHRS_M2] Communications Fault, FailCount= 4 2024-10-01T17:53:15.468Z,1727805195.468 [AHRS_M2](ERROR): Communications Fault 2024-10-01T17:53:15.518Z,1727805195.518 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-10-01T17:53:15.538Z,1727805195.538 [AHRS_M2](INFO): Powering down 2024-10-01T17:53:16.375Z,1727805196.375 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-10-01T17:53:16.375Z,1727805196.375 [AHRS_M2] No Fault, FailCount= 4 2024-10-01T17:53:16.750Z,1727805196.750 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-01T17:53:20.304Z,1727805200.304 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:20.365Z,1727805200.365 [CBIT](FAULT): WATER ALARM STERN. 2024-10-01T17:53:20.366Z,1727805200.366 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2024-10-01T17:53:20.716Z,1727805200.716 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:21.116Z,1727805201.116 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:21.512Z,1727805201.512 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:21.924Z,1727805201.924 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:22.448Z,1727805202.448 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:22.944Z,1727805202.944 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:23.428Z,1727805203.428 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:23.896Z,1727805203.896 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:24.344Z,1727805204.344 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:24.780Z,1727805204.780 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:25.272Z,1727805205.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:25.908Z,1727805205.908 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:26.384Z,1727805206.384 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:26.780Z,1727805206.780 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:27.192Z,1727805207.192 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:27.596Z,1727805207.596 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:28.008Z,1727805208.008 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:28.404Z,1727805208.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:28.800Z,1727805208.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:29.208Z,1727805209.208 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:29.604Z,1727805209.604 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-10-01T17:53:29.604Z,1727805209.604 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-10-01T17:53:29.604Z,1727805209.604 [AHRS_M2] Communications Fault, FailCount= 5 2024-10-01T17:53:29.604Z,1727805209.604 [AHRS_M2](ERROR): Communications Fault 2024-10-01T17:53:29.635Z,1727805209.635 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-10-01T17:53:29.635Z,1727805209.635 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2024-10-01T17:53:29.686Z,1727805209.686 [AHRS_M2](INFO): Powering down 2024-10-01T17:53:29.784Z,1727805209.784 [CommandExec](FAULT): Scheduling is paused 2024-10-01T17:53:29.784Z,1727805209.784 [CBIT](INFO): Critical error at 20241001T175329 2024-10-01T17:53:29.785Z,1727805209.785 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-10-01T17:53:33.777Z,1727805213.777 [SBIT](IMPORTANT): SBIT PASSED 2024-10-01T17:53:33.777Z,1727805213.777 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-10-01T17:53:33.778Z,1727805213.778 [SBIT](IMPORTANT): 2024-10-01T17:53:33.778Z,1727805213.778 [SBIT](IMPORTANT): CBIT.gf24Offset=162 microampere; 2024-10-01T17:53:33.778Z,1727805213.778 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool; 2024-10-01T17:53:33.778Z,1727805213.778 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2024-10-01T17:53:33.778Z,1727805213.778 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-10-01T17:53:33.778Z,1727805213.778 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2024-10-01T17:53:33.778Z,1727805213.778 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2024-10-01T17:53:33.778Z,1727805213.778 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=-0.1 meter; 2024-10-01T17:53:33.779Z,1727805213.779 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-10-01T17:53:33.779Z,1727805213.779 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2024-10-01T17:53:33.779Z,1727805213.779 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute; 2024-10-01T17:53:33.779Z,1727805213.779 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2024-10-01T17:53:33.779Z,1727805213.779 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2024-10-01T17:53:34.157Z,1727805214.157 [MissionManager](IMPORTANT): Started mission Startup 2024-10-01T17:53:34.157Z,1727805214.157 [Startup] Running Loop=1 2024-10-01T17:53:34.157Z,1727805214.157 [Startup](DEBUG): Aggregate::initialize Startup 2024-10-01T17:53:34.157Z,1727805214.157 [Startup:A.GoToSurface] Running Loop=1 2024-10-01T17:53:34.157Z,1727805214.157 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-10-01T17:53:34.158Z,1727805214.158 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-10-01T17:53:34.158Z,1727805214.158 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-10-01T17:53:34.158Z,1727805214.158 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-10-01T17:53:34.159Z,1727805214.159 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-10-01T17:53:34.159Z,1727805214.159 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-10-01T17:53:34.159Z,1727805214.159 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-10-01T17:53:34.162Z,1727805214.162 [Startup:StartupSatComms] Running Loop=1 2024-10-01T17:53:34.162Z,1727805214.162 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-10-01T17:53:34.162Z,1727805214.162 [Startup:StartupSatComms:A] Running Loop=1 2024-10-01T17:53:34.556Z,1727805214.556 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-10-01T17:53:39.038Z,1727805219.038 [CBIT](FAULT): WATER ALARM BOW. 2024-10-01T17:53:39.039Z,1727805219.039 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2024-10-01T17:53:39.407Z,1727805219.407 [CBIT](FAULT): WATER ALARM BOW. 2024-10-01T17:53:39.409Z,1727805219.409 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2 2024-10-01T17:53:39.817Z,1727805219.817 [CBIT](FAULT): WATER ALARM BOW. 2024-10-01T17:53:39.818Z,1727805219.818 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3 2024-10-01T17:53:40.231Z,1727805220.231 [CBIT](FAULT): WATER ALARM BOW. 2024-10-01T17:53:40.244Z,1727805220.244 [CBIT](CRITICAL): WATER DETECTED IN PRESSURE HULL: BOW. BURNWIRE ACTIVATED 2024-10-01T17:53:40.245Z,1727805220.245 [CBIT](IMPORTANT): Powered off ESP with command: ! echo 0 > /dev/loadA6;echo 0 > /dev/loadA7 2024-10-01T17:53:40.331Z,1727805220.331 [CommandExec](IMPORTANT): got command ! echo 0 > /dev/loadA6;echo 0 > /dev/loadA7 2024-10-01T17:53:40.626Z,1727805220.626 [CBIT](INFO): Critical error at 20241001T175340 2024-10-01T17:54:18.992Z,1727805258.992 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:54:18.992Z,1727805258.992 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-10-01T17:54:18.992Z,1727805258.992 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-01T17:54:19.014Z,1727805259.014 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:54:19.014Z,1727805259.014 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-10-01T17:54:19.014Z,1727805259.014 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-10-01T17:54:19.015Z,1727805259.015 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:54:19.016Z,1727805259.016 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-10-01T17:54:19.016Z,1727805259.016 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-10-01T17:54:19.027Z,1727805259.027 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-01T17:54:19.027Z,1727805259.027 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-10-01T17:54:19.027Z,1727805259.027 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-10-01T17:54:19.425Z,1727805259.425 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-01T17:54:19.425Z,1727805259.425 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-10-01T17:54:19.425Z,1727805259.425 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-10-01T17:54:19.426Z,1727805259.426 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-10-01T17:54:19.426Z,1727805259.426 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-10-01T17:54:19.426Z,1727805259.426 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-10-01T17:54:19.816Z,1727805259.816 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-10-01T17:54:30.775Z,1727805270.775 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.017156 2024-10-01T17:54:34.346Z,1727805274.346 [Startup:StartupSatComms:A](INFO): Timed out from 2024-10-01T17:53:34.2Z 2024-10-01T17:54:34.346Z,1727805274.346 [Startup:StartupSatComms:A] Stopped 2024-10-01T17:54:34.346Z,1727805274.346 [Startup:StartupSatComms:B] Running Loop=1 2024-10-01T17:54:34.751Z,1727805274.751 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-10-01T17:54:40.912Z,1727805280.912 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241001T174519/Courier0004.lzma 2024-10-01T17:54:41.914Z,1727805281.914 [DataOverHttps](INFO): Moved sent file to Logs/20241001T174519/Courier0004.lzma.bak 2024-10-01T17:54:41.914Z,1727805281.914 [DataOverHttps](INFO): SBD MOMSN=23238966 2024-10-01T17:54:59.877Z,1727805299.877 [DataOverHttps](INFO): Sending 265 bytes from file Logs/20241001T175208/Courier0000.lzma 2024-10-01T17:55:00.882Z,1727805300.882 [DataOverHttps](INFO): Moved sent file to Logs/20241001T175208/Courier0000.lzma.bak 2024-10-01T17:55:00.882Z,1727805300.882 [DataOverHttps](INFO): SBD MOMSN=23238968 2024-10-01T17:55:17.714Z,1727805317.714 [DataOverHttps](INFO): Sending 609 bytes from file Logs/20241001T174519/Express0005.lzma 2024-10-01T17:55:18.714Z,1727805318.714 [DataOverHttps](INFO): Moved sent file to Logs/20241001T174519/Express0005.lzma.bak 2024-10-01T17:55:18.714Z,1727805318.714 [DataOverHttps](INFO): SBD MOMSN=23238973 2024-10-01T17:55:33.911Z,1727805333.911 [DataOverHttps](INFO): Sending 1169 bytes from file Logs/20241001T175208/Express0001.lzma 2024-10-01T17:55:34.652Z,1727805334.652 [Startup:StartupSatComms:B](INFO): Timed out from 2024-10-01T17:54:34.3Z 2024-10-01T17:55:34.652Z,1727805334.652 [Startup:StartupSatComms:B] Stopped 2024-10-01T17:55:34.652Z,1727805334.652 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-10-01T17:55:34.652Z,1727805334.652 [Startup:StartupSatComms] Stopped 2024-10-01T17:55:34.652Z,1727805334.652 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-10-01T17:55:34.653Z,1727805334.653 [Startup](INFO): Completed Startup 2024-10-01T17:55:34.654Z,1727805334.654 [MissionManager](INFO): Startup is completed. 2024-10-01T17:55:34.654Z,1727805334.654 [MissionManager](INFO): Uninitializing Mission Startup 2024-10-01T17:55:34.654Z,1727805334.654 [Startup] Stopped 2024-10-01T17:55:34.654Z,1727805334.654 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-10-01T17:55:34.654Z,1727805334.654 [Startup:A.GoToSurface] Stopped 2024-10-01T17:55:34.654Z,1727805334.654 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-10-01T17:55:34.910Z,1727805334.910 [DataOverHttps](INFO): Moved sent file to Logs/20241001T175208/Express0001.lzma.bak 2024-10-01T17:55:34.910Z,1727805334.910 [DataOverHttps](INFO): SBD MOMSN=23238993 2024-10-01T17:55:35.053Z,1727805335.053 [MissionManager](IMPORTANT): Started mission Default 2024-10-01T17:55:35.054Z,1727805335.054 [Default] Running Loop=1 2024-10-01T17:55:35.054Z,1727805335.054 [Default](DEBUG): Aggregate::initialize Default 2024-10-01T17:55:35.054Z,1727805335.054 [Default:B.GoToSurface] Running Loop=1 2024-10-01T17:55:35.054Z,1727805335.054 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-10-01T17:55:35.054Z,1727805335.054 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-10-01T17:55:35.054Z,1727805335.054 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-10-01T17:55:35.055Z,1727805335.055 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-10-01T17:55:35.055Z,1727805335.055 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-10-01T17:55:35.055Z,1727805335.055 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-10-01T17:55:35.056Z,1727805335.056 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-10-01T17:55:35.056Z,1727805335.056 [Default:A.Wait] Running Loop=1 2024-10-01T17:55:35.056Z,1727805335.056 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-10-01T17:55:48.407Z,1727805348.407 [Default:A.Wait](INFO): Done Waiting. 2024-10-01T17:55:48.408Z,1727805348.408 [Default:A.Wait] Stopped 2024-10-01T17:55:48.408Z,1727805348.408 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-10-01T17:55:48.783Z,1727805348.783 [Default:CheckIn] Running Loop=1 2024-10-01T17:55:48.783Z,1727805348.783 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-01T17:55:48.783Z,1727805348.783 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-01T17:55:49.182Z,1727805349.182 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-10-01T17:55:53.998Z,1727805353.998 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:56:06.925Z,1727805366.925 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:56:19.451Z,1727805379.451 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:56:19.893Z,1727805379.893 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:56:19.893Z,1727805379.893 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-10-01T17:56:19.893Z,1727805379.893 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-01T17:56:19.895Z,1727805379.895 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:56:19.895Z,1727805379.895 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-10-01T17:56:19.895Z,1727805379.895 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-10-01T17:56:19.897Z,1727805379.897 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:56:19.897Z,1727805379.897 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-10-01T17:56:19.897Z,1727805379.897 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-10-01T17:56:19.907Z,1727805379.907 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-01T17:56:19.908Z,1727805379.908 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-10-01T17:56:19.908Z,1727805379.908 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-10-01T17:56:20.295Z,1727805380.295 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-01T17:56:20.295Z,1727805380.295 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-10-01T17:56:20.296Z,1727805380.296 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-10-01T17:56:20.296Z,1727805380.296 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-10-01T17:56:20.296Z,1727805380.296 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-10-01T17:56:20.297Z,1727805380.297 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-10-01T17:56:20.691Z,1727805380.691 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-10-01T17:56:32.379Z,1727805392.379 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:56:44.902Z,1727805404.902 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:56:58.233Z,1727805418.233 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:57:11.161Z,1727805431.161 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:57:24.090Z,1727805444.090 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:57:36.613Z,1727805456.613 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:57:49.138Z,1727805469.138 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:58:01.257Z,1727805481.257 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:58:02.478Z,1727805482.478 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-10-01T17:58:08.781Z,1727805488.781 [CommandExec](IMPORTANT): got command burn off 2024-10-01T17:58:08.781Z,1727805488.781 [CommandExec](IMPORTANT): Deactivating dropweight wire 2024-10-01T17:58:13.782Z,1727805493.782 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-01T17:58:17.314Z,1727805497.314 [CommandExec](IMPORTANT): got command burn off 2024-10-01T17:58:17.314Z,1727805497.314 [CommandExec](IMPORTANT): Deactivating dropweight wire 2024-10-01T17:58:20.707Z,1727805500.707 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:58:20.707Z,1727805500.707 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-10-01T17:58:20.707Z,1727805500.707 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-01T17:58:20.709Z,1727805500.709 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:58:20.709Z,1727805500.709 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-10-01T17:58:20.709Z,1727805500.709 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-10-01T17:58:20.710Z,1727805500.710 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-10-01T17:58:20.710Z,1727805500.710 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2024-10-01T17:58:20.710Z,1727805500.710 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-10-01T17:58:20.722Z,1727805500.722 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-01T17:58:20.722Z,1727805500.722 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-10-01T17:58:20.722Z,1727805500.722 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-10-01T17:58:21.113Z,1727805501.113 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-01T17:58:21.113Z,1727805501.113 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-10-01T17:58:21.114Z,1727805501.114 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-10-01T17:58:21.114Z,1727805501.114 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-10-01T17:58:21.114Z,1727805501.114 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-10-01T17:58:21.115Z,1727805501.115 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2024-10-01T17:58:21.489Z,1727805501.489 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-10-01T17:58:27.821Z,1727805507.821 [CommandExec](IMPORTANT): got command restart application 2024-10-01T17:58:28.824Z,1727805508.824 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-01T17:58:28.825Z,1727805508.825 [CommandExec](INFO): Uninitializing the command executive. 2024-10-01T17:58:28.825Z,1727805508.825 [CommandExec](INFO): Uninitializing the command scheduler. 2024-10-01T17:58:28.825Z,1727805508.825 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:28.856Z,1727805508.856 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-10-01T17:58:28.856Z,1727805508.856 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-10-01T17:58:28.857Z,1727805508.857 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:28.857Z,1727805508.857 [NavChartDb](INFO): Join timeout helper Thread ID is 1090 2024-10-01T17:58:28.865Z,1727805508.865 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-01T17:58:28.865Z,1727805508.865 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:28.876Z,1727805508.876 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-10-01T17:58:28.877Z,1727805508.877 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:28.877Z,1727805508.877 [Radio_Surface](INFO): Join timeout helper Thread ID is 1091 2024-10-01T17:58:29.154Z,1727805509.154 [Radio_Surface](INFO): Powering down 2024-10-01T17:58:29.157Z,1727805509.157 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-01T17:58:29.157Z,1727805509.157 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:29.175Z,1727805509.175 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-10-01T17:58:29.175Z,1727805509.175 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:29.176Z,1727805509.176 [Onboard](INFO): Join timeout helper Thread ID is 1092 2024-10-01T17:58:29.232Z,1727805509.232 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-01T17:58:29.233Z,1727805509.233 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:29.236Z,1727805509.236 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-10-01T17:58:29.236Z,1727805509.236 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:29.237Z,1727805509.237 [DataOverHttps](INFO): Join timeout helper Thread ID is 1093 2024-10-01T17:58:29.968Z,1727805509.968 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-10-01T17:58:29.968Z,1727805509.968 [AHRS_M2] No Fault, FailCount= 5 2024-10-01T17:58:30.068Z,1727805510.068 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-01T17:58:30.069Z,1727805510.069 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.072Z,1727805510.072 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-10-01T17:58:30.072Z,1727805510.072 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.073Z,1727805510.073 [logger](INFO): Join timeout helper Thread ID is 1094 2024-10-01T17:58:30.100Z,1727805510.100 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-01T17:58:30.101Z,1727805510.101 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.113Z,1727805510.113 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-10-01T17:58:30.113Z,1727805510.113 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.114Z,1727805510.114 [CommandLine](INFO): Join timeout helper Thread ID is 1095 2024-10-01T17:58:30.180Z,1727805510.180 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-01T17:58:30.181Z,1727805510.181 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.193Z,1727805510.193 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-10-01T17:58:30.193Z,1727805510.193 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.193Z,1727805510.193 [CommandExec](INFO): Join timeout helper Thread ID is 1096 2024-10-01T17:58:30.194Z,1727805510.194 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-10-01T17:58:30.195Z,1727805510.195 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.195Z,1727805510.195 [controlThread](INFO): Join timeout helper Thread ID is 1097 2024-10-01T17:58:30.340Z,1727805510.340 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-01T17:58:30.341Z,1727805510.341 [controlThread](DEBUG): Uninitializing ControlThread 2024-10-01T17:58:30.341Z,1727805510.341 [AHRS_M2](INFO): Powering down 2024-10-01T17:58:30.343Z,1727805510.343 [NAL9602](INFO): Powering down 2024-10-01T17:58:30.344Z,1727805510.344 [Sonardyne_Nano](INFO): Powering down 2024-10-01T17:58:30.465Z,1727805510.465 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-10-01T17:58:30.466Z,1727805510.466 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-10-01T17:58:30.467Z,1727805510.467 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-10-01T17:58:30.467Z,1727805510.467 [MissionManager](INFO): Uninitializing Mission Default 2024-10-01T17:58:30.467Z,1727805510.467 [Default] Stopped 2024-10-01T17:58:30.467Z,1727805510.467 [Default](DEBUG): Aggregate::uninitialize Default 2024-10-01T17:58:30.467Z,1727805510.467 [Default:B.GoToSurface] Stopped 2024-10-01T17:58:30.468Z,1727805510.468 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-10-01T17:58:30.468Z,1727805510.468 [Default:CheckIn] Stopped 2024-10-01T17:58:30.468Z,1727805510.468 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-01T17:58:30.468Z,1727805510.468 [Default:CheckIn:Read_GPS] Stopped 2024-10-01T17:58:30.470Z,1727805510.470 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-10-01T17:58:30.471Z,1727805510.471 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-10-01T17:58:30.471Z,1727805510.471 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-10-01T17:58:30.471Z,1727805510.471 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-10-01T17:58:30.472Z,1727805510.472 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-10-01T17:58:30.472Z,1727805510.472 [BuoyancyServo](INFO): Powering down 2024-10-01T17:58:30.484Z,1727805510.484 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-10-01T17:58:30.484Z,1727805510.484 [ElevatorServo](INFO): Powering down 2024-10-01T17:58:30.485Z,1727805510.485 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-10-01T17:58:30.485Z,1727805510.485 [MassServo](INFO): Powering down 2024-10-01T17:58:30.486Z,1727805510.486 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-10-01T17:58:30.486Z,1727805510.486 [RudderServo](INFO): Powering down 2024-10-01T17:58:30.487Z,1727805510.487 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-10-01T17:58:30.487Z,1727805510.487 [ThrusterHE](INFO): Powering down 2024-10-01T17:58:30.488Z,1727805510.488 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-10-01T17:58:30.488Z,1727805510.488 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-10-01T17:58:30.489Z,1727805510.489 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-10-01T17:58:30.489Z,1727805510.489 [CBIT](DEBUG): Powering off loads. 2024-10-01T17:58:30.500Z,1727805510.500 [CBIT](DEBUG): Disabling WDT. 2024-10-01T17:58:30.512Z,1727805510.512 [CBIT](DEBUG): Opening all GF detection circuits. 2024-10-01T17:58:30.513Z,1727805510.513 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.547Z,1727805510.547 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.549Z,1727805510.549 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.555Z,1727805510.555 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.706Z,1727805510.706 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-01T17:58:30.753Z,1727805510.753 [logger ThreadHandler](INFO): Thread cancelled.