2023-05-11T21:25:36.253Z,1683840336.253 [Supervisor](DEBUG): Initializing supervisor.
2023-05-11T21:25:36.258Z,1683840336.258 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-05-11T21:25:36.258Z,1683840336.258 [SyncHandler](INFO): Protected caller Thread ID is 834
2023-05-11T21:25:36.259Z,1683840336.259 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-05-11T21:25:36.260Z,1683840336.260 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-05-11T21:25:36.260Z,1683840336.260 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 835
2023-05-11T21:25:36.264Z,1683840336.264 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-05-11T21:25:36.281Z,1683840336.281 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-05-11T21:25:36.282Z,1683840336.282 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-05-11T21:25:36.282Z,1683840336.282 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 836
2023-05-11T21:25:36.287Z,1683840336.287 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-05-11T21:25:36.288Z,1683840336.288 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-05-11T21:25:36.288Z,1683840336.288 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 837
2023-05-11T21:25:36.290Z,1683840336.290 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-05-11T21:25:36.291Z,1683840336.291 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-05-11T21:25:36.291Z,1683840336.291 [logger ThreadHandler](INFO): Protected caller Thread ID is 838
2023-05-11T21:25:36.295Z,1683840336.295 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-05-11T21:25:36.295Z,1683840336.295 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-05-11T21:25:36.300Z,1683840336.300 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-05-11T21:25:36.631Z,1683840336.631 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-05-11T21:25:36.631Z,1683840336.631 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-05-11T21:25:37.315Z,1683840337.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-05-11T21:25:37.345Z,1683840337.345 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-05-11T21:25:37.453Z,1683840337.453 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-05-11T21:25:37.454Z,1683840337.454 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-05-11T21:25:37.942Z,1683840337.942 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-05-11T21:25:37.943Z,1683840337.943 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-05-11T21:25:38.040Z,1683840338.040 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-05-11T21:25:38.042Z,1683840338.042 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-05-11T21:25:38.123Z,1683840338.123 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-05-11T21:25:38.522Z,1683840338.522 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-05-11T21:25:38.524Z,1683840338.524 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-05-11T21:25:38.742Z,1683840338.742 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-05-11T21:25:38.743Z,1683840338.743 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-05-11T21:25:38.879Z,1683840338.879 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-05-11T21:25:38.881Z,1683840338.881 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-05-11T21:25:39.117Z,1683840339.117 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-05-11T21:25:39.119Z,1683840339.119 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-05-11T21:25:39.639Z,1683840339.639 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-05-11T21:25:39.639Z,1683840339.639 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-05-11T21:25:40.526Z,1683840340.526 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-05-11T21:25:40.527Z,1683840340.527 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-05-11T21:25:40.607Z,1683840340.607 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-05-11T21:25:40.795Z,1683840340.795 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-05-11T21:25:40.797Z,1683840340.797 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-05-11T21:25:41.016Z,1683840341.016 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-05-11T21:25:41.016Z,1683840341.016 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-05-11T21:25:41.309Z,1683840341.309 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-05-11T21:25:41.311Z,1683840341.311 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2023-05-11T21:25:41.316Z,1683840341.316 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2023-05-11T21:25:41.425Z,1683840341.425 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2023-05-11T21:25:41.573Z,1683840341.573 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2023-05-11T21:25:41.660Z,1683840341.660 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2023-05-11T21:25:41.743Z,1683840341.743 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2023-05-11T21:25:41.852Z,1683840341.852 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2023-05-11T21:25:42.027Z,1683840342.027 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2023-05-11T21:25:42.347Z,1683840342.347 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-05-11T21:25:42.348Z,1683840342.348 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2023-05-11T21:25:42.480Z,1683840342.480 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2023-05-11T21:25:42.575Z,1683840342.575 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2023-05-11T21:25:42.680Z,1683840342.680 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2023-05-11T21:25:42.781Z,1683840342.781 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-05-11T21:25:42.806Z,1683840342.806 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-05-11T21:25:42.928Z,1683840342.928 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-05-11T21:25:42.930Z,1683840342.930 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-05-11T21:25:42.946Z,1683840342.946 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-05-11T21:25:42.947Z,1683840342.947 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-05-11T21:25:43.018Z,1683840343.018 [DepthRateCalculator] Loaded
2023-05-11T21:25:43.018Z,1683840343.018 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-05-11T21:25:43.023Z,1683840343.023 [PitchRateCalculator] Loaded
2023-05-11T21:25:43.024Z,1683840343.024 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-05-11T21:25:43.034Z,1683840343.034 [SpeedCalculator] Loaded
2023-05-11T21:25:43.034Z,1683840343.034 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-05-11T21:25:43.049Z,1683840343.049 [VerticalHomogeneityIndexCalculator] Loaded
2023-05-11T21:25:43.049Z,1683840343.049 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread.
2023-05-11T21:25:43.054Z,1683840343.054 [YawRateCalculator] Loaded
2023-05-11T21:25:43.054Z,1683840343.054 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-05-11T21:25:43.075Z,1683840343.075 [ElevatorOffsetCalculator] Loaded
2023-05-11T21:25:43.076Z,1683840343.076 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-05-11T21:25:43.076Z,1683840343.076 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-05-11T21:25:43.077Z,1683840343.077 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-05-11T21:25:43.143Z,1683840343.143 [VerticalControl](DEBUG): Construct VerticalControl.
2023-05-11T21:25:43.198Z,1683840343.198 [VerticalControl] Loaded
2023-05-11T21:25:43.198Z,1683840343.198 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-05-11T21:25:43.201Z,1683840343.201 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-05-11T21:25:43.241Z,1683840343.241 [HorizontalControl] Loaded
2023-05-11T21:25:43.242Z,1683840343.242 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-05-11T21:25:43.244Z,1683840343.244 [SpeedControl](DEBUG): Construct SpeedControl.
2023-05-11T21:25:43.247Z,1683840343.247 [SpeedControl] Loaded
2023-05-11T21:25:43.247Z,1683840343.247 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-05-11T21:25:43.250Z,1683840343.250 [LoopControl](DEBUG): Construct LoopControl.
2023-05-11T21:25:43.250Z,1683840343.250 [LoopControl] Loaded
2023-05-11T21:25:43.250Z,1683840343.250 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-05-11T21:25:43.251Z,1683840343.251 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-05-11T21:25:43.251Z,1683840343.251 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-05-11T21:25:43.385Z,1683840343.385 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-05-11T21:25:43.386Z,1683840343.386 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-05-11T21:25:43.399Z,1683840343.399 [NavChart] Loaded
2023-05-11T21:25:43.399Z,1683840343.399 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-05-11T21:25:43.405Z,1683840343.405 [UniversalFixResidualReporter] Loaded
2023-05-11T21:25:43.405Z,1683840343.405 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-05-11T21:25:43.405Z,1683840343.405 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-05-11T21:25:43.407Z,1683840343.407 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-05-11T21:25:43.590Z,1683840343.590 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-05-11T21:25:43.590Z,1683840343.590 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-05-11T21:25:44.343Z,1683840344.343 [AHRS_M2] Loaded
2023-05-11T21:25:44.343Z,1683840344.343 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-05-11T21:25:44.593Z,1683840344.593 [BackseatComponent] Loaded
2023-05-11T21:25:44.593Z,1683840344.593 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-05-11T21:25:44.594Z,1683840344.594 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408F64E0
2023-05-11T21:25:44.594Z,1683840344.594 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 921
2023-05-11T21:25:44.597Z,1683840344.597 [LcmUniversalReporter] Loaded
2023-05-11T21:25:44.597Z,1683840344.597 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-05-11T21:25:45.661Z,1683840345.661 [BPC1] Loaded
2023-05-11T21:25:45.661Z,1683840345.661 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-05-11T21:25:45.803Z,1683840345.803 [DataOverHttps] Loaded
2023-05-11T21:25:45.803Z,1683840345.803 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-05-11T21:25:45.804Z,1683840345.804 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409264E0
2023-05-11T21:25:45.805Z,1683840345.805 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 922
2023-05-11T21:25:45.825Z,1683840345.825 [Depth_Keller] Loaded
2023-05-11T21:25:45.826Z,1683840345.826 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-05-11T21:25:45.831Z,1683840345.831 [DropWeight] Loaded
2023-05-11T21:25:45.831Z,1683840345.831 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-05-11T21:25:45.868Z,1683840345.868 [DVL_micro] Loaded
2023-05-11T21:25:45.868Z,1683840345.868 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2023-05-11T21:25:45.929Z,1683840345.929 [NAL9602] Loaded
2023-05-11T21:25:45.929Z,1683840345.929 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-05-11T21:25:45.959Z,1683840345.959 [Onboard] Loaded
2023-05-11T21:25:45.959Z,1683840345.959 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-05-11T21:25:45.960Z,1683840345.960 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409564E0
2023-05-11T21:25:45.961Z,1683840345.961 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 923
2023-05-11T21:25:45.972Z,1683840345.972 [Power24vConverter] Loaded
2023-05-11T21:25:45.973Z,1683840345.973 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-05-11T21:25:45.986Z,1683840345.986 [Radio_Surface] Loaded
2023-05-11T21:25:45.986Z,1683840345.986 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-05-11T21:25:45.987Z,1683840345.987 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409864E0
2023-05-11T21:25:45.987Z,1683840345.987 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 924
2023-05-11T21:25:46.078Z,1683840346.078 [DAT] Loaded
2023-05-11T21:25:46.078Z,1683840346.078 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-05-11T21:25:46.079Z,1683840346.079 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409B64E0
2023-05-11T21:25:46.080Z,1683840346.080 [DAT ThreadHandler](INFO): Protected caller Thread ID is 925
2023-05-11T21:25:46.080Z,1683840346.080 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-05-11T21:25:46.081Z,1683840346.081 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-05-11T21:25:46.240Z,1683840346.240 [BuoyancyServo] Loaded
2023-05-11T21:25:46.240Z,1683840346.240 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-05-11T21:25:46.260Z,1683840346.260 [ElevatorServo] Loaded
2023-05-11T21:25:46.260Z,1683840346.260 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-05-11T21:25:46.280Z,1683840346.280 [MassServo] Loaded
2023-05-11T21:25:46.280Z,1683840346.280 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-05-11T21:25:46.298Z,1683840346.298 [RudderServo] Loaded
2023-05-11T21:25:46.299Z,1683840346.299 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-05-11T21:25:46.313Z,1683840346.313 [ThrusterHE] Loaded
2023-05-11T21:25:46.313Z,1683840346.313 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-05-11T21:25:46.314Z,1683840346.314 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-05-11T21:25:46.314Z,1683840346.314 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-05-11T21:25:46.410Z,1683840346.410 [StratificationFrontDetector](IMPORTANT): thresholdVTHI set to: 0.100000 degC
2023-05-11T21:25:46.410Z,1683840346.410 [StratificationFrontDetector](INFO): (re)initializing
2023-05-11T21:25:46.410Z,1683840346.410 [StratificationFrontDetector] Loaded
2023-05-11T21:25:46.411Z,1683840346.411 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2023-05-11T21:25:46.411Z,1683840346.411 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-05-11T21:25:46.412Z,1683840346.412 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-05-11T21:25:46.455Z,1683840346.455 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-05-11T21:25:46.456Z,1683840346.456 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-05-11T21:25:46.808Z,1683840346.808 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-05-11T21:25:46.808Z,1683840346.808 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-05-11T21:25:47.023Z,1683840347.023 [CTD_Seabird] Loaded
2023-05-11T21:25:47.023Z,1683840347.023 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-05-11T21:25:47.024Z,1683840347.024 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B494E0
2023-05-11T21:25:47.024Z,1683840347.024 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 926
2023-05-11T21:25:47.058Z,1683840347.058 [ESPComponent] Loaded
2023-05-11T21:25:47.058Z,1683840347.058 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-05-11T21:25:47.078Z,1683840347.078 [PAR_Licor] Loaded
2023-05-11T21:25:47.078Z,1683840347.078 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-05-11T21:25:47.109Z,1683840347.109 [WetLabsBB2FL] Loaded
2023-05-11T21:25:47.109Z,1683840347.109 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-05-11T21:25:47.110Z,1683840347.110 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B794E0
2023-05-11T21:25:47.111Z,1683840347.111 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 927
2023-05-11T21:25:47.112Z,1683840347.112 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-05-11T21:25:47.112Z,1683840347.112 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-05-11T21:25:47.279Z,1683840347.279 [SBIT](DEBUG): Construct Startup Built In Test.
2023-05-11T21:25:47.288Z,1683840347.288 [SBIT] Loaded
2023-05-11T21:25:47.289Z,1683840347.289 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-05-11T21:25:47.292Z,1683840347.292 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-05-11T21:25:47.304Z,1683840347.304 [IBIT] Loaded
2023-05-11T21:25:47.305Z,1683840347.305 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-05-11T21:25:47.310Z,1683840347.310 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-05-11T21:25:47.414Z,1683840347.414 [CBIT] Loaded
2023-05-11T21:25:47.414Z,1683840347.414 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-05-11T21:25:47.414Z,1683840347.414 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-05-11T21:25:47.421Z,1683840347.421 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-05-11T21:25:47.424Z,1683840347.424 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-05-11T21:25:47.435Z,1683840347.435 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-05-11T21:25:47.436Z,1683840347.436 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BE74E0
2023-05-11T21:25:47.436Z,1683840347.436 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 928
2023-05-11T21:25:47.440Z,1683840347.440 [Supervisor](INFO): Main Thread ID is 827
2023-05-11T21:25:47.441Z,1683840347.441 [Supervisor](DEBUG): Running supervisor.
2023-05-11T21:25:47.441Z,1683840347.441 [CommandExec ThreadHandler](INFO): Handler Thread ID is 929
2023-05-11T21:25:47.442Z,1683840347.442 [CommandExec](INFO): Initializing the command executive.
2023-05-11T21:25:47.443Z,1683840347.443 [CommandLine ThreadHandler](INFO): Handler Thread ID is 930
2023-05-11T21:25:47.445Z,1683840347.445 [controlThread ThreadHandler](INFO): Handler Thread ID is 931
2023-05-11T21:25:47.446Z,1683840347.446 [controlThread](DEBUG): Initializing ControlThread
2023-05-11T21:25:47.446Z,1683840347.446 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-05-11T21:25:47.447Z,1683840347.447 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-05-11T21:25:47.447Z,1683840347.447 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-05-11T21:25:47.447Z,1683840347.447 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing
2023-05-11T21:25:47.448Z,1683840347.448 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-05-11T21:25:47.449Z,1683840347.449 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-05-11T21:25:47.449Z,1683840347.449 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-05-11T21:25:47.451Z,1683840347.451 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-05-11T21:25:47.452Z,1683840347.452 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-05-11T21:25:47.452Z,1683840347.452 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-05-11T21:25:47.453Z,1683840347.453 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-05-11T21:25:47.454Z,1683840347.454 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-05-11T21:25:47.461Z,1683840347.461 [SBIT](INFO): Initialize SBIT Component.
2023-05-11T21:25:47.462Z,1683840347.462 [SBIT](IMPORTANT): git: 2023-05-11
2023-05-11T21:25:47.462Z,1683840347.462 [SBIT](INFO): git hash: 819773fe6d6f007a19954d172147646e14066f04
2023-05-11T21:25:47.462Z,1683840347.462 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-05-11T21:25:47.463Z,1683840347.463 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-05-11T21:25:47.464Z,1683840347.464 [SBIT](INFO): Beginning SBIT in 134.000000 seconds.
2023-05-11T21:25:47.464Z,1683840347.464 [IBIT](INFO): Initialize IBIT Component.
2023-05-11T21:25:47.466Z,1683840347.466 [CBIT](DEBUG): Initialize CBIT Component.
2023-05-11T21:25:47.466Z,1683840347.466 [logger ThreadHandler](INFO): Handler Thread ID is 932
2023-05-11T21:25:47.477Z,1683840347.477 [CBIT](DEBUG): Initialized mux pins.
2023-05-11T21:25:47.477Z,1683840347.477 [CBIT](DEBUG): Initializing the watchdog timer.
2023-05-11T21:25:47.485Z,1683840347.485 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 933
2023-05-11T21:25:47.497Z,1683840347.497 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 934
2023-05-11T21:25:47.498Z,1683840347.498 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-05-11T21:25:47.501Z,1683840347.501 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-05-11T21:25:47.501Z,1683840347.501 [CBIT](DEBUG): Initializing heartbeat.
2023-05-11T21:25:47.509Z,1683840347.509 [Onboard ThreadHandler](INFO): Handler Thread ID is 935
2023-05-11T21:25:47.527Z,1683840347.527 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 936
2023-05-11T21:25:47.546Z,1683840347.546 [DAT ThreadHandler](INFO): Handler Thread ID is 937
2023-05-11T21:25:47.546Z,1683840347.546 [DAT](INFO): Powering up
2023-05-11T21:25:47.547Z,1683840347.547 [DAT](DEBUG): Initializing DAT.
2023-05-11T21:25:47.550Z,1683840347.550 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 939
2023-05-11T21:25:47.551Z,1683840347.551 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-11T21:25:47.554Z,1683840347.554 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 941
2023-05-11T21:25:47.557Z,1683840347.557 [WetLabsBB2FL](INFO): Powering up
2023-05-11T21:25:47.558Z,1683840347.558 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 943
2023-05-11T21:25:47.567Z,1683840347.567 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-05-11T21:25:47.567Z,1683840347.567 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-05-11T21:25:47.567Z,1683840347.567 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-05-11T21:25:47.567Z,1683840347.567 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-05-11T21:25:47.567Z,1683840347.567 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-05-11T21:25:47.567Z,1683840347.567 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-05-11T21:25:47.568Z,1683840347.568 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-05-11T21:25:47.568Z,1683840347.568 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-05-11T21:25:47.573Z,1683840347.573 [CBIT](DEBUG): Deactivating GF circuits.
2023-05-11T21:25:47.573Z,1683840347.573 [CBIT](DEBUG): Deactivating emergency mode.
2023-05-11T21:25:47.613Z,1683840347.613 [CBIT](DEBUG): Backplane powered.
2023-05-11T21:25:47.614Z,1683840347.614 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-05-11T21:25:47.653Z,1683840347.653 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-11T21:25:47.664Z,1683840347.664 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2023-05-11T21:25:47.665Z,1683840347.665 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-05-11T21:25:47.749Z,1683840347.749 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-05-11T21:25:47.752Z,1683840347.752 [Default:A.Wait](DEBUG): Construct Wait.
2023-05-11T21:25:47.766Z,1683840347.766 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-11T21:25:47.790Z,1683840347.790 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-05-11T21:25:47.792Z,1683840347.792 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-05-11T21:25:47.826Z,1683840347.826 [Default:E.Execute](DEBUG): Construct Execute.
2023-05-11T21:25:47.842Z,1683840347.842 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2023-05-11T21:25:47.847Z,1683840347.847 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-05-11T21:25:47.874Z,1683840347.874 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-05-11T21:25:47.933Z,1683840347.933 [Radio_Surface](INFO): Powering up
2023-05-11T21:25:48.042Z,1683840348.042 [Power24vConverter](INFO): Powering up.
2023-05-11T21:25:48.083Z,1683840348.083 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-05-11T21:25:48.089Z,1683840348.089 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-05-11T21:25:48.090Z,1683840348.090 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-05-11T21:25:48.097Z,1683840348.097 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-05-11T21:25:48.098Z,1683840348.098 [MassServo](DEBUG): Initializing EZServoServo.
2023-05-11T21:25:48.105Z,1683840348.105 [MassServo](DEBUG): Initializing MassServo.
2023-05-11T21:25:48.106Z,1683840348.106 [RudderServo](DEBUG): Initializing EZServoServo.
2023-05-11T21:25:48.113Z,1683840348.113 [RudderServo](DEBUG): Initializing RudderServo.
2023-05-11T21:25:48.114Z,1683840348.114 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-05-11T21:25:48.121Z,1683840348.121 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-05-11T21:25:48.294Z,1683840348.294 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-05-11T21:25:48.294Z,1683840348.294 [DropWeight] Hardware Fault, FailCount= 1
2023-05-11T21:25:48.294Z,1683840348.294 [DropWeight](ERROR): Hardware Fault
2023-05-11T21:25:48.320Z,1683840348.320 [CommandExec](FAULT): Scheduling is paused
2023-05-11T21:25:48.320Z,1683840348.320 [CBIT](INFO): Critical error at 20230511T212548
2023-05-11T21:25:48.320Z,1683840348.320 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-05-11T21:25:48.331Z,1683840348.331 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-05-11T21:25:48.331Z,1683840348.332 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-05-11T21:25:48.683Z,1683840348.683 [CBIT](INFO): Critical error at 20230511T212548
2023-05-11T21:25:50.169Z,1683840350.169 [WetLabsBB2FL](INFO): Powering down
2023-05-11T21:25:53.606Z,1683840353.606 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-05-11T21:25:59.897Z,1683840359.897 [DAT](INFO): DAT read: 

