2021-03-23T22:02:20.782Z,1616536940.782 [Supervisor](DEBUG): Initializing supervisor.
2021-03-23T22:02:20.787Z,1616536940.787 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-03-23T22:02:20.788Z,1616536940.788 [SyncHandler](INFO): Protected caller Thread ID is 7813
2021-03-23T22:02:20.788Z,1616536940.788 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-03-23T22:02:20.789Z,1616536940.789 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-03-23T22:02:20.790Z,1616536940.790 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7814
2021-03-23T22:02:20.794Z,1616536940.794 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-03-23T22:02:20.814Z,1616536940.814 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-03-23T22:02:20.815Z,1616536940.815 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-03-23T22:02:20.816Z,1616536940.816 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7815
2021-03-23T22:02:20.818Z,1616536940.818 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-03-23T22:02:20.819Z,1616536940.819 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-03-23T22:02:20.819Z,1616536940.819 [logger ThreadHandler](INFO): Protected caller Thread ID is 7816
2021-03-23T22:02:20.823Z,1616536940.823 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-03-23T22:02:20.823Z,1616536940.823 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-03-23T22:02:20.825Z,1616536940.825 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-03-23T22:02:20.923Z,1616536940.923 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-03-23T22:02:20.924Z,1616536940.924 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-03-23T22:02:21.542Z,1616536941.542 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-03-23T22:02:21.542Z,1616536941.542 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-03-23T22:02:21.759Z,1616536941.759 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-03-23T22:02:21.759Z,1616536941.759 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-03-23T22:02:21.841Z,1616536941.841 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-03-23T22:02:21.966Z,1616536941.966 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-03-23T22:02:21.966Z,1616536941.966 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-03-23T22:02:22.049Z,1616536942.049 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-03-23T22:02:22.152Z,1616536942.152 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-03-23T22:02:22.152Z,1616536942.152 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-03-23T22:02:22.501Z,1616536942.501 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-03-23T22:02:22.501Z,1616536942.501 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-03-23T22:02:23.036Z,1616536943.036 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-03-23T22:02:23.037Z,1616536943.037 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-03-23T22:02:23.189Z,1616536943.189 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-03-23T22:02:23.190Z,1616536943.190 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-03-23T22:02:23.390Z,1616536943.390 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-03-23T22:02:23.391Z,1616536943.391 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-03-23T22:02:23.914Z,1616536943.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-03-23T22:02:23.914Z,1616536943.914 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-03-23T22:02:24.158Z,1616536944.158 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-03-23T22:02:24.159Z,1616536944.159 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-03-23T22:02:24.367Z,1616536944.367 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-03-23T22:02:24.367Z,1616536944.367 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-03-23T22:02:24.730Z,1616536944.730 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-03-23T22:02:24.730Z,1616536944.730 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-03-23T22:02:25.075Z,1616536945.075 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-03-23T22:02:25.077Z,1616536945.077 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2021-03-23T22:02:25.077Z,1616536945.077 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2021-03-23T22:02:25.163Z,1616536945.163 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2021-03-23T22:02:25.325Z,1616536945.325 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2021-03-23T22:02:25.437Z,1616536945.437 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2021-03-23T22:02:25.549Z,1616536945.549 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2021-03-23T22:02:25.741Z,1616536945.741 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2021-03-23T22:02:26.029Z,1616536946.029 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2021-03-23T22:02:26.437Z,1616536946.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-03-23T22:02:26.437Z,1616536946.437 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2021-03-23T22:02:26.533Z,1616536946.533 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2021-03-23T22:02:26.635Z,1616536946.635 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2021-03-23T22:02:26.778Z,1616536946.778 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2021-03-23T22:02:26.882Z,1616536946.882 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2021-03-23T22:02:26.882Z,1616536946.882 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-03-23T22:02:26.902Z,1616536946.902 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-03-23T22:02:26.987Z,1616536946.987 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-03-23T22:02:26.988Z,1616536946.988 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-03-23T22:02:27.038Z,1616536947.038 [VerticalControl](DEBUG): Construct VerticalControl.
2021-03-23T22:02:27.098Z,1616536947.098 [VerticalControl] Loaded
2021-03-23T22:02:27.098Z,1616536947.098 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-03-23T22:02:27.101Z,1616536947.101 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-03-23T22:02:27.139Z,1616536947.139 [HorizontalControl] Loaded
2021-03-23T22:02:27.139Z,1616536947.139 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-03-23T22:02:27.142Z,1616536947.142 [SpeedControl](DEBUG): Construct SpeedControl.
2021-03-23T22:02:27.145Z,1616536947.145 [SpeedControl] Loaded
2021-03-23T22:02:27.145Z,1616536947.145 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-03-23T22:02:27.147Z,1616536947.147 [LoopControl](DEBUG): Construct LoopControl.
2021-03-23T22:02:27.148Z,1616536947.148 [LoopControl] Loaded
2021-03-23T22:02:27.149Z,1616536947.149 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-03-23T22:02:27.149Z,1616536947.149 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-03-23T22:02:27.149Z,1616536947.149 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-03-23T22:02:27.190Z,1616536947.190 [DepthRateCalculator] Loaded
2021-03-23T22:02:27.190Z,1616536947.190 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-03-23T22:02:27.194Z,1616536947.194 [PitchRateCalculator] Loaded
2021-03-23T22:02:27.195Z,1616536947.195 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-03-23T22:02:27.205Z,1616536947.205 [SpeedCalculator] Loaded
2021-03-23T22:02:27.205Z,1616536947.205 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-03-23T22:02:27.218Z,1616536947.218 [TempGradientCalculator] Loaded
2021-03-23T22:02:27.219Z,1616536947.219 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-03-23T22:02:27.223Z,1616536947.223 [YawRateCalculator] Loaded
2021-03-23T22:02:27.223Z,1616536947.223 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-03-23T22:02:27.240Z,1616536947.240 [ElevatorOffsetCalculator] Loaded
2021-03-23T22:02:27.240Z,1616536947.240 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-03-23T22:02:27.240Z,1616536947.240 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-03-23T22:02:27.241Z,1616536947.241 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-03-23T22:02:27.268Z,1616536947.268 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-03-23T22:02:27.269Z,1616536947.269 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-03-23T22:02:27.325Z,1616536947.325 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-03-23T22:02:27.325Z,1616536947.325 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-03-23T22:02:27.630Z,1616536947.630 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-03-23T22:02:27.631Z,1616536947.631 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-03-23T22:02:27.730Z,1616536947.730 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-03-23T22:02:27.731Z,1616536947.731 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-03-23T22:02:28.068Z,1616536948.068 [AHRS_M2] Loaded
2021-03-23T22:02:28.068Z,1616536948.068 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2021-03-23T22:02:28.098Z,1616536948.098 [BackseatComponent] Loaded
2021-03-23T22:02:28.098Z,1616536948.098 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2021-03-23T22:02:28.099Z,1616536948.099 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408FE4E0
2021-03-23T22:02:28.099Z,1616536948.099 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7899
2021-03-23T22:02:28.102Z,1616536948.102 [LcmUniversalReporter] Loaded
2021-03-23T22:02:28.102Z,1616536948.102 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2021-03-23T22:02:28.853Z,1616536948.853 [BPC1] Loaded
2021-03-23T22:02:28.853Z,1616536948.853 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-03-23T22:02:28.933Z,1616536948.933 [DataOverHttps] Loaded
2021-03-23T22:02:28.934Z,1616536948.934 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-03-23T22:02:28.935Z,1616536948.935 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4092E4E0
2021-03-23T22:02:28.935Z,1616536948.935 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7900
2021-03-23T22:02:28.954Z,1616536948.954 [Depth_Keller] Loaded
2021-03-23T22:02:28.955Z,1616536948.955 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-03-23T22:02:29.016Z,1616536949.016 [NAL9602] Loaded
2021-03-23T22:02:29.016Z,1616536949.016 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-03-23T22:02:29.046Z,1616536949.046 [Onboard] Loaded
2021-03-23T22:02:29.046Z,1616536949.046 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-03-23T22:02:29.047Z,1616536949.047 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4095E4E0
2021-03-23T22:02:29.047Z,1616536949.047 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7901
2021-03-23T22:02:29.060Z,1616536949.060 [Radio_Surface] Loaded
2021-03-23T22:02:29.060Z,1616536949.060 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-03-23T22:02:29.061Z,1616536949.061 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4098E4E0
2021-03-23T22:02:29.062Z,1616536949.062 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7902
2021-03-23T22:02:29.100Z,1616536949.100 [RDI_Pathfinder] Loaded
2021-03-23T22:02:29.101Z,1616536949.101 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2021-03-23T22:02:29.180Z,1616536949.180 [DAT] Loaded
2021-03-23T22:02:29.180Z,1616536949.180 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2021-03-23T22:02:29.181Z,1616536949.181 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-03-23T22:02:29.181Z,1616536949.181 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-03-23T22:02:29.261Z,1616536949.261 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-03-23T22:02:29.261Z,1616536949.261 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-03-23T22:02:29.274Z,1616536949.274 [NavChart] Loaded
2021-03-23T22:02:29.274Z,1616536949.274 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-03-23T22:02:29.280Z,1616536949.280 [UniversalFixResidualReporter] Loaded
2021-03-23T22:02:29.280Z,1616536949.280 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-03-23T22:02:29.281Z,1616536949.281 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-03-23T22:02:29.281Z,1616536949.281 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-03-23T22:02:29.420Z,1616536949.420 [SBIT](DEBUG): Construct Startup Built In Test.
2021-03-23T22:02:29.429Z,1616536949.429 [SBIT] Loaded
2021-03-23T22:02:29.430Z,1616536949.430 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-03-23T22:02:29.432Z,1616536949.432 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-03-23T22:02:29.445Z,1616536949.445 [IBIT] Loaded
2021-03-23T22:02:29.445Z,1616536949.445 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-03-23T22:02:29.451Z,1616536949.451 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-03-23T22:02:29.553Z,1616536949.553 [CBIT] Loaded
2021-03-23T22:02:29.553Z,1616536949.553 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-03-23T22:02:29.554Z,1616536949.554 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-03-23T22:02:29.554Z,1616536949.554 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-03-23T22:02:29.665Z,1616536949.665 [BuoyancyServo] Loaded
2021-03-23T22:02:29.665Z,1616536949.665 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-03-23T22:02:29.684Z,1616536949.684 [ElevatorServo] Loaded
2021-03-23T22:02:29.685Z,1616536949.685 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-03-23T22:02:29.703Z,1616536949.703 [MassServo] Loaded
2021-03-23T22:02:29.703Z,1616536949.703 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-03-23T22:02:29.721Z,1616536949.721 [RudderServo] Loaded
2021-03-23T22:02:29.722Z,1616536949.722 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-03-23T22:02:29.739Z,1616536949.739 [ThrusterServo] Loaded
2021-03-23T22:02:29.739Z,1616536949.739 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2021-03-23T22:02:29.740Z,1616536949.740 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-03-23T22:02:29.740Z,1616536949.740 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-03-23T22:02:29.751Z,1616536949.751 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-03-23T22:02:29.752Z,1616536949.752 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-03-23T22:02:29.930Z,1616536949.930 [CTD_Seabird] Loaded
2021-03-23T22:02:29.930Z,1616536949.930 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2021-03-23T22:02:29.931Z,1616536949.931 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ABA4E0
2021-03-23T22:02:29.932Z,1616536949.932 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7903
2021-03-23T22:02:29.952Z,1616536949.952 [PAR_Licor] Loaded
2021-03-23T22:02:29.953Z,1616536949.953 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2021-03-23T22:02:29.984Z,1616536949.984 [WetLabsBB2FL] Loaded
2021-03-23T22:02:29.985Z,1616536949.985 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2021-03-23T22:02:29.986Z,1616536949.986 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AEA4E0
2021-03-23T22:02:29.986Z,1616536949.986 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7904
2021-03-23T22:02:29.987Z,1616536949.987 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-03-23T22:02:29.993Z,1616536949.993 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-03-23T22:02:29.996Z,1616536949.996 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-03-23T22:02:30.007Z,1616536950.007 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-03-23T22:02:30.008Z,1616536950.008 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B1A4E0
2021-03-23T22:02:30.008Z,1616536950.008 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7905
2021-03-23T22:02:30.013Z,1616536950.013 [Supervisor](INFO): Main Thread ID is 7812
2021-03-23T22:02:30.013Z,1616536950.013 [Supervisor](DEBUG): Running supervisor.
2021-03-23T22:02:30.013Z,1616536950.013 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7906
2021-03-23T22:02:30.017Z,1616536950.017 [controlThread ThreadHandler](INFO): Handler Thread ID is 7907
2021-03-23T22:02:30.018Z,1616536950.018 [controlThread](DEBUG): Initializing ControlThread
2021-03-23T22:02:30.019Z,1616536950.019 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-03-23T22:02:30.020Z,1616536950.020 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-03-23T22:02:30.021Z,1616536950.021 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-03-23T22:02:30.022Z,1616536950.022 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-03-23T22:02:30.022Z,1616536950.022 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-03-23T22:02:30.022Z,1616536950.022 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-03-23T22:02:30.023Z,1616536950.023 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-03-23T22:02:30.023Z,1616536950.023 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-03-23T22:02:30.023Z,1616536950.023 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-03-23T22:02:30.024Z,1616536950.024 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-03-23T22:02:30.029Z,1616536950.029 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-03-23T22:02:30.030Z,1616536950.030 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-03-23T22:02:30.030Z,1616536950.030 [SBIT](INFO): Initialize SBIT Component.
2021-03-23T22:02:30.031Z,1616536950.031 [SBIT](IMPORTANT): git: 2021-02-15-20-g8bf65dadf
2021-03-23T22:02:30.031Z,1616536950.031 [SBIT](INFO): git hash: 8bf65dadfccbc7089cf46f1ce6d490d0002662f8
2021-03-23T22:02:30.031Z,1616536950.031 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-03-23T22:02:30.032Z,1616536950.032 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2021-03-23T22:02:30.034Z,1616536950.034 [SBIT](INFO): Beginning SBIT in 40.000000 seconds.
2021-03-23T22:02:30.034Z,1616536950.034 [IBIT](INFO): Initialize IBIT Component.
2021-03-23T22:02:30.035Z,1616536950.035 [CBIT](DEBUG): Initialize CBIT Component.
2021-03-23T22:02:30.036Z,1616536950.036 [logger ThreadHandler](INFO): Handler Thread ID is 7908
2021-03-23T22:02:30.048Z,1616536950.048 [CBIT](DEBUG): Initialized mux pins.
2021-03-23T22:02:30.048Z,1616536950.048 [CBIT](DEBUG): Initializing the watchdog timer.
2021-03-23T22:02:30.057Z,1616536950.057 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7909
2021-03-23T22:02:30.069Z,1616536950.069 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7910
2021-03-23T22:02:30.070Z,1616536950.070 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2021-03-23T22:02:30.073Z,1616536950.073 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-03-23T22:02:30.073Z,1616536950.073 [CBIT](DEBUG): Initializing heartbeat.
2021-03-23T22:02:30.081Z,1616536950.081 [Onboard ThreadHandler](INFO): Handler Thread ID is 7911
2021-03-23T22:02:30.098Z,1616536950.098 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7912
2021-03-23T22:02:30.117Z,1616536950.117 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7913
2021-03-23T22:02:30.117Z,1616536950.117 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-03-23T22:02:30.133Z,1616536950.133 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7915
2021-03-23T22:02:30.137Z,1616536950.137 [WetLabsBB2FL](INFO): Powering up
2021-03-23T22:02:30.138Z,1616536950.138 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7917
2021-03-23T22:02:30.141Z,1616536950.141 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-03-23T22:02:30.141Z,1616536950.141 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-03-23T22:02:30.142Z,1616536950.142 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-03-23T22:02:30.142Z,1616536950.142 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-03-23T22:02:30.142Z,1616536950.142 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-03-23T22:02:30.142Z,1616536950.142 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-03-23T22:02:30.142Z,1616536950.142 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-03-23T22:02:30.142Z,1616536950.142 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-03-23T22:02:30.143Z,1616536950.143 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-03-23T22:02:30.143Z,1616536950.143 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-03-23T22:02:30.143Z,1616536950.143 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-03-23T22:02:30.143Z,1616536950.143 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-03-23T22:02:30.143Z,1616536950.143 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-03-23T22:02:30.143Z,1616536950.143 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-03-23T22:02:30.144Z,1616536950.144 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-03-23T22:02:30.144Z,1616536950.144 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-03-23T22:02:30.144Z,1616536950.144 [CBIT](DEBUG): Deactivating GF circuits.
2021-03-23T22:02:30.144Z,1616536950.144 [CBIT](DEBUG): Deactivating emergency mode.
2021-03-23T22:02:30.180Z,1616536950.180 [CBIT](DEBUG): Backplane powered.
2021-03-23T22:02:30.185Z,1616536950.185 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2021-03-23T22:02:30.210Z,1616536950.210 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-03-23T22:02:30.250Z,1616536950.250 [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-03-23T22:02:30.251Z,1616536950.251 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2021-03-23T22:02:30.319Z,1616536950.319 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-03-23T22:02:30.320Z,1616536950.320 [Default:A.Wait](DEBUG): Construct Wait.
2021-03-23T22:02:30.322Z,1616536950.322 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-03-23T22:02:30.389Z,1616536950.389 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-03-23T22:02:30.392Z,1616536950.392 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-03-23T22:02:30.414Z,1616536950.414 [Default:E.Execute](DEBUG): Construct Execute.
2021-03-23T22:02:30.425Z,1616536950.425 [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-03-23T22:02:30.430Z,1616536950.430 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,RDI_Pathfinder,DAT,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2021-03-23T22:02:30.440Z,1616536950.440 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-03-23T22:02:30.440Z,1616536950.440 [AHRS_M2](INFO): AHRS_M2: Not simulateHardware.
2021-03-23T22:02:30.510Z,1616536950.510 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2021-03-23T22:02:30.511Z,1616536950.511 [RDI_Pathfinder](INFO): Start
2021-03-23T22:02:30.512Z,1616536950.512 [Radio_Surface](INFO): Powering up
2021-03-23T22:02:30.515Z,1616536950.515 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2021-03-23T22:02:30.516Z,1616536950.516 [DAT](INFO): Powering up
2021-03-23T22:02:30.516Z,1616536950.516 [DAT](DEBUG): Initializing DAT.
2021-03-23T22:02:30.516Z,1616536950.516 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2021-03-23T22:02:30.605Z,1616536950.605 [DepthRateCalculator](ERROR): Depth measurement is not active
2021-03-23T22:02:30.651Z,1616536950.651 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-03-23T22:02:30.656Z,1616536950.656 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-03-23T22:02:30.658Z,1616536950.658 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-03-23T22:02:30.679Z,1616536950.679 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-03-23T22:02:30.681Z,1616536950.681 [MassServo](DEBUG): Initializing EZServoServo.
2021-03-23T22:02:30.700Z,1616536950.700 [MassServo](DEBUG): Initializing MassServo.
2021-03-23T22:02:30.701Z,1616536950.701 [RudderServo](DEBUG): Initializing EZServoServo.
2021-03-23T22:02:30.709Z,1616536950.709 [RudderServo](DEBUG): Initializing RudderServo.
2021-03-23T22:02:30.710Z,1616536950.710 [ThrusterServo](DEBUG): Initializing EZServoServo.
2021-03-23T22:02:30.716Z,1616536950.716 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2021-03-23T22:02:30.859Z,1616536950.859 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:31.245Z,1616536951.245 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:31.576Z,1616536951.576 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2021-03-23T22:02:31.576Z,1616536951.576 [RudderServo](FAULT): Rudder failed to initialize
2021-03-23T22:02:31.577Z,1616536951.577 [RudderServo] Communications Fault, FailCount= 1
2021-03-23T22:02:31.577Z,1616536951.577 [RudderServo](ERROR): Communications Fault
2021-03-23T22:02:31.677Z,1616536951.677 [CBIT](ERROR): Communications Fault in component: RudderServo
2021-03-23T22:02:31.685Z,1616536951.685 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:31.885Z,1616536951.885 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-03-23T22:02:31.885Z,1616536951.885 [RudderServo](INFO): Powering down
2021-03-23T22:02:32.089Z,1616536952.089 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:32.493Z,1616536952.493 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:32.535Z,1616536952.535 [RudderServo](DEBUG): Initializing EZServoServo.
2021-03-23T22:02:32.654Z,1616536952.654 [RudderServo](DEBUG): Initializing RudderServo.
2021-03-23T22:02:32.658Z,1616536952.658 [CBIT](INFO): Clearing failed state for component RudderServo
2021-03-23T22:02:32.658Z,1616536952.658 [RudderServo] No Fault, FailCount= 1
2021-03-23T22:02:32.748Z,1616536952.748 [WetLabsBB2FL](INFO): Powering down
2021-03-23T22:02:32.897Z,1616536952.897 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:33.301Z,1616536953.301 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:33.777Z,1616536953.777 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:34.138Z,1616536954.138 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:34.537Z,1616536954.537 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:35.005Z,1616536955.005 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:35.357Z,1616536955.357 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:35.761Z,1616536955.761 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:36.165Z,1616536956.165 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:36.569Z,1616536956.569 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:36.978Z,1616536956.978 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:37.377Z,1616536957.377 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:37.781Z,1616536957.781 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:38.185Z,1616536958.185 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:38.577Z,1616536958.577 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:38.974Z,1616536958.974 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:39.377Z,1616536959.377 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:39.769Z,1616536959.769 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:40.169Z,1616536960.169 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:40.577Z,1616536960.577 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:40.977Z,1616536960.977 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:41.381Z,1616536961.381 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:41.785Z,1616536961.785 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:42.189Z,1616536962.189 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:42.593Z,1616536962.593 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:42.998Z,1616536962.998 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:43.010Z,1616536963.010 [RDI_Pathfinder](ERROR): Failed to parse:Teledyne RD Instruments (c) 2019
2021-03-23T22:02:43.939Z,1616536963.939 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004755
2021-03-23T22:02:44.210Z,1616536964.210 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:44.215Z,1616536964.215 [RDI_Pathfinder](ERROR): Failed to parse::RA,  0.00,   0.00,   0.00,   0.00,   0.00
2021-03-23T22:02:44.616Z,1616536964.616 [DAT](INFO): commRate: 800
2021-03-23T22:02:45.422Z,1616536965.422 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:45.425Z,1616536965.425 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:02:45.427Z,1616536965.427 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:02:45.427Z,1616536965.427 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:02:45.427Z,1616536965.427 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:02:45.427Z,1616536965.427 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:02:45.430Z,1616536965.430 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:02:46.634Z,1616536966.634 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:46.637Z,1616536966.637 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:02:46.639Z,1616536966.639 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:02:46.639Z,1616536966.639 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:02:46.639Z,1616536966.639 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:02:46.639Z,1616536966.639 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:02:46.642Z,1616536966.642 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:02:46.643Z,1616536966.643 [DAT](INFO): entering command mode
2021-03-23T22:02:47.038Z,1616536967.038 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:47.442Z,1616536967.442 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:47.846Z,1616536967.846 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:47.849Z,1616536967.849 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:02:47.851Z,1616536967.851 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:02:47.851Z,1616536967.851 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:02:47.851Z,1616536967.851 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:02:47.851Z,1616536967.851 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:02:47.854Z,1616536967.854 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:02:47.854Z,1616536967.854 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:48.250Z,1616536968.250 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:48.253Z,1616536968.253 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:02:48.255Z,1616536968.255 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:02:48.255Z,1616536968.255 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:02:48.255Z,1616536968.255 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:02:48.255Z,1616536968.255 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:02:48.257Z,1616536968.257 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:02:48.258Z,1616536968.258 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:48.654Z,1616536968.654 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:49.070Z,1616536969.070 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:49.074Z,1616536969.074 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:02:49.075Z,1616536969.075 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:02:49.076Z,1616536969.076 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:02:49.076Z,1616536969.076 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:02:49.076Z,1616536969.076 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:02:49.078Z,1616536969.078 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:02:49.079Z,1616536969.079 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:49.462Z,1616536969.462 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:49.866Z,1616536969.866 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:50.270Z,1616536970.270 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:50.273Z,1616536970.273 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:02:50.275Z,1616536970.275 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:02:50.275Z,1616536970.275 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:02:50.275Z,1616536970.275 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:02:50.275Z,1616536970.275 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:02:50.278Z,1616536970.278 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:02:50.278Z,1616536970.278 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:50.674Z,1616536970.674 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:51.082Z,1616536971.082 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:51.085Z,1616536971.085 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:02:51.087Z,1616536971.087 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:02:51.087Z,1616536971.087 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:02:51.087Z,1616536971.087 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:02:51.087Z,1616536971.087 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:02:51.090Z,1616536971.090 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:02:51.091Z,1616536971.091 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:51.482Z,1616536971.482 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:51.886Z,1616536971.886 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:52.290Z,1616536972.290 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:02:52.293Z,1616536972.293 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:02:52.295Z,1616536972.295 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:02:52.295Z,1616536972.295 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:02:52.295Z,1616536972.295 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:02:52.296Z,1616536972.296 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:02:52.298Z,1616536972.298 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:02:52.298Z,1616536972.298 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:52.693Z,1616536972.693 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2021-03-23T22:02:52.694Z,1616536972.694 [RDI_Pathfinder] Communications Fault, FailCount= 1
2021-03-23T22:02:52.694Z,1616536972.694 [RDI_Pathfinder](ERROR): Communications Fault
2021-03-23T22:02:52.695Z,1616536972.695 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:52.722Z,1616536972.722 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2021-03-23T22:02:53.115Z,1616536973.115 [RDI_Pathfinder](INFO): Stop
2021-03-23T22:02:53.189Z,1616536973.189 [RDI_Pathfinder](INFO): Powering down
2021-03-23T22:02:53.190Z,1616536973.190 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:53.501Z,1616536973.501 [RDI_Pathfinder](INFO): Stopping
2021-03-23T22:02:53.502Z,1616536973.502 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:53.905Z,1616536973.905 [RDI_Pathfinder](INFO): Stopped
2021-03-23T22:02:53.906Z,1616536973.906 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:53.937Z,1616536973.937 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2021-03-23T22:02:53.937Z,1616536973.937 [RDI_Pathfinder] No Fault, FailCount= 1
2021-03-23T22:02:54.309Z,1616536974.309 [RDI_Pathfinder](INFO): Start
2021-03-23T22:02:54.311Z,1616536974.311 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:54.713Z,1616536974.713 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:54.714Z,1616536974.714 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:55.121Z,1616536975.121 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:55.122Z,1616536975.122 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:55.521Z,1616536975.521 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:55.522Z,1616536975.522 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:55.925Z,1616536975.925 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:55.926Z,1616536975.926 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:56.329Z,1616536976.329 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:56.330Z,1616536976.330 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:56.745Z,1616536976.745 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:56.746Z,1616536976.746 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:57.137Z,1616536977.137 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:57.138Z,1616536977.138 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:57.541Z,1616536977.541 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:57.542Z,1616536977.542 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:57.945Z,1616536977.945 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:57.946Z,1616536977.946 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:58.354Z,1616536978.354 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:58.355Z,1616536978.355 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:58.753Z,1616536978.753 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:58.754Z,1616536978.754 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:59.158Z,1616536979.158 [NAL9602](INFO): Powering up NAL9602
2021-03-23T22:02:59.159Z,1616536979.159 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:59.159Z,1616536979.159 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:59.561Z,1616536979.561 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:59.562Z,1616536979.562 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:02:59.973Z,1616536979.973 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:02:59.974Z,1616536979.974 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:03:00.369Z,1616536980.369 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:00.370Z,1616536980.370 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:03:00.773Z,1616536980.773 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:00.774Z,1616536980.774 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:03:01.177Z,1616536981.177 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:01.178Z,1616536981.178 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:03:01.587Z,1616536981.587 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:01.588Z,1616536981.588 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:03:01.985Z,1616536981.985 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:01.986Z,1616536981.986 [DAT](DEBUG): checking for command mode acknowledgment
2021-03-23T22:03:01.986Z,1616536981.986 [DAT](FAULT): failed to enter command mode
2021-03-23T22:03:02.390Z,1616536982.390 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:02.391Z,1616536982.391 [DAT](INFO): entering command mode
2021-03-23T22:03:02.793Z,1616536982.793 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:02.795Z,1616536982.795 [DAT](INFO): setting verbose to 3
2021-03-23T22:03:03.203Z,1616536983.203 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:03.205Z,1616536983.205 [DAT](INFO): set verbose to 3
2021-03-23T22:03:03.205Z,1616536983.205 [DAT](INFO): setting DatVerbose to 27440
2021-03-23T22:03:03.601Z,1616536983.601 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:03.603Z,1616536983.603 [DAT](INFO): set DatVerbose to 27440
2021-03-23T22:03:03.603Z,1616536983.603 [DAT](INFO): setting transmit power to 8
2021-03-23T22:03:04.005Z,1616536984.005 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:04.007Z,1616536984.007 [DAT](INFO): set transmit power to 8
2021-03-23T22:03:04.007Z,1616536984.007 [DAT](INFO): setting local address to 9
2021-03-23T22:03:04.417Z,1616536984.417 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:04.419Z,1616536984.419 [DAT](INFO): set local address to 9
2021-03-23T22:03:04.813Z,1616536984.813 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:05.217Z,1616536985.217 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:05.628Z,1616536985.628 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:06.029Z,1616536986.029 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:06.429Z,1616536986.429 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:06.834Z,1616536986.834 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:06.842Z,1616536986.842 [RDI_Pathfinder](ERROR): Failed to parse:Teledyne RD Instruments (c) 2019
2021-03-23T22:03:08.046Z,1616536988.046 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:08.049Z,1616536988.049 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:08.051Z,1616536988.051 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:08.051Z,1616536988.051 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:08.051Z,1616536988.051 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:08.051Z,1616536988.051 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:08.062Z,1616536988.062 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:08.854Z,1616536988.854 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:08.857Z,1616536988.857 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:08.859Z,1616536988.859 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:08.859Z,1616536988.859 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:08.859Z,1616536988.859 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:08.859Z,1616536988.859 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:08.861Z,1616536988.861 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:10.066Z,1616536990.066 [NAL9602](INFO): NAL9602 initialized
2021-03-23T22:03:10.470Z,1616536990.470 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:10.474Z,1616536990.474 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:10.476Z,1616536990.476 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:10.476Z,1616536990.476 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:10.484Z,1616536990.484 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:10.485Z,1616536990.485 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:10.486Z,1616536990.486 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:10.582Z,1616536990.582 [SBIT](IMPORTANT): Beginning Startup BIT
2021-03-23T22:03:10.604Z,1616536990.604 [CBIT](IMPORTANT): Beginning ground fault scan
2021-03-23T22:03:11.293Z,1616536991.293 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:11.296Z,1616536991.296 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:11.298Z,1616536991.298 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:11.298Z,1616536991.298 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:11.298Z,1616536991.298 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:11.299Z,1616536991.299 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:11.301Z,1616536991.301 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:11.713Z,1616536991.713 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:11.716Z,1616536991.716 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:11.718Z,1616536991.718 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:11.718Z,1616536991.718 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:11.718Z,1616536991.718 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:11.719Z,1616536991.719 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:11.731Z,1616536991.731 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:12.905Z,1616536992.905 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:12.908Z,1616536992.908 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:12.910Z,1616536992.910 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:12.910Z,1616536992.910 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:12.910Z,1616536992.910 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:12.911Z,1616536992.911 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:12.917Z,1616536992.917 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:13.721Z,1616536993.721 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:13.724Z,1616536993.724 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:13.726Z,1616536993.726 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:13.726Z,1616536993.726 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:13.726Z,1616536993.726 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:13.726Z,1616536993.726 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:13.728Z,1616536993.728 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:14.922Z,1616536994.922 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:14.925Z,1616536994.925 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:14.927Z,1616536994.927 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:14.927Z,1616536994.927 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:14.928Z,1616536994.928 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:14.928Z,1616536994.928 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:14.930Z,1616536994.930 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:15.742Z,1616536995.742 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:15.750Z,1616536995.750 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:15.751Z,1616536995.751 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:15.752Z,1616536995.752 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:15.760Z,1616536995.760 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:15.760Z,1616536995.760 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:15.762Z,1616536995.762 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:16.546Z,1616536996.546 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2021-03-23T22:03:16.546Z,1616536996.546 [RDI_Pathfinder] Communications Fault, FailCount= 2
2021-03-23T22:03:16.546Z,1616536996.546 [RDI_Pathfinder](ERROR): Communications Fault
2021-03-23T22:03:16.640Z,1616536996.640 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2021-03-23T22:03:16.934Z,1616536996.934 [RDI_Pathfinder](INFO): Stop
2021-03-23T22:03:17.000Z,1616536997.000 [RDI_Pathfinder](INFO): Powering down
2021-03-23T22:03:17.338Z,1616536997.338 [RDI_Pathfinder](INFO): Stopping
2021-03-23T22:03:17.752Z,1616536997.752 [RDI_Pathfinder](INFO): Stopped
2021-03-23T22:03:17.841Z,1616536997.841 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2021-03-23T22:03:17.841Z,1616536997.841 [RDI_Pathfinder] No Fault, FailCount= 2
2021-03-23T22:03:18.165Z,1616536998.165 [RDI_Pathfinder](INFO): Start
2021-03-23T22:03:18.568Z,1616536998.568 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:18.964Z,1616536998.964 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:19.358Z,1616536999.358 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:19.767Z,1616536999.767 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:20.166Z,1616537000.166 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:20.570Z,1616537000.570 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:20.974Z,1616537000.974 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:21.390Z,1616537001.390 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:21.473Z,1616537001.473 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.004645
CHAN A1 (24V): 0.000206
CHAN A2 (12V): -0.007377
CHAN A3 (5V): -0.001790
CHAN B0 (3.3V): 0.000275
CHAN B1 (3.15aV): 0.000111
CHAN B2 (3.15bV): -0.000078
CHAN B3 (GND): 0.002350
OPEN: 0.004955
Full Scale Calc: 4.765 mA, -1.589 mA
2021-03-23T22:03:21.782Z,1616537001.782 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:22.186Z,1616537002.186 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:22.590Z,1616537002.590 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:23.020Z,1616537003.020 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:23.408Z,1616537003.408 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:23.816Z,1616537003.816 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:24.220Z,1616537004.220 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:24.610Z,1616537004.610 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:25.014Z,1616537005.014 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:25.430Z,1616537005.430 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:25.822Z,1616537005.822 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:26.238Z,1616537006.238 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:26.630Z,1616537006.630 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:27.034Z,1616537007.034 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:27.438Z,1616537007.438 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:27.854Z,1616537007.854 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:28.256Z,1616537008.256 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:28.660Z,1616537008.660 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:29.068Z,1616537009.068 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:29.481Z,1616537009.481 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:29.879Z,1616537009.879 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:30.270Z,1616537010.270 [RDI_Pathfinder](INFO): Starting
2021-03-23T22:03:30.683Z,1616537010.683 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:30.691Z,1616537010.691 [RDI_Pathfinder](ERROR): Failed to parse:Teledyne RD Instruments (c) 2019
2021-03-23T22:03:31.902Z,1616537011.902 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:31.923Z,1616537011.923 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:31.926Z,1616537011.926 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:31.926Z,1616537011.926 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:31.926Z,1616537011.926 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:31.926Z,1616537011.926 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:31.928Z,1616537011.928 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:32.701Z,1616537012.701 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:32.704Z,1616537012.704 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:32.706Z,1616537012.706 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:32.706Z,1616537012.706 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:32.706Z,1616537012.706 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:32.707Z,1616537012.707 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:32.709Z,1616537012.709 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:34.329Z,1616537014.329 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:34.332Z,1616537014.332 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:34.334Z,1616537014.334 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:34.334Z,1616537014.334 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:34.334Z,1616537014.334 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:34.334Z,1616537014.334 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:34.336Z,1616537014.336 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:35.122Z,1616537015.122 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:35.126Z,1616537015.126 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:35.128Z,1616537015.128 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:35.128Z,1616537015.128 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:35.128Z,1616537015.128 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:35.128Z,1616537015.128 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:35.130Z,1616537015.130 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:35.541Z,1616537015.541 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:35.544Z,1616537015.544 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:35.546Z,1616537015.546 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:35.546Z,1616537015.546 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:35.546Z,1616537015.546 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:35.547Z,1616537015.547 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:35.549Z,1616537015.549 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:36.740Z,1616537016.740 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:36.743Z,1616537016.743 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:36.745Z,1616537016.745 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:36.746Z,1616537016.746 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:36.746Z,1616537016.746 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:36.746Z,1616537016.746 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:36.748Z,1616537016.748 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:37.562Z,1616537017.562 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:37.566Z,1616537017.566 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:37.567Z,1616537017.567 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:37.568Z,1616537017.568 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:37.584Z,1616537017.584 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:37.584Z,1616537017.584 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:37.586Z,1616537017.586 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:38.773Z,1616537018.773 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:38.776Z,1616537018.776 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:38.778Z,1616537018.778 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:38.778Z,1616537018.778 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:38.778Z,1616537018.778 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:38.778Z,1616537018.778 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:38.806Z,1616537018.806 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:39.585Z,1616537019.585 [RDI_Pathfinder](INFO): Message in queue
2021-03-23T22:03:39.588Z,1616537019.588 [RDI_Pathfinder](INFO): BIT Error is:0
2021-03-23T22:03:39.590Z,1616537019.590 [RDI_Pathfinder](INFO): Beam 1 Range:0.000000
2021-03-23T22:03:39.590Z,1616537019.590 [RDI_Pathfinder](INFO): Beam 2 Range:0.000000
2021-03-23T22:03:39.590Z,1616537019.590 [RDI_Pathfinder](INFO): Beam 3 Range:0.000000
2021-03-23T22:03:39.590Z,1616537019.590 [RDI_Pathfinder](INFO): Beam 4 Range:0.000000
2021-03-23T22:03:39.592Z,1616537019.592 [RDI_Pathfinder](ERROR): Failed to parse::BS,-32768,-32768,-32768,V
2021-03-23T22:03:40.370Z,1616537020.370 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2021-03-23T22:03:40.370Z,1616537020.370 [RDI_Pathfinder] Communications Fault, FailCount= 3
2021-03-23T22:03:40.370Z,1616537020.370 [RDI_Pathfinder](ERROR): Communications Fault
2021-03-23T22:03:40.432Z,1616537020.432 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2021-03-23T22:03:40.432Z,1616537020.432 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2021-03-23T22:03:40.778Z,1616537020.778 [RDI_Pathfinder](INFO): Stop
2021-03-23T22:03:40.848Z,1616537020.848 [RDI_Pathfinder](INFO): Powering down
2021-03-23T22:03:40.903Z,1616537020.903 [CommandLine](FAULT): Scheduling is paused
2021-03-23T22:03:40.903Z,1616537020.903 [CBIT](INFO): Critical error at 20210323T220340
2021-03-23T22:03:40.904Z,1616537020.904 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2021-03-23T22:03:41.182Z,1616537021.182 [RDI_Pathfinder](INFO): Stopping
2021-03-23T22:03:41.586Z,1616537021.586 [RDI_Pathfinder](INFO): Stopped
2021-03-23T22:04:04.703Z,1616537044.703 [SBIT](IMPORTANT): SBIT PASSED
2021-03-23T22:04:04.703Z,1616537044.703 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2021-03-23T22:04:04.704Z,1616537044.704 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count;

2021-03-23T22:04:04.704Z,1616537044.704 [SBIT](IMPORTANT): CBIT.gf24Offset=143 microampere;

2021-03-23T22:04:04.704Z,1616537044.704 [SBIT](IMPORTANT): DAT.sbdAddress=6 enum;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): DAT.surfaceThreshold=-0.5 meter;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): DAT.verbosity=0 count;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): DataOverHttps.loadAtStartup=1 bool;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): Dock.depth=22.5 meter;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): Dock.lat=36.8137 degree;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): Dock.lon=-121.818 degree;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): Dock.transponderCode=50 count;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): Docked.dockingDepthOffset=1.5 meter;

