2023-02-22T22:27:48.497Z,1677104868.497 [Supervisor](DEBUG): Initializing supervisor.
2023-02-22T22:27:48.502Z,1677104868.502 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-02-22T22:27:48.502Z,1677104868.502 [SyncHandler](INFO): Protected caller Thread ID is 6386
2023-02-22T22:27:48.503Z,1677104868.503 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-02-22T22:27:48.504Z,1677104868.504 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-02-22T22:27:48.504Z,1677104868.504 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6387
2023-02-22T22:27:48.508Z,1677104868.508 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-02-22T22:27:48.525Z,1677104868.525 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-02-22T22:27:48.526Z,1677104868.526 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-02-22T22:27:48.527Z,1677104868.527 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6388
2023-02-22T22:27:48.531Z,1677104868.531 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-02-22T22:27:48.532Z,1677104868.532 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-02-22T22:27:48.532Z,1677104868.532 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6389
2023-02-22T22:27:48.534Z,1677104868.534 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-02-22T22:27:48.535Z,1677104868.535 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-02-22T22:27:48.535Z,1677104868.535 [logger ThreadHandler](INFO): Protected caller Thread ID is 6390
2023-02-22T22:27:48.539Z,1677104868.539 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-02-22T22:27:48.539Z,1677104868.539 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-02-22T22:27:48.541Z,1677104868.541 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-02-22T22:27:48.978Z,1677104868.978 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-02-22T22:27:48.978Z,1677104868.978 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-02-22T22:27:49.178Z,1677104869.178 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-02-22T22:27:49.178Z,1677104869.178 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-02-22T22:27:49.257Z,1677104869.257 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-02-22T22:27:49.465Z,1677104869.465 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-02-22T22:27:49.466Z,1677104869.466 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-02-22T22:27:49.543Z,1677104869.543 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-02-22T22:27:49.634Z,1677104869.634 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-02-22T22:27:49.635Z,1677104869.635 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-02-22T22:27:49.956Z,1677104869.956 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-02-22T22:27:49.957Z,1677104869.957 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-02-22T22:27:50.084Z,1677104870.084 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-02-22T22:27:50.084Z,1677104870.084 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-02-22T22:27:50.550Z,1677104870.550 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-02-22T22:27:50.551Z,1677104870.551 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-02-22T22:27:50.725Z,1677104870.725 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-02-22T22:27:50.725Z,1677104870.725 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-02-22T22:27:51.104Z,1677104871.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-02-22T22:27:51.104Z,1677104871.104 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-02-22T22:27:51.371Z,1677104871.371 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-02-22T22:27:51.372Z,1677104871.372 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-02-22T22:27:51.479Z,1677104871.479 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-02-22T22:27:51.480Z,1677104871.480 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-02-22T22:27:52.195Z,1677104872.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-02-22T22:27:52.196Z,1677104872.196 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-02-22T22:27:52.513Z,1677104872.513 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-02-22T22:27:52.513Z,1677104872.513 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-02-22T22:27:52.723Z,1677104872.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-02-22T22:27:52.725Z,1677104872.725 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2023-02-22T22:27:52.726Z,1677104872.726 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2023-02-22T22:27:52.912Z,1677104872.912 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2023-02-22T22:27:52.993Z,1677104872.993 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2023-02-22T22:27:53.121Z,1677104873.121 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2023-02-22T22:27:53.268Z,1677104873.268 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2023-02-22T22:27:53.975Z,1677104873.975 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-02-22T22:27:53.976Z,1677104873.976 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2023-02-22T22:27:54.078Z,1677104874.078 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2023-02-22T22:27:54.194Z,1677104874.194 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2023-02-22T22:27:54.523Z,1677104874.523 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2023-02-22T22:27:54.661Z,1677104874.661 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2023-02-22T22:27:54.756Z,1677104874.756 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2023-02-22T22:27:54.845Z,1677104874.845 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-02-22T22:27:54.857Z,1677104874.857 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-02-22T22:27:54.868Z,1677104874.868 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-02-22T22:27:54.868Z,1677104874.868 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-02-22T22:27:54.965Z,1677104874.965 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-02-22T22:27:54.966Z,1677104874.966 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-02-22T22:27:55.015Z,1677104875.015 [VerticalControl](DEBUG): Construct VerticalControl.
2023-02-22T22:27:55.073Z,1677104875.073 [VerticalControl] Loaded
2023-02-22T22:27:55.074Z,1677104875.074 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-02-22T22:27:55.076Z,1677104875.076 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-02-22T22:27:55.117Z,1677104875.117 [HorizontalControl] Loaded
2023-02-22T22:27:55.117Z,1677104875.117 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-02-22T22:27:55.119Z,1677104875.119 [SpeedControl](DEBUG): Construct SpeedControl.
2023-02-22T22:27:55.122Z,1677104875.122 [SpeedControl] Loaded
2023-02-22T22:27:55.123Z,1677104875.123 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-02-22T22:27:55.125Z,1677104875.125 [LoopControl](DEBUG): Construct LoopControl.
2023-02-22T22:27:55.126Z,1677104875.126 [LoopControl] Loaded
2023-02-22T22:27:55.126Z,1677104875.126 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-02-22T22:27:55.126Z,1677104875.126 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-02-22T22:27:55.127Z,1677104875.127 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-02-22T22:27:55.254Z,1677104875.254 [BuoyancyServo] Loaded
2023-02-22T22:27:55.254Z,1677104875.254 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-02-22T22:27:55.274Z,1677104875.274 [ElevatorServo] Loaded
2023-02-22T22:27:55.274Z,1677104875.274 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-02-22T22:27:55.293Z,1677104875.293 [MassServo] Loaded
2023-02-22T22:27:55.294Z,1677104875.294 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-02-22T22:27:55.312Z,1677104875.312 [RudderServo] Loaded
2023-02-22T22:27:55.312Z,1677104875.312 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-02-22T22:27:55.326Z,1677104875.326 [ThrusterHE] Loaded
2023-02-22T22:27:55.326Z,1677104875.326 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-02-22T22:27:55.327Z,1677104875.327 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-02-22T22:27:55.327Z,1677104875.327 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-02-22T22:27:55.376Z,1677104875.376 [DepthRateCalculator] Loaded
2023-02-22T22:27:55.377Z,1677104875.377 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-02-22T22:27:55.381Z,1677104875.381 [PitchRateCalculator] Loaded
2023-02-22T22:27:55.382Z,1677104875.382 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-02-22T22:27:55.391Z,1677104875.391 [SpeedCalculator] Loaded
2023-02-22T22:27:55.391Z,1677104875.391 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-02-22T22:27:55.396Z,1677104875.396 [YawRateCalculator] Loaded
2023-02-22T22:27:55.397Z,1677104875.397 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-02-22T22:27:55.414Z,1677104875.414 [ElevatorOffsetCalculator] Loaded
2023-02-22T22:27:55.415Z,1677104875.415 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-02-22T22:27:55.415Z,1677104875.415 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-02-22T22:27:55.416Z,1677104875.416 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-02-22T22:27:55.526Z,1677104875.526 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-02-22T22:27:55.526Z,1677104875.526 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-02-22T22:27:55.540Z,1677104875.540 [NavChart] Loaded
2023-02-22T22:27:55.540Z,1677104875.540 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-02-22T22:27:55.546Z,1677104875.546 [UniversalFixResidualReporter] Loaded
2023-02-22T22:27:55.546Z,1677104875.546 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-02-22T22:27:55.546Z,1677104875.546 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-02-22T22:27:55.547Z,1677104875.547 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-02-22T22:27:55.957Z,1677104875.957 [AHRS_M2] Loaded
2023-02-22T22:27:55.957Z,1677104875.957 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-02-22T22:27:55.991Z,1677104875.991 [BackseatComponent] Loaded
2023-02-22T22:27:55.992Z,1677104875.992 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-02-22T22:27:55.993Z,1677104875.993 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408E04E0
2023-02-22T22:27:55.993Z,1677104875.993 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6472
2023-02-22T22:27:55.996Z,1677104875.996 [LcmUniversalReporter] Loaded
2023-02-22T22:27:55.996Z,1677104875.996 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-02-22T22:27:56.817Z,1677104876.817 [BPC1] Loaded
2023-02-22T22:27:56.817Z,1677104876.817 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-02-22T22:27:56.887Z,1677104876.887 [DataOverHttps] Loaded
2023-02-22T22:27:56.888Z,1677104876.888 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-02-22T22:27:56.889Z,1677104876.889 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409104E0
2023-02-22T22:27:56.889Z,1677104876.889 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6473
2023-02-22T22:27:56.910Z,1677104876.910 [Depth_Keller] Loaded
2023-02-22T22:27:56.910Z,1677104876.910 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-02-22T22:27:56.915Z,1677104876.915 [DropWeight] Loaded
2023-02-22T22:27:56.915Z,1677104876.915 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-02-22T22:27:56.934Z,1677104876.934 [MultiRay] Loaded
2023-02-22T22:27:56.934Z,1677104876.934 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2023-02-22T22:27:56.995Z,1677104876.995 [NAL9602] Loaded
2023-02-22T22:27:56.995Z,1677104876.995 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-02-22T22:27:57.024Z,1677104877.024 [Onboard] Loaded
2023-02-22T22:27:57.025Z,1677104877.025 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-02-22T22:27:57.026Z,1677104877.026 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409404E0
2023-02-22T22:27:57.026Z,1677104877.026 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6474
2023-02-22T22:27:57.038Z,1677104877.038 [Power24vConverter] Loaded
2023-02-22T22:27:57.038Z,1677104877.038 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-02-22T22:27:57.051Z,1677104877.051 [Radio_Surface] Loaded
2023-02-22T22:27:57.052Z,1677104877.052 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-02-22T22:27:57.053Z,1677104877.053 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409704E0
2023-02-22T22:27:57.053Z,1677104877.053 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6475
2023-02-22T22:27:57.144Z,1677104877.144 [DAT] Loaded
2023-02-22T22:27:57.145Z,1677104877.145 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-02-22T22:27:57.145Z,1677104877.145 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409A04E0
2023-02-22T22:27:57.146Z,1677104877.146 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6476
2023-02-22T22:27:57.146Z,1677104877.146 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-02-22T22:27:57.147Z,1677104877.147 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-02-22T22:27:57.202Z,1677104877.202 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-02-22T22:27:57.203Z,1677104877.203 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-02-22T22:27:57.352Z,1677104877.352 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-02-22T22:27:57.353Z,1677104877.353 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-02-22T22:27:57.379Z,1677104877.379 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-02-22T22:27:57.379Z,1677104877.379 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-02-22T22:27:57.545Z,1677104877.545 [CTD_Seabird] Loaded
2023-02-22T22:27:57.545Z,1677104877.545 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-02-22T22:27:57.546Z,1677104877.546 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ACB4E0
2023-02-22T22:27:57.547Z,1677104877.547 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6477
2023-02-22T22:27:57.579Z,1677104877.579 [ESPComponent] Loaded
2023-02-22T22:27:57.579Z,1677104877.579 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-02-22T22:27:57.599Z,1677104877.599 [PAR_Licor] Loaded
2023-02-22T22:27:57.599Z,1677104877.599 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-02-22T22:27:57.630Z,1677104877.630 [WetLabsBB2FL] Loaded
2023-02-22T22:27:57.630Z,1677104877.630 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-02-22T22:27:57.631Z,1677104877.631 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AFB4E0
2023-02-22T22:27:57.631Z,1677104877.631 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6478
2023-02-22T22:27:57.632Z,1677104877.632 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-02-22T22:27:57.633Z,1677104877.633 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-02-22T22:27:57.934Z,1677104877.934 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-02-22T22:27:57.934Z,1677104877.934 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-02-22T22:27:58.070Z,1677104878.070 [SBIT](DEBUG): Construct Startup Built In Test.
2023-02-22T22:27:58.079Z,1677104878.079 [SBIT] Loaded
2023-02-22T22:27:58.080Z,1677104878.080 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-02-22T22:27:58.082Z,1677104878.082 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-02-22T22:27:58.095Z,1677104878.095 [IBIT] Loaded
2023-02-22T22:27:58.095Z,1677104878.095 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-02-22T22:27:58.101Z,1677104878.101 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-02-22T22:27:58.205Z,1677104878.205 [CBIT] Loaded
2023-02-22T22:27:58.205Z,1677104878.205 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-02-22T22:27:58.205Z,1677104878.205 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-02-22T22:27:58.212Z,1677104878.212 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-02-22T22:27:58.214Z,1677104878.214 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-02-22T22:27:58.225Z,1677104878.225 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-02-22T22:27:58.226Z,1677104878.226 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BDE4E0
2023-02-22T22:27:58.227Z,1677104878.227 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6479
2023-02-22T22:27:58.239Z,1677104878.239 [Supervisor](INFO): Main Thread ID is 6385
2023-02-22T22:27:58.239Z,1677104878.239 [Supervisor](DEBUG): Running supervisor.
2023-02-22T22:27:58.240Z,1677104878.240 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6480
2023-02-22T22:27:58.241Z,1677104878.241 [CommandExec](INFO): Initializing the command executive.
2023-02-22T22:27:58.242Z,1677104878.242 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6481
2023-02-22T22:27:58.245Z,1677104878.245 [controlThread ThreadHandler](INFO): Handler Thread ID is 6482
2023-02-22T22:27:58.245Z,1677104878.245 [controlThread](DEBUG): Initializing ControlThread
2023-02-22T22:27:58.246Z,1677104878.246 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-02-22T22:27:58.248Z,1677104878.248 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-02-22T22:27:58.248Z,1677104878.248 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-02-22T22:27:58.249Z,1677104878.249 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-02-22T22:27:58.250Z,1677104878.250 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-02-22T22:27:58.251Z,1677104878.251 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-02-22T22:27:58.251Z,1677104878.251 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-02-22T22:27:58.251Z,1677104878.251 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-02-22T22:27:58.252Z,1677104878.252 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-02-22T22:27:58.253Z,1677104878.253 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-02-22T22:27:58.253Z,1677104878.253 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-02-22T22:27:58.261Z,1677104878.261 [SBIT](INFO): Initialize SBIT Component.
2023-02-22T22:27:58.261Z,1677104878.261 [SBIT](IMPORTANT): git: 2023-02-10
2023-02-22T22:27:58.261Z,1677104878.261 [SBIT](INFO): git hash: c406eb0a7e3d06ad2f4805df3abb847da8df30bc
2023-02-22T22:27:58.262Z,1677104878.262 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-02-22T22:27:58.263Z,1677104878.263 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-02-22T22:27:58.264Z,1677104878.264 [SBIT](INFO): Beginning SBIT in 81.000000 seconds.
2023-02-22T22:27:58.264Z,1677104878.264 [IBIT](INFO): Initialize IBIT Component.
2023-02-22T22:27:58.265Z,1677104878.265 [CBIT](DEBUG): Initialize CBIT Component.
2023-02-22T22:27:58.276Z,1677104878.276 [CBIT](DEBUG): Initialized mux pins.
2023-02-22T22:27:58.276Z,1677104878.276 [CBIT](DEBUG): Initializing the watchdog timer.
2023-02-22T22:27:58.277Z,1677104878.277 [logger ThreadHandler](INFO): Handler Thread ID is 6483
2023-02-22T22:27:58.300Z,1677104878.300 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-02-22T22:27:58.301Z,1677104878.301 [CBIT](DEBUG): Initializing heartbeat.
2023-02-22T22:27:58.302Z,1677104878.302 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6484
2023-02-22T22:27:58.302Z,1677104878.302 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6485
2023-02-22T22:27:58.303Z,1677104878.303 [Onboard ThreadHandler](INFO): Handler Thread ID is 6486
2023-02-22T22:27:58.306Z,1677104878.306 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-02-22T22:27:58.326Z,1677104878.326 [DAT ThreadHandler](INFO): Handler Thread ID is 6488
2023-02-22T22:27:58.329Z,1677104878.329 [DAT](INFO): Powering up
2023-02-22T22:27:58.329Z,1677104878.329 [DAT](DEBUG): Initializing DAT.
2023-02-22T22:27:58.330Z,1677104878.330 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6490
2023-02-22T22:27:58.331Z,1677104878.331 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-02-22T22:27:58.333Z,1677104878.333 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6491
2023-02-22T22:27:58.334Z,1677104878.334 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6492
2023-02-22T22:27:58.337Z,1677104878.337 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-02-22T22:27:58.337Z,1677104878.337 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-02-22T22:27:58.337Z,1677104878.337 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-02-22T22:27:58.338Z,1677104878.338 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-02-22T22:27:58.338Z,1677104878.338 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-02-22T22:27:58.338Z,1677104878.338 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-02-22T22:27:58.338Z,1677104878.338 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-02-22T22:27:58.338Z,1677104878.338 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-02-22T22:27:58.368Z,1677104878.368 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6487
2023-02-22T22:27:58.372Z,1677104878.372 [CBIT](DEBUG): Deactivating GF circuits.
2023-02-22T22:27:58.372Z,1677104878.372 [CBIT](DEBUG): Deactivating emergency mode.
2023-02-22T22:27:58.408Z,1677104878.408 [CBIT](DEBUG): Backplane powered.
2023-02-22T22:27:58.409Z,1677104878.409 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-02-22T22:27:58.422Z,1677104878.422 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-02-22T22:27:58.453Z,1677104878.453 [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-02-22T22:27:58.454Z,1677104878.454 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-02-22T22:27:58.489Z,1677104878.489 [WetLabsBB2FL](INFO): Powering up
2023-02-22T22:27:58.557Z,1677104878.557 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-02-22T22:27:58.558Z,1677104878.558 [Default:A.Wait](DEBUG): Construct Wait.
2023-02-22T22:27:58.575Z,1677104878.575 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-02-22T22:27:58.615Z,1677104878.615 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-02-22T22:27:58.617Z,1677104878.617 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-02-22T22:27:58.639Z,1677104878.639 [Default:E.Execute](DEBUG): Construct Execute.
2023-02-22T22:27:58.642Z,1677104878.642 [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-02-22T22:27:58.647Z,1677104878.647 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-02-22T22:27:58.673Z,1677104878.673 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-02-22T22:27:58.742Z,1677104878.742 [MultiRay](INFO): Powering up MultiRay Lights
2023-02-22T22:27:58.772Z,1677104878.772 [Radio_Surface](INFO): Powering up
2023-02-22T22:27:58.773Z,1677104878.773 [Power24vConverter](INFO): Powering up.
2023-02-22T22:27:58.812Z,1677104878.812 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:27:58.821Z,1677104878.821 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-02-22T22:27:58.822Z,1677104878.822 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:27:58.829Z,1677104878.829 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:27:58.829Z,1677104878.829 [MassServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:27:58.837Z,1677104878.837 [MassServo](DEBUG): Initializing MassServo.
2023-02-22T22:27:58.837Z,1677104878.837 [RudderServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:27:58.845Z,1677104878.845 [RudderServo](DEBUG): Initializing RudderServo.
2023-02-22T22:27:58.845Z,1677104878.845 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-02-22T22:27:58.853Z,1677104878.853 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-02-22T22:27:59.804Z,1677104879.804 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2023-02-22T22:27:59.804Z,1677104879.804 [RudderServo](FAULT): Rudder failed to initialize
2023-02-22T22:27:59.805Z,1677104879.805 [RudderServo] Communications Fault, FailCount= 1
2023-02-22T22:27:59.805Z,1677104879.805 [RudderServo](ERROR): Communications Fault
2023-02-22T22:27:59.808Z,1677104879.808 [CBIT](ERROR): Communications Fault in component: RudderServo
2023-02-22T22:28:00.269Z,1677104880.269 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-02-22T22:28:00.269Z,1677104880.269 [RudderServo](INFO): Powering down
2023-02-22T22:28:00.456Z,1677104880.456 [WetLabsBB2FL](INFO): Powering down
2023-02-22T22:28:00.731Z,1677104880.731 [RudderServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:28:00.850Z,1677104880.850 [RudderServo](DEBUG): Initializing RudderServo.
2023-02-22T22:28:00.854Z,1677104880.854 [CBIT](INFO): Clearing failed state for component RudderServo
2023-02-22T22:28:00.854Z,1677104880.854 [RudderServo] No Fault, FailCount= 1
2023-02-22T22:28:04.562Z,1677104884.562 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-02-22T22:28:06.375Z,1677104886.375 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2023-02-22T22:28:12.226Z,1677104892.226 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004733
2023-02-22T22:28:13.199Z,1677104893.199 [DAT](INFO): commRate: 800
2023-02-22T22:28:15.264Z,1677104895.264 [DAT](INFO): entering command mode
2023-02-22T22:28:15.465Z,1677104895.465 [DAT](INFO): setting verbose to 3
2023-02-22T22:28:15.718Z,1677104895.718 [DAT](INFO): set verbose to 3
2023-02-22T22:28:15.718Z,1677104895.718 [DAT](INFO): setting DatVerbose to 27440
2023-02-22T22:28:15.970Z,1677104895.970 [DAT](INFO): set DatVerbose to 27440
2023-02-22T22:28:15.970Z,1677104895.970 [DAT](INFO): setting transmit power to 8
2023-02-22T22:28:16.222Z,1677104896.222 [DAT](INFO): set transmit power to 8
2023-02-22T22:28:16.222Z,1677104896.222 [DAT](INFO): setting local address to 5
2023-02-22T22:28:16.474Z,1677104896.474 [DAT](INFO): set local address to 5
2023-02-22T22:28:16.475Z,1677104896.475 [DAT](INFO): Setting time to: 22:28:16 And date to:2/22/2023
2023-02-22T22:28:16.727Z,1677104896.727 [DAT](INFO): Local DAT time set to Wed Feb 22, 2023  22:28:16  

2023-02-22T22:28:27.366Z,1677104907.366 [NAL9602](INFO): Powering up NAL9602
2023-02-22T22:28:38.274Z,1677104918.274 [NAL9602](INFO): NAL9602 initialized
2023-02-22T22:29:19.979Z,1677104959.979 [SBIT](IMPORTANT): Beginning Startup BIT
2023-02-22T22:29:19.984Z,1677104959.984 [CBIT](IMPORTANT): Beginning ground fault scan
2023-02-22T22:29:30.818Z,1677104970.818 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.002037
CHAN A1 (24V): -0.008022
CHAN A2 (12V): -0.004357
CHAN A3 (5V): -0.003802
CHAN B0 (3.3V): -0.001043
CHAN B1 (3.15aV): -0.001294
CHAN B2 (3.15bV): -0.001452
CHAN B3 (GND): -0.000339
OPEN: 0.004752
Full Scale: +/- 1 mA
2023-02-22T22:29:40.152Z,1677104980.152 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:29:40.153Z,1677104980.153 [ElevatorServo] Hardware Fault, FailCount= 1
2023-02-22T22:29:40.153Z,1677104980.153 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:29:40.241Z,1677104980.241 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:29:40.506Z,1677104980.506 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:29:40.506Z,1677104980.506 [ElevatorServo](INFO): Powering down
2023-02-22T22:29:41.320Z,1677104981.320 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:29:41.433Z,1677104981.433 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:29:41.465Z,1677104981.465 [CBIT](INFO): Clearing failed state for component ElevatorServo
2023-02-22T22:29:41.465Z,1677104981.465 [ElevatorServo] No Fault, FailCount= 1
2023-02-22T22:29:45.405Z,1677104985.405 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:29:45.405Z,1677104985.405 [ElevatorServo] Hardware Fault, FailCount= 2
2023-02-22T22:29:45.405Z,1677104985.405 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:29:45.470Z,1677104985.470 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:29:45.820Z,1677104985.820 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:29:45.820Z,1677104985.820 [ElevatorServo](INFO): Powering down
2023-02-22T22:29:46.578Z,1677104986.578 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:29:46.697Z,1677104986.697 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:29:46.729Z,1677104986.729 [CBIT](INFO): Clearing failed state for component ElevatorServo
2023-02-22T22:29:46.729Z,1677104986.729 [ElevatorServo] No Fault, FailCount= 2
2023-02-22T22:29:50.660Z,1677104990.660 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:29:50.660Z,1677104990.660 [ElevatorServo] Hardware Fault, FailCount= 3
2023-02-22T22:29:50.660Z,1677104990.660 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:29:50.690Z,1677104990.690 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:29:50.691Z,1677104990.691 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2023-02-22T22:29:51.011Z,1677104991.011 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:29:51.011Z,1677104991.011 [ElevatorServo](INFO): Powering down
2023-02-22T22:29:51.030Z,1677104991.030 [CommandExec](FAULT): Scheduling is paused
2023-02-22T22:29:51.031Z,1677104991.031 [CBIT](INFO): Critical error at 20230222T222950
2023-02-22T22:29:51.031Z,1677104991.031 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-02-22T22:29:51.819Z,1677104991.819 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:29:51.933Z,1677104991.933 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:29:59.939Z,1677104999.939 [SBIT](ERROR): Could not read elevatorAngleReader_.
2023-02-22T22:29:59.940Z,1677104999.940 [SBIT](FAULT): Control surface position failure.
2023-02-22T22:30:13.704Z,1677105013.704 [SBIT](ERROR): Could not read elevatorAngleReader_.
2023-02-22T22:30:13.704Z,1677105013.704 [SBIT](FAULT): Control surface position failure.
2023-02-22T22:30:14.135Z,1677105014.135 [SBIT](CRITICAL): SBIT FAILED
2023-02-22T22:30:14.136Z,1677105014.136 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-02-22T22:30:14.137Z,1677105014.137 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count;

2023-02-22T22:30:14.137Z,1677105014.137 [SBIT](IMPORTANT): BackseatComponent.alwaysOn=0 bool;

2023-02-22T22:30:14.137Z,1677105014.137 [SBIT](IMPORTANT): DAT.verbosity=1 count;

2023-02-22T22:30:14.137Z,1677105014.137 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2023-02-22T22:30:14.137Z,1677105014.137 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=10 minute;

2023-02-22T22:30:14.137Z,1677105014.137 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2023-02-22T22:30:14.137Z,1677105014.137 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;

2023-02-22T22:30:14.138Z,1677105014.138 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;

2023-02-22T22:30:14.138Z,1677105014.138 [SBIT](IMPORTANT): Express linearApproximation platform_roll_angle 5.000000 degree;

2023-02-22T22:30:14.138Z,1677105014.138 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=184.896478 cubic_centimeter;

2023-02-22T22:30:14.138Z,1677105014.138 [SBIT](IMPORTANT): VerticalControl.elevDeadband=0.1 angular_degree;

2023-02-22T22:30:14.138Z,1677105014.138 [SBIT](IMPORTANT): VerticalControl.massDefault=15.484465 millimeter;

2023-02-22T22:30:14.140Z,1677105014.140 [CBIT](INFO): Critical error at 20230222T223014
2023-02-22T22:30:14.459Z,1677105014.459 [MissionManager](IMPORTANT): Started mission Startup
2023-02-22T22:30:14.459Z,1677105014.459 [Startup] Running Loop=1
2023-02-22T22:30:14.459Z,1677105014.459 [Startup](DEBUG): Aggregate::initialize Startup
2023-02-22T22:30:14.459Z,1677105014.459 [Startup:A.GoToSurface] Running Loop=1
2023-02-22T22:30:14.459Z,1677105014.459 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-02-22T22:30:14.460Z,1677105014.460 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-02-22T22:30:14.460Z,1677105014.460 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-02-22T22:30:14.461Z,1677105014.461 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-02-22T22:30:14.461Z,1677105014.461 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-02-22T22:30:14.461Z,1677105014.461 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-02-22T22:30:14.463Z,1677105014.463 [Startup:StartupSatComms] Running Loop=1
2023-02-22T22:30:14.463Z,1677105014.463 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-02-22T22:30:14.464Z,1677105014.464 [Startup:StartupSatComms:A] Running Loop=1
2023-02-22T22:30:14.854Z,1677105014.854 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-02-22T22:30:25.745Z,1677105025.745 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:30:39.068Z,1677105039.068 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:30:52.399Z,1677105052.399 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:30:58.546Z,1677105058.546 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-02-22T22:30:58.546Z,1677105058.546 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:30:58.566Z,1677105058.566 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:30:58.930Z,1677105058.930 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:30:58.930Z,1677105058.930 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-02-22T22:31:05.326Z,1677105065.326 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:31:14.652Z,1677105074.652 [Startup:StartupSatComms:A](INFO): Timed out from 2023-02-22T22:30:14.5Z
2023-02-22T22:31:14.652Z,1677105074.652 [Startup:StartupSatComms:A] Stopped
2023-02-22T22:31:14.652Z,1677105074.652 [Startup:StartupSatComms:B] Running Loop=1
2023-02-22T22:31:15.045Z,1677105075.045 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-02-22T22:31:18.659Z,1677105078.659 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:31:21.844Z,1677105081.844 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230217T224039/Courier0033.lzma
2023-02-22T22:31:22.846Z,1677105082.846 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Courier0033.lzma.bak
2023-02-22T22:31:22.846Z,1677105082.846 [DataOverHttps](INFO): SBD MOMSN=17487184
2023-02-22T22:31:31.990Z,1677105091.990 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:31:38.736Z,1677105098.736 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20230222T184848/Courier0000.lzma
2023-02-22T22:31:39.738Z,1677105099.738 [DataOverHttps](INFO): Moved sent file to Logs/20230222T184848/Courier0000.lzma.bak
2023-02-22T22:31:39.738Z,1677105099.738 [DataOverHttps](INFO): SBD MOMSN=17487186
2023-02-22T22:31:45.323Z,1677105105.323 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:31:50.193Z,1677105110.193 [CommandExec](IMPORTANT): got command failComponent
2023-02-22T22:31:50.193Z,1677105110.193 [CommandExec](IMPORTANT): Failed components:
2023-02-22T22:31:50.194Z,1677105110.194 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2023-02-22T22:31:55.332Z,1677105115.332 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230222T184848/Courier0004.lzma
2023-02-22T22:31:56.334Z,1677105116.334 [DataOverHttps](INFO): Moved sent file to Logs/20230222T184848/Courier0004.lzma.bak
2023-02-22T22:31:56.334Z,1677105116.334 [DataOverHttps](INFO): SBD MOMSN=17487189
2023-02-22T22:31:58.659Z,1677105118.659 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:32:11.904Z,1677105131.904 [DataOverHttps](INFO): Sending 55 bytes from file Logs/20230222T184848/Courier0007.lzma
2023-02-22T22:32:11.988Z,1677105131.988 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:32:12.906Z,1677105132.906 [DataOverHttps](INFO): Moved sent file to Logs/20230222T184848/Courier0007.lzma.bak
2023-02-22T22:32:12.907Z,1677105132.907 [DataOverHttps](INFO): SBD MOMSN=17487191
2023-02-22T22:32:14.850Z,1677105134.850 [Startup:StartupSatComms:B](INFO): Timed out from 2023-02-22T22:31:14.7Z
2023-02-22T22:32:14.850Z,1677105134.850 [Startup:StartupSatComms:B] Stopped
2023-02-22T22:32:14.850Z,1677105134.850 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-02-22T22:32:14.850Z,1677105134.850 [Startup:StartupSatComms] Stopped
2023-02-22T22:32:14.850Z,1677105134.850 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-02-22T22:32:14.851Z,1677105134.851 [Startup](INFO): Completed Startup
2023-02-22T22:32:14.851Z,1677105134.851 [MissionManager](INFO): Startup is completed.
2023-02-22T22:32:14.851Z,1677105134.851 [MissionManager](INFO): Uninitializing Mission Startup
2023-02-22T22:32:14.851Z,1677105134.851 [Startup] Stopped
2023-02-22T22:32:14.851Z,1677105134.851 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-02-22T22:32:14.851Z,1677105134.851 [Startup:A.GoToSurface] Stopped
2023-02-22T22:32:14.851Z,1677105134.851 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-02-22T22:32:15.246Z,1677105135.246 [MissionManager](IMPORTANT): Started mission Default
2023-02-22T22:32:15.246Z,1677105135.246 [Default] Running Loop=1
2023-02-22T22:32:15.246Z,1677105135.246 [Default](DEBUG): Aggregate::initialize Default
2023-02-22T22:32:15.246Z,1677105135.246 [Default:B.GoToSurface] Running Loop=1
2023-02-22T22:32:15.246Z,1677105135.246 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-02-22T22:32:15.247Z,1677105135.247 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-02-22T22:32:15.247Z,1677105135.247 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-02-22T22:32:15.247Z,1677105135.247 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-02-22T22:32:15.247Z,1677105135.247 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-02-22T22:32:15.248Z,1677105135.248 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-02-22T22:32:15.248Z,1677105135.248 [Default:A.Wait] Running Loop=1
2023-02-22T22:32:15.248Z,1677105135.248 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-02-22T22:32:25.325Z,1677105145.325 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:32:25.729Z,1677105145.729 [CommandExec](IMPORTANT): got command failComponent
2023-02-22T22:32:25.729Z,1677105145.729 [CommandExec](IMPORTANT): Failed components:
2023-02-22T22:32:25.729Z,1677105145.729 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2023-02-22T22:32:28.594Z,1677105148.594 [Default:A.Wait](INFO): Done Waiting.
2023-02-22T22:32:28.594Z,1677105148.594 [Default:A.Wait] Stopped
2023-02-22T22:32:28.594Z,1677105148.594 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-02-22T22:32:28.970Z,1677105148.970 [Default:CheckIn] Running Loop=1
2023-02-22T22:32:28.970Z,1677105148.970 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-02-22T22:32:28.970Z,1677105148.970 [Default:CheckIn:Read_GPS] Running Loop=1
2023-02-22T22:32:29.376Z,1677105149.376 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-02-22T22:32:39.055Z,1677105159.055 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:32:52.421Z,1677105172.421 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-02-22T22:32:59.132Z,1677105179.132 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20230222T185945/Courier0000.lzma
2023-02-22T22:33:00.134Z,1677105180.134 [DataOverHttps](INFO): Moved sent file to Logs/20230222T185945/Courier0000.lzma.bak
2023-02-22T22:33:00.134Z,1677105180.134 [DataOverHttps](INFO): SBD MOMSN=17487193
2023-02-22T22:33:42.106Z,1677105222.106 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-02-22T22:33:48.562Z,1677105228.562 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2023-02-22T22:33:59.543Z,1677105239.543 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-02-22T22:33:59.543Z,1677105239.543 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:33:59.553Z,1677105239.553 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:33:59.922Z,1677105239.922 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:33:59.922Z,1677105239.922 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-02-22T22:35:17.706Z,1677105317.706 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 10 degree
2023-02-22T22:35:17.722Z,1677105317.722 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread.
2023-02-22T22:35:17.908Z,1677105317.908 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-02-22T22:35:22.298Z,1677105322.298 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5.
2023-02-22T22:35:22.301Z,1677105322.301 [BPC1](INFO): Received data from all battery sticks.
2023-02-22T22:35:59.601Z,1677105359.601 [CommandExec](IMPORTANT): got command failComponent
2023-02-22T22:35:59.601Z,1677105359.601 [CommandExec](IMPORTANT): Failed components:
2023-02-22T22:35:59.601Z,1677105359.601 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2023-02-22T22:36:32.015Z,1677105392.015 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -10 degree
2023-02-22T22:37:00.478Z,1677105420.478 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-02-22T22:37:00.478Z,1677105420.478 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:37:00.489Z,1677105420.489 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:37:00.910Z,1677105420.910 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:37:00.910Z,1677105420.910 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-02-22T22:37:29.172Z,1677105449.172 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-22T22:32:28.0Z
2023-02-22T22:37:29.172Z,1677105449.172 [Default:CheckIn:Read_GPS] Stopped
2023-02-22T22:37:29.172Z,1677105449.172 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-02-22T22:37:29.587Z,1677105449.587 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-02-22T22:37:36.241Z,1677105456.241 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20230222T222748/Courier0000.lzma
2023-02-22T22:37:37.242Z,1677105457.242 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Courier0000.lzma.bak
2023-02-22T22:37:37.242Z,1677105457.242 [DataOverHttps](INFO): SBD MOMSN=17487196
2023-02-22T22:37:44.723Z,1677105464.723 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -10 degree
2023-02-22T22:37:50.753Z,1677105470.753 [CommandExec](IMPORTANT): got command failComponent
2023-02-22T22:37:50.753Z,1677105470.753 [CommandExec](IMPORTANT): Failed components:
2023-02-22T22:37:50.753Z,1677105470.753 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2023-02-22T22:37:53.668Z,1677105473.668 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230222T222748/Courier0004.lzma
2023-02-22T22:37:54.670Z,1677105474.670 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Courier0004.lzma.bak
2023-02-22T22:37:54.670Z,1677105474.670 [DataOverHttps](INFO): SBD MOMSN=17487201
2023-02-22T22:37:59.505Z,1677105479.505 [CommandExec](IMPORTANT): got command failComponent
2023-02-22T22:37:59.505Z,1677105479.505 [CommandExec](IMPORTANT): Failed components:
2023-02-22T22:37:59.505Z,1677105479.505 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2023-02-22T22:38:04.094Z,1677105484.094 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo
2023-02-22T22:38:04.095Z,1677105484.095 [ElevatorServo] No Fault, FailCount= 3
2023-02-22T22:38:04.095Z,1677105484.095 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault
2023-02-22T22:38:07.184Z,1677105487.184 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:38:07.185Z,1677105487.185 [ElevatorServo] Hardware Fault, FailCount= 4
2023-02-22T22:38:07.185Z,1677105487.185 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:38:07.213Z,1677105487.213 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:38:07.214Z,1677105487.214 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2023-02-22T22:38:07.564Z,1677105487.564 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:38:07.564Z,1677105487.564 [ElevatorServo](INFO): Powering down
2023-02-22T22:38:07.571Z,1677105487.571 [CBIT](INFO): Critical error at 20230222T223807
2023-02-22T22:38:08.383Z,1677105488.383 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:38:08.501Z,1677105488.501 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:38:10.678Z,1677105490.678 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20230217T224039/Express0031.lzma
2023-02-22T22:38:11.678Z,1677105491.678 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0031.lzma.bak
2023-02-22T22:38:11.678Z,1677105491.678 [DataOverHttps](INFO): SBD MOMSN=17487203
2023-02-22T22:38:21.198Z,1677105501.198 [CommandExec](IMPORTANT): got command maintain clear
2023-02-22T22:38:21.314Z,1677105501.314 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-02-22T22:38:26.615Z,1677105506.615 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo
2023-02-22T22:38:26.615Z,1677105506.615 [ElevatorServo] No Fault, FailCount= 4
2023-02-22T22:38:26.615Z,1677105506.615 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault
2023-02-22T22:38:27.185Z,1677105507.185 [DataOverHttps](INFO): Sending 97 bytes from file Logs/20230217T224039/Express0034.lzma
2023-02-22T22:38:28.186Z,1677105508.186 [DataOverHttps](INFO): Moved sent file to Logs/20230217T224039/Express0034.lzma.bak
2023-02-22T22:38:28.186Z,1677105508.186 [DataOverHttps](INFO): SBD MOMSN=17487208
2023-02-22T22:38:29.792Z,1677105509.792 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:38:29.792Z,1677105509.792 [ElevatorServo] Hardware Fault, FailCount= 5
2023-02-22T22:38:29.792Z,1677105509.792 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:38:29.841Z,1677105509.841 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:38:29.841Z,1677105509.841 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2023-02-22T22:38:30.191Z,1677105510.191 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:38:30.192Z,1677105510.192 [ElevatorServo](INFO): Powering down
2023-02-22T22:38:30.198Z,1677105510.198 [CBIT](INFO): Critical error at 20230222T223829
2023-02-22T22:38:30.000Z,1677105511.000 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:38:31.117Z,1677105511.117 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:38:39.007Z,1677105519.007 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo
2023-02-22T22:38:39.007Z,1677105519.007 [ElevatorServo] No Fault, FailCount= 5
2023-02-22T22:38:39.008Z,1677105519.008 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault
2023-02-22T22:38:39.446Z,1677105519.446 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-02-22T22:38:39.446Z,1677105519.446 [NAL9602] Data Fault, FailCount= 1
2023-02-22T22:38:39.446Z,1677105519.446 [NAL9602](ERROR): Data Fault
2023-02-22T22:38:39.627Z,1677105519.627 [CBIT](ERROR): Data Fault in component: NAL9602
2023-02-22T22:38:39.850Z,1677105519.850 [NAL9602](INFO): Powering down
2023-02-22T22:38:40.733Z,1677105520.733 [CBIT](INFO): Clearing failed state for component NAL9602
2023-02-22T22:38:40.733Z,1677105520.733 [NAL9602] No Fault, FailCount= 1
2023-02-22T22:38:41.940Z,1677105521.940 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:38:41.941Z,1677105521.941 [ElevatorServo] Hardware Fault, FailCount= 6
2023-02-22T22:38:41.941Z,1677105521.941 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:38:41.973Z,1677105521.973 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:38:41.973Z,1677105521.973 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2023-02-22T22:38:42.317Z,1677105522.317 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:38:42.317Z,1677105522.317 [ElevatorServo](INFO): Powering down
2023-02-22T22:38:42.324Z,1677105522.324 [CBIT](INFO): Critical error at 20230222T223841
2023-02-22T22:38:43.119Z,1677105523.119 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:38:43.237Z,1677105523.237 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:38:44.319Z,1677105524.319 [DataOverHttps](INFO): Sending 1272 bytes from file Logs/20230222T184848/Express0001.lzma
2023-02-22T22:38:45.318Z,1677105525.318 [DataOverHttps](INFO): Moved sent file to Logs/20230222T184848/Express0001.lzma.bak
2023-02-22T22:38:45.318Z,1677105525.318 [DataOverHttps](INFO): SBD MOMSN=17487211
2023-02-22T22:38:55.350Z,1677105535.350 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo
2023-02-22T22:38:55.351Z,1677105535.351 [ElevatorServo] No Fault, FailCount= 6
2023-02-22T22:38:55.351Z,1677105535.351 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault
2023-02-22T22:39:00.780Z,1677105540.780 [DataOverHttps](INFO): Sending 219 bytes from file Logs/20230222T184848/Express0005.lzma
2023-02-22T22:39:01.783Z,1677105541.783 [DataOverHttps](INFO): Moved sent file to Logs/20230222T184848/Express0005.lzma.bak
2023-02-22T22:39:01.783Z,1677105541.783 [DataOverHttps](INFO): SBD MOMSN=17487248
2023-02-22T22:39:10.158Z,1677105550.158 [NAL9602](INFO): Powering up NAL9602
2023-02-22T22:39:19.336Z,1677105559.336 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20230222T184848/Express0008.lzma
2023-02-22T22:39:20.338Z,1677105560.338 [DataOverHttps](INFO): Moved sent file to Logs/20230222T184848/Express0008.lzma.bak
2023-02-22T22:39:20.338Z,1677105560.338 [DataOverHttps](INFO): SBD MOMSN=17487299
2023-02-22T22:39:21.060Z,1677105561.060 [NAL9602](INFO): NAL9602 initialized
2023-02-22T22:39:23.177Z,1677105563.177 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 10 degree
2023-02-22T22:39:23.179Z,1677105563.179 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread.
2023-02-22T22:39:23.538Z,1677105563.538 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-02-22T22:39:37.165Z,1677105577.165 [DataOverHttps](INFO): Sending 436 bytes from file Logs/20230222T185945/Express0001.lzma
2023-02-22T22:39:38.162Z,1677105578.162 [DataOverHttps](INFO): Moved sent file to Logs/20230222T185945/Express0001.lzma.bak
2023-02-22T22:39:38.162Z,1677105578.162 [DataOverHttps](INFO): SBD MOMSN=17487304
2023-02-22T22:39:40.932Z,1677105580.932 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -10 degree
2023-02-22T22:39:53.662Z,1677105593.662 [DataOverHttps](INFO): Sending 1099 bytes from file Logs/20230222T222748/Express0001.lzma
2023-02-22T22:39:54.662Z,1677105594.662 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Express0001.lzma.bak
2023-02-22T22:39:54.662Z,1677105594.662 [DataOverHttps](INFO): SBD MOMSN=17487310
2023-02-22T22:40:01.473Z,1677105601.473 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-02-22T22:40:01.473Z,1677105601.473 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:40:01.485Z,1677105601.485 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:40:01.888Z,1677105601.888 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:40:01.888Z,1677105601.888 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-02-22T22:40:10.220Z,1677105610.220 [DataOverHttps](INFO): Sending 356 bytes from file Logs/20230222T222748/Express0005.lzma
2023-02-22T22:40:11.222Z,1677105611.222 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Express0005.lzma.bak
2023-02-22T22:40:11.222Z,1677105611.222 [DataOverHttps](INFO): SBD MOMSN=17487339
2023-02-22T22:40:12.806Z,1677105612.806 [Default:CheckIn:Read_Iridium] Stopped
2023-02-22T22:40:12.806Z,1677105612.806 [Default:CheckIn:C.Wait] Running Loop=1
2023-02-22T22:40:12.806Z,1677105612.806 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-02-22T22:40:28.099Z,1677105628.099 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2023-02-22T22:40:41.358Z,1677105641.358 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:40:43.547Z,1677105643.547 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:40:43.547Z,1677105643.547 [ElevatorServo] Hardware Fault, FailCount= 1
2023-02-22T22:40:43.547Z,1677105643.547 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:40:43.577Z,1677105643.577 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:40:43.923Z,1677105643.923 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:40:43.923Z,1677105643.923 [ElevatorServo](INFO): Powering down
2023-02-22T22:40:44.705Z,1677105644.705 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:40:44.821Z,1677105644.821 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:40:44.825Z,1677105644.825 [CBIT](INFO): Clearing failed state for component ElevatorServo
2023-02-22T22:40:44.825Z,1677105644.825 [ElevatorServo] No Fault, FailCount= 1
2023-02-22T22:40:48.792Z,1677105648.792 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:40:48.792Z,1677105648.792 [ElevatorServo] Hardware Fault, FailCount= 2
2023-02-22T22:40:48.792Z,1677105648.792 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:40:48.825Z,1677105648.825 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:40:49.177Z,1677105649.177 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:40:49.177Z,1677105649.177 [ElevatorServo](INFO): Powering down
2023-02-22T22:40:49.962Z,1677105649.962 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:40:50.078Z,1677105650.078 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:40:50.083Z,1677105650.083 [CBIT](INFO): Clearing failed state for component ElevatorServo
2023-02-22T22:40:50.083Z,1677105650.083 [ElevatorServo] No Fault, FailCount= 2
2023-02-22T22:40:52.524Z,1677105652.524 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo
2023-02-22T22:40:52.524Z,1677105652.524 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault
2023-02-22T22:40:54.084Z,1677105654.084 [ElevatorServo](FAULT): Overload Error
2023-02-22T22:40:54.084Z,1677105654.084 [ElevatorServo] Hardware Fault, FailCount= 3
2023-02-22T22:40:54.085Z,1677105654.085 [ElevatorServo](ERROR): Hardware Fault
2023-02-22T22:40:54.131Z,1677105654.131 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2023-02-22T22:40:54.131Z,1677105654.131 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2023-02-22T22:40:54.401Z,1677105654.401 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T22:40:54.401Z,1677105654.401 [ElevatorServo](INFO): Powering down
2023-02-22T22:40:54.404Z,1677105654.404 [CBIT](INFO): Critical error at 20230222T224054
2023-02-22T22:40:55.208Z,1677105655.208 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-22T22:40:55.345Z,1677105655.345 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-22T22:43:02.490Z,1677105782.490 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-02-22T22:43:02.490Z,1677105782.490 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:43:02.523Z,1677105782.523 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:43:02.885Z,1677105782.885 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:43:02.885Z,1677105782.885 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-02-22T22:43:20.575Z,1677105800.575 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo
2023-02-22T22:43:20.575Z,1677105800.575 [ElevatorServo] No Fault, FailCount= 3
2023-02-22T22:43:20.575Z,1677105800.575 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault
2023-02-22T22:43:40.483Z,1677105820.483 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:45:01.098Z,1677105901.098 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo
2023-02-22T22:45:01.099Z,1677105901.099 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault
2023-02-22T22:45:10.999Z,1677105910.999 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:45:13.362Z,1677105913.362 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-02-22T22:45:13.363Z,1677105913.363 [Default:CheckIn:C.Wait] Stopped
2023-02-22T22:45:13.363Z,1677105913.363 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-02-22T22:45:13.363Z,1677105913.363 [Default:CheckIn:D] Running Loop=1
2023-02-22T22:45:13.765Z,1677105913.765 [Default:CheckIn:D] Stopped
2023-02-22T22:45:13.766Z,1677105913.766 [Default:CheckIn:E] Running Loop=1
2023-02-22T22:45:14.196Z,1677105914.196 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.975321 min 
2023-02-22T22:45:14.217Z,1677105914.217 [Default:CheckIn:E] Stopped
2023-02-22T22:45:14.219Z,1677105914.219 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-02-22T22:45:14.225Z,1677105914.225 [Default:CheckIn] Stopped
2023-02-22T22:45:14.226Z,1677105914.226 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-02-22T22:45:14.226Z,1677105914.226 [Default:CheckIn](INFO): Running loop #2
2023-02-22T22:45:14.227Z,1677105914.227 [Default:CheckIn] Running Loop=2
2023-02-22T22:45:14.229Z,1677105914.229 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-02-22T22:45:14.229Z,1677105914.229 [Default:CheckIn:Read_GPS] Running Loop=1
2023-02-22T22:45:35.237Z,1677105935.237 [CommandExec](IMPORTANT): got command failComponent
2023-02-22T22:45:35.237Z,1677105935.237 [CommandExec](IMPORTANT): Failed components:
2023-02-22T22:45:35.237Z,1677105935.237 [CommandExec](IMPORTANT): No failed Components.
2023-02-22T22:45:54.206Z,1677105954.206 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:46:03.481Z,1677105963.481 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-02-22T22:46:03.481Z,1677105963.481 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:46:03.514Z,1677105963.514 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:46:03.896Z,1677105963.896 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:46:03.896Z,1677105963.896 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-02-22T22:47:15.431Z,1677106035.431 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:47:23.853Z,1677106043.853 [CommandExec](IMPORTANT): got command failComponent
2023-02-22T22:47:23.853Z,1677106043.853 [CommandExec](IMPORTANT): Failed components:
2023-02-22T22:47:23.853Z,1677106043.853 [CommandExec](IMPORTANT): No failed Components.
2023-02-22T22:47:58.503Z,1677106078.503 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2023-02-22T22:48:19.390Z,1677106099.390 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:48:42.845Z,1677106122.845 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2023-02-22T22:49:04.469Z,1677106144.469 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-02-22T22:49:04.469Z,1677106144.469 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:49:04.492Z,1677106144.492 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:49:04.867Z,1677106144.867 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:49:04.867Z,1677106144.867 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-02-22T22:49:24.238Z,1677106164.238 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-02-22T22:49:24.238Z,1677106164.238 [NAL9602] Data Fault, FailCount= 2
2023-02-22T22:49:24.238Z,1677106164.238 [NAL9602](ERROR): Data Fault
2023-02-22T22:49:24.279Z,1677106164.279 [CBIT](ERROR): Data Fault in component: NAL9602
2023-02-22T22:49:24.638Z,1677106164.638 [NAL9602](INFO): Powering down
2023-02-22T22:49:25.462Z,1677106165.462 [CBIT](INFO): Clearing failed state for component NAL9602
2023-02-22T22:49:25.462Z,1677106165.462 [NAL9602] No Fault, FailCount= 2
2023-02-22T22:49:39.736Z,1677106179.736 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2023-02-22T22:49:54.942Z,1677106194.942 [NAL9602](INFO): Powering up NAL9602
2023-02-22T22:50:05.850Z,1677106205.850 [NAL9602](INFO): NAL9602 initialized
2023-02-22T22:50:14.342Z,1677106214.342 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-22T22:45:14.2Z
2023-02-22T22:50:14.342Z,1677106214.342 [Default:CheckIn:Read_GPS] Stopped
2023-02-22T22:50:14.342Z,1677106214.342 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-02-22T22:50:21.484Z,1677106221.484 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20230222T222748/Courier0007.lzma
2023-02-22T22:50:22.486Z,1677106222.486 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Courier0007.lzma.bak
2023-02-22T22:50:22.486Z,1677106222.486 [DataOverHttps](INFO): SBD MOMSN=17487397
2023-02-22T22:50:39.628Z,1677106239.628 [DataOverHttps](INFO): Sending 602 bytes from file Logs/20230222T222748/Express0008.lzma
2023-02-22T22:50:39.931Z,1677106239.931 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:50:40.066Z,1677106240.066 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Express0008.lzma.bak
2023-02-22T22:50:40.066Z,1677106240.066 [DataOverHttps](INFO): SBD MOMSN=17487403
2023-02-22T22:50:41.842Z,1677106241.842 [Default:CheckIn:Read_Iridium] Stopped
2023-02-22T22:50:41.842Z,1677106241.842 [Default:CheckIn:C.Wait] Running Loop=1
2023-02-22T22:50:41.842Z,1677106241.842 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-02-22T22:51:06.161Z,1677106266.161 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2023-02-22T22:51:31.046Z,1677106291.046 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2023-02-22T22:52:05.451Z,1677106325.451 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-02-22T22:52:05.451Z,1677106325.451 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:52:05.462Z,1677106325.462 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:52:05.859Z,1677106325.859 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:52:05.859Z,1677106325.859 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-02-22T22:52:33.977Z,1677106353.977 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:52:56.475Z,1677106376.475 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2023-02-22T22:53:36.508Z,1677106416.508 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2023-02-22T22:54:02.047Z,1677106442.047 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:54:30.207Z,1677106470.207 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2023-02-22T22:55:06.475Z,1677106506.475 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-02-22T22:55:06.475Z,1677106506.475 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:55:06.498Z,1677106506.498 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:55:06.865Z,1677106506.865 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:55:06.865Z,1677106506.865 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-02-22T22:55:21.319Z,1677106521.319 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2023-02-22T22:55:42.399Z,1677106542.399 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-02-22T22:55:42.399Z,1677106542.399 [Default:CheckIn:C.Wait] Stopped
2023-02-22T22:55:42.399Z,1677106542.399 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-02-22T22:55:42.400Z,1677106542.400 [Default:CheckIn:D] Running Loop=1
2023-02-22T22:55:42.808Z,1677106542.808 [Default:CheckIn:D] Stopped
2023-02-22T22:55:42.808Z,1677106542.808 [Default:CheckIn:E] Running Loop=1
2023-02-22T22:55:43.207Z,1677106543.207 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.459367 min 
2023-02-22T22:55:43.207Z,1677106543.207 [Default:CheckIn:E] Stopped
2023-02-22T22:55:43.207Z,1677106543.207 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-02-22T22:55:43.207Z,1677106543.207 [Default:CheckIn] Stopped
2023-02-22T22:55:43.207Z,1677106543.207 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-02-22T22:55:43.207Z,1677106543.207 [Default:CheckIn](INFO): Running loop #3
2023-02-22T22:55:43.207Z,1677106543.207 [Default:CheckIn] Running Loop=3
2023-02-22T22:55:43.207Z,1677106543.207 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-02-22T22:55:43.208Z,1677106543.208 [Default:CheckIn:Read_GPS] Running Loop=1
2023-02-22T22:57:22.431Z,1677106642.431 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2023-02-22T22:57:53.230Z,1677106673.230 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T22:58:07.469Z,1677106687.469 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-02-22T22:58:07.469Z,1677106687.469 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T22:58:07.480Z,1677106687.480 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T22:58:07.852Z,1677106687.852 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T22:58:07.852Z,1677106687.852 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-02-22T22:58:16.323Z,1677106696.323 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2023-02-22T22:58:42.470Z,1677106722.470 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2023-02-22T22:59:15.445Z,1677106755.445 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2023-02-22T23:00:07.014Z,1677106807.014 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-02-22T23:00:07.014Z,1677106807.014 [NAL9602] Data Fault, FailCount= 3
2023-02-22T23:00:07.014Z,1677106807.014 [NAL9602](ERROR): Data Fault
2023-02-22T23:00:07.087Z,1677106807.087 [CBIT](ERROR): Data Fault in component: NAL9602
2023-02-22T23:00:07.418Z,1677106807.418 [NAL9602](INFO): Powering down
2023-02-22T23:00:08.295Z,1677106808.295 [CBIT](INFO): Clearing failed state for component NAL9602
2023-02-22T23:00:08.295Z,1677106808.295 [NAL9602] No Fault, FailCount= 3
2023-02-22T23:00:09.389Z,1677106809.389 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2023-02-22T23:00:34.003Z,1677106834.003 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2023-02-22T23:00:37.718Z,1677106837.718 [NAL9602](INFO): Powering up NAL9602
2023-02-22T23:00:43.382Z,1677106843.382 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-22T22:55:43.2Z
2023-02-22T23:00:43.382Z,1677106843.382 [Default:CheckIn:Read_GPS] Stopped
2023-02-22T23:00:43.382Z,1677106843.382 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-02-22T23:00:48.626Z,1677106848.626 [NAL9602](INFO): NAL9602 initialized
2023-02-22T23:00:50.268Z,1677106850.268 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230222T222748/Courier0010.lzma
2023-02-22T23:00:51.270Z,1677106851.270 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Courier0010.lzma.bak
2023-02-22T23:00:51.270Z,1677106851.270 [DataOverHttps](INFO): SBD MOMSN=17487461
2023-02-22T23:01:06.865Z,1677106866.865 [DataOverHttps](INFO): Sending 322 bytes from file Logs/20230222T222748/Express0011.lzma
2023-02-22T23:01:07.858Z,1677106867.858 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Express0011.lzma.bak
2023-02-22T23:01:07.858Z,1677106867.858 [DataOverHttps](INFO): SBD MOMSN=17487507
2023-02-22T23:01:08.447Z,1677106868.447 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-02-22T23:01:08.447Z,1677106868.447 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T23:01:08.458Z,1677106868.458 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T23:01:08.857Z,1677106868.857 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T23:01:08.857Z,1677106868.857 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-02-22T23:01:09.646Z,1677106869.646 [Default:CheckIn:Read_Iridium] Stopped
2023-02-22T23:01:09.646Z,1677106869.646 [Default:CheckIn:C.Wait] Running Loop=1
2023-02-22T23:01:09.646Z,1677106869.646 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-02-22T23:04:09.432Z,1677107049.432 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-02-22T23:04:09.432Z,1677107049.432 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-02-22T23:04:09.472Z,1677107049.472 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-02-22T23:04:09.850Z,1677107049.850 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-02-22T23:04:09.850Z,1677107049.850 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-02-22T23:04:26.009Z,1677107066.009 [CommandExec](IMPORTANT): got command quit
2023-02-22T23:04:27.012Z,1677107067.012 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:27.012Z,1677107067.012 [CommandExec](INFO): Uninitializing the command executive.
2023-02-22T23:04:27.013Z,1677107067.013 [CommandExec](INFO): Uninitializing the command scheduler.
2023-02-22T23:04:27.013Z,1677107067.013 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:27.045Z,1677107067.045 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-02-22T23:04:27.045Z,1677107067.045 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-02-22T23:04:27.045Z,1677107067.045 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:27.046Z,1677107067.046 [NavChartDb](INFO): Join timeout helper Thread ID is 6565
2023-02-22T23:04:27.133Z,1677107067.133 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:27.133Z,1677107067.133 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:27.137Z,1677107067.137 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-02-22T23:04:27.137Z,1677107067.137 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:27.137Z,1677107067.137 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6566
2023-02-22T23:04:27.640Z,1677107067.640 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:27.641Z,1677107067.641 [WetLabsBB2FL](INFO): Powering down
2023-02-22T23:04:27.641Z,1677107067.641 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:27.648Z,1677107067.648 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-02-22T23:04:27.648Z,1677107067.648 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:27.649Z,1677107067.649 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6567
2023-02-22T23:04:28.364Z,1677107068.364 [CTD_Seabird](INFO): Powering down
2023-02-22T23:04:28.376Z,1677107068.376 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:28.376Z,1677107068.376 [CTD_Seabird](INFO): Powering down
2023-02-22T23:04:28.389Z,1677107068.389 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:28.393Z,1677107068.393 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-02-22T23:04:28.394Z,1677107068.394 [DAT ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:28.394Z,1677107068.394 [DAT](INFO): Join timeout helper Thread ID is 6568
2023-02-22T23:04:28.395Z,1677107068.395 [DAT](INFO): Powering down
2023-02-22T23:04:28.465Z,1677107068.465 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:28.465Z,1677107068.465 [DAT](INFO): Powering down
2023-02-22T23:04:28.466Z,1677107068.466 [DAT ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:28.472Z,1677107068.472 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-02-22T23:04:28.472Z,1677107068.472 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:28.473Z,1677107068.473 [Radio_Surface](INFO): Join timeout helper Thread ID is 6569
2023-02-22T23:04:28.581Z,1677107068.581 [Radio_Surface](INFO): Powering down
2023-02-22T23:04:28.582Z,1677107068.582 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:28.582Z,1677107068.582 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:28.601Z,1677107068.601 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-02-22T23:04:28.601Z,1677107068.601 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:28.602Z,1677107068.602 [Onboard](INFO): Join timeout helper Thread ID is 6570
2023-02-22T23:04:29.125Z,1677107069.125 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-02-22T23:04:30.196Z,1677107070.196 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:30.197Z,1677107070.197 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:30.214Z,1677107070.214 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-02-22T23:04:30.214Z,1677107070.214 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:30.215Z,1677107070.215 [DataOverHttps](INFO): Join timeout helper Thread ID is 6571
2023-02-22T23:04:31.132Z,1677107071.132 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:31.133Z,1677107071.133 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.145Z,1677107071.145 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-02-22T23:04:31.145Z,1677107071.145 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.146Z,1677107071.146 [BackseatComponent](INFO): Join timeout helper Thread ID is 6572
2023-02-22T23:04:31.201Z,1677107071.201 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:31.201Z,1677107071.201 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.205Z,1677107071.205 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-02-22T23:04:31.205Z,1677107071.205 [logger ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.206Z,1677107071.206 [logger](INFO): Join timeout helper Thread ID is 6573
2023-02-22T23:04:31.253Z,1677107071.253 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:31.253Z,1677107071.253 [logger ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.269Z,1677107071.269 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-02-22T23:04:31.269Z,1677107071.269 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.269Z,1677107071.269 [CommandLine](INFO): Join timeout helper Thread ID is 6574
2023-02-22T23:04:31.344Z,1677107071.344 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:31.345Z,1677107071.345 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.349Z,1677107071.349 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-02-22T23:04:31.349Z,1677107071.349 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.350Z,1677107071.349 [CommandExec](INFO): Join timeout helper Thread ID is 6575
2023-02-22T23:04:31.351Z,1677107071.351 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-02-22T23:04:31.351Z,1677107071.351 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.351Z,1677107071.351 [controlThread](INFO): Join timeout helper Thread ID is 6576
2023-02-22T23:04:31.616Z,1677107071.616 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-22T23:04:31.617Z,1677107071.617 [controlThread](DEBUG): Uninitializing ControlThread
2023-02-22T23:04:31.617Z,1677107071.617 [AHRS_M2](INFO): Powering down
2023-02-22T23:04:31.689Z,1677107071.689 [MultiRay](INFO): Powering down.
2023-02-22T23:04:31.690Z,1677107071.690 [NAL9602](INFO): Powering down
2023-02-22T23:04:31.692Z,1677107071.692 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-02-22T23:04:31.693Z,1677107071.693 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-02-22T23:04:31.693Z,1677107071.693 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-02-22T23:04:31.694Z,1677107071.694 [MissionManager](INFO): Uninitializing Mission Default
2023-02-22T23:04:31.694Z,1677107071.694 [Default] Stopped
2023-02-22T23:04:31.694Z,1677107071.694 [Default](DEBUG): Aggregate::uninitialize Default
2023-02-22T23:04:31.694Z,1677107071.694 [Default:B.GoToSurface] Stopped
2023-02-22T23:04:31.694Z,1677107071.694 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-02-22T23:04:31.694Z,1677107071.694 [Default:CheckIn] Stopped
2023-02-22T23:04:31.694Z,1677107071.694 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-02-22T23:04:31.694Z,1677107071.694 [Default:CheckIn:C.Wait] Stopped
2023-02-22T23:04:31.694Z,1677107071.694 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-02-22T23:04:31.697Z,1677107071.697 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-02-22T23:04:31.697Z,1677107071.697 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-02-22T23:04:31.698Z,1677107071.698 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-02-22T23:04:31.698Z,1677107071.698 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-02-22T23:04:31.698Z,1677107071.698 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-02-22T23:04:31.699Z,1677107071.699 [BuoyancyServo](INFO): Powering down
2023-02-22T23:04:31.712Z,1677107071.712 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-22T23:04:31.713Z,1677107071.713 [ElevatorServo](INFO): Powering down
2023-02-22T23:04:31.713Z,1677107071.713 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-02-22T23:04:31.713Z,1677107071.713 [MassServo](INFO): Powering down
2023-02-22T23:04:31.714Z,1677107071.714 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-02-22T23:04:31.714Z,1677107071.714 [RudderServo](INFO): Powering down
2023-02-22T23:04:31.715Z,1677107071.715 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-02-22T23:04:31.715Z,1677107071.715 [ThrusterHE](INFO): Powering down
2023-02-22T23:04:31.716Z,1677107071.716 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-02-22T23:04:31.717Z,1677107071.717 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-02-22T23:04:31.717Z,1677107071.717 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-02-22T23:04:31.717Z,1677107071.717 [CBIT](DEBUG): Powering off loads.
2023-02-22T23:04:31.728Z,1677107071.728 [CBIT](DEBUG): Disabling WDT.
2023-02-22T23:04:31.740Z,1677107071.740 [CBIT](DEBUG): Opening all GF detection circuits.
2023-02-22T23:04:31.741Z,1677107071.741 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.787Z,1677107071.787 [DAT ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.793Z,1677107071.793 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.795Z,1677107071.795 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.801Z,1677107071.801 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.845Z,1677107071.845 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.882Z,1677107071.882 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.887Z,1677107071.887 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.919Z,1677107071.919 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-22T23:04:31.980Z,1677107071.980 [logger ThreadHandler](INFO): Thread cancelled.