2022-05-04T22:17:29.907Z,1651702649.907 [Supervisor](DEBUG): Initializing supervisor.
2022-05-04T22:17:29.912Z,1651702649.912 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-05-04T22:17:29.913Z,1651702649.913 [SyncHandler](INFO): Protected caller Thread ID is 1031
2022-05-04T22:17:29.913Z,1651702649.913 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-05-04T22:17:29.915Z,1651702649.915 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-05-04T22:17:29.915Z,1651702649.915 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1032
2022-05-04T22:17:29.919Z,1651702649.919 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-05-04T22:17:29.938Z,1651702649.938 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-05-04T22:17:29.939Z,1651702649.939 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-05-04T22:17:29.939Z,1651702649.939 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1033
2022-05-04T22:17:29.943Z,1651702649.943 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-05-04T22:17:29.944Z,1651702649.944 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-05-04T22:17:29.944Z,1651702649.944 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1034
2022-05-04T22:17:29.946Z,1651702649.946 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-05-04T22:17:29.947Z,1651702649.947 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-05-04T22:17:29.948Z,1651702649.948 [logger ThreadHandler](INFO): Protected caller Thread ID is 1035
2022-05-04T22:17:29.951Z,1651702649.951 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-05-04T22:17:29.952Z,1651702649.952 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-05-04T22:17:29.953Z,1651702649.953 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-05-04T22:17:30.048Z,1651702650.048 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-05-04T22:17:30.049Z,1651702650.049 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-05-04T22:17:30.263Z,1651702650.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-05-04T22:17:30.263Z,1651702650.263 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-05-04T22:17:30.527Z,1651702650.527 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-05-04T22:17:30.528Z,1651702650.528 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-05-04T22:17:30.634Z,1651702650.634 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-05-04T22:17:30.635Z,1651702650.635 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-05-04T22:17:31.279Z,1651702651.279 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-05-04T22:17:31.280Z,1651702651.280 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-05-04T22:17:31.724Z,1651702651.724 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-05-04T22:17:31.725Z,1651702651.725 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-05-04T22:17:32.289Z,1651702652.289 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-05-04T22:17:32.290Z,1651702652.290 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-05-04T22:17:32.747Z,1651702652.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-05-04T22:17:32.748Z,1651702652.748 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-05-04T22:17:33.343Z,1651702653.343 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-05-04T22:17:33.344Z,1651702653.344 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-05-04T22:17:33.713Z,1651702653.713 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-05-04T22:17:33.714Z,1651702653.714 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-05-04T22:17:33.932Z,1651702653.932 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-05-04T22:17:33.932Z,1651702653.932 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-05-04T22:17:34.062Z,1651702654.062 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-05-04T22:17:34.063Z,1651702654.063 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-05-04T22:17:34.143Z,1651702654.143 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-05-04T22:17:34.222Z,1651702654.222 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-05-04T22:17:34.408Z,1651702654.408 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-05-04T22:17:34.408Z,1651702654.408 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-05-04T22:17:34.625Z,1651702654.625 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-05-04T22:17:34.627Z,1651702654.627 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2022-05-04T22:17:34.628Z,1651702654.628 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2022-05-04T22:17:34.710Z,1651702654.710 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2022-05-04T22:17:34.970Z,1651702654.970 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-05-04T22:17:34.971Z,1651702654.971 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2022-05-04T22:17:35.067Z,1651702655.067 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2022-05-04T22:17:35.230Z,1651702655.230 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2022-05-04T22:17:35.411Z,1651702655.411 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2022-05-04T22:17:35.496Z,1651702655.496 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2022-05-04T22:17:35.601Z,1651702655.601 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2022-05-04T22:17:35.702Z,1651702655.702 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2022-05-04T22:17:35.862Z,1651702655.862 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2022-05-04T22:17:35.965Z,1651702655.965 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2022-05-04T22:17:36.065Z,1651702656.065 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2022-05-04T22:17:36.065Z,1651702656.065 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2022-05-04T22:17:36.080Z,1651702656.080 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-05-04T22:17:36.190Z,1651702656.190 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-05-04T22:17:36.191Z,1651702656.191 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-05-04T22:17:36.337Z,1651702656.337 [BuoyancyServo] Loaded
2022-05-04T22:17:36.338Z,1651702656.338 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-05-04T22:17:36.358Z,1651702656.358 [ElevatorServo] Loaded
2022-05-04T22:17:36.358Z,1651702656.358 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-05-04T22:17:36.374Z,1651702656.374 [ThrusterHE] Loaded
2022-05-04T22:17:36.374Z,1651702656.374 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-05-04T22:17:36.375Z,1651702656.375 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-05-04T22:17:36.375Z,1651702656.375 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-05-04T22:17:36.517Z,1651702656.517 [SBIT](DEBUG): Construct Startup Built In Test.
2022-05-04T22:17:36.533Z,1651702656.533 [SBIT] Loaded
2022-05-04T22:17:36.533Z,1651702656.533 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-05-04T22:17:36.536Z,1651702656.536 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-05-04T22:17:36.557Z,1651702656.557 [IBIT] Loaded
2022-05-04T22:17:36.557Z,1651702656.557 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-05-04T22:17:36.562Z,1651702656.562 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-05-04T22:17:36.775Z,1651702656.775 [CBIT] Loaded
2022-05-04T22:17:36.776Z,1651702656.776 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-05-04T22:17:36.776Z,1651702656.776 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-05-04T22:17:36.777Z,1651702656.777 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-05-04T22:17:36.915Z,1651702656.915 [ESPComponent] Loaded
2022-05-04T22:17:36.915Z,1651702656.915 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2022-05-04T22:17:36.934Z,1651702656.934 [PAR_Licor] Loaded
2022-05-04T22:17:36.934Z,1651702656.934 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-05-04T22:17:36.965Z,1651702656.965 [WetLabsBB2FL] Loaded
2022-05-04T22:17:36.966Z,1651702656.966 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2022-05-04T22:17:36.967Z,1651702656.967 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406614E0
2022-05-04T22:17:36.967Z,1651702656.967 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1117
2022-05-04T22:17:36.968Z,1651702656.968 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-05-04T22:17:36.969Z,1651702656.969 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-05-04T22:17:37.018Z,1651702657.018 [DepthRateCalculator] Loaded
2022-05-04T22:17:37.019Z,1651702657.019 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-05-04T22:17:37.024Z,1651702657.024 [PitchRateCalculator] Loaded
2022-05-04T22:17:37.024Z,1651702657.024 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-05-04T22:17:37.034Z,1651702657.034 [SpeedCalculator] Loaded
2022-05-04T22:17:37.035Z,1651702657.035 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-05-04T22:17:37.039Z,1651702657.039 [YawRateCalculator] Loaded
2022-05-04T22:17:37.040Z,1651702657.040 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-05-04T22:17:37.058Z,1651702657.058 [ElevatorOffsetCalculator] Loaded
2022-05-04T22:17:37.058Z,1651702657.058 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-05-04T22:17:37.075Z,1651702657.075 [ShortestDistanceToPolygonSidesCalculator] Loaded
2022-05-04T22:17:37.075Z,1651702657.075 [ComponentRegistry](DEBUG): SyncComponent "ShortestDistanceToPolygonSidesCalculator" handled in the control thread.
2022-05-04T22:17:37.075Z,1651702657.075 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-05-04T22:17:37.076Z,1651702657.076 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-05-04T22:17:37.171Z,1651702657.171 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-05-04T22:17:37.171Z,1651702657.171 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-05-04T22:17:37.197Z,1651702657.197 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-05-04T22:17:37.198Z,1651702657.198 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-05-04T22:17:37.319Z,1651702657.319 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-05-04T22:17:37.319Z,1651702657.319 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-05-04T22:17:37.333Z,1651702657.333 [NavChart] Loaded
2022-05-04T22:17:37.333Z,1651702657.333 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-05-04T22:17:37.339Z,1651702657.339 [UniversalFixResidualReporter] Loaded
2022-05-04T22:17:37.339Z,1651702657.339 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-05-04T22:17:37.339Z,1651702657.339 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-05-04T22:17:37.340Z,1651702657.340 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-05-04T22:17:37.853Z,1651702657.853 [AHRS_M2] Loaded
2022-05-04T22:17:37.853Z,1651702657.853 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-05-04T22:17:37.927Z,1651702657.927 [DataOverHttps] Loaded
2022-05-04T22:17:37.927Z,1651702657.927 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-05-04T22:17:37.928Z,1651702657.928 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409DD4E0
2022-05-04T22:17:37.929Z,1651702657.929 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1118
2022-05-04T22:17:37.948Z,1651702657.948 [Depth_Keller] Loaded
2022-05-04T22:17:37.949Z,1651702657.949 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-05-04T22:17:37.984Z,1651702657.984 [DVL_micro] Loaded
2022-05-04T22:17:37.985Z,1651702657.985 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2022-05-04T22:17:38.041Z,1651702658.041 [NAL9602] Loaded
2022-05-04T22:17:38.042Z,1651702658.042 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-05-04T22:17:38.067Z,1651702658.067 [Onboard] Loaded
2022-05-04T22:17:38.067Z,1651702658.067 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-05-04T22:17:38.068Z,1651702658.068 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A0D4E0
2022-05-04T22:17:38.068Z,1651702658.068 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1119
2022-05-04T22:17:38.080Z,1651702658.080 [Power24vConverter] Loaded
2022-05-04T22:17:38.080Z,1651702658.080 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-05-04T22:17:38.093Z,1651702658.093 [Radio_Surface] Loaded
2022-05-04T22:17:38.093Z,1651702658.093 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-05-04T22:17:38.094Z,1651702658.094 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A3D4E0
2022-05-04T22:17:38.094Z,1651702658.094 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1120
2022-05-04T22:17:38.095Z,1651702658.095 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-05-04T22:17:38.096Z,1651702658.096 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-05-04T22:17:38.182Z,1651702658.182 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-05-04T22:17:38.183Z,1651702658.183 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-05-04T22:17:38.268Z,1651702658.268 [VerticalControl](DEBUG): Construct VerticalControl.
2022-05-04T22:17:38.320Z,1651702658.320 [VerticalControl] Loaded
2022-05-04T22:17:38.321Z,1651702658.321 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-05-04T22:17:38.325Z,1651702658.325 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-05-04T22:17:38.508Z,1651702658.508 [HorizontalControl] Loaded
2022-05-04T22:17:38.508Z,1651702658.508 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-05-04T22:17:38.557Z,1651702658.557 [SpeedControl](DEBUG): Construct SpeedControl.
2022-05-04T22:17:38.559Z,1651702658.559 [SpeedControl] Loaded
2022-05-04T22:17:38.559Z,1651702658.559 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-05-04T22:17:38.562Z,1651702658.562 [LoopControl](DEBUG): Construct LoopControl.
2022-05-04T22:17:38.562Z,1651702658.562 [LoopControl] Loaded
2022-05-04T22:17:38.562Z,1651702658.562 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-05-04T22:17:38.563Z,1651702658.563 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-05-04T22:17:38.563Z,1651702658.563 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-05-04T22:17:38.601Z,1651702658.601 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-05-04T22:17:38.601Z,1651702658.601 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-05-04T22:17:39.230Z,1651702659.230 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-05-04T22:17:39.236Z,1651702659.236 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-05-04T22:17:39.239Z,1651702659.239 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-05-04T22:17:39.249Z,1651702659.249 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-05-04T22:17:39.250Z,1651702659.250 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B474E0
2022-05-04T22:17:39.251Z,1651702659.251 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1121
2022-05-04T22:17:39.255Z,1651702659.255 [Supervisor](INFO): Main Thread ID is 823
2022-05-04T22:17:39.255Z,1651702659.255 [Supervisor](DEBUG): Running supervisor.
2022-05-04T22:17:39.256Z,1651702659.256 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1122
2022-05-04T22:17:39.256Z,1651702659.256 [CommandExec](INFO): Initializing the command executive.
2022-05-04T22:17:39.258Z,1651702659.258 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1123
2022-05-04T22:17:39.260Z,1651702659.260 [controlThread ThreadHandler](INFO): Handler Thread ID is 1124
2022-05-04T22:17:39.260Z,1651702659.260 [controlThread](DEBUG): Initializing ControlThread
2022-05-04T22:17:39.262Z,1651702659.262 [SBIT](INFO): Initialize SBIT Component.
2022-05-04T22:17:39.262Z,1651702659.262 [SBIT](IMPORTANT): git: 2022-04-25-37-g2a944135f
2022-05-04T22:17:39.263Z,1651702659.263 [SBIT](INFO): git hash: 2a944135f4713de004d013a6b17eee164aec7a5a
2022-05-04T22:17:39.263Z,1651702659.263 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-05-04T22:17:39.264Z,1651702659.264 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2022-05-04T22:17:39.265Z,1651702659.265 [SBIT](INFO): Beginning SBIT in 59.000000 seconds.
2022-05-04T22:17:39.266Z,1651702659.266 [IBIT](INFO): Initialize IBIT Component.
2022-05-04T22:17:39.267Z,1651702659.267 [CBIT](DEBUG): Initialize CBIT Component.
2022-05-04T22:17:39.268Z,1651702659.268 [logger ThreadHandler](INFO): Handler Thread ID is 1125
2022-05-04T22:17:39.280Z,1651702659.280 [CBIT](DEBUG): Initialized mux pins.
2022-05-04T22:17:39.280Z,1651702659.280 [CBIT](DEBUG): Initializing the watchdog timer.
2022-05-04T22:17:39.288Z,1651702659.288 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1126
2022-05-04T22:17:39.293Z,1651702659.293 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:17:39.294Z,1651702659.294 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1128
2022-05-04T22:17:39.295Z,1651702659.295 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2022-05-04T22:17:39.304Z,1651702659.304 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2022-05-04T22:17:39.304Z,1651702659.304 [CBIT](DEBUG): Initializing heartbeat.
2022-05-04T22:17:39.305Z,1651702659.305 [Onboard ThreadHandler](INFO): Handler Thread ID is 1129
2022-05-04T22:17:39.334Z,1651702659.334 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1130
2022-05-04T22:17:39.340Z,1651702659.340 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1131
2022-05-04T22:17:39.343Z,1651702659.343 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI01M.000
2022-05-04T22:17:39.343Z,1651702659.343 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2022-05-04T22:17:39.343Z,1651702659.343 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI89M.000
2022-05-04T22:17:39.343Z,1651702659.343 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2022-05-04T22:17:39.344Z,1651702659.344 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI11M.000
2022-05-04T22:17:39.344Z,1651702659.344 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI11M.000
2022-05-04T22:17:39.344Z,1651702659.344 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI07M.000
2022-05-04T22:17:39.344Z,1651702659.344 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI07M.000
2022-05-04T22:17:39.344Z,1651702659.344 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5OH07M.000
2022-05-04T22:17:39.344Z,1651702659.344 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5OH07M.000
2022-05-04T22:17:39.345Z,1651702659.345 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5OH31M.000
2022-05-04T22:17:39.345Z,1651702659.345 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5OH31M.000
2022-05-04T22:17:39.376Z,1651702659.376 [CBIT](DEBUG): Deactivating GF circuits.
2022-05-04T22:17:39.376Z,1651702659.376 [CBIT](DEBUG): Deactivating emergency mode.
2022-05-04T22:17:39.412Z,1651702659.412 [CBIT](DEBUG): Backplane powered.
2022-05-04T22:17:39.416Z,1651702659.416 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-05-04T22:17:39.417Z,1651702659.417 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-05-04T22:17:39.417Z,1651702659.417 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-05-04T22:17:39.417Z,1651702659.417 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-05-04T22:17:39.418Z,1651702659.418 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-05-04T22:17:39.418Z,1651702659.418 [ShortestDistanceToPolygonSidesCalculator](DEBUG): Initializing.
2022-05-04T22:17:39.420Z,1651702659.420 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-05-04T22:17:39.420Z,1651702659.420 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-05-04T22:17:39.429Z,1651702659.429 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-05-04T22:17:39.430Z,1651702659.430 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-05-04T22:17:39.431Z,1651702659.431 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-05-04T22:17:39.436Z,1651702659.436 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-05-04T22:17:39.437Z,1651702659.437 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-05-04T22:17:39.473Z,1651702659.473 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-05-04T22:17:39.509Z,1651702659.509 [MissionManager](DEBUG):
2022-05-04T22:17:39.509Z,1651702659.509 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-05-04T22:17:39.605Z,1651702659.605 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-05-04T22:17:39.606Z,1651702659.606 [Default:A.Wait](DEBUG): Construct Wait.
2022-05-04T22:17:39.609Z,1651702659.609 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-05-04T22:17:39.672Z,1651702659.672 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-05-04T22:17:39.675Z,1651702659.675 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-05-04T22:17:39.698Z,1651702659.698 [Default:E.Execute](DEBUG): Construct Execute.
2022-05-04T22:17:39.701Z,1651702659.701 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2022-05-04T22:17:39.711Z,1651702659.711 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2022-05-04T22:17:39.736Z,1651702659.736 [Radio_Surface](INFO): Powering up
2022-05-04T22:17:39.745Z,1651702659.745 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:17:39.785Z,1651702659.785 [Depth_Keller](ERROR): Pressure reading out of range: 1896.040405 decibar
2022-05-04T22:17:39.793Z,1651702659.793 [Power24vConverter](INFO): Powering up.
2022-05-04T22:17:39.813Z,1651702659.813 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-05-04T22:17:39.842Z,1651702659.842 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-05-04T22:17:39.848Z,1651702659.848 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-05-04T22:17:39.849Z,1651702659.849 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-05-04T22:17:39.856Z,1651702659.856 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-05-04T22:17:39.857Z,1651702659.857 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-05-04T22:17:39.864Z,1651702659.864 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-05-04T22:17:39.867Z,1651702659.867 [CBIT](FAULT): Main Battery Failure. Count: 1
2022-05-04T22:17:43.826Z,1651702663.826 [CBIT](FAULT): Main Battery Failure. Count: 11
2022-05-04T22:17:44.580Z,1651702664.580 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-05-04T22:17:44.580Z,1651702664.580 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:17:44.649Z,1651702664.649 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:17:45.080Z,1651702665.080 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:17:45.452Z,1651702665.452 [ThrusterHE](ERROR): Zero Speed Commanded.
2022-05-04T22:17:45.995Z,1651702665.995 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:17:45.995Z,1651702665.995 [WetLabsBB2FL] No Fault, FailCount= 1
2022-05-04T22:17:46.293Z,1651702666.293 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:17:47.927Z,1651702667.927 [CBIT](FAULT): Main Battery Failure. Count: 21
2022-05-04T22:17:51.584Z,1651702671.584 [WetLabsBB2FL] Communications Fault, FailCount= 2
2022-05-04T22:17:51.584Z,1651702671.584 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:17:51.877Z,1651702671.877 [CBIT](FAULT): Main Battery Failure. Count: 31
2022-05-04T22:17:51.879Z,1651702671.879 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:17:52.084Z,1651702672.084 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:17:53.109Z,1651702673.109 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:17:53.109Z,1651702673.109 [WetLabsBB2FL] No Fault, FailCount= 2
2022-05-04T22:17:53.297Z,1651702673.297 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:17:55.916Z,1651702675.916 [CBIT](FAULT): Main Battery Failure. Count: 41
2022-05-04T22:17:57.109Z,1651702677.109 [DVL_micro](FAULT): Failed to initialize within timeout.
2022-05-04T22:17:57.109Z,1651702677.109 [DVL_micro] Communications Fault, FailCount= 1
2022-05-04T22:17:57.109Z,1651702677.109 [DVL_micro](ERROR): Communications Fault
2022-05-04T22:17:57.164Z,1651702677.164 [CBIT](ERROR): Communications Fault in component: DVL_micro
2022-05-04T22:17:57.580Z,1651702677.580 [DVL_micro](INFO): Powering down
2022-05-04T22:17:58.348Z,1651702678.348 [CBIT](INFO): Clearing failed state for component DVL_micro
2022-05-04T22:17:58.348Z,1651702678.348 [DVL_micro] No Fault, FailCount= 1
2022-05-04T22:17:58.588Z,1651702678.588 [WetLabsBB2FL] Communications Fault, FailCount= 3
2022-05-04T22:17:58.588Z,1651702678.588 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:17:58.773Z,1651702678.773 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:17:59.088Z,1651702679.088 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:17:59.965Z,1651702679.965 [CBIT](FAULT): Main Battery Failure. Count: 51
2022-05-04T22:17:59.967Z,1651702679.967 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:17:59.967Z,1651702679.967 [WetLabsBB2FL] No Fault, FailCount= 3
2022-05-04T22:18:00.309Z,1651702680.309 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:18:03.982Z,1651702683.982 [CBIT](FAULT): Main Battery Failure. Count: 61
2022-05-04T22:18:05.592Z,1651702685.592 [WetLabsBB2FL] Communications Fault, FailCount= 4
2022-05-04T22:18:05.592Z,1651702685.592 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:18:05.600Z,1651702685.600 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:18:06.092Z,1651702686.092 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:18:07.215Z,1651702687.215 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:18:07.215Z,1651702687.215 [WetLabsBB2FL] No Fault, FailCount= 4
2022-05-04T22:18:07.306Z,1651702687.306 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:18:08.026Z,1651702688.026 [CBIT](FAULT): Main Battery Failure. Count: 71
2022-05-04T22:18:08.415Z,1651702688.415 [NAL9602](INFO): Powering up NAL9602
2022-05-04T22:18:12.061Z,1651702692.061 [CBIT](FAULT): Main Battery Failure. Count: 81
2022-05-04T22:18:12.604Z,1651702692.604 [WetLabsBB2FL] Communications Fault, FailCount= 5
2022-05-04T22:18:12.604Z,1651702692.604 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:18:12.896Z,1651702692.896 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:18:12.897Z,1651702692.897 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:18:13.104Z,1651702693.104 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:18:16.089Z,1651702696.089 [DVL_micro](FAULT): Failed to initialize within timeout.
2022-05-04T22:18:16.089Z,1651702696.089 [DVL_micro] Communications Fault, FailCount= 2
2022-05-04T22:18:16.089Z,1651702696.089 [DVL_micro](ERROR): Communications Fault
2022-05-04T22:18:16.102Z,1651702696.102 [CBIT](FAULT): Main Battery Failure. Count: 91
2022-05-04T22:18:16.136Z,1651702696.136 [CBIT](ERROR): Communications Fault in component: DVL_micro
2022-05-04T22:18:16.564Z,1651702696.564 [DVL_micro](INFO): Powering down
2022-05-04T22:18:17.325Z,1651702697.325 [CBIT](INFO): Clearing failed state for component DVL_micro
2022-05-04T22:18:17.325Z,1651702697.325 [DVL_micro] No Fault, FailCount= 2
2022-05-04T22:18:19.322Z,1651702699.322 [NAL9602](INFO): NAL9602 initialized
2022-05-04T22:18:20.160Z,1651702700.160 [CBIT](FAULT): Main Battery Failure. Count: 101
2022-05-04T22:18:24.206Z,1651702704.206 [CBIT](FAULT): Main Battery Failure. Count: 111
2022-05-04T22:18:24.552Z,1651702704.552 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 10 degree
2022-05-04T22:18:24.555Z,1651702704.555 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread.
2022-05-04T22:18:24.595Z,1651702704.595 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2022-05-04T22:18:28.257Z,1651702708.257 [CBIT](FAULT): Main Battery Failure. Count: 121
2022-05-04T22:18:32.275Z,1651702712.275 [CBIT](FAULT): Main Battery Failure. Count: 131
2022-05-04T22:18:35.079Z,1651702715.079 [DVL_micro](FAULT): Failed to initialize within timeout.
2022-05-04T22:18:35.079Z,1651702715.079 [DVL_micro] Communications Fault, FailCount= 3
2022-05-04T22:18:35.079Z,1651702715.079 [DVL_micro](ERROR): Communications Fault
2022-05-04T22:18:35.095Z,1651702715.095 [CBIT](ERROR): Communications Fault in component: DVL_micro
2022-05-04T22:18:35.095Z,1651702715.095 [CBIT](CRITICAL): Communications Fault in component: DVL_micro
2022-05-04T22:18:35.565Z,1651702715.565 [DVL_micro](INFO): Powering down
2022-05-04T22:18:35.587Z,1651702715.587 [CommandExec](FAULT): Scheduling is paused
2022-05-04T22:18:35.588Z,1651702715.588 [CBIT](INFO): Critical error at 20220504T221835
2022-05-04T22:18:35.588Z,1651702715.588 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-05-04T22:18:36.302Z,1651702716.302 [CBIT](FAULT): Main Battery Failure. Count: 141
2022-05-04T22:18:38.739Z,1651702718.739 [SBIT](IMPORTANT): Beginning Startup BIT
2022-05-04T22:18:38.744Z,1651702718.744 [CBIT](IMPORTANT): Beginning ground fault scan
2022-05-04T22:18:39.350Z,1651702719.350 [CommandExec](IMPORTANT): got command maintain clear
2022-05-04T22:18:39.573Z,1651702719.573 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2022-05-04T22:18:40.353Z,1651702720.353 [CBIT](FAULT): Main Battery Failure. Count: 151
2022-05-04T22:18:44.415Z,1651702724.415 [CBIT](FAULT): Main Battery Failure. Count: 161
2022-05-04T22:18:48.426Z,1651702728.426 [CBIT](FAULT): Main Battery Failure. Count: 171
2022-05-04T22:18:49.670Z,1651702729.670 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.074451
CHAN A1 (24V): -0.163497
CHAN A2 (12V): -0.086861
CHAN A3 (5V): -0.002492
CHAN B0 (3.3V): -0.001417
CHAN B1 (3.15aV): -0.001167
CHAN B2 (3.15bV): -0.001194
CHAN B3 (GND): 0.000152
OPEN: 0.004094
Full Scale: +/- 1 mA
2022-05-04T22:18:52.062Z,1651702732.062 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-05-04T22:18:52.062Z,1651702732.062 [SBIT](ERROR): Could not read massPosReader_.
2022-05-04T22:18:52.473Z,1651702732.473 [CBIT](FAULT): Main Battery Failure. Count: 181
2022-05-04T22:18:56.534Z,1651702736.534 [CBIT](FAULT): Main Battery Failure. Count: 191
2022-05-04T22:18:56.833Z,1651702736.833 [CommandExec](IMPORTANT): got command failComponent
2022-05-04T22:18:56.833Z,1651702736.833 [CommandExec](IMPORTANT): Failed components:
2022-05-04T22:18:56.833Z,1651702736.833 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault
2022-05-04T22:18:56.833Z,1651702736.833 [CommandExec](IMPORTANT): DVL_micro: Communications Fault
2022-05-04T22:19:00.564Z,1651702740.564 [CBIT](FAULT): Main Battery Failure. Count: 201
2022-05-04T22:19:04.612Z,1651702744.612 [CBIT](FAULT): Main Battery Failure. Count: 211
2022-05-04T22:19:08.627Z,1651702748.627 [CBIT](FAULT): Main Battery Failure. Count: 221
2022-05-04T22:19:12.666Z,1651702752.666 [CBIT](FAULT): Main Battery Failure. Count: 231
2022-05-04T22:19:16.715Z,1651702756.715 [CBIT](FAULT): Main Battery Failure. Count: 241
2022-05-04T22:19:18.718Z,1651702758.718 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-05-04T22:19:18.718Z,1651702758.718 [SBIT](ERROR): Could not read massPosReader_.
2022-05-04T22:19:18.718Z,1651702758.718 [SBIT](FAULT): Control surface position failure.
2022-05-04T22:19:20.802Z,1651702760.802 [CBIT](FAULT): Main Battery Failure. Count: 251
2022-05-04T22:19:24.593Z,1651702764.593 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 10 degree
2022-05-04T22:19:24.594Z,1651702764.594 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread.
2022-05-04T22:19:24.788Z,1651702764.788 [CBIT](FAULT): Main Battery Failure. Count: 261
2022-05-04T22:19:24.795Z,1651702764.795 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2022-05-04T22:19:28.942Z,1651702768.942 [CBIT](FAULT): Main Battery Failure. Count: 271
2022-05-04T22:19:32.458Z,1651702772.458 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-05-04T22:19:32.459Z,1651702772.459 [SBIT](ERROR): Could not read massPosReader_.
2022-05-04T22:19:32.459Z,1651702772.459 [SBIT](FAULT): Control surface position failure.
2022-05-04T22:19:32.874Z,1651702772.874 [SBIT](CRITICAL): SBIT FAILED
2022-05-04T22:19:32.875Z,1651702772.875 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2022-05-04T22:19:32.875Z,1651702772.875 [SBIT](IMPORTANT): BPC1.loadAtStartup=0 bool;
2022-05-04T22:19:32.876Z,1651702772.876 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool;
2022-05-04T22:19:32.876Z,1651702772.876 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;
2022-05-04T22:19:32.876Z,1651702772.876 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2022-05-04T22:19:32.876Z,1651702772.876 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;
2022-05-04T22:19:32.876Z,1651702772.876 [SBIT](IMPORTANT): Express linearApproximation CBIT.ampHoursUsed 1.000000 ampere_hour;
2022-05-04T22:19:32.876Z,1651702772.876 [SBIT](IMPORTANT): MassServo.loadAtStartup=0 bool;
2022-05-04T22:19:32.877Z,1651702772.877 [SBIT](IMPORTANT): RudderServo.loadAtStartup=0 bool;
2022-05-04T22:19:32.877Z,1651702772.877 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex1=34.4368 degree;
2022-05-04T22:19:32.877Z,1651702772.877 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex2=34.267 degree;
2022-05-04T22:19:32.877Z,1651702772.877 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex3=34.107 degree;
2022-05-04T22:19:32.877Z,1651702772.877 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex4=34.37 degree;
2022-05-04T22:19:32.877Z,1651702772.877 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.loadAtStartup=1 bool;
2022-05-04T22:19:32.877Z,1651702772.877 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex1=-120.476 degree;
2022-05-04T22:19:32.877Z,1651702772.877 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex2=-119.333 degree;
2022-05-04T22:19:32.878Z,1651702772.878 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex3=-119.33 degree;
2022-05-04T22:19:32.878Z,1651702772.878 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex4=-120.5 degree;
2022-05-04T22:19:32.879Z,1651702772.879 [CBIT](INFO): Critical error at 20220504T221932
2022-05-04T22:19:32.880Z,1651702772.880 [CBIT](FAULT): Main Battery Failure. Count: 281
2022-05-04T22:19:33.272Z,1651702773.272 [MissionManager](IMPORTANT): Started mission Startup
2022-05-04T22:19:33.273Z,1651702773.273 [Startup] Running Loop=1
2022-05-04T22:19:33.273Z,1651702773.273 [Startup](DEBUG): Aggregate::initialize Startup
2022-05-04T22:19:33.273Z,1651702773.273 [Startup:A.GoToSurface] Running Loop=1
2022-05-04T22:19:33.273Z,1651702773.273 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-05-04T22:19:33.274Z,1651702773.274 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-05-04T22:19:33.274Z,1651702773.274 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-05-04T22:19:33.274Z,1651702773.274 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-05-04T22:19:33.275Z,1651702773.275 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-05-04T22:19:33.275Z,1651702773.275 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-05-04T22:19:33.276Z,1651702773.276 [Startup:StartupSatComms] Running Loop=1
2022-05-04T22:19:33.276Z,1651702773.276 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2022-05-04T22:19:33.277Z,1651702773.277 [Startup:StartupSatComms:A] Running Loop=1
2022-05-04T22:19:33.671Z,1651702773.671 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2022-05-04T22:19:36.917Z,1651702776.917 [CBIT](FAULT): Main Battery Failure. Count: 291
2022-05-04T22:19:38.060Z,1651702778.060 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -10 degree
2022-05-04T22:19:40.978Z,1651702780.978 [CBIT](FAULT): Main Battery Failure. Count: 301
2022-05-04T22:19:44.992Z,1651702784.992 [CBIT](FAULT): Main Battery Failure. Count: 311
2022-05-04T22:19:46.556Z,1651702786.556 [CommandExec](IMPORTANT): got command get platform_elevator_angle degree
2022-05-04T22:19:46.556Z,1651702786.556 [CommandExec](IMPORTANT): platform_elevator_angle -10.011745 arcdeg
2022-05-04T22:19:49.023Z,1651702789.023 [CBIT](FAULT): Main Battery Failure. Count: 321
2022-05-04T22:19:53.085Z,1651702793.085 [CBIT](FAULT): Main Battery Failure. Count: 331
2022-05-04T22:19:57.118Z,1651702797.118 [CBIT](FAULT): Main Battery Failure. Count: 341
2022-05-04T22:20:01.125Z,1651702801.125 [AHRS_M2](FAULT): LCB fault: Current Limiter Activated.
2022-05-04T22:20:01.126Z,1651702801.126 [AHRS_M2] Hardware Fault, FailCount= 1
2022-05-04T22:20:01.126Z,1651702801.126 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:20:01.141Z,1651702801.141 [CBIT](FAULT): Main Battery Failure. Count: 351
2022-05-04T22:20:01.143Z,1651702801.143 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:20:01.526Z,1651702801.526 [AHRS_M2](INFO): Powering down
2022-05-04T22:20:01.933Z,1651702801.933 [AHRS_M2](FAULT): LCB fault: Current Limiter Activated.
2022-05-04T22:20:02.373Z,1651702802.373 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-05-04T22:20:02.373Z,1651702802.373 [AHRS_M2] No Fault, FailCount= 1
2022-05-04T22:20:02.740Z,1651702802.740 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:20:05.181Z,1651702805.181 [CBIT](FAULT): Main Battery Failure. Count: 361
2022-05-04T22:20:07.185Z,1651702807.185 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:07.185Z,1651702807.185 [AHRS_M2] Hardware Fault, FailCount= 2
2022-05-04T22:20:07.185Z,1651702807.185 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:20:07.228Z,1651702807.228 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:20:07.588Z,1651702807.588 [AHRS_M2](INFO): Powering down
2022-05-04T22:20:07.989Z,1651702807.989 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:08.426Z,1651702808.426 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-05-04T22:20:08.426Z,1651702808.426 [AHRS_M2] No Fault, FailCount= 2
2022-05-04T22:20:08.796Z,1651702808.796 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:20:09.218Z,1651702809.218 [CBIT](FAULT): Main Battery Failure. Count: 371
2022-05-04T22:20:13.246Z,1651702813.246 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:13.246Z,1651702813.246 [AHRS_M2] Hardware Fault, FailCount= 3
2022-05-04T22:20:13.246Z,1651702813.246 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:20:13.272Z,1651702813.272 [CBIT](FAULT): Main Battery Failure. Count: 381
2022-05-04T22:20:13.274Z,1651702813.274 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:20:13.644Z,1651702813.644 [AHRS_M2](INFO): Powering down
2022-05-04T22:20:14.053Z,1651702814.053 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:14.480Z,1651702814.480 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-05-04T22:20:14.480Z,1651702814.480 [AHRS_M2] No Fault, FailCount= 3
2022-05-04T22:20:14.857Z,1651702814.857 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:20:17.300Z,1651702817.300 [CBIT](FAULT): Main Battery Failure. Count: 391
2022-05-04T22:20:18.511Z,1651702818.511 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 10 degree
2022-05-04T22:20:19.306Z,1651702819.306 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:19.306Z,1651702819.306 [AHRS_M2] Hardware Fault, FailCount= 4
2022-05-04T22:20:19.306Z,1651702819.306 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:20:19.324Z,1651702819.324 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:20:19.708Z,1651702819.708 [AHRS_M2](INFO): Powering down
2022-05-04T22:20:20.113Z,1651702820.113 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:20.569Z,1651702820.569 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-05-04T22:20:20.569Z,1651702820.569 [AHRS_M2] No Fault, FailCount= 4
2022-05-04T22:20:20.922Z,1651702820.922 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:20:21.374Z,1651702821.374 [CBIT](FAULT): Main Battery Failure. Count: 401
2022-05-04T22:20:25.365Z,1651702825.365 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:25.365Z,1651702825.365 [AHRS_M2] Hardware Fault, FailCount= 5
2022-05-04T22:20:25.365Z,1651702825.365 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:20:25.380Z,1651702825.380 [CBIT](FAULT): Main Battery Failure. Count: 411
2022-05-04T22:20:25.383Z,1651702825.383 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:20:25.383Z,1651702825.383 [CBIT](CRITICAL): Hardware Fault in component: AHRS_M2
2022-05-04T22:20:25.766Z,1651702825.766 [AHRS_M2](INFO): Powering down
2022-05-04T22:20:25.858Z,1651702825.858 [CBIT](INFO): Critical error at 20220504T222025
2022-05-04T22:20:26.173Z,1651702826.173 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:29.432Z,1651702829.432 [CBIT](FAULT): Main Battery Failure. Count: 421
2022-05-04T22:20:33.477Z,1651702833.477 [Startup:StartupSatComms:A](INFO): Timed out from 2022-05-04T22:19:33.3Z
2022-05-04T22:20:33.478Z,1651702833.478 [Startup:StartupSatComms:A] Stopped
2022-05-04T22:20:33.478Z,1651702833.478 [Startup:StartupSatComms:B] Running Loop=1
2022-05-04T22:20:33.485Z,1651702833.485 [CBIT](FAULT): Main Battery Failure. Count: 431
2022-05-04T22:20:33.870Z,1651702833.870 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-05-04T22:20:37.498Z,1651702837.498 [CBIT](FAULT): Main Battery Failure. Count: 441
2022-05-04T22:20:38.916Z,1651702838.916 [CommandExec](IMPORTANT): got command failComponent
2022-05-04T22:20:38.917Z,1651702838.917 [CommandExec](IMPORTANT): Failed components:
2022-05-04T22:20:38.917Z,1651702838.917 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault
2022-05-04T22:20:38.917Z,1651702838.917 [CommandExec](IMPORTANT): AHRS_M2: Hardware Fault
2022-05-04T22:20:38.917Z,1651702838.917 [CommandExec](IMPORTANT): DVL_micro: Communications Fault
2022-05-04T22:20:39.524Z,1651702839.524 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2022-05-04T22:20:39.524Z,1651702839.524 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:20:39.534Z,1651702839.534 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:20:39.941Z,1651702839.941 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:20:39.941Z,1651702839.941 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2022-05-04T22:20:41.553Z,1651702841.553 [CBIT](FAULT): Main Battery Failure. Count: 451
2022-05-04T22:20:42.045Z,1651702842.045 [CommandExec](IMPORTANT): got command failComponent none AHRS_M2
2022-05-04T22:20:42.045Z,1651702842.045 [AHRS_M2] No Fault, FailCount= 5
2022-05-04T22:20:42.045Z,1651702842.045 [CommandExec](IMPORTANT): AHRS_M2 failureMode is No Fault
2022-05-04T22:20:42.328Z,1651702842.328 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:20:42.754Z,1651702842.754 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:20:42.755Z,1651702842.755 [WetLabsBB2FL] No Fault, FailCount= 5
2022-05-04T22:20:42.989Z,1651702842.989 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:20:45.613Z,1651702845.613 [CBIT](FAULT): Main Battery Failure. Count: 461
2022-05-04T22:20:46.770Z,1651702846.770 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:46.771Z,1651702846.771 [AHRS_M2] Hardware Fault, FailCount= 6
2022-05-04T22:20:46.771Z,1651702846.771 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:20:46.788Z,1651702846.788 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:20:46.788Z,1651702846.788 [CBIT](CRITICAL): Hardware Fault in component: AHRS_M2
2022-05-04T22:20:47.181Z,1651702847.181 [AHRS_M2](INFO): Powering down
2022-05-04T22:20:47.280Z,1651702847.280 [CBIT](INFO): Critical error at 20220504T222046
2022-05-04T22:20:47.586Z,1651702847.586 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:20:48.280Z,1651702848.280 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-05-04T22:20:48.280Z,1651702848.280 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:20:48.407Z,1651702848.407 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:20:48.780Z,1651702848.780 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:20:49.632Z,1651702849.632 [CBIT](FAULT): Main Battery Failure. Count: 471
2022-05-04T22:20:49.634Z,1651702849.634 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:20:49.634Z,1651702849.634 [WetLabsBB2FL] No Fault, FailCount= 1
2022-05-04T22:20:49.993Z,1651702849.993 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:20:53.659Z,1651702853.659 [CBIT](FAULT): Main Battery Failure. Count: 481
2022-05-04T22:20:55.288Z,1651702855.288 [WetLabsBB2FL] Communications Fault, FailCount= 2
2022-05-04T22:20:55.288Z,1651702855.288 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:20:55.302Z,1651702855.302 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:20:55.788Z,1651702855.788 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:20:56.892Z,1651702856.892 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:20:56.892Z,1651702856.892 [WetLabsBB2FL] No Fault, FailCount= 2
2022-05-04T22:20:57.002Z,1651702857.002 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:20:57.699Z,1651702857.699 [CBIT](FAULT): Main Battery Failure. Count: 491
2022-05-04T22:21:01.749Z,1651702861.749 [CBIT](FAULT): Main Battery Failure. Count: 501
2022-05-04T22:21:02.296Z,1651702862.296 [WetLabsBB2FL] Communications Fault, FailCount= 3
2022-05-04T22:21:02.296Z,1651702862.296 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:21:02.542Z,1651702862.542 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:21:02.796Z,1651702862.796 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:21:03.754Z,1651702863.754 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:21:03.754Z,1651702863.754 [WetLabsBB2FL] No Fault, FailCount= 3
2022-05-04T22:21:04.009Z,1651702864.009 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:21:05.788Z,1651702865.788 [CBIT](FAULT): Main Battery Failure. Count: 511
2022-05-04T22:21:06.284Z,1651702866.284 [CommandExec](IMPORTANT): got command failComponent none AHRS_M2
2022-05-04T22:21:06.285Z,1651702866.285 [AHRS_M2] No Fault, FailCount= 6
2022-05-04T22:21:06.285Z,1651702866.285 [CommandExec](IMPORTANT): AHRS_M2 failureMode is No Fault
2022-05-04T22:21:06.568Z,1651702866.568 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:21:09.300Z,1651702869.300 [WetLabsBB2FL] Communications Fault, FailCount= 4
2022-05-04T22:21:09.300Z,1651702869.300 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:21:09.419Z,1651702869.419 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:21:09.800Z,1651702869.800 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:21:09.844Z,1651702869.844 [CBIT](FAULT): Main Battery Failure. Count: 521
2022-05-04T22:21:10.651Z,1651702870.651 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:21:10.651Z,1651702870.651 [WetLabsBB2FL] No Fault, FailCount= 4
2022-05-04T22:21:11.010Z,1651702871.010 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:21:11.010Z,1651702871.010 [AHRS_M2] Hardware Fault, FailCount= 7
2022-05-04T22:21:11.010Z,1651702871.010 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:21:11.013Z,1651702871.013 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:21:11.062Z,1651702871.062 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:21:11.062Z,1651702871.062 [CBIT](CRITICAL): Hardware Fault in component: AHRS_M2
2022-05-04T22:21:11.416Z,1651702871.416 [AHRS_M2](INFO): Powering down
2022-05-04T22:21:11.525Z,1651702871.525 [CBIT](INFO): Critical error at 20220504T222111
2022-05-04T22:21:11.825Z,1651702871.825 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:21:13.858Z,1651702873.858 [CBIT](FAULT): Main Battery Failure. Count: 531
2022-05-04T22:21:16.304Z,1651702876.304 [WetLabsBB2FL] Communications Fault, FailCount= 5
2022-05-04T22:21:16.304Z,1651702876.304 [WetLabsBB2FL](ERROR): Communications Fault
2022-05-04T22:21:16.703Z,1651702876.703 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:21:16.703Z,1651702876.703 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2022-05-04T22:21:16.800Z,1651702876.800 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:21:17.900Z,1651702877.900 [CBIT](FAULT): Main Battery Failure. Count: 541
2022-05-04T22:21:21.955Z,1651702881.955 [CBIT](FAULT): Main Battery Failure. Count: 551
2022-05-04T22:21:26.011Z,1651702886.011 [CBIT](FAULT): Main Battery Failure. Count: 561
2022-05-04T22:21:29.088Z,1651702889.088 [CommandExec](IMPORTANT): got command failComponent none AHRS_M2
2022-05-04T22:21:29.088Z,1651702889.088 [AHRS_M2] No Fault, FailCount= 7
2022-05-04T22:21:29.089Z,1651702889.089 [CommandExec](IMPORTANT): AHRS_M2 failureMode is No Fault
2022-05-04T22:21:29.192Z,1651702889.192 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:21:30.023Z,1651702890.023 [CBIT](FAULT): Main Battery Failure. Count: 571
2022-05-04T22:21:33.634Z,1651702893.634 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:21:33.634Z,1651702893.634 [AHRS_M2] Hardware Fault, FailCount= 8
2022-05-04T22:21:33.635Z,1651702893.635 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:21:33.643Z,1651702893.643 [Startup:StartupSatComms:B](INFO): Timed out from 2022-05-04T22:20:33.5Z
2022-05-04T22:21:33.644Z,1651702893.644 [Startup:StartupSatComms:B] Stopped
2022-05-04T22:21:33.644Z,1651702893.644 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2022-05-04T22:21:33.644Z,1651702893.644 [Startup:StartupSatComms] Stopped
2022-05-04T22:21:33.644Z,1651702893.644 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2022-05-04T22:21:33.645Z,1651702893.645 [Startup](INFO): Completed Startup
2022-05-04T22:21:33.645Z,1651702893.645 [MissionManager](INFO): Startup is completed.
2022-05-04T22:21:33.645Z,1651702893.645 [MissionManager](INFO): Uninitializing Mission Startup
2022-05-04T22:21:33.645Z,1651702893.645 [Startup] Stopped
2022-05-04T22:21:33.645Z,1651702893.645 [Startup](DEBUG): Aggregate::uninitialize Startup
2022-05-04T22:21:33.645Z,1651702893.645 [Startup:A.GoToSurface] Stopped
2022-05-04T22:21:33.645Z,1651702893.645 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-05-04T22:21:33.683Z,1651702893.683 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:21:33.684Z,1651702893.684 [CBIT](CRITICAL): Hardware Fault in component: AHRS_M2
2022-05-04T22:21:34.040Z,1651702894.040 [AHRS_M2](INFO): Powering down
2022-05-04T22:21:34.128Z,1651702894.128 [MissionManager](IMPORTANT): Started mission Default
2022-05-04T22:21:34.128Z,1651702894.128 [Default] Running Loop=1
2022-05-04T22:21:34.128Z,1651702894.128 [Default](DEBUG): Aggregate::initialize Default
2022-05-04T22:21:34.128Z,1651702894.128 [Default:B.GoToSurface] Running Loop=1
2022-05-04T22:21:34.128Z,1651702894.128 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-05-04T22:21:34.129Z,1651702894.129 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-05-04T22:21:34.129Z,1651702894.129 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-05-04T22:21:34.129Z,1651702894.129 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-05-04T22:21:34.130Z,1651702894.130 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-05-04T22:21:34.130Z,1651702894.130 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-05-04T22:21:34.130Z,1651702894.130 [Default:A.Wait] Running Loop=1
2022-05-04T22:21:34.130Z,1651702894.130 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-05-04T22:21:34.138Z,1651702894.138 [CBIT](INFO): Critical error at 20220504T222133
2022-05-04T22:21:34.138Z,1651702894.138 [CBIT](FAULT): Main Battery Failure. Count: 581
2022-05-04T22:21:34.445Z,1651702894.445 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:21:35.284Z,1651702895.284 [CBIT](INFO): Clearing failed state for component DVL_micro
2022-05-04T22:21:35.284Z,1651702895.284 [DVL_micro] No Fault, FailCount= 3
2022-05-04T22:21:38.102Z,1651702898.102 [CBIT](FAULT): Main Battery Failure. Count: 591
2022-05-04T22:21:40.856Z,1651702900.856 [CommandExec](IMPORTANT): got command failComponent none AHRS_M2
2022-05-04T22:21:40.856Z,1651702900.856 [AHRS_M2] No Fault, FailCount= 8
2022-05-04T22:21:40.857Z,1651702900.857 [CommandExec](IMPORTANT): AHRS_M2 failureMode is No Fault
2022-05-04T22:21:40.919Z,1651702900.919 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:21:42.156Z,1651702902.156 [CBIT](FAULT): Main Battery Failure. Count: 601
2022-05-04T22:21:45.357Z,1651702905.357 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:21:45.357Z,1651702905.357 [AHRS_M2] Hardware Fault, FailCount= 9
2022-05-04T22:21:45.357Z,1651702905.357 [AHRS_M2](ERROR): Hardware Fault
2022-05-04T22:21:45.399Z,1651702905.399 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-05-04T22:21:45.399Z,1651702905.399 [CBIT](CRITICAL): Hardware Fault in component: AHRS_M2
2022-05-04T22:21:45.756Z,1651702905.756 [AHRS_M2](INFO): Powering down
2022-05-04T22:21:45.855Z,1651702905.855 [CBIT](INFO): Critical error at 20220504T222145
2022-05-04T22:21:46.165Z,1651702906.165 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-05-04T22:21:46.180Z,1651702906.180 [CBIT](FAULT): Main Battery Failure. Count: 611
2022-05-04T22:21:47.398Z,1651702907.398 [Default:A.Wait](INFO): Done Waiting.
2022-05-04T22:21:47.399Z,1651702907.399 [Default:A.Wait] Stopped
2022-05-04T22:21:47.399Z,1651702907.399 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-05-04T22:21:47.810Z,1651702907.810 [Default:CheckIn] Running Loop=1
2022-05-04T22:21:47.810Z,1651702907.810 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-05-04T22:21:47.810Z,1651702907.810 [Default:CheckIn:Read_GPS] Running Loop=1
2022-05-04T22:21:48.206Z,1651702908.206 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-05-04T22:21:50.226Z,1651702910.226 [CBIT](FAULT): Main Battery Failure. Count: 621
2022-05-04T22:21:53.030Z,1651702913.030 [DVL_micro](FAULT): Failed to initialize within timeout.
2022-05-04T22:21:53.030Z,1651702913.030 [DVL_micro] Communications Fault, FailCount= 1
2022-05-04T22:21:53.030Z,1651702913.030 [DVL_micro](ERROR): Communications Fault
2022-05-04T22:21:53.058Z,1651702913.058 [CBIT](ERROR): Communications Fault in component: DVL_micro
2022-05-04T22:21:53.508Z,1651702913.508 [DVL_micro](INFO): Powering down
2022-05-04T22:21:54.259Z,1651702914.259 [CBIT](FAULT): Main Battery Failure. Count: 631
2022-05-04T22:21:54.261Z,1651702914.261 [CBIT](INFO): Clearing failed state for component DVL_micro
2022-05-04T22:21:54.261Z,1651702914.261 [DVL_micro] No Fault, FailCount= 1
2022-05-04T22:21:58.313Z,1651702918.313 [CBIT](FAULT): Main Battery Failure. Count: 641
2022-05-04T22:22:00.636Z,1651702920.636 [CommandExec](IMPORTANT): got command failComponent none AHRS_M2
2022-05-04T22:22:00.636Z,1651702920.636 [AHRS_M2] No Fault, FailCount= 9
2022-05-04T22:22:00.636Z,1651702920.636 [CommandExec](IMPORTANT): AHRS_M2 failureMode is No Fault
2022-05-04T22:22:00.708Z,1651702920.708 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-04T22:22:02.349Z,1651702922.349 [CBIT](FAULT): Main Battery Failure. Count: 651
2022-05-04T22:22:06.388Z,1651702926.388 [CBIT](FAULT): Main Battery Failure. Count: 661
2022-05-04T22:22:10.426Z,1651702930.426 [CBIT](FAULT): Main Battery Failure. Count: 671
2022-05-04T22:22:12.022Z,1651702932.022 [DVL_micro](FAULT): Failed to initialize within timeout.
2022-05-04T22:22:12.022Z,1651702932.022 [DVL_micro] Communications Fault, FailCount= 2
2022-05-04T22:22:12.022Z,1651702932.022 [DVL_micro](ERROR): Communications Fault
2022-05-04T22:22:12.039Z,1651702932.039 [CBIT](ERROR): Communications Fault in component: DVL_micro
2022-05-04T22:22:12.508Z,1651702932.508 [DVL_micro](INFO): Powering down
2022-05-04T22:22:13.285Z,1651702933.285 [CBIT](INFO): Clearing failed state for component DVL_micro
2022-05-04T22:22:13.285Z,1651702933.285 [DVL_micro] No Fault, FailCount= 2
2022-05-04T22:22:14.488Z,1651702934.488 [CBIT](FAULT): Main Battery Failure. Count: 681
2022-05-04T22:22:18.535Z,1651702938.535 [CBIT](FAULT): Main Battery Failure. Count: 691
2022-05-04T22:22:22.548Z,1651702942.548 [CBIT](FAULT): Main Battery Failure. Count: 701
2022-05-04T22:22:26.583Z,1651702946.583 [CBIT](FAULT): Main Battery Failure. Count: 711
2022-05-04T22:22:27.541Z,1651702947.541 [CommandExec](IMPORTANT): got command get platform_orientation degree
2022-05-04T22:22:27.541Z,1651702947.541 [CommandExec](IMPORTANT): platform_orientation 59.249862 arcdeg
2022-05-04T22:22:29.697Z,1651702949.697 [CommandExec](IMPORTANT): got command get platform_orientation degree
2022-05-04T22:22:29.698Z,1651702949.698 [CommandExec](IMPORTANT): platform_orientation 59.252499 arcdeg
2022-05-04T22:22:30.630Z,1651702950.630 [CBIT](FAULT): Main Battery Failure. Count: 721
2022-05-04T22:22:31.017Z,1651702951.017 [DVL_micro](FAULT): Failed to initialize within timeout.
2022-05-04T22:22:31.017Z,1651702951.017 [DVL_micro] Communications Fault, FailCount= 3
2022-05-04T22:22:31.017Z,1651702951.017 [DVL_micro](ERROR): Communications Fault
2022-05-04T22:22:31.061Z,1651702951.061 [CBIT](ERROR): Communications Fault in component: DVL_micro
2022-05-04T22:22:31.061Z,1651702951.061 [CBIT](CRITICAL): Communications Fault in component: DVL_micro
2022-05-04T22:22:31.492Z,1651702951.492 [DVL_micro](INFO): Powering down
2022-05-04T22:22:31.516Z,1651702951.516 [CBIT](INFO): Critical error at 20220504T222231
2022-05-04T22:22:34.688Z,1651702954.688 [CBIT](FAULT): Main Battery Failure. Count: 731
2022-05-04T22:22:38.703Z,1651702958.703 [CBIT](FAULT): Main Battery Failure. Count: 741
2022-05-04T22:22:42.753Z,1651702962.753 [CBIT](FAULT): Main Battery Failure. Count: 751
2022-05-04T22:22:59.931Z,1651702979.931 [CommandExec](IMPORTANT): got command get platform_orientation degree
2022-05-04T22:22:59.932Z,1651702979.932 [CommandExec](IMPORTANT): platform_orientation 59.226107 arcdeg
2022-05-04T22:23:23.130Z,1651703003.130 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-05-04T22:23:40.529Z,1651703020.529 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2022-05-04T22:23:40.529Z,1651703020.529 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:23:40.561Z,1651703020.561 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:23:40.935Z,1651703020.935 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:23:40.935Z,1651703020.935 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2022-05-04T22:23:46.611Z,1651703026.611 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-05-04T22:23:46.611Z,1651703026.611 [WetLabsBB2FL] No Fault, FailCount= 5
2022-05-04T22:23:46.697Z,1651703026.697 [WetLabsBB2FL](INFO): Powering up
2022-05-04T22:23:48.808Z,1651703028.808 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:24:07.553Z,1651703047.553 [CommandExec](IMPORTANT): got command strobe off
2022-05-04T22:24:07.553Z,1651703047.553 [CommandExec](IMPORTANT): Deactivating strobe
2022-05-04T22:25:31.267Z,1651703131.267 [CBIT](INFO): Clearing failed state for component DVL_micro
2022-05-04T22:25:31.267Z,1651703131.267 [DVL_micro] No Fault, FailCount= 3
2022-05-04T22:25:33.462Z,1651703133.462 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004967
2022-05-04T22:25:46.571Z,1651703146.571 [DVL_micro](INFO): Failure count cleared after critical for DVL_micro
2022-05-04T22:26:35.068Z,1651703195.068 [DVL_micro](ERROR): only read 2 of 4 data items
2022-05-04T22:26:35.068Z,1651703195.068 [DVL_micro](ERROR): Failed to parse:
:BI,+00042,-00108+00000,I
2022-05-04T22:26:41.527Z,1651703201.527 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2022-05-04T22:26:41.527Z,1651703201.527 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:26:41.537Z,1651703201.537 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:26:41.949Z,1651703201.949 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:26:41.949Z,1651703201.949 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2022-05-04T22:26:47.983Z,1651703207.983 [Default:CheckIn:Read_GPS](INFO): Timed out from 2022-05-04T22:21:47.8Z
2022-05-04T22:26:47.983Z,1651703207.983 [Default:CheckIn:Read_GPS] Stopped
2022-05-04T22:26:47.983Z,1651703207.983 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-05-04T22:26:48.410Z,1651703208.410 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-05-04T22:26:55.423Z,1651703215.423 [DataOverHttps](INFO): Sending 91 bytes from file Logs/20220504T203335/Courier0034.lzma
2022-05-04T22:26:56.426Z,1651703216.426 [DataOverHttps](INFO): Moved sent file to Logs/20220504T203335/Courier0034.lzma.bak
2022-05-04T22:26:56.426Z,1651703216.426 [DataOverHttps](INFO): SBD MOMSN=16689755
2022-05-04T22:27:11.972Z,1651703231.972 [DataOverHttps](INFO): Sending 254 bytes from file Logs/20220504T221729/Courier0000.lzma
2022-05-04T22:27:12.974Z,1651703232.974 [DataOverHttps](INFO): Moved sent file to Logs/20220504T221729/Courier0000.lzma.bak
2022-05-04T22:27:12.974Z,1651703232.974 [DataOverHttps](INFO): SBD MOMSN=16689758
2022-05-04T22:27:28.527Z,1651703248.527 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20220504T221729/Courier0004.lzma
2022-05-04T22:27:29.530Z,1651703249.530 [DataOverHttps](INFO): Moved sent file to Logs/20220504T221729/Courier0004.lzma.bak
2022-05-04T22:27:29.530Z,1651703249.530 [DataOverHttps](INFO): SBD MOMSN=16689764
2022-05-04T22:27:45.146Z,1651703265.146 [DataOverHttps](INFO): Sending 1470 bytes from file Logs/20220504T203335/Express0035.lzma
2022-05-04T22:27:46.146Z,1651703266.146 [DataOverHttps](INFO): Moved sent file to Logs/20220504T203335/Express0035.lzma.bak
2022-05-04T22:27:46.146Z,1651703266.146 [DataOverHttps](INFO): SBD MOMSN=16689771
2022-05-04T22:28:02.010Z,1651703282.010 [DataOverHttps](INFO): Sending 1588 bytes from file Logs/20220504T221729/Express0001.lzma
2022-05-04T22:28:03.010Z,1651703283.010 [DataOverHttps](INFO): Moved sent file to Logs/20220504T221729/Express0001.lzma.bak
2022-05-04T22:28:03.010Z,1651703283.010 [DataOverHttps](INFO): SBD MOMSN=16689889
2022-05-04T22:28:18.553Z,1651703298.553 [DataOverHttps](INFO): Sending 823 bytes from file Logs/20220504T221729/Express0005.lzma
2022-05-04T22:28:19.554Z,1651703299.554 [DataOverHttps](INFO): Moved sent file to Logs/20220504T221729/Express0005.lzma.bak
2022-05-04T22:28:19.554Z,1651703299.554 [DataOverHttps](INFO): SBD MOMSN=16689988
2022-05-04T22:28:20.486Z,1651703300.486 [NAL9602](FAULT): GPS failed to acquire within timeout.
2022-05-04T22:28:20.486Z,1651703300.486 [NAL9602] Data Fault, FailCount= 1
2022-05-04T22:28:20.486Z,1651703300.486 [NAL9602](ERROR): Data Fault
2022-05-04T22:28:20.502Z,1651703300.502 [CBIT](ERROR): Data Fault in component: NAL9602
2022-05-04T22:28:20.917Z,1651703300.917 [NAL9602](INFO): Powering down
2022-05-04T22:28:20.943Z,1651703300.943 [Default:CheckIn:Read_Iridium] Stopped
2022-05-04T22:28:20.943Z,1651703300.943 [Default:CheckIn:C.Wait] Running Loop=1
2022-05-04T22:28:20.943Z,1651703300.943 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-05-04T22:28:21.732Z,1651703301.732 [CBIT](INFO): Clearing failed state for component NAL9602
2022-05-04T22:28:21.732Z,1651703301.732 [NAL9602] No Fault, FailCount= 1
2022-05-04T22:28:51.200Z,1651703331.200 [NAL9602](INFO): Powering up NAL9602
2022-05-04T22:29:02.121Z,1651703342.121 [NAL9602](INFO): NAL9602 initialized
2022-05-04T22:29:42.520Z,1651703382.520 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2022-05-04T22:29:42.520Z,1651703382.520 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:29:42.530Z,1651703382.530 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:29:42.981Z,1651703382.981 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:29:42.981Z,1651703382.981 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2022-05-04T22:30:43.929Z,1651703443.929 [DVL_micro](ERROR): only read 3 of 4 data items
2022-05-04T22:30:43.929Z,1651703443.929 [DVL_micro](ERROR): Failed to parse:
:BI,+0078,-00099,+00000,I
2022-05-04T22:31:24.330Z,1651703484.330 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2022-05-04T22:31:24.330Z,1651703484.330 [DVL_micro](ERROR): Failed to parse:
:TS,00000000000000,35.0,+22.4,0000.,000
2022-05-04T22:32:43.544Z,1651703563.544 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2022-05-04T22:32:43.544Z,1651703563.544 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:32:43.578Z,1651703563.578 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:32:43.957Z,1651703563.957 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:32:43.957Z,1651703563.957 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2022-05-04T22:32:47.985Z,1651703567.985 [DVL_micro](ERROR): Failed to parse:
00000000022.5,00000,000
2022-05-04T22:33:21.542Z,1651703601.542 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-05-04T22:33:21.542Z,1651703601.542 [Default:CheckIn:C.Wait] Stopped
2022-05-04T22:33:21.542Z,1651703601.542 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-05-04T22:33:21.542Z,1651703601.542 [Default:CheckIn:D] Running Loop=1
2022-05-04T22:33:21.949Z,1651703601.949 [Default:CheckIn:D] Stopped
2022-05-04T22:33:21.950Z,1651703601.950 [Default:CheckIn:E] Running Loop=1
2022-05-04T22:33:22.330Z,1651703602.330 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.797020 min
2022-05-04T22:33:22.330Z,1651703602.330 [Default:CheckIn:E] Stopped
2022-05-04T22:33:22.330Z,1651703602.330 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-05-04T22:33:22.330Z,1651703602.330 [Default:CheckIn] Stopped
2022-05-04T22:33:22.330Z,1651703602.330 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-05-04T22:33:22.330Z,1651703602.330 [Default:CheckIn](INFO): Running loop #2
2022-05-04T22:33:22.331Z,1651703602.331 [Default:CheckIn] Running Loop=2
2022-05-04T22:33:22.331Z,1651703602.331 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-05-04T22:33:22.331Z,1651703602.331 [Default:CheckIn:Read_GPS] Running Loop=1
2022-05-04T22:35:44.586Z,1651703744.586 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2022-05-04T22:35:44.586Z,1651703744.586 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:35:44.596Z,1651703744.596 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:35:45.021Z,1651703745.021 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:35:45.021Z,1651703745.021 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2022-05-04T22:36:20.535Z,1651703780.535 [DVL_micro](ERROR): Failed to parse:
:WI,+00068,-00025,-00089,+00000,A
2022-05-04T22:38:22.586Z,1651703902.586 [Default:CheckIn:Read_GPS](INFO): Timed out from 2022-05-04T22:33:22.3Z
2022-05-04T22:38:22.586Z,1651703902.586 [Default:CheckIn:Read_GPS] Stopped
2022-05-04T22:38:22.586Z,1651703902.586 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-05-04T22:38:29.979Z,1651703909.979 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20220504T221729/Courier0007.lzma
2022-05-04T22:38:30.982Z,1651703910.982 [DataOverHttps](INFO): Moved sent file to Logs/20220504T221729/Courier0007.lzma.bak
2022-05-04T22:38:30.982Z,1651703910.982 [DataOverHttps](INFO): SBD MOMSN=16690059
2022-05-04T22:38:45.605Z,1651703925.605 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2022-05-04T22:38:45.605Z,1651703925.605 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:38:45.657Z,1651703925.657 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:38:46.030Z,1651703926.030 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:38:46.030Z,1651703926.030 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2022-05-04T22:38:46.728Z,1651703926.728 [DataOverHttps](INFO): Sending 298 bytes from file Logs/20220504T221729/Express0008.lzma
2022-05-04T22:38:47.730Z,1651703927.730 [DataOverHttps](INFO): Moved sent file to Logs/20220504T221729/Express0008.lzma.bak
2022-05-04T22:38:47.730Z,1651703927.730 [DataOverHttps](INFO): SBD MOMSN=16690061
2022-05-04T22:38:49.257Z,1651703929.257 [Default:CheckIn:Read_Iridium] Stopped
2022-05-04T22:38:49.258Z,1651703929.258 [Default:CheckIn:C.Wait] Running Loop=1
2022-05-04T22:38:49.258Z,1651703929.258 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-05-04T22:39:04.984Z,1651703944.984 [NAL9602](FAULT): GPS failed to acquire within timeout.
2022-05-04T22:39:04.984Z,1651703944.984 [NAL9602] Data Fault, FailCount= 2
2022-05-04T22:39:04.984Z,1651703944.984 [NAL9602](ERROR): Data Fault
2022-05-04T22:39:05.001Z,1651703945.001 [CBIT](ERROR): Data Fault in component: NAL9602
2022-05-04T22:39:05.406Z,1651703945.406 [NAL9602](INFO): Powering down
2022-05-04T22:39:06.199Z,1651703946.199 [CBIT](INFO): Clearing failed state for component NAL9602
2022-05-04T22:39:06.199Z,1651703946.199 [NAL9602] No Fault, FailCount= 2
2022-05-04T22:39:35.686Z,1651703975.686 [NAL9602](INFO): Powering up NAL9602
2022-05-04T22:39:46.590Z,1651703986.590 [NAL9602](INFO): NAL9602 initialized
2022-05-04T22:41:18.829Z,1651704078.829 [CommandExec](IMPORTANT): got command report
2022-05-04T22:41:24.757Z,1651704084.757 [CommandExec](IMPORTANT): got command show variable ahU
2022-05-04T22:41:29.277Z,1651704089.277 [CommandExec](IMPORTANT): got command show variable amph
2022-05-04T22:41:29.404Z,1651704089.404 [CommandExec](IMPORTANT): CBIT.ampHoursUsed (ampere_hour)
2022-05-04T22:41:36.730Z,1651704096.730 [CommandExec](IMPORTANT): got command get CBIT.ampHoursUsed
2022-05-04T22:41:36.730Z,1651704096.730 [CommandExec](IMPORTANT): CBIT.ampHoursUsed 153.766418 Ah
2022-05-04T22:41:46.618Z,1651704106.618 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2022-05-04T22:41:46.618Z,1651704106.618 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:41:46.628Z,1651704106.628 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:41:47.068Z,1651704107.068 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:41:47.068Z,1651704107.068 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2022-05-04T22:43:49.813Z,1651704229.813 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-05-04T22:43:49.813Z,1651704229.813 [Default:CheckIn:C.Wait] Stopped
2022-05-04T22:43:49.813Z,1651704229.813 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-05-04T22:43:49.813Z,1651704229.813 [Default:CheckIn:D] Running Loop=1
2022-05-04T22:43:50.221Z,1651704230.221 [Default:CheckIn:D] Stopped
2022-05-04T22:43:50.221Z,1651704230.221 [Default:CheckIn:E] Running Loop=1
2022-05-04T22:43:50.650Z,1651704230.650 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.268209 min
2022-05-04T22:43:50.650Z,1651704230.650 [Default:CheckIn:E] Stopped
2022-05-04T22:43:50.651Z,1651704230.651 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-05-04T22:43:50.651Z,1651704230.651 [Default:CheckIn] Stopped
2022-05-04T22:43:50.651Z,1651704230.651 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-05-04T22:43:50.651Z,1651704230.651 [Default:CheckIn](INFO): Running loop #3
2022-05-04T22:43:50.651Z,1651704230.651 [Default:CheckIn] Running Loop=3
2022-05-04T22:43:50.651Z,1651704230.651 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-05-04T22:43:50.651Z,1651704230.651 [Default:CheckIn:Read_GPS] Running Loop=1
2022-05-04T22:43:55.875Z,1651704235.875 [DVL_micro](ERROR): only read 3 of 4 data items
2022-05-04T22:43:55.895Z,1651704235.895 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.999,+9999.99,+9999.99
2022-05-04T22:44:47.633Z,1651704287.633 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2022-05-04T22:44:47.633Z,1651704287.633 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:44:47.643Z,1651704287.643 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:44:48.038Z,1651704288.038 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:44:48.038Z,1651704288.038 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2022-05-04T22:45:01.747Z,1651704301.747 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2022-05-04T22:45:01.747Z,1651704301.747 [DVL_micro](ERROR): Failed to parse:
:TS,00000000000000,35.0,+220,1489.0,000
2022-05-04T22:47:48.625Z,1651704468.625 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2022-05-04T22:47:48.625Z,1651704468.625 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:47:48.635Z,1651704468.635 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:47:49.041Z,1651704469.041 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:47:49.041Z,1651704469.041 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2022-05-04T22:47:55.876Z,1651704475.876 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2022-05-04T22:47:55.876Z,1651704475.876 [DVL_micro](ERROR): Failed to parse:
:TS,000000,35.0,+220,1489.0,0+00021,-00002,-00085,+00000,A
2022-05-04T22:48:50.890Z,1651704530.890 [Default:CheckIn:Read_GPS](INFO): Timed out from 2022-05-04T22:43:50.7Z
2022-05-04T22:48:50.890Z,1651704530.890 [Default:CheckIn:Read_GPS] Stopped
2022-05-04T22:48:50.890Z,1651704530.890 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-05-04T22:48:58.178Z,1651704538.178 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20220504T221729/Courier0010.lzma
2022-05-04T22:48:59.162Z,1651704539.162 [DataOverHttps](INFO): Moved sent file to Logs/20220504T221729/Courier0010.lzma.bak
2022-05-04T22:48:59.162Z,1651704539.162 [DataOverHttps](INFO): SBD MOMSN=16690065
2022-05-04T22:49:13.768Z,1651704553.768 [DataOverHttps](INFO): Sending 285 bytes from file Logs/20220504T221729/Express0011.lzma
2022-05-04T22:49:14.770Z,1651704554.770 [DataOverHttps](INFO): Moved sent file to Logs/20220504T221729/Express0011.lzma.bak
2022-05-04T22:49:14.770Z,1651704554.770 [DataOverHttps](INFO): SBD MOMSN=16690067
2022-05-04T22:49:16.325Z,1651704556.325 [Default:CheckIn:Read_Iridium] Stopped
2022-05-04T22:49:16.325Z,1651704556.325 [Default:CheckIn:C.Wait] Running Loop=1
2022-05-04T22:49:16.325Z,1651704556.325 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-05-04T22:49:49.415Z,1651704589.415 [NAL9602](FAULT): GPS failed to acquire within timeout.
2022-05-04T22:49:49.415Z,1651704589.415 [NAL9602] Data Fault, FailCount= 3
2022-05-04T22:49:49.415Z,1651704589.415 [NAL9602](ERROR): Data Fault
2022-05-04T22:49:49.494Z,1651704589.494 [CBIT](ERROR): Data Fault in component: NAL9602
2022-05-04T22:49:49.825Z,1651704589.825 [NAL9602](INFO): Powering down
2022-05-04T22:49:50.670Z,1651704590.670 [CBIT](INFO): Clearing failed state for component NAL9602
2022-05-04T22:49:50.670Z,1651704590.670 [NAL9602] No Fault, FailCount= 3
2022-05-04T22:50:20.124Z,1651704620.124 [NAL9602](INFO): Powering up NAL9602
2022-05-04T22:50:31.022Z,1651704631.022 [NAL9602](INFO): NAL9602 initialized
2022-05-04T22:50:45.576Z,1651704645.576 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2022-05-04T22:50:45.576Z,1651704645.576 [DVL_micro](ERROR): Failed to parse:
:TS,00000000000000,35,0000.0,1489.0,000
2022-05-04T22:50:49.623Z,1651704649.623 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2022-05-04T22:50:49.623Z,1651704649.623 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-05-04T22:50:49.634Z,1651704649.634 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-05-04T22:50:50.074Z,1651704650.074 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-05-04T22:50:50.074Z,1651704650.074 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2022-05-04T22:52:06.379Z,1651704726.379 [DVL_micro](ERROR): only read 2 of 4 data items
2022-05-04T22:52:06.379Z,1651704726.379 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.99,+9999.99,,+9999.99
2022-05-04T22:53:32.968Z,1651704812.968 [CommandExec](IMPORTANT): got command quit
2022-05-04T22:53:33.972Z,1651704813.972 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:33.972Z,1651704813.972 [CommandExec](INFO): Uninitializing the command executive.
2022-05-04T22:53:33.972Z,1651704813.972 [CommandExec](INFO): Uninitializing the command scheduler.
2022-05-04T22:53:33.972Z,1651704813.972 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:33.988Z,1651704813.988 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2022-05-04T22:53:33.988Z,1651704813.988 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-05-04T22:53:33.988Z,1651704813.988 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:33.989Z,1651704813.989 [NavChartDb](INFO): Join timeout helper Thread ID is 1184
2022-05-04T22:53:34.172Z,1651704814.172 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:34.172Z,1651704814.172 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:34.176Z,1651704814.176 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-05-04T22:53:34.176Z,1651704814.176 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:34.176Z,1651704814.176 [Radio_Surface](INFO): Join timeout helper Thread ID is 1185
2022-05-04T22:53:34.540Z,1651704814.540 [Radio_Surface](INFO): Powering down
2022-05-04T22:53:34.541Z,1651704814.541 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:34.541Z,1651704814.541 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:34.556Z,1651704814.556 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-05-04T22:53:34.556Z,1651704814.556 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:34.556Z,1651704814.556 [Onboard](INFO): Join timeout helper Thread ID is 1186
2022-05-04T22:53:34.900Z,1651704814.900 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-05-04T22:53:36.097Z,1651704816.097 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:36.098Z,1651704816.098 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:36.108Z,1651704816.108 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-05-04T22:53:36.108Z,1651704816.108 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:36.108Z,1651704816.108 [DataOverHttps](INFO): Join timeout helper Thread ID is 1187
2022-05-04T22:53:36.908Z,1651704816.908 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:36.908Z,1651704816.908 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:36.920Z,1651704816.920 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2022-05-04T22:53:36.920Z,1651704816.920 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:36.920Z,1651704816.920 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1188
2022-05-04T22:53:36.992Z,1651704816.992 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:36.992Z,1651704816.992 [WetLabsBB2FL](INFO): Powering down
2022-05-04T22:53:36.993Z,1651704816.993 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.009Z,1651704817.009 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-05-04T22:53:37.009Z,1651704817.009 [logger ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.009Z,1651704817.009 [logger](INFO): Join timeout helper Thread ID is 1189
2022-05-04T22:53:37.020Z,1651704817.020 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:37.020Z,1651704817.020 [logger ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.028Z,1651704817.028 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-05-04T22:53:37.029Z,1651704817.029 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.029Z,1651704817.029 [CommandLine](INFO): Join timeout helper Thread ID is 1190
2022-05-04T22:53:37.072Z,1651704817.072 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:37.072Z,1651704817.072 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.088Z,1651704817.088 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-05-04T22:53:37.089Z,1651704817.089 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.089Z,1651704817.089 [CommandExec](INFO): Join timeout helper Thread ID is 1191
2022-05-04T22:53:37.090Z,1651704817.090 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-05-04T22:53:37.090Z,1651704817.090 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.091Z,1651704817.091 [controlThread](INFO): Join timeout helper Thread ID is 1192
2022-05-04T22:53:37.268Z,1651704817.268 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-04T22:53:37.268Z,1651704817.268 [controlThread](DEBUG): Uninitializing ControlThread
2022-05-04T22:53:37.269Z,1651704817.269 [AHRS_M2](INFO): Powering down
2022-05-04T22:53:37.412Z,1651704817.412 [DVL_micro](INFO): Powering down
2022-05-04T22:53:37.413Z,1651704817.413 [NAL9602](INFO): Powering down
2022-05-04T22:53:37.414Z,1651704817.414 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-05-04T22:53:37.415Z,1651704817.415 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-05-04T22:53:37.416Z,1651704817.416 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-05-04T22:53:37.417Z,1651704817.417 [MissionManager](INFO): Uninitializing Mission Default
2022-05-04T22:53:37.417Z,1651704817.417 [Default] Stopped
2022-05-04T22:53:37.417Z,1651704817.417 [Default](DEBUG): Aggregate::uninitialize Default
2022-05-04T22:53:37.417Z,1651704817.417 [Default:B.GoToSurface] Stopped
2022-05-04T22:53:37.417Z,1651704817.417 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-05-04T22:53:37.417Z,1651704817.417 [Default:CheckIn] Stopped
2022-05-04T22:53:37.417Z,1651704817.417 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-05-04T22:53:37.417Z,1651704817.417 [Default:CheckIn:C.Wait] Stopped
2022-05-04T22:53:37.417Z,1651704817.417 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-05-04T22:53:37.420Z,1651704817.420 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-05-04T22:53:37.420Z,1651704817.420 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-05-04T22:53:37.421Z,1651704817.421 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-05-04T22:53:37.421Z,1651704817.421 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-05-04T22:53:37.421Z,1651704817.421 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-05-04T22:53:37.422Z,1651704817.422 [BuoyancyServo](INFO): Powering down
2022-05-04T22:53:37.436Z,1651704817.436 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-05-04T22:53:37.436Z,1651704817.436 [ElevatorServo](INFO): Powering down
2022-05-04T22:53:37.437Z,1651704817.437 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-05-04T22:53:37.437Z,1651704817.437 [ThrusterHE](INFO): Powering down
2022-05-04T22:53:37.438Z,1651704817.438 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-05-04T22:53:37.438Z,1651704817.438 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-05-04T22:53:37.439Z,1651704817.439 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-05-04T22:53:37.439Z,1651704817.439 [CBIT](DEBUG): Powering off loads.
2022-05-04T22:53:37.452Z,1651704817.452 [CBIT](DEBUG): Disabling WDT.
2022-05-04T22:53:37.464Z,1651704817.464 [CBIT](DEBUG): Opening all GF detection circuits.
2022-05-04T22:53:37.464Z,1651704817.464 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.495Z,1651704817.495 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.526Z,1651704817.526 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.528Z,1651704817.528 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.535Z,1651704817.535 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.586Z,1651704817.586 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-05-04T22:53:37.647Z,1651704817.647 [logger ThreadHandler](INFO): Thread cancelled.