2024-08-29T20:02:17.715Z,1724961737.715 [Supervisor](DEBUG): Initializing supervisor. 2024-08-29T20:02:17.719Z,1724961737.719 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-08-29T20:02:17.719Z,1724961737.719 [SyncHandler](INFO): Protected caller Thread ID is 4558 2024-08-29T20:02:17.720Z,1724961737.720 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-08-29T20:02:17.721Z,1724961737.721 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-08-29T20:02:17.721Z,1724961737.721 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4559 2024-08-29T20:02:17.725Z,1724961737.725 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-08-29T20:02:17.742Z,1724961737.742 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-08-29T20:02:17.743Z,1724961737.743 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-08-29T20:02:17.743Z,1724961737.743 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4560 2024-08-29T20:02:17.747Z,1724961737.747 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-08-29T20:02:17.748Z,1724961737.748 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-08-29T20:02:17.749Z,1724961737.749 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4561 2024-08-29T20:02:17.751Z,1724961737.751 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-08-29T20:02:17.752Z,1724961737.752 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-08-29T20:02:17.752Z,1724961737.752 [logger ThreadHandler](INFO): Protected caller Thread ID is 4562 2024-08-29T20:02:17.756Z,1724961737.756 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-08-29T20:02:17.756Z,1724961737.756 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-08-29T20:02:17.758Z,1724961737.758 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-08-29T20:02:17.867Z,1724961737.867 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-08-29T20:02:17.867Z,1724961737.867 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-08-29T20:02:18.115Z,1724961738.115 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-08-29T20:02:18.116Z,1724961738.116 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-08-29T20:02:18.496Z,1724961738.496 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-08-29T20:02:18.496Z,1724961738.496 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-08-29T20:02:18.619Z,1724961738.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-08-29T20:02:18.620Z,1724961738.620 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-08-29T20:02:19.661Z,1724961739.661 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-08-29T20:02:19.661Z,1724961739.661 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-08-29T20:02:20.183Z,1724961740.183 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-08-29T20:02:20.183Z,1724961740.183 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-08-29T20:02:20.744Z,1724961740.744 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-08-29T20:02:20.745Z,1724961740.745 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-08-29T20:02:21.190Z,1724961741.190 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-08-29T20:02:21.191Z,1724961741.191 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-08-29T20:02:21.549Z,1724961741.549 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-08-29T20:02:21.549Z,1724961741.549 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-08-29T20:02:21.948Z,1724961741.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-08-29T20:02:21.948Z,1724961741.948 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-08-29T20:02:22.193Z,1724961742.193 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-08-29T20:02:22.193Z,1724961742.193 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-08-29T20:02:22.346Z,1724961742.346 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-08-29T20:02:22.347Z,1724961742.347 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-08-29T20:02:22.441Z,1724961742.441 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-08-29T20:02:22.533Z,1724961742.533 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-08-29T20:02:22.739Z,1724961742.739 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-08-29T20:02:22.739Z,1724961742.739 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-08-29T20:02:22.990Z,1724961742.990 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-08-29T20:02:22.992Z,1724961742.992 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2024-08-29T20:02:22.992Z,1724961742.992 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2024-08-29T20:02:23.089Z,1724961743.089 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2024-08-29T20:02:23.442Z,1724961743.442 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-08-29T20:02:23.443Z,1724961743.443 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2024-08-29T20:02:23.553Z,1724961743.553 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2024-08-29T20:02:23.732Z,1724961743.732 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2024-08-29T20:02:23.843Z,1724961743.843 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2024-08-29T20:02:23.967Z,1724961743.967 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2024-08-29T20:02:24.093Z,1724961744.093 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2024-08-29T20:02:24.212Z,1724961744.212 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2024-08-29T20:02:24.387Z,1724961744.387 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2024-08-29T20:02:24.497Z,1724961744.497 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg 2024-08-29T20:02:24.595Z,1724961744.595 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2024-08-29T20:02:24.713Z,1724961744.713 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2024-08-29T20:02:25.005Z,1724961745.005 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2024-08-29T20:02:25.007Z,1724961745.007 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-08-29T20:02:25.370Z,1724961745.370 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-08-29T20:02:25.371Z,1724961745.371 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-08-29T20:02:25.500Z,1724961745.500 [BuoyancyServo] Loaded 2024-08-29T20:02:25.500Z,1724961745.500 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-08-29T20:02:25.523Z,1724961745.523 [ElevatorServo] Loaded 2024-08-29T20:02:25.523Z,1724961745.523 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-08-29T20:02:25.545Z,1724961745.545 [MassServo] Loaded 2024-08-29T20:02:25.545Z,1724961745.545 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-08-29T20:02:25.567Z,1724961745.567 [RudderServo] Loaded 2024-08-29T20:02:25.567Z,1724961745.567 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-08-29T20:02:25.584Z,1724961745.584 [ThrusterHE] Loaded 2024-08-29T20:02:25.584Z,1724961745.584 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-08-29T20:02:25.584Z,1724961745.584 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-08-29T20:02:25.585Z,1724961745.585 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-08-29T20:02:25.717Z,1724961745.717 [SBIT](DEBUG): Construct Startup Built In Test. 2024-08-29T20:02:25.731Z,1724961745.731 [SBIT] Loaded 2024-08-29T20:02:25.732Z,1724961745.732 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-08-29T20:02:25.734Z,1724961745.734 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-08-29T20:02:25.754Z,1724961745.754 [IBIT] Loaded 2024-08-29T20:02:25.755Z,1724961745.755 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-08-29T20:02:25.760Z,1724961745.760 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-08-29T20:02:25.977Z,1724961745.977 [CBIT] Loaded 2024-08-29T20:02:25.977Z,1724961745.977 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-08-29T20:02:25.978Z,1724961745.978 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-08-29T20:02:25.978Z,1724961745.978 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-08-29T20:02:26.142Z,1724961746.142 [CTD_Seabird] Loaded 2024-08-29T20:02:26.143Z,1724961746.143 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-08-29T20:02:26.144Z,1724961746.144 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406784E0 2024-08-29T20:02:26.144Z,1724961746.144 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4651 2024-08-29T20:02:26.178Z,1724961746.178 [ESPComponent] Loaded 2024-08-29T20:02:26.179Z,1724961746.179 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-08-29T20:02:26.200Z,1724961746.200 [PAR_Licor] Loaded 2024-08-29T20:02:26.200Z,1724961746.200 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-08-29T20:02:26.242Z,1724961746.242 [WetLabsBB2FL] Loaded 2024-08-29T20:02:26.242Z,1724961746.242 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-08-29T20:02:26.243Z,1724961746.243 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406A84E0 2024-08-29T20:02:26.244Z,1724961746.244 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4652 2024-08-29T20:02:26.245Z,1724961746.245 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-08-29T20:02:26.245Z,1724961746.245 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-08-29T20:02:26.293Z,1724961746.293 [DepthRateCalculator] Loaded 2024-08-29T20:02:26.294Z,1724961746.294 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-08-29T20:02:26.299Z,1724961746.299 [PitchRateCalculator] Loaded 2024-08-29T20:02:26.299Z,1724961746.299 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-08-29T20:02:26.309Z,1724961746.309 [SpeedCalculator] Loaded 2024-08-29T20:02:26.309Z,1724961746.309 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-08-29T20:02:26.314Z,1724961746.314 [YawRateCalculator] Loaded 2024-08-29T20:02:26.314Z,1724961746.314 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-08-29T20:02:26.333Z,1724961746.333 [ElevatorOffsetCalculator] Loaded 2024-08-29T20:02:26.333Z,1724961746.333 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-08-29T20:02:26.334Z,1724961746.334 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-08-29T20:02:26.334Z,1724961746.334 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-08-29T20:02:26.439Z,1724961746.439 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-08-29T20:02:26.439Z,1724961746.439 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-08-29T20:02:26.464Z,1724961746.464 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-08-29T20:02:26.465Z,1724961746.465 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-08-29T20:02:26.572Z,1724961746.572 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-08-29T20:02:26.572Z,1724961746.572 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-08-29T20:02:26.586Z,1724961746.586 [NavChart] Loaded 2024-08-29T20:02:26.587Z,1724961746.587 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-08-29T20:02:26.592Z,1724961746.592 [UniversalFixResidualReporter] Loaded 2024-08-29T20:02:26.592Z,1724961746.592 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-08-29T20:02:26.593Z,1724961746.593 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-08-29T20:02:26.593Z,1724961746.593 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-08-29T20:02:27.031Z,1724961747.031 [AHRS_M2] Loaded 2024-08-29T20:02:27.032Z,1724961747.032 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-08-29T20:02:27.070Z,1724961747.070 [BackseatComponent] Loaded 2024-08-29T20:02:27.070Z,1724961747.070 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-08-29T20:02:27.071Z,1724961747.071 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A694E0 2024-08-29T20:02:27.072Z,1724961747.072 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4653 2024-08-29T20:02:27.074Z,1724961747.074 [LcmUniversalReporter] Loaded 2024-08-29T20:02:27.075Z,1724961747.075 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-08-29T20:02:27.803Z,1724961747.803 [BPC1] Loaded 2024-08-29T20:02:27.804Z,1724961747.804 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-08-29T20:02:27.898Z,1724961747.898 [DAT] Loaded 2024-08-29T20:02:27.899Z,1724961747.899 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-08-29T20:02:27.900Z,1724961747.900 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A994E0 2024-08-29T20:02:27.900Z,1724961747.900 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4654 2024-08-29T20:02:27.971Z,1724961747.971 [DataOverHttps] Loaded 2024-08-29T20:02:27.971Z,1724961747.971 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-08-29T20:02:27.972Z,1724961747.972 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AC94E0 2024-08-29T20:02:27.972Z,1724961747.972 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4655 2024-08-29T20:02:27.995Z,1724961747.995 [Depth_Keller] Loaded 2024-08-29T20:02:27.995Z,1724961747.995 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-08-29T20:02:28.001Z,1724961748.001 [DropWeight] Loaded 2024-08-29T20:02:28.001Z,1724961748.001 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-08-29T20:02:28.041Z,1724961748.041 [DVL_micro] Loaded 2024-08-29T20:02:28.042Z,1724961748.042 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2024-08-29T20:02:28.102Z,1724961748.102 [NAL9602] Loaded 2024-08-29T20:02:28.103Z,1724961748.103 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-08-29T20:02:28.128Z,1724961748.128 [Onboard] Loaded 2024-08-29T20:02:28.128Z,1724961748.128 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-08-29T20:02:28.129Z,1724961748.129 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AF94E0 2024-08-29T20:02:28.129Z,1724961748.129 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4656 2024-08-29T20:02:28.143Z,1724961748.143 [Power24vConverter] Loaded 2024-08-29T20:02:28.144Z,1724961748.144 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-08-29T20:02:28.159Z,1724961748.159 [Radio_Surface] Loaded 2024-08-29T20:02:28.159Z,1724961748.159 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-08-29T20:02:28.160Z,1724961748.160 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B294E0 2024-08-29T20:02:28.160Z,1724961748.160 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4657 2024-08-29T20:02:28.176Z,1724961748.176 [Sonardyne_Nano] Loaded 2024-08-29T20:02:28.176Z,1724961748.176 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-08-29T20:02:28.177Z,1724961748.177 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-08-29T20:02:28.177Z,1724961748.177 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-08-29T20:02:28.242Z,1724961748.242 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-08-29T20:02:28.243Z,1724961748.243 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-08-29T20:02:28.293Z,1724961748.293 [VerticalControl](DEBUG): Construct VerticalControl. 2024-08-29T20:02:28.342Z,1724961748.342 [VerticalControl] Loaded 2024-08-29T20:02:28.343Z,1724961748.343 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-08-29T20:02:28.345Z,1724961748.345 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-08-29T20:02:28.388Z,1724961748.388 [HorizontalControl] Loaded 2024-08-29T20:02:28.389Z,1724961748.389 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-08-29T20:02:28.391Z,1724961748.391 [SpeedControl](DEBUG): Construct SpeedControl. 2024-08-29T20:02:28.393Z,1724961748.393 [SpeedControl] Loaded 2024-08-29T20:02:28.393Z,1724961748.393 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-08-29T20:02:28.396Z,1724961748.396 [LoopControl](DEBUG): Construct LoopControl. 2024-08-29T20:02:28.396Z,1724961748.396 [LoopControl] Loaded 2024-08-29T20:02:28.396Z,1724961748.396 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-08-29T20:02:28.397Z,1724961748.397 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-08-29T20:02:28.397Z,1724961748.397 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-08-29T20:02:28.407Z,1724961748.407 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-08-29T20:02:28.408Z,1724961748.408 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-08-29T20:02:28.725Z,1724961748.725 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-08-29T20:02:28.731Z,1724961748.731 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-08-29T20:02:28.734Z,1724961748.734 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-08-29T20:02:28.745Z,1724961748.745 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-08-29T20:02:28.746Z,1724961748.746 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C514E0 2024-08-29T20:02:28.747Z,1724961748.747 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4658 2024-08-29T20:02:28.751Z,1724961748.751 [Supervisor](INFO): Main Thread ID is 4557 2024-08-29T20:02:28.751Z,1724961748.751 [Supervisor](DEBUG): Running supervisor. 2024-08-29T20:02:28.752Z,1724961748.752 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4659 2024-08-29T20:02:28.752Z,1724961748.752 [CommandExec](INFO): Initializing the command executive. 2024-08-29T20:02:28.754Z,1724961748.754 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4660 2024-08-29T20:02:28.757Z,1724961748.757 [controlThread ThreadHandler](INFO): Handler Thread ID is 4661 2024-08-29T20:02:28.757Z,1724961748.757 [controlThread](DEBUG): Initializing ControlThread 2024-08-29T20:02:28.759Z,1724961748.759 [SBIT](INFO): Initialize SBIT Component. 2024-08-29T20:02:28.760Z,1724961748.760 [SBIT](IMPORTANT): git: 2024-08-12-95-g598b95f60 2024-08-29T20:02:28.760Z,1724961748.760 [SBIT](INFO): git hash: 598b95f6033d24136933a3d5d1ddac5d4570ac95 2024-08-29T20:02:28.760Z,1724961748.760 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-08-29T20:02:28.762Z,1724961748.762 [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-08-29T20:02:28.763Z,1724961748.763 [SBIT](INFO): Beginning SBIT in 107.000000 seconds. 2024-08-29T20:02:28.763Z,1724961748.763 [IBIT](INFO): Initialize IBIT Component. 2024-08-29T20:02:28.764Z,1724961748.764 [CBIT](DEBUG): Initialize CBIT Component. 2024-08-29T20:02:28.765Z,1724961748.765 [logger ThreadHandler](INFO): Handler Thread ID is 4662 2024-08-29T20:02:28.776Z,1724961748.776 [CBIT](DEBUG): Initialized mux pins. 2024-08-29T20:02:28.776Z,1724961748.776 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2024-08-29T20:02:28.776Z,1724961748.776 [CBIT](DEBUG): Initializing the watchdog timer. 2024-08-29T20:02:28.784Z,1724961748.784 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4663 2024-08-29T20:02:28.785Z,1724961748.785 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-08-29T20:02:28.789Z,1724961748.789 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4665 2024-08-29T20:02:28.792Z,1724961748.792 [WetLabsBB2FL](INFO): Powering up 2024-08-29T20:02:28.793Z,1724961748.793 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4667 2024-08-29T20:02:28.800Z,1724961748.800 [CBIT](CRITICAL): Watchdog Timer failed to initialize. 2024-08-29T20:02:28.800Z,1724961748.800 [CBIT] Hardware Fault, FailCount= 1 2024-08-29T20:02:28.800Z,1724961748.800 [CBIT](ERROR): Hardware Fault 2024-08-29T20:02:28.800Z,1724961748.800 [CBIT](DEBUG): Initializing heartbeat. 2024-08-29T20:02:28.801Z,1724961748.801 [DAT ThreadHandler](INFO): Handler Thread ID is 4668 2024-08-29T20:02:28.802Z,1724961748.802 [DAT](INFO): Powering up 2024-08-29T20:02:28.802Z,1724961748.802 [DAT](DEBUG): Initializing DAT. 2024-08-29T20:02:28.805Z,1724961748.805 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4670 2024-08-29T20:02:28.806Z,1724961748.806 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-08-29T20:02:28.816Z,1724961748.816 [Onboard ThreadHandler](INFO): Handler Thread ID is 4671 2024-08-29T20:02:28.834Z,1724961748.834 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4672 2024-08-29T20:02:28.852Z,1724961748.852 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4673 2024-08-29T20:02:28.854Z,1724961748.854 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK1NORSO.000 2024-08-29T20:02:28.855Z,1724961748.855 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK1NORSO.000 2024-08-29T20:02:28.855Z,1724961748.855 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK2NORS.000 2024-08-29T20:02:28.855Z,1724961748.855 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK2NORS.000 2024-08-29T20:02:28.855Z,1724961748.855 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK3HORRO.000 2024-08-29T20:02:28.855Z,1724961748.855 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK3HORRO.000 2024-08-29T20:02:28.872Z,1724961748.872 [CBIT](DEBUG): Deactivating GF circuits. 2024-08-29T20:02:28.872Z,1724961748.872 [CBIT](DEBUG): Deactivating emergency mode. 2024-08-29T20:02:28.912Z,1724961748.912 [CBIT](DEBUG): Backplane powered. 2024-08-29T20:02:28.916Z,1724961748.916 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-08-29T20:02:28.916Z,1724961748.916 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-08-29T20:02:28.917Z,1724961748.917 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-08-29T20:02:28.917Z,1724961748.917 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-08-29T20:02:28.917Z,1724961748.917 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-08-29T20:02:28.919Z,1724961748.919 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-08-29T20:02:28.919Z,1724961748.919 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-08-29T20:02:28.926Z,1724961748.926 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-08-29T20:02:28.928Z,1724961748.928 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-08-29T20:02:28.929Z,1724961748.929 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-08-29T20:02:28.929Z,1724961748.929 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-08-29T20:02:28.930Z,1724961748.930 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-08-29T20:02:28.931Z,1724961748.931 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-08-29T20:02:28.931Z,1724961748.931 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-08-29T20:02:28.936Z,1724961748.936 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-08-29T20:02:29.010Z,1724961749.010 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-08-29T20:02:29.014Z,1724961749.014 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-08-29T20:02:29.067Z,1724961749.067 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-08-29T20:02:29.068Z,1724961749.068 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-08-29T20:02:29.068Z,1724961749.068 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-08-29T20:02:29.069Z,1724961749.069 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-08-29T20:02:29.240Z,1724961749.240 [Radio_Surface](INFO): Powering up 2024-08-29T20:02:29.413Z,1724961749.413 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-08-29T20:02:29.418Z,1724961749.418 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-08-29T20:02:29.436Z,1724961749.436 [Default:A.Wait](DEBUG): Construct Wait. 2024-08-29T20:02:29.438Z,1724961749.438 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-08-29T20:02:29.458Z,1724961749.458 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-08-29T20:02:29.481Z,1724961749.481 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-08-29T20:02:29.486Z,1724961749.486 [Default:E.Execute](DEBUG): Construct Execute. 2024-08-29T20:02:29.505Z,1724961749.505 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-08-29T20:02:29.510Z,1724961749.510 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-08-29T20:02:29.534Z,1724961749.534 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-08-29T20:02:29.605Z,1724961749.605 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.444336 decibar, 0.000000 m 2024-08-29T20:02:29.609Z,1724961749.609 [Power24vConverter](INFO): Powering up. 2024-08-29T20:02:29.610Z,1724961749.610 [Sonardyne_Nano](INFO): Initializing. 2024-08-29T20:02:29.636Z,1724961749.636 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-08-29T20:02:29.669Z,1724961749.669 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-08-29T20:02:29.676Z,1724961749.676 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-08-29T20:02:29.677Z,1724961749.677 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-08-29T20:02:29.684Z,1724961749.684 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-08-29T20:02:29.685Z,1724961749.685 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-29T20:02:29.692Z,1724961749.692 [MassServo](DEBUG): Initializing MassServo. 2024-08-29T20:02:29.693Z,1724961749.693 [RudderServo](DEBUG): Initializing EZServoServo. 2024-08-29T20:02:29.700Z,1724961749.700 [RudderServo](DEBUG): Initializing RudderServo. 2024-08-29T20:02:29.701Z,1724961749.701 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-08-29T20:02:29.708Z,1724961749.708 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-08-29T20:02:29.709Z,1724961749.709 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-08-29T20:02:29.709Z,1724961749.709 [CBIT](DEBUG): Powering off loads. 2024-08-29T20:02:29.720Z,1724961749.720 [CBIT](DEBUG): Disabling WDT. 2024-08-29T20:02:29.732Z,1724961749.732 [CBIT](DEBUG): Opening all GF detection circuits. 2024-08-29T20:02:29.982Z,1724961749.982 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-08-29T20:02:29.982Z,1724961749.982 [DropWeight] Hardware Fault, FailCount= 1 2024-08-29T20:02:29.982Z,1724961749.982 [DropWeight](ERROR): Hardware Fault 2024-08-29T20:02:31.073Z,1724961751.073 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2024-08-29T20:02:31.073Z,1724961751.073 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2024-08-29T20:02:31.073Z,1724961751.073 [BuoyancyServo] Communications Fault, FailCount= 1 2024-08-29T20:02:31.073Z,1724961751.073 [BuoyancyServo](ERROR): Communications Fault 2024-08-29T20:02:31.376Z,1724961751.376 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2024-08-29T20:02:31.376Z,1724961751.376 [ElevatorServo](FAULT): Elevator failed to initialize 2024-08-29T20:02:31.376Z,1724961751.376 [ElevatorServo] Communications Fault, FailCount= 1 2024-08-29T20:02:31.376Z,1724961751.376 [ElevatorServo](ERROR): Communications Fault 2024-08-29T20:02:31.680Z,1724961751.680 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2024-08-29T20:02:31.680Z,1724961751.680 [RudderServo](FAULT): Rudder failed to initialize 2024-08-29T20:02:31.680Z,1724961751.680 [RudderServo] Communications Fault, FailCount= 1 2024-08-29T20:02:31.680Z,1724961751.680 [RudderServo](ERROR): Communications Fault 2024-08-29T20:02:31.730Z,1724961751.730 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-08-29T20:02:31.731Z,1724961751.731 [ElevatorServo](INFO): Powering down 2024-08-29T20:02:31.741Z,1724961751.741 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-08-29T20:02:31.741Z,1724961751.741 [RudderServo](INFO): Powering down 2024-08-29T20:02:31.742Z,1724961751.742 [ThrusterHE](FAULT): Thruster failed to initialize 2024-08-29T20:02:31.742Z,1724961751.742 [ThrusterHE] Communications Fault, FailCount= 1 2024-08-29T20:02:31.742Z,1724961751.742 [ThrusterHE](ERROR): Communications Fault 2024-08-29T20:02:32.098Z,1724961752.098 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-08-29T20:02:32.143Z,1724961752.143 [ElevatorServo](FAULT): LCB fault: Current Limiter Activated. 2024-08-29T20:02:32.143Z,1724961752.143 [ElevatorServo] Hardware Fault, FailCount= 1 2024-08-29T20:02:32.143Z,1724961752.143 [ElevatorServo](ERROR): Hardware Fault 2024-08-29T20:02:32.152Z,1724961752.152 [RudderServo](FAULT): LCB fault: Current Limiter Activated. 2024-08-29T20:02:32.152Z,1724961752.152 [RudderServo] Hardware Fault, FailCount= 1 2024-08-29T20:02:32.152Z,1724961752.152 [RudderServo](ERROR): Hardware Fault 2024-08-29T20:02:32.153Z,1724961752.153 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-08-29T20:02:32.153Z,1724961752.153 [ThrusterHE](INFO): Powering down 2024-08-29T20:02:32.515Z,1724961752.515 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-08-29T20:02:32.641Z,1724961752.641 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-08-29T20:02:32.944Z,1724961752.944 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2024-08-29T20:02:32.944Z,1724961752.944 [MassServo] Communications Fault, FailCount= 1 2024-08-29T20:02:32.944Z,1724961752.944 [MassServo](ERROR): Communications Fault 2024-08-29T20:02:32.945Z,1724961752.945 [RudderServo](DEBUG): Initializing EZServoServo. 2024-08-29T20:02:33.065Z,1724961753.065 [RudderServo](DEBUG): Initializing RudderServo. 2024-08-29T20:02:33.066Z,1724961753.066 [ThrusterHE](FAULT): LCB fault: Current Limiter Activated. 2024-08-29T20:02:33.066Z,1724961753.066 [ThrusterHE] Hardware Fault, FailCount= 1 2024-08-29T20:02:33.066Z,1724961753.066 [ThrusterHE](ERROR): Hardware Fault 2024-08-29T20:02:33.191Z,1724961753.191 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-29T20:02:33.191Z,1724961753.191 [MassServo](INFO): Powering down 2024-08-29T20:02:33.576Z,1724961753.576 [MassServo](FAULT): LCB fault: Current Limiter Activated. 2024-08-29T20:02:33.577Z,1724961753.577 [MassServo] Hardware Fault, FailCount= 1 2024-08-29T20:02:33.577Z,1724961753.577 [MassServo](ERROR): Hardware Fault 2024-08-29T20:02:33.917Z,1724961753.917 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213 2024-08-29T20:02:33.963Z,1724961753.963 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-29T20:02:34.080Z,1724961754.080 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-08-29T20:02:34.080Z,1724961754.080 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-29T20:02:34.081Z,1724961754.081 [MassServo](DEBUG): Initializing MassServo. 2024-08-29T20:02:34.359Z,1724961754.359 [Sonardyne_Nano](ERROR): External power not detected 2024-08-29T20:02:34.580Z,1724961754.580 [WetLabsBB2FL](INFO): Powering down 2024-08-29T20:02:39.138Z,1724961759.138 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2024-08-29T20:02:39.138Z,1724961759.138 [AHRS_M2] Hardware Fault, FailCount= 1 2024-08-29T20:02:39.138Z,1724961759.138 [AHRS_M2](ERROR): Hardware Fault 2024-08-29T20:02:39.540Z,1724961759.540 [AHRS_M2](INFO): Powering down 2024-08-29T20:02:39.945Z,1724961759.945 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2024-08-29T20:02:41.836Z,1724961761.836 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-08-29T20:02:41.836Z,1724961761.836 [CTD_Seabird] Communications Fault, FailCount= 1 2024-08-29T20:02:41.836Z,1724961761.836 [CTD_Seabird](ERROR): Communications Fault 2024-08-29T20:02:42.241Z,1724961762.241 [CTD_Seabird](INFO): Powering down 2024-08-29T20:02:46.818Z,1724961766.818 [DVL_micro](FAULT): Failed to initialize within timeout. 2024-08-29T20:02:46.818Z,1724961766.818 [DVL_micro] Communications Fault, FailCount= 1 2024-08-29T20:02:46.818Z,1724961766.818 [DVL_micro](ERROR): Communications Fault 2024-08-29T20:02:47.316Z,1724961767.316 [DVL_micro](INFO): Powering down 2024-08-29T20:02:58.132Z,1724961778.132 [NAL9602](INFO): Powering up NAL9602 2024-08-29T20:03:18.735Z,1724961798.735 [NAL9602](ERROR): NAL9602 initialization error. 2024-08-29T20:03:18.735Z,1724961798.735 [NAL9602] Communications Fault, FailCount= 1 2024-08-29T20:03:18.735Z,1724961798.735 [NAL9602](ERROR): Communications Fault 2024-08-29T20:03:19.138Z,1724961799.138 [NAL9602](INFO): Powering down 2024-08-29T20:03:29.032Z,1724961809.032 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-08-29T20:03:29.032Z,1724961809.032 [DAT] Communications Fault, FailCount= 1 2024-08-29T20:03:29.032Z,1724961809.032 [DAT](ERROR): Communications Fault 2024-08-29T20:03:29.436Z,1724961809.436 [DAT](INFO): Powering down 2024-08-29T20:04:16.515Z,1724961856.515 [SBIT](IMPORTANT): Beginning Startup BIT 2024-08-29T20:04:29.031Z,1724961869.031 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-08-29T20:04:29.031Z,1724961869.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-08-29T20:04:29.031Z,1724961869.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-08-29T20:04:29.847Z,1724961869.847 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-08-29T20:04:29.847Z,1724961869.847 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-08-29T20:04:29.847Z,1724961869.847 [SBIT](ERROR): Could not read massPosReader_. 2024-08-29T20:04:56.511Z,1724961896.511 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-08-29T20:04:56.511Z,1724961896.511 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-08-29T20:04:56.511Z,1724961896.511 [SBIT](ERROR): Could not read massPosReader_. 2024-08-29T20:04:56.511Z,1724961896.511 [SBIT](FAULT): Control surface position failure. 2024-08-29T20:05:10.247Z,1724961910.247 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-08-29T20:05:10.247Z,1724961910.247 [SBIT](ERROR): Could not read rudderAngleReader_. 2024-08-29T20:05:10.247Z,1724961910.247 [SBIT](ERROR): Could not read massPosReader_. 2024-08-29T20:05:10.247Z,1724961910.247 [SBIT](FAULT): Control surface position failure. 2024-08-29T20:05:10.649Z,1724961910.649 [SBIT](CRITICAL): SBIT FAILED 2024-08-29T20:05:10.649Z,1724961910.649 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2024-08-29T20:05:11.108Z,1724961911.108 [MissionManager](IMPORTANT): Started mission Startup 2024-08-29T20:05:11.108Z,1724961911.108 [Startup] Running Loop=1 2024-08-29T20:05:11.108Z,1724961911.108 [Startup](DEBUG): Aggregate::initialize Startup 2024-08-29T20:05:11.108Z,1724961911.108 [Startup:A.GoToSurface] Running Loop=1 2024-08-29T20:05:11.109Z,1724961911.109 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-29T20:05:11.109Z,1724961911.109 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-08-29T20:05:11.109Z,1724961911.109 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-08-29T20:05:11.110Z,1724961911.110 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-08-29T20:05:11.110Z,1724961911.110 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-08-29T20:05:11.110Z,1724961911.110 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-29T20:05:11.111Z,1724961911.111 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-29T20:05:11.113Z,1724961911.113 [Startup:StartupSatComms] Running Loop=1 2024-08-29T20:05:11.113Z,1724961911.113 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-08-29T20:05:11.113Z,1724961911.113 [Startup:StartupSatComms:A] Running Loop=1 2024-08-29T20:05:11.464Z,1724961911.464 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-08-29T20:06:11.251Z,1724961971.251 [Startup:StartupSatComms:A](INFO): Timed out from 2024-08-29T20:05:11.1Z 2024-08-29T20:06:11.251Z,1724961971.251 [Startup:StartupSatComms:A] Stopped 2024-08-29T20:06:11.251Z,