2021-08-19T17:37:33.571Z,1629394653.571 [Supervisor](DEBUG): Initializing supervisor.
2021-08-19T17:37:33.576Z,1629394653.576 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-08-19T17:37:33.576Z,1629394653.576 [SyncHandler](INFO): Protected caller Thread ID is 9515
2021-08-19T17:37:33.577Z,1629394653.577 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-08-19T17:37:33.578Z,1629394653.578 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-08-19T17:37:33.578Z,1629394653.578 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9516
2021-08-19T17:37:33.582Z,1629394653.582 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-08-19T17:37:33.602Z,1629394653.602 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-08-19T17:37:33.603Z,1629394653.603 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-08-19T17:37:33.604Z,1629394653.604 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9517
2021-08-19T17:37:33.606Z,1629394653.606 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-08-19T17:37:33.607Z,1629394653.607 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-08-19T17:37:33.607Z,1629394653.607 [logger ThreadHandler](INFO): Protected caller Thread ID is 9518
2021-08-19T17:37:33.611Z,1629394653.611 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-08-19T17:37:33.612Z,1629394653.612 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-08-19T17:37:33.613Z,1629394653.613 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-08-19T17:37:34.069Z,1629394654.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-08-19T17:37:34.070Z,1629394654.070 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-08-19T17:37:34.302Z,1629394654.302 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-08-19T17:37:34.303Z,1629394654.303 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-08-19T17:37:34.511Z,1629394654.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-08-19T17:37:34.511Z,1629394654.511 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-08-19T17:37:34.625Z,1629394654.625 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-08-19T17:37:34.625Z,1629394654.625 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-08-19T17:37:35.028Z,1629394655.028 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-08-19T17:37:35.029Z,1629394655.029 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-08-19T17:37:35.395Z,1629394655.395 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-08-19T17:37:35.395Z,1629394655.395 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-08-19T17:37:35.497Z,1629394655.497 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-08-19T17:37:35.498Z,1629394655.498 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-08-19T17:37:35.658Z,1629394655.658 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-08-19T17:37:35.659Z,1629394655.659 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-08-19T17:37:36.238Z,1629394656.238 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-08-19T17:37:36.239Z,1629394656.239 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-08-19T17:37:36.628Z,1629394656.628 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-08-19T17:37:36.629Z,1629394656.629 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-08-19T17:37:36.713Z,1629394656.713 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-08-19T17:37:36.935Z,1629394656.935 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-08-19T17:37:36.936Z,1629394656.936 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-08-19T17:37:37.070Z,1629394657.070 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-08-19T17:37:37.071Z,1629394657.071 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-08-19T17:37:37.847Z,1629394657.847 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-08-19T17:37:37.848Z,1629394657.848 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-08-19T17:37:38.043Z,1629394658.043 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-08-19T17:37:38.573Z,1629394658.573 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-08-19T17:37:38.725Z,1629394658.725 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2021-08-19T17:37:38.726Z,1629394658.726 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2021-08-19T17:37:38.913Z,1629394658.913 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2021-08-19T17:37:39.012Z,1629394659.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2021-08-19T17:37:39.130Z,1629394659.130 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2021-08-19T17:37:39.238Z,1629394659.238 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2021-08-19T17:37:39.326Z,1629394659.326 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2021-08-19T17:37:39.415Z,1629394659.415 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2021-08-19T17:37:39.536Z,1629394659.536 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2021-08-19T17:37:39.641Z,1629394659.641 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2021-08-19T17:37:39.795Z,1629394659.795 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2021-08-19T17:37:40.073Z,1629394660.073 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-08-19T17:37:40.073Z,1629394660.073 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2021-08-19T17:37:40.174Z,1629394660.174 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2021-08-19T17:37:40.174Z,1629394660.174 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-08-19T17:37:40.191Z,1629394660.191 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-08-19T17:37:40.540Z,1629394660.540 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-08-19T17:37:40.541Z,1629394660.541 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-08-19T17:37:40.625Z,1629394660.625 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-08-19T17:37:40.626Z,1629394660.626 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-08-19T17:37:40.661Z,1629394660.661 [DeadReckonUsingSpeedCalculator] Loaded
2021-08-19T17:37:40.662Z,1629394660.662 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2021-08-19T17:37:40.675Z,1629394660.675 [NavChart] Loaded
2021-08-19T17:37:40.675Z,1629394660.675 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-08-19T17:37:40.681Z,1629394660.681 [UniversalFixResidualReporter] Loaded
2021-08-19T17:37:40.681Z,1629394660.681 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-08-19T17:37:40.682Z,1629394660.682 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-08-19T17:37:40.682Z,1629394660.682 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-08-19T17:37:40.693Z,1629394660.693 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-08-19T17:37:40.694Z,1629394660.694 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-08-19T17:37:40.875Z,1629394660.875 [ESPComponent] Loaded
2021-08-19T17:37:40.876Z,1629394660.876 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2021-08-19T17:37:40.895Z,1629394660.895 [PAR_Licor] Loaded
2021-08-19T17:37:40.896Z,1629394660.896 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2021-08-19T17:37:40.897Z,1629394660.897 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-08-19T17:37:40.897Z,1629394660.897 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-08-19T17:37:40.954Z,1629394660.954 [VerticalControl](DEBUG): Construct VerticalControl.
2021-08-19T17:37:41.015Z,1629394661.015 [VerticalControl] Loaded
2021-08-19T17:37:41.015Z,1629394661.015 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-08-19T17:37:41.018Z,1629394661.018 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-08-19T17:37:41.057Z,1629394661.057 [HorizontalControl] Loaded
2021-08-19T17:37:41.058Z,1629394661.058 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-08-19T17:37:41.060Z,1629394661.060 [SpeedControl](DEBUG): Construct SpeedControl.
2021-08-19T17:37:41.063Z,1629394661.063 [SpeedControl] Loaded
2021-08-19T17:37:41.064Z,1629394661.064 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-08-19T17:37:41.066Z,1629394661.066 [LoopControl](DEBUG): Construct LoopControl.
2021-08-19T17:37:41.067Z,1629394661.067 [LoopControl] Loaded
2021-08-19T17:37:41.067Z,1629394661.067 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-08-19T17:37:41.068Z,1629394661.068 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-08-19T17:37:41.068Z,1629394661.068 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-08-19T17:37:41.112Z,1629394661.112 [DepthRateCalculator] Loaded
2021-08-19T17:37:41.113Z,1629394661.113 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-08-19T17:37:41.117Z,1629394661.117 [PitchRateCalculator] Loaded
2021-08-19T17:37:41.118Z,1629394661.118 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-08-19T17:37:41.127Z,1629394661.127 [SpeedCalculator] Loaded
2021-08-19T17:37:41.127Z,1629394661.127 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-08-19T17:37:41.142Z,1629394661.142 [TempGradientCalculator] Loaded
2021-08-19T17:37:41.142Z,1629394661.142 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-08-19T17:37:41.146Z,1629394661.146 [YawRateCalculator] Loaded
2021-08-19T17:37:41.147Z,1629394661.147 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-08-19T17:37:41.164Z,1629394661.164 [ElevatorOffsetCalculator] Loaded
2021-08-19T17:37:41.164Z,1629394661.164 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-08-19T17:37:41.165Z,1629394661.165 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-08-19T17:37:41.165Z,1629394661.165 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-08-19T17:37:41.267Z,1629394661.267 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-08-19T17:37:41.267Z,1629394661.267 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-08-19T17:37:41.329Z,1629394661.329 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-08-19T17:37:41.330Z,1629394661.330 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-08-19T17:37:41.458Z,1629394661.458 [BuoyancyServo] Loaded
2021-08-19T17:37:41.459Z,1629394661.459 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-08-19T17:37:41.478Z,1629394661.478 [ElevatorServo] Loaded
2021-08-19T17:37:41.479Z,1629394661.479 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-08-19T17:37:41.499Z,1629394661.499 [MassServo] Loaded
2021-08-19T17:37:41.499Z,1629394661.499 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-08-19T17:37:41.518Z,1629394661.518 [RudderServo] Loaded
2021-08-19T17:37:41.518Z,1629394661.518 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-08-19T17:37:41.536Z,1629394661.536 [ThrusterServo] Loaded
2021-08-19T17:37:41.536Z,1629394661.536 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2021-08-19T17:37:41.537Z,1629394661.537 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-08-19T17:37:41.537Z,1629394661.537 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-08-19T17:37:41.649Z,1629394661.649 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-08-19T17:37:41.649Z,1629394661.649 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-08-19T17:37:42.881Z,1629394662.881 [BPC1] Loaded
2021-08-19T17:37:42.882Z,1629394662.882 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-08-19T17:37:42.959Z,1629394662.959 [DataOverHttps] Loaded
2021-08-19T17:37:42.960Z,1629394662.960 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-08-19T17:37:42.961Z,1629394662.961 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409B34E0
2021-08-19T17:37:42.961Z,1629394662.961 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9600
2021-08-19T17:37:42.983Z,1629394662.983 [Depth_Keller] Loaded
2021-08-19T17:37:42.983Z,1629394662.983 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-08-19T17:37:43.047Z,1629394663.047 [NAL9602] Loaded
2021-08-19T17:37:43.047Z,1629394663.047 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-08-19T17:37:43.076Z,1629394663.076 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2021-08-19T17:37:43.077Z,1629394663.077 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2021-08-19T17:37:43.077Z,1629394663.077 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2021-08-19T17:37:43.078Z,1629394663.078 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2021-08-19T17:37:43.079Z,1629394663.079 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2021-08-19T17:37:43.079Z,1629394663.079 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2021-08-19T17:37:43.080Z,1629394663.080 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2021-08-19T17:37:43.080Z,1629394663.080 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2021-08-19T17:37:43.080Z,1629394663.080 [Onboard] Loaded
2021-08-19T17:37:43.081Z,1629394663.081 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-08-19T17:37:43.082Z,1629394663.082 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409E34E0
2021-08-19T17:37:43.082Z,1629394663.082 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9601
2021-08-19T17:37:43.096Z,1629394663.096 [Power24vConverter] Loaded
2021-08-19T17:37:43.096Z,1629394663.096 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2021-08-19T17:37:43.110Z,1629394663.110 [Radio_Surface] Loaded
2021-08-19T17:37:43.110Z,1629394663.110 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-08-19T17:37:43.111Z,1629394663.111 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A134E0
2021-08-19T17:37:43.112Z,1629394663.112 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9602
2021-08-19T17:37:43.157Z,1629394663.157 [RDI_Pathfinder] Loaded
2021-08-19T17:37:43.157Z,1629394663.157 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2021-08-19T17:37:43.247Z,1629394663.247 [DAT] Loaded
2021-08-19T17:37:43.247Z,1629394663.247 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2021-08-19T17:37:43.247Z,1629394663.247 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-08-19T17:37:43.248Z,1629394663.248 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-08-19T17:37:43.623Z,1629394663.623 [SBIT](DEBUG): Construct Startup Built In Test.
2021-08-19T17:37:43.634Z,1629394663.634 [SBIT] Loaded
2021-08-19T17:37:43.634Z,1629394663.634 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-08-19T17:37:43.639Z,1629394663.639 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-08-19T17:37:43.653Z,1629394663.653 [IBIT] Loaded
2021-08-19T17:37:43.653Z,1629394663.653 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-08-19T17:37:43.659Z,1629394663.659 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-08-19T17:37:43.766Z,1629394663.766 [CBIT] Loaded
2021-08-19T17:37:43.766Z,1629394663.766 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-08-19T17:37:43.767Z,1629394663.767 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-08-19T17:37:43.767Z,1629394663.767 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-08-19T17:37:43.796Z,1629394663.796 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-08-19T17:37:43.802Z,1629394663.802 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-08-19T17:37:43.805Z,1629394663.805 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-08-19T17:37:43.816Z,1629394663.816 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-08-19T17:37:43.817Z,1629394663.817 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A9E4E0
2021-08-19T17:37:43.818Z,1629394663.818 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9603
2021-08-19T17:37:43.822Z,1629394663.822 [Supervisor](INFO): Main Thread ID is 9237
2021-08-19T17:37:43.823Z,1629394663.823 [Supervisor](DEBUG): Running supervisor.
2021-08-19T17:37:43.823Z,1629394663.823 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9604
2021-08-19T17:37:43.827Z,1629394663.827 [controlThread ThreadHandler](INFO): Handler Thread ID is 9605
2021-08-19T17:37:43.827Z,1629394663.827 [controlThread](DEBUG): Initializing ControlThread
2021-08-19T17:37:43.829Z,1629394663.829 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-08-19T17:37:43.829Z,1629394663.829 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-08-19T17:37:43.830Z,1629394663.830 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-08-19T17:37:43.833Z,1629394663.833 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-08-19T17:37:43.835Z,1629394663.835 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-08-19T17:37:43.835Z,1629394663.835 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-08-19T17:37:43.836Z,1629394663.836 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-08-19T17:37:43.836Z,1629394663.836 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-08-19T17:37:43.837Z,1629394663.837 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-08-19T17:37:43.837Z,1629394663.837 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-08-19T17:37:43.837Z,1629394663.837 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-08-19T17:37:43.838Z,1629394663.838 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-08-19T17:37:43.838Z,1629394663.838 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-08-19T17:37:43.841Z,1629394663.841 [SBIT](INFO): Initialize SBIT Component.
2021-08-19T17:37:43.842Z,1629394663.842 [SBIT](IMPORTANT): git: 2021-06-24-10-g1c68dac98
2021-08-19T17:37:43.842Z,1629394663.842 [SBIT](INFO): git hash: 1c68dac98e3954a039edc16fe17de653428a8fd0
2021-08-19T17:37:43.843Z,1629394663.843 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-08-19T17:37:43.844Z,1629394663.844 [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-08-19T17:37:43.845Z,1629394663.845 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2021-08-19T17:37:43.846Z,1629394663.846 [IBIT](INFO): Initialize IBIT Component.
2021-08-19T17:37:43.847Z,1629394663.847 [CBIT](DEBUG): Initialize CBIT Component.
2021-08-19T17:37:43.848Z,1629394663.848 [logger ThreadHandler](INFO): Handler Thread ID is 9606
2021-08-19T17:37:43.860Z,1629394663.860 [CBIT](DEBUG): Initialized mux pins.
2021-08-19T17:37:43.861Z,1629394663.861 [CBIT](DEBUG): Initializing the watchdog timer.
2021-08-19T17:37:43.865Z,1629394663.865 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9607
2021-08-19T17:37:43.866Z,1629394663.866 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2021-08-19T17:37:43.873Z,1629394663.873 [Onboard ThreadHandler](INFO): Handler Thread ID is 9608
2021-08-19T17:37:43.885Z,1629394663.885 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-08-19T17:37:43.886Z,1629394663.886 [CBIT](DEBUG): Initializing heartbeat.
2021-08-19T17:37:43.893Z,1629394663.893 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9609
2021-08-19T17:37:43.901Z,1629394663.901 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9610
2021-08-19T17:37:43.905Z,1629394663.905 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-08-19T17:37:43.905Z,1629394663.905 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-08-19T17:37:43.905Z,1629394663.905 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-08-19T17:37:43.905Z,1629394663.905 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-08-19T17:37:43.905Z,1629394663.905 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-08-19T17:37:43.905Z,1629394663.905 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-08-19T17:37:43.906Z,1629394663.906 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-08-19T17:37:43.906Z,1629394663.906 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-08-19T17:37:43.906Z,1629394663.906 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-08-19T17:37:43.906Z,1629394663.906 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-08-19T17:37:43.906Z,1629394663.906 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-08-19T17:37:43.906Z,1629394663.906 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-08-19T17:37:43.907Z,1629394663.907 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-08-19T17:37:43.907Z,1629394663.907 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-08-19T17:37:43.907Z,1629394663.907 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-08-19T17:37:43.907Z,1629394663.907 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-08-19T17:37:43.956Z,1629394663.956 [CBIT](DEBUG): Deactivating GF circuits.
2021-08-19T17:37:43.956Z,1629394663.956 [CBIT](DEBUG): Deactivating emergency mode.
2021-08-19T17:37:43.992Z,1629394663.992 [CBIT](DEBUG): Backplane powered.
2021-08-19T17:37:43.993Z,1629394663.993 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2021-08-19T17:37:44.006Z,1629394664.006 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-08-19T17:37:44.026Z,1629394664.026 [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-08-19T17:37:44.027Z,1629394664.027 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2021-08-19T17:37:44.105Z,1629394664.105 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-08-19T17:37:44.107Z,1629394664.107 [Default:A.Wait](DEBUG): Construct Wait.
2021-08-19T17:37:44.125Z,1629394664.125 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-08-19T17:37:44.146Z,1629394664.146 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-08-19T17:37:44.180Z,1629394664.180 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-08-19T17:37:44.186Z,1629394664.186 [Default:E.Execute](DEBUG): Construct Execute.
2021-08-19T17:37:44.214Z,1629394664.214 [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-08-19T17:37:44.219Z,1629394664.219 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,DAT,PAR_Licor,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-08-19T17:37:44.297Z,1629394664.297 [Radio_Surface](INFO): Powering up
2021-08-19T17:37:44.300Z,1629394664.300 [Power24vConverter](INFO): Powering up.
2021-08-19T17:37:44.309Z,1629394664.309 [DAT](INFO): Powering up
2021-08-19T17:37:44.310Z,1629394664.310 [DAT](DEBUG): Initializing DAT.
2021-08-19T17:37:44.374Z,1629394664.374 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-19T17:37:44.389Z,1629394664.389 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-19T17:37:44.390Z,1629394664.390 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-08-19T17:37:44.401Z,1629394664.401 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-08-19T17:37:44.402Z,1629394664.402 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-19T17:37:44.409Z,1629394664.409 [MassServo](DEBUG): Initializing MassServo.
2021-08-19T17:37:44.410Z,1629394664.410 [RudderServo](DEBUG): Initializing EZServoServo.
2021-08-19T17:37:44.417Z,1629394664.417 [RudderServo](DEBUG): Initializing RudderServo.
2021-08-19T17:37:44.418Z,1629394664.418 [ThrusterServo](DEBUG): Initializing EZServoServo.
2021-08-19T17:37:44.425Z,1629394664.425 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2021-08-19T17:37:45.372Z,1629394665.372 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2021-08-19T17:37:45.373Z,1629394665.373 [RudderServo](FAULT): Rudder failed to initialize
2021-08-19T17:37:45.373Z,1629394665.373 [RudderServo] Communications Fault, FailCount= 1
2021-08-19T17:37:45.373Z,1629394665.373 [RudderServo](ERROR): Communications Fault
2021-08-19T17:37:45.473Z,1629394665.473 [CBIT](ERROR): Communications Fault in component: RudderServo
2021-08-19T17:37:45.673Z,1629394665.673 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-08-19T17:37:45.674Z,1629394665.674 [RudderServo](INFO): Powering down
2021-08-19T17:37:46.326Z,1629394666.326 [RudderServo](DEBUG): Initializing EZServoServo.
2021-08-19T17:37:46.445Z,1629394666.445 [RudderServo](DEBUG): Initializing RudderServo.
2021-08-19T17:37:46.449Z,1629394666.449 [CBIT](INFO): Clearing failed state for component RudderServo
2021-08-19T17:37:46.450Z,1629394666.450 [RudderServo] No Fault, FailCount= 1
2021-08-19T17:38:04.516Z,1629394684.516 [SBIT](IMPORTANT): Beginning Startup BIT
2021-08-19T17:38:04.547Z,1629394684.547 [CBIT](IMPORTANT): Beginning ground fault scan
2021-08-19T17:38:13.362Z,1629394693.362 [NAL9602](INFO): Powering up NAL9602
2021-08-19T17:38:15.969Z,1629394695.969 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.877588
CHAN A1 (24V): 0.065588
CHAN A2 (12V): 0.919862
CHAN A3 (5V): 0.936899
CHAN B0 (3.3V): 0.729343
CHAN B1 (3.15aV): 0.967864
CHAN B2 (3.15bV): 0.967091
CHAN B3 (GND): 0.011876
OPEN: 0.027477
Full Scale Calc: 4.765 mA, -1.589 mA
2021-08-19T17:38:24.286Z,1629394704.286 [NAL9602](INFO): NAL9602 initialized
2021-08-19T17:38:25.338Z,1629394705.338 [CommandLine](IMPORTANT): got command get RDI_Pathfinder.loadAtStartup
2021-08-19T17:38:25.339Z,1629394705.339 [CommandLine](IMPORTANT): RDI_Pathfinder.loadAtStartup 1 bool
2021-08-19T17:38:29.466Z,1629394709.466 [CommandLine](IMPORTANT): got command failComponent
2021-08-19T17:38:29.466Z,1629394709.466 [CommandLine](IMPORTANT): Failed components:
2021-08-19T17:38:29.467Z,1629394709.467 [CommandLine](IMPORTANT): No failed Components.
2021-08-19T17:38:44.487Z,1629394724.487 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2021-08-19T17:38:44.487Z,1629394724.487 [DAT] Communications Fault, FailCount= 1
2021-08-19T17:38:44.487Z,1629394724.487 [DAT](ERROR): Communications Fault
2021-08-19T17:38:44.503Z,1629394724.503 [CBIT](ERROR): Communications Fault in component: DAT
2021-08-19T17:38:44.919Z,1629394724.919 [DAT](INFO): Powering down
2021-08-19T17:38:45.719Z,1629394725.719 [CBIT](INFO): Clearing failed state for component DAT
2021-08-19T17:38:45.719Z,1629394725.719 [DAT] No Fault, FailCount= 1
2021-08-19T17:38:48.162Z,1629394728.162 [DAT](INFO): Powering up
2021-08-19T17:38:48.162Z,1629394728.162 [DAT](DEBUG): Initializing DAT.
2021-08-19T17:38:58.239Z,1629394738.239 [SBIT](IMPORTANT): SBIT PASSED
2021-08-19T17:38:58.239Z,1629394738.239 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2021-08-19T17:38:58.240Z,1629394738.240 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2021-08-19T17:38:58.240Z,1629394738.240 [SBIT](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;

2021-08-19T17:38:58.240Z,1629394738.240 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2021-08-19T17:38:58.241Z,1629394738.241 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;

2021-08-19T17:38:58.241Z,1629394738.241 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2021-08-19T17:38:58.241Z,1629394738.241 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2021-08-19T17:38:58.241Z,1629394738.241 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour;

2021-08-19T17:38:58.241Z,1629394738.241 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11 volt;

2021-08-19T17:38:58.241Z,1629394738.241 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool;

2021-08-19T17:38:58.241Z,1629394738.241 [SBIT](IMPORTANT): PAR_Licor.adcCal=8.76539e-06 microampere_per_count;

2021-08-19T17:38:58.242Z,1629394738.242 [SBIT](IMPORTANT): PAR_Licor.darkCount=4 count;

2021-08-19T17:38:58.242Z,1629394738.242 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;

2021-08-19T17:38:58.242Z,1629394738.242 [SBIT](IMPORTANT): PAR_Licor.multiplier=269.34 micromole_per_second_per_square_meter_per_microampere;

2021-08-19T17:38:58.242Z,1629394738.242 [SBIT](IMPORTANT): PAR_Licor.parCal=1.221 none;

2021-08-19T17:38:58.242Z,1629394738.242 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool;

2021-08-19T17:38:58.242Z,1629394738.242 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=235 cubic_centimeter;

2021-08-19T17:38:58.242Z,1629394738.242 [SBIT](IMPORTANT): VerticalControl.massDefault=0 centimeter;

2021-08-19T17:38:58.243Z,1629394738.243 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;

2021-08-19T17:38:58.648Z,1629394738.648 [MissionManager](IMPORTANT): Started mission Startup
2021-08-19T17:38:58.649Z,1629394738.649 [Startup] Running Loop=1
2021-08-19T17:38:58.649Z,1629394738.649 [Startup](DEBUG): Aggregate::initialize Startup
2021-08-19T17:38:58.649Z,1629394738.649 [Startup:A.GoToSurface] Running Loop=1
2021-08-19T17:38:58.649Z,1629394738.649 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-08-19T17:38:58.650Z,1629394738.650 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-08-19T17:38:58.650Z,1629394738.650 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-08-19T17:38:58.650Z,1629394738.650 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-08-19T17:38:58.651Z,1629394738.651 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-08-19T17:38:58.651Z,1629394738.651 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-08-19T17:38:58.653Z,1629394738.653 [Startup:StartupSatComms] Running Loop=1
2021-08-19T17:38:58.654Z,1629394738.654 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2021-08-19T17:38:58.654Z,1629394738.654 [Startup:StartupSatComms:A] Running Loop=1
2021-08-19T17:38:59.058Z,1629394739.058 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2021-08-19T17:39:17.747Z,1629394757.747 [CommandLine](IMPORTANT): got command report touch height_above_sea_floor
2021-08-19T17:39:25.962Z,1629394765.962 [CommandLine](IMPORTANT): got command report clear
2021-08-19T17:39:39.757Z,1629394779.757 [CommandLine](IMPORTANT): got command report touch RDI_Pathfinder.height_above_sea_floor
2021-08-19T17:39:39.876Z,1629394779.876 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:41.909Z,1629394781.909 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:43.903Z,1629394783.903 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2021-08-19T17:39:43.903Z,1629394783.903 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2021-08-19T17:39:43.903Z,1629394783.903 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-08-19T17:39:43.904Z,1629394783.904 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2021-08-19T17:39:43.904Z,1629394783.904 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2021-08-19T17:39:43.905Z,1629394783.905 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2021-08-19T17:39:43.932Z,1629394783.932 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-08-19T17:39:43.932Z,1629394783.932 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2021-08-19T17:39:43.946Z,1629394783.946 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:44.302Z,1629394784.302 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-08-19T17:39:44.302Z,1629394784.302 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2021-08-19T17:39:44.302Z,1629394784.302 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2021-08-19T17:39:44.302Z,1629394784.302 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2021-08-19T17:39:44.691Z,1629394784.691 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-08-19T17:39:45.969Z,1629394785.969 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:47.959Z,1629394787.959 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:48.320Z,1629394788.320 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2021-08-19T17:39:48.320Z,1629394788.320 [DAT] Communications Fault, FailCount= 2
2021-08-19T17:39:48.320Z,1629394788.320 [DAT](ERROR): Communications Fault
2021-08-19T17:39:48.336Z,1629394788.336 [CBIT](ERROR): Communications Fault in component: DAT
2021-08-19T17:39:48.727Z,1629394788.727 [DAT](INFO): Powering down
2021-08-19T17:39:49.557Z,1629394789.557 [CBIT](INFO): Clearing failed state for component DAT
2021-08-19T17:39:49.558Z,1629394789.558 [DAT] No Fault, FailCount= 2
2021-08-19T17:39:49.991Z,1629394789.991 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:51.978Z,1629394791.978 [DAT](INFO): Powering up
2021-08-19T17:39:51.978Z,1629394791.978 [DAT](DEBUG): Initializing DAT.
2021-08-19T17:39:52.049Z,1629394792.049 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:54.053Z,1629394794.053 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:56.047Z,1629394796.047 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:58.072Z,1629394798.072 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:39:58.835Z,1629394798.835 [Startup:StartupSatComms:A](INFO): Timed out from 2021-08-19T17:38:58.7Z
2021-08-19T17:39:58.835Z,1629394798.835 [Startup:StartupSatComms:A] Stopped
2021-08-19T17:39:58.835Z,1629394798.835 [Startup:StartupSatComms:B] Running Loop=1
2021-08-19T17:39:59.246Z,1629394799.246 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2021-08-19T17:40:00.095Z,1629394800.095 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:02.133Z,1629394802.133 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:04.118Z,1629394804.118 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:04.521Z,1629394804.521 [CommandLine](IMPORTANT): got command failComponent
2021-08-19T17:40:04.521Z,1629394804.521 [CommandLine](IMPORTANT): Failed components:
2021-08-19T17:40:04.521Z,1629394804.521 [CommandLine](IMPORTANT): No failed Components.
2021-08-19T17:40:06.152Z,1629394806.152 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:08.194Z,1629394808.194 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:10.176Z,1629394810.176 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:11.623Z,1629394811.623 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005105
2021-08-19T17:40:12.227Z,1629394812.227 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:14.217Z,1629394814.217 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:15.851Z,1629394815.851 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:18.028Z,1629394818.028 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:19.889Z,1629394819.889 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:20.401Z,1629394820.401 [DataOverHttps](INFO): Sending 391 bytes from file Logs/20210819T172436/Express0008.lzma
2021-08-19T17:40:21.402Z,1629394821.402 [DataOverHttps](INFO): Moved sent file to Logs/20210819T172436/Express0008.lzma.bak
2021-08-19T17:40:21.402Z,1629394821.402 [DataOverHttps](INFO): SBD MOMSN=15896021
2021-08-19T17:40:21.918Z,1629394821.918 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:23.925Z,1629394823.925 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:26.004Z,1629394826.004 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:27.000Z,1629394828.000 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:30.081Z,1629394830.081 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:30.669Z,1629394830.669 [CommandLine](IMPORTANT): got command failComponent 
2021-08-19T17:40:30.669Z,1629394830.669 [CommandLine](IMPORTANT): Failed components:
2021-08-19T17:40:30.670Z,1629394830.670 [CommandLine](IMPORTANT): No failed Components.
2021-08-19T17:40:32.186Z,1629394832.186 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:34.188Z,1629394834.188 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:36.219Z,1629394836.219 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:38.253Z,1629394838.253 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:39.435Z,1629394839.435 [DataOverHttps](INFO): Sending 1258 bytes from file Logs/20210819T173733/Express0001.lzma
2021-08-19T17:40:40.203Z,1629394840.203 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:40.442Z,1629394840.442 [DataOverHttps](INFO): Moved sent file to Logs/20210819T173733/Express0001.lzma.bak
2021-08-19T17:40:40.443Z,1629394840.443 [DataOverHttps](INFO): SBD MOMSN=15896041
2021-08-19T17:40:42.266Z,1629394842.266 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:44.301Z,1629394844.301 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:45.413Z,1629394845.413 [Startup:StartupSatComms:B] Stopped
2021-08-19T17:40:45.414Z,1629394845.414 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2021-08-19T17:40:45.414Z,1629394845.414 [Startup:StartupSatComms] Stopped
2021-08-19T17:40:45.414Z,1629394845.414 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2021-08-19T17:40:45.415Z,1629394845.415 [Startup](INFO): Completed Startup
2021-08-19T17:40:45.415Z,1629394845.415 [MissionManager](INFO): Startup is completed.
2021-08-19T17:40:45.415Z,1629394845.415 [MissionManager](INFO): Uninitializing Mission Startup
2021-08-19T17:40:45.415Z,1629394845.415 [Startup] Stopped
2021-08-19T17:40:45.415Z,1629394845.415 [Startup](DEBUG): Aggregate::uninitialize Startup
2021-08-19T17:40:45.415Z,1629394845.415 [Startup:A.GoToSurface] Stopped
2021-08-19T17:40:45.415Z,1629394845.415 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-08-19T17:40:45.847Z,1629394845.847 [MissionManager](IMPORTANT): Started mission Default
2021-08-19T17:40:45.847Z,1629394845.847 [Default] Running Loop=1
2021-08-19T17:40:45.847Z,1629394845.847 [Default](DEBUG): Aggregate::initialize Default
2021-08-19T17:40:45.847Z,1629394845.847 [Default:B.GoToSurface] Running Loop=1
2021-08-19T17:40:45.847Z,1629394845.847 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-08-19T17:40:45.847Z,1629394845.847 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-08-19T17:40:45.848Z,1629394845.848 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-08-19T17:40:45.848Z,1629394845.848 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-08-19T17:40:45.849Z,1629394845.849 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-08-19T17:40:45.849Z,1629394845.849 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-08-19T17:40:45.849Z,1629394845.849 [Default:A.Wait] Running Loop=1
2021-08-19T17:40:45.849Z,1629394845.849 [Default:A.Wait](DEBUG): Initialize Wait Component.
2021-08-19T17:40:46.316Z,1629394846.316 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:48.329Z,1629394848.329 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:49.870Z,1629394849.870 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:51.960Z,1629394851.960 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:52.227Z,1629394852.227 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2021-08-19T17:40:52.227Z,1629394852.227 [DAT] Communications Fault, FailCount= 3
2021-08-19T17:40:52.227Z,1629394852.227 [DAT](ERROR): Communications Fault
2021-08-19T17:40:52.284Z,1629394852.284 [CBIT](ERROR): Communications Fault in component: DAT
2021-08-19T17:40:52.631Z,1629394852.631 [DAT](INFO): Powering down
2021-08-19T17:40:53.496Z,1629394853.496 [CBIT](INFO): Clearing failed state for component DAT
2021-08-19T17:40:53.496Z,1629394853.496 [DAT] No Fault, FailCount= 3
2021-08-19T17:40:53.893Z,1629394853.893 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:55.924Z,1629394855.924 [DAT](INFO): Powering up
2021-08-19T17:40:55.926Z,1629394855.926 [DAT](DEBUG): Initializing DAT.
2021-08-19T17:40:55.972Z,1629394855.972 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:58.099Z,1629394858.099 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:40:59.138Z,1629394859.138 [Default:A.Wait](INFO): Done Waiting.
2021-08-19T17:40:59.139Z,1629394859.139 [Default:A.Wait] Stopped
2021-08-19T17:40:59.139Z,1629394859.139 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2021-08-19T17:40:59.527Z,1629394859.527 [Default:CheckIn] Running Loop=1
2021-08-19T17:40:59.527Z,1629394859.527 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-08-19T17:40:59.527Z,1629394859.527 [Default:CheckIn:Read_GPS] Running Loop=1
2021-08-19T17:41:00.006Z,1629394860.006 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2021-08-19T17:41:00.043Z,1629394860.043 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:01.999Z,1629394861.999 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:04.014Z,1629394864.014 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:06.011Z,1629394866.011 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:08.035Z,1629394868.035 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:10.060Z,1629394870.060 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:12.086Z,1629394872.086 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:13.930Z,1629394873.930 [CommandLine](IMPORTANT): got command configSet AHRS_M2.verbosity 3.000000 count
2021-08-19T17:41:14.120Z,1629394874.120 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:16.101Z,1629394876.101 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:18.344Z,1629394878.344 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:20.155Z,1629394880.155 [Reporter](INFO): RDI_Pathfinder.height_above_sea_floor 0.000000 m
2021-08-19T17:41:21.458Z,1629394881.458 [CommandLine](IMPORTANT): got command report clear
2021-08-19T17:41:42.617Z,1629394902.617 [CommandLine](IMPORTANT): got command get AHRS_M2.loadAtStartup
2021-08-19T17:41:42.618Z,1629394902.618 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup 0 bool
2021-08-19T17:41:44.753Z,1629394904.753 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2021-08-19T17:41:44.754Z,1629394904.754 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2021-08-19T17:41:44.754Z,1629394904.754 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-08-19T17:41:44.755Z,1629394904.755 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2021-08-19T17:41:44.755Z,1629394904.755 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2021-08-19T17:41:44.755Z,1629394904.755 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2021-08-19T17:41:44.767Z,1629394904.767 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-08-19T17:41:44.767Z,1629394904.767 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2021-08-19T17:41:45.173Z,1629394905.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-08-19T17:41:45.173Z,1629394905.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2021-08-19T17:41:45.174Z,1629394905.174 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2021-08-19T17:41:45.174Z,1629394905.174 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2021-08-19T17:41:45.562Z,1629394905.562 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-08-19T17:41:56.091Z,1629394916.091 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2021-08-19T17:41:56.091Z,1629394916.091 [DAT] Communications Fault, FailCount= 4
2021-08-19T17:41:56.091Z,1629394916.091 [DAT](ERROR): Communications Fault
2021-08-19T17:41:56.106Z,1629394916.106 [CBIT](ERROR): Communications Fault in component: DAT
2021-08-19T17:41:56.477Z,1629394916.477 [DAT](INFO): Powering down
2021-08-19T17:41:57.301Z,1629394917.301 [CBIT](INFO): Clearing failed state for component DAT
2021-08-19T17:41:57.301Z,1629394917.301 [DAT] No Fault, FailCount= 4
2021-08-19T17:41:59.697Z,1629394919.697 [DAT](INFO): Powering up
2021-08-19T17:41:59.697Z,1629394919.697 [DAT](DEBUG): Initializing DAT.
2021-08-19T17:42:07.758Z,1629394927.758 [CommandLine](IMPORTANT): got command configSet AHRS_M2.loadAtStartup 1.000000 bool persist
2021-08-19T17:42:07.758Z,1629394927.758 [CommandLine](IMPORTANT): configSet AHRS_M2.loadAtStartup requires a restart to take effect.
2021-08-19T17:42:27.578Z,1629394947.578 [CommandLine](IMPORTANT): got command get WetLabsBB2FL.loadAtStartup 
2021-08-19T17:42:27.579Z,1629394947.579 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup 0 bool
2021-08-19T17:42:41.451Z,1629394961.451 [CommandLine](IMPORTANT): got command configSet WetLabsBB2FL.loadAtStartup 1.000000 bool persist
2021-08-19T17:42:41.451Z,1629394961.451 [CommandLine](IMPORTANT): configSet WetLabsBB2FL.loadAtStartup requires a restart to take effect.
2021-08-19T17:42:59.948Z,1629394979.948 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2021-08-19T17:42:59.979Z,1629394979.979 [DAT] Communications Fault, FailCount= 5
2021-08-19T17:42:59.979Z,1629394979.979 [DAT](ERROR): Communications Fault
2021-08-19T17:42:59.997Z,1629394979.997 [CBIT](ERROR): Communications Fault in component: DAT
2021-08-19T17:43:00.295Z,1629394980.295 [DAT](INFO): Powering down
2021-08-19T17:43:01.120Z,1629394981.120 [CBIT](INFO): Clearing failed state for component DAT
2021-08-19T17:43:01.120Z,1629394981.120 [DAT] No Fault, FailCount= 5
2021-08-19T17:43:03.529Z,1629394983.529 [DAT](INFO): Powering up
2021-08-19T17:43:03.529Z,1629394983.529 [DAT](DEBUG): Initializing DAT.
2021-08-19T17:43:09.347Z,1629394989.347 [CommandLine](IMPORTANT): got command configSet CTD_Seabird.loadAtStartup 1.000000 bool persist
2021-08-19T17:43:09.348Z,1629394989.348 [CommandLine](IMPORTANT): configSet CTD_Seabird.loadAtStartup requires a restart to take effect.
2021-08-19T17:43:18.586Z,1629394998.586 [CommandLine](IMPORTANT): got command restart application
2021-08-19T17:43:19.592Z,1629394999.592 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2021-08-19T17:43:19.593Z,1629394999.593 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-19T17:43:19.593Z,1629394999.593 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:19.780Z,1629394999.780 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2021-08-19T17:43:19.781Z,1629394999.781 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:19.782Z,1629394999.782 [CommandLine](INFO): Join timeout helper Thread ID is 9642
2021-08-19T17:43:19.783Z,1629394999.783 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-08-19T17:43:19.783Z,1629394999.783 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:19.784Z,1629394999.784 [NavChartDb](INFO): Join timeout helper Thread ID is 9643
2021-08-19T17:43:19.889Z,1629394999.889 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-19T17:43:19.889Z,1629394999.889 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:19.904Z,1629394999.904 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-08-19T17:43:19.904Z,1629394999.904 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:19.905Z,1629394999.905 [Radio_Surface](INFO): Join timeout helper Thread ID is 9644
2021-08-19T17:43:20.253Z,1629395000.253 [Radio_Surface](INFO): Powering down
2021-08-19T17:43:20.253Z,1629395000.253 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-19T17:43:20.254Z,1629395000.254 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:20.272Z,1629395000.272 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-08-19T17:43:20.272Z,1629395000.272 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:20.273Z,1629395000.273 [Onboard](INFO): Join timeout helper Thread ID is 9645
2021-08-19T17:43:24.156Z,1629395004.156 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-19T17:43:24.157Z,1629395004.157 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:24.164Z,1629395004.164 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-08-19T17:43:24.164Z,1629395004.164 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:24.165Z,1629395004.165 [DataOverHttps](INFO): Join timeout helper Thread ID is 9646
2021-08-19T17:43:24.541Z,1629395004.541 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-19T17:43:24.544Z,1629395004.544 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:24.557Z,1629395004.557 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-08-19T17:43:24.558Z,1629395004.558 [logger ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:24.558Z,1629395004.558 [logger](INFO): Join timeout helper Thread ID is 9647
2021-08-19T17:43:24.565Z,1629395004.565 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-19T17:43:24.565Z,1629395004.565 [logger ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:24.581Z,1629395004.581 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-08-19T17:43:24.581Z,1629395004.581 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:24.581Z,1629395004.581 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-08-19T17:43:24.581Z,1629395004.581 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:24.582Z,1629395004.582 [controlThread](INFO): Join timeout helper Thread ID is 9648
2021-08-19T17:43:24.924Z,1629395004.924 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-19T17:43:24.925Z,1629395004.925 [controlThread](DEBUG): Uninitializing ControlThread
2021-08-19T17:43:24.927Z,1629395004.927 [NAL9602](INFO): Powering down
2021-08-19T17:43:25.001Z,1629395005.001 [RDI_Pathfinder](INFO): Powering down
2021-08-19T17:43:25.002Z,1629395005.002 [DAT](INFO): Powering down
2021-08-19T17:43:25.121Z,1629395005.121 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-08-19T17:43:25.122Z,1629395005.122 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-08-19T17:43:25.123Z,1629395005.123 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-08-19T17:43:25.123Z,1629395005.123 [MissionManager](INFO): Uninitializing Mission Default
2021-08-19T17:43:25.123Z,1629395005.123 [Default] Stopped
2021-08-19T17:43:25.123Z,1629395005.123 [Default](DEBUG): Aggregate::uninitialize Default
2021-08-19T17:43:25.124Z,1629395005.124 [Default:B.GoToSurface] Stopped
2021-08-19T17:43:25.124Z,1629395005.124 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-08-19T17:43:25.124Z,1629395005.124 [Default:CheckIn] Stopped
2021-08-19T17:43:25.124Z,1629395005.124 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-08-19T17:43:25.124Z,1629395005.124 [Default:CheckIn:Read_GPS] Stopped
2021-08-19T17:43:25.127Z,1629395005.127 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-08-19T17:43:25.127Z,1629395005.127 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-08-19T17:43:25.128Z,1629395005.128 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-08-19T17:43:25.128Z,1629395005.128 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-08-19T17:43:25.128Z,1629395005.128 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-19T17:43:25.128Z,1629395005.128 [BuoyancyServo](INFO): Powering down
2021-08-19T17:43:25.141Z,1629395005.141 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-08-19T17:43:25.141Z,1629395005.141 [ElevatorServo](INFO): Powering down
2021-08-19T17:43:25.142Z,1629395005.142 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-19T17:43:25.142Z,1629395005.142 [MassServo](INFO): Powering down
2021-08-19T17:43:25.143Z,1629395005.143 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-08-19T17:43:25.143Z,1629395005.143 [RudderServo](INFO): Powering down
2021-08-19T17:43:25.144Z,1629395005.144 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2021-08-19T17:43:25.144Z,1629395005.144 [ThrusterServo](INFO): Powering down
2021-08-19T17:43:25.145Z,1629395005.145 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-08-19T17:43:25.145Z,1629395005.145 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-08-19T17:43:25.145Z,1629395005.145 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-08-19T17:43:25.146Z,1629395005.146 [CBIT](DEBUG): Powering off loads.
2021-08-19T17:43:25.156Z,1629395005.156 [CBIT](DEBUG): Disabling WDT.
2021-08-19T17:43:25.168Z,1629395005.168 [CBIT](DEBUG): Opening all GF detection circuits.
2021-08-19T17:43:25.169Z,1629395005.169 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:25.250Z,1629395005.250 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:25.253Z,1629395005.253 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:25.259Z,1629395005.259 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:25.338Z,1629395005.338 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-08-19T17:43:25.401Z,1629395005.401 [logger ThreadHandler](INFO): Thread cancelled.