2024-02-28T00:55:48.346Z,1709081748.346 [Supervisor](DEBUG): Initializing supervisor. 2024-02-28T00:55:48.351Z,1709081748.351 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-02-28T00:55:48.351Z,1709081748.351 [SyncHandler](INFO): Protected caller Thread ID is 6638 2024-02-28T00:55:48.352Z,1709081748.352 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-02-28T00:55:48.353Z,1709081748.353 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-02-28T00:55:48.354Z,1709081748.354 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6639 2024-02-28T00:55:48.358Z,1709081748.358 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-02-28T00:55:48.375Z,1709081748.375 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-02-28T00:55:48.376Z,1709081748.376 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-02-28T00:55:48.376Z,1709081748.376 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6640 2024-02-28T00:55:48.380Z,1709081748.380 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-02-28T00:55:48.381Z,1709081748.381 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-02-28T00:55:48.382Z,1709081748.382 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6641 2024-02-28T00:55:48.384Z,1709081748.384 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-02-28T00:55:48.385Z,1709081748.385 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-02-28T00:55:48.385Z,1709081748.385 [logger ThreadHandler](INFO): Protected caller Thread ID is 6642 2024-02-28T00:55:48.389Z,1709081748.389 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-02-28T00:55:48.389Z,1709081748.389 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-02-28T00:55:48.390Z,1709081748.390 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-02-28T00:55:48.615Z,1709081748.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-02-28T00:55:48.616Z,1709081748.616 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-02-28T00:55:48.827Z,1709081748.827 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-02-28T00:55:48.828Z,1709081748.828 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-02-28T00:55:48.925Z,1709081748.925 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-02-28T00:55:48.925Z,1709081748.925 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-02-28T00:55:49.118Z,1709081749.118 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-02-28T00:55:49.119Z,1709081749.119 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-02-28T00:55:49.602Z,1709081749.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-02-28T00:55:49.602Z,1709081749.602 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-02-28T00:55:49.712Z,1709081749.712 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-02-28T00:55:49.713Z,1709081749.713 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-02-28T00:55:49.987Z,1709081749.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-02-28T00:55:49.988Z,1709081749.987 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-02-28T00:55:50.198Z,1709081750.198 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-02-28T00:55:50.199Z,1709081750.199 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-02-28T00:55:50.698Z,1709081750.698 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-02-28T00:55:50.698Z,1709081750.698 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-02-28T00:55:51.131Z,1709081751.131 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-02-28T00:55:51.132Z,1709081751.132 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-02-28T00:55:51.212Z,1709081751.212 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-02-28T00:55:51.580Z,1709081751.580 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-02-28T00:55:51.580Z,1709081751.580 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-02-28T00:55:51.721Z,1709081751.721 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-02-28T00:55:51.721Z,1709081751.721 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-02-28T00:55:52.568Z,1709081752.568 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-02-28T00:55:52.569Z,1709081752.569 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-02-28T00:55:52.951Z,1709081752.951 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-02-28T00:55:52.952Z,1709081752.952 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-02-28T00:55:53.036Z,1709081753.036 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2024-02-28T00:55:53.037Z,1709081753.037 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2024-02-28T00:55:53.122Z,1709081753.122 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2024-02-28T00:55:53.231Z,1709081753.231 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2024-02-28T00:55:53.337Z,1709081753.337 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg 2024-02-28T00:55:53.445Z,1709081753.445 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2024-02-28T00:55:53.587Z,1709081753.587 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2024-02-28T00:55:53.689Z,1709081753.689 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2024-02-28T00:55:53.794Z,1709081753.794 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2024-02-28T00:55:53.928Z,1709081753.928 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2024-02-28T00:55:54.094Z,1709081754.094 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2024-02-28T00:55:54.192Z,1709081754.192 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2024-02-28T00:55:54.464Z,1709081754.464 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-02-28T00:55:54.466Z,1709081754.466 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/ 2024-02-28T00:55:54.466Z,1709081754.466 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-02-28T00:55:54.469Z,1709081754.469 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-02-28T00:55:54.843Z,1709081754.843 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-02-28T00:55:54.843Z,1709081754.843 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-02-28T00:55:55.322Z,1709081755.322 [AHRS_M2] Loaded 2024-02-28T00:55:55.323Z,1709081755.323 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-02-28T00:55:56.213Z,1709081756.213 [BPC1] Loaded 2024-02-28T00:55:56.213Z,1709081756.213 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-02-28T00:55:56.299Z,1709081756.299 [DataOverHttps] Loaded 2024-02-28T00:55:56.299Z,1709081756.299 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-02-28T00:55:56.300Z,1709081756.300 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408854E0 2024-02-28T00:55:56.300Z,1709081756.300 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6724 2024-02-28T00:55:56.321Z,1709081756.321 [Depth_Keller] Loaded 2024-02-28T00:55:56.321Z,1709081756.321 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-02-28T00:55:56.326Z,1709081756.326 [DropWeight] Loaded 2024-02-28T00:55:56.326Z,1709081756.326 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-02-28T00:55:56.390Z,1709081756.390 [NAL9602] Loaded 2024-02-28T00:55:56.390Z,1709081756.390 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-02-28T00:55:56.419Z,1709081756.419 [Onboard] Loaded 2024-02-28T00:55:56.420Z,1709081756.420 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-02-28T00:55:56.421Z,1709081756.421 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408B54E0 2024-02-28T00:55:56.421Z,1709081756.421 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6725 2024-02-28T00:55:56.435Z,1709081756.435 [Power24vConverter] Loaded 2024-02-28T00:55:56.435Z,1709081756.435 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-02-28T00:55:56.449Z,1709081756.449 [Radio_Surface] Loaded 2024-02-28T00:55:56.449Z,1709081756.449 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-02-28T00:55:56.450Z,1709081756.450 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408E54E0 2024-02-28T00:55:56.451Z,1709081756.451 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6726 2024-02-28T00:55:56.464Z,1709081756.464 [Sonardyne_Nano] Loaded 2024-02-28T00:55:56.465Z,1709081756.465 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-02-28T00:55:56.556Z,1709081756.556 [DAT] Loaded 2024-02-28T00:55:56.556Z,1709081756.556 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-02-28T00:55:56.557Z,1709081756.557 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409154E0 2024-02-28T00:55:56.557Z,1709081756.557 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6727 2024-02-28T00:55:56.558Z,1709081756.558 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-02-28T00:55:56.558Z,1709081756.558 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-02-28T00:55:56.684Z,1709081756.684 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-02-28T00:55:56.684Z,1709081756.684 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-02-28T00:55:56.739Z,1709081756.739 [VerticalControl](DEBUG): Construct VerticalControl. 2024-02-28T00:55:56.798Z,1709081756.798 [VerticalControl] Loaded 2024-02-28T00:55:56.799Z,1709081756.799 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-02-28T00:55:56.802Z,1709081756.802 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-02-28T00:55:56.843Z,1709081756.843 [HorizontalControl] Loaded 2024-02-28T00:55:56.843Z,1709081756.843 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-02-28T00:55:56.846Z,1709081756.846 [SpeedControl](DEBUG): Construct SpeedControl. 2024-02-28T00:55:56.849Z,1709081756.849 [SpeedControl] Loaded 2024-02-28T00:55:56.849Z,1709081756.849 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-02-28T00:55:56.852Z,1709081756.852 [LoopControl](DEBUG): Construct LoopControl. 2024-02-28T00:55:56.852Z,1709081756.852 [LoopControl] Loaded 2024-02-28T00:55:56.853Z,1709081756.853 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-02-28T00:55:56.853Z,1709081756.853 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-02-28T00:55:56.853Z,1709081756.853 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-02-28T00:55:56.864Z,1709081756.864 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-02-28T00:55:56.865Z,1709081756.865 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-02-28T00:55:56.894Z,1709081756.894 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-02-28T00:55:56.894Z,1709081756.894 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-02-28T00:55:57.012Z,1709081757.012 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-02-28T00:55:57.012Z,1709081757.012 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-02-28T00:55:57.054Z,1709081757.054 [DeadReckonUsingSpeedCalculator] Loaded 2024-02-28T00:55:57.054Z,1709081757.054 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-02-28T00:55:57.096Z,1709081757.096 [DeadReckonWithRespectToSeafloor] Loaded 2024-02-28T00:55:57.096Z,1709081757.096 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-02-28T00:55:57.110Z,1709081757.110 [NavChart] Loaded 2024-02-28T00:55:57.110Z,1709081757.110 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-02-28T00:55:57.116Z,1709081757.116 [UniversalFixResidualReporter] Loaded 2024-02-28T00:55:57.116Z,1709081757.116 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-02-28T00:55:57.116Z,1709081757.116 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-02-28T00:55:57.117Z,1709081757.117 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-02-28T00:55:57.283Z,1709081757.283 [SBIT](DEBUG): Construct Startup Built In Test. 2024-02-28T00:55:57.292Z,1709081757.292 [SBIT] Loaded 2024-02-28T00:55:57.292Z,1709081757.292 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-02-28T00:55:57.295Z,1709081757.295 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-02-28T00:55:57.308Z,1709081757.308 [IBIT] Loaded 2024-02-28T00:55:57.308Z,1709081757.308 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-02-28T00:55:57.314Z,1709081757.314 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-02-28T00:55:57.419Z,1709081757.419 [CBIT] Loaded 2024-02-28T00:55:57.419Z,1709081757.419 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-02-28T00:55:57.420Z,1709081757.420 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-02-28T00:55:57.420Z,1709081757.420 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-02-28T00:55:57.584Z,1709081757.584 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-02-28T00:55:57.584Z,1709081757.584 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-02-28T00:55:57.723Z,1709081757.723 [BuoyancyServo] Loaded 2024-02-28T00:55:57.723Z,1709081757.723 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-02-28T00:55:57.744Z,1709081757.744 [ElevatorServo] Loaded 2024-02-28T00:55:57.744Z,1709081757.744 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-02-28T00:55:57.764Z,1709081757.764 [MassServo] Loaded 2024-02-28T00:55:57.764Z,1709081757.764 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-02-28T00:55:57.783Z,1709081757.783 [RudderServo] Loaded 2024-02-28T00:55:57.783Z,1709081757.783 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-02-28T00:55:57.798Z,1709081757.798 [ThrusterHE] Loaded 2024-02-28T00:55:57.798Z,1709081757.798 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-02-28T00:55:57.799Z,1709081757.799 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-02-28T00:55:57.799Z,1709081757.799 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-02-28T00:55:57.981Z,1709081757.981 [CTD_Seabird] Loaded 2024-02-28T00:55:57.981Z,1709081757.981 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-02-28T00:55:57.982Z,1709081757.982 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B254E0 2024-02-28T00:55:57.983Z,1709081757.983 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6728 2024-02-28T00:55:58.003Z,1709081758.003 [PAR_Licor] Loaded 2024-02-28T00:55:58.003Z,1709081758.003 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-02-28T00:55:58.044Z,1709081758.044 [WetLabsBB2FL] Loaded 2024-02-28T00:55:58.044Z,1709081758.044 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-02-28T00:55:58.045Z,1709081758.045 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B554E0 2024-02-28T00:55:58.045Z,1709081758.045 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6729 2024-02-28T00:55:58.046Z,1709081758.046 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-02-28T00:55:58.047Z,1709081758.047 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-02-28T00:55:58.149Z,1709081758.149 [DepthRateCalculator] Loaded 2024-02-28T00:55:58.149Z,1709081758.149 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-02-28T00:55:58.154Z,1709081758.154 [PitchRateCalculator] Loaded 2024-02-28T00:55:58.155Z,1709081758.155 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-02-28T00:55:58.163Z,1709081758.163 [SpeedCalculator] Loaded 2024-02-28T00:55:58.164Z,1709081758.164 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-02-28T00:55:58.168Z,1709081758.168 [YawRateCalculator] Loaded 2024-02-28T00:55:58.168Z,1709081758.168 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-02-28T00:55:58.187Z,1709081758.187 [ElevatorOffsetCalculator] Loaded 2024-02-28T00:55:58.188Z,1709081758.188 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-02-28T00:55:58.188Z,1709081758.188 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-02-28T00:55:58.189Z,1709081758.189 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-02-28T00:55:58.249Z,1709081758.249 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-02-28T00:55:58.256Z,1709081758.256 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-02-28T00:55:58.258Z,1709081758.258 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-02-28T00:55:58.270Z,1709081758.270 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-02-28T00:55:58.271Z,1709081758.271 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BE14E0 2024-02-28T00:55:58.271Z,1709081758.271 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6730 2024-02-28T00:55:58.276Z,1709081758.276 [Supervisor](INFO): Main Thread ID is 6322 2024-02-28T00:55:58.276Z,1709081758.276 [Supervisor](DEBUG): Running supervisor. 2024-02-28T00:55:58.276Z,1709081758.276 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6731 2024-02-28T00:55:58.277Z,1709081758.277 [CommandExec](INFO): Initializing the command executive. 2024-02-28T00:55:58.278Z,1709081758.278 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6732 2024-02-28T00:55:58.281Z,1709081758.281 [controlThread ThreadHandler](INFO): Handler Thread ID is 6733 2024-02-28T00:55:58.281Z,1709081758.281 [controlThread](DEBUG): Initializing ControlThread 2024-02-28T00:55:58.285Z,1709081758.285 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-02-28T00:55:58.287Z,1709081758.287 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-02-28T00:55:58.288Z,1709081758.288 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-02-28T00:55:58.288Z,1709081758.288 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-02-28T00:55:58.289Z,1709081758.289 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-28T00:55:58.290Z,1709081758.290 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-02-28T00:55:58.290Z,1709081758.290 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-02-28T00:55:58.290Z,1709081758.290 [SBIT](INFO): Initialize SBIT Component. 2024-02-28T00:55:58.291Z,1709081758.291 [SBIT](IMPORTANT): git: 2024-02-15-11-g938a8443c 2024-02-28T00:55:58.291Z,1709081758.291 [SBIT](INFO): git hash: 938a8443c99493f6074473dd0552d31c6d48c406 2024-02-28T00:55:58.291Z,1709081758.291 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-02-28T00:55:58.293Z,1709081758.293 [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-28T00:55:58.294Z,1709081758.294 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2024-02-28T00:55:58.294Z,1709081758.294 [IBIT](INFO): Initialize IBIT Component. 2024-02-28T00:55:58.295Z,1709081758.295 [CBIT](DEBUG): Initialize CBIT Component. 2024-02-28T00:55:58.296Z,1709081758.296 [logger ThreadHandler](INFO): Handler Thread ID is 6734 2024-02-28T00:55:58.307Z,1709081758.307 [CBIT](DEBUG): Initialized mux pins. 2024-02-28T00:55:58.307Z,1709081758.307 [CBIT](DEBUG): Initializing the watchdog timer. 2024-02-28T00:55:58.316Z,1709081758.316 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6735 2024-02-28T00:55:58.318Z,1709081758.318 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-02-28T00:55:58.331Z,1709081758.331 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-02-28T00:55:58.332Z,1709081758.332 [CBIT](DEBUG): Initializing heartbeat. 2024-02-28T00:55:58.332Z,1709081758.332 [Onboard ThreadHandler](INFO): Handler Thread ID is 6736 2024-02-28T00:55:58.354Z,1709081758.354 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6737 2024-02-28T00:55:58.368Z,1709081758.368 [DAT ThreadHandler](INFO): Handler Thread ID is 6738 2024-02-28T00:55:58.368Z,1709081758.368 [DAT](INFO): Powering up 2024-02-28T00:55:58.369Z,1709081758.369 [DAT](DEBUG): Initializing DAT. 2024-02-28T00:55:58.373Z,1709081758.373 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6740 2024-02-28T00:55:58.373Z,1709081758.373 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-02-28T00:55:58.377Z,1709081758.377 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6742 2024-02-28T00:55:58.380Z,1709081758.380 [WetLabsBB2FL](INFO): Powering up 2024-02-28T00:55:58.382Z,1709081758.382 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6744 2024-02-28T00:55:58.385Z,1709081758.385 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-02-28T00:55:58.385Z,1709081758.385 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-02-28T00:55:58.385Z,1709081758.385 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-02-28T00:55:58.385Z,1709081758.385 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-02-28T00:55:58.386Z,1709081758.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-02-28T00:55:58.386Z,1709081758.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-02-28T00:55:58.386Z,1709081758.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-02-28T00:55:58.386Z,1709081758.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-02-28T00:55:58.386Z,1709081758.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-02-28T00:55:58.386Z,1709081758.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-02-28T00:55:58.387Z,1709081758.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-02-28T00:55:58.387Z,1709081758.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-02-28T00:55:58.403Z,1709081758.403 [CBIT](DEBUG): Deactivating GF circuits. 2024-02-28T00:55:58.403Z,1709081758.403 [CBIT](DEBUG): Deactivating emergency mode. 2024-02-28T00:55:58.443Z,1709081758.443 [CBIT](DEBUG): Backplane powered. 2024-02-28T00:55:58.448Z,1709081758.448 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-02-28T00:55:58.448Z,1709081758.448 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-02-28T00:55:58.448Z,1709081758.448 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-02-28T00:55:58.449Z,1709081758.449 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-02-28T00:55:58.449Z,1709081758.449 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-02-28T00:55:58.451Z,1709081758.451 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-02-28T00:55:58.451Z,1709081758.451 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Startup.tx 2024-02-28T00:55:58.463Z,1709081758.463 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-02-28T00:55:58.494Z,1709081758.494 [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-28T00:55:58.494Z,1709081758.494 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-02-28T00:55:58.495Z,1709081758.495 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Default.tx 2024-02-28T00:55:58.566Z,1709081758.566 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-02-28T00:55:58.567Z,1709081758.567 [Default:A.Wait](DEBUG): Construct Wait. 2024-02-28T00:55:58.569Z,1709081758.569 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-02-28T00:55:58.601Z,1709081758.601 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-02-28T00:55:58.604Z,1709081758.604 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-02-28T00:55:58.610Z,1709081758.610 [Default:E.Execute](DEBUG): Construct Execute. 2024-02-28T00:55:58.628Z,1709081758.628 [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-28T00:55:58.636Z,1709081758.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-28T00:55:58.649Z,1709081758.649 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-02-28T00:55:58.726Z,1709081758.726 [Power24vConverter](INFO): Powering up. 2024-02-28T00:55:58.727Z,1709081758.727 [Sonardyne_Nano](INFO): Initializing. 2024-02-28T00:55:58.759Z,1709081758.759 [Radio_Surface](INFO): Powering up 2024-02-28T00:55:58.797Z,1709081758.797 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:55:58.804Z,1709081758.804 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-02-28T00:55:58.805Z,1709081758.805 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:55:58.812Z,1709081758.812 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-28T00:55:58.812Z,1709081758.812 [MassServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:55:58.820Z,1709081758.820 [MassServo](DEBUG): Initializing MassServo. 2024-02-28T00:55:58.820Z,1709081758.820 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:55:58.828Z,1709081758.828 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-28T00:55:58.828Z,1709081758.828 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-02-28T00:55:58.836Z,1709081758.836 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-02-28T00:55:59.101Z,1709081759.101 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-02-28T00:55:59.101Z,1709081759.101 [DropWeight] Hardware Fault, FailCount= 1 2024-02-28T00:55:59.101Z,1709081759.101 [DropWeight](ERROR): Hardware Fault 2024-02-28T00:55:59.142Z,1709081759.142 [CommandExec](FAULT): Scheduling is paused 2024-02-28T00:55:59.143Z,1709081759.143 [CBIT](INFO): Critical error at 20240228T005559 2024-02-28T00:55:59.143Z,1709081759.143 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-02-28T00:55:59.149Z,1709081759.149 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-02-28T00:55:59.150Z,1709081759.150 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-02-28T00:55:59.486Z,1709081759.486 [CBIT](INFO): Critical error at 20240228T005559 2024-02-28T00:56:00.487Z,1709081760.487 [WetLabsBB2FL](INFO): Powering down 2024-02-28T00:56:00.666Z,1709081760.666 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-02-28T00:56:01.952Z,1709081761.952 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409 2024-02-28T00:56:02.307Z,1709081762.307 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-02-28T00:56:04.044Z,1709081764.044 [RudderServo](FAULT): Overload Error 2024-02-28T00:56:04.044Z,1709081764.044 [RudderServo] Hardware Fault, FailCount= 1 2024-02-28T00:56:04.044Z,1709081764.044 [RudderServo](ERROR): Hardware Fault 2024-02-28T00:56:04.095Z,1709081764.095 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-02-28T00:56:04.484Z,1709081764.484 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-28T00:56:04.484Z,1709081764.484 [RudderServo](INFO): Powering down 2024-02-28T00:56:04.485Z,1709081764.485 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-02-28T00:56:05.167Z,1709081765.167 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:56:05.288Z,1709081765.288 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-28T00:56:05.292Z,1709081765.292 [CBIT](INFO): Clearing failed state for component RudderServo 2024-02-28T00:56:05.293Z,1709081765.293 [RudderServo] No Fault, FailCount= 1 2024-02-28T00:56:08.524Z,1709081768.524 [CBIT](CRITICAL): Environmental Failure. Press:14.715565 PSI. Humidity:42%. Temp:26 C. ABORTING MISSION 2024-02-28T00:56:08.841Z,1709081768.841 [CBIT](INFO): Critical error at 20240228T005608 2024-02-28T00:56:10.420Z,1709081770.420 [RudderServo](FAULT): Overload Error 2024-02-28T00:56:10.420Z,1709081770.420 [RudderServo] Hardware Fault, FailCount= 2 2024-02-28T00:56:10.420Z,1709081770.420 [RudderServo](ERROR): Hardware Fault 2024-02-28T00:56:10.448Z,1709081770.448 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-02-28T00:56:10.802Z,1709081770.802 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-28T00:56:10.802Z,1709081770.802 [RudderServo](INFO): Powering down 2024-02-28T00:56:11.423Z,1709081771.423 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-02-28T00:56:11.424Z,1709081771.424 [CTD_Seabird] Communications Fault, FailCount= 1 2024-02-28T00:56:11.424Z,1709081771.424 [CTD_Seabird](ERROR): Communications Fault 2024-02-28T00:56:11.598Z,1709081771.598 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:56:11.713Z,1709081771.713 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-28T00:56:11.717Z,1709081771.717 [CBIT](INFO): Clearing failed state for component RudderServo 2024-02-28T00:56:11.717Z,1709081771.717 [RudderServo] No Fault, FailCount= 2 2024-02-28T00:56:11.717Z,1709081771.717 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-02-28T00:56:11.828Z,1709081771.828 [CTD_Seabird](INFO): Powering down 2024-02-28T00:56:12.887Z,1709081772.887 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-02-28T00:56:12.887Z,1709081772.887 [CTD_Seabird] No Fault, FailCount= 1 2024-02-28T00:56:13.167Z,1709081773.167 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-02-28T00:56:16.886Z,1709081776.886 [RudderServo](FAULT): Overload Error 2024-02-28T00:56:16.886Z,1709081776.886 [RudderServo] Hardware Fault, FailCount= 3 2024-02-28T00:56:16.886Z,1709081776.886 [RudderServo](ERROR): Hardware Fault 2024-02-28T00:56:16.915Z,1709081776.915 [CBIT](ERROR): Hardware Fault in component: RudderServo 2024-02-28T00:56:16.916Z,1709081776.916 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2024-02-28T00:56:17.258Z,1709081777.258 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-28T00:56:17.258Z,1709081777.258 [RudderServo](INFO): Powering down 2024-02-28T00:56:17.261Z,1709081777.261 [CBIT](INFO): Critical error at 20240228T005616 2024-02-28T00:56:18.059Z,1709081778.059 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:56:18.173Z,1709081778.173 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-28T00:56:18.879Z,1709081778.879 [SBIT](IMPORTANT): Beginning Startup BIT 2024-02-28T00:56:18.884Z,1709081778.884 [CBIT](IMPORTANT): Beginning ground fault scan 2024-02-28T00:56:20.543Z,1709081780.543 [ElevatorServo](FAULT): Overload Error 2024-02-28T00:56:20.543Z,1709081780.543 [ElevatorServo] Hardware Fault, FailCount= 1 2024-02-28T00:56:20.543Z,1709081780.543 [ElevatorServo](ERROR): Hardware Fault 2024-02-28T00:56:20.576Z,1709081780.576 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-02-28T00:56:20.911Z,1709081780.911 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-28T00:56:20.911Z,1709081780.911 [ElevatorServo](INFO): Powering down 2024-02-28T00:56:21.696Z,1709081781.696 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:56:21.812Z,1709081781.812 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-28T00:56:21.848Z,1709081781.848 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-02-28T00:56:21.848Z,1709081781.848 [ElevatorServo] No Fault, FailCount= 1 2024-02-28T00:56:26.220Z,1709081786.220 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-02-28T00:56:26.220Z,1709081786.220 [CTD_Seabird] Communications Fault, FailCount= 2 2024-02-28T00:56:26.220Z,1709081786.220 [CTD_Seabird](ERROR): Communications Fault 2024-02-28T00:56:26.533Z,1709081786.533 [NAL9602](INFO): Powering up NAL9602 2024-02-28T00:56:26.624Z,1709081786.624 [CTD_Seabird](INFO): Powering down 2024-02-28T00:56:26.712Z,1709081786.712 [ElevatorServo](FAULT): Overload Error 2024-02-28T00:56:26.712Z,1709081786.712 [ElevatorServo] Hardware Fault, FailCount= 2 2024-02-28T00:56:26.712Z,1709081786.712 [ElevatorServo](ERROR): Hardware Fault 2024-02-28T00:56:26.777Z,1709081786.777 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-02-28T00:56:26.777Z,1709081786.777 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-02-28T00:56:26.952Z,1709081786.952 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-28T00:56:26.952Z,1709081786.952 [ElevatorServo](INFO): Powering down 2024-02-28T00:56:27.751Z,1709081787.751 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:56:27.868Z,1709081787.868 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-28T00:56:27.900Z,1709081787.900 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-02-28T00:56:27.900Z,1709081787.900 [ElevatorServo] No Fault, FailCount= 2 2024-02-28T00:56:27.900Z,1709081787.900 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-02-28T00:56:27.900Z,1709081787.900 [CTD_Seabird] No Fault, FailCount= 2 2024-02-28T00:56:27.971Z,1709081787.971 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-02-28T00:56:29.815Z,1709081789.815 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.010143 CHAN A1 (24V): -0.133805 CHAN A2 (12V): 0.000093 CHAN A3 (5V): -0.002448 CHAN B0 (3.3V): -0.000866 CHAN B1 (3.15aV): -0.000508 CHAN B2 (3.15bV): -0.001300 CHAN B3 (GND): -0.001866 OPEN: 0.003952 Full Scale: +/- 1 mA 2024-02-28T00:56:32.237Z,1709081792.237 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-02-28T00:56:32.436Z,1709081792.436 [CommandExec](IMPORTANT): got command failComponent 2024-02-28T00:56:32.436Z,1709081792.436 [CommandExec](IMPORTANT): Failed components: 2024-02-28T00:56:32.436Z,1709081792.436 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-02-28T00:56:32.437Z,1709081792.437 [CommandExec](IMPORTANT): RudderServo: Hardware Fault 2024-02-28T00:56:32.671Z,1709081792.671 [ElevatorServo](FAULT): Overload Error 2024-02-28T00:56:32.671Z,1709081792.671 [ElevatorServo] Hardware Fault, FailCount= 3 2024-02-28T00:56:32.671Z,1709081792.671 [ElevatorServo](ERROR): Hardware Fault 2024-02-28T00:56:32.677Z,1709081792.677 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-02-28T00:56:32.677Z,1709081792.677 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-02-28T00:56:33.011Z,1709081793.011 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-28T00:56:33.011Z,1709081793.011 [ElevatorServo](INFO): Powering down 2024-02-28T00:56:33.015Z,1709081793.015 [CBIT](INFO): Critical error at 20240228T005632 2024-02-28T00:56:33.822Z,1709081793.822 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-28T00:56:33.936Z,1709081793.936 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-28T00:56:37.435Z,1709081797.435 [NAL9602](INFO): NAL9602 initialized 2024-02-28T00:56:38.064Z,1709081798.064 [CommandExec](IMPORTANT): got command failComponent 2024-02-28T00:56:38.064Z,1709081798.064 [CommandExec](IMPORTANT): Failed components: 2024-02-28T00:56:38.065Z,1709081798.065 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-02-28T00:56:38.065Z,1709081798.065 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault 2024-02-28T00:56:38.065Z,1709081798.065 [CommandExec](IMPORTANT): RudderServo: Hardware Fault 2024-02-28T00:56:41.024Z,1709081801.024 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-02-28T00:56:41.024Z,1709081801.024 [CTD_Seabird] Communications Fault, FailCount= 3 2024-02-28T00:56:41.024Z,1709081801.024 [CTD_Seabird](ERROR): Communications Fault 2024-02-28T00:56:41.165Z,1709081801.165 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-02-28T00:56:41.165Z,1709081801.165 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2024-02-28T00:56:41.427Z,1709081801.427 [CTD_Seabird](INFO): Powering down 2024-02-28T00:56:47.224Z,1709081807.224 [CommandExec](IMPORTANT): got command failComponent 2024-02-28T00:56:47.224Z,1709081807.224 [CommandExec](IMPORTANT): Failed components: 2024-02-28T00:56:47.224Z,1709081807.224 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-02-28T00:56:47.224Z,1709081807.224 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault 2024-02-28T00:56:47.225Z,1709081807.225 [CommandExec](IMPORTANT): RudderServo: Hardware Fault 2024-02-28T00:56:47.225Z,1709081807.225 [CommandExec](IMPORTANT): CTD_Seabird: Communications Fault 2024-02-28T00:56:58.612Z,1709081818.612 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-28T00:56:58.612Z,1709081818.612 [DAT] Communications Fault, FailCount= 1 2024-02-28T00:56:58.612Z,1709081818.612 [DAT](ERROR): Communications Fault 2024-02-28T00:56:58.877Z,1709081818.877 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-02-28T00:56:58.877Z,1709081818.877 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-02-28T00:56:58.877Z,1709081818.877 [SBIT](FAULT): Control surface position failure. 2024-02-28T00:56:58.880Z,1709081818.880 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-28T00:56:59.015Z,1709081819.015 [DAT](INFO): Powering down 2024-02-28T00:57:00.076Z,1709081820.076 [CBIT](INFO): Clearing failed state for component DAT 2024-02-28T00:57:00.076Z,1709081820.076 [DAT] No Fault, FailCount= 1 2024-02-28T00:57:02.071Z,1709081822.071 [DAT](INFO): Powering up 2024-02-28T00:57:02.072Z,1709081822.072 [DAT](DEBUG): Initializing DAT. 2024-02-28T00:57:11.738Z,1709081831.738 [CommandExec](IMPORTANT): got command get depth 2024-02-28T00:57:11.741Z,1709081831.741 [CommandExec](IMPORTANT): depth -0.027540 m 2024-02-28T00:57:12.332Z,1709081832.332 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-02-28T00:57:12.332Z,1709081832.332 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-02-28T00:57:12.332Z,1709081832.332 [SBIT](FAULT): Control surface position failure. 2024-02-28T00:57:12.647Z,1709081832.647 [SBIT](CRITICAL): SBIT FAILED 2024-02-28T00:57:12.648Z,1709081832.648 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-02-28T00:57:12.648Z,1709081832.648 [SBIT](IMPORTANT): 2024-02-28T00:57:12.650Z,1709081832.650 [CBIT](INFO): Critical error at 20240228T005712 2024-02-28T00:57:13.033Z,1709081833.033 [MissionManager](IMPORTANT): Started mission Startup 2024-02-28T00:57:13.033Z,1709081833.033 [Startup] Running Loop=1 2024-02-28T00:57:13.033Z,1709081833.033 [Startup](DEBUG): Aggregate::initialize Startup 2024-02-28T00:57:13.033Z,1709081833.033 [Startup:A.GoToSurface] Running Loop=1 2024-02-28T00:57:13.034Z,1709081833.034 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-02-28T00:57:13.034Z,1709081833.034 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-02-28T00:57:13.035Z,1709081833.035 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-02-28T00:57:13.035Z,1709081833.035 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-02-28T00:57:13.035Z,1709081833.035 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-02-28T00:57:13.036Z,1709081833.036 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-02-28T00:57:13.037Z,1709081833.037 [Startup:StartupSatComms] Running Loop=1 2024-02-28T00:57:13.037Z,1709081833.037 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-02-28T00:57:13.037Z,1709081833.037 [Startup:StartupSatComms:A] Running Loop=1 2024-02-28T00:57:13.431Z,1709081833.431 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-02-28T00:57:20.816Z,1709081840.816 [CommandExec](IMPORTANT): got command get depth 2024-02-28T00:57:20.816Z,1709081840.816 [CommandExec](IMPORTANT): depth -0.013518 m 2024-02-28T00:57:21.960Z,1709081841.960 [CommandExec](IMPORTANT): got command failComponent 2024-02-28T00:57:21.960Z,1709081841.960 [CommandExec](IMPORTANT): Failed components: 2024-02-28T00:57:21.960Z,1709081841.960 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-02-28T00:57:21.961Z,1709081841.961 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault 2024-02-28T00:57:21.961Z,1709081841.961 [CommandExec](IMPORTANT): RudderServo: Hardware Fault 2024-02-28T00:57:21.961Z,1709081841.961 [CommandExec](IMPORTANT): CTD_Seabird: Communications Fault 2024-02-28T00:57:53.100Z,1709081873.100 [CommandExec](IMPORTANT): got command quit 2024-02-28T00:57:54.103Z,1709081874.103 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:54.104Z,1709081874.104 [CommandExec](INFO): Uninitializing the command executive. 2024-02-28T00:57:54.104Z,1709081874.104 [CommandExec](INFO): Uninitializing the command scheduler. 2024-02-28T00:57:54.104Z,1709081874.104 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:54.239Z,1709081874.239 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-02-28T00:57:54.239Z,1709081874.239 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-02-28T00:57:54.240Z,1709081874.240 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:54.240Z,1709081874.240 [NavChartDb](INFO): Join timeout helper Thread ID is 6764 2024-02-28T00:57:54.439Z,1709081874.439 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:54.440Z,1709081874.440 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:54.451Z,1709081874.451 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-02-28T00:57:54.451Z,1709081874.451 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:54.452Z,1709081874.452 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6765 2024-02-28T00:57:54.880Z,1709081874.880 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:54.880Z,1709081874.880 [WetLabsBB2FL](INFO): Powering down 2024-02-28T00:57:54.881Z,1709081874.881 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:54.902Z,1709081874.902 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-02-28T00:57:54.902Z,1709081874.902 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:54.902Z,1709081874.902 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6766 2024-02-28T00:57:55.099Z,1709081875.099 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:55.100Z,1709081875.100 [CTD_Seabird](INFO): Powering down 2024-02-28T00:57:55.111Z,1709081875.111 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:55.119Z,1709081875.119 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-02-28T00:57:55.119Z,1709081875.119 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:55.120Z,1709081875.120 [DAT](INFO): Join timeout helper Thread ID is 6767 2024-02-28T00:57:55.320Z,1709081875.320 [DAT](INFO): Powering down 2024-02-28T00:57:55.403Z,1709081875.403 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:55.403Z,1709081875.403 [DAT](INFO): Powering down 2024-02-28T00:57:55.404Z,1709081875.404 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:55.405Z,1709081875.405 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-02-28T00:57:55.405Z,1709081875.405 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:55.405Z,1709081875.405 [Radio_Surface](INFO): Join timeout helper Thread ID is 6768 2024-02-28T00:57:55.527Z,1709081875.527 [Radio_Surface](INFO): Powering down 2024-02-28T00:57:55.528Z,1709081875.528 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:55.528Z,1709081875.528 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:55.540Z,1709081875.540 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-02-28T00:57:55.540Z,1709081875.540 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:55.541Z,1709081875.541 [Onboard](INFO): Join timeout helper Thread ID is 6769 2024-02-28T00:57:58.427Z,1709081878.427 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:58.428Z,1709081878.428 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.437Z,1709081878.437 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-02-28T00:57:58.437Z,1709081878.437 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.437Z,1709081878.437 [DataOverHttps](INFO): Join timeout helper Thread ID is 6770 2024-02-28T00:57:58.823Z,1709081878.823 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:58.824Z,1709081878.824 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.832Z,1709081878.832 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-02-28T00:57:58.832Z,1709081878.832 [logger ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.833Z,1709081878.833 [logger](INFO): Join timeout helper Thread ID is 6771 2024-02-28T00:57:58.847Z,1709081878.847 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:58.848Z,1709081878.848 [logger ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.852Z,1709081878.852 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-02-28T00:57:58.852Z,1709081878.852 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.852Z,1709081878.852 [CommandLine](INFO): Join timeout helper Thread ID is 6772 2024-02-28T00:57:58.856Z,1709081878.856 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:58.856Z,1709081878.856 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.872Z,1709081878.872 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-02-28T00:57:58.872Z,1709081878.872 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.872Z,1709081878.872 [CommandExec](INFO): Join timeout helper Thread ID is 6773 2024-02-28T00:57:58.874Z,1709081878.874 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-02-28T00:57:58.874Z,1709081878.874 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:58.874Z,1709081878.874 [controlThread](INFO): Join timeout helper Thread ID is 6774 2024-02-28T00:57:59.027Z,1709081879.027 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-28T00:57:59.028Z,1709081879.028 [controlThread](DEBUG): Uninitializing ControlThread 2024-02-28T00:57:59.028Z,1709081879.028 [AHRS_M2](INFO): Powering down 2024-02-28T00:57:59.101Z,1709081879.101 [NAL9602](INFO): Powering down 2024-02-28T00:57:59.102Z,1709081879.102 [Sonardyne_Nano](INFO): Powering down 2024-02-28T00:57:59.220Z,1709081879.220 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-02-28T00:57:59.221Z,1709081879.221 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-02-28T00:57:59.222Z,1709081879.222 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-02-28T00:57:59.222Z,1709081879.222 [MissionManager](INFO): Uninitializing Mission Default 2024-02-28T00:57:59.225Z,1709081879.225 [MissionManager](INFO): Uninitializing Mission Startup 2024-02-28T00:57:59.225Z,1709081879.225 [Startup] Stopped 2024-02-28T00:57:59.225Z,1709081879.225 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-02-28T00:57:59.225Z,1709081879.225 [Startup:A.GoToSurface] Stopped 2024-02-28T00:57:59.225Z,1709081879.225 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-02-28T00:57:59.225Z,1709081879.225 [Startup:StartupSatComms] Stopped 2024-02-28T00:57:59.225Z,1709081879.225 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-02-28T00:57:59.225Z,1709081879.225 [Startup:StartupSatComms:A] Stopped 2024-02-28T00:57:59.227Z,1709081879.227 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-02-28T00:57:59.227Z,1709081879.227 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-02-28T00:57:59.227Z,1709081879.227 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-02-28T00:57:59.228Z,1709081879.228 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-02-28T00:57:59.228Z,1709081879.228 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-02-28T00:57:59.228Z,1709081879.228 [BuoyancyServo](INFO): Powering down 2024-02-28T00:57:59.239Z,1709081879.239 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-28T00:57:59.239Z,1709081879.239 [ElevatorServo](INFO): Powering down 2024-02-28T00:57:59.240Z,1709081879.240 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-02-28T00:57:59.240Z,1709081879.240 [MassServo](INFO): Powering down 2024-02-28T00:57:59.241Z,1709081879.241 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-28T00:57:59.241Z,1709081879.241 [RudderServo](INFO): Powering down 2024-02-28T00:57:59.242Z,1709081879.242 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-02-28T00:57:59.242Z,1709081879.242 [ThrusterHE](INFO): Powering down 2024-02-28T00:57:59.243Z,1709081879.243 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-02-28T00:57:59.243Z,1709081879.243 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-02-28T00:57:59.244Z,1709081879.244 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-02-28T00:57:59.244Z,1709081879.244 [CBIT](DEBUG): Powering off loads. 2024-02-28T00:57:59.255Z,1709081879.255 [CBIT](DEBUG): Disabling WDT. 2024-02-28T00:57:59.267Z,1709081879.267 [CBIT](DEBUG): Opening all GF detection circuits. 2024-02-28T00:57:59.268Z,1709081879.268 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:59.283Z,1709081879.283 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:59.289Z,1709081879.289 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:59.290Z,1709081879.290 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:59.296Z,1709081879.296 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:59.654Z,1709081879.654 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:59.658Z,1709081879.658 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:59.675Z,1709081879.675 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-28T00:57:59.722Z,1709081879.722 [logger ThreadHandler](INFO): Thread cancelled.