2019-02-22T23:51:55.171Z,1550879515.171 [Supervisor](DEBUG): Initializing supervisor.
2019-02-22T23:51:55.174Z,1550879515.174 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-02-22T23:51:55.175Z,1550879515.175 [SyncHandler](INFO): Protected caller Thread ID is 1760
2019-02-22T23:51:55.176Z,1550879515.176 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-02-22T23:51:55.177Z,1550879515.177 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-02-22T23:51:55.177Z,1550879515.177 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1761
2019-02-22T23:51:55.180Z,1550879515.180 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-02-22T23:51:55.192Z,1550879515.192 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-02-22T23:51:55.193Z,1550879515.193 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-02-22T23:51:55.194Z,1550879515.194 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1762
2019-02-22T23:51:55.194Z,1550879515.194 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-02-22T23:51:55.195Z,1550879515.195 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-02-22T23:51:55.196Z,1550879515.196 [logger ThreadHandler](INFO): Protected caller Thread ID is 1763
2019-02-22T23:51:55.198Z,1550879515.198 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-02-22T23:51:55.198Z,1550879515.198 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-02-22T23:51:55.200Z,1550879515.200 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-02-22T23:51:55.612Z,1550879515.612 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-02-22T23:51:55.613Z,1550879515.613 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-02-22T23:51:55.753Z,1550879515.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-02-22T23:51:55.754Z,1550879515.754 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-02-22T23:51:55.832Z,1550879515.832 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-02-22T23:51:55.928Z,1550879515.928 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-02-22T23:51:55.928Z,1550879515.928 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-02-22T23:51:56.022Z,1550879516.022 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-02-22T23:51:56.023Z,1550879516.023 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-02-22T23:51:56.388Z,1550879516.388 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-02-22T23:51:56.388Z,1550879516.388 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-02-22T23:51:56.488Z,1550879516.488 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-02-22T23:51:56.489Z,1550879516.489 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-02-22T23:51:56.940Z,1550879516.940 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-02-22T23:51:56.941Z,1550879516.941 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-02-22T23:51:57.136Z,1550879517.136 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-02-22T23:51:57.137Z,1550879517.137 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-02-22T23:51:57.436Z,1550879517.436 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-02-22T23:51:57.436Z,1550879517.436 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-02-22T23:51:57.641Z,1550879517.641 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-02-22T23:51:57.641Z,1550879517.641 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-02-22T23:51:57.780Z,1550879517.780 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-02-22T23:51:57.781Z,1550879517.781 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-02-22T23:51:58.258Z,1550879518.258 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-02-22T23:51:58.258Z,1550879518.258 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-02-22T23:51:58.587Z,1550879518.587 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-02-22T23:51:58.587Z,1550879518.587 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-02-22T23:51:58.789Z,1550879518.789 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-02-22T23:51:58.791Z,1550879518.791 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2019-02-22T23:51:58.792Z,1550879518.792 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2019-02-22T23:51:58.962Z,1550879518.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2019-02-22T23:51:59.043Z,1550879519.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2019-02-22T23:51:59.155Z,1550879519.155 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2019-02-22T23:51:59.248Z,1550879519.248 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2019-02-22T23:52:00.060Z,1550879520.060 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-02-22T23:52:00.060Z,1550879520.060 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2019-02-22T23:52:00.157Z,1550879520.157 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2019-02-22T23:52:00.264Z,1550879520.264 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2019-02-22T23:52:00.356Z,1550879520.356 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2019-02-22T23:52:00.502Z,1550879520.502 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2019-02-22T23:52:00.601Z,1550879520.601 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2019-02-22T23:52:00.698Z,1550879520.698 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2019-02-22T23:52:00.698Z,1550879520.698 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-02-22T23:52:00.703Z,1550879520.703 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-02-22T23:52:00.717Z,1550879520.717 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-02-22T23:52:00.717Z,1550879520.717 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-02-22T23:52:00.784Z,1550879520.784 [VerticalControl](DEBUG): Construct VerticalControl.
2019-02-22T23:52:00.897Z,1550879520.897 [VerticalControl] Loaded
2019-02-22T23:52:00.897Z,1550879520.897 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-02-22T23:52:00.898Z,1550879520.898 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-02-22T23:52:00.966Z,1550879520.966 [HorizontalControl] Loaded
2019-02-22T23:52:00.966Z,1550879520.966 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-02-22T23:52:00.967Z,1550879520.967 [SpeedControl](DEBUG): Construct SpeedControl.
2019-02-22T23:52:00.972Z,1550879520.972 [SpeedControl] Loaded
2019-02-22T23:52:00.972Z,1550879520.972 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-02-22T23:52:00.973Z,1550879520.973 [LoopControl](DEBUG): Construct LoopControl.
2019-02-22T23:52:00.973Z,1550879520.973 [LoopControl] Loaded
2019-02-22T23:52:00.974Z,1550879520.974 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-02-22T23:52:00.974Z,1550879520.974 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-02-22T23:52:00.975Z,1550879520.975 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-02-22T23:52:01.096Z,1550879521.096 [BuoyancyServo] Loaded
2019-02-22T23:52:01.096Z,1550879521.096 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-02-22T23:52:01.107Z,1550879521.107 [ElevatorServo] Loaded
2019-02-22T23:52:01.108Z,1550879521.108 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-02-22T23:52:01.118Z,1550879521.118 [MassServo] Loaded
2019-02-22T23:52:01.119Z,1550879521.119 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-02-22T23:52:01.129Z,1550879521.129 [RudderServo] Loaded
2019-02-22T23:52:01.130Z,1550879521.130 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-02-22T23:52:01.130Z,1550879521.130 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-02-22T23:52:01.131Z,1550879521.131 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-02-22T23:52:01.171Z,1550879521.171 [DepthRateCalculator] Loaded
2019-02-22T23:52:01.172Z,1550879521.172 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-02-22T23:52:01.177Z,1550879521.177 [PitchRateCalculator] Loaded
2019-02-22T23:52:01.177Z,1550879521.177 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-02-22T23:52:01.193Z,1550879521.193 [SpeedCalculator] Loaded
2019-02-22T23:52:01.193Z,1550879521.193 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-02-22T23:52:01.213Z,1550879521.213 [TempGradientCalculator] Loaded
2019-02-22T23:52:01.214Z,1550879521.214 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-02-22T23:52:01.219Z,1550879521.219 [YawRateCalculator] Loaded
2019-02-22T23:52:01.219Z,1550879521.219 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-02-22T23:52:01.248Z,1550879521.248 [ElevatorOffsetCalculator] Loaded
2019-02-22T23:52:01.248Z,1550879521.248 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-02-22T23:52:01.248Z,1550879521.248 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-02-22T23:52:01.249Z,1550879521.249 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-02-22T23:52:01.353Z,1550879521.353 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-02-22T23:52:01.353Z,1550879521.353 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-02-22T23:52:01.411Z,1550879521.411 [DeadReckonUsingSpeedCalculator] Loaded
2019-02-22T23:52:01.411Z,1550879521.411 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-02-22T23:52:01.428Z,1550879521.428 [NavChart] Loaded
2019-02-22T23:52:01.428Z,1550879521.428 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-02-22T23:52:01.432Z,1550879521.432 [UniversalFixResidualReporter] Loaded
2019-02-22T23:52:01.433Z,1550879521.433 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-02-22T23:52:01.433Z,1550879521.433 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-02-22T23:52:01.434Z,1550879521.434 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-02-22T23:52:01.758Z,1550879521.758 [AHRS_M2] Loaded
2019-02-22T23:52:01.758Z,1550879521.758 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-02-22T23:52:01.832Z,1550879521.832 [DataOverHttps] Loaded
2019-02-22T23:52:01.832Z,1550879521.832 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-02-22T23:52:01.833Z,1550879521.833 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407F54E0
2019-02-22T23:52:01.834Z,1550879521.834 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1842
2019-02-22T23:52:01.847Z,1550879521.847 [Depth_Keller] Loaded
2019-02-22T23:52:01.847Z,1550879521.847 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-02-22T23:52:01.852Z,1550879521.852 [DropWeight] Loaded
2019-02-22T23:52:01.852Z,1550879521.852 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-02-22T23:52:01.949Z,1550879521.949 [NAL9602] Loaded
2019-02-22T23:52:01.949Z,1550879521.949 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-02-22T23:52:01.965Z,1550879521.965 [Onboard] Loaded
2019-02-22T23:52:01.965Z,1550879521.965 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-02-22T23:52:01.969Z,1550879521.969 [Radio_Surface] Loaded
2019-02-22T23:52:01.969Z,1550879521.969 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-02-22T23:52:01.970Z,1550879521.970 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408254E0
2019-02-22T23:52:01.970Z,1550879521.970 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1843
2019-02-22T23:52:03.745Z,1550879523.745 [BPC1] Loaded
2019-02-22T23:52:03.745Z,1550879523.745 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-02-22T23:52:03.745Z,1550879523.745 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-02-22T23:52:03.746Z,1550879523.746 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-02-22T23:52:03.810Z,1550879523.810 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-02-22T23:52:03.811Z,1550879523.811 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-02-22T23:52:03.910Z,1550879523.910 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-02-22T23:52:03.911Z,1550879523.911 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-02-22T23:52:03.937Z,1550879523.937 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-02-22T23:52:03.937Z,1550879523.937 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-02-22T23:52:04.182Z,1550879524.182 [CTD_NeilBrown] Loaded
2019-02-22T23:52:04.182Z,1550879524.182 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-02-22T23:52:04.183Z,1550879524.183 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409B04E0
2019-02-22T23:52:04.184Z,1550879524.184 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1844
2019-02-22T23:52:04.193Z,1550879524.193 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-02-22T23:52:04.198Z,1550879524.198 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-02-22T23:52:04.199Z,1550879524.199 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-02-22T23:52:04.204Z,1550879524.204 [CTD_Seabird](INFO): created writer for : depth
2019-02-22T23:52:04.205Z,1550879524.205 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-02-22T23:52:04.210Z,1550879524.210 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-02-22T23:52:04.210Z,1550879524.210 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-02-22T23:52:04.215Z,1550879524.215 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-02-22T23:52:04.216Z,1550879524.216 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-02-22T23:52:04.221Z,1550879524.221 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-02-22T23:52:04.222Z,1550879524.222 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-02-22T23:52:04.227Z,1550879524.227 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-02-22T23:52:04.227Z,1550879524.227 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-02-22T23:52:04.232Z,1550879524.232 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-02-22T23:52:04.259Z,1550879524.259 [CTD_Seabird] Loaded
2019-02-22T23:52:04.259Z,1550879524.259 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-02-22T23:52:04.260Z,1550879524.260 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409E04E0
2019-02-22T23:52:04.261Z,1550879524.261 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1845
2019-02-22T23:52:04.310Z,1550879524.310 [WetLabsBB2FL] Loaded
2019-02-22T23:52:04.310Z,1550879524.310 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-02-22T23:52:04.312Z,1550879524.312 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A104E0
2019-02-22T23:52:04.312Z,1550879524.312 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1846
2019-02-22T23:52:04.313Z,1550879524.313 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-02-22T23:52:04.313Z,1550879524.313 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-02-22T23:52:04.718Z,1550879524.718 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-02-22T23:52:04.719Z,1550879524.719 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-02-22T23:52:04.851Z,1550879524.851 [SBIT](DEBUG): Construct Startup Built In Test.
2019-02-22T23:52:04.861Z,1550879524.861 [SBIT] Loaded
2019-02-22T23:52:04.862Z,1550879524.862 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-02-22T23:52:04.862Z,1550879524.862 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-02-22T23:52:04.874Z,1550879524.874 [IBIT] Loaded
2019-02-22T23:52:04.874Z,1550879524.874 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-02-22T23:52:04.877Z,1550879524.877 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-02-22T23:52:05.013Z,1550879525.013 [CBIT] Loaded
2019-02-22T23:52:05.013Z,1550879525.013 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-02-22T23:52:05.014Z,1550879525.014 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-02-22T23:52:05.017Z,1550879525.017 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-02-22T23:52:05.018Z,1550879525.018 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-02-22T23:52:05.025Z,1550879525.025 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-02-22T23:52:05.026Z,1550879525.026 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ADD4E0
2019-02-22T23:52:05.026Z,1550879525.026 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1847
2019-02-22T23:52:05.031Z,1550879525.031 [Supervisor](INFO): Main Thread ID is 1614
2019-02-22T23:52:05.031Z,1550879525.031 [Supervisor](DEBUG): Running supervisor.
2019-02-22T23:52:05.031Z,1550879525.031 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1848
2019-02-22T23:52:05.034Z,1550879525.034 [controlThread ThreadHandler](INFO): Handler Thread ID is 1849
2019-02-22T23:52:05.034Z,1550879525.034 [controlThread](DEBUG): Initializing ControlThread
2019-02-22T23:52:05.035Z,1550879525.035 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-02-22T23:52:05.037Z,1550879525.037 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-02-22T23:52:05.037Z,1550879525.037 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-02-22T23:52:05.038Z,1550879525.038 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-02-22T23:52:05.039Z,1550879525.039 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-02-22T23:52:05.039Z,1550879525.039 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-02-22T23:52:05.040Z,1550879525.040 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-02-22T23:52:05.040Z,1550879525.040 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-02-22T23:52:05.041Z,1550879525.041 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-02-22T23:52:05.041Z,1550879525.041 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-02-22T23:52:05.042Z,1550879525.042 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-22T23:52:05.043Z,1550879525.043 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-02-22T23:52:05.043Z,1550879525.043 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-02-22T23:52:05.049Z,1550879525.049 [SBIT](INFO): Initialize SBIT Component.
2019-02-22T23:52:05.049Z,1550879525.049 [SBIT](IMPORTANT): git: 2019-02-11-73-gd81f403
2019-02-22T23:52:05.049Z,1550879525.049 [SBIT](INFO): git hash: d81f403ba8dd4609f3c9691256c8521b6bd69743
2019-02-22T23:52:05.049Z,1550879525.049 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-02-22T23:52:05.051Z,1550879525.051 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2019-02-22T23:52:05.052Z,1550879525.052 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-02-22T23:52:05.052Z,1550879525.052 [IBIT](INFO): Initialize IBIT Component.
2019-02-22T23:52:05.053Z,1550879525.053 [CBIT](DEBUG): Initialize CBIT Component.
2019-02-22T23:52:05.055Z,1550879525.055 [logger ThreadHandler](INFO): Handler Thread ID is 1850
2019-02-22T23:52:05.066Z,1550879525.066 [CBIT](DEBUG): Initialized mux pins.
2019-02-22T23:52:05.066Z,1550879525.066 [CBIT](DEBUG): Initializing the watchdog timer.
2019-02-22T23:52:05.075Z,1550879525.075 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1851
2019-02-22T23:52:05.076Z,1550879525.076 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-02-22T23:52:05.087Z,1550879525.087 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1852
2019-02-22T23:52:05.090Z,1550879525.090 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-02-22T23:52:05.090Z,1550879525.090 [CBIT](DEBUG): Initializing heartbeat.
2019-02-22T23:52:05.099Z,1550879525.099 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1853
2019-02-22T23:52:05.111Z,1550879525.111 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1854
2019-02-22T23:52:05.111Z,1550879525.111 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-22T23:52:05.115Z,1550879525.115 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-22T23:52:05.116Z,1550879525.116 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1856
2019-02-22T23:52:05.117Z,1550879525.117 [WetLabsBB2FL](INFO): Powering down
2019-02-22T23:52:05.159Z,1550879525.159 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1857
2019-02-22T23:52:05.161Z,1550879525.161 [NavChartDb](FAULT): Change detected in ENC collection. Wiping NavChart Directory
2019-02-22T23:52:05.162Z,1550879525.162 [CBIT](DEBUG): Deactivating GF circuits.
2019-02-22T23:52:05.162Z,1550879525.162 [CBIT](DEBUG): Deactivating emergency mode.
2019-02-22T23:52:05.170Z,1550879525.170 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-02-22T23:52:05.172Z,1550879525.172 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US1WC07M.000
2019-02-22T23:52:05.172Z,1550879525.172 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-02-22T23:52:05.173Z,1550879525.173 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2WC11M.000
2019-02-22T23:52:05.173Z,1550879525.173 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-02-22T23:52:05.175Z,1550879525.175 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3CA52M.000
2019-02-22T23:52:05.175Z,1550879525.175 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-02-22T23:52:05.177Z,1550879525.177 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4CA60M.000
2019-02-22T23:52:05.177Z,1550879525.177 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-02-22T23:52:05.178Z,1550879525.178 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA50M.000
2019-02-22T23:52:05.179Z,1550879525.179 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-02-22T23:52:05.180Z,1550879525.180 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA61M.000
2019-02-22T23:52:05.180Z,1550879525.180 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-02-22T23:52:05.182Z,1550879525.182 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA62M.000
2019-02-22T23:52:05.182Z,1550879525.182 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-02-22T23:52:05.184Z,1550879525.184 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA83M.000
2019-02-22T23:52:05.199Z,1550879525.199 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-02-22T23:52:05.209Z,1550879525.209 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-22T23:52:05.219Z,1550879525.219 [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>


2019-02-22T23:52:05.220Z,1550879525.220 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-02-22T23:52:05.271Z,1550879525.271 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA83M.000
2019-02-22T23:52:05.319Z,1550879525.319 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-02-22T23:52:05.320Z,1550879525.320 [Default:A.Wait](DEBUG): Construct Wait.
2019-02-22T23:52:05.321Z,1550879525.321 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-22T23:52:05.412Z,1550879525.412 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-02-22T23:52:05.414Z,1550879525.414 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-02-22T23:52:05.443Z,1550879525.443 [Default:E.Execute](DEBUG): Construct Execute.
2019-02-22T23:52:05.447Z,1550879525.447 [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>


2019-02-22T23:52:05.458Z,1550879525.458 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-02-22T23:52:05.467Z,1550879525.467 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-02-22T23:52:05.490Z,1550879525.490 [Radio_Surface](INFO): Powering up
2019-02-22T23:52:05.563Z,1550879525.563 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar
2019-02-22T23:52:05.643Z,1550879525.643 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:05.671Z,1550879525.671 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-02-22T23:52:05.683Z,1550879525.683 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-02-22T23:52:05.684Z,1550879525.684 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-02-22T23:52:05.711Z,1550879525.711 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-02-22T23:52:05.712Z,1550879525.712 [MassServo](DEBUG): Initializing EZServoServo.
2019-02-22T23:52:05.719Z,1550879525.719 [MassServo](DEBUG): Initializing MassServo.
2019-02-22T23:52:05.720Z,1550879525.720 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-22T23:52:05.737Z,1550879525.737 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-22T23:52:05.879Z,1550879525.879 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-02-22T23:52:05.879Z,1550879525.879 [DropWeight] Hardware Fault, FailCount= 1
2019-02-22T23:52:05.879Z,1550879525.879 [DropWeight](ERROR): Hardware Fault
2019-02-22T23:52:05.915Z,1550879525.915 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:05.947Z,1550879525.947 [CommandLine](FAULT): Scheduling is paused
2019-02-22T23:52:05.948Z,1550879525.948 [CBIT](INFO): Critical error at 20190222T235205
2019-02-22T23:52:05.948Z,1550879525.948 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-02-22T23:52:05.951Z,1550879525.951 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-02-22T23:52:05.951Z,1550879525.951 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-02-22T23:52:06.283Z,1550879526.283 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:06.598Z,1550879526.598 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2019-02-22T23:52:06.599Z,1550879526.599 [RudderServo](FAULT): Rudder failed to initialize
2019-02-22T23:52:06.599Z,1550879526.599 [RudderServo] Communications Fault, FailCount= 1
2019-02-22T23:52:06.599Z,1550879526.599 [RudderServo](ERROR): Communications Fault
2019-02-22T23:52:06.600Z,1550879526.600 [CBIT](INFO): Critical error at 20190222T235205
2019-02-22T23:52:06.603Z,1550879526.603 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-02-22T23:52:06.687Z,1550879526.687 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:06.819Z,1550879526.819 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-22T23:52:06.819Z,1550879526.819 [RudderServo](INFO): Powering down
2019-02-22T23:52:07.091Z,1550879527.091 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:07.495Z,1550879527.495 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:07.511Z,1550879527.511 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-22T23:52:07.631Z,1550879527.631 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-22T23:52:07.635Z,1550879527.635 [CBIT](INFO): Clearing failed state for component RudderServo
2019-02-22T23:52:07.635Z,1550879527.635 [RudderServo] No Fault, FailCount= 1
2019-02-22T23:52:07.903Z,1550879527.903 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:08.311Z,1550879528.311 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:09.014Z,1550879529.014 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:09.039Z,1550879529.039 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:09.418Z,1550879529.418 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:09.447Z,1550879529.447 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:09.822Z,1550879529.822 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:09.843Z,1550879529.843 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:10.250Z,1550879530.250 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:10.283Z,1550879530.283 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:10.666Z,1550879530.666 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:10.695Z,1550879530.695 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:11.126Z,1550879531.126 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:11.151Z,1550879531.151 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:11.338Z,1550879531.338 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:11.359Z,1550879531.359 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:11.962Z,1550879531.962 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:11.987Z,1550879531.987 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:12.390Z,1550879532.390 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:12.415Z,1550879532.415 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:12.794Z,1550879532.794 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:12.819Z,1550879532.819 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:13.211Z,1550879533.211 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:13.231Z,1550879533.231 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:13.331Z,1550879533.331 [RudderServo](FAULT): Overload Error
2019-02-22T23:52:13.331Z,1550879533.331 [RudderServo] Hardware Fault, FailCount= 2
2019-02-22T23:52:13.331Z,1550879533.331 [RudderServo](ERROR): Hardware Fault
2019-02-22T23:52:13.335Z,1550879533.335 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-02-22T23:52:13.430Z,1550879533.430 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:13.451Z,1550879533.451 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:13.487Z,1550879533.487 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-22T23:52:13.487Z,1550879533.487 [RudderServo](INFO): Powering down
2019-02-22T23:52:14.058Z,1550879534.058 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:14.079Z,1550879534.079 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:14.462Z,1550879534.462 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-02-22T23:52:14.483Z,1550879534.483 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:14.528Z,1550879534.528 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-22T23:52:14.652Z,1550879534.652 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-22T23:52:14.656Z,1550879534.656 [CBIT](INFO): Clearing failed state for component RudderServo
2019-02-22T23:52:14.656Z,1550879534.656 [RudderServo] No Fault, FailCount= 2
2019-02-22T23:52:14.731Z,1550879534.731 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:15.158Z,1550879535.158 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:15.179Z,1550879535.179 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:15.282Z,1550879535.282 [CBIT](CRITICAL): Environmental Failure. Press:14.983178 PSI. Humidity:24%. Temp:25 C. ABORTING MISSION
2019-02-22T23:52:15.562Z,1550879535.562 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:15.599Z,1550879535.599 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:15.640Z,1550879535.640 [CBIT](INFO): Critical error at 20190222T235215
2019-02-22T23:52:15.966Z,1550879535.966 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:15.999Z,1550879535.999 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:16.370Z,1550879536.370 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:16.391Z,1550879536.391 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:16.774Z,1550879536.774 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:16.795Z,1550879536.795 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:17.398Z,1550879537.398 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:17.419Z,1550879537.419 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:17.802Z,1550879537.802 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:17.823Z,1550879537.823 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:18.243Z,1550879538.243 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:18.263Z,1550879538.263 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:18.643Z,1550879538.643 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:18.643Z,1550879538.643 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-02-22T23:52:18.643Z,1550879538.643 [AHRS_M2] Communications Fault, FailCount= 1
2019-02-22T23:52:18.643Z,1550879538.643 [AHRS_M2](ERROR): Communications Fault
2019-02-22T23:52:18.663Z,1550879538.663 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:18.738Z,1550879538.738 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-02-22T23:52:18.743Z,1550879538.743 [AHRS_M2](INFO): Powering down
2019-02-22T23:52:18.863Z,1550879538.863 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:19.155Z,1550879539.155 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-22T23:52:19.155Z,1550879539.155 [CTD_Seabird] Communications Fault, FailCount= 1
2019-02-22T23:52:19.155Z,1550879539.155 [CTD_Seabird](ERROR): Communications Fault
2019-02-22T23:52:19.167Z,1550879539.167 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:19.227Z,1550879539.227 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-22T23:52:19.560Z,1550879539.560 [CTD_Seabird](INFO): Powering down
2019-02-22T23:52:19.591Z,1550879539.591 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:19.650Z,1550879539.650 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-02-22T23:52:19.651Z,1550879539.651 [AHRS_M2] No Fault, FailCount= 1
2019-02-22T23:52:19.954Z,1550879539.954 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-02-22T23:52:19.979Z,1550879539.979 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:20.035Z,1550879540.035 [RudderServo](FAULT): Overload Error
2019-02-22T23:52:20.035Z,1550879540.035 [RudderServo] Hardware Fault, FailCount= 3
2019-02-22T23:52:20.035Z,1550879540.035 [RudderServo](ERROR): Hardware Fault
2019-02-22T23:52:20.074Z,1550879540.074 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-02-22T23:52:20.074Z,1550879540.074 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2019-02-22T23:52:20.280Z,1550879540.280 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA83M.000
2019-02-22T23:52:20.383Z,1550879540.383 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:20.423Z,1550879540.423 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-22T23:52:20.423Z,1550879540.423 [RudderServo](INFO): Powering down
2019-02-22T23:52:20.425Z,1550879540.425 [CBIT](INFO): Critical error at 20190222T235220
2019-02-22T23:52:20.807Z,1550879540.807 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:21.207Z,1550879541.207 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:21.247Z,1550879541.247 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-22T23:52:21.363Z,1550879541.363 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-22T23:52:21.607Z,1550879541.607 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:21.659Z,1550879541.659 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-22T23:52:21.659Z,1550879541.659 [CTD_Seabird] No Fault, FailCount= 1
2019-02-22T23:52:22.001Z,1550879542.001 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:22.411Z,1550879542.411 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:22.526Z,1550879542.526 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-22T23:52:22.535Z,1550879542.535 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-22T23:52:22.811Z,1550879542.811 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:23.510Z,1550879543.510 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:23.531Z,1550879543.531 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:23.914Z,1550879543.914 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:23.935Z,1550879543.935 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:24.326Z,1550879544.326 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:24.351Z,1550879544.351 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:24.730Z,1550879544.730 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:24.771Z,1550879544.771 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:25.146Z,1550879545.146 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:25.167Z,1550879545.167 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:25.558Z,1550879545.558 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:25.579Z,1550879545.579 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:25.954Z,1550879545.954 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:25.999Z,1550879545.999 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:26.366Z,1550879546.366 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:26.391Z,1550879546.391 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:26.794Z,1550879546.794 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:26.855Z,1550879546.855 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:27.250Z,1550879547.250 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:27.303Z,1550879547.303 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:27.458Z,1550879547.458 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:27.479Z,1550879547.479 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:28.115Z,1550879548.115 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:28.139Z,1550879548.139 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:28.530Z,1550879548.530 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:28.552Z,1550879548.552 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:28.919Z,1550879548.919 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:28.943Z,1550879548.943 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:29.343Z,1550879549.343 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:29.371Z,1550879549.371 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:29.810Z,1550879549.810 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:29.855Z,1550879549.855 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:30.226Z,1550879550.226 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:30.259Z,1550879550.259 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:30.622Z,1550879550.622 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:30.643Z,1550879550.643 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:31.026Z,1550879551.026 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:31.042Z,1550879551.042 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:31.438Z,1550879551.438 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:31.454Z,1550879551.454 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:31.838Z,1550879551.838 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:31.863Z,1550879551.863 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:32.250Z,1550879552.250 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2019-02-22T23:52:32.255Z,1550879552.255 [NAL9602](INFO): Powering up NAL9602
2019-02-22T23:52:32.275Z,1550879552.275 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:32.399Z,1550879552.399 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:32.803Z,1550879552.803 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:33.191Z,1550879553.191 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-02-22T23:52:33.191Z,1550879553.191 [AHRS_M2] Communications Fault, FailCount= 2
2019-02-22T23:52:33.191Z,1550879553.191 [AHRS_M2](ERROR): Communications Fault
2019-02-22T23:52:33.211Z,1550879553.211 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:33.247Z,1550879553.247 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-02-22T23:52:33.542Z,1550879553.542 [AHRS_M2](INFO): Powering down
2019-02-22T23:52:33.631Z,1550879553.631 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:33.684Z,1550879553.684 [SBIT](IMPORTANT): Beginning Startup BIT
2019-02-22T23:52:33.689Z,1550879553.689 [CBIT](IMPORTANT): Beginning ground fault scan
2019-02-22T23:52:33.963Z,1550879553.963 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:34.375Z,1550879554.375 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:34.478Z,1550879554.478 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-02-22T23:52:34.478Z,1550879554.478 [AHRS_M2] No Fault, FailCount= 2
2019-02-22T23:52:34.754Z,1550879554.754 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-02-22T23:52:34.778Z,1550879554.778 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:35.179Z,1550879555.179 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:35.599Z,1550879555.599 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:35.987Z,1550879555.987 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:36.388Z,1550879556.388 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:36.578Z,1550879556.578 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-22T23:52:36.578Z,1550879556.578 [CTD_Seabird] Communications Fault, FailCount= 2
2019-02-22T23:52:36.578Z,1550879556.578 [CTD_Seabird](ERROR): Communications Fault
2019-02-22T23:52:36.797Z,1550879556.797 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:36.864Z,1550879556.864 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-22T23:52:36.982Z,1550879556.982 [CTD_Seabird](INFO): Powering down
2019-02-22T23:52:37.195Z,1550879557.195 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:37.599Z,1550879557.599 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:38.030Z,1550879558.030 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:38.435Z,1550879558.435 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:38.839Z,1550879558.839 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:38.929Z,1550879558.929 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-22T23:52:38.929Z,1550879558.929 [CTD_Seabird] No Fault, FailCount= 2
2019-02-22T23:52:39.255Z,1550879559.255 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:39.655Z,1550879559.655 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:39.931Z,1550879559.931 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-22T23:52:39.933Z,1550879559.933 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-22T23:52:40.322Z,1550879560.322 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:40.351Z,1550879560.351 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:40.838Z,1550879560.838 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:40.859Z,1550879560.859 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:41.270Z,1550879561.270 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:41.307Z,1550879561.307 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:41.682Z,1550879561.682 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:41.715Z,1550879561.715 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:42.238Z,1550879562.238 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:42.259Z,1550879562.259 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:42.691Z,1550879562.691 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:42.723Z,1550879562.723 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:43.158Z,1550879563.158 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:43.191Z,1550879563.191 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:43.686Z,1550879563.686 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:43.700Z,1550879563.700 [NAL9602](INFO): NAL9602 initialized
2019-02-22T23:52:43.723Z,1550879563.723 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:44.170Z,1550879564.170 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:44.191Z,1550879564.191 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:44.598Z,1550879564.598 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:44.625Z,1550879564.625 [NAL9602](DEBUG): Fix Requested
2019-02-22T23:52:44.643Z,1550879564.643 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:45.106Z,1550879565.106 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:45.179Z,1550879565.179 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:45.231Z,1550879565.231 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.008318
CHAN A1 (24V): 0.002496
CHAN A2 (12V): -0.068427
CHAN A3 (5V): -0.003279
CHAN B0 (3.3V): -0.001176
CHAN B1 (3.15aV): -0.000875
CHAN B2 (3.15bV): -0.001226
CHAN B3 (GND): -0.000001
OPEN: -0.001295
Full Scale Calc: 4.765 mA, -1.589 mA
2019-02-22T23:52:45.590Z,1550879565.590 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:45.631Z,1550879565.631 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:46.030Z,1550879566.030 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:46.051Z,1550879566.051 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:46.446Z,1550879566.446 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:46.471Z,1550879566.471 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:46.878Z,1550879566.878 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:46.903Z,1550879566.903 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:46.976Z,1550879566.976 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-02-22T23:52:47.302Z,1550879567.302 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:47.367Z,1550879567.367 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:47.806Z,1550879567.806 [AHRS_M2](ERROR): Subscribe yawErrEst UART error: serial timeout
2019-02-22T23:52:47.807Z,1550879567.807 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-02-22T23:52:47.807Z,1550879567.807 [AHRS_M2] Communications Fault, FailCount= 3
2019-02-22T23:52:47.807Z,1550879567.807 [AHRS_M2](ERROR): Communications Fault
2019-02-22T23:52:47.839Z,1550879567.839 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:47.971Z,1550879567.971 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-02-22T23:52:47.978Z,1550879567.978 [AHRS_M2](INFO): Powering down
2019-02-22T23:52:48.095Z,1550879568.095 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:48.403Z,1550879568.403 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:48.811Z,1550879568.811 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:48.951Z,1550879568.951 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-02-22T23:52:48.951Z,1550879568.951 [AHRS_M2] No Fault, FailCount= 3
2019-02-22T23:52:49.186Z,1550879569.186 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-02-22T23:52:49.215Z,1550879569.215 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:49.615Z,1550879569.615 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:50.031Z,1550879570.031 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:50.163Z,1550879570.163 [CommandLine](IMPORTANT): got command configSet AHRS_M2.loadAtStartup 0.000000 bool persist
2019-02-22T23:52:50.164Z,1550879570.164 [CommandLine](IMPORTANT): configSet AHRS_M2.loadAtStartup requires a restart to take effect.
2019-02-22T23:52:50.232Z,1550879570.232 [NavChartDb](INFO): # of records loaded: 5000
2019-02-22T23:52:50.418Z,1550879570.418 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:50.827Z,1550879570.827 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:51.231Z,1550879571.231 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:51.626Z,1550879571.626 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:52.051Z,1550879572.051 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:52.479Z,1550879572.479 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:52.887Z,1550879572.887 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:53.287Z,1550879573.287 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:53.679Z,1550879573.679 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:53.978Z,1550879573.978 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-22T23:52:53.978Z,1550879573.978 [CTD_Seabird] Communications Fault, FailCount= 3
2019-02-22T23:52:53.978Z,1550879573.978 [CTD_Seabird](ERROR): Communications Fault
2019-02-22T23:52:54.067Z,1550879574.067 [CommandLine](IMPORTANT): got command restart application
2019-02-22T23:52:54.139Z,1550879574.139 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:54.251Z,1550879574.251 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-22T23:52:54.252Z,1550879574.252 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-02-22T23:52:54.383Z,1550879574.383 [CTD_Seabird](INFO): Powering down
2019-02-22T23:52:54.474Z,1550879574.474 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:54.875Z,1550879574.875 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:55.071Z,1550879575.071 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:55.071Z,1550879575.071 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.234Z,1550879575.234 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-02-22T23:52:55.234Z,1550879575.234 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.235Z,1550879575.235 [CommandLine](INFO): Join timeout helper Thread ID is 1872
2019-02-22T23:52:55.254Z,1550879575.254 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-02-22T23:52:55.255Z,1550879575.255 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.255Z,1550879575.255 [NavChartDb](INFO): Join timeout helper Thread ID is 1873
2019-02-22T23:52:55.255Z,1550879575.255 [NavChartDb](INFO): # of records loaded: 5606
2019-02-22T23:52:55.263Z,1550879575.263 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA83M.000
2019-02-22T23:52:55.263Z,1550879575.263 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:55.264Z,1550879575.264 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.264Z,1550879575.264 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-02-22T23:52:55.264Z,1550879575.264 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.265Z,1550879575.265 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1874
2019-02-22T23:52:55.343Z,1550879575.343 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:55.554Z,1550879575.554 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:55.555Z,1550879575.555 [WetLabsBB2FL](INFO): Powering down
2019-02-22T23:52:55.555Z,1550879575.555 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.562Z,1550879575.562 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-02-22T23:52:55.563Z,1550879575.563 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.563Z,1550879575.563 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1875
2019-02-22T23:52:55.695Z,1550879575.695 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:55.918Z,1550879575.918 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:55.919Z,1550879575.919 [CTD_Seabird](INFO): Powering down
2019-02-22T23:52:55.930Z,1550879575.930 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.934Z,1550879575.934 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-02-22T23:52:55.935Z,1550879575.935 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.935Z,1550879575.935 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1876
2019-02-22T23:52:55.935Z,1550879575.935 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:55.935Z,1550879575.935 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.937Z,1550879575.937 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-02-22T23:52:55.937Z,1550879575.937 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:55.937Z,1550879575.937 [Radio_Surface](INFO): Join timeout helper Thread ID is 1877
2019-02-22T23:52:55.998Z,1550879575.998 [Radio_Surface](INFO): Powering down
2019-02-22T23:52:55.999Z,1550879575.999 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:55.999Z,1550879575.999 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.003Z,1550879576.003 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-02-22T23:52:56.003Z,1550879576.003 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.004Z,1550879576.004 [DataOverHttps](INFO): Join timeout helper Thread ID is 1878
2019-02-22T23:52:56.082Z,1550879576.082 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-22T23:52:56.390Z,1550879576.390 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:56.391Z,1550879576.391 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.402Z,1550879576.402 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-02-22T23:52:56.402Z,1550879576.402 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.403Z,1550879576.403 [logger](INFO): Join timeout helper Thread ID is 1879
2019-02-22T23:52:56.403Z,1550879576.403 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:56.403Z,1550879576.403 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.404Z,1550879576.404 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-02-22T23:52:56.405Z,1550879576.405 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.405Z,1550879576.405 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-02-22T23:52:56.405Z,1550879576.405 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.405Z,1550879576.405 [controlThread](INFO): Join timeout helper Thread ID is 1880
2019-02-22T23:52:56.454Z,1550879576.454 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-22T23:52:56.455Z,1550879576.455 [controlThread](DEBUG): Uninitializing ControlThread
2019-02-22T23:52:56.455Z,1550879576.455 [AHRS_M2](INFO): Powering down
2019-02-22T23:52:56.527Z,1550879576.527 [NAL9602](INFO): Powering down
2019-02-22T23:52:56.529Z,1550879576.529 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-02-22T23:52:56.530Z,1550879576.530 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-02-22T23:52:56.531Z,1550879576.531 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-02-22T23:52:56.531Z,1550879576.531 [MissionManager](INFO): Uninitializing Mission Default
2019-02-22T23:52:56.533Z,1550879576.533 [MissionManager](INFO): Uninitializing Mission Startup
2019-02-22T23:52:56.535Z,1550879576.535 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-02-22T23:52:56.535Z,1550879576.535 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-02-22T23:52:56.535Z,1550879576.535 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-02-22T23:52:56.535Z,1550879576.535 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-02-22T23:52:56.536Z,1550879576.536 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-02-22T23:52:56.536Z,1550879576.536 [BuoyancyServo](INFO): Powering down
2019-02-22T23:52:56.552Z,1550879576.552 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-02-22T23:52:56.552Z,1550879576.552 [ElevatorServo](INFO): Powering down
2019-02-22T23:52:56.555Z,1550879576.555 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-02-22T23:52:56.555Z,1550879576.555 [MassServo](INFO): Powering down
2019-02-22T23:52:56.556Z,1550879576.556 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-22T23:52:56.556Z,1550879576.556 [RudderServo](INFO): Powering down
2019-02-22T23:52:56.556Z,1550879576.556 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-02-22T23:52:56.557Z,1550879576.557 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-02-22T23:52:56.557Z,1550879576.557 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-02-22T23:52:56.557Z,1550879576.557 [CBIT](DEBUG): Powering off loads.
2019-02-22T23:52:56.570Z,1550879576.570 [CBIT](DEBUG): Disabling WDT.
2019-02-22T23:52:56.582Z,1550879576.582 [CBIT](DEBUG): Opening all GF detection circuits.
2019-02-22T23:52:56.583Z,1550879576.583 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.933Z,1550879576.933 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.939Z,1550879576.939 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.971Z,1550879576.971 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.973Z,1550879576.973 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:56.976Z,1550879576.976 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:57.005Z,1550879577.005 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-22T23:52:57.046Z,1550879577.046 [logger ThreadHandler](INFO): Thread cancelled.