2023-05-11T21:25:59.899Z,1683840359.899 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2023-05-11T21:26:01.662Z,1683840361.662 [DAT](INFO): DAT read: MF Frequency Band

2023-05-11T21:26:01.663Z,1683840361.663 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2023-05-11T21:26:01.664Z,1683840361.664 [DAT](INFO): DAT read: May 11 2023 21:25:45 

2023-05-11T21:26:02.670Z,1683840362.670 [DAT](INFO): DAT read: Features enabled [Bearing]

2023-05-11T21:26:02.671Z,1683840362.671 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2023-05-11T21:26:02.671Z,1683840362.671 [DAT](INFO): commRate: 800
2023-05-11T21:26:04.737Z,1683840364.737 [DAT](INFO): entering command mode
2023-05-11T21:26:04.937Z,1683840364.937 [DAT](INFO): DAT read: 

2023-05-11T21:26:04.938Z,1683840364.938 [DAT](INFO): DAT read: user:1>

2023-05-11T21:26:04.938Z,1683840364.938 [DAT](INFO): setting verbose to 3
2023-05-11T21:26:05.189Z,1683840365.189 [DAT](INFO): DAT read: user:1>

2023-05-11T21:26:05.190Z,1683840365.190 [DAT](INFO): DAT read: Verbose         | 3           