2021-03-23T22:04:04.705Z,1616537044.705 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2021-03-23T22:04:04.706Z,1616537044.706 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_temperature 0.150000 kelvin;

2021-03-23T22:04:04.706Z,1616537044.706 [SBIT](IMPORTANT): Express linearApproximation acoustic_contact_range 5.000000 meter;

2021-03-23T22:04:04.706Z,1616537044.706 [SBIT](IMPORTANT): LineCapture.armSpeed=1 meter_per_second;

2021-03-23T22:04:04.706Z,1616537044.706 [SBIT](IMPORTANT): LineCapture.midcourseDepth=20 meter;

2021-03-23T22:04:04.706Z,1616537044.706 [SBIT](IMPORTANT): LineCapture.navigationGain=nan none;

2021-03-23T22:04:04.706Z,1616537044.706 [SBIT](IMPORTANT): LineCapture.rolloutDistance=200 meter;

2021-03-23T22:04:04.706Z,1616537044.706 [SBIT](IMPORTANT): Undock.reverseThrustTimeout=0 second;

2021-03-23T22:04:04.706Z,1616537044.706 [SBIT](IMPORTANT): Undock.undockDepth=15 meter;

2021-03-23T22:04:04.707Z,1616537044.707 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=250.315511 cubic_centimeter;

