2021-04-30T21:25:31.251Z,1619817931.251 [Supervisor](DEBUG): Initializing supervisor.
2021-04-30T21:25:31.256Z,1619817931.256 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-04-30T21:25:31.257Z,1619817931.257 [SyncHandler](INFO): Protected caller Thread ID is 956
2021-04-30T21:25:31.257Z,1619817931.257 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-04-30T21:25:31.259Z,1619817931.259 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-04-30T21:25:31.259Z,1619817931.259 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 957
2021-04-30T21:25:31.264Z,1619817931.264 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-04-30T21:25:31.283Z,1619817931.283 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-04-30T21:25:31.284Z,1619817931.284 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-04-30T21:25:31.284Z,1619817931.284 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 958
2021-04-30T21:25:31.286Z,1619817931.286 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-04-30T21:25:31.287Z,1619817931.287 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-04-30T21:25:31.287Z,1619817931.287 [logger ThreadHandler](INFO): Protected caller Thread ID is 959
2021-04-30T21:25:31.291Z,1619817931.291 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-04-30T21:25:31.291Z,1619817931.291 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-04-30T21:25:31.293Z,1619817931.293 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-04-30T21:25:31.712Z,1619817931.712 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-04-30T21:25:31.712Z,1619817931.712 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-04-30T21:25:31.929Z,1619817931.929 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-04-30T21:25:31.929Z,1619817931.929 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-04-30T21:25:32.126Z,1619817932.126 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-04-30T21:25:32.126Z,1619817932.126 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-04-30T21:25:32.227Z,1619817932.227 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-04-30T21:25:32.228Z,1619817932.228 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-04-30T21:25:32.583Z,1619817932.583 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-04-30T21:25:32.584Z,1619817932.584 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-04-30T21:25:32.924Z,1619817932.924 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-04-30T21:25:32.924Z,1619817932.924 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-04-30T21:25:33.020Z,1619817933.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-04-30T21:25:33.021Z,1619817933.021 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-04-30T21:25:33.170Z,1619817933.170 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-04-30T21:25:33.170Z,1619817933.170 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-04-30T21:25:33.803Z,1619817933.803 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-04-30T21:25:33.804Z,1619817933.804 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-04-30T21:25:34.161Z,1619817934.161 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-04-30T21:25:34.162Z,1619817934.162 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-04-30T21:25:34.243Z,1619817934.243 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-04-30T21:25:34.451Z,1619817934.451 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-04-30T21:25:34.451Z,1619817934.451 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-04-30T21:25:34.579Z,1619817934.579 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-04-30T21:25:34.579Z,1619817934.579 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-04-30T21:25:35.297Z,1619817935.297 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-04-30T21:25:35.298Z,1619817935.298 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-04-30T21:25:35.378Z,1619817935.378 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-04-30T21:25:35.629Z,1619817935.629 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-04-30T21:25:35.630Z,1619817935.630 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2021-04-30T21:25:35.631Z,1619817935.631 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2021-04-30T21:25:35.803Z,1619817935.803 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2021-04-30T21:25:35.899Z,1619817935.899 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2021-04-30T21:25:36.009Z,1619817936.009 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2021-04-30T21:25:36.110Z,1619817936.110 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2021-04-30T21:25:36.194Z,1619817936.194 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2021-04-30T21:25:36.279Z,1619817936.279 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2021-04-30T21:25:36.393Z,1619817936.393 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2021-04-30T21:25:36.493Z,1619817936.493 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2021-04-30T21:25:36.641Z,1619817936.641 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2021-04-30T21:25:36.896Z,1619817936.896 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-04-30T21:25:36.896Z,1619817936.896 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2021-04-30T21:25:36.992Z,1619817936.992 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2021-04-30T21:25:36.992Z,1619817936.992 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-04-30T21:25:37.000Z,1619817937.000 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-04-30T21:25:37.306Z,1619817937.306 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-04-30T21:25:37.306Z,1619817937.306 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-04-30T21:25:37.384Z,1619817937.384 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-04-30T21:25:37.384Z,1619817937.384 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-04-30T21:25:37.417Z,1619817937.417 [DeadReckonUsingSpeedCalculator] Loaded
2021-04-30T21:25:37.417Z,1619817937.417 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2021-04-30T21:25:37.429Z,1619817937.429 [NavChart] Loaded
2021-04-30T21:25:37.430Z,1619817937.430 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-04-30T21:25:37.435Z,1619817937.435 [UniversalFixResidualReporter] Loaded
2021-04-30T21:25:37.435Z,1619817937.435 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-04-30T21:25:37.436Z,1619817937.436 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-04-30T21:25:37.436Z,1619817937.436 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-04-30T21:25:37.447Z,1619817937.447 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-04-30T21:25:37.447Z,1619817937.447 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-04-30T21:25:37.639Z,1619817937.639 [CTD_Seabird] Loaded
2021-04-30T21:25:37.639Z,1619817937.639 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2021-04-30T21:25:37.640Z,1619817937.640 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4061E4E0
2021-04-30T21:25:37.641Z,1619817937.641 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1042
2021-04-30T21:25:37.671Z,1619817937.671 [WetLabsBB2FL] Loaded
2021-04-30T21:25:37.672Z,1619817937.672 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2021-04-30T21:25:37.673Z,1619817937.673 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4064E4E0
2021-04-30T21:25:37.673Z,1619817937.673 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1043
2021-04-30T21:25:37.674Z,1619817937.674 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-04-30T21:25:37.674Z,1619817937.674 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-04-30T21:25:37.724Z,1619817937.724 [VerticalControl](DEBUG): Construct VerticalControl.
2021-04-30T21:25:37.784Z,1619817937.784 [VerticalControl] Loaded
2021-04-30T21:25:37.784Z,1619817937.784 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-04-30T21:25:37.787Z,1619817937.787 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-04-30T21:25:37.823Z,1619817937.823 [HorizontalControl] Loaded
2021-04-30T21:25:37.823Z,1619817937.823 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-04-30T21:25:37.826Z,1619817937.826 [SpeedControl](DEBUG): Construct SpeedControl.
2021-04-30T21:25:37.829Z,1619817937.829 [SpeedControl] Loaded
2021-04-30T21:25:37.829Z,1619817937.829 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-04-30T21:25:37.832Z,1619817937.832 [LoopControl](DEBUG): Construct LoopControl.
2021-04-30T21:25:37.832Z,1619817937.832 [LoopControl] Loaded
2021-04-30T21:25:37.832Z,1619817937.832 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-04-30T21:25:37.833Z,1619817937.833 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-04-30T21:25:37.833Z,1619817937.833 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-04-30T21:25:37.872Z,1619817937.872 [DepthRateCalculator] Loaded
2021-04-30T21:25:37.873Z,1619817937.873 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-04-30T21:25:37.877Z,1619817937.877 [PitchRateCalculator] Loaded
2021-04-30T21:25:37.878Z,1619817937.878 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-04-30T21:25:37.887Z,1619817937.887 [SpeedCalculator] Loaded
2021-04-30T21:25:37.887Z,1619817937.887 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-04-30T21:25:37.900Z,1619817937.900 [TempGradientCalculator] Loaded
2021-04-30T21:25:37.900Z,1619817937.900 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-04-30T21:25:37.904Z,1619817937.904 [YawRateCalculator] Loaded
2021-04-30T21:25:37.905Z,1619817937.905 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-04-30T21:25:37.921Z,1619817937.921 [ElevatorOffsetCalculator] Loaded
2021-04-30T21:25:37.922Z,1619817937.922 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-04-30T21:25:37.922Z,1619817937.922 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-04-30T21:25:37.923Z,1619817937.923 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-04-30T21:25:38.009Z,1619817938.009 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-04-30T21:25:38.010Z,1619817938.010 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-04-30T21:25:38.063Z,1619817938.063 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-04-30T21:25:38.063Z,1619817938.063 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-04-30T21:25:38.169Z,1619817938.169 [BuoyancyServo] Loaded
2021-04-30T21:25:38.169Z,1619817938.169 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-04-30T21:25:38.188Z,1619817938.188 [ElevatorServo] Loaded
2021-04-30T21:25:38.188Z,1619817938.188 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-04-30T21:25:38.205Z,1619817938.205 [MassServo] Loaded
2021-04-30T21:25:38.206Z,1619817938.206 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-04-30T21:25:38.223Z,1619817938.223 [RudderServo] Loaded
2021-04-30T21:25:38.223Z,1619817938.223 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-04-30T21:25:38.240Z,1619817938.240 [ThrusterServo] Loaded
2021-04-30T21:25:38.240Z,1619817938.240 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2021-04-30T21:25:38.241Z,1619817938.241 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-04-30T21:25:38.241Z,1619817938.241 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-04-30T21:25:38.340Z,1619817938.340 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-04-30T21:25:38.341Z,1619817938.341 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-04-30T21:25:39.386Z,1619817939.386 [BPC1] Loaded
2021-04-30T21:25:39.386Z,1619817939.386 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-04-30T21:25:39.461Z,1619817939.461 [DataOverHttps] Loaded
2021-04-30T21:25:39.461Z,1619817939.461 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-04-30T21:25:39.462Z,1619817939.462 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A004E0
2021-04-30T21:25:39.462Z,1619817939.462 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1044
2021-04-30T21:25:39.481Z,1619817939.481 [Depth_Keller] Loaded
2021-04-30T21:25:39.482Z,1619817939.482 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-04-30T21:25:39.544Z,1619817939.544 [NAL9602] Loaded
2021-04-30T21:25:39.545Z,1619817939.545 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-04-30T21:25:39.639Z,1619817939.639 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2021-04-30T21:25:39.640Z,1619817939.640 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2021-04-30T21:25:39.640Z,1619817939.640 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2021-04-30T21:25:39.641Z,1619817939.641 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2021-04-30T21:25:39.641Z,1619817939.641 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2021-04-30T21:25:39.642Z,1619817939.642 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2021-04-30T21:25:39.642Z,1619817939.642 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2021-04-30T21:25:39.643Z,1619817939.643 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2021-04-30T21:25:39.643Z,1619817939.643 [Onboard] Loaded
2021-04-30T21:25:39.643Z,1619817939.643 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-04-30T21:25:39.644Z,1619817939.644 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A304E0
2021-04-30T21:25:39.644Z,1619817939.644 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1045
2021-04-30T21:25:39.657Z,1619817939.657 [Radio_Surface] Loaded
2021-04-30T21:25:39.657Z,1619817939.657 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-04-30T21:25:39.658Z,1619817939.658 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A604E0
2021-04-30T21:25:39.659Z,1619817939.659 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1046
2021-04-30T21:25:39.753Z,1619817939.753 [DAT] Loaded
2021-04-30T21:25:39.754Z,1619817939.754 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2021-04-30T21:25:39.754Z,1619817939.754 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-04-30T21:25:39.755Z,1619817939.755 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-04-30T21:25:39.893Z,1619817939.893 [SBIT](DEBUG): Construct Startup Built In Test.
2021-04-30T21:25:39.902Z,1619817939.902 [SBIT] Loaded
2021-04-30T21:25:39.902Z,1619817939.902 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-04-30T21:25:39.905Z,1619817939.905 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-04-30T21:25:39.918Z,1619817939.918 [IBIT] Loaded
2021-04-30T21:25:39.918Z,1619817939.918 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-04-30T21:25:39.924Z,1619817939.924 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-04-30T21:25:40.024Z,1619817940.024 [CBIT] Loaded
2021-04-30T21:25:40.024Z,1619817940.024 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-04-30T21:25:40.025Z,1619817940.025 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-04-30T21:25:40.025Z,1619817940.025 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-04-30T21:25:40.119Z,1619817940.119 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-04-30T21:25:40.124Z,1619817940.124 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-04-30T21:25:40.127Z,1619817940.127 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-04-30T21:25:40.138Z,1619817940.138 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-04-30T21:25:40.139Z,1619817940.139 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AEB4E0
2021-04-30T21:25:40.140Z,1619817940.140 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1047
2021-04-30T21:25:40.471Z,1619817940.471 [Supervisor](INFO): Main Thread ID is 811
2021-04-30T21:25:40.471Z,1619817940.471 [Supervisor](DEBUG): Running supervisor.
2021-04-30T21:25:40.472Z,1619817940.472 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1048
2021-04-30T21:25:40.474Z,1619817940.474 [controlThread ThreadHandler](INFO): Handler Thread ID is 1049
2021-04-30T21:25:40.475Z,1619817940.475 [controlThread](DEBUG): Initializing ControlThread
2021-04-30T21:25:40.476Z,1619817940.476 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-04-30T21:25:40.476Z,1619817940.476 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-04-30T21:25:40.477Z,1619817940.477 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-04-30T21:25:40.477Z,1619817940.477 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-04-30T21:25:40.479Z,1619817940.479 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-04-30T21:25:40.480Z,1619817940.480 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-04-30T21:25:40.480Z,1619817940.480 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-04-30T21:25:40.480Z,1619817940.480 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-04-30T21:25:40.481Z,1619817940.481 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-04-30T21:25:40.481Z,1619817940.481 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-04-30T21:25:40.481Z,1619817940.481 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-04-30T21:25:40.482Z,1619817940.482 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-04-30T21:25:40.482Z,1619817940.482 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-04-30T21:25:40.487Z,1619817940.487 [SBIT](INFO): Initialize SBIT Component.
2021-04-30T21:25:40.487Z,1619817940.487 [SBIT](IMPORTANT): git: 2021-04-08-5-g614db2672
2021-04-30T21:25:40.487Z,1619817940.487 [SBIT](INFO): git hash: 614db2672e3cc2f5f8a2440aa19f5fff8fa25f54
2021-04-30T21:25:40.488Z,1619817940.488 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-04-30T21:25:40.489Z,1619817940.489 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2021-04-30T21:25:40.490Z,1619817940.490 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2021-04-30T21:25:40.490Z,1619817940.490 [IBIT](INFO): Initialize IBIT Component.
2021-04-30T21:25:40.491Z,1619817940.491 [CBIT](DEBUG): Initialize CBIT Component.
2021-04-30T21:25:40.492Z,1619817940.492 [logger ThreadHandler](INFO): Handler Thread ID is 1050
2021-04-30T21:25:40.502Z,1619817940.502 [CBIT](DEBUG): Initialized mux pins.
2021-04-30T21:25:40.502Z,1619817940.502 [CBIT](DEBUG): Initializing the watchdog timer.
2021-04-30T21:25:40.510Z,1619817940.510 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1051
2021-04-30T21:25:40.511Z,1619817940.511 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-04-30T21:25:40.515Z,1619817940.515 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1053
2021-04-30T21:25:40.518Z,1619817940.518 [WetLabsBB2FL](INFO): Powering up
2021-04-30T21:25:40.520Z,1619817940.520 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1055
2021-04-30T21:25:40.521Z,1619817940.521 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2021-04-30T21:25:40.526Z,1619817940.526 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-04-30T21:25:40.527Z,1619817940.527 [CBIT](DEBUG): Initializing heartbeat.
2021-04-30T21:25:40.534Z,1619817940.534 [Onboard ThreadHandler](INFO): Handler Thread ID is 1056
2021-04-30T21:25:40.551Z,1619817940.551 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1057
2021-04-30T21:25:40.558Z,1619817940.558 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1058
2021-04-30T21:25:40.561Z,1619817940.561 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-04-30T21:25:40.561Z,1619817940.561 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-04-30T21:25:40.562Z,1619817940.562 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-04-30T21:25:40.562Z,1619817940.562 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-04-30T21:25:40.562Z,1619817940.562 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-04-30T21:25:40.562Z,1619817940.562 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-04-30T21:25:40.563Z,1619817940.563 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-04-30T21:25:40.563Z,1619817940.563 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-04-30T21:25:40.563Z,1619817940.563 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-04-30T21:25:40.563Z,1619817940.563 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-04-30T21:25:40.563Z,1619817940.563 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-04-30T21:25:40.563Z,1619817940.563 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-04-30T21:25:40.564Z,1619817940.564 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-04-30T21:25:40.564Z,1619817940.564 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-04-30T21:25:40.564Z,1619817940.564 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-04-30T21:25:40.564Z,1619817940.564 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-04-30T21:25:40.598Z,1619817940.598 [CBIT](DEBUG): Deactivating GF circuits.
2021-04-30T21:25:40.598Z,1619817940.598 [CBIT](DEBUG): Deactivating emergency mode.
2021-04-30T21:25:40.634Z,1619817940.634 [CBIT](DEBUG): Backplane powered.
2021-04-30T21:25:40.635Z,1619817940.635 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2021-04-30T21:25:40.647Z,1619817940.647 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-04-30T21:25:40.657Z,1619817940.657 [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>


2021-04-30T21:25:40.660Z,1619817940.660 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2021-04-30T21:25:40.733Z,1619817940.733 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-04-30T21:25:40.734Z,1619817940.734 [Default:A.Wait](DEBUG): Construct Wait.
2021-04-30T21:25:40.736Z,1619817940.736 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-04-30T21:25:40.787Z,1619817940.787 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-04-30T21:25:40.790Z,1619817940.790 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-04-30T21:25:40.811Z,1619817940.811 [Default:E.Execute](DEBUG): Construct Execute.
2021-04-30T21:25:40.815Z,1619817940.815 [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="P2H">
                <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>


2021-04-30T21:25:40.819Z,1619817940.819 [controlThread](DEBUG): Component order: CycleStarter,BPC1,Depth_Keller,NAL9602,DAT,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2021-04-30T21:25:40.867Z,1619817940.867 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar
2021-04-30T21:25:40.868Z,1619817940.868 [DAT](INFO): Powering up
2021-04-30T21:25:40.868Z,1619817940.868 [DAT](DEBUG): Initializing DAT.
2021-04-30T21:25:40.890Z,1619817940.890 [DepthRateCalculator](ERROR): Depth measurement is not active
2021-04-30T21:25:40.926Z,1619817940.926 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:25:40.934Z,1619817940.934 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-04-30T21:25:40.935Z,1619817940.935 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:25:40.942Z,1619817940.942 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-04-30T21:25:40.943Z,1619817940.943 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:25:40.950Z,1619817940.950 [MassServo](DEBUG): Initializing MassServo.
2021-04-30T21:25:40.951Z,1619817940.951 [RudderServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:25:40.954Z,1619817940.954 [Radio_Surface](INFO): Powering up
2021-04-30T21:25:40.958Z,1619817940.958 [RudderServo](DEBUG): Initializing RudderServo.
2021-04-30T21:25:40.959Z,1619817940.959 [ThrusterServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:25:40.966Z,1619817940.966 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2021-04-30T21:25:45.306Z,1619817945.306 [MassServo](FAULT): Overload Error
2021-04-30T21:25:45.306Z,1619817945.306 [MassServo] Hardware Fault, FailCount= 1
2021-04-30T21:25:45.306Z,1619817945.306 [MassServo](ERROR): Hardware Fault
2021-04-30T21:25:45.311Z,1619817945.311 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-04-30T21:25:45.689Z,1619817945.689 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-04-30T21:25:45.689Z,1619817945.689 [MassServo](INFO): Powering down
2021-04-30T21:25:45.810Z,1619817945.810 [WetLabsBB2FL] Communications Fault, FailCount= 1
2021-04-30T21:25:45.810Z,1619817945.810 [WetLabsBB2FL](ERROR): Communications Fault
2021-04-30T21:25:46.094Z,1619817946.094 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-04-30T21:25:46.310Z,1619817946.310 [WetLabsBB2FL](INFO): Powering down
2021-04-30T21:25:46.750Z,1619817946.750 [CBIT](INFO): Clearing failed state for component MassServo
2021-04-30T21:25:46.750Z,1619817946.750 [MassServo] No Fault, FailCount= 1
2021-04-30T21:25:46.899Z,1619817946.899 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:25:46.906Z,1619817946.906 [MassServo](DEBUG): Initializing MassServo.
2021-04-30T21:25:47.305Z,1619817947.305 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-04-30T21:25:47.305Z,1619817947.305 [WetLabsBB2FL] No Fault, FailCount= 1
2021-04-30T21:25:47.523Z,1619817947.523 [WetLabsBB2FL](INFO): Powering up
2021-04-30T21:25:52.578Z,1619817952.578 [MassServo](FAULT): Overload Error
2021-04-30T21:25:52.578Z,1619817952.578 [MassServo] Hardware Fault, FailCount= 2
2021-04-30T21:25:52.579Z,1619817952.579 [MassServo](ERROR): Hardware Fault
2021-04-30T21:25:52.583Z,1619817952.583 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-04-30T21:25:52.814Z,1619817952.814 [WetLabsBB2FL] Communications Fault, FailCount= 2
2021-04-30T21:25:52.814Z,1619817952.814 [WetLabsBB2FL](ERROR): Communications Fault
2021-04-30T21:25:52.958Z,1619817952.958 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-04-30T21:25:52.959Z,1619817952.959 [MassServo](INFO): Powering down
2021-04-30T21:25:52.963Z,1619817952.963 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-04-30T21:25:53.314Z,1619817953.314 [WetLabsBB2FL](INFO): Powering down
2021-04-30T21:25:53.578Z,1619817953.578 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-04-30T21:25:53.578Z,1619817953.578 [CTD_Seabird] Communications Fault, FailCount= 1
2021-04-30T21:25:53.578Z,1619817953.578 [CTD_Seabird](ERROR): Communications Fault
2021-04-30T21:25:53.886Z,1619817953.886 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-04-30T21:25:53.886Z,1619817953.886 [CBIT](INFO): Clearing failed state for component MassServo
2021-04-30T21:25:53.886Z,1619817953.886 [MassServo] No Fault, FailCount= 2
2021-04-30T21:25:53.983Z,1619817953.983 [CTD_Seabird](INFO): Powering down
2021-04-30T21:25:54.171Z,1619817954.171 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:25:54.178Z,1619817954.178 [MassServo](DEBUG): Initializing MassServo.
2021-04-30T21:25:54.182Z,1619817954.182 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-04-30T21:25:54.182Z,1619817954.182 [WetLabsBB2FL] No Fault, FailCount= 2
2021-04-30T21:25:54.527Z,1619817954.527 [WetLabsBB2FL](INFO): Powering up
2021-04-30T21:25:55.042Z,1619817955.042 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2021-04-30T21:25:55.042Z,1619817955.042 [CTD_Seabird] No Fault, FailCount= 1
2021-04-30T21:25:55.326Z,1619817955.326 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-04-30T21:25:59.458Z,1619817959.458 [MassServo](FAULT): Overload Error
2021-04-30T21:25:59.458Z,1619817959.458 [MassServo] Hardware Fault, FailCount= 3
2021-04-30T21:25:59.458Z,1619817959.458 [MassServo](ERROR): Hardware Fault
2021-04-30T21:25:59.462Z,1619817959.462 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-04-30T21:25:59.818Z,1619817959.818 [WetLabsBB2FL] Communications Fault, FailCount= 3
2021-04-30T21:25:59.818Z,1619817959.818 [WetLabsBB2FL](ERROR): Communications Fault
2021-04-30T21:25:59.839Z,1619817959.839 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-04-30T21:25:59.839Z,1619817959.839 [MassServo](INFO): Powering down
2021-04-30T21:25:59.844Z,1619817959.844 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-04-30T21:26:00.318Z,1619817960.318 [WetLabsBB2FL](INFO): Powering down
2021-04-30T21:26:00.756Z,1619817960.756 [CBIT](INFO): Clearing failed state for component MassServo
2021-04-30T21:26:00.756Z,1619817960.756 [MassServo] No Fault, FailCount= 3
2021-04-30T21:26:01.038Z,1619817961.038 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:26:01.046Z,1619817961.046 [MassServo](DEBUG): Initializing MassServo.
2021-04-30T21:26:01.047Z,1619817961.047 [SBIT](IMPORTANT): Beginning Startup BIT
2021-04-30T21:26:01.051Z,1619817961.051 [CBIT](IMPORTANT): Beginning ground fault scan
2021-04-30T21:26:01.519Z,1619817961.519 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-04-30T21:26:01.519Z,1619817961.519 [WetLabsBB2FL] No Fault, FailCount= 3
2021-04-30T21:26:01.531Z,1619817961.531 [WetLabsBB2FL](INFO): Powering up
2021-04-30T21:26:04.794Z,1619817964.794 [CommandLine](IMPORTANT): got command failComponent
2021-04-30T21:26:04.795Z,1619817964.795 [CommandLine](IMPORTANT): Failed components:
2021-04-30T21:26:04.795Z,1619817964.795 [CommandLine](IMPORTANT): No failed Components.
2021-04-30T21:26:06.075Z,1619817966.075 [CommandLine](IMPORTANT): got command failComponent
2021-04-30T21:26:06.075Z,1619817966.075 [CommandLine](IMPORTANT): Failed components:
2021-04-30T21:26:06.075Z,1619817966.075 [CommandLine](IMPORTANT): No failed Components.
2021-04-30T21:26:06.346Z,1619817966.346 [MassServo](FAULT): Overload Error
2021-04-30T21:26:06.346Z,1619817966.346 [MassServo] Hardware Fault, FailCount= 4
2021-04-30T21:26:06.346Z,1619817966.346 [MassServo](ERROR): Hardware Fault
2021-04-30T21:26:06.351Z,1619817966.351 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-04-30T21:26:06.699Z,1619817966.699 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-04-30T21:26:06.700Z,1619817966.700 [MassServo](INFO): Powering down
2021-04-30T21:26:06.854Z,1619817966.854 [WetLabsBB2FL] Communications Fault, FailCount= 4
2021-04-30T21:26:06.854Z,1619817966.854 [WetLabsBB2FL](ERROR): Communications Fault
2021-04-30T21:26:07.102Z,1619817967.102 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-04-30T21:26:07.354Z,1619817967.354 [WetLabsBB2FL](INFO): Powering down
2021-04-30T21:26:07.502Z,1619817967.502 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:26:07.623Z,1619817967.623 [MassServo](DEBUG): Initializing MassServo.
2021-04-30T21:26:07.633Z,1619817967.633 [CBIT](INFO): Clearing failed state for component MassServo
2021-04-30T21:26:07.633Z,1619817967.633 [MassServo] No Fault, FailCount= 4
2021-04-30T21:26:08.316Z,1619817968.316 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-04-30T21:26:08.316Z,1619817968.316 [WetLabsBB2FL] No Fault, FailCount= 4
2021-04-30T21:26:08.378Z,1619817968.378 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-04-30T21:26:08.378Z,1619817968.378 [CTD_Seabird] Communications Fault, FailCount= 2
2021-04-30T21:26:08.378Z,1619817968.378 [CTD_Seabird](ERROR): Communications Fault
2021-04-30T21:26:08.567Z,1619817968.567 [WetLabsBB2FL](INFO): Powering up
2021-04-30T21:26:08.745Z,1619817968.745 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-04-30T21:26:08.782Z,1619817968.782 [CTD_Seabird](INFO): Powering down
2021-04-30T21:26:09.911Z,1619817969.911 [NAL9602](INFO): Powering up NAL9602
2021-04-30T21:26:09.943Z,1619817969.943 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2021-04-30T21:26:09.943Z,1619817969.943 [CTD_Seabird] No Fault, FailCount= 2
2021-04-30T21:26:10.126Z,1619817970.126 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-04-30T21:26:11.982Z,1619817971.982 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008524
CHAN A1 (24V): 0.010346
CHAN A2 (12V): -0.005496
CHAN A3 (5V): -0.002943
CHAN B0 (3.3V): -0.000410
CHAN B1 (3.15aV): -0.000966
CHAN B2 (3.15bV): -0.001965
CHAN B3 (GND): -0.000266
OPEN: -0.001210
Full Scale Calc: 4.765 mA, -1.589 mA
2021-04-30T21:26:13.858Z,1619817973.858 [WetLabsBB2FL] Communications Fault, FailCount= 5
2021-04-30T21:26:13.858Z,1619817973.858 [WetLabsBB2FL](ERROR): Communications Fault
2021-04-30T21:26:13.986Z,1619817973.986 [MassServo](FAULT): Overload Error
2021-04-30T21:26:13.986Z,1619817973.986 [MassServo] Hardware Fault, FailCount= 5
2021-04-30T21:26:13.986Z,1619817973.986 [MassServo](ERROR): Hardware Fault
2021-04-30T21:26:14.026Z,1619817974.026 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-04-30T21:26:14.027Z,1619817974.027 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2021-04-30T21:26:14.027Z,1619817974.027 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-04-30T21:26:14.027Z,1619817974.027 [CBIT](CRITICAL): Hardware Fault in component: MassServo
2021-04-30T21:26:14.358Z,1619817974.358 [WetLabsBB2FL](INFO): Powering down
2021-04-30T21:26:14.375Z,1619817974.375 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-04-30T21:26:14.375Z,1619817974.375 [MassServo](INFO): Powering down
2021-04-30T21:26:14.377Z,1619817974.377 [SBIT](ERROR): Could not read massPosReader_.
2021-04-30T21:26:14.379Z,1619817974.379 [CommandLine](FAULT): Scheduling is paused
2021-04-30T21:26:14.379Z,1619817974.379 [CBIT](INFO): Critical error at 20210430T212614
2021-04-30T21:26:14.379Z,1619817974.379 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2021-04-30T21:26:15.176Z,1619817975.176 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:26:15.291Z,1619817975.291 [MassServo](DEBUG): Initializing MassServo.
2021-04-30T21:26:20.298Z,1619817980.298 [CommandLine](IMPORTANT): got command failComponent
2021-04-30T21:26:20.299Z,1619817980.299 [CommandLine](IMPORTANT): Failed components:
2021-04-30T21:26:20.299Z,1619817980.299 [CommandLine](IMPORTANT): WetLabsBB2FL: Communications Fault
2021-04-30T21:26:20.299Z,1619817980.299 [CommandLine](IMPORTANT): MassServo: Hardware Fault
2021-04-30T21:26:20.835Z,1619817980.835 [NAL9602](INFO): NAL9602 initialized
2021-04-30T21:26:23.178Z,1619817983.178 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-04-30T21:26:23.178Z,1619817983.178 [CTD_Seabird] Communications Fault, FailCount= 3
2021-04-30T21:26:23.178Z,1619817983.178 [CTD_Seabird](ERROR): Communications Fault
2021-04-30T21:26:23.277Z,1619817983.277 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-04-30T21:26:23.278Z,1619817983.278 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2021-04-30T21:26:23.582Z,1619817983.582 [CTD_Seabird](INFO): Powering down
2021-04-30T21:26:24.667Z,1619817984.667 [CommandLine](IMPORTANT): got command failComponent none MassServo
2021-04-30T21:26:24.667Z,1619817984.667 [MassServo] No Fault, FailCount= 5
2021-04-30T21:26:24.667Z,1619817984.667 [CommandLine](IMPORTANT): MassServo failureMode is No Fault
2021-04-30T21:26:29.362Z,1619817989.362 [MassServo](FAULT): Overload Error
2021-04-30T21:26:29.362Z,1619817989.362 [MassServo] Hardware Fault, FailCount= 6
2021-04-30T21:26:29.362Z,1619817989.362 [MassServo](ERROR): Hardware Fault
2021-04-30T21:26:29.367Z,1619817989.367 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-04-30T21:26:29.367Z,1619817989.367 [CBIT](CRITICAL): Hardware Fault in component: MassServo
2021-04-30T21:26:29.746Z,1619817989.746 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-04-30T21:26:29.747Z,1619817989.747 [MassServo](INFO): Powering down
2021-04-30T21:26:29.750Z,1619817989.750 [CBIT](INFO): Critical error at 20210430T212629
2021-04-30T21:26:30.535Z,1619817990.535 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:26:30.651Z,1619817990.651 [MassServo](DEBUG): Initializing MassServo.
2021-04-30T21:26:41.021Z,1619818001.021 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2021-04-30T21:26:41.021Z,1619818001.021 [DAT] Communications Fault, FailCount= 1
2021-04-30T21:26:41.021Z,1619818001.021 [DAT](ERROR): Communications Fault
2021-04-30T21:26:41.032Z,1619818001.032 [SBIT](ERROR): Could not read massPosReader_.
2021-04-30T21:26:41.032Z,1619818001.032 [SBIT](FAULT): Control surface position failure.
2021-04-30T21:26:41.035Z,1619818001.035 [CBIT](ERROR): Communications Fault in component: DAT
2021-04-30T21:26:41.455Z,1619818001.455 [DAT](INFO): Powering down
2021-04-30T21:26:42.267Z,1619818002.267 [CBIT](INFO): Clearing failed state for component DAT
2021-04-30T21:26:42.267Z,1619818002.267 [DAT] No Fault, FailCount= 1
2021-04-30T21:26:44.678Z,1619818004.678 [DAT](INFO): Powering up
2021-04-30T21:26:44.678Z,1619818004.678 [DAT](DEBUG): Initializing DAT.
2021-04-30T21:26:54.832Z,1619818014.832 [SBIT](ERROR): Could not read massPosReader_.
2021-04-30T21:26:54.832Z,1619818014.832 [SBIT](FAULT): Control surface position failure.
2021-04-30T21:26:55.212Z,1619818015.212 [SBIT](CRITICAL): SBIT FAILED
2021-04-30T21:26:55.212Z,1619818015.212 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2021-04-30T21:26:55.213Z,1619818015.213 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2021-04-30T21:26:55.213Z,1619818015.213 [SBIT](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;

2021-04-30T21:26:55.213Z,1619818015.213 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;

2021-04-30T21:26:55.213Z,1619818015.213 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2021-04-30T21:26:55.213Z,1619818015.213 [SBIT](IMPORTANT): MassServo.overloadTimeout=10 second;

2021-04-30T21:26:55.213Z,1619818015.213 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool;

2021-04-30T21:26:55.242Z,1619818015.242 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=235 cubic_centimeter;

2021-04-30T21:26:55.242Z,1619818015.242 [SBIT](IMPORTANT): VerticalControl.massDefault=0 centimeter;

2021-04-30T21:26:55.244Z,1619818015.244 [CBIT](INFO): Critical error at 20210430T212655
2021-04-30T21:26:55.616Z,1619818015.616 [MissionManager](IMPORTANT): Started mission Startup
2021-04-30T21:26:55.616Z,1619818015.616 [Startup] Running Loop=1
2021-04-30T21:26:55.616Z,1619818015.616 [Startup](DEBUG): Aggregate::initialize Startup
2021-04-30T21:26:55.616Z,1619818015.616 [Startup:A.GoToSurface] Running Loop=1
2021-04-30T21:26:55.616Z,1619818015.616 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-04-30T21:26:55.617Z,1619818015.617 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-04-30T21:26:55.617Z,1619818015.617 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-04-30T21:26:55.618Z,1619818015.618 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-04-30T21:26:55.618Z,1619818015.618 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-04-30T21:26:55.618Z,1619818015.618 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-04-30T21:26:55.620Z,1619818015.620 [Startup:StartupSatComms] Running Loop=1
2021-04-30T21:26:55.620Z,1619818015.620 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2021-04-30T21:26:55.620Z,1619818015.620 [Startup:StartupSatComms:A] Running Loop=1
2021-04-30T21:26:55.995Z,1619818015.995 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2021-04-30T21:27:40.824Z,1619818060.824 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2021-04-30T21:27:40.824Z,1619818060.824 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2021-04-30T21:27:40.824Z,1619818060.824 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-04-30T21:27:40.825Z,1619818060.825 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2021-04-30T21:27:40.825Z,1619818060.825 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2021-04-30T21:27:40.825Z,1619818060.825 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2021-04-30T21:27:40.835Z,1619818060.835 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-04-30T21:27:40.835Z,1619818060.835 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2021-04-30T21:27:41.233Z,1619818061.233 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-04-30T21:27:41.233Z,1619818061.233 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2021-04-30T21:27:41.233Z,1619818061.233 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2021-04-30T21:27:41.233Z,1619818061.233 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2021-04-30T21:27:41.631Z,1619818061.631 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-04-30T21:27:44.861Z,1619818064.861 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2021-04-30T21:27:44.861Z,1619818064.861 [DAT] Communications Fault, FailCount= 2
2021-04-30T21:27:44.861Z,1619818064.861 [DAT](ERROR): Communications Fault
2021-04-30T21:27:44.876Z,1619818064.876 [CBIT](ERROR): Communications Fault in component: DAT
2021-04-30T21:27:45.259Z,1619818065.259 [DAT](INFO): Powering down
2021-04-30T21:27:46.086Z,1619818066.086 [CBIT](INFO): Clearing failed state for component DAT
2021-04-30T21:27:46.086Z,1619818066.086 [DAT] No Fault, FailCount= 2
2021-04-30T21:27:48.570Z,1619818068.570 [DAT](INFO): Powering up
2021-04-30T21:27:48.571Z,1619818068.571 [DAT](DEBUG): Initializing DAT.
2021-04-30T21:27:55.773Z,1619818075.773 [Startup:StartupSatComms:A](INFO): Timed out from 2021-04-30T21:26:55.6Z
2021-04-30T21:27:55.773Z,1619818075.773 [Startup:StartupSatComms:A] Stopped
2021-04-30T21:27:55.774Z,1619818075.774 [Startup:StartupSatComms:B] Running Loop=1
2021-04-30T21:27:56.175Z,1619818076.175 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2021-04-30T21:23:14.644Z,1619817794.644 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004905
2021-04-30T21:23:21.617Z,1619817801.617 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20210430T210712/Courier0007.lzma
2021-04-30T21:23:22.619Z,1619817802.619 [DataOverHttps](INFO): Moved sent file to Logs/20210430T210712/Courier0007.lzma.bak
2021-04-30T21:23:22.620Z,1619817802.620 [DataOverHttps](INFO): SBD MOMSN=15612564
2021-04-30T21:23:37.937Z,1619817817.937 [DataOverHttps](INFO): Sending 135 bytes from file Logs/20210430T212343/Courier0000.lzma
2021-04-30T21:23:38.939Z,1619817818.939 [DataOverHttps](INFO): Moved sent file to Logs/20210430T212343/Courier0000.lzma.bak
2021-04-30T21:23:38.939Z,1619817818.939 [DataOverHttps](INFO): SBD MOMSN=15612566
2021-04-30T21:23:49.966Z,1619817829.966 [CommandLine](IMPORTANT): got command failComponent
2021-04-30T21:23:49.966Z,1619817829.966 [CommandLine](IMPORTANT): Failed components:
2021-04-30T21:23:49.966Z,1619817829.966 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault
2021-04-30T21:23:49.966Z,1619817829.966 [CommandLine](IMPORTANT): WetLabsBB2FL: Communications Fault
2021-04-30T21:23:49.967Z,1619817829.967 [CommandLine](IMPORTANT): MassServo: Hardware Fault
2021-04-30T21:23:52.774Z,1619817832.774 [CommandLine](IMPORTANT): got command failComponent none MassServo
2021-04-30T21:23:52.774Z,1619817832.774 [MassServo] No Fault, FailCount= 6
2021-04-30T21:23:52.774Z,1619817832.774 [CommandLine](IMPORTANT): MassServo failureMode is No Fault
2021-04-30T21:23:53.992Z,1619817833.992 [DataOverHttps](INFO): Sending 127 bytes from file Logs/20210430T212531/Courier0000.lzma
2021-04-30T21:23:54.995Z,1619817834.995 [DataOverHttps](INFO): Moved sent file to Logs/20210430T212531/Courier0000.lzma.bak
2021-04-30T21:23:54.995Z,1619817834.995 [DataOverHttps](INFO): SBD MOMSN=15612573
2021-04-30T21:23:59.078Z,1619817839.078 [CommandLine](IMPORTANT): got command failComponent
2021-04-30T21:23:59.078Z,1619817839.078 [CommandLine](IMPORTANT): Failed components:
2021-04-30T21:23:59.078Z,1619817839.078 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault
2021-04-30T21:23:59.078Z,1619817839.078 [CommandLine](IMPORTANT): WetLabsBB2FL: Communications Fault
2021-04-30T21:24:05.183Z,1619817845.183 [CommandLine](IMPORTANT): got command 
2021-04-30T21:24:05.183Z,1619817845.183 [CommandLine](FAULT): Incomplete syntax. Try: help
2021-04-30T21:24:06.062Z,1619817846.062 [CommandLine](IMPORTANT): got command failComponent
2021-04-30T21:24:06.062Z,1619817846.062 [CommandLine](IMPORTANT): Failed components:
2021-04-30T21:24:06.062Z,1619817846.062 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault
2021-04-30T21:24:06.062Z,1619817846.062 [CommandLine](IMPORTANT): WetLabsBB2FL: Communications Fault
2021-04-30T21:24:07.527Z,1619817847.527 [CommandLine](IMPORTANT): got command failComponent
2021-04-30T21:24:07.527Z,1619817847.527 [CommandLine](IMPORTANT): Failed components:
2021-04-30T21:24:07.527Z,1619817847.527 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault
2021-04-30T21:24:07.527Z,1619817847.527 [CommandLine](IMPORTANT): WetLabsBB2FL: Communications Fault
2021-04-30T21:24:11.112Z,1619817851.112 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20210430T210712/Express0008.lzma
2021-04-30T21:24:12.115Z,1619817852.115 [DataOverHttps](INFO): Moved sent file to Logs/20210430T210712/Express0008.lzma.bak
2021-04-30T21:24:12.115Z,1619817852.115 [DataOverHttps](INFO): SBD MOMSN=15612579
2021-04-30T21:24:27.167Z,1619817867.167 [DataOverHttps](INFO): Sending 1428 bytes from file Logs/20210430T212343/Express0001.lzma
2021-04-30T21:24:28.163Z,1619817868.163 [DataOverHttps](INFO): Moved sent file to Logs/20210430T212343/Express0001.lzma.bak
2021-04-30T21:24:28.163Z,1619817868.163 [DataOverHttps](INFO): SBD MOMSN=15612581
2021-04-30T21:24:43.690Z,1619817883.690 [DataOverHttps](INFO): Sending 1210 bytes from file Logs/20210430T212531/Express0001.lzma
2021-04-30T21:24:44.140Z,1619817884.140 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2021-04-30T21:24:44.691Z,1619817884.691 [DataOverHttps](INFO): Moved sent file to Logs/20210430T212531/Express0001.lzma.bak
2021-04-30T21:24:44.691Z,1619817884.691 [DataOverHttps](INFO): SBD MOMSN=15612648
2021-04-30T21:24:46.996Z,1619817886.996 [Startup:StartupSatComms:B] Stopped
2021-04-30T21:24:46.997Z,1619817886.997 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2021-04-30T21:24:46.997Z,1619817886.997 [Startup:StartupSatComms] Stopped
2021-04-30T21:24:46.997Z,1619817886.997 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2021-04-30T21:24:46.998Z,1619817886.998 [Startup](INFO): Completed Startup
2021-04-30T21:24:46.998Z,1619817886.998 [MissionManager](INFO): Startup is completed.
2021-04-30T21:24:46.998Z,1619817886.998 [MissionManager](INFO): Uninitializing Mission Startup
2021-04-30T21:24:46.998Z,1619817886.998 [Startup] Stopped
2021-04-30T21:24:46.998Z,1619817886.998 [Startup](DEBUG): Aggregate::uninitialize Startup
2021-04-30T21:24:46.998Z,1619817886.998 [Startup:A.GoToSurface] Stopped
2021-04-30T21:24:46.998Z,1619817886.998 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-04-30T21:24:47.378Z,1619817887.378 [MissionManager](IMPORTANT): Started mission Default
2021-04-30T21:24:47.378Z,1619817887.378 [Default] Running Loop=1
2021-04-30T21:24:47.378Z,1619817887.378 [Default](DEBUG): Aggregate::initialize Default
2021-04-30T21:24:47.378Z,1619817887.378 [Default:B.GoToSurface] Running Loop=1
2021-04-30T21:24:47.378Z,1619817887.378 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-04-30T21:24:47.378Z,1619817887.378 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-04-30T21:24:47.379Z,1619817887.379 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-04-30T21:24:47.379Z,1619817887.379 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-04-30T21:24:47.379Z,1619817887.379 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-04-30T21:24:47.380Z,1619817887.380 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-04-30T21:24:47.380Z,1619817887.380 [Default:A.Wait] Running Loop=1
2021-04-30T21:24:47.380Z,1619817887.380 [Default:A.Wait](DEBUG): Initialize Wait Component.
2021-04-30T21:24:48.415Z,1619817888.415 [CommandLine](IMPORTANT): got command failComponent
2021-04-30T21:24:48.415Z,1619817888.415 [CommandLine](IMPORTANT): Failed components:
2021-04-30T21:24:48.415Z,1619817888.415 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault
2021-04-30T21:24:48.415Z,1619817888.415 [CommandLine](IMPORTANT): WetLabsBB2FL: Communications Fault
2021-04-30T21:24:51.582Z,1619817891.582 [CommandLine](IMPORTANT): got command failComponent hardware MassServo
2021-04-30T21:24:51.582Z,1619817891.582 [MassServo] Hardware Fault, FailCount= 7
2021-04-30T21:24:51.582Z,1619817891.582 [MassServo](ERROR): Hardware Fault
2021-04-30T21:24:51.582Z,1619817891.582 [CommandLine](IMPORTANT): MassServo failureMode is Hardware Fault
2021-04-30T21:24:51.839Z,1619817891.839 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-04-30T21:24:51.839Z,1619817891.839 [MassServo](INFO): Powering down
2021-04-30T21:24:51.844Z,1619817891.844 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-04-30T21:24:51.844Z,1619817891.844 [CBIT](CRITICAL): Hardware Fault in component: MassServo
2021-04-30T21:24:52.236Z,1619817892.236 [CBIT](INFO): Critical error at 20210430T212451
2021-04-30T21:24:57.574Z,1619817897.574 [CommandLine](IMPORTANT): got command failComponent none MassServo
2021-04-30T21:24:57.574Z,1619817897.574 [MassServo] No Fault, FailCount= 7
2021-04-30T21:24:57.574Z,1619817897.574 [CommandLine](IMPORTANT): MassServo failureMode is No Fault
2021-04-30T21:24:57.903Z,1619817897.903 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-30T21:24:57.909Z,1619817897.909 [MassServo](DEBUG): Initializing MassServo.
2021-04-30T21:25:00.727Z,1619817900.727 [Default:A.Wait](INFO): Done Waiting.
2021-04-30T21:25:00.727Z,1619817900.727 [Default:A.Wait] Stopped
2021-04-30T21:25:00.727Z,1619817900.727 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2021-04-30T21:25:01.125Z,1619817901.125 [Default:CheckIn] Running Loop=1
2021-04-30T21:25:01.125Z,1619817901.125 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-04-30T21:25:01.125Z,1619817901.125 [Default:CheckIn:Read_GPS] Running Loop=1
2021-04-30T21:25:01.541Z,1619817901.541 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2021-04-30T21:26:01.770Z,1619817961.770 [CommandLine](IMPORTANT): got command quit
2021-04-30T21:26:02.773Z,1619817962.773 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:02.773Z,1619817962.773 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:02.849Z,1619817962.849 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2021-04-30T21:26:02.849Z,1619817962.849 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:02.850Z,1619817962.850 [CommandLine](INFO): Join timeout helper Thread ID is 1097
2021-04-30T21:26:02.850Z,1619817962.850 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-04-30T21:26:02.850Z,1619817962.850 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:02.851Z,1619817962.851 [NavChartDb](INFO): Join timeout helper Thread ID is 1098
2021-04-30T21:26:03.229Z,1619817963.229 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:03.229Z,1619817963.229 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:03.249Z,1619817963.249 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-04-30T21:26:03.249Z,1619817963.249 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:03.249Z,1619817963.249 [Radio_Surface](INFO): Join timeout helper Thread ID is 1099
2021-04-30T21:26:03.453Z,1619817963.453 [Radio_Surface](INFO): Powering down
2021-04-30T21:26:03.454Z,1619817963.454 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:03.454Z,1619817963.454 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:03.461Z,1619817963.461 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-04-30T21:26:03.461Z,1619817963.461 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:03.461Z,1619817963.461 [Onboard](INFO): Join timeout helper Thread ID is 1100
2021-04-30T21:26:03.985Z,1619817963.985 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2021-04-30T21:26:07.361Z,1619817967.361 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:07.362Z,1619817967.362 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:07.369Z,1619817967.369 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-04-30T21:26:07.369Z,1619817967.369 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:07.369Z,1619817967.369 [DataOverHttps](INFO): Join timeout helper Thread ID is 1101
2021-04-30T21:26:08.001Z,1619817968.001 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:08.002Z,1619817968.002 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.010Z,1619817968.010 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2021-04-30T21:26:08.010Z,1619817968.010 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.010Z,1619817968.010 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1102
2021-04-30T21:26:08.169Z,1619817968.169 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:08.169Z,1619817968.169 [WetLabsBB2FL](INFO): Powering down
2021-04-30T21:26:08.170Z,1619817968.170 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.194Z,1619817968.194 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2021-04-30T21:26:08.194Z,1619817968.194 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.194Z,1619817968.194 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1103
2021-04-30T21:26:08.269Z,1619817968.269 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:08.269Z,1619817968.269 [CTD_Seabird](INFO): Powering down
2021-04-30T21:26:08.281Z,1619817968.281 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.298Z,1619817968.298 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-04-30T21:26:08.298Z,1619817968.298 [logger ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.298Z,1619817968.298 [logger](INFO): Join timeout helper Thread ID is 1104
2021-04-30T21:26:08.313Z,1619817968.313 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:08.313Z,1619817968.313 [logger ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.318Z,1619817968.318 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-04-30T21:26:08.318Z,1619817968.318 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.318Z,1619817968.318 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-04-30T21:26:08.318Z,1619817968.318 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.318Z,1619817968.318 [controlThread](INFO): Join timeout helper Thread ID is 1105
2021-04-30T21:26:08.565Z,1619817968.565 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-30T21:26:08.565Z,1619817968.565 [controlThread](DEBUG): Uninitializing ControlThread
2021-04-30T21:26:08.566Z,1619817968.566 [NAL9602](INFO): Powering down
2021-04-30T21:26:08.567Z,1619817968.567 [DAT](INFO): Powering down
2021-04-30T21:26:08.686Z,1619817968.686 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-04-30T21:26:08.686Z,1619817968.686 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-04-30T21:26:08.687Z,1619817968.687 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-04-30T21:26:08.688Z,1619817968.688 [MissionManager](INFO): Uninitializing Mission Default
2021-04-30T21:26:08.688Z,1619817968.688 [Default] Stopped
2021-04-30T21:26:08.688Z,1619817968.688 [Default](DEBUG): Aggregate::uninitialize Default
2021-04-30T21:26:08.688Z,1619817968.688 [Default:B.GoToSurface] Stopped
2021-04-30T21:26:08.688Z,1619817968.688 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-04-30T21:26:08.688Z,1619817968.688 [Default:CheckIn] Stopped
2021-04-30T21:26:08.688Z,1619817968.688 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-04-30T21:26:08.688Z,1619817968.688 [Default:CheckIn:Read_GPS] Stopped
2021-04-30T21:26:08.691Z,1619817968.691 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-04-30T21:26:08.691Z,1619817968.691 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-04-30T21:26:08.691Z,1619817968.691 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-04-30T21:26:08.692Z,1619817968.692 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-04-30T21:26:08.692Z,1619817968.692 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-04-30T21:26:08.692Z,1619817968.692 [BuoyancyServo](INFO): Powering down
2021-04-30T21:26:08.705Z,1619817968.705 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-04-30T21:26:08.705Z,1619817968.705 [ElevatorServo](INFO): Powering down
2021-04-30T21:26:08.706Z,1619817968.706 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-04-30T21:26:08.706Z,1619817968.706 [MassServo](INFO): Powering down
2021-04-30T21:26:08.707Z,1619817968.707 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-04-30T21:26:08.707Z,1619817968.707 [RudderServo](INFO): Powering down
2021-04-30T21:26:08.708Z,1619817968.708 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2021-04-30T21:26:08.708Z,1619817968.708 [ThrusterServo](INFO): Powering down
2021-04-30T21:26:08.709Z,1619817968.709 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-04-30T21:26:08.709Z,1619817968.709 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-04-30T21:26:08.709Z,1619817968.709 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-04-30T21:26:08.710Z,1619817968.710 [CBIT](DEBUG): Powering off loads.
2021-04-30T21:26:08.721Z,1619817968.721 [CBIT](DEBUG): Disabling WDT.
2021-04-30T21:26:08.733Z,1619817968.733 [CBIT](DEBUG): Opening all GF detection circuits.
2021-04-30T21:26:08.734Z,1619817968.734 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.757Z,1619817968.757 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.760Z,1619817968.760 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.806Z,1619817968.806 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.808Z,1619817968.808 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.813Z,1619817968.813 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.889Z,1619817968.889 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-04-30T21:26:08.950Z,1619817968.950 [logger ThreadHandler](INFO): Thread cancelled.