2023-05-11T21:26:05.191Z,1683840365.191 [DAT](INFO): set verbose to 3
2023-05-11T21:26:05.191Z,1683840365.191 [DAT](INFO): setting DatVerbose to 27440
2023-05-11T21:26:05.441Z,1683840365.441 [DAT](INFO): DAT read: user:2>

2023-05-11T21:26:05.442Z,1683840365.442 [DAT](INFO): DAT read: DatVerbose      | 27440       

2023-05-11T21:26:05.443Z,1683840365.443 [DAT](INFO): set DatVerbose to 27440
2023-05-11T21:26:05.443Z,1683840365.443 [DAT](INFO): setting transmit power to 8
2023-05-11T21:26:05.693Z,1683840365.693 [DAT](INFO): DAT read: user:3>

2023-05-11T21:26:05.694Z,1683840365.694 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2023-05-11T21:26:05.695Z,1683840365.695 [DAT](INFO): set transmit power to 8
2023-05-11T21:26:05.695Z,1683840365.695 [DAT](INFO): setting local address to 11
2023-05-11T21:26:05.945Z,1683840365.945 [DAT](INFO): DAT read: user:4>

2023-05-11T21:26:05.946Z,1683840365.946 [DAT](INFO): DAT read: LocalAddr       | 11          

2023-05-11T21:26:05.947Z,1683840365.947 [DAT](INFO): set local address to 11
2023-05-11T21:26:05.948Z,1683840365.948 [DAT](INFO): Setting time to: 21:26:5 And date to:5/11/2023
2023-05-11T21:26:06.197Z,1683840366.197 [DAT](INFO): DAT read: user:5>

2023-05-11T21:26:06.198Z,1683840366.198 [DAT](INFO): DAT read: Thu May 11, 2023  21:26:05  

2023-05-11T21:26:06.199Z,1683840366.199 [DAT](INFO): Local DAT time set to Thu May 11, 2023  21:26:05  

2023-05-11T21:26:16.163Z,1683840376.163 [NAL9602](INFO): Powering up NAL9602
2023-05-11T21:26:27.067Z,1683840387.067 [NAL9602](INFO): NAL9602 initialized
2023-05-11T21:28:02.024Z,1683840482.024 [SBIT](IMPORTANT): Beginning Startup BIT
2023-05-11T21:28:02.029Z,1683840482.029 [CBIT](IMPORTANT): Beginning ground fault scan
2023-05-11T21:28:07.678Z,1683840487.678 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2023-05-11T21:28:07.678Z,1683840487.678 [DVL_micro](ERROR): Failed to parse:
:TS,00000000000000,35.0,+21.7,0000.0,1489.0,,+02389,-01996,+00985,+00BI,+02389,-01996,+00985,+00000,I
2023-05-11T21:28:07.815Z,1683840487.815 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005016
2023-05-11T21:28:12.953Z,1683840492.953 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.004129
CHAN A1 (24V): -0.002491
CHAN A2 (12V): -0.000866
CHAN A3 (5V): 0.000950
CHAN B0 (3.3V): 0.000518
CHAN B1 (3.15aV): -0.000187
CHAN B2 (3.15bV): 0.001192
CHAN B3 (GND): 0.000655
OPEN: -0.003914
Full Scale: +/- 1 mA
2023-05-11T21:28:47.703Z,1683840527.703 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-05-11T21:28:47.704Z,1683840527.704 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:28:47.748Z,1683840527.748 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:28:48.126Z,1683840528.126 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:28:48.126Z,1683840528.126 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-05-11T21:28:55.058Z,1683840535.058 [DAT](INFO): DAT read: user:6>Lowpower

2023-05-11T21:28:55.059Z,1683840535.059 [DAT](DEBUG): Re-entering command mode due to deviceResponse_: user:6>Lowpower

2023-05-11T21:28:56.153Z,1683840536.153 [SBIT](IMPORTANT): SBIT PASSED
2023-05-11T21:28:56.153Z,1683840536.153 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-05-11T21:28:56.154Z,1683840536.154 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=12 count;

2023-05-11T21:28:56.154Z,1683840536.154 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum;

2023-05-11T21:28:56.154Z,1683840536.154 [SBIT](IMPORTANT): Depth_Keller.offset=3.6 decibar;

2023-05-11T21:28:56.154Z,1683840536.155 [SBIT](IMPORTANT): Express none CBIT.ampHoursUsed;

2023-05-11T21:28:56.155Z,1683840536.155 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_salinity_homogeneity_index 0.050000 practical_salinity_unit;

2023-05-11T21:28:56.155Z,1683840536.155 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_temperature_homogeneity_index 0.050000 celsius;

2023-05-11T21:28:56.155Z,1683840536.155 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;

2023-05-11T21:28:56.155Z,1683840536.155 [SBIT](IMPORTANT): Express none height_above_sea_floor;

2023-05-11T21:28:56.155Z,1683840536.155 [SBIT](IMPORTANT): StratificationFrontDetector.loadAtStartup=1 bool;

2023-05-11T21:28:56.155Z,1683840536.155 [SBIT](IMPORTANT): StratificationFrontDetector.threshold_VTHI=0.1 celsius;

2023-05-11T21:28:56.155Z,1683840536.155 [SBIT](IMPORTANT): StratificationFrontDetector.verbosity=1 count;

2023-05-11T21:28:56.155Z,1683840536.155 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=208.617815 cubic_centimeter;

2023-05-11T21:28:56.156Z,1683840536.156 [SBIT](IMPORTANT): VerticalControl.massDefault=28.688721 millimeter;

2023-05-11T21:28:56.156Z,1683840536.156 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-28 millimeter;

2023-05-11T21:28:56.156Z,1683840536.156 [SBIT](IMPORTANT): VerticalControl.massPositionLimitFwd=32 millimeter;

2023-05-11T21:28:56.156Z,1683840536.156 [SBIT](IMPORTANT): VerticalControl.surfaceThreshold=1.5 meter;