2021-03-23T22:04:04.707Z,1616537044.707 [SBIT](IMPORTANT): VerticalControl.massDefault=5.224349 millimeter;

2021-03-23T22:04:05.062Z,1616537045.062 [MissionManager](IMPORTANT): Started mission Startup
2021-03-23T22:04:05.063Z,1616537045.063 [Startup] Running Loop=1
2021-03-23T22:04:05.063Z,1616537045.063 [Startup](DEBUG): Aggregate::initialize Startup
2021-03-23T22:04:05.063Z,1616537045.063 [Startup:A.GoToSurface] Running Loop=1
2021-03-23T22:04:05.063Z,1616537045.063 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-03-23T22:04:05.064Z,1616537045.064 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-03-23T22:04:05.064Z,1616537045.064 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-03-23T22:04:05.065Z,1616537045.065 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-03-23T22:04:05.065Z,1616537045.065 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-03-23T22:04:05.065Z,1616537045.065 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-03-23T22:04:05.067Z,1616537045.067 [Startup:StartupSatComms] Running Loop=1
2021-03-23T22:04:05.067Z,1616537045.067 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2021-03-23T22:04:05.067Z,1616537045.067 [Startup:StartupSatComms:A] Running Loop=1
2021-03-23T22:04:05.471Z,1616537045.471 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2021-03-23T22:04:18.642Z,1616537058.642 [CommandLine](IMPORTANT): got command quit
2021-03-23T22:04:19.648Z,1616537059.648 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:19.649Z,1616537059.649 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:19.664Z,1616537059.664 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2021-03-23T22:04:19.664Z,1616537059.664 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:19.665Z,1616537059.665 [CommandLine](INFO): Join timeout helper Thread ID is 7939
2021-03-23T22:04:19.672Z,1616537059.672 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-03-23T22:04:19.672Z,1616537059.672 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:19.673Z,1616537059.673 [NavChartDb](INFO): Join timeout helper Thread ID is 7940
2021-03-23T22:04:19.856Z,1616537059.856 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:19.857Z,1616537059.857 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:19.860Z,1616537059.860 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2021-03-23T22:04:19.860Z,1616537059.860 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:19.861Z,1616537059.861 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7941
2021-03-23T22:04:20.025Z,1616537060.025 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:20.026Z,1616537060.026 [WetLabsBB2FL](INFO): Powering down
2021-03-23T22:04:20.029Z,1616537060.029 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:20.036Z,1616537060.036 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2021-03-23T22:04:20.036Z,1616537060.036 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:20.037Z,1616537060.037 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7942
2021-03-23T22:04:20.596Z,1616537060.596 [CTD_Seabird](INFO): Powering down
2021-03-23T22:04:20.608Z,1616537060.608 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:20.609Z,1616537060.609 [CTD_Seabird](INFO): Powering down
2021-03-23T22:04:20.620Z,1616537060.620 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:20.628Z,1616537060.628 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-03-23T22:04:20.628Z,1616537060.628 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:20.629Z,1616537060.629 [Radio_Surface](INFO): Join timeout helper Thread ID is 7943
2021-03-23T22:04:20.872Z,1616537060.872 [Radio_Surface](INFO): Powering down
2021-03-23T22:04:20.873Z,1616537060.873 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:20.873Z,1616537060.873 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:20.877Z,1616537060.877 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-03-23T22:04:20.877Z,1616537060.877 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:20.878Z,1616537060.878 [Onboard](INFO): Join timeout helper Thread ID is 7944
2021-03-23T22:04:25.172Z,1616537065.172 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:25.173Z,1616537065.173 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.184Z,1616537065.184 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-03-23T22:04:25.184Z,1616537065.184 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.185Z,1616537065.185 [DataOverHttps](INFO): Join timeout helper Thread ID is 7945
2021-03-23T22:04:25.768Z,1616537065.768 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:25.771Z,1616537065.771 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.777Z,1616537065.777 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2021-03-23T22:04:25.777Z,1616537065.777 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.777Z,1616537065.777 [BackseatComponent](INFO): Join timeout helper Thread ID is 7946
2021-03-23T22:04:25.904Z,1616537065.904 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:25.905Z,1616537065.905 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.917Z,1616537065.917 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-03-23T22:04:25.917Z,1616537065.917 [logger ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.917Z,1616537065.917 [logger](INFO): Join timeout helper Thread ID is 7947
2021-03-23T22:04:25.960Z,1616537065.960 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:25.961Z,1616537065.961 [logger ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.977Z,1616537065.977 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-03-23T22:04:25.977Z,1616537065.977 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.977Z,1616537065.977 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-03-23T22:04:25.977Z,1616537065.977 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:25.978Z,1616537065.978 [controlThread](INFO): Join timeout helper Thread ID is 7948
2021-03-23T22:04:26.008Z,1616537066.008 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-23T22:04:26.009Z,1616537066.009 [controlThread](DEBUG): Uninitializing ControlThread
2021-03-23T22:04:26.009Z,1616537066.009 [AHRS_M2](INFO): Powering down
2021-03-23T22:04:26.081Z,1616537066.081 [NAL9602](INFO): Powering down
2021-03-23T22:04:26.082Z,1616537066.082 [RDI_Pathfinder](INFO): Powering down
2021-03-23T22:04:26.083Z,1616537066.083 [DAT](INFO): Powering down
2021-03-23T22:04:26.205Z,1616537066.205 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-03-23T22:04:26.206Z,1616537066.206 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-03-23T22:04:26.206Z,1616537066.206 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-03-23T22:04:26.207Z,1616537066.207 [MissionManager](INFO): Uninitializing Mission Default
2021-03-23T22:04:26.209Z,1616537066.209 [MissionManager](INFO): Uninitializing Mission Startup
2021-03-23T22:04:26.210Z,1616537066.210 [Startup] Stopped
2021-03-23T22:04:26.210Z,1616537066.210 [Startup](DEBUG): Aggregate::uninitialize Startup
2021-03-23T22:04:26.210Z,1616537066.210 [Startup:A.GoToSurface] Stopped
2021-03-23T22:04:26.210Z,1616537066.210 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-03-23T22:04:26.210Z,1616537066.210 [Startup:StartupSatComms] Stopped
2021-03-23T22:04:26.210Z,1616537066.210 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2021-03-23T22:04:26.210Z,1616537066.210 [Startup:StartupSatComms:A] Stopped
2021-03-23T22:04:26.211Z,1616537066.211 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-03-23T22:04:26.212Z,1616537066.212 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-03-23T22:04:26.212Z,1616537066.212 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-03-23T22:04:26.212Z,1616537066.212 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-03-23T22:04:26.213Z,1616537066.213 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-03-23T22:04:26.213Z,1616537066.213 [BuoyancyServo](INFO): Powering down
2021-03-23T22:04:26.224Z,1616537066.224 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-03-23T22:04:26.224Z,1616537066.224 [ElevatorServo](INFO): Powering down
2021-03-23T22:04:26.225Z,1616537066.225 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-03-23T22:04:26.225Z,1616537066.225 [MassServo](INFO): Powering down
2021-03-23T22:04:26.226Z,1616537066.226 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-03-23T22:04:26.226Z,1616537066.226 [RudderServo](INFO): Powering down
2021-03-23T22:04:26.227Z,1616537066.227 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2021-03-23T22:04:26.227Z,1616537066.227 [ThrusterServo](INFO): Powering down
2021-03-23T22:04:26.228Z,1616537066.228 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-03-23T22:04:26.228Z,1616537066.228 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-03-23T22:04:26.229Z,1616537066.229 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-03-23T22:04:26.229Z,1616537066.229 [CBIT](DEBUG): Powering off loads.
2021-03-23T22:04:26.240Z,1616537066.240 [CBIT](DEBUG): Disabling WDT.
2021-03-23T22:04:26.252Z,1616537066.252 [CBIT](DEBUG): Opening all GF detection circuits.
2021-03-23T22:04:26.253Z,1616537066.253 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:26.304Z,1616537066.304 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:26.307Z,1616537066.307 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:26.312Z,1616537066.312 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:26.355Z,1616537066.355 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:26.409Z,1616537066.409 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:26.412Z,1616537066.412 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:26.420Z,1616537066.420 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-03-23T22:04:26.479Z,1616537066.479 [logger ThreadHandler](INFO): Thread cancelled.