2024-02-29T20:27:54.149Z,1709238474.149 [Supervisor](DEBUG): Initializing supervisor. 2024-02-29T20:27:54.154Z,1709238474.154 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-02-29T20:27:54.154Z,1709238474.154 [SyncHandler](INFO): Protected caller Thread ID is 1809 2024-02-29T20:27:54.155Z,1709238474.155 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-02-29T20:27:54.156Z,1709238474.156 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-02-29T20:27:54.156Z,1709238474.156 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1810 2024-02-29T20:27:54.160Z,1709238474.160 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-02-29T20:27:54.177Z,1709238474.177 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-02-29T20:27:54.178Z,1709238474.178 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-02-29T20:27:54.178Z,1709238474.178 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1811 2024-02-29T20:27:54.182Z,1709238474.182 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-02-29T20:27:54.183Z,1709238474.183 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-02-29T20:27:54.184Z,1709238474.184 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1812 2024-02-29T20:27:54.186Z,1709238474.186 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-02-29T20:27:54.187Z,1709238474.187 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-02-29T20:27:54.187Z,1709238474.187 [logger ThreadHandler](INFO): Protected caller Thread ID is 1813 2024-02-29T20:27:54.191Z,1709238474.191 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-02-29T20:27:54.191Z,1709238474.191 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-02-29T20:27:54.192Z,1709238474.192 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-02-29T20:27:54.423Z,1709238474.423 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-02-29T20:27:54.423Z,1709238474.423 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-02-29T20:27:54.640Z,1709238474.640 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-02-29T20:27:54.641Z,1709238474.641 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-02-29T20:27:54.738Z,1709238474.738 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-02-29T20:27:54.738Z,1709238474.738 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-02-29T20:27:54.936Z,1709238474.936 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-02-29T20:27:54.936Z,1709238474.936 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-02-29T20:27:55.432Z,1709238475.432 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-02-29T20:27:55.433Z,1709238475.433 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-02-29T20:27:55.545Z,1709238475.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-02-29T20:27:55.545Z,1709238475.545 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-02-29T20:27:55.827Z,1709238475.827 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-02-29T20:27:55.827Z,1709238475.827 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-02-29T20:27:56.054Z,1709238476.054 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-02-29T20:27:56.054Z,1709238476.054 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-02-29T20:27:56.646Z,1709238476.646 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-02-29T20:27:56.646Z,1709238476.646 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-02-29T20:27:57.092Z,1709238477.092 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-02-29T20:27:57.092Z,1709238477.092 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-02-29T20:27:57.173Z,1709238477.173 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-02-29T20:27:57.552Z,1709238477.552 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-02-29T20:27:57.553Z,1709238477.553 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-02-29T20:27:57.694Z,1709238477.694 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-02-29T20:27:57.695Z,1709238477.695 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-02-29T20:27:58.556Z,1709238478.556 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-02-29T20:27:58.556Z,1709238478.556 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-02-29T20:27:58.940Z,1709238478.940 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-02-29T20:27:58.941Z,1709238478.941 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-02-29T20:27:59.026Z,1709238479.026 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2024-02-29T20:27:59.027Z,1709238479.027 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2024-02-29T20:27:59.113Z,1709238479.113 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2024-02-29T20:27:59.224Z,1709238479.224 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2024-02-29T20:27:59.332Z,1709238479.332 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg 2024-02-29T20:27:59.441Z,1709238479.441 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2024-02-29T20:27:59.545Z,1709238479.545 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2024-02-29T20:27:59.632Z,1709238479.632 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2024-02-29T20:27:59.740Z,1709238479.740 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2024-02-29T20:27:59.876Z,1709238479.876 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2024-02-29T20:28:00.071Z,1709238480.071 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2024-02-29T20:28:00.169Z,1709238480.169 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2024-02-29T20:28:00.442Z,1709238480.442 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-02-29T20:28:00.444Z,1709238480.444 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/ 2024-02-29T20:28:00.444Z,1709238480.444 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-02-29T20:28:02.709Z,1709238482.709 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-02-29T20:28:03.053Z,1709238483.053 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-02-29T20:28:03.054Z,1709238483.054 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-02-29T20:28:03.492Z,1709238483.492 [AHRS_M2] Loaded 2024-02-29T20:28:03.492Z,1709238483.492 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-02-29T20:28:04.330Z,1709238484.330 [BPC1] Loaded 2024-02-29T20:28:04.330Z,1709238484.330 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-02-29T20:28:04.455Z,1709238484.455 [DataOverHttps] Loaded 2024-02-29T20:28:04.456Z,1709238484.456 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-02-29T20:28:04.459Z,1709238484.459 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408854E0 2024-02-29T20:28:04.460Z,1709238484.460 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1896 2024-02-29T20:28:04.480Z,1709238484.480 [Depth_Keller] Loaded 2024-02-29T20:28:04.481Z,1709238484.481 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-02-29T20:28:04.485Z,1709238484.485 [DropWeight] Loaded 2024-02-29T20:28:04.486Z,1709238484.486 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-02-29T20:28:04.549Z,1709238484.549 [NAL9602] Loaded 2024-02-29T20:28:04.549Z,1709238484.549 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-02-29T20:28:04.579Z,1709238484.579 [Onboard] Loaded 2024-02-29T20:28:04.579Z,1709238484.579 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-02-29T20:28:04.580Z,1709238484.580 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408B54E0 2024-02-29T20:28:04.580Z,1709238484.580 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1897 2024-02-29T20:28:04.594Z,1709238484.594 [Power24vConverter] Loaded 2024-02-29T20:28:04.594Z,1709238484.594 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-02-29T20:28:04.609Z,1709238484.609 [Radio_Surface] Loaded 2024-02-29T20:28:04.609Z,1709238484.609 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-02-29T20:28:04.610Z,1709238484.610 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408E54E0 2024-02-29T20:28:04.610Z,1709238484.610 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1898 2024-02-29T20:28:04.624Z,1709238484.624 [Sonardyne_Nano] Loaded 2024-02-29T20:28:04.624Z,1709238484.624 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-02-29T20:28:04.715Z,1709238484.715 [DAT] Loaded 2024-02-29T20:28:04.715Z,1709238484.715 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-02-29T20:28:04.716Z,1709238484.716 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409154E0 2024-02-29T20:28:04.716Z,1709238484.716 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1899 2024-02-29T20:28:04.717Z,1709238484.717 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-02-29T20:28:04.717Z,1709238484.717 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-02-29T20:28:04.835Z,1709238484.835 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-02-29T20:28:04.836Z,1709238484.836 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-02-29T20:28:04.890Z,1709238484.890 [VerticalControl](DEBUG): Construct VerticalControl. 2024-02-29T20:28:04.948Z,1709238484.948 [VerticalControl] Loaded 2024-02-29T20:28:04.949Z,1709238484.949 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-02-29T20:28:04.951Z,1709238484.951 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-02-29T20:28:04.993Z,1709238484.993 [HorizontalControl] Loaded 2024-02-29T20:28:04.993Z,1709238484.993 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-02-29T20:28:04.996Z,1709238484.996 [SpeedControl](DEBUG): Construct SpeedControl. 2024-02-29T20:28:04.999Z,1709238484.999 [SpeedControl] Loaded 2024-02-29T20:28:04.999Z,1709238484.999 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-02-29T20:28:05.002Z,1709238485.002 [LoopControl](DEBUG): Construct LoopControl. 2024-02-29T20:28:05.002Z,1709238485.002 [LoopControl] Loaded 2024-02-29T20:28:05.002Z,1709238485.002 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-02-29T20:28:05.003Z,1709238485.003 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-02-29T20:28:05.003Z,1709238485.003 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-02-29T20:28:05.014Z,1709238485.014 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-02-29T20:28:05.014Z,1709238485.014 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-02-29T20:28:05.041Z,1709238485.041 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-02-29T20:28:05.042Z,1709238485.042 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-02-29T20:28:05.156Z,1709238485.156 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-02-29T20:28:05.156Z,1709238485.156 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-02-29T20:28:05.198Z,1709238485.198 [DeadReckonUsingSpeedCalculator] Loaded 2024-02-29T20:28:05.198Z,1709238485.198 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-02-29T20:28:05.240Z,1709238485.240 [DeadReckonWithRespectToSeafloor] Loaded 2024-02-29T20:28:05.240Z,1709238485.240 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-02-29T20:28:05.254Z,1709238485.254 [NavChart] Loaded 2024-02-29T20:28:05.254Z,1709238485.254 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-02-29T20:28:05.260Z,1709238485.260 [UniversalFixResidualReporter] Loaded 2024-02-29T20:28:05.260Z,1709238485.260 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-02-29T20:28:05.261Z,1709238485.261 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-02-29T20:28:05.261Z,1709238485.261 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-02-29T20:28:05.422Z,1709238485.422 [SBIT](DEBUG): Construct Startup Built In Test. 2024-02-29T20:28:05.431Z,1709238485.431 [SBIT] Loaded 2024-02-29T20:28:05.432Z,1709238485.432 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-02-29T20:28:05.435Z,1709238485.435 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-02-29T20:28:05.447Z,1709238485.447 [IBIT] Loaded 2024-02-29T20:28:05.447Z,1709238485.447 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-02-29T20:28:05.453Z,1709238485.453 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-02-29T20:28:05.558Z,1709238485.558 [CBIT] Loaded 2024-02-29T20:28:05.559Z,1709238485.559 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-02-29T20:28:05.559Z,1709238485.559 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-02-29T20:28:05.560Z,1709238485.560 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-02-29T20:28:05.716Z,1709238485.716 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-02-29T20:28:05.716Z,1709238485.716 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-02-29T20:28:05.850Z,1709238485.850 [BuoyancyServo] Loaded 2024-02-29T20:28:05.850Z,1709238485.850 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-02-29T20:28:05.871Z,1709238485.871 [ElevatorServo] Loaded 2024-02-29T20:28:05.871Z,1709238485.871 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-02-29T20:28:05.891Z,1709238485.891 [MassServo] Loaded 2024-02-29T20:28:05.891Z,1709238485.891 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-02-29T20:28:05.910Z,1709238485.910 [RudderServo] Loaded 2024-02-29T20:28:05.910Z,1709238485.910 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-02-29T20:28:05.925Z,1709238485.925 [ThrusterHE] Loaded 2024-02-29T20:28:05.926Z,1709238485.926 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-02-29T20:28:05.926Z,1709238485.926 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-02-29T20:28:05.926Z,1709238485.926 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-02-29T20:28:06.102Z,1709238486.102 [CTD_Seabird] Loaded 2024-02-29T20:28:06.102Z,1709238486.102 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-02-29T20:28:06.103Z,1709238486.103 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B254E0 2024-02-29T20:28:06.104Z,1709238486.104 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1900 2024-02-29T20:28:06.124Z,1709238486.124 [PAR_Licor] Loaded 2024-02-29T20:28:06.124Z,1709238486.124 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-02-29T20:28:06.165Z,1709238486.165 [WetLabsBB2FL] Loaded 2024-02-29T20:28:06.165Z,1709238486.165 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-02-29T20:28:06.166Z,1709238486.166 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B554E0 2024-02-29T20:28:06.166Z,1709238486.166 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1901 2024-02-29T20:28:06.167Z,1709238486.167 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-02-29T20:28:06.168Z,1709238486.168 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-02-29T20:28:06.234Z,1709238486.234 [DepthRateCalculator] Loaded 2024-02-29T20:28:06.235Z,1709238486.235 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-02-29T20:28:06.240Z,1709238486.240 [PitchRateCalculator] Loaded 2024-02-29T20:28:06.240Z,1709238486.240 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-02-29T20:28:06.249Z,1709238486.249 [SpeedCalculator] Loaded 2024-02-29T20:28:06.249Z,1709238486.249 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-02-29T20:28:06.253Z,1709238486.253 [YawRateCalculator] Loaded 2024-02-29T20:28:06.254Z,1709238486.254 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-02-29T20:28:06.286Z,1709238486.286 [ElevatorOffsetCalculator] Loaded 2024-02-29T20:28:06.286Z,1709238486.286 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-02-29T20:28:06.287Z,1709238486.287 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-02-29T20:28:06.287Z,1709238486.287 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-02-29T20:28:06.351Z,1709238486.351 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-02-29T20:28:06.357Z,1709238486.357 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-02-29T20:28:06.360Z,1709238486.360 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-02-29T20:28:06.371Z,1709238486.371 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-02-29T20:28:06.373Z,1709238486.373 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BE14E0 2024-02-29T20:28:06.373Z,1709238486.373 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1902 2024-02-29T20:28:06.378Z,1709238486.378 [Supervisor](INFO): Main Thread ID is 1808 2024-02-29T20:28:06.378Z,1709238486.378 [Supervisor](DEBUG): Running supervisor. 2024-02-29T20:28:06.378Z,1709238486.378 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1903 2024-02-29T20:28:06.379Z,1709238486.379 [CommandExec](INFO): Initializing the command executive. 2024-02-29T20:28:06.381Z,1709238486.381 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1904 2024-02-29T20:28:06.383Z,1709238486.383 [controlThread ThreadHandler](INFO): Handler Thread ID is 1905 2024-02-29T20:28:06.383Z,1709238486.383 [controlThread](DEBUG): Initializing ControlThread 2024-02-29T20:28:06.390Z,1709238486.390 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-02-29T20:28:06.392Z,1709238486.392 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-02-29T20:28:06.393Z,1709238486.393 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-02-29T20:28:06.393Z,1709238486.393 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-02-29T20:28:06.394Z,1709238486.394 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-29T20:28:06.395Z,1709238486.395 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-02-29T20:28:06.395Z,1709238486.395 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-02-29T20:28:06.396Z,1709238486.396 [SBIT](INFO): Initialize SBIT Component. 2024-02-29T20:28:06.396Z,1709238486.396 [SBIT](IMPORTANT): git: 2024-02-15-11-g938a8443c 2024-02-29T20:28:06.396Z,1709238486.396 [SBIT](INFO): git hash: 938a8443c99493f6074473dd0552d31c6d48c406 2024-02-29T20:28:06.397Z,1709238486.397 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-02-29T20:28:06.398Z,1709238486.398 [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-02-29T20:28:06.399Z,1709238486.399 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2024-02-29T20:28:06.399Z,1709238486.399 [IBIT](INFO): Initialize IBIT Component. 2024-02-29T20:28:06.400Z,1709238486.400 [CBIT](DEBUG): Initialize CBIT Component. 2024-02-29T20:28:06.401Z,1709238486.401 [logger ThreadHandler](INFO): Handler Thread ID is 1906 2024-02-29T20:28:06.412Z,1709238486.412 [CBIT](DEBUG): Initialized mux pins. 2024-02-29T20:28:06.412Z,1709238486.412 [CBIT](DEBUG): Initializing the watchdog timer. 2024-02-29T20:28:06.420Z,1709238486.420 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1907 2024-02-29T20:28:06.422Z,1709238486.422 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-02-29T20:28:06.432Z,1709238486.432 [Onboard ThreadHandler](INFO): Handler Thread ID is 1908 2024-02-29T20:28:06.436Z,1709238486.436 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-02-29T20:28:06.437Z,1709238486.437 [CBIT](DEBUG): Initializing heartbeat. 2024-02-29T20:28:06.453Z,1709238486.453 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1909 2024-02-29T20:28:06.468Z,1709238486.468 [DAT ThreadHandler](INFO): Handler Thread ID is 1910 2024-02-29T20:28:06.469Z,1709238486.469 [DAT](INFO): Powering up 2024-02-29T20:28:06.469Z,1709238486.469 [DAT](DEBUG): Initializing DAT. 2024-02-29T20:28:06.474Z,1709238486.474 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1912 2024-02-29T20:28:06.474Z,1709238486.474 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-02-29T20:28:06.482Z,1709238486.482 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1914 2024-02-29T20:28:06.485Z,1709238486.485 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1916 2024-02-29T20:28:06.487Z,1709238486.487 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-02-29T20:28:06.487Z,1709238486.487 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-02-29T20:28:06.488Z,1709238486.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-02-29T20:28:06.488Z,1709238486.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-02-29T20:28:06.488Z,1709238486.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-02-29T20:28:06.488Z,1709238486.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-02-29T20:28:06.489Z,1709238486.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-02-29T20:28:06.489Z,1709238486.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-02-29T20:28:06.489Z,1709238486.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-02-29T20:28:06.489Z,1709238486.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-02-29T20:28:06.489Z,1709238486.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-02-29T20:28:06.489Z,1709238486.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-02-29T20:28:06.493Z,1709238486.493 [WetLabsBB2FL](INFO): Powering up 2024-02-29T20:28:06.508Z,1709238486.508 [CBIT](DEBUG): Deactivating GF circuits. 2024-02-29T20:28:06.508Z,1709238486.508 [CBIT](DEBUG): Deactivating emergency mode. 2024-02-29T20:28:06.548Z,1709238486.548 [CBIT](DEBUG): Backplane powered. 2024-02-29T20:28:06.552Z,1709238486.552 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-02-29T20:28:06.553Z,1709238486.553 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-02-29T20:28:06.553Z,1709238486.553 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-02-29T20:28:06.553Z,1709238486.553 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-02-29T20:28:06.554Z,1709238486.554 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-02-29T20:28:06.555Z,1709238486.555 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-02-29T20:28:06.555Z,1709238486.555 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Startup.tx 2024-02-29T20:28:06.567Z,1709238486.567 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-02-29T20:28:06.599Z,1709238486.599 [MissionManager](DEBUG): 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-02-29T20:28:06.600Z,1709238486.600 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-02-29T20:28:06.601Z,1709238486.601 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Default.tx 2024-02-29T20:28:06.645Z,1709238486.645 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-02-29T20:28:06.646Z,1709238486.646 [Default:A.Wait](DEBUG): Construct Wait. 2024-02-29T20:28:06.660Z,1709238486.660 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-02-29T20:28:06.671Z,1709238486.671 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-02-29T20:28:06.687Z,1709238486.687 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-02-29T20:28:06.701Z,1709238486.701 [Default:E.Execute](DEBUG): Construct Execute. 2024-02-29T20:28:06.719Z,1709238486.719 [MissionManager](DEBUG): 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-02-29T20:28:06.725Z,1709238486.725 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,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-02-29T20:28:06.743Z,1709238486.743 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-02-29T20:28:06.810Z,1709238486.810 [Power24vConverter](INFO): Powering up. 2024-02-29T20:28:06.811Z,1709238486.811 [Sonardyne_Nano](INFO): Initializing. 2024-02-29T20:28:06.860Z,1709238486.860 [Radio_Surface](INFO): Powering up 2024-02-29T20:28:06.861Z,1709238486.861 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:06.868Z,1709238486.868 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-02-29T20:28:06.869Z,1709238486.869 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:06.876Z,1709238486.876 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-29T20:28:06.877Z,1709238486.877 [MassServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:06.888Z,1709238486.888 [MassServo](DEBUG): Initializing MassServo. 2024-02-29T20:28:06.889Z,1709238486.889 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:06.897Z,1709238486.897 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-29T20:28:06.897Z,1709238486.897 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:06.904Z,1709238486.904 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-02-29T20:28:07.181Z,1709238487.181 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-02-29T20:28:07.181Z,1709238487.181 [DropWeight] Hardware Fault, FailCount= 1 2024-02-29T20:28:07.181Z,1709238487.181 [DropWeight](ERROR): Hardware Fault 2024-02-29T20:28:07.203Z,1709238487.203 [CommandExec](FAULT): Scheduling is paused 2024-02-29T20:28:07.208Z,1709238487.208 [CBIT](INFO): Critical error at 20240229T202807 2024-02-29T20:28:07.209Z,1709238487.209 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-02-29T20:28:07.211Z,1709238487.211 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-02-29T20:28:07.211Z,1709238487.211 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-02-29T20:28:07.559Z,1709238487.559 [CBIT](INFO): Critical error at 20240229T202807 2024-02-29T20:28:08.592Z,1709238488.592 [WetLabsBB2FL](INFO): Powering down 2024-02-29T20:28:08.754Z,1709238488.754 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-02-29T20:28:10.016Z,1709238490.016 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409 2024-02-29T20:28:12.116Z,1709238492.116 [RudderServo](FAULT): Overload Error 2024-02-29T20:28:12.116Z,1709238492.116 [RudderServo] Hardware Fault, FailCount= 1 2024-02-29T20:28:12.117Z,1709238492.117 [RudderServo](ERROR): Hardware Fault 2024-02-29T20:28:12.155Z,1709238492.155 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-02-29T20:28:12.633Z,1709238492.633 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-29T20:28:12.633Z,1709238492.633 [RudderServo](INFO): Powering down 2024-02-29T20:28:12.634Z,1709238492.634 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-02-29T20:28:13.267Z,1709238493.267 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:13.385Z,1709238493.385 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-29T20:28:13.389Z,1709238493.389 [CBIT](INFO): Clearing failed state for component RudderServo 2024-02-29T20:28:13.390Z,1709238493.390 [RudderServo] No Fault, FailCount= 1 2024-02-29T20:28:16.493Z,1709238496.493 [CBIT](CRITICAL): Environmental Failure. Press:14.743506 PSI. Humidity:45%. Temp:24 C. ABORTING MISSION 2024-02-29T20:28:16.922Z,1709238496.922 [CBIT](INFO): Critical error at 20240229T202816 2024-02-29T20:28:17.150Z,1709238497.150 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004668 2024-02-29T20:28:18.516Z,1709238498.516 [RudderServo](FAULT): Overload Error 2024-02-29T20:28:18.516Z,1709238498.516 [RudderServo] Hardware Fault, FailCount= 2 2024-02-29T20:28:18.516Z,1709238498.516 [RudderServo](ERROR): Hardware Fault 2024-02-29T20:28:18.544Z,1709238498.544 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-02-29T20:28:18.898Z,1709238498.898 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-29T20:28:18.898Z,1709238498.898 [RudderServo](INFO): Powering down 2024-02-29T20:28:19.524Z,1709238499.524 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-02-29T20:28:19.524Z,1709238499.524 [CTD_Seabird] Communications Fault, FailCount= 1 2024-02-29T20:28:19.524Z,1709238499.524 [CTD_Seabird](ERROR): Communications Fault 2024-02-29T20:28:19.682Z,1709238499.682 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:19.801Z,1709238499.801 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-29T20:28:19.805Z,1709238499.805 [CBIT](INFO): Clearing failed state for component RudderServo 2024-02-29T20:28:19.805Z,1709238499.805 [RudderServo] No Fault, FailCount= 2 2024-02-29T20:28:19.805Z,1709238499.805 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-02-29T20:28:19.929Z,1709238499.929 [CTD_Seabird](INFO): Powering down 2024-02-29T20:28:20.957Z,1709238500.957 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-02-29T20:28:20.957Z,1709238500.957 [CTD_Seabird] No Fault, FailCount= 1 2024-02-29T20:28:21.272Z,1709238501.272 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-02-29T20:28:24.920Z,1709238504.920 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-02-29T20:28:24.920Z,1709238504.920 [AHRS_M2] Data Fault, FailCount= 1 2024-02-29T20:28:24.920Z,1709238504.920 [AHRS_M2](ERROR): Data Fault 2024-02-29T20:28:24.972Z,1709238504.972 [RudderServo](FAULT): Overload Error 2024-02-29T20:28:24.972Z,1709238504.972 [RudderServo] Hardware Fault, FailCount= 3 2024-02-29T20:28:24.972Z,1709238504.972 [RudderServo](ERROR): Hardware Fault 2024-02-29T20:28:24.000Z,1709238505.000 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-02-29T20:28:25.000Z,1709238505.000 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-02-29T20:28:25.001Z,1709238505.001 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2024-02-29T20:28:25.313Z,1709238505.313 [AHRS_M2](INFO): Powering down 2024-02-29T20:28:25.398Z,1709238505.398 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-29T20:28:25.399Z,1709238505.399 [RudderServo](INFO): Powering down 2024-02-29T20:28:25.401Z,1709238505.401 [CBIT](INFO): Critical error at 20240229T202825 2024-02-29T20:28:26.142Z,1709238506.142 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:26.261Z,1709238506.261 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-29T20:28:26.264Z,1709238506.264 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-02-29T20:28:26.264Z,1709238506.264 [AHRS_M2] No Fault, FailCount= 1 2024-02-29T20:28:26.525Z,1709238506.525 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-02-29T20:28:26.950Z,1709238506.950 [SBIT](IMPORTANT): Beginning Startup BIT 2024-02-29T20:28:26.954Z,1709238506.954 [CBIT](IMPORTANT): Beginning ground fault scan 2024-02-29T20:28:28.996Z,1709238508.996 [ElevatorServo](FAULT): Overload Error 2024-02-29T20:28:28.996Z,1709238508.996 [ElevatorServo] Hardware Fault, FailCount= 1 2024-02-29T20:28:28.996Z,1709238508.996 [ElevatorServo](ERROR): Hardware Fault 2024-02-29T20:28:29.085Z,1709238509.085 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-02-29T20:28:29.381Z,1709238509.381 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-29T20:28:29.381Z,1709238509.381 [ElevatorServo](INFO): Powering down 2024-02-29T20:28:30.080Z,1709238510.080 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-02-29T20:28:30.564Z,1709238510.564 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-02-29T20:28:30.589Z,1709238510.589 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:30.709Z,1709238510.709 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-29T20:28:30.741Z,1709238510.741 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-02-29T20:28:30.741Z,1709238510.741 [ElevatorServo] No Fault, FailCount= 1 2024-02-29T20:28:31.064Z,1709238511.064 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-02-29T20:28:31.469Z,1709238511.469 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-02-29T20:28:34.324Z,1709238514.324 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-02-29T20:28:34.324Z,1709238514.324 [CTD_Seabird] Communications Fault, FailCount= 2 2024-02-29T20:28:34.324Z,1709238514.324 [CTD_Seabird](ERROR): Communications Fault 2024-02-29T20:28:34.549Z,1709238514.549 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-02-29T20:28:34.728Z,1709238514.728 [CTD_Seabird](INFO): Powering down 2024-02-29T20:28:34.869Z,1709238514.869 [NAL9602](INFO): Powering up NAL9602 2024-02-29T20:28:35.720Z,1709238515.720 [ElevatorServo](FAULT): Overload Error 2024-02-29T20:28:35.720Z,1709238515.720 [ElevatorServo] Hardware Fault, FailCount= 2 2024-02-29T20:28:35.720Z,1709238515.720 [ElevatorServo](ERROR): Hardware Fault 2024-02-29T20:28:35.773Z,1709238515.773 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-02-29T20:28:35.773Z,1709238515.773 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-02-29T20:28:35.773Z,1709238515.773 [CTD_Seabird] No Fault, FailCount= 2 2024-02-29T20:28:36.072Z,1709238516.072 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-02-29T20:28:36.087Z,1709238516.087 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-29T20:28:36.087Z,1709238516.087 [ElevatorServo](INFO): Powering down 2024-02-29T20:28:36.898Z,1709238516.898 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:37.017Z,1709238517.017 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-29T20:28:37.048Z,1709238517.048 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-02-29T20:28:37.048Z,1709238517.048 [ElevatorServo] No Fault, FailCount= 2 2024-02-29T20:28:38.552Z,1709238518.552 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.008638 CHAN A1 (24V): 0.055017 CHAN A2 (12V): 0.000262 CHAN A3 (5V): -0.001763 CHAN B0 (3.3V): -0.000783 CHAN B1 (3.15aV): -0.000543 CHAN B2 (3.15bV): -0.000737 CHAN B3 (GND): -0.002286 OPEN: 0.004456 Full Scale: +/- 1 mA 2024-02-29T20:28:39.795Z,1709238519.795 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:40.122Z,1709238520.122 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-02-29T20:28:40.123Z,1709238520.123 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-02-29T20:28:40.277Z,1709238520.277 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:40.883Z,1709238520.883 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:41.311Z,1709238521.311 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:41.656Z,1709238521.656 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-02-29T20:28:41.657Z,1709238521.657 [AHRS_M2] Data Fault, FailCount= 2 2024-02-29T20:28:41.657Z,1709238521.657 [AHRS_M2](ERROR): Data Fault 2024-02-29T20:28:41.911Z,1709238521.911 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-02-29T20:28:41.994Z,1709238521.994 [AHRS_M2](INFO): Powering down 2024-02-29T20:28:42.404Z,1709238522.404 [ElevatorServo](FAULT): Overload Error 2024-02-29T20:28:42.404Z,1709238522.404 [ElevatorServo] Hardware Fault, FailCount= 3 2024-02-29T20:28:42.404Z,1709238522.404 [ElevatorServo](ERROR): Hardware Fault 2024-02-29T20:28:42.485Z,1709238522.485 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-02-29T20:28:42.485Z,1709238522.485 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-02-29T20:28:42.792Z,1709238522.792 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-29T20:28:42.792Z,1709238522.792 [ElevatorServo](INFO): Powering down 2024-02-29T20:28:42.823Z,1709238522.823 [CBIT](INFO): Critical error at 20240229T202842 2024-02-29T20:28:42.825Z,1709238522.825 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-02-29T20:28:42.825Z,1709238522.825 [AHRS_M2] No Fault, FailCount= 2 2024-02-29T20:28:43.149Z,1709238523.149 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-02-29T20:28:43.759Z,1709238523.759 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-29T20:28:43.883Z,1709238523.883 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-29T20:28:46.009Z,1709238526.009 [NAL9602](INFO): NAL9602 initialized 2024-02-29T20:28:48.851Z,1709238528.851 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-02-29T20:28:49.137Z,1709238529.137 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-02-29T20:28:49.137Z,1709238529.137 [CTD_Seabird] Communications Fault, FailCount= 3 2024-02-29T20:28:49.137Z,1709238529.137 [CTD_Seabird](ERROR): Communications Fault 2024-02-29T20:28:49.541Z,1709238529.541 [CTD_Seabird](INFO): Powering down 2024-02-29T20:28:49.766Z,1709238529.766 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-02-29T20:28:49.935Z,1709238529.935 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-02-29T20:28:49.945Z,1709238529.945 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2024-02-29T20:28:50.390Z,1709238530.390 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-02-29T20:28:51.000Z,1709238531.000 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-02-29T20:28:51.371Z,1709238531.371 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-02-29T20:28:51.751Z,1709238531.751 [AHRS_M2](ERROR): Start data-stream UART error: serial buffer full 2024-02-29T20:28:52.446Z,1709238532.446 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:52.853Z,1709238532.853 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:53.249Z,1709238533.249 [CommandExec](IMPORTANT): got command show variable omega 2024-02-29T20:28:53.345Z,1709238533.345 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:53.648Z,1709238533.648 [CommandExec](IMPORTANT): Simulator.designOmega (revolution_per_minute) 2024-02-29T20:28:54.042Z,1709238534.042 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:54.461Z,1709238534.461 [CommandExec](IMPORTANT): SpeedControl.propOmegaAction (radian_per_second) 2024-02-29T20:28:54.741Z,1709238534.741 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:55.097Z,1709238535.097 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:55.506Z,1709238535.506 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:55.939Z,1709238535.939 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:56.303Z,1709238536.303 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:56.725Z,1709238536.725 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:57.133Z,1709238537.133 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:57.514Z,1709238537.514 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:57.930Z,1709238537.930 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:58.327Z,1709238538.327 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:58.890Z,1709238538.890 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:59.299Z,1709238539.299 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:28:59.682Z,1709238539.682 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:29:00.083Z,1709238540.083 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:29:00.494Z,1709238540.494 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:29:00.896Z,1709238540.896 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:29:01.294Z,1709238541.294 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:29:01.706Z,1709238541.706 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:29:02.106Z,1709238542.106 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full 2024-02-29T20:29:02.220Z,1709238542.220 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-02-29T20:29:02.220Z,1709238542.220 [AHRS_M2] Data Fault, FailCount= 3 2024-02-29T20:29:02.221Z,1709238542.221 [AHRS_M2](ERROR): Data Fault 2024-02-29T20:29:02.394Z,1709238542.394 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-02-29T20:29:02.490Z,1709238542.490 [AHRS_M2](INFO): Powering down 2024-02-29T20:29:03.334Z,1709238543.334 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-02-29T20:29:03.335Z,1709238543.335 [AHRS_M2] No Fault, FailCount= 3 2024-02-29T20:29:03.693Z,1709238543.693 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-02-29T20:29:06.496Z,1709238546.496 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-29T20:29:06.496Z,1709238546.496 [DAT] Communications Fault, FailCount= 1 2024-02-29T20:29:06.496Z,1709238546.496 [DAT](ERROR): Communications Fault 2024-02-29T20:29:06.562Z,1709238546.562 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-29T20:29:06.900Z,1709238546.900 [DAT](INFO): Powering down 2024-02-29T20:29:07.006Z,1709238547.006 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-02-29T20:29:07.006Z,1709238547.006 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-02-29T20:29:07.006Z,1709238547.006 [SBIT](FAULT): Control surface position failure. 2024-02-29T20:29:07.815Z,1709238547.815 [CBIT](INFO): Clearing failed state for component DAT 2024-02-29T20:29:07.815Z,1709238547.815 [DAT] No Fault, FailCount= 1 2024-02-29T20:29:08.405Z,1709238548.405 [CommandExec](IMPORTANT): got command show variable omega 2024-02-29T20:29:08.448Z,1709238548.448 [CommandExec](IMPORTANT): Simulator.designOmega (revolution_per_minute) 2024-02-29T20:29:08.547Z,1709238548.547 [CommandExec](IMPORTANT): SpeedControl.propOmegaAction (radian_per_second) 2024-02-29T20:29:09.952Z,1709238549.952 [DAT](INFO): Powering up 2024-02-29T20:29:09.952Z,1709238549.952 [DAT](DEBUG): Initializing DAT. 2024-02-29T20:29:17.036Z,1709238557.036 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-02-29T20:29:17.036Z,1709238557.036 [AHRS_M2] Data Fault, FailCount= 4 2024-02-29T20:29:17.036Z,1709238557.036 [AHRS_M2](ERROR): Data Fault 2024-02-29T20:29:17.082Z,1709238557.082 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-02-29T20:29:17.429Z,1709238557.429 [AHRS_M2](INFO): Powering down 2024-02-29T20:29:18.276Z,1709238558.276 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-02-29T20:29:18.276Z,1709238558.276 [AHRS_M2] No Fault, FailCount= 4 2024-02-29T20:29:18.641Z,1709238558.641 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-02-29T20:29:20.683Z,1709238560.683 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-02-29T20:29:20.683Z,1709238560.683 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-02-29T20:29:20.683Z,1709238560.683 [SBIT](FAULT): Control surface position failure. 2024-02-29T20:29:21.086Z,1709238561.086 [SBIT](CRITICAL): SBIT FAILED 2024-02-29T20:29:21.086Z,1709238561.086 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-02-29T20:29:21.087Z,1709238561.087 [SBIT](IMPORTANT): 2024-02-29T20:29:21.089Z,1709238561.089 [CBIT](INFO): Critical error at 20240229T202921 2024-02-29T20:29:21.490Z,1709238561.490 [MissionManager](IMPORTANT): Started mission Startup 2024-02-29T20:29:21.491Z,1709238561.491 [Startup] Running Loop=1 2024-02-29T20:29:21.491Z,1709238561.491 [Startup](DEBUG): Aggregate::initialize Startup 2024-02-29T20:29:21.491Z,1709238561.491 [Startup:A.GoToSurface] Running Loop=1 2024-02-29T20:29:21.491Z,1709238561.491 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-02-29T20:29:21.492Z,1709238561.492 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-02-29T20:29:21.492Z,1709238561.492 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-02-29T20:29:21.493Z,1709238561.493 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-02-29T20:29:21.493Z,1709238561.493 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-02-29T20:29:21.493Z,1709238561.493 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-02-29T20:29:21.495Z,1709238561.495 [Startup:StartupSatComms] Running Loop=1 2024-02-29T20:29:21.495Z,1709238561.495 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-02-29T20:29:21.495Z,1709238561.495 [Startup:StartupSatComms:A] Running Loop=1 2024-02-29T20:29:21.918Z,1709238561.918 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-02-29T20:29:30.083Z,1709238570.083 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300 revolution_per_minute 2024-02-29T20:29:30.086Z,1709238570.086 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread. 2024-02-29T20:29:30.403Z,1709238570.403 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2024-02-29T20:29:31.984Z,1709238571.984 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-02-29T20:29:31.984Z,1709238571.984 [AHRS_M2] Data Fault, FailCount= 5 2024-02-29T20:29:31.984Z,1709238571.984 [AHRS_M2](ERROR): Data Fault 2024-02-29T20:29:32.026Z,1709238572.026 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-02-29T20:29:32.027Z,1709238572.027 [CBIT](CRITICAL): Data Fault in component: AHRS_M2 2024-02-29T20:29:32.377Z,1709238572.377 [AHRS_M2](INFO): Powering down 2024-02-29T20:29:32.486Z,1709238572.486 [CBIT](INFO): Critical error at 20240229T202932 2024-02-29T20:29:36.489Z,1709238576.489 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:29:36.880Z,1709238576.880 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:29:37.280Z,1709238577.280 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:29:38.931Z,1709238578.931 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:29:39.312Z,1709238579.312 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:29:39.668Z,1709238579.668 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-02-29T20:29:39.668Z,1709238579.668 [ThrusterHE](INFO): Powering down 2024-02-29T20:29:40.720Z,1709238580.720 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-02-29T20:29:40.841Z,1709238580.841 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-02-29T20:29:48.204Z,1709238588.204 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:29:48.514Z,1709238588.514 [CommandExec](IMPORTANT): got command maintain clear 2024-02-29T20:29:48.619Z,1709238588.619 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:29:48.675Z,1709238588.675 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,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-02-29T20:29:49.024Z,1709238589.024 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:30:02.408Z,1709238602.408 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction -300 revolution_per_minute 2024-02-29T20:30:02.410Z,1709238602.410 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread. 2024-02-29T20:30:02.717Z,1709238602.717 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2024-02-29T20:30:06.787Z,1709238606.787 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-02-29T20:30:06.788Z,1709238606.788 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-02-29T20:30:06.788Z,1709238606.788 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-29T20:30:06.789Z,1709238606.789 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-02-29T20:30:06.790Z,1709238606.790 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-02-29T20:30:06.790Z,1709238606.790 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-29T20:30:06.791Z,1709238606.791 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-02-29T20:30:06.791Z,1709238606.791 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-02-29T20:30:06.791Z,1709238606.791 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-29T20:30:06.815Z,1709238606.815 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-29T20:30:06.816Z,1709238606.816 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-29T20:30:06.816Z,1709238606.816 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-29T20:30:07.252Z,1709238607.252 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-29T20:30:07.252Z,1709238607.252 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-02-29T20:30:07.252Z,1709238607.252 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-29T20:30:07.253Z,1709238607.253 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-02-29T20:30:07.253Z,1709238607.253 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-29T20:30:07.253Z,1709238607.253 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-02-29T20:30:07.603Z,1709238607.603 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-29T20:30:08.412Z,1709238608.412 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:30:08.804Z,1709238608.804 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:30:09.232Z,1709238609.232 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:30:09.596Z,1709238609.596 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-02-29T20:30:09.596Z,1709238609.596 [ThrusterHE](INFO): Powering down 2024-02-29T20:30:09.996Z,1709238609.996 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-29T20:30:09.996Z,1709238609.996 [DAT] Communications Fault, FailCount= 2 2024-02-29T20:30:09.996Z,1709238609.996 [DAT](ERROR): Communications Fault 2024-02-29T20:30:10.385Z,1709238610.385 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-02-29T20:30:10.400Z,1709238610.400 [DAT](INFO): Powering down 2024-02-29T20:30:10.505Z,1709238610.505 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-02-29T20:30:10.510Z,1709238610.510 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-29T20:30:11.613Z,1709238611.613 [CBIT](INFO): Clearing failed state for component DAT 2024-02-29T20:30:11.613Z,1709238611.613 [DAT] No Fault, FailCount= 2 2024-02-29T20:30:13.448Z,1709238613.448 [DAT](INFO): Powering up 2024-02-29T20:30:13.448Z,1709238613.448 [DAT](DEBUG): Initializing DAT. 2024-02-29T20:30:13.557Z,1709238613.557 [CommandExec](IMPORTANT): got command maintain clear 2024-02-29T20:30:13.636Z,1709238613.636 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,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-02-29T20:30:16.076Z,1709238616.076 [ThrusterHE](IMPORTANT): Status lock Detected. 2024-02-29T20:30:18.152Z,1709238618.152 [CommandExec](IMPORTANT): got command quit 2024-02-29T20:30:19.156Z,1709238619.156 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:19.156Z,1709238619.156 [CommandExec](INFO): Uninitializing the command executive. 2024-02-29T20:30:19.156Z,1709238619.156 [CommandExec](INFO): Uninitializing the command scheduler. 2024-02-29T20:30:19.156Z,1709238619.156 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:19.252Z,1709238619.252 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-02-29T20:30:19.252Z,1709238619.252 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-02-29T20:30:19.252Z,1709238619.252 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:19.253Z,1709238619.253 [NavChartDb](INFO): Join timeout helper Thread ID is 1945 2024-02-29T20:30:19.548Z,1709238619.548 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:19.548Z,1709238619.548 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:19.552Z,1709238619.552 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-02-29T20:30:19.552Z,1709238619.552 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:19.552Z,1709238619.552 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1946 2024-02-29T20:30:19.676Z,1709238619.676 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:19.676Z,1709238619.676 [WetLabsBB2FL](INFO): Powering down 2024-02-29T20:30:19.677Z,1709238619.677 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:19.677Z,1709238619.677 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-02-29T20:30:19.677Z,1709238619.677 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:19.678Z,1709238619.678 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1947 2024-02-29T20:30:19.796Z,1709238619.796 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:19.796Z,1709238619.796 [CTD_Seabird](INFO): Powering down 2024-02-29T20:30:19.808Z,1709238619.808 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:19.820Z,1709238619.820 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-02-29T20:30:19.820Z,1709238619.820 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:19.820Z,1709238619.820 [DAT](INFO): Join timeout helper Thread ID is 1948 2024-02-29T20:30:20.008Z,1709238620.008 [DAT](INFO): Powering down 2024-02-29T20:30:20.088Z,1709238620.088 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:20.088Z,1709238620.088 [DAT](INFO): Powering down 2024-02-29T20:30:20.089Z,1709238620.089 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:20.104Z,1709238620.104 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-02-29T20:30:20.104Z,1709238620.104 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:20.104Z,1709238620.104 [Radio_Surface](INFO): Join timeout helper Thread ID is 1949 2024-02-29T20:30:20.232Z,1709238620.232 [Radio_Surface](INFO): Powering down 2024-02-29T20:30:20.233Z,1709238620.233 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:20.233Z,1709238620.233 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:20.249Z,1709238620.249 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-02-29T20:30:20.249Z,1709238620.249 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:20.249Z,1709238620.249 [Onboard](INFO): Join timeout helper Thread ID is 1950 2024-02-29T20:30:20.845Z,1709238620.845 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-02-29T20:30:21.560Z,1709238621.560 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:21.560Z,1709238621.560 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.564Z,1709238621.564 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-02-29T20:30:21.565Z,1709238621.565 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.565Z,1709238621.565 [DataOverHttps](INFO): Join timeout helper Thread ID is 1951 2024-02-29T20:30:21.734Z,1709238621.734 [Startup:StartupSatComms:A](INFO): Timed out from 2024-02-29T20:29:21.5Z 2024-02-29T20:30:21.734Z,1709238621.734 [Startup:StartupSatComms:A] Stopped 2024-02-29T20:30:21.749Z,1709238621.749 [Startup:StartupSatComms:B] Running Loop=1 2024-02-29T20:30:21.848Z,1709238621.848 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:21.848Z,1709238621.848 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.853Z,1709238621.853 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-02-29T20:30:21.853Z,1709238621.853 [logger ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.853Z,1709238621.853 [logger](INFO): Join timeout helper Thread ID is 1952 2024-02-29T20:30:21.892Z,1709238621.892 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:21.892Z,1709238621.892 [logger ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.912Z,1709238621.912 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-02-29T20:30:21.913Z,1709238621.913 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.913Z,1709238621.913 [CommandLine](INFO): Join timeout helper Thread ID is 1953 2024-02-29T20:30:21.988Z,1709238621.988 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:21.988Z,1709238621.988 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.993Z,1709238621.993 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-02-29T20:30:21.993Z,1709238621.993 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.993Z,1709238621.993 [CommandExec](INFO): Join timeout helper Thread ID is 1954 2024-02-29T20:30:21.994Z,1709238621.994 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-02-29T20:30:21.994Z,1709238621.994 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:21.995Z,1709238621.995 [controlThread](INFO): Join timeout helper Thread ID is 1955 2024-02-29T20:30:22.064Z,1709238622.064 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-29T20:30:22.064Z,1709238622.064 [controlThread](DEBUG): Uninitializing ControlThread 2024-02-29T20:30:22.065Z,1709238622.065 [AHRS_M2](INFO): Powering down 2024-02-29T20:30:22.067Z,1709238622.067 [NAL9602](INFO): Powering down 2024-02-29T20:30:22.068Z,1709238622.068 [Sonardyne_Nano](INFO): Powering down 2024-02-29T20:30:22.189Z,1709238622.189 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-02-29T20:30:22.190Z,1709238622.190 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-02-29T20:30:22.190Z,1709238622.190 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-02-29T20:30:22.191Z,1709238622.191 [MissionManager](INFO): Uninitializing Mission Default 2024-02-29T20:30:22.193Z,1709238622.193 [MissionManager](INFO): Uninitializing Mission Startup 2024-02-29T20:30:22.193Z,1709238622.193 [Startup] Stopped 2024-02-29T20:30:22.193Z,1709238622.193 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-02-29T20:30:22.194Z,1709238622.194 [Startup:A.GoToSurface] Stopped 2024-02-29T20:30:22.194Z,1709238622.194 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-02-29T20:30:22.194Z,1709238622.194 [Startup:StartupSatComms] Stopped 2024-02-29T20:30:22.194Z,1709238622.194 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-02-29T20:30:22.194Z,1709238622.194 [Startup:StartupSatComms:B] Stopped 2024-02-29T20:30:22.195Z,1709238622.195 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-02-29T20:30:22.196Z,1709238622.196 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-02-29T20:30:22.196Z,1709238622.196 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-02-29T20:30:22.196Z,1709238622.196 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-02-29T20:30:22.197Z,1709238622.197 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-02-29T20:30:22.197Z,1709238622.197 [BuoyancyServo](INFO): Powering down 2024-02-29T20:30:22.208Z,1709238622.208 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-29T20:30:22.208Z,1709238622.208 [ElevatorServo](INFO): Powering down 2024-02-29T20:30:22.209Z,1709238622.209 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-02-29T20:30:22.209Z,1709238622.209 [MassServo](INFO): Powering down 2024-02-29T20:30:22.210Z,1709238622.210 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-29T20:30:22.210Z,1709238622.210 [RudderServo](INFO): Powering down 2024-02-29T20:30:22.211Z,1709238622.211 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-02-29T20:30:22.211Z,1709238622.211 [ThrusterHE](INFO): Powering down 2024-02-29T20:30:22.212Z,1709238622.212 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-02-29T20:30:22.212Z,1709238622.212 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-02-29T20:30:22.212Z,1709238622.212 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-02-29T20:30:22.212Z,1709238622.212 [CBIT](DEBUG): Powering off loads. 2024-02-29T20:30:22.224Z,1709238622.224 [CBIT](DEBUG): Disabling WDT. 2024-02-29T20:30:22.236Z,1709238622.236 [CBIT](DEBUG): Opening all GF detection circuits. 2024-02-29T20:30:22.237Z,1709238622.237 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:22.264Z,1709238622.264 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:22.270Z,1709238622.270 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:22.271Z,1709238622.271 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:22.277Z,1709238622.277 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:22.638Z,1709238622.638 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:22.642Z,1709238622.642 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:22.660Z,1709238622.660 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-29T20:30:22.707Z,1709238622.707 [logger ThreadHandler](INFO): Thread cancelled.