2024-08-19T20:08:30.787Z,1724098110.787 [Supervisor](DEBUG): Initializing supervisor. 2024-08-19T20:08:30.791Z,1724098110.791 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-08-19T20:08:30.792Z,1724098110.792 [SyncHandler](INFO): Protected caller Thread ID is 3169 2024-08-19T20:08:30.792Z,1724098110.792 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-08-19T20:08:30.793Z,1724098110.793 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-08-19T20:08:30.793Z,1724098110.793 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3170 2024-08-19T20:08:30.797Z,1724098110.797 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-08-19T20:08:30.814Z,1724098110.814 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-08-19T20:08:30.815Z,1724098110.815 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-08-19T20:08:30.815Z,1724098110.815 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3171 2024-08-19T20:08:30.820Z,1724098110.820 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-08-19T20:08:30.821Z,1724098110.821 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-08-19T20:08:30.821Z,1724098110.821 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3172 2024-08-19T20:08:30.823Z,1724098110.823 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-08-19T20:08:30.824Z,1724098110.824 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-08-19T20:08:30.824Z,1724098110.824 [logger ThreadHandler](INFO): Protected caller Thread ID is 3173 2024-08-19T20:08:30.828Z,1724098110.828 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-08-19T20:08:30.828Z,1724098110.828 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-08-19T20:08:30.831Z,1724098110.831 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-08-19T20:08:31.195Z,1724098111.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-08-19T20:08:31.196Z,1724098111.196 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-08-19T20:08:31.964Z,1724098111.964 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-08-19T20:08:31.965Z,1724098111.965 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-08-19T20:08:32.086Z,1724098112.086 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-08-19T20:08:32.087Z,1724098112.087 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-08-19T20:08:32.743Z,1724098112.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-08-19T20:08:32.744Z,1724098112.744 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-08-19T20:08:32.854Z,1724098112.854 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-08-19T20:08:32.855Z,1724098112.855 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-08-19T20:08:32.949Z,1724098112.949 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-08-19T20:08:33.376Z,1724098113.376 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-08-19T20:08:33.377Z,1724098113.377 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-08-19T20:08:33.615Z,1724098113.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-08-19T20:08:33.616Z,1724098113.616 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-08-19T20:08:33.768Z,1724098113.768 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-08-19T20:08:33.769Z,1724098113.769 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-08-19T20:08:34.026Z,1724098114.026 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-08-19T20:08:34.027Z,1724098114.027 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-08-19T20:08:34.628Z,1724098114.628 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-08-19T20:08:34.629Z,1724098114.629 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-08-19T20:08:35.257Z,1724098115.257 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-08-19T20:08:35.258Z,1724098115.258 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-08-19T20:08:35.352Z,1724098115.352 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-08-19T20:08:35.561Z,1724098115.561 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-08-19T20:08:35.562Z,1724098115.562 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-08-19T20:08:35.807Z,1724098115.807 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-08-19T20:08:35.808Z,1724098115.808 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-08-19T20:08:36.122Z,1724098116.122 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-08-19T20:08:36.124Z,1724098116.124 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2024-08-19T20:08:36.125Z,1724098116.125 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2024-08-19T20:08:36.246Z,1724098116.246 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2024-08-19T20:08:36.411Z,1724098116.411 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2024-08-19T20:08:36.518Z,1724098116.518 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2024-08-19T20:08:36.614Z,1724098116.614 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2024-08-19T20:08:36.738Z,1724098116.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg 2024-08-19T20:08:36.835Z,1724098116.835 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2024-08-19T20:08:36.954Z,1724098116.954 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2024-08-19T20:08:37.229Z,1724098117.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-08-19T20:08:37.230Z,1724098117.230 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2024-08-19T20:08:37.377Z,1724098117.377 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2024-08-19T20:08:37.484Z,1724098117.484 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2024-08-19T20:08:37.590Z,1724098117.590 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2024-08-19T20:08:37.708Z,1724098117.708 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/ 2024-08-19T20:08:37.709Z,1724098117.709 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-08-19T20:08:37.726Z,1724098117.726 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-08-19T20:08:37.896Z,1724098117.896 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-08-19T20:08:37.897Z,1724098117.897 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-08-19T20:08:37.912Z,1724098117.912 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-08-19T20:08:37.912Z,1724098117.912 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-08-19T20:08:37.981Z,1724098117.981 [DepthRateCalculator] Loaded 2024-08-19T20:08:37.981Z,1724098117.981 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-08-19T20:08:37.987Z,1724098117.987 [PitchRateCalculator] Loaded 2024-08-19T20:08:37.987Z,1724098117.987 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-08-19T20:08:37.997Z,1724098117.997 [SpeedCalculator] Loaded 2024-08-19T20:08:37.997Z,1724098117.997 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-08-19T20:08:38.002Z,1724098118.002 [YawRateCalculator] Loaded 2024-08-19T20:08:38.002Z,1724098118.002 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-08-19T20:08:38.023Z,1724098118.023 [ElevatorOffsetCalculator] Loaded 2024-08-19T20:08:38.023Z,1724098118.023 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-08-19T20:08:38.023Z,1724098118.023 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-08-19T20:08:38.024Z,1724098118.024 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-08-19T20:08:38.091Z,1724098118.091 [VerticalControl](DEBUG): Construct VerticalControl. 2024-08-19T20:08:38.145Z,1724098118.145 [VerticalControl] Loaded 2024-08-19T20:08:38.145Z,1724098118.145 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-08-19T20:08:38.148Z,1724098118.148 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-08-19T20:08:38.193Z,1724098118.193 [HorizontalControl] Loaded 2024-08-19T20:08:38.194Z,1724098118.194 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-08-19T20:08:38.196Z,1724098118.196 [SpeedControl](DEBUG): Construct SpeedControl. 2024-08-19T20:08:38.199Z,1724098118.199 [SpeedControl] Loaded 2024-08-19T20:08:38.199Z,1724098118.199 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-08-19T20:08:38.201Z,1724098118.201 [LoopControl](DEBUG): Construct LoopControl. 2024-08-19T20:08:38.202Z,1724098118.202 [LoopControl] Loaded 2024-08-19T20:08:38.202Z,1724098118.202 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-08-19T20:08:38.202Z,1724098118.202 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-08-19T20:08:38.203Z,1724098118.203 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-08-19T20:08:38.336Z,1724098118.336 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-08-19T20:08:38.336Z,1724098118.336 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-08-19T20:08:38.363Z,1724098118.363 [NavChart] Loaded 2024-08-19T20:08:38.389Z,1724098118.389 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-08-19T20:08:38.394Z,1724098118.394 [UniversalFixResidualReporter] Loaded 2024-08-19T20:08:38.394Z,1724098118.394 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-08-19T20:08:38.395Z,1724098118.395 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-08-19T20:08:38.396Z,1724098118.396 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-08-19T20:08:38.617Z,1724098118.617 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-08-19T20:08:38.619Z,1724098118.619 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-08-19T20:08:39.391Z,1724098119.391 [AHRS_M2] Loaded 2024-08-19T20:08:39.391Z,1724098119.391 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-08-19T20:08:39.752Z,1724098119.752 [BackseatComponent] Loaded 2024-08-19T20:08:39.753Z,1724098119.753 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-08-19T20:08:39.754Z,1724098119.754 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409384E0 2024-08-19T20:08:39.754Z,1724098119.754 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3259 2024-08-19T20:08:39.818Z,1724098119.818 [LcmUniversalReporter] Loaded 2024-08-19T20:08:39.818Z,1724098119.818 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-08-19T20:08:40.859Z,1724098120.859 [BPC1] Loaded 2024-08-19T20:08:40.859Z,1724098120.859 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-08-19T20:08:40.945Z,1724098120.945 [DATMMP] Loaded 2024-08-19T20:08:40.945Z,1724098120.945 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2024-08-19T20:08:40.946Z,1724098120.946 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409694E0 2024-08-19T20:08:40.946Z,1724098120.946 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 3260 2024-08-19T20:08:41.047Z,1724098121.047 [DataOverHttps] Loaded 2024-08-19T20:08:41.047Z,1724098121.047 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-08-19T20:08:41.048Z,1724098121.048 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409994E0 2024-08-19T20:08:41.049Z,1724098121.049 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3261 2024-08-19T20:08:41.077Z,1724098121.077 [Depth_Keller] Loaded 2024-08-19T20:08:41.077Z,1724098121.077 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-08-19T20:08:41.117Z,1724098121.117 [DVL_micro] Loaded 2024-08-19T20:08:41.117Z,1724098121.117 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2024-08-19T20:08:41.181Z,1724098121.181 [NAL9602] Loaded 2024-08-19T20:08:41.181Z,1724098121.181 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-08-19T20:08:41.211Z,1724098121.211 [Onboard] Loaded 2024-08-19T20:08:41.211Z,1724098121.211 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-08-19T20:08:41.212Z,1724098121.212 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409C94E0 2024-08-19T20:08:41.212Z,1724098121.212 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3262 2024-08-19T20:08:41.226Z,1724098121.226 [Power24vConverter] Loaded 2024-08-19T20:08:41.227Z,1724098121.227 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-08-19T20:08:41.241Z,1724098121.241 [Radio_Surface] Loaded 2024-08-19T20:08:41.242Z,1724098121.242 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-08-19T20:08:41.243Z,1724098121.243 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409F94E0 2024-08-19T20:08:41.243Z,1724098121.243 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3263 2024-08-19T20:08:41.258Z,1724098121.258 [Sonardyne_Nano] Loaded 2024-08-19T20:08:41.259Z,1724098121.259 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-08-19T20:08:41.259Z,1724098121.259 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-08-19T20:08:41.260Z,1724098121.260 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-08-19T20:08:41.421Z,1724098121.421 [BuoyancyServo] Loaded 2024-08-19T20:08:41.422Z,1724098121.422 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-08-19T20:08:41.443Z,1724098121.443 [MassServo] Loaded 2024-08-19T20:08:41.443Z,1724098121.443 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-08-19T20:08:41.465Z,1724098121.465 [RudderServo] Loaded 2024-08-19T20:08:41.465Z,1724098121.465 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-08-19T20:08:41.481Z,1724098121.481 [ThrusterHE] Loaded 2024-08-19T20:08:41.481Z,1724098121.481 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-08-19T20:08:41.481Z,1724098121.481 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-08-19T20:08:41.482Z,1724098121.482 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-08-19T20:08:41.578Z,1724098121.578 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-08-19T20:08:41.579Z,1724098121.579 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-08-19T20:08:41.627Z,1724098121.627 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-08-19T20:08:41.627Z,1724098121.627 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-08-19T20:08:42.023Z,1724098122.023 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-08-19T20:08:42.024Z,1724098122.024 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-08-19T20:08:42.254Z,1724098122.254 [CTD_Seabird] Loaded 2024-08-19T20:08:42.255Z,1724098122.255 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-08-19T20:08:42.256Z,1724098122.256 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BB34E0 2024-08-19T20:08:42.256Z,1724098122.256 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3264 2024-08-19T20:08:42.293Z,1724098122.293 [ESPComponent] Loaded 2024-08-19T20:08:42.294Z,1724098122.294 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-08-19T20:08:42.315Z,1724098122.315 [PAR_Licor] Loaded 2024-08-19T20:08:42.316Z,1724098122.316 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-08-19T20:08:42.316Z,1724098122.316 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-08-19T20:08:42.317Z,1724098122.317 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-08-19T20:08:42.486Z,1724098122.486 [SBIT](DEBUG): Construct Startup Built In Test. 2024-08-19T20:08:42.495Z,1724098122.495 [SBIT] Loaded 2024-08-19T20:08:42.495Z,1724098122.495 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-08-19T20:08:42.498Z,1724098122.498 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-08-19T20:08:42.511Z,1724098122.511 [IBIT] Loaded 2024-08-19T20:08:42.511Z,1724098122.511 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-08-19T20:08:42.517Z,1724098122.517 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-08-19T20:08:42.621Z,1724098122.621 [CBIT] Loaded 2024-08-19T20:08:42.622Z,1724098122.622 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-08-19T20:08:42.622Z,1724098122.622 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-08-19T20:08:42.628Z,1724098122.628 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-08-19T20:08:42.631Z,1724098122.631 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-08-19T20:08:42.642Z,1724098122.642 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-08-19T20:08:42.643Z,1724098122.643 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C224E0 2024-08-19T20:08:42.643Z,1724098122.643 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3265 2024-08-19T20:08:42.648Z,1724098122.648 [Supervisor](INFO): Main Thread ID is 3168 2024-08-19T20:08:42.648Z,1724098122.648 [Supervisor](DEBUG): Running supervisor. 2024-08-19T20:08:42.649Z,1724098122.649 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3266 2024-08-19T20:08:42.649Z,1724098122.649 [CommandExec](INFO): Initializing the command executive. 2024-08-19T20:08:42.650Z,1724098122.650 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3267 2024-08-19T20:08:42.653Z,1724098122.653 [controlThread ThreadHandler](INFO): Handler Thread ID is 3268 2024-08-19T20:08:42.653Z,1724098122.653 [controlThread](DEBUG): Initializing ControlThread 2024-08-19T20:08:42.654Z,1724098122.654 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-08-19T20:08:42.654Z,1724098122.654 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-08-19T20:08:42.655Z,1724098122.655 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-08-19T20:08:42.655Z,1724098122.655 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-08-19T20:08:42.655Z,1724098122.655 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-08-19T20:08:42.656Z,1724098122.656 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-08-19T20:08:42.657Z,1724098122.657 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-08-19T20:08:42.658Z,1724098122.658 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-08-19T20:08:42.658Z,1724098122.658 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-08-19T20:08:42.659Z,1724098122.659 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-08-19T20:08:42.660Z,1724098122.660 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-08-19T20:08:42.669Z,1724098122.669 [SBIT](INFO): Initialize SBIT Component. 2024-08-19T20:08:42.669Z,1724098122.669 [SBIT](IMPORTANT): git: 2024-08-12-95-g598b95f60 2024-08-19T20:08:42.670Z,1724098122.670 [SBIT](INFO): git hash: 598b95f6033d24136933a3d5d1ddac5d4570ac95 2024-08-19T20:08:42.670Z,1724098122.670 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-08-19T20:08:42.671Z,1724098122.671 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-08-19T20:08:42.672Z,1724098122.672 [SBIT](INFO): Beginning SBIT in 68.000000 seconds. 2024-08-19T20:08:42.673Z,1724098122.673 [IBIT](INFO): Initialize IBIT Component. 2024-08-19T20:08:42.674Z,1724098122.674 [CBIT](DEBUG): Initialize CBIT Component. 2024-08-19T20:08:42.674Z,1724098122.674 [logger ThreadHandler](INFO): Handler Thread ID is 3269 2024-08-19T20:08:42.685Z,1724098122.685 [CBIT](DEBUG): Initialized mux pins. 2024-08-19T20:08:42.685Z,1724098122.685 [CBIT](DEBUG): Initializing the watchdog timer. 2024-08-19T20:08:42.693Z,1724098122.693 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3270 2024-08-19T20:08:42.705Z,1724098122.705 [DATMMP ThreadHandler](INFO): Handler Thread ID is 3271 2024-08-19T20:08:42.706Z,1724098122.706 [DATMMP](INFO): Start 2024-08-19T20:08:42.706Z,1724098122.706 [DATMMP](INFO): Powering up 2024-08-19T20:08:42.706Z,1724098122.706 [DATMMP](DEBUG): Initializing DATMMP. 2024-08-19T20:08:42.709Z,1724098122.709 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-08-19T20:08:42.709Z,1724098122.709 [CBIT](DEBUG): Initializing heartbeat. 2024-08-19T20:08:42.715Z,1724098122.715 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3273 2024-08-19T20:08:42.717Z,1724098122.717 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-08-19T20:08:42.725Z,1724098122.725 [Onboard ThreadHandler](INFO): Handler Thread ID is 3274 2024-08-19T20:08:42.743Z,1724098122.743 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3275 2024-08-19T20:08:42.765Z,1724098122.765 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3276 2024-08-19T20:08:42.766Z,1724098122.766 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-08-19T20:08:42.770Z,1724098122.770 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3278 2024-08-19T20:08:42.774Z,1724098122.774 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK1NORSO.000 2024-08-19T20:08:42.774Z,1724098122.774 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK1NORSO.000 2024-08-19T20:08:42.775Z,1724098122.775 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK2NORS.000 2024-08-19T20:08:42.775Z,1724098122.775 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK2NORS.000 2024-08-19T20:08:42.775Z,1724098122.775 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK3HORRO.000 2024-08-19T20:08:42.775Z,1724098122.775 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK3HORRO.000 2024-08-19T20:08:42.781Z,1724098122.781 [CBIT](DEBUG): Deactivating GF circuits. 2024-08-19T20:08:42.781Z,1724098122.781 [CBIT](DEBUG): Deactivating emergency mode. 2024-08-19T20:08:42.821Z,1724098122.821 [CBIT](DEBUG): Backplane powered. 2024-08-19T20:08:42.821Z,1724098122.821 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-08-19T20:08:42.822Z,1724098122.822 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-08-19T20:08:42.822Z,1724098122.822 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-08-19T20:08:42.827Z,1724098122.827 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-08-19T20:08:42.886Z,1724098122.886 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-08-19T20:08:42.906Z,1724098122.906 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-08-19T20:08:42.926Z,1724098122.926 [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-19T20:08:42.927Z,1724098122.927 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-08-19T20:08:42.927Z,1724098122.927 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-08-19T20:08:42.943Z,1724098122.943 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-08-19T20:08:42.957Z,1724098122.957 [DATMMP](INFO): Starting 2024-08-19T20:08:43.149Z,1724098123.149 [Radio_Surface](INFO): Powering up 2024-08-19T20:08:43.209Z,1724098123.209 [DATMMP](INFO): Starting 2024-08-19T20:08:43.248Z,1724098123.248 [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-19T20:08:43.274Z,1724098123.274 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-08-19T20:08:43.275Z,1724098123.275 [Default:A.Wait](DEBUG): Construct Wait. 2024-08-19T20:08:43.278Z,1724098123.278 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-08-19T20:08:43.348Z,1724098123.348 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-08-19T20:08:43.351Z,1724098123.351 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-08-19T20:08:43.369Z,1724098123.369 [Default:E.Execute](DEBUG): Construct Execute. 2024-08-19T20:08:43.372Z,1724098123.372 [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-19T20:08:43.378Z,1724098123.378 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-08-19T20:08:43.401Z,1724098123.401 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-08-19T20:08:43.461Z,1724098123.461 [DATMMP](INFO): Starting 2024-08-19T20:08:43.474Z,1724098123.474 [Power24vConverter](INFO): Powering up. 2024-08-19T20:08:43.475Z,1724098123.475 [Sonardyne_Nano](INFO): Initializing. 2024-08-19T20:08:43.547Z,1724098123.547 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:08:43.549Z,1724098123.549 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-08-19T20:08:43.550Z,1724098123.550 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:08:43.557Z,1724098123.557 [MassServo](DEBUG): Initializing MassServo. 2024-08-19T20:08:43.558Z,1724098123.558 [RudderServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:08:43.565Z,1724098123.565 [RudderServo](DEBUG): Initializing RudderServo. 2024-08-19T20:08:43.566Z,1724098123.566 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-08-19T20:08:43.573Z,1724098123.573 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-08-19T20:08:43.713Z,1724098123.713 [DATMMP](INFO): Starting 2024-08-19T20:08:43.965Z,1724098123.965 [DATMMP](INFO): Starting 2024-08-19T20:08:44.217Z,1724098124.217 [DATMMP](INFO): Starting 2024-08-19T20:08:44.469Z,1724098124.469 [DATMMP](INFO): Starting 2024-08-19T20:08:44.721Z,1724098124.721 [DATMMP](INFO): Starting 2024-08-19T20:08:44.973Z,1724098124.973 [DATMMP](INFO): Starting 2024-08-19T20:08:45.225Z,1724098125.225 [DATMMP](INFO): Starting 2024-08-19T20:08:45.477Z,1724098125.477 [DATMMP](INFO): Starting 2024-08-19T20:08:45.729Z,1724098125.729 [DATMMP](INFO): Starting 2024-08-19T20:08:45.981Z,1724098125.981 [DATMMP](INFO): Starting 2024-08-19T20:08:46.234Z,1724098126.234 [DATMMP](INFO): Starting 2024-08-19T20:08:46.485Z,1724098126.485 [DATMMP](INFO): Starting 2024-08-19T20:08:46.737Z,1724098126.737 [DATMMP](INFO): Starting 2024-08-19T20:08:46.941Z,1724098126.941 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:46.989Z,1724098126.989 [DATMMP](INFO): Starting 2024-08-19T20:08:47.241Z,1724098127.241 [DATMMP](INFO): Starting 2024-08-19T20:08:47.369Z,1724098127.369 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:47.493Z,1724098127.493 [DATMMP](INFO): Starting 2024-08-19T20:08:47.745Z,1724098127.745 [DATMMP](INFO): Starting 2024-08-19T20:08:47.865Z,1724098127.865 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:47.938Z,1724098127.938 [MassServo](FAULT): Overload Error 2024-08-19T20:08:47.938Z,1724098127.938 [MassServo] Hardware Fault, FailCount= 1 2024-08-19T20:08:47.938Z,1724098127.938 [MassServo](ERROR): Hardware Fault 2024-08-19T20:08:47.969Z,1724098127.969 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-08-19T20:08:47.998Z,1724098127.998 [DATMMP](INFO): Starting 2024-08-19T20:08:48.249Z,1724098128.249 [DATMMP](INFO): Starting 2024-08-19T20:08:48.301Z,1724098128.301 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:48.421Z,1724098128.421 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-19T20:08:48.421Z,1724098128.421 [MassServo](INFO): Powering down 2024-08-19T20:08:48.502Z,1724098128.502 [DATMMP](INFO): Starting 2024-08-19T20:08:48.753Z,1724098128.753 [DATMMP](INFO): Starting 2024-08-19T20:08:48.781Z,1724098128.781 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:49.005Z,1724098129.005 [DATMMP](INFO): Starting 2024-08-19T20:08:49.229Z,1724098129.229 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:49.257Z,1724098129.257 [DATMMP](INFO): Starting 2024-08-19T20:08:49.289Z,1724098129.289 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:08:49.441Z,1724098129.441 [MassServo](DEBUG): Initializing MassServo. 2024-08-19T20:08:49.509Z,1724098129.509 [DATMMP](INFO): Starting 2024-08-19T20:08:49.562Z,1724098129.562 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-08-19T20:08:49.625Z,1724098129.625 [CBIT](INFO): Clearing failed state for component MassServo 2024-08-19T20:08:49.625Z,1724098129.625 [MassServo] No Fault, FailCount= 1 2024-08-19T20:08:49.761Z,1724098129.761 [DATMMP](INFO): Starting 2024-08-19T20:08:49.957Z,1724098129.957 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:50.013Z,1724098130.013 [DATMMP](INFO): Starting 2024-08-19T20:08:50.265Z,1724098130.265 [DATMMP](INFO): Starting 2024-08-19T20:08:50.461Z,1724098130.461 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:50.517Z,1724098130.517 [DATMMP](INFO): Starting 2024-08-19T20:08:50.769Z,1724098130.769 [DATMMP](INFO): Starting 2024-08-19T20:08:50.941Z,1724098130.941 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:51.021Z,1724098131.021 [DATMMP](INFO): Starting 2024-08-19T20:08:51.273Z,1724098131.273 [DATMMP](INFO): Starting 2024-08-19T20:08:51.357Z,1724098131.357 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:51.525Z,1724098131.525 [DATMMP](INFO): Starting 2024-08-19T20:08:51.777Z,1724098131.777 [DATMMP](INFO): Starting 2024-08-19T20:08:51.809Z,1724098131.809 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:52.029Z,1724098132.029 [DATMMP](INFO): Starting 2024-08-19T20:08:52.253Z,1724098132.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:52.281Z,1724098132.281 [DATMMP](INFO): Starting 2024-08-19T20:08:52.533Z,1724098132.533 [DATMMP](INFO): Starting 2024-08-19T20:08:52.709Z,1724098132.709 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:52.785Z,1724098132.785 [DATMMP](INFO): Starting 2024-08-19T20:08:53.037Z,1724098133.037 [DATMMP](INFO): Starting 2024-08-19T20:08:53.173Z,1724098133.173 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:53.289Z,1724098133.289 [DATMMP](INFO): Starting 2024-08-19T20:08:53.541Z,1724098133.541 [DATMMP](INFO): Starting 2024-08-19T20:08:53.625Z,1724098133.625 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:53.745Z,1724098133.745 [MassServo](FAULT): Overload Error 2024-08-19T20:08:53.745Z,1724098133.745 [MassServo] Hardware Fault, FailCount= 2 2024-08-19T20:08:53.745Z,1724098133.745 [MassServo](ERROR): Hardware Fault 2024-08-19T20:08:53.749Z,1724098133.749 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-08-19T20:08:53.794Z,1724098133.794 [DATMMP](INFO): Starting 2024-08-19T20:08:54.045Z,1724098134.045 [DATMMP](INFO): Starting 2024-08-19T20:08:54.073Z,1724098134.073 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:54.189Z,1724098134.189 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-19T20:08:54.189Z,1724098134.189 [MassServo](INFO): Powering down 2024-08-19T20:08:54.297Z,1724098134.297 [DATMMP](INFO): Starting 2024-08-19T20:08:54.533Z,1724098134.533 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:54.549Z,1724098134.549 [DATMMP](INFO): Starting 2024-08-19T20:08:54.801Z,1724098134.801 [DATMMP](INFO): Starting 2024-08-19T20:08:54.801Z,1724098134.801 [DATMMP](INFO): DAT read: 2024-08-19T20:08:54.802Z,1724098134.802 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-08-19T20:08:54.973Z,1724098134.973 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:55.050Z,1724098135.050 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:08:55.053Z,1724098135.053 [DATMMP](INFO): Starting 2024-08-19T20:08:55.166Z,1724098135.166 [MassServo](DEBUG): Initializing MassServo. 2024-08-19T20:08:55.170Z,1724098135.170 [CBIT](INFO): Clearing failed state for component MassServo 2024-08-19T20:08:55.170Z,1724098135.170 [MassServo] No Fault, FailCount= 2 2024-08-19T20:08:55.305Z,1724098135.305 [DATMMP](INFO): Starting 2024-08-19T20:08:55.505Z,1724098135.505 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:55.557Z,1724098135.557 [DATMMP](INFO): Starting 2024-08-19T20:08:55.661Z,1724098135.661 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.010283 2024-08-19T20:08:55.809Z,1724098135.809 [DATMMP](INFO): Starting 2024-08-19T20:08:55.817Z,1724098135.817 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-08-19T20:08:55.817Z,1724098135.817 [CTD_Seabird] Communications Fault, FailCount= 1 2024-08-19T20:08:55.817Z,1724098135.817 [CTD_Seabird](ERROR): Communications Fault 2024-08-19T20:08:55.937Z,1724098135.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:56.035Z,1724098136.035 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-08-19T20:08:56.061Z,1724098136.061 [DATMMP](INFO): Starting 2024-08-19T20:08:56.222Z,1724098136.222 [CTD_Seabird](INFO): Powering down 2024-08-19T20:08:56.313Z,1724098136.313 [DATMMP](INFO): Starting 2024-08-19T20:08:56.314Z,1724098136.314 [DATMMP](INFO): DAT read: MF Frequency Band 2024-08-19T20:08:56.315Z,1724098136.315 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-08-19T20:08:56.315Z,1724098136.315 [DATMMP](INFO): DAT read: Jan 4 2000 03:54:53 2024-08-19T20:08:56.377Z,1724098136.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:08:56.377Z,1724098136.377 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-08-19T20:08:56.377Z,1724098136.377 [AHRS_M2] Communications Fault, FailCount= 1 2024-08-19T20:08:56.377Z,1724098136.377 [AHRS_M2](ERROR): Communications Fault 2024-08-19T20:08:56.449Z,1724098136.449 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-08-19T20:08:56.456Z,1724098136.456 [AHRS_M2](INFO): Powering down 2024-08-19T20:08:56.565Z,1724098136.565 [DATMMP](INFO): Starting 2024-08-19T20:08:56.817Z,1724098136.817 [DATMMP](INFO): Starting 2024-08-19T20:08:57.069Z,1724098137.069 [DATMMP](INFO): Starting 2024-08-19T20:08:57.321Z,1724098137.321 [DATMMP](INFO): Starting 2024-08-19T20:08:57.353Z,1724098137.353 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-08-19T20:08:57.353Z,1724098137.353 [AHRS_M2] No Fault, FailCount= 1 2024-08-19T20:08:57.354Z,1724098137.354 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-08-19T20:08:57.354Z,1724098137.354 [CTD_Seabird] No Fault, FailCount= 1 2024-08-19T20:08:57.565Z,1724098137.565 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-08-19T20:08:57.573Z,1724098137.573 [DATMMP](INFO): Starting 2024-08-19T20:08:57.574Z,1724098137.574 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2024-08-19T20:08:57.575Z,1724098137.575 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-08-19T20:08:57.575Z,1724098137.575 [DATMMP](INFO): commRate: 800 2024-08-19T20:08:57.666Z,1724098137.666 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-08-19T20:08:57.825Z,1724098137.825 [DATMMP](INFO): Starting 2024-08-19T20:08:58.078Z,1724098138.078 [DATMMP](INFO): Starting 2024-08-19T20:08:58.329Z,1724098138.329 [DATMMP](INFO): Starting 2024-08-19T20:08:58.581Z,1724098138.581 [DATMMP](INFO): Starting 2024-08-19T20:08:58.833Z,1724098138.833 [DATMMP](INFO): Starting 2024-08-19T20:08:59.085Z,1724098139.085 [DATMMP](INFO): Starting 2024-08-19T20:08:59.337Z,1724098139.337 [DATMMP](INFO): Starting 2024-08-19T20:08:59.377Z,1724098139.377 [MassServo](FAULT): Overload Error 2024-08-19T20:08:59.377Z,1724098139.377 [MassServo] Hardware Fault, FailCount= 3 2024-08-19T20:08:59.377Z,1724098139.377 [MassServo](ERROR): Hardware Fault 2024-08-19T20:08:59.381Z,1724098139.381 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-08-19T20:08:59.589Z,1724098139.589 [DATMMP](INFO): Starting 2024-08-19T20:08:59.641Z,1724098139.641 [DATMMP](INFO): entering command mode 2024-08-19T20:08:59.766Z,1724098139.766 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-19T20:08:59.766Z,1724098139.766 [MassServo](INFO): Powering down 2024-08-19T20:08:59.841Z,1724098139.841 [DATMMP](INFO): Starting 2024-08-19T20:08:59.841Z,1724098139.841 [DATMMP](INFO): DAT read: 2024-08-19T20:08:59.842Z,1724098139.842 [DATMMP](INFO): DAT read: user:1> 2024-08-19T20:08:59.842Z,1724098139.842 [DATMMP](DEBUG): read user prompt 1: user:1> 2024-08-19T20:08:59.842Z,1724098139.842 [DATMMP](INFO): entering MMP mode 2024-08-19T20:09:00.093Z,1724098140.093 [DATMMP](INFO): Starting 2024-08-19T20:09:00.093Z,1724098140.093 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-19T20:09:00.095Z,1724098140.095 [DATMMP](INFO): status rx: x1 2024-08-19T20:09:00.095Z,1724098140.095 [DATMMP](INFO): MMP status: 1: started 2024-08-19T20:09:00.095Z,1724098140.095 [DATMMP](INFO): Received message type: status 2024-08-19T20:09:00.096Z,1724098140.096 [DATMMP](INFO): Handled 2024-08-19T20:09:00.345Z,1724098140.345 [DATMMP](INFO): Starting 2024-08-19T20:09:00.346Z,1724098140.346 [DATMMP](INFO): Sent Tx Power Config 8 2024-08-19T20:09:00.346Z,1724098140.346 [DATMMP](INFO): Setting local address: 11 2024-08-19T20:09:00.348Z,1724098140.348 [DATMMP](INFO): Setting time to: 20:9:0 And date to:8/19/2024 2024-08-19T20:09:00.520Z,1724098140.520 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:09:00.597Z,1724098140.597 [DATMMP](INFO): Starting 2024-08-19T20:09:00.597Z,1724098140.597 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-19T20:09:00.598Z,1724098140.598 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0 2024-08-19T20:09:00.598Z,1724098140.598 [DATMMP](INFO): Received message type: mdmpower 2024-08-19T20:09:00.599Z,1724098140.599 [DATMMP](INFO): Handled 2024-08-19T20:09:00.642Z,1724098140.642 [MassServo](DEBUG): Initializing MassServo. 2024-08-19T20:09:00.648Z,1724098140.648 [CBIT](INFO): Clearing failed state for component MassServo 2024-08-19T20:09:00.648Z,1724098140.648 [MassServo] No Fault, FailCount= 3 2024-08-19T20:09:00.849Z,1724098140.849 [DATMMP](INFO): Starting 2024-08-19T20:09:00.849Z,1724098140.849 [DATMMP](INFO): GSXN notify for xid: 10 2024-08-19T20:09:00.850Z,1724098140.850 [DATMMP](INFO): sreg_txpower rx: x8 2024-08-19T20:09:00.850Z,1724098140.850 [DATMMP](INFO): Received message type: sreg_txpower 2024-08-19T20:09:00.850Z,1724098140.850 [DATMMP](INFO): Match for : sreg_txpower 2024-08-19T20:09:00.850Z,1724098140.850 [DATMMP](INFO): ACK 2024-08-19T20:09:01.101Z,1724098141.101 [DATMMP](INFO): Starting 2024-08-19T20:09:01.101Z,1724098141.101 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-19T20:09:01.102Z,1724098141.102 [DATMMP](INFO): mdmlocal rx: xB x0 x0 x0 2024-08-19T20:09:01.102Z,1724098141.102 [DATMMP](INFO): Received message type: mdmlocal 2024-08-19T20:09:01.103Z,1724098141.103 [DATMMP](INFO): Handled 2024-08-19T20:09:01.217Z,1724098141.217 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:01.219Z,1724098141.219 [DVL_micro](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:01.219Z,1724098141.219 [DVL_micro] Communications Fault, FailCount= 1 2024-08-19T20:09:01.219Z,1724098141.219 [DVL_micro](ERROR): Communications Fault 2024-08-19T20:09:01.238Z,1724098141.238 [CBIT](ERROR): Communications Fault in component: DVL_micro 2024-08-19T20:09:01.353Z,1724098141.353 [DATMMP](INFO): Starting 2024-08-19T20:09:01.353Z,1724098141.353 [DATMMP](INFO): GSXN notify for xid: 11 2024-08-19T20:09:01.354Z,1724098141.354 [DATMMP](INFO): sreg_locaddr rx: xB 2024-08-19T20:09:01.354Z,1724098141.354 [DATMMP](INFO): Received message type: sreg_locaddr 2024-08-19T20:09:01.354Z,1724098141.354 [DATMMP](INFO): Match for : sreg_locaddr 2024-08-19T20:09:01.354Z,1724098141.354 [DATMMP](INFO): ACK 2024-08-19T20:09:01.605Z,1724098141.605 [DATMMP](INFO): Starting 2024-08-19T20:09:01.605Z,1724098141.605 [DATMMP](INFO): GSXN notify for xid: 12 2024-08-19T20:09:01.606Z,1724098141.606 [DATMMP](INFO): timedate rx: x0 x14 x9 x0 x7 x13 x7C x0 2024-08-19T20:09:01.607Z,1724098141.607 [DATMMP](INFO): Received message type: timedate 2024-08-19T20:09:01.607Z,1724098141.607 [DATMMP](INFO): Match for : timedate 2024-08-19T20:09:01.607Z,1724098141.607 [DATMMP](INFO): ACK 2024-08-19T20:09:01.629Z,1724098141.629 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:01.729Z,1724098141.729 [DVL_micro](INFO): Powering down 2024-08-19T20:09:01.857Z,1724098141.857 [DATMMP](INFO): Starting 2024-08-19T20:09:01.857Z,1724098141.857 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-19T20:09:01.858Z,1724098141.858 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2024-08-19T20:09:01.858Z,1724098141.858 [DATMMP](INFO): Received message type: sys_verb 2024-08-19T20:09:01.858Z,1724098141.858 [DATMMP](INFO): Handled 2024-08-19T20:09:02.109Z,1724098142.109 [DATMMP](INFO): Starting 2024-08-19T20:09:02.109Z,1724098142.109 [DATMMP](INFO): GSXN notify for xid: 13 2024-08-19T20:09:02.110Z,1724098142.110 [DATMMP](INFO): sreg_verbosity rx: x0 2024-08-19T20:09:02.110Z,1724098142.110 [DATMMP](INFO): Received message type: sreg_verbosity 2024-08-19T20:09:02.110Z,1724098142.110 [DATMMP](INFO): Match for : sreg_verbosity 2024-08-19T20:09:02.110Z,1724098142.110 [DATMMP](INFO): ACK 2024-08-19T20:09:02.253Z,1724098142.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:02.362Z,1724098142.362 [DATMMP](INFO): Starting 2024-08-19T20:09:02.364Z,1724098142.364 [DATMMP](INFO): GSXN notify for xid: 14 2024-08-19T20:09:02.366Z,1724098142.366 [DATMMP](INFO): version rx: x2 x5 2024-08-19T20:09:02.367Z,1724098142.367 [DATMMP](INFO): DatMMPVersion: 2.5 2024-08-19T20:09:02.367Z,1724098142.367 [DATMMP](INFO): Received message type: version 2024-08-19T20:09:02.367Z,1724098142.367 [DATMMP](INFO): Match for : version 2024-08-19T20:09:02.367Z,1724098142.367 [DATMMP](INFO): ACK 2024-08-19T20:09:02.367Z,1724098142.367 [DATMMP](INFO): in MMP mode: config complete going to runnable 2024-08-19T20:09:02.657Z,1724098142.657 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:02.678Z,1724098142.678 [CBIT](INFO): Clearing failed state for component DVL_micro 2024-08-19T20:09:02.678Z,1724098142.678 [DVL_micro] No Fault, FailCount= 1 2024-08-19T20:09:03.089Z,1724098143.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:03.461Z,1724098143.461 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:03.929Z,1724098143.929 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:04.321Z,1724098144.321 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:04.737Z,1724098144.737 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:05.141Z,1724098145.141 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:05.185Z,1724098145.185 [MassServo](FAULT): Overload Error 2024-08-19T20:09:05.185Z,1724098145.185 [MassServo] Hardware Fault, FailCount= 4 2024-08-19T20:09:05.185Z,1724098145.185 [MassServo](ERROR): Hardware Fault 2024-08-19T20:09:05.189Z,1724098145.189 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-08-19T20:09:05.553Z,1724098145.553 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:05.575Z,1724098145.575 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-19T20:09:05.576Z,1724098145.576 [MassServo](INFO): Powering down 2024-08-19T20:09:05.937Z,1724098145.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:06.349Z,1724098146.349 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:06.380Z,1724098146.380 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:09:06.498Z,1724098146.498 [MassServo](DEBUG): Initializing MassServo. 2024-08-19T20:09:06.502Z,1724098146.502 [CBIT](INFO): Clearing failed state for component MassServo 2024-08-19T20:09:06.502Z,1724098146.502 [MassServo] No Fault, FailCount= 4 2024-08-19T20:09:06.833Z,1724098146.833 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:07.229Z,1724098147.229 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:07.641Z,1724098147.641 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:08.049Z,1724098148.049 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:08.453Z,1724098148.453 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:08.853Z,1724098148.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:09.273Z,1724098149.273 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:09.685Z,1724098149.685 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:10.089Z,1724098150.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:10.493Z,1724098150.493 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:10.617Z,1724098150.617 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:10.617Z,1724098150.617 [CTD_Seabird] Communications Fault, FailCount= 2 2024-08-19T20:09:10.617Z,1724098150.617 [CTD_Seabird](ERROR): Communications Fault 2024-08-19T20:09:10.917Z,1724098150.917 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:10.917Z,1724098150.917 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:10.917Z,1724098150.917 [AHRS_M2] Communications Fault, FailCount= 2 2024-08-19T20:09:10.917Z,1724098150.917 [AHRS_M2](ERROR): Communications Fault 2024-08-19T20:09:10.980Z,1724098150.980 [MassServo](FAULT): Overload Error 2024-08-19T20:09:10.980Z,1724098150.980 [MassServo] Hardware Fault, FailCount= 5 2024-08-19T20:09:10.980Z,1724098150.980 [MassServo](ERROR): Hardware Fault 2024-08-19T20:09:10.985Z,1724098150.985 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-08-19T20:09:10.985Z,1724098150.985 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-08-19T20:09:10.985Z,1724098150.985 [CBIT](CRITICAL): Hardware Fault in component: MassServo 2024-08-19T20:09:10.986Z,1724098150.986 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-08-19T20:09:10.992Z,1724098150.992 [AHRS_M2](INFO): Powering down 2024-08-19T20:09:11.025Z,1724098151.025 [CTD_Seabird](INFO): Powering down 2024-08-19T20:09:11.093Z,1724098151.093 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-19T20:09:11.093Z,1724098151.093 [MassServo](INFO): Powering down 2024-08-19T20:09:11.096Z,1724098151.096 [CommandExec](FAULT): Scheduling is paused 2024-08-19T20:09:11.096Z,1724098151.096 [CBIT](INFO): Critical error at 20240819T200910 2024-08-19T20:09:11.096Z,1724098151.096 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-08-19T20:09:11.406Z,1724098151.406 [NAL9602](INFO): Powering up NAL9602 2024-08-19T20:09:11.817Z,1724098151.817 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:09:11.934Z,1724098151.934 [MassServo](DEBUG): Initializing MassServo. 2024-08-19T20:09:11.938Z,1724098151.938 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-08-19T20:09:11.938Z,1724098151.938 [AHRS_M2] No Fault, FailCount= 2 2024-08-19T20:09:12.202Z,1724098152.202 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-08-19T20:09:12.233Z,1724098152.233 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-08-19T20:09:12.233Z,1724098152.233 [CTD_Seabird] No Fault, FailCount= 2 2024-08-19T20:09:12.369Z,1724098152.369 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-08-19T20:09:15.474Z,1724098155.474 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-19T20:09:15.475Z,1724098155.475 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2024-08-19T20:09:15.475Z,1724098155.475 [DATMMP](INFO): Received message type: timesync 2024-08-19T20:09:15.475Z,1724098155.475 [DATMMP](INFO): Handled 2024-08-19T20:09:15.753Z,1724098155.753 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:16.153Z,1724098156.153 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:16.557Z,1724098156.557 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:16.969Z,1724098156.969 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:17.377Z,1724098157.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:17.770Z,1724098157.770 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:18.173Z,1724098158.173 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:18.585Z,1724098158.585 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:19.081Z,1724098159.081 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:19.429Z,1724098159.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:19.841Z,1724098159.841 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:20.249Z,1724098160.249 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:20.649Z,1724098160.649 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:20.654Z,1724098160.654 [DVL_micro](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:20.654Z,1724098160.654 [DVL_micro] Communications Fault, FailCount= 2 2024-08-19T20:09:20.654Z,1724098160.654 [DVL_micro](ERROR): Communications Fault 2024-08-19T20:09:20.684Z,1724098160.684 [CBIT](ERROR): Communications Fault in component: DVL_micro 2024-08-19T20:09:21.053Z,1724098161.053 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:21.153Z,1724098161.153 [DVL_micro](INFO): Powering down 2024-08-19T20:09:21.541Z,1724098161.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:21.937Z,1724098161.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:21.000Z,1724098162.000 [CBIT](INFO): Clearing failed state for component DVL_micro 2024-08-19T20:09:21.000Z,1724098162.000 [DVL_micro] No Fault, FailCount= 2 2024-08-19T20:09:22.345Z,1724098162.345 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:22.358Z,1724098162.358 [NAL9602](INFO): NAL9602 initialized 2024-08-19T20:09:22.741Z,1724098162.741 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:23.165Z,1724098163.165 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:23.557Z,1724098163.557 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:23.965Z,1724098163.965 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:24.365Z,1724098164.365 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:24.781Z,1724098164.781 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:25.177Z,1724098165.177 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:25.177Z,1724098165.177 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:25.177Z,1724098165.177 [AHRS_M2] Communications Fault, FailCount= 3 2024-08-19T20:09:25.177Z,1724098165.177 [AHRS_M2](ERROR): Communications Fault 2024-08-19T20:09:25.243Z,1724098165.243 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-08-19T20:09:25.250Z,1724098165.250 [AHRS_M2](INFO): Powering down 2024-08-19T20:09:25.421Z,1724098165.421 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:25.421Z,1724098165.421 [CTD_Seabird] Communications Fault, FailCount= 3 2024-08-19T20:09:25.421Z,1724098165.421 [CTD_Seabird](ERROR): Communications Fault 2024-08-19T20:09:25.581Z,1724098165.581 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-19T20:09:25.582Z,1724098165.582 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2024-08-19T20:09:25.582Z,1724098165.582 [DATMMP](INFO): Received message type: timesync 2024-08-19T20:09:25.582Z,1724098165.582 [DATMMP](INFO): Handled 2024-08-19T20:09:25.687Z,1724098165.687 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-08-19T20:09:25.688Z,1724098165.688 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2024-08-19T20:09:25.825Z,1724098165.825 [CTD_Seabird](INFO): Powering down 2024-08-19T20:09:26.084Z,1724098166.084 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-08-19T20:09:26.084Z,1724098166.084 [AHRS_M2] No Fault, FailCount= 3 2024-08-19T20:09:26.463Z,1724098166.463 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-08-19T20:09:30.021Z,1724098170.021 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:30.425Z,1724098170.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:30.821Z,1724098170.821 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:31.225Z,1724098171.225 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:31.637Z,1724098171.637 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:32.041Z,1724098172.041 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:32.441Z,1724098172.441 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:32.845Z,1724098172.845 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:33.257Z,1724098173.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:33.665Z,1724098173.665 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:34.065Z,1724098174.065 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:34.469Z,1724098174.469 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:34.865Z,1724098174.865 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:35.277Z,1724098175.277 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:35.689Z,1724098175.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:36.089Z,1724098176.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:36.477Z,1724098176.477 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:36.893Z,1724098176.893 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:37.297Z,1724098177.297 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:37.689Z,1724098177.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:38.125Z,1724098178.125 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:38.509Z,1724098178.509 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:38.917Z,1724098178.917 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:39.317Z,1724098179.317 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:39.317Z,1724098179.317 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:39.317Z,1724098179.317 [AHRS_M2] Communications Fault, FailCount= 4 2024-08-19T20:09:39.317Z,1724098179.317 [AHRS_M2](ERROR): Communications Fault 2024-08-19T20:09:39.344Z,1724098179.344 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-08-19T20:09:39.398Z,1724098179.398 [AHRS_M2](INFO): Powering down 2024-08-19T20:09:40.210Z,1724098180.210 [DVL_micro](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:40.210Z,1724098180.210 [DVL_micro] Communications Fault, FailCount= 3 2024-08-19T20:09:40.210Z,1724098180.210 [DVL_micro](ERROR): Communications Fault 2024-08-19T20:09:40.273Z,1724098180.273 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-08-19T20:09:40.273Z,1724098180.273 [AHRS_M2] No Fault, FailCount= 4 2024-08-19T20:09:40.273Z,1724098180.273 [CBIT](ERROR): Communications Fault in component: DVL_micro 2024-08-19T20:09:40.274Z,1724098180.274 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2024-08-19T20:09:40.609Z,1724098180.609 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-08-19T20:09:40.717Z,1724098180.717 [DVL_micro](INFO): Powering down 2024-08-19T20:09:40.758Z,1724098180.758 [CBIT](INFO): Critical error at 20240819T200940 2024-08-19T20:09:44.169Z,1724098184.169 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:44.573Z,1724098184.573 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:44.973Z,1724098184.973 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:45.377Z,1724098185.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:45.777Z,1724098185.777 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:46.197Z,1724098186.197 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:46.597Z,1724098186.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:46.989Z,1724098186.989 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:47.393Z,1724098187.393 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:47.797Z,1724098187.797 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:48.201Z,1724098188.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:48.605Z,1724098188.605 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:49.017Z,1724098189.017 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:49.425Z,1724098189.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:49.829Z,1724098189.829 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:50.233Z,1724098190.233 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:50.629Z,1724098190.629 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:51.041Z,1724098191.041 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:51.090Z,1724098191.090 [SBIT](IMPORTANT): Beginning Startup BIT 2024-08-19T20:09:51.095Z,1724098191.095 [CBIT](IMPORTANT): Beginning ground fault scan 2024-08-19T20:09:51.461Z,1724098191.461 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:51.837Z,1724098191.837 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:52.245Z,1724098192.245 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:52.657Z,1724098192.657 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:53.157Z,1724098193.157 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:53.561Z,1724098193.561 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-08-19T20:09:53.561Z,1724098193.561 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-08-19T20:09:53.561Z,1724098193.561 [AHRS_M2] Communications Fault, FailCount= 5 2024-08-19T20:09:53.562Z,1724098193.562 [AHRS_M2](ERROR): Communications Fault 2024-08-19T20:09:53.635Z,1724098193.635 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-08-19T20:09:53.635Z,1724098193.635 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2024-08-19T20:09:53.666Z,1724098193.666 [AHRS_M2](INFO): Powering down 2024-08-19T20:09:53.790Z,1724098193.790 [CBIT](INFO): Critical error at 20240819T200953 2024-08-19T20:10:02.161Z,1724098202.161 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.005509 CHAN A1 (24V): -0.003089 CHAN A2 (12V): -0.000204 CHAN A3 (5V): 0.000519 CHAN B0 (3.3V): 0.001625 CHAN B1 (3.15aV): 0.000301 CHAN B2 (3.15bV): 0.000624 CHAN B3 (GND): 0.000846 OPEN: -0.001416 Full Scale: +/- 1 mA 2024-08-19T20:10:04.175Z,1724098204.175 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-08-19T20:10:04.175Z,1724098204.175 [SBIT](ERROR): Could not read massPosReader_. 2024-08-19T20:10:30.842Z,1724098230.842 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-08-19T20:10:30.843Z,1724098230.843 [SBIT](ERROR): Could not read massPosReader_. 2024-08-19T20:10:30.843Z,1724098230.843 [SBIT](FAULT): Control surface position failure. 2024-08-19T20:10:42.973Z,1724098242.973 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-08-19T20:10:42.973Z,1724098242.973 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-08-19T20:10:42.973Z,1724098242.973 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-08-19T20:10:42.983Z,1724098242.983 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-08-19T20:10:43.381Z,1724098243.381 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-08-19T20:10:43.381Z,1724098243.381 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-08-19T20:10:44.576Z,1724098244.576 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-08-19T20:10:44.576Z,1724098244.576 [SBIT](ERROR): Could not read massPosReader_. 2024-08-19T20:10:44.576Z,1724098244.576 [SBIT](FAULT): Control surface position failure. 2024-08-19T20:10:44.984Z,1724098244.984 [SBIT](CRITICAL): SBIT FAILED 2024-08-19T20:10:44.984Z,1724098244.984 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-08-19T20:10:44.985Z,1724098244.985 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count; 2024-08-19T20:10:44.985Z,1724098244.985 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool; 2024-08-19T20:10:44.985Z,1724098244.985 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-08-19T20:10:44.985Z,1724098244.985 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2024-08-19T20:10:44.985Z,1724098244.985 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2024-08-19T20:10:44.985Z,1724098244.985 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=5 meter; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): Depth_Keller.offset=3.6 decibar; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): ElevatorServo.currLimit=75 percent; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): ElevatorServo.limitHi=16369 count; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): ElevatorServo.limitLo=0 count; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=0 bool; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour; 2024-08-19T20:10:44.986Z,1724098244.986 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2024-08-19T20:10:44.987Z,1724098244.987 [SBIT](IMPORTANT): Radio_Surface.loadAtStartup=1 bool; 2024-08-19T20:10:44.987Z,1724098244.987 [SBIT](IMPORTANT): VerticalControl.massDefault=12.059213 millimeter; 2024-08-19T20:10:44.987Z,1724098244.987 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2024-08-19T20:10:44.989Z,1724098244.989 [CBIT](INFO): Critical error at 20240819T201044 2024-08-19T20:10:45.377Z,1724098245.377 [MissionManager](IMPORTANT): Started mission Startup 2024-08-19T20:10:45.377Z,1724098245.377 [Startup] Running Loop=1 2024-08-19T20:10:45.377Z,1724098245.377 [Startup](DEBUG): Aggregate::initialize Startup 2024-08-19T20:10:45.378Z,1724098245.378 [Startup:A.GoToSurface] Running Loop=1 2024-08-19T20:10:45.378Z,1724098245.378 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-19T20:10:45.378Z,1724098245.378 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-08-19T20:10:45.379Z,1724098245.379 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-08-19T20:10:45.379Z,1724098245.379 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-08-19T20:10:45.379Z,1724098245.379 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-08-19T20:10:45.380Z,1724098245.380 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-19T20:10:45.380Z,1724098245.380 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-19T20:10:45.382Z,1724098245.382 [Startup:StartupSatComms] Running Loop=1 2024-08-19T20:10:45.383Z,1724098245.383 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-08-19T20:10:45.383Z,1724098245.383 [Startup:StartupSatComms:A] Running Loop=1 2024-08-19T20:10:45.779Z,1724098245.779 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-08-19T20:11:45.585Z,1724098305.585 [Startup:StartupSatComms:A](INFO): Timed out from 2024-08-19T20:10:45.4Z 2024-08-19T20:11:45.586Z,1724098305.586 [Startup:StartupSatComms:A] Stopped 2024-08-19T20:11:45.586Z,1724098305.586 [Startup:StartupSatComms:B] Running Loop=1 2024-08-19T20:11:45.986Z,1724098305.986 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-08-19T20:11:49.527Z,1724098309.527 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20000204T030405/Courier0007.lzma 2024-08-19T20:11:50.455Z,1724098310.455 [DataOverHttps](INFO): Moved sent file to Logs/20000204T030405/Courier0007.lzma.bak 2024-08-19T20:11:50.455Z,1724098310.455 [DataOverHttps](INFO): SBD MOMSN=23016583 2024-08-19T20:11:52.555Z,1724098312.555 [BPC1](ERROR): BPC1B: No match for serial number FFFF in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2024-08-19T20:11:55.842Z,1724098315.842 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-08-19T20:11:55.842Z,1724098315.842 [CTD_Seabird] No Fault, FailCount= 3 2024-08-19T20:11:56.245Z,1724098316.245 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-08-19T20:12:09.140Z,1724098329.140 [DataOverHttps](INFO): Sending 270 bytes from file Logs/20240819T200830/Courier0000.lzma 2024-08-19T20:12:09.297Z,1724098329.297 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-08-19T20:12:09.297Z,1724098329.297 [CTD_Seabird] Communications Fault, FailCount= 1 2024-08-19T20:12:09.297Z,1724098329.297 [CTD_Seabird](ERROR): Communications Fault 2024-08-19T20:12:09.553Z,1724098329.553 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-08-19T20:12:09.701Z,1724098329.701 [CTD_Seabird](INFO): Powering down 2024-08-19T20:12:10.114Z,1724098330.114 [DataOverHttps](INFO): Moved sent file to Logs/20240819T200830/Courier0000.lzma.bak 2024-08-19T20:12:10.115Z,1724098330.115 [DataOverHttps](INFO): SBD MOMSN=23016636 2024-08-19T20:12:10.762Z,1724098330.762 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-08-19T20:12:10.763Z,1724098330.763 [CTD_Seabird] No Fault, FailCount= 1 2024-08-19T20:12:11.045Z,1724098331.045 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-08-19T20:12:24.102Z,1724098344.102 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-08-19T20:12:24.102Z,1724098344.102 [CTD_Seabird] Communications Fault, FailCount= 2 2024-08-19T20:12:24.102Z,1724098344.102 [CTD_Seabird](ERROR): Communications Fault 2024-08-19T20:12:24.107Z,1724098344.107 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-08-19T20:12:24.505Z,1724098344.505 [CTD_Seabird](INFO): Powering down 2024-08-19T20:12:25.720Z,1724098345.720 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-08-19T20:12:25.720Z,1724098345.720 [CTD_Seabird] No Fault, FailCount= 2 2024-08-19T20:12:25.849Z,1724098345.849 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-08-19T20:12:29.914Z,1724098349.914 [DataOverHttps](INFO): Sending 287 bytes from file Logs/20000204T030405/Express0008.lzma 2024-08-19T20:12:30.914Z,1724098350.914 [DataOverHttps](INFO): Moved sent file to Logs/20000204T030405/Express0008.lzma.bak 2024-08-19T20:12:30.915Z,1724098350.915 [DataOverHttps](INFO): SBD MOMSN=23016657 2024-08-19T20:12:38.901Z,1724098358.901 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-08-19T20:12:38.901Z,1724098358.901 [CTD_Seabird] Communications Fault, FailCount= 3 2024-08-19T20:12:38.901Z,1724098358.901 [CTD_Seabird](ERROR): Communications Fault 2024-08-19T20:12:39.066Z,1724098359.066 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-08-19T20:12:39.067Z,1724098359.067 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2024-08-19T20:12:39.305Z,1724098359.305 [CTD_Seabird](INFO): Powering down 2024-08-19T20:12:40.276Z,1724098360.276 [CBIT](INFO): Clearing failed state for component DVL_micro 2024-08-19T20:12:40.276Z,1724098360.276 [DVL_micro] No Fault, FailCount= 3 2024-08-19T20:12:43.894Z,1724098363.894 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2024-08-19T20:12:43.894Z,1724098363.894 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-08-19T20:12:43.894Z,1724098363.894 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-08-19T20:12:43.904Z,1724098363.904 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-08-19T20:12:44.313Z,1724098364.313 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-08-19T20:12:44.313Z,1724098364.313 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-08-19T20:12:45.907Z,1724098365.907 [Startup:StartupSatComms:B](INFO): Timed out from 2024-08-19T20:11:45.6Z 2024-08-19T20:12:45.907Z,1724098365.907 [Startup:StartupSatComms:B] Stopped 2024-08-19T20:12:45.907Z,1724098365.907 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-08-19T20:12:45.907Z,1724098365.907 [Startup:StartupSatComms] Stopped 2024-08-19T20:12:45.907Z,1724098365.907 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-08-19T20:12:45.908Z,1724098365.908 [Startup](INFO): Completed Startup 2024-08-19T20:12:45.908Z,1724098365.908 [MissionManager](INFO): Startup is completed. 2024-08-19T20:12:45.908Z,1724098365.908 [MissionManager](INFO): Uninitializing Mission Startup 2024-08-19T20:12:45.908Z,1724098365.908 [Startup] Stopped 2024-08-19T20:12:45.908Z,1724098365.908 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-08-19T20:12:45.913Z,1724098365.913 [Startup:A.GoToSurface] Stopped 2024-08-19T20:12:45.913Z,1724098365.913 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-19T20:12:46.307Z,1724098366.307 [MissionManager](IMPORTANT): Started mission Default 2024-08-19T20:12:46.308Z,1724098366.308 [Default] Running Loop=1 2024-08-19T20:12:46.308Z,1724098366.308 [Default](DEBUG): Aggregate::initialize Default 2024-08-19T20:12:46.308Z,1724098366.308 [Default:B.GoToSurface] Running Loop=1 2024-08-19T20:12:46.308Z,1724098366.308 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-19T20:12:46.308Z,1724098366.308 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-08-19T20:12:46.313Z,1724098366.313 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-08-19T20:12:46.313Z,1724098366.313 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-08-19T20:12:46.313Z,1724098366.313 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-08-19T20:12:46.314Z,1724098366.314 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-19T20:12:46.314Z,1724098366.314 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-19T20:12:46.314Z,1724098366.314 [Default:A.Wait] Running Loop=1 2024-08-19T20:12:46.314Z,1724098366.314 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-08-19T20:12:49.674Z,1724098369.674 [DataOverHttps](INFO): Sending 412 bytes from file Logs/20240814T220810/Express0005.lzma 2024-08-19T20:12:50.675Z,1724098370.675 [DataOverHttps](INFO): Moved sent file to Logs/20240814T220810/Express0005.lzma.bak 2024-08-19T20:12:50.675Z,1724098370.675 [DataOverHttps](INFO): SBD MOMSN=23016833 2024-08-19T20:12:58.010Z,1724098378.010 [DVL_micro](FAULT): Failed to initialize within timeout. 2024-08-19T20:12:58.010Z,1724098378.010 [DVL_micro] Communications Fault, FailCount= 1 2024-08-19T20:12:58.010Z,1724098378.010 [DVL_micro](ERROR): Communications Fault 2024-08-19T20:12:58.051Z,1724098378.051 [CBIT](ERROR): Communications Fault in component: DVL_micro 2024-08-19T20:12:58.509Z,1724098378.509 [DVL_micro](INFO): Powering down 2024-08-19T20:12:59.274Z,1724098379.274 [CBIT](INFO): Clearing failed state for component DVL_micro 2024-08-19T20:12:59.274Z,1724098379.274 [DVL_micro] No Fault, FailCount= 1 2024-08-19T20:12:59.658Z,1724098379.658 [Default:A.Wait](INFO): Done Waiting. 2024-08-19T20:12:59.658Z,1724098379.658 [Default:A.Wait] Stopped 2024-08-19T20:12:59.658Z,1724098379.658 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-08-19T20:13:00.047Z,1724098380.047 [Default:CheckIn] Running Loop=1 2024-08-19T20:13:00.047Z,1724098380.047 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-19T20:13:00.048Z,1724098380.048 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-19T20:13:00.446Z,1724098380.446 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-08-19T20:13:04.466Z,1724098384.466 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-19T20:13:16.998Z,1724098396.998 [DVL_micro](FAULT): Failed to initialize within timeout. 2024-08-19T20:13:16.998Z,1724098396.998 [DVL_micro] Communications Fault, FailCount= 2 2024-08-19T20:13:16.998Z,1724098396.998 [DVL_micro](ERROR): Communications Fault 2024-08-19T20:13:17.018Z,1724098397.018 [CBIT](ERROR): Communications Fault in component: DVL_micro 2024-08-19T20:13:17.497Z,1724098397.497 [DVL_micro](INFO): Powering down 2024-08-19T20:13:18.230Z,1724098398.230 [CBIT](INFO): Clearing failed state for component DVL_micro 2024-08-19T20:13:18.230Z,1724098398.230 [DVL_micro] No Fault, FailCount= 2 2024-08-19T20:13:19.818Z,1724098399.818 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-19T20:13:34.766Z,1724098414.766 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-19T20:13:35.987Z,1724098415.987 [DVL_micro](FAULT): Failed to initialize within timeout. 2024-08-19T20:13:35.987Z,1724098415.987 [DVL_micro] Communications Fault, FailCount= 3 2024-08-19T20:13:35.987Z,1724098415.987 [DVL_micro](ERROR): Communications Fault 2024-08-19T20:13:36.030Z,1724098416.030 [CBIT](ERROR): Communications Fault in component: DVL_micro 2024-08-19T20:13:36.030Z,1724098416.030 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2024-08-19T20:13:36.481Z,1724098416.481 [DVL_micro](INFO): Powering down 2024-08-19T20:13:36.524Z,1724098416.524 [CBIT](INFO): Critical error at 20240819T201336 2024-08-19T20:13:49.997Z,1724098429.997 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-19T20:14:04.944Z,1724098444.944 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-19T20:14:11.032Z,1724098451.032 [CBIT](INFO): Clearing failed state for component MassServo 2024-08-19T20:14:11.032Z,1724098451.032 [MassServo] No Fault, FailCount= 5 2024-08-19T20:14:14.691Z,1724098454.691 [MassServo](FAULT): Overload Error 2024-08-19T20:14:14.692Z,1724098454.692 [MassServo] Hardware Fault, FailCount= 1 2024-08-19T20:14:14.692Z,1724098454.692 [MassServo](ERROR): Hardware Fault 2024-08-19T20:14:14.696Z,1724098454.696 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-08-19T20:14:15.074Z,1724098455.074 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-19T20:14:15.074Z,1724098455.074 [MassServo](INFO): Powering down 2024-08-19T20:14:15.877Z,1724098455.877 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:14:15.996Z,1724098455.996 [MassServo](DEBUG): Initializing MassServo. 2024-08-19T20:14:16.002Z,1724098456.002 [CBIT](INFO): Clearing failed state for component MassServo 2024-08-19T20:14:16.002Z,1724098456.002 [MassServo] No Fault, FailCount= 1 2024-08-19T20:14:19.893Z,1724098459.893 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-19T20:14:20.359Z,1724098460.359 [MassServo](FAULT): Overload Error 2024-08-19T20:14:20.359Z,1724098460.359 [MassServo] Hardware Fault, FailCount= 2 2024-08-19T20:14:20.359Z,1724098460.359 [MassServo](ERROR): Hardware Fault 2024-08-19T20:14:20.364Z,1724098460.364 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-08-19T20:14:20.725Z,1724098460.725 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-19T20:14:20.725Z,1724098460.725 [MassServo](INFO): Powering down 2024-08-19T20:14:20.868Z,1724098460.868 [CommandExec](IMPORTANT): got command quit 2024-08-19T20:14:21.533Z,1724098461.533 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-19T20:14:21.648Z,1724098461.648 [MassServo](DEBUG): Initializing MassServo. 2024-08-19T20:14:21.652Z,1724098461.652 [CBIT](INFO): Clearing failed state for component MassServo 2024-08-19T20:14:21.653Z,1724098461.653 [MassServo] No Fault, FailCount= 2 2024-08-19T20:14:21.871Z,1724098461.871 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:21.871Z,1724098461.871 [CommandExec](INFO): Uninitializing the command executive. 2024-08-19T20:14:21.871Z,1724098461.871 [CommandExec](INFO): Uninitializing the command scheduler. 2024-08-19T20:14:21.872Z,1724098461.872 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:22.027Z,1724098462.027 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-08-19T20:14:22.027Z,1724098462.027 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-08-19T20:14:22.027Z,1724098462.027 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:22.028Z,1724098462.028 [NavChartDb](INFO): Join timeout helper Thread ID is 3317 2024-08-19T20:14:22.119Z,1724098462.119 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:22.120Z,1724098462.120 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:22.127Z,1724098462.127 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-08-19T20:14:22.127Z,1724098462.127 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:22.128Z,1724098462.128 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3318 2024-08-19T20:14:22.427Z,1724098462.427 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:22.427Z,1724098462.427 [CTD_Seabird](INFO): Powering down 2024-08-19T20:14:22.439Z,1724098462.439 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:22.458Z,1724098462.458 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-08-19T20:14:22.458Z,1724098462.458 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:22.458Z,1724098462.458 [Radio_Surface](INFO): Join timeout helper Thread ID is 3319 2024-08-19T20:14:22.519Z,1724098462.519 [Radio_Surface](INFO): Powering down 2024-08-19T20:14:22.520Z,1724098462.520 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:22.520Z,1724098462.520 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:22.535Z,1724098462.535 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-08-19T20:14:22.535Z,1724098462.535 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:22.536Z,1724098462.536 [Onboard](INFO): Join timeout helper Thread ID is 3320 2024-08-19T20:14:23.279Z,1724098463.279 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:23.279Z,1724098463.279 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.295Z,1724098463.295 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-08-19T20:14:23.295Z,1724098463.295 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.296Z,1724098463.296 [DataOverHttps](INFO): Join timeout helper Thread ID is 3321 2024-08-19T20:14:23.400Z,1724098463.400 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:23.400Z,1724098463.400 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.416Z,1724098463.416 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2024-08-19T20:14:23.416Z,1724098463.416 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.417Z,1724098463.417 [DATMMP](INFO): Join timeout helper Thread ID is 3322 2024-08-19T20:14:23.652Z,1724098463.652 [DATMMP](INFO): Stop 2024-08-19T20:14:23.652Z,1724098463.652 [DATMMP](INFO): uninitialize 2024-08-19T20:14:23.652Z,1724098463.652 [DATMMP](INFO): Powering down 2024-08-19T20:14:23.724Z,1724098463.724 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:23.724Z,1724098463.724 [DATMMP](INFO): uninitialize 2024-08-19T20:14:23.724Z,1724098463.724 [DATMMP](INFO): Powering down 2024-08-19T20:14:23.725Z,1724098463.725 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.728Z,1724098463.728 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-08-19T20:14:23.728Z,1724098463.728 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.728Z,1724098463.728 [BackseatComponent](INFO): Join timeout helper Thread ID is 3323 2024-08-19T20:14:23.812Z,1724098463.812 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:23.812Z,1724098463.812 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.828Z,1724098463.828 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-08-19T20:14:23.828Z,1724098463.828 [logger ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.828Z,1724098463.828 [logger](INFO): Join timeout helper Thread ID is 3324 2024-08-19T20:14:23.859Z,1724098463.859 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:23.860Z,1724098463.860 [logger ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.868Z,1724098463.868 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-08-19T20:14:23.868Z,1724098463.868 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.868Z,1724098463.868 [CommandLine](INFO): Join timeout helper Thread ID is 3325 2024-08-19T20:14:23.895Z,1724098463.895 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:23.896Z,1724098463.896 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.908Z,1724098463.908 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-08-19T20:14:23.908Z,1724098463.908 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.908Z,1724098463.908 [CommandExec](INFO): Join timeout helper Thread ID is 3326 2024-08-19T20:14:23.910Z,1724098463.910 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-08-19T20:14:23.910Z,1724098463.910 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:23.910Z,1724098463.910 [controlThread](INFO): Join timeout helper Thread ID is 3327 2024-08-19T20:14:23.927Z,1724098463.927 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-19T20:14:23.928Z,1724098463.928 [controlThread](DEBUG): Uninitializing ControlThread 2024-08-19T20:14:23.928Z,1724098463.928 [AHRS_M2](INFO): Powering down 2024-08-19T20:14:23.930Z,1724098463.930 [DVL_micro](INFO): Powering down 2024-08-19T20:14:23.931Z,1724098463.931 [NAL9602](INFO): Powering down 2024-08-19T20:14:23.932Z,1724098463.932 [Sonardyne_Nano](INFO): Powering down 2024-08-19T20:14:24.052Z,1724098464.052 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-08-19T20:14:24.053Z,1724098464.053 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-08-19T20:14:24.053Z,1724098464.053 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-08-19T20:14:24.054Z,1724098464.054 [MissionManager](INFO): Uninitializing Mission Default 2024-08-19T20:14:24.054Z,1724098464.054 [Default] Stopped 2024-08-19T20:14:24.054Z,1724098464.054 [Default](DEBUG): Aggregate::uninitialize Default 2024-08-19T20:14:24.054Z,1724098464.054 [Default:B.GoToSurface] Stopped 2024-08-19T20:14:24.054Z,1724098464.054 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-19T20:14:24.054Z,1724098464.054 [Default:CheckIn] Stopped 2024-08-19T20:14:24.054Z,1724098464.054 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-19T20:14:24.054Z,1724098464.054 [Default:CheckIn:Read_GPS] Stopped 2024-08-19T20:14:24.058Z,1724098464.058 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-08-19T20:14:24.058Z,1724098464.058 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-08-19T20:14:24.058Z,1724098464.058 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-08-19T20:14:24.059Z,1724098464.059 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-08-19T20:14:24.059Z,1724098464.059 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-08-19T20:14:24.059Z,1724098464.059 [BuoyancyServo](INFO): Powering down 2024-08-19T20:14:24.071Z,1724098464.071 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-19T20:14:24.071Z,1724098464.071 [MassServo](INFO): Powering down 2024-08-19T20:14:24.072Z,1724098464.072 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-08-19T20:14:24.072Z,1724098464.072 [RudderServo](INFO): Powering down 2024-08-19T20:14:24.073Z,1724098464.073 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-08-19T20:14:24.073Z,1724098464.073 [ThrusterHE](INFO): Powering down 2024-08-19T20:14:24.074Z,1724098464.074 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-08-19T20:14:24.074Z,1724098464.074 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-08-19T20:14:24.074Z,1724098464.074 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-08-19T20:14:24.075Z,1724098464.075 [CBIT](DEBUG): Powering off loads. 2024-08-19T20:14:24.087Z,1724098464.087 [CBIT](DEBUG): Disabling WDT. 2024-08-19T20:14:24.099Z,1724098464.099 [CBIT](DEBUG): Opening all GF detection circuits. 2024-08-19T20:14:24.100Z,1724098464.100 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:24.146Z,1724098464.146 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:24.149Z,1724098464.149 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:24.157Z,1724098464.157 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:24.163Z,1724098464.163 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:24.205Z,1724098464.205 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:24.379Z,1724098464.379 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:24.401Z,1724098464.401 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-08-19T20:14:24.463Z,1724098464.463 [logger ThreadHandler](INFO): Thread cancelled.