2023-05-11T21:28:56.156Z,1683840536.156 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth1=3 meter;

2023-05-11T21:28:56.156Z,1683840536.156 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth2=5 meter;

2023-05-11T21:28:56.156Z,1683840536.156 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=10 meter;

2023-05-11T21:28:56.156Z,1683840536.156 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=15 meter;

2023-05-11T21:28:56.157Z,1683840536.157 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.loadAtStartup=1 bool;

2023-05-11T21:28:56.559Z,1683840536.559 [MissionManager](IMPORTANT): Started mission Startup
2023-05-11T21:28:56.560Z,1683840536.560 [Startup] Running Loop=1
2023-05-11T21:28:56.560Z,1683840536.560 [Startup](DEBUG): Aggregate::initialize Startup
2023-05-11T21:28:56.560Z,1683840536.560 [Startup:A.GoToSurface] Running Loop=1
2023-05-11T21:28:56.560Z,1683840536.560 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-11T21:28:56.560Z,1683840536.560 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-11T21:28:56.561Z,1683840536.561 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-11T21:28:56.561Z,1683840536.561 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-11T21:28:56.562Z,1683840536.562 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-11T21:28:56.562Z,1683840536.562 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-11T21:28:56.563Z,1683840536.563 [Startup:StartupSatComms] Running Loop=1
2023-05-11T21:28:56.564Z,1683840536.564 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-05-11T21:28:56.564Z,1683840536.564 [Startup:StartupSatComms:A] Running Loop=1
2023-05-11T21:28:56.957Z,1683840536.957 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-05-11T21:29:56.824Z,1683840596.824 [Startup:StartupSatComms:A](INFO): Timed out from 2023-05-11T21:28:56.6Z
2023-05-11T21:29:56.824Z,1683840596.824 [Startup:StartupSatComms:A] Stopped
2023-05-11T21:29:56.824Z,1683840596.824 [Startup:StartupSatComms:B] Running Loop=1
2023-05-11T21:29:57.152Z,1683840597.152 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-05-11T21:30:03.551Z,1683840603.551 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20230511T201355/Courier0007.lzma
2023-05-11T21:30:04.552Z,1683840604.552 [DataOverHttps](INFO): Moved sent file to Logs/20230511T201355/Courier0007.lzma.bak
2023-05-11T21:30:04.552Z,1683840604.552 [DataOverHttps](INFO): SBD MOMSN=18291088
2023-05-11T21:30:19.380Z,1683840619.380 [DVL_micro](ERROR): Failed to parse:
:SA,-01.73,+01.08,296.1
2023-05-11T21:30:20.203Z,1683840620.203 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20230511T210725/Courier0000.lzma
2023-05-11T21:30:21.203Z,1683840621.203 [DataOverHttps](INFO): Moved sent file to Logs/20230511T210725/Courier0000.lzma.bak
2023-05-11T21:30:21.204Z,1683840621.204 [DataOverHttps](INFO): SBD MOMSN=18291092
2023-05-11T21:30:36.915Z,1683840636.915 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230511T210725/Courier0004.lzma
2023-05-11T21:30:37.915Z,1683840637.915 [DataOverHttps](INFO): Moved sent file to Logs/20230511T210725/Courier0004.lzma.bak
2023-05-11T21:30:37.916Z,1683840637.916 [DataOverHttps](INFO): SBD MOMSN=18291099
2023-05-11T21:30:56.941Z,1683840656.941 [Startup:StartupSatComms:B](INFO): Timed out from 2023-05-11T21:29:56.8Z
2023-05-11T21:30:56.941Z,1683840656.941 [Startup:StartupSatComms:B] Stopped
2023-05-11T21:30:56.941Z,1683840656.941 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-05-11T21:30:56.950Z,1683840656.950 [Startup:StartupSatComms] Stopped
2023-05-11T21:30:56.950Z,1683840656.950 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-05-11T21:30:56.951Z,1683840656.951 [Startup](INFO): Completed Startup
2023-05-11T21:30:56.951Z,1683840656.951 [MissionManager](INFO): Startup is completed.
2023-05-11T21:30:56.951Z,1683840656.951 [MissionManager](INFO): Uninitializing Mission Startup
2023-05-11T21:30:56.951Z,1683840656.951 [Startup] Stopped
2023-05-11T21:30:56.951Z,1683840656.951 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-05-11T21:30:56.951Z,1683840656.951 [Startup:A.GoToSurface] Stopped
2023-05-11T21:30:56.951Z,1683840656.951 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-11T21:30:57.331Z,1683840657.331 [MissionManager](IMPORTANT): Started mission Default
2023-05-11T21:30:57.331Z,1683840657.331 [Default] Running Loop=1
2023-05-11T21:30:57.332Z,1683840657.332 [Default](DEBUG): Aggregate::initialize Default
2023-05-11T21:30:57.332Z,1683840657.332 [Default:B.GoToSurface] Running Loop=1
2023-05-11T21:30:57.332Z,1683840657.332 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-11T21:30:57.332Z,1683840657.332 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-11T21:30:57.332Z,1683840657.332 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-11T21:30:57.333Z,1683840657.333 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-11T21:30:57.333Z,1683840657.333 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-11T21:30:57.333Z,1683840657.333 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-11T21:30:57.367Z,1683840657.367 [Default:A.Wait] Running Loop=1
2023-05-11T21:30:57.367Z,1683840657.367 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-05-11T21:30:58.499Z,1683840658.499 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230511T210725/Courier0007.lzma
2023-05-11T21:30:59.428Z,1683840659.428 [DataOverHttps](INFO): Moved sent file to Logs/20230511T210725/Courier0007.lzma.bak
2023-05-11T21:30:59.428Z,1683840659.428 [DataOverHttps](INFO): SBD MOMSN=18291104
2023-05-11T21:31:10.656Z,1683840670.656 [Default:A.Wait](INFO): Done Waiting.
2023-05-11T21:31:10.656Z,1683840670.656 [Default:A.Wait] Stopped
2023-05-11T21:31:10.656Z,1683840670.656 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-05-11T21:31:11.068Z,1683840671.068 [Default:CheckIn] Running Loop=1
2023-05-11T21:31:11.068Z,1683840671.068 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-11T21:31:11.068Z,1683840671.068 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-11T21:31:11.476Z,1683840671.476 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-05-11T21:31:30.848Z,1683840690.848 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-05-11T21:31:48.650Z,1683840708.650 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-05-11T21:31:48.650Z,1683840708.650 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:31:48.661Z,1683840708.661 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:31:49.064Z,1683840709.064 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:31:49.064Z,1683840709.064 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-05-11T21:31:53.458Z,1683840713.458 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:32:08.408Z,1683840728.408 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:32:23.355Z,1683840743.355 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:32:38.302Z,1683840758.302 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:32:52.846Z,1683840772.846 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:33:07.800Z,1683840787.800 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:33:22.338Z,1683840802.338 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:33:36.883Z,1683840816.883 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:33:51.830Z,1683840831.830 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:34:06.395Z,1683840846.395 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:34:21.354Z,1683840861.354 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:34:49.665Z,1683840889.665 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-05-11T21:34:49.665Z,1683840889.665 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:34:49.676Z,1683840889.676 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:34:50.083Z,1683840890.083 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:34:50.083Z,1683840890.083 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-05-11T21:35:07.414Z,1683840907.414 [DVL_micro](ERROR): Failed to parse:
:WI,+00951,+00066,+01755,+00000,A
2023-05-11T21:36:11.259Z,1683840971.259 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-11T21:31:11.1Z
2023-05-11T21:36:11.259Z,1683840971.259 [Default:CheckIn:Read_GPS] Stopped
2023-05-11T21:36:11.259Z,1683840971.259 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-05-11T21:36:11.653Z,1683840971.653 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-05-11T21:36:18.825Z,1683840978.825 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20230511T212536/Courier0000.lzma
2023-05-11T21:36:19.828Z,1683840979.828 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Courier0000.lzma.bak
2023-05-11T21:36:19.828Z,1683840979.828 [DataOverHttps](INFO): SBD MOMSN=18291615
2023-05-11T21:36:28.621Z,1683840988.621 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-11T21:36:28.621Z,1683840988.621 [NAL9602] Data Fault, FailCount= 1
2023-05-11T21:36:28.621Z,1683840988.621 [NAL9602](ERROR): Data Fault
2023-05-11T21:36:28.639Z,1683840988.639 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-11T21:36:29.016Z,1683840989.016 [NAL9602](INFO): Powering down
2023-05-11T21:36:29.840Z,1683840989.840 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-11T21:36:29.841Z,1683840989.841 [NAL9602] No Fault, FailCount= 1
2023-05-11T21:36:35.449Z,1683840995.449 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230511T212536/Courier0004.lzma
2023-05-11T21:36:36.451Z,1683840996.451 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Courier0004.lzma.bak
2023-05-11T21:36:36.452Z,1683840996.452 [DataOverHttps](INFO): SBD MOMSN=18291620
2023-05-11T21:36:52.743Z,1683841012.743 [DataOverHttps](INFO): Sending 192 bytes from file Logs/20230508T222140/Express0011.lzma
2023-05-11T21:36:53.743Z,1683841013.743 [DataOverHttps](INFO): Moved sent file to Logs/20230508T222140/Express0011.lzma.bak
2023-05-11T21:36:53.744Z,1683841013.744 [DataOverHttps](INFO): SBD MOMSN=18291622
2023-05-11T21:36:59.321Z,1683841019.321 [NAL9602](INFO): Powering up NAL9602
2023-05-11T21:37:09.335Z,1683841029.335 [DataOverHttps](INFO): Sending 450 bytes from file Logs/20230511T182922/Express0001.lzma
2023-05-11T21:37:10.223Z,1683841030.223 [NAL9602](INFO): NAL9602 initialized
2023-05-11T21:37:10.335Z,1683841030.335 [DataOverHttps](INFO): Moved sent file to Logs/20230511T182922/Express0001.lzma.bak
2023-05-11T21:37:10.336Z,1683841030.336 [DataOverHttps](INFO): SBD MOMSN=18291627
2023-05-11T21:37:27.437Z,1683841047.437 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230511T183633/Express0001.lzma
2023-05-11T21:37:28.439Z,1683841048.439 [DataOverHttps](INFO): Moved sent file to Logs/20230511T183633/Express0001.lzma.bak
2023-05-11T21:37:28.440Z,1683841048.440 [DataOverHttps](INFO): SBD MOMSN=18291638
2023-05-11T21:37:44.124Z,1683841064.124 [DataOverHttps](INFO): Sending 1294 bytes from file Logs/20230511T184149/Express0001.lzma
2023-05-11T21:37:45.124Z,1683841065.124 [DataOverHttps](INFO): Moved sent file to Logs/20230511T184149/Express0001.lzma.bak
2023-05-11T21:37:45.124Z,1683841065.124 [DataOverHttps](INFO): SBD MOMSN=18291640
2023-05-11T21:37:50.643Z,1683841070.643 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-05-11T21:37:50.643Z,1683841070.643 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:37:50.686Z,1683841070.686 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:37:51.060Z,1683841071.060 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:37:51.060Z,1683841071.060 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-05-11T21:38:00.715Z,1683841080.715 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20230511T184149/Express0005.lzma
2023-05-11T21:38:01.716Z,1683841081.716 [DataOverHttps](INFO): Moved sent file to Logs/20230511T184149/Express0005.lzma.bak
2023-05-11T21:38:01.716Z,1683841081.716 [DataOverHttps](INFO): SBD MOMSN=18291680
2023-05-11T21:38:17.492Z,1683841097.492 [DataOverHttps](INFO): Sending 643 bytes from file Logs/20230511T184149/Express0008.lzma
2023-05-11T21:38:18.491Z,1683841098.491 [DataOverHttps](INFO): Moved sent file to Logs/20230511T184149/Express0008.lzma.bak
2023-05-11T21:38:18.492Z,1683841098.492 [DataOverHttps](INFO): SBD MOMSN=18291687
2023-05-11T21:38:34.204Z,1683841114.204 [DataOverHttps](INFO): Sending 1291 bytes from file Logs/20230511T201355/Express0001.lzma
2023-05-11T21:38:35.203Z,1683841115.203 [DataOverHttps](INFO): Moved sent file to Logs/20230511T201355/Express0001.lzma.bak
2023-05-11T21:38:35.204Z,1683841115.204 [DataOverHttps](INFO): SBD MOMSN=18291743
2023-05-11T21:38:50.831Z,1683841130.831 [DataOverHttps](INFO): Sending 299 bytes from file Logs/20230511T201355/Express0005.lzma
2023-05-11T21:38:59.226Z,1683841139.226 [DataOverHttps](INFO): Sending 299 bytes from file Logs/20230511T201355/Express0005.lzma
2023-05-11T21:39:00.227Z,1683841140.227 [DataOverHttps](INFO): Moved sent file to Logs/20230511T201355/Express0005.lzma.bak
2023-05-11T21:39:00.228Z,1683841140.228 [DataOverHttps](INFO): SBD MOMSN=18291783
2023-05-11T21:39:15.923Z,1683841155.923 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20230511T201355/Express0008.lzma
2023-05-11T21:39:16.923Z,1683841156.923 [DataOverHttps](INFO): Moved sent file to Logs/20230511T201355/Express0008.lzma.bak
2023-05-11T21:39:16.924Z,1683841156.924 [DataOverHttps](INFO): SBD MOMSN=18291799
2023-05-11T21:39:33.831Z,1683841173.831 [DataOverHttps](INFO): Sending 1215 bytes from file Logs/20230511T210725/Express0001.lzma
2023-05-11T21:39:34.831Z,1683841174.831 [DataOverHttps](INFO): Moved sent file to Logs/20230511T210725/Express0001.lzma.bak
2023-05-11T21:39:34.832Z,1683841174.832 [DataOverHttps](INFO): SBD MOMSN=18291844
2023-05-11T21:39:50.394Z,1683841190.394 [DataOverHttps](INFO): Sending 296 bytes from file Logs/20230511T210725/Express0005.lzma
2023-05-11T21:39:51.395Z,1683841191.395 [DataOverHttps](INFO): Moved sent file to Logs/20230511T210725/Express0005.lzma.bak
2023-05-11T21:39:51.396Z,1683841191.396 [DataOverHttps](INFO): SBD MOMSN=18291881
2023-05-11T21:40:07.141Z,1683841207.141 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20230511T210725/Express0008.lzma
2023-05-11T21:40:08.143Z,1683841208.143 [DataOverHttps](INFO): Moved sent file to Logs/20230511T210725/Express0008.lzma.bak
2023-05-11T21:40:08.144Z,1683841208.144 [DataOverHttps](INFO): SBD MOMSN=18291891
2023-05-11T21:40:24.312Z,1683841224.312 [DataOverHttps](INFO): Sending 1153 bytes from file Logs/20230511T212536/Express0001.lzma
2023-05-11T21:40:25.299Z,1683841225.299 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Express0001.lzma.bak
2023-05-11T21:40:25.300Z,1683841225.300 [DataOverHttps](INFO): SBD MOMSN=18291895
2023-05-11T21:40:41.014Z,1683841241.014 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20230511T212536/Express0005.lzma
2023-05-11T21:40:42.016Z,1683841242.016 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Express0005.lzma.bak
2023-05-11T21:40:42.016Z,1683841242.016 [DataOverHttps](INFO): SBD MOMSN=18291929
2023-05-11T21:40:44.420Z,1683841244.420 [Default:CheckIn:Read_Iridium] Stopped
2023-05-11T21:40:44.420Z,1683841244.420 [Default:CheckIn:C.Wait] Running Loop=1
2023-05-11T21:40:44.420Z,1683841244.420 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-11T21:40:48.657Z,1683841248.657 [CBIT](INFO): Clearing failed state for component DropWeight
2023-05-11T21:40:48.658Z,1683841248.658 [DropWeight] No Fault, FailCount= 1
2023-05-11T21:40:51.798Z,1683841251.798 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-05-11T21:40:51.798Z,1683841251.798 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:40:51.850Z,1683841251.850 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:40:52.190Z,1683841252.190 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:40:52.190Z,1683841252.190 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-05-11T21:41:50.691Z,1683841310.691 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:41:55.943Z,1683841315.943 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:42:10.487Z,1683841330.487 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:42:25.044Z,1683841345.044 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:42:27.508Z,1683841347.508 [DVL_micro](ERROR): Failed to parse:
:WI,-00154,-01034,+01539,+00000,A
2023-05-11T21:42:39.987Z,1683841359.987 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:42:54.530Z,1683841374.530 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:43:09.478Z,1683841389.478 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:43:24.022Z,1683841404.022 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:43:38.970Z,1683841418.970 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:43:52.727Z,1683841432.727 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-05-11T21:43:52.727Z,1683841432.727 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:43:52.738Z,1683841432.738 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:43:53.153Z,1683841433.153 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:43:53.153Z,1683841433.153 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-05-11T21:43:53.919Z,1683841433.919 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:44:09.275Z,1683841449.275 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:44:52.971Z,1683841492.971 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2023-05-11T21:44:52.971Z,1683841492.971 [DVL_micro](ERROR): Failed to parse:
:TS,00000000000000,35.0,+21.8,00000,000
2023-05-11T21:45:45.060Z,1683841545.060 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-05-11T21:45:45.060Z,1683841545.060 [Default:CheckIn:C.Wait] Stopped
2023-05-11T21:45:45.060Z,1683841545.060 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-11T21:45:45.060Z,1683841545.060 [Default:CheckIn:D] Running Loop=1
2023-05-11T21:45:45.453Z,1683841545.453 [Default:CheckIn:D] Stopped
2023-05-11T21:45:45.453Z,1683841545.453 [Default:CheckIn:E] Running Loop=1
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 14.802017 min 
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn:E] Stopped
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn] Stopped
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn](INFO): Running loop #2
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn] Running Loop=2
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-11T21:45:45.846Z,1683841545.846 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-11T21:46:53.735Z,1683841613.735 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-05-11T21:46:53.735Z,1683841613.735 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:46:53.758Z,1683841613.758 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:46:54.173Z,1683841614.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:46:54.173Z,1683841614.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-05-11T21:47:11.080Z,1683841631.080 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-11T21:47:11.080Z,1683841631.080 [NAL9602] Data Fault, FailCount= 2
2023-05-11T21:47:11.080Z,1683841631.080 [NAL9602](ERROR): Data Fault
2023-05-11T21:47:11.099Z,1683841631.099 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-11T21:47:11.483Z,1683841631.483 [NAL9602](INFO): Powering down
2023-05-11T21:47:12.321Z,1683841632.321 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-11T21:47:12.321Z,1683841632.321 [NAL9602] No Fault, FailCount= 2
2023-05-11T21:47:41.780Z,1683841661.780 [NAL9602](INFO): Powering up NAL9602
2023-05-11T21:47:52.696Z,1683841672.696 [NAL9602](INFO): NAL9602 initialized
2023-05-11T21:49:54.708Z,1683841794.708 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-05-11T21:49:54.708Z,1683841794.708 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:49:54.746Z,1683841794.746 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:49:55.121Z,1683841795.121 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:49:55.121Z,1683841795.121 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-05-11T21:50:46.012Z,1683841846.012 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-11T21:45:45.8Z
2023-05-11T21:50:46.013Z,1683841846.013 [Default:CheckIn:Read_GPS] Stopped
2023-05-11T21:50:46.013Z,1683841846.013 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-05-11T21:50:57.401Z,1683841857.401 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230511T212536/Courier0007.lzma
2023-05-11T21:50:58.403Z,1683841858.403 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Courier0007.lzma.bak
2023-05-11T21:50:58.404Z,1683841858.404 [DataOverHttps](INFO): SBD MOMSN=18292015
2023-05-11T21:51:07.020Z,1683841867.020 [DVL_micro](ERROR): only read 3 of 4 data items
2023-05-11T21:51:07.020Z,1683841867.020 [DVL_micro](ERROR): Failed to parse:
:BI,+01581,-0099,+00000,I
2023-05-11T21:51:18.573Z,1683841878.573 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20230511T212536/Express0008.lzma
2023-05-11T21:51:19.576Z,1683841879.576 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Express0008.lzma.bak
2023-05-11T21:51:19.576Z,1683841879.576 [DataOverHttps](INFO): SBD MOMSN=18292017
2023-05-11T21:51:21.609Z,1683841881.609 [Default:CheckIn:Read_Iridium] Stopped
2023-05-11T21:51:21.609Z,1683841881.609 [Default:CheckIn:C.Wait] Running Loop=1
2023-05-11T21:51:21.609Z,1683841881.609 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-11T21:51:47.820Z,1683841907.819 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:51:53.078Z,1683841913.078 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:52:08.032Z,1683841928.033 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:52:22.978Z,1683841942.978 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:52:38.318Z,1683841958.318 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:52:53.266Z,1683841973.266 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:52:55.708Z,1683841975.708 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-05-11T21:52:55.708Z,1683841975.708 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:52:55.719Z,1683841975.719 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:52:56.120Z,1683841976.120 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:52:56.120Z,1683841976.120 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-05-11T21:53:08.215Z,1683841988.215 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:53:22.758Z,1683842002.758 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:53:37.711Z,1683842017.711 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:53:52.251Z,1683842032.251 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:54:07.202Z,1683842047.202 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-11T21:54:37.101Z,1683842077.101 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-05-11T21:55:56.719Z,1683842156.719 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-05-11T21:55:56.720Z,1683842156.720 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:55:56.730Z,1683842156.730 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:55:57.133Z,1683842157.133 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:55:57.133Z,1683842157.133 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-05-11T21:56:22.176Z,1683842182.176 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-05-11T21:56:22.176Z,1683842182.176 [Default:CheckIn:C.Wait] Stopped
2023-05-11T21:56:22.176Z,1683842182.176 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-11T21:56:22.176Z,1683842182.176 [Default:CheckIn:D] Running Loop=1
2023-05-11T21:56:22.561Z,1683842182.561 [Default:CheckIn:D] Stopped
2023-05-11T21:56:22.561Z,1683842182.561 [Default:CheckIn:E] Running Loop=1
2023-05-11T21:56:22.987Z,1683842182.987 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.420492 min 
2023-05-11T21:56:22.987Z,1683842182.987 [Default:CheckIn:E] Stopped
2023-05-11T21:56:22.987Z,1683842182.987 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-05-11T21:56:22.988Z,1683842182.988 [Default:CheckIn] Stopped
2023-05-11T21:56:22.988Z,1683842182.988 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-11T21:56:22.988Z,1683842182.988 [Default:CheckIn](INFO): Running loop #3
2023-05-11T21:56:22.988Z,1683842182.988 [Default:CheckIn] Running Loop=3
2023-05-11T21:56:22.988Z,1683842182.988 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-11T21:56:22.988Z,1683842182.988 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-11T21:56:48.395Z,1683842208.395 [BPC1](INFO): Calculating totals. Valid battery stick count: 27. Valid reserve battery stick count: 3.
2023-05-11T21:56:48.399Z,1683842208.399 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2023-05-11T21:56:53.256Z,1683842213.256 [DVL_micro](ERROR): only read 1 of 4 data items
2023-05-11T21:56:53.256Z,1683842213.256 [DVL_micro](ERROR): Failed to parse:
:BI,+01361+01095,+00000,I
2023-05-11T21:57:53.857Z,1683842273.857 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-11T21:57:53.857Z,1683842273.857 [NAL9602] Data Fault, FailCount= 3
2023-05-11T21:57:53.857Z,1683842273.857 [NAL9602](ERROR): Data Fault
2023-05-11T21:57:53.875Z,1683842273.875 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-11T21:57:54.255Z,1683842274.255 [NAL9602](INFO): Powering down
2023-05-11T21:57:55.082Z,1683842275.082 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-11T21:57:55.082Z,1683842275.082 [NAL9602] No Fault, FailCount= 3
2023-05-11T21:58:24.552Z,1683842304.552 [NAL9602](INFO): Powering up NAL9602
2023-05-11T21:58:35.473Z,1683842315.473 [NAL9602](INFO): NAL9602 initialized
2023-05-11T21:58:57.691Z,1683842337.691 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-05-11T21:58:57.691Z,1683842337.691 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T21:58:57.702Z,1683842337.702 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T21:58:58.160Z,1683842338.160 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T21:58:58.160Z,1683842338.160 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-05-11T22:01:23.146Z,1683842483.146 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-11T21:56:22.0Z
2023-05-11T22:01:23.146Z,1683842483.146 [Default:CheckIn:Read_GPS] Stopped
2023-05-11T22:01:23.146Z,1683842483.146 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-05-11T22:01:30.045Z,1683842490.045 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230511T212536/Courier0010.lzma
2023-05-11T22:01:31.047Z,1683842491.047 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Courier0010.lzma.bak
2023-05-11T22:01:31.047Z,1683842491.047 [DataOverHttps](INFO): SBD MOMSN=18292102
2023-05-11T22:01:43.739Z,1683842503.739 [DVL_micro](ERROR): only read 3 of 4 data items
2023-05-11T22:01:43.739Z,1683842503.739 [DVL_micro](ERROR): Failed to parse:
:BI,+01436,-0251,+00000,I
2023-05-11T22:01:46.609Z,1683842506.609 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230511T212536/Express0011.lzma
2023-05-11T22:01:47.611Z,1683842507.611 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Express0011.lzma.bak
2023-05-11T22:01:47.612Z,1683842507.612 [DataOverHttps](INFO): SBD MOMSN=18292104
2023-05-11T22:01:49.413Z,1683842509.413 [Default:CheckIn:Read_Iridium] Stopped
2023-05-11T22:01:49.413Z,1683842509.413 [Default:CheckIn:C.Wait] Running Loop=1
2023-05-11T22:01:49.413Z,1683842509.413 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-11T22:01:58.729Z,1683842518.729 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-05-11T22:01:58.729Z,1683842518.729 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:01:58.740Z,1683842518.740 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:01:59.157Z,1683842519.157 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:01:59.157Z,1683842519.157 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-05-11T22:04:59.723Z,1683842699.723 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2023-05-11T22:04:59.723Z,1683842699.723 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:04:59.734Z,1683842699.734 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:05:00.124Z,1683842700.124 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:05:00.124Z,1683842700.124 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2023-05-11T22:06:49.984Z,1683842809.984 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-05-11T22:06:49.985Z,1683842809.985 [Default:CheckIn:C.Wait] Stopped
2023-05-11T22:06:49.985Z,1683842809.985 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-11T22:06:49.985Z,1683842809.985 [Default:CheckIn:D] Running Loop=1
2023-05-11T22:06:50.386Z,1683842810.386 [Default:CheckIn:D] Stopped
2023-05-11T22:06:50.386Z,1683842810.386 [Default:CheckIn:E] Running Loop=1
2023-05-11T22:06:50.783Z,1683842810.783 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.884237 min 
2023-05-11T22:06:50.783Z,1683842810.783 [Default:CheckIn:E] Stopped
2023-05-11T22:06:50.783Z,1683842810.783 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-05-11T22:06:50.783Z,1683842810.783 [Default:CheckIn] Stopped
2023-05-11T22:06:50.783Z,1683842810.783 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-11T22:06:50.783Z,1683842810.783 [Default:CheckIn](INFO): Running loop #4
2023-05-11T22:06:50.783Z,1683842810.783 [Default:CheckIn] Running Loop=4
2023-05-11T22:06:50.783Z,1683842810.783 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-11T22:06:50.784Z,1683842810.784 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-11T22:08:00.691Z,1683842880.691 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2023-05-11T22:08:00.691Z,1683842880.691 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:08:00.718Z,1683842880.718 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:08:01.081Z,1683842881.081 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:08:01.081Z,1683842881.081 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2023-05-11T22:08:38.649Z,1683842918.649 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-11T22:08:38.649Z,1683842918.649 [NAL9602] Data Fault, FailCount= 4
2023-05-11T22:08:38.650Z,1683842918.650 [NAL9602](ERROR): Data Fault
2023-05-11T22:08:38.667Z,1683842918.667 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-11T22:08:39.040Z,1683842919.040 [NAL9602](INFO): Powering down
2023-05-11T22:08:39.866Z,1683842919.866 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-11T22:08:39.866Z,1683842919.866 [NAL9602] No Fault, FailCount= 4
2023-05-11T22:09:09.350Z,1683842949.350 [NAL9602](INFO): Powering up NAL9602
2023-05-11T22:09:20.248Z,1683842960.248 [NAL9602](INFO): NAL9602 initialized
2023-05-11T22:10:28.128Z,1683843028.128 [DVL_micro](ERROR): Failed to parse:
99,-01318,+01295,+00000,I
2023-05-11T22:10:50.002Z,1683843050.002 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-05-11T22:10:50.002Z,1683843050.002 [DropWeight] Hardware Fault, FailCount= 1
2023-05-11T22:10:50.002Z,1683843050.002 [DropWeight](ERROR): Hardware Fault
2023-05-11T22:10:50.104Z,1683843050.104 [CBIT](INFO): Critical error at 20230511T221050
2023-05-11T22:10:50.119Z,1683843050.119 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-05-11T22:10:50.119Z,1683843050.119 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-05-11T22:10:50.440Z,1683843050.440 [CBIT](INFO): Critical error at 20230511T221050
2023-05-11T22:11:01.756Z,1683843061.756 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2023-05-11T22:11:01.756Z,1683843061.756 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:11:01.791Z,1683843061.791 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:11:02.142Z,1683843062.142 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:11:02.142Z,1683843062.142 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2023-05-11T22:11:19.093Z,1683843079.093 [DVL_micro](ERROR): only read 2 of 4 data items
2023-05-11T22:11:19.093Z,1683843079.093 [DVL_micro](ERROR): Failed to parse:
:RD,+99999.99,+99999.99
2023-05-11T22:11:51.028Z,1683843111.028 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-11T22:06:50.8Z
2023-05-11T22:11:51.028Z,1683843111.028 [Default:CheckIn:Read_GPS] Stopped
2023-05-11T22:11:51.029Z,1683843111.029 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-05-11T22:11:57.925Z,1683843117.925 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20230511T212536/Courier0013.lzma
2023-05-11T22:11:58.927Z,1683843118.927 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Courier0013.lzma.bak
2023-05-11T22:11:58.928Z,1683843118.928 [DataOverHttps](INFO): SBD MOMSN=18292189
2023-05-11T22:12:15.361Z,1683843135.361 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230511T212536/Express0014.lzma
2023-05-11T22:12:16.367Z,1683843136.367 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Express0014.lzma.bak
2023-05-11T22:12:16.368Z,1683843136.368 [DataOverHttps](INFO): SBD MOMSN=18292203
2023-05-11T22:12:18.100Z,1683843138.100 [Default:CheckIn:Read_Iridium] Stopped
2023-05-11T22:12:18.101Z,1683843138.101 [Default:CheckIn:C.Wait] Running Loop=1
2023-05-11T22:12:18.101Z,1683843138.101 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-11T22:14:02.745Z,1683843242.745 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2023-05-11T22:14:02.745Z,1683843242.745 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:14:02.756Z,1683843242.756 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:14:03.170Z,1683843243.170 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:14:03.170Z,1683843243.170 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2023-05-11T22:16:01.903Z,1683843361.903 [DVL_micro](ERROR): only read 3 of 4 data items
2023-05-11T22:16:01.903Z,1683843361.903 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.99,+9999.99,+9999.999
2023-05-11T22:16:06.755Z,1683843366.755 [DVL_micro](ERROR): Failed to parse:
:SA,-01.71,+01.08,296.3
2023-05-11T22:16:09.165Z,1683843369.165 [DVL_micro](ERROR): No DVL communication! Re-initializing
2023-05-11T22:16:09.165Z,1683843369.165 [DVL_micro] Communications Fault, FailCount= 1
2023-05-11T22:16:09.165Z,1683843369.165 [DVL_micro](ERROR): Communications Fault
2023-05-11T22:16:09.238Z,1683843369.238 [CBIT](ERROR): Communications Fault in component: DVL_micro
2023-05-11T22:16:09.638Z,1683843369.638 [DVL_micro](INFO): Powering down
2023-05-11T22:16:10.415Z,1683843370.415 [CBIT](INFO): Clearing failed state for component DVL_micro
2023-05-11T22:16:10.415Z,1683843370.415 [DVL_micro] No Fault, FailCount= 1
2023-05-11T22:17:03.712Z,1683843423.712 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2023-05-11T22:17:03.712Z,1683843423.712 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:17:03.723Z,1683843423.723 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:17:04.216Z,1683843424.216 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:17:04.216Z,1683843424.216 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2023-05-11T22:17:18.660Z,1683843438.660 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-05-11T22:17:18.661Z,1683843438.661 [Default:CheckIn:C.Wait] Stopped
2023-05-11T22:17:18.661Z,1683843438.661 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-11T22:17:18.661Z,1683843438.661 [Default:CheckIn:D] Running Loop=1
2023-05-11T22:17:19.064Z,1683843439.064 [Default:CheckIn:D] Stopped
2023-05-11T22:17:19.064Z,1683843439.064 [Default:CheckIn:E] Running Loop=1
2023-05-11T22:17:19.497Z,1683843439.497 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.362211 min 
2023-05-11T22:17:19.497Z,1683843439.497 [Default:CheckIn:E] Stopped
2023-05-11T22:17:19.497Z,1683843439.497 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-05-11T22:17:19.497Z,1683843439.497 [Default:CheckIn] Stopped
2023-05-11T22:17:19.497Z,1683843439.497 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-11T22:17:19.498Z,1683843439.498 [Default:CheckIn](INFO): Running loop #5
2023-05-11T22:17:19.498Z,1683843439.498 [Default:CheckIn] Running Loop=5
2023-05-11T22:17:19.498Z,1683843439.498 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-11T22:17:19.498Z,1683843439.498 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-11T22:19:21.489Z,1683843561.489 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-11T22:19:21.489Z,1683843561.489 [NAL9602] Data Fault, FailCount= 5
2023-05-11T22:19:21.489Z,1683843561.489 [NAL9602](ERROR): Data Fault
2023-05-11T22:19:21.507Z,1683843561.507 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-11T22:19:21.507Z,1683843561.507 [CBIT](CRITICAL): Data Fault in component: NAL9602
2023-05-11T22:19:21.868Z,1683843561.868 [NAL9602](INFO): Powering down
2023-05-11T22:19:21.905Z,1683843561.905 [CBIT](INFO): Critical error at 20230511T221921
2023-05-11T22:20:04.706Z,1683843604.706 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2023-05-11T22:20:04.706Z,1683843604.706 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:20:04.719Z,1683843604.719 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:20:05.127Z,1683843605.127 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:20:05.128Z,1683843605.128 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2023-05-11T22:21:21.878Z,1683843681.878 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-11T22:21:21.878Z,1683843681.878 [NAL9602] No Fault, FailCount= 5
2023-05-11T22:21:22.259Z,1683843682.259 [NAL9602](INFO): Powering up NAL9602
2023-05-11T22:21:33.167Z,1683843693.167 [NAL9602](INFO): NAL9602 initialized
2023-05-11T22:22:19.665Z,1683843739.665 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-11T22:17:19.5Z
2023-05-11T22:22:19.665Z,1683843739.665 [Default:CheckIn:Read_GPS] Stopped
2023-05-11T22:22:19.666Z,1683843739.666 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-05-11T22:22:26.897Z,1683843746.897 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20230511T212536/Courier0016.lzma
2023-05-11T22:22:27.899Z,1683843747.899 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Courier0016.lzma.bak
2023-05-11T22:22:27.900Z,1683843747.900 [DataOverHttps](INFO): SBD MOMSN=18292350
2023-05-11T22:22:43.429Z,1683843763.429 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230511T212536/Express0017.lzma
2023-05-11T22:22:45.324Z,1683843765.324 [DataOverHttps](INFO): Moved sent file to Logs/20230511T212536/Express0017.lzma.bak
2023-05-11T22:22:45.324Z,1683843765.324 [DataOverHttps](INFO): SBD MOMSN=18292353
2023-05-11T22:22:46.320Z,1683843766.320 [Default:CheckIn:Read_Iridium] Stopped
2023-05-11T22:22:46.320Z,1683843766.320 [Default:CheckIn:C.Wait] Running Loop=1
2023-05-11T22:22:46.321Z,1683843766.321 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-11T22:23:05.720Z,1683843785.720 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2023-05-11T22:23:05.720Z,1683843785.720 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:23:05.735Z,1683843785.735 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:23:06.106Z,1683843786.106 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:23:06.106Z,1683843786.106 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2023-05-11T22:23:28.733Z,1683843808.733 [DVL_micro](ERROR): only read 3 of 4 data items
2023-05-11T22:23:28.746Z,1683843808.746 [DVL_micro](ERROR): Failed to parse:
:BI,+01163,-02126,+01134,+00BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00
2023-05-11T22:25:50.169Z,1683843950.169 [CBIT](INFO): Clearing failed state for component DropWeight
2023-05-11T22:25:50.169Z,1683843950.169 [DropWeight] No Fault, FailCount= 1
2023-05-11T22:26:06.735Z,1683843966.735 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2023-05-11T22:26:06.735Z,1683843966.735 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:26:06.746Z,1683843966.746 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:26:07.135Z,1683843967.135 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:26:07.135Z,1683843967.135 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2023-05-11T22:27:46.877Z,1683844066.877 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-05-11T22:27:46.877Z,1683844066.877 [Default:CheckIn:C.Wait] Stopped
2023-05-11T22:27:46.877Z,1683844066.877 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-11T22:27:46.877Z,1683844066.877 [Default:CheckIn:D] Running Loop=1
2023-05-11T22:27:47.312Z,1683844067.312 [Default:CheckIn:D] Stopped
2023-05-11T22:27:47.312Z,1683844067.312 [Default:CheckIn:E] Running Loop=1
2023-05-11T22:27:47.709Z,1683844067.709 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.833004 min 
2023-05-11T22:27:47.709Z,1683844067.709 [Default:CheckIn:E] Stopped
2023-05-11T22:27:47.709Z,1683844067.709 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-05-11T22:27:47.709Z,1683844067.709 [Default:CheckIn] Stopped
2023-05-11T22:27:47.709Z,1683844067.709 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-11T22:27:47.710Z,1683844067.710 [Default:CheckIn](INFO): Running loop #6
2023-05-11T22:27:47.710Z,1683844067.710 [Default:CheckIn] Running Loop=6
2023-05-11T22:27:47.710Z,1683844067.710 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-11T22:27:47.710Z,1683844067.710 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-11T22:29:04.850Z,1683844144.850 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2023-05-11T22:29:04.850Z,1683844144.850 [DVL_micro](ERROR): Failed to parse:
:TS0000000,35.0,+22.0,0000.0,1489.0,000
2023-05-11T22:29:07.723Z,1683844147.723 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2023-05-11T22:29:07.723Z,1683844147.723 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-11T22:29:07.734Z,1683844147.734 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-11T22:29:08.125Z,1683844148.125 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-11T22:29:08.125Z,1683844148.125 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2023-05-11T22:29:49.526Z,1683844189.526 [CommandExec](IMPORTANT): got command quit
2023-05-11T22:29:50.530Z,1683844190.530 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:50.530Z,1683844190.530 [CommandExec](INFO): Uninitializing the command executive.
2023-05-11T22:29:50.530Z,1683844190.530 [CommandExec](INFO): Uninitializing the command scheduler.
2023-05-11T22:29:50.530Z,1683844190.530 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:50.622Z,1683844190.622 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-05-11T22:29:50.622Z,1683844190.622 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-05-11T22:29:50.623Z,1683844190.623 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:50.624Z,1683844190.624 [NavChartDb](INFO): Join timeout helper Thread ID is 1010
2023-05-11T22:29:50.794Z,1683844190.794 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:50.794Z,1683844190.794 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:50.806Z,1683844190.806 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-05-11T22:29:50.806Z,1683844190.806 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:50.806Z,1683844190.806 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1011
2023-05-11T22:29:51.070Z,1683844191.070 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:51.070Z,1683844191.070 [WetLabsBB2FL](INFO): Powering down
2023-05-11T22:29:51.071Z,1683844191.071 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:51.074Z,1683844191.074 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-05-11T22:29:51.074Z,1683844191.074 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:51.074Z,1683844191.074 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1012
2023-05-11T22:29:51.586Z,1683844191.586 [CTD_Seabird](INFO): Powering down
2023-05-11T22:29:51.605Z,1683844191.605 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:51.606Z,1683844191.606 [CTD_Seabird](INFO): Powering down
2023-05-11T22:29:51.618Z,1683844191.618 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:51.626Z,1683844191.626 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-05-11T22:29:51.626Z,1683844191.626 [DAT ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:51.626Z,1683844191.626 [DAT](INFO): Join timeout helper Thread ID is 1013
2023-05-11T22:29:51.758Z,1683844191.758 [DAT](INFO): Powering down
2023-05-11T22:29:51.831Z,1683844191.831 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:51.831Z,1683844191.831 [DAT](INFO): Powering down
2023-05-11T22:29:51.832Z,1683844191.832 [DAT ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:51.850Z,1683844191.850 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-05-11T22:29:51.850Z,1683844191.850 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:51.850Z,1683844191.850 [Radio_Surface](INFO): Join timeout helper Thread ID is 1014
2023-05-11T22:29:51.902Z,1683844191.902 [Radio_Surface](INFO): Powering down
2023-05-11T22:29:51.903Z,1683844191.903 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:51.903Z,1683844191.903 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:51.915Z,1683844191.915 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-05-11T22:29:51.915Z,1683844191.915 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:51.915Z,1683844191.915 [Onboard](INFO): Join timeout helper Thread ID is 1015
2023-05-11T22:29:54.794Z,1683844194.794 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:54.794Z,1683844194.794 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:54.810Z,1683844194.810 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-05-11T22:29:54.810Z,1683844194.810 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:54.811Z,1683844194.811 [DataOverHttps](INFO): Join timeout helper Thread ID is 1016
2023-05-11T22:29:55.346Z,1683844195.346 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:55.347Z,1683844195.347 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.363Z,1683844195.363 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-05-11T22:29:55.363Z,1683844195.363 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.363Z,1683844195.363 [BackseatComponent](INFO): Join timeout helper Thread ID is 1017
2023-05-11T22:29:55.502Z,1683844195.502 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:55.502Z,1683844195.502 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.510Z,1683844195.510 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-05-11T22:29:55.511Z,1683844195.511 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.511Z,1683844195.511 [logger](INFO): Join timeout helper Thread ID is 1018
2023-05-11T22:29:55.520Z,1683844195.520 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:55.520Z,1683844195.520 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.530Z,1683844195.530 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-05-11T22:29:55.530Z,1683844195.530 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.531Z,1683844195.531 [CommandLine](INFO): Join timeout helper Thread ID is 1019
2023-05-11T22:29:55.550Z,1683844195.550 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:55.550Z,1683844195.550 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.570Z,1683844195.570 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-05-11T22:29:55.570Z,1683844195.570 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.571Z,1683844195.571 [CommandExec](INFO): Join timeout helper Thread ID is 1020
2023-05-11T22:29:55.576Z,1683844195.576 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-05-11T22:29:55.576Z,1683844195.576 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.577Z,1683844195.577 [controlThread](INFO): Join timeout helper Thread ID is 1021
2023-05-11T22:29:55.730Z,1683844195.730 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-11T22:29:55.730Z,1683844195.730 [controlThread](DEBUG): Uninitializing ControlThread
2023-05-11T22:29:55.730Z,1683844195.730 [AHRS_M2](INFO): Powering down
2023-05-11T22:29:55.874Z,1683844195.874 [DVL_micro](INFO): Powering down
2023-05-11T22:29:55.875Z,1683844195.875 [NAL9602](INFO): Powering down
2023-05-11T22:29:55.878Z,1683844195.878 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-05-11T22:29:55.879Z,1683844195.879 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-05-11T22:29:55.880Z,1683844195.880 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-05-11T22:29:55.880Z,1683844195.880 [MissionManager](INFO): Uninitializing Mission Default
2023-05-11T22:29:55.880Z,1683844195.880 [Default] Stopped
2023-05-11T22:29:55.881Z,1683844195.881 [Default](DEBUG): Aggregate::uninitialize Default
2023-05-11T22:29:55.881Z,1683844195.881 [Default:B.GoToSurface] Stopped
2023-05-11T22:29:55.881Z,1683844195.881 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-11T22:29:55.881Z,1683844195.881 [Default:CheckIn] Stopped
2023-05-11T22:29:55.881Z,1683844195.881 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-11T22:29:55.881Z,1683844195.881 [Default:CheckIn:Read_GPS] Stopped
2023-05-11T22:29:55.884Z,1683844195.884 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-05-11T22:29:55.884Z,1683844195.884 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-05-11T22:29:55.884Z,1683844195.884 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-05-11T22:29:55.885Z,1683844195.885 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-05-11T22:29:55.885Z,1683844195.885 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-05-11T22:29:55.885Z,1683844195.885 [BuoyancyServo](INFO): Powering down
2023-05-11T22:29:55.898Z,1683844195.898 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-05-11T22:29:55.898Z,1683844195.898 [ElevatorServo](INFO): Powering down
2023-05-11T22:29:55.899Z,1683844195.899 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-05-11T22:29:55.899Z,1683844195.899 [MassServo](INFO): Powering down
2023-05-11T22:29:55.900Z,1683844195.900 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-05-11T22:29:55.900Z,1683844195.900 [RudderServo](INFO): Powering down
2023-05-11T22:29:55.901Z,1683844195.901 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-05-11T22:29:55.901Z,1683844195.901 [ThrusterHE](INFO): Powering down
2023-05-11T22:29:55.902Z,1683844195.902 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-05-11T22:29:55.902Z,1683844195.902 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-05-11T22:29:55.902Z,1683844195.902 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-05-11T22:29:55.902Z,1683844195.902 [CBIT](DEBUG): Powering off loads.
2023-05-11T22:29:55.913Z,1683844195.913 [CBIT](DEBUG): Disabling WDT.
2023-05-11T22:29:55.925Z,1683844195.925 [CBIT](DEBUG): Opening all GF detection circuits.
2023-05-11T22:29:55.926Z,1683844195.926 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.970Z,1683844195.970 [DAT ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.975Z,1683844195.975 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.977Z,1683844195.977 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:55.984Z,1683844195.984 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:56.028Z,1683844196.028 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:56.079Z,1683844196.079 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:56.084Z,1683844196.084 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:56.106Z,1683844196.106 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-11T22:29:56.167Z,1683844196.167 [logger ThreadHandler](INFO): Thread cancelled.