2020-08-12T17:35:05.580Z,1597253705.580 [Supervisor](DEBUG): Initializing supervisor.
2020-08-12T17:35:05.583Z,1597253705.583 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-08-12T17:35:05.583Z,1597253705.583 [SyncHandler](INFO): Protected caller Thread ID is 7747
2020-08-12T17:35:05.584Z,1597253705.584 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-08-12T17:35:05.585Z,1597253705.585 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-08-12T17:35:05.585Z,1597253705.585 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7748
2020-08-12T17:35:05.588Z,1597253705.588 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-08-12T17:35:05.599Z,1597253705.599 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-08-12T17:35:05.600Z,1597253705.600 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-08-12T17:35:05.601Z,1597253705.601 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7749
2020-08-12T17:35:05.602Z,1597253705.602 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-08-12T17:35:05.602Z,1597253705.602 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-08-12T17:35:05.603Z,1597253705.603 [logger ThreadHandler](INFO): Protected caller Thread ID is 7750
2020-08-12T17:35:05.605Z,1597253705.605 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-08-12T17:35:05.605Z,1597253705.605 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-08-12T17:35:05.607Z,1597253705.607 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-08-12T17:35:06.020Z,1597253706.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-08-12T17:35:06.020Z,1597253706.020 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-08-12T17:35:06.157Z,1597253706.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-08-12T17:35:06.158Z,1597253706.158 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-08-12T17:35:06.235Z,1597253706.235 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-08-12T17:35:06.421Z,1597253706.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-08-12T17:35:06.422Z,1597253706.422 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-08-12T17:35:06.516Z,1597253706.516 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-08-12T17:35:06.517Z,1597253706.517 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-08-12T17:35:06.610Z,1597253706.610 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-08-12T17:35:06.611Z,1597253706.611 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-08-12T17:35:06.985Z,1597253706.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-08-12T17:35:06.986Z,1597253706.986 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-08-12T17:35:07.085Z,1597253707.085 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-08-12T17:35:07.085Z,1597253707.085 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-08-12T17:35:07.525Z,1597253707.525 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-08-12T17:35:07.526Z,1597253707.526 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-08-12T17:35:07.708Z,1597253707.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-08-12T17:35:07.708Z,1597253707.708 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-08-12T17:35:08.004Z,1597253708.004 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-08-12T17:35:08.005Z,1597253708.005 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-08-12T17:35:08.212Z,1597253708.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-08-12T17:35:08.213Z,1597253708.213 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-08-12T17:35:08.349Z,1597253708.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-08-12T17:35:08.350Z,1597253708.350 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-08-12T17:35:08.985Z,1597253708.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-08-12T17:35:08.986Z,1597253708.986 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-08-12T17:35:09.299Z,1597253709.299 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-08-12T17:35:09.299Z,1597253709.299 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-08-12T17:35:09.499Z,1597253709.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-08-12T17:35:09.501Z,1597253709.501 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2020-08-12T17:35:09.502Z,1597253709.502 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2020-08-12T17:35:09.756Z,1597253709.756 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2020-08-12T17:35:09.840Z,1597253709.840 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2020-08-12T17:35:09.986Z,1597253709.986 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2020-08-12T17:35:10.068Z,1597253710.068 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2020-08-12T17:35:10.293Z,1597253710.293 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-08-12T17:35:10.293Z,1597253710.293 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2020-08-12T17:35:10.624Z,1597253710.624 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2020-08-12T17:35:10.794Z,1597253710.794 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2020-08-12T17:35:11.053Z,1597253711.053 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2020-08-12T17:35:11.421Z,1597253711.421 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2020-08-12T17:35:11.835Z,1597253711.835 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2020-08-12T17:35:11.929Z,1597253711.929 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-08-12T17:35:11.941Z,1597253711.941 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-08-12T17:35:11.954Z,1597253711.954 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-08-12T17:35:11.955Z,1597253711.955 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-08-12T17:35:12.001Z,1597253712.001 [VerticalControl](DEBUG): Construct VerticalControl.
2020-08-12T17:35:12.112Z,1597253712.112 [VerticalControl] Loaded
2020-08-12T17:35:12.112Z,1597253712.112 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-08-12T17:35:12.113Z,1597253712.113 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-08-12T17:35:12.180Z,1597253712.180 [HorizontalControl] Loaded
2020-08-12T17:35:12.180Z,1597253712.180 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-08-12T17:35:12.180Z,1597253712.180 [SpeedControl](DEBUG): Construct SpeedControl.
2020-08-12T17:35:12.186Z,1597253712.186 [SpeedControl] Loaded
2020-08-12T17:35:12.186Z,1597253712.186 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-08-12T17:35:12.187Z,1597253712.187 [LoopControl](DEBUG): Construct LoopControl.
2020-08-12T17:35:12.187Z,1597253712.187 [LoopControl] Loaded
2020-08-12T17:35:12.188Z,1597253712.188 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-08-12T17:35:12.188Z,1597253712.188 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-08-12T17:35:12.188Z,1597253712.188 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-08-12T17:35:12.289Z,1597253712.289 [BuoyancyServo] Loaded
2020-08-12T17:35:12.289Z,1597253712.289 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-08-12T17:35:12.300Z,1597253712.300 [ElevatorServo] Loaded
2020-08-12T17:35:12.300Z,1597253712.300 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-08-12T17:35:12.311Z,1597253712.311 [MassServo] Loaded
2020-08-12T17:35:12.311Z,1597253712.311 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-08-12T17:35:12.322Z,1597253712.322 [RudderServo] Loaded
2020-08-12T17:35:12.323Z,1597253712.323 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-08-12T17:35:12.333Z,1597253712.333 [ThrusterServo] Loaded
2020-08-12T17:35:12.333Z,1597253712.333 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-08-12T17:35:12.334Z,1597253712.334 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-08-12T17:35:12.334Z,1597253712.334 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-08-12T17:35:12.374Z,1597253712.374 [DepthRateCalculator] Loaded
2020-08-12T17:35:12.374Z,1597253712.374 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-08-12T17:35:12.379Z,1597253712.379 [PitchRateCalculator] Loaded
2020-08-12T17:35:12.379Z,1597253712.379 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-08-12T17:35:12.394Z,1597253712.394 [SpeedCalculator] Loaded
2020-08-12T17:35:12.394Z,1597253712.394 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-08-12T17:35:12.415Z,1597253712.415 [TempGradientCalculator] Loaded
2020-08-12T17:35:12.415Z,1597253712.415 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-08-12T17:35:12.420Z,1597253712.420 [YawRateCalculator] Loaded
2020-08-12T17:35:12.420Z,1597253712.420 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-08-12T17:35:12.449Z,1597253712.449 [ElevatorOffsetCalculator] Loaded
2020-08-12T17:35:12.449Z,1597253712.449 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-08-12T17:35:12.450Z,1597253712.450 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-08-12T17:35:12.450Z,1597253712.450 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-08-12T17:35:12.552Z,1597253712.552 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-08-12T17:35:12.552Z,1597253712.552 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-08-12T17:35:12.573Z,1597253712.573 [NavChart] Loaded
2020-08-12T17:35:12.573Z,1597253712.573 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-08-12T17:35:12.577Z,1597253712.577 [UniversalFixResidualReporter] Loaded
2020-08-12T17:35:12.577Z,1597253712.577 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-08-12T17:35:12.577Z,1597253712.577 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-08-12T17:35:12.578Z,1597253712.578 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-08-12T17:35:12.827Z,1597253712.827 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-08-12T17:35:12.832Z,1597253712.832 [AHRS_M2](INFO): created writer for : platform_orientation
2020-08-12T17:35:12.834Z,1597253712.834 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-08-12T17:35:12.839Z,1597253712.839 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-08-12T17:35:12.840Z,1597253712.840 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-08-12T17:35:12.845Z,1597253712.845 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-08-12T17:35:12.845Z,1597253712.845 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-08-12T17:35:12.850Z,1597253712.850 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-08-12T17:35:12.922Z,1597253712.922 [AHRS_M2] Loaded
2020-08-12T17:35:12.923Z,1597253712.923 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-08-12T17:35:13.000Z,1597253713.000 [DataOverHttps] Loaded
2020-08-12T17:35:13.000Z,1597253713.000 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-08-12T17:35:13.001Z,1597253713.001 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407F94E0
2020-08-12T17:35:13.002Z,1597253713.002 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7833
2020-08-12T17:35:13.015Z,1597253713.015 [Depth_Keller] Loaded
2020-08-12T17:35:13.015Z,1597253713.015 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-08-12T17:35:13.111Z,1597253713.111 [NAL9602] Loaded
2020-08-12T17:35:13.111Z,1597253713.111 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-08-12T17:35:13.160Z,1597253713.160 [Onboard] Loaded
2020-08-12T17:35:13.160Z,1597253713.160 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-08-12T17:35:13.161Z,1597253713.161 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408294E0
2020-08-12T17:35:13.161Z,1597253713.161 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7834
2020-08-12T17:35:13.165Z,1597253713.165 [Radio_Surface] Loaded
2020-08-12T17:35:13.165Z,1597253713.165 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-08-12T17:35:13.166Z,1597253713.166 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408594E0
2020-08-12T17:35:13.166Z,1597253713.166 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7835
2020-08-12T17:35:13.290Z,1597253713.290 [DAT] Loaded
2020-08-12T17:35:13.290Z,1597253713.290 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-08-12T17:35:14.793Z,1597253714.793 [BPC1] Loaded
2020-08-12T17:35:14.793Z,1597253714.793 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-08-12T17:35:14.800Z,1597253714.800 [AMEcho] Loaded
2020-08-12T17:35:14.800Z,1597253714.800 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2020-08-12T17:35:14.801Z,1597253714.801 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-08-12T17:35:14.801Z,1597253714.801 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-08-12T17:35:14.870Z,1597253714.870 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-08-12T17:35:14.870Z,1597253714.870 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-08-12T17:35:14.965Z,1597253714.965 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-08-12T17:35:14.966Z,1597253714.966 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-08-12T17:35:14.998Z,1597253714.998 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-08-12T17:35:14.998Z,1597253714.998 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-08-12T17:35:15.179Z,1597253715.179 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-08-12T17:35:15.185Z,1597253715.185 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-08-12T17:35:15.185Z,1597253715.185 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-08-12T17:35:15.190Z,1597253715.190 [CTD_Seabird](INFO): created writer for : depth
2020-08-12T17:35:15.190Z,1597253715.190 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-08-12T17:35:15.195Z,1597253715.195 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-08-12T17:35:15.196Z,1597253715.196 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-08-12T17:35:15.201Z,1597253715.201 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-08-12T17:35:15.201Z,1597253715.201 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-08-12T17:35:15.206Z,1597253715.206 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-08-12T17:35:15.207Z,1597253715.207 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-08-12T17:35:15.212Z,1597253715.212 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-08-12T17:35:15.213Z,1597253715.213 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-08-12T17:35:15.218Z,1597253715.218 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-08-12T17:35:15.245Z,1597253715.245 [CTD_Seabird] Loaded
2020-08-12T17:35:15.245Z,1597253715.245 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-08-12T17:35:15.246Z,1597253715.246 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409EF4E0
2020-08-12T17:35:15.246Z,1597253715.246 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7836
2020-08-12T17:35:15.277Z,1597253715.277 [ESPComponent] Loaded
2020-08-12T17:35:15.277Z,1597253715.277 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-08-12T17:35:15.291Z,1597253715.291 [PAR_Licor] Loaded
2020-08-12T17:35:15.291Z,1597253715.291 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-08-12T17:35:15.298Z,1597253715.298 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-08-12T17:35:15.298Z,1597253715.298 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-08-12T17:35:15.302Z,1597253715.302 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-08-12T17:35:15.302Z,1597253715.302 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-08-12T17:35:15.307Z,1597253715.307 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-08-12T17:35:15.307Z,1597253715.307 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-08-12T17:35:15.311Z,1597253715.311 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-08-12T17:35:15.311Z,1597253715.311 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-08-12T17:35:15.315Z,1597253715.315 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-08-12T17:35:15.316Z,1597253715.316 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-08-12T17:35:15.320Z,1597253715.320 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-08-12T17:35:15.320Z,1597253715.320 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-08-12T17:35:15.324Z,1597253715.324 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-08-12T17:35:15.324Z,1597253715.324 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-08-12T17:35:15.329Z,1597253715.329 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-08-12T17:35:15.333Z,1597253715.333 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-08-12T17:35:15.334Z,1597253715.334 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-12T17:35:15.334Z,1597253715.334 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-12T17:35:15.338Z,1597253715.338 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-12T17:35:15.338Z,1597253715.338 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-12T17:35:15.343Z,1597253715.343 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-12T17:35:15.343Z,1597253715.343 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-12T17:35:15.348Z,1597253715.348 [WetLabsBB2FL] Loaded
2020-08-12T17:35:15.348Z,1597253715.348 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-08-12T17:35:15.349Z,1597253715.349 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A1F4E0
2020-08-12T17:35:15.349Z,1597253715.349 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7837
2020-08-12T17:35:15.350Z,1597253715.350 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-08-12T17:35:15.351Z,1597253715.351 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-08-12T17:35:15.656Z,1597253715.656 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-08-12T17:35:15.656Z,1597253715.656 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-08-12T17:35:15.898Z,1597253715.898 [SBIT](DEBUG): Construct Startup Built In Test.
2020-08-12T17:35:15.909Z,1597253715.909 [SBIT] Loaded
2020-08-12T17:35:15.909Z,1597253715.909 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-08-12T17:35:15.910Z,1597253715.910 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-08-12T17:35:15.922Z,1597253715.922 [IBIT] Loaded
2020-08-12T17:35:15.922Z,1597253715.922 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-08-12T17:35:15.925Z,1597253715.925 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-08-12T17:35:16.060Z,1597253716.060 [CBIT] Loaded
2020-08-12T17:35:16.060Z,1597253716.060 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-08-12T17:35:16.060Z,1597253716.060 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-08-12T17:35:16.064Z,1597253716.064 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-08-12T17:35:16.065Z,1597253716.065 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-08-12T17:35:16.071Z,1597253716.071 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-08-12T17:35:16.072Z,1597253716.072 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AFF4E0
2020-08-12T17:35:16.073Z,1597253716.073 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7838
2020-08-12T17:35:16.078Z,1597253716.078 [Supervisor](INFO): Main Thread ID is 7746
2020-08-12T17:35:16.078Z,1597253716.078 [Supervisor](DEBUG): Running supervisor.
2020-08-12T17:35:16.078Z,1597253716.078 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7839
2020-08-12T17:35:16.081Z,1597253716.081 [controlThread ThreadHandler](INFO): Handler Thread ID is 7840
2020-08-12T17:35:16.081Z,1597253716.081 [controlThread](DEBUG): Initializing ControlThread
2020-08-12T17:35:16.082Z,1597253716.082 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-08-12T17:35:16.084Z,1597253716.084 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-08-12T17:35:16.084Z,1597253716.084 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-08-12T17:35:16.085Z,1597253716.085 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-08-12T17:35:16.086Z,1597253716.086 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-08-12T17:35:16.086Z,1597253716.086 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-08-12T17:35:16.086Z,1597253716.086 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-08-12T17:35:16.087Z,1597253716.087 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-08-12T17:35:16.087Z,1597253716.087 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-08-12T17:35:16.087Z,1597253716.087 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-08-12T17:35:16.088Z,1597253716.088 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-08-12T17:35:16.089Z,1597253716.089 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-08-12T17:35:16.097Z,1597253716.097 [SBIT](INFO): Initialize SBIT Component.
2020-08-12T17:35:16.098Z,1597253716.098 [SBIT](IMPORTANT): git: 2020-01-30-43-g2288ba088
2020-08-12T17:35:16.098Z,1597253716.098 [SBIT](INFO): git hash: 2288ba0885cb5e0ead12bdc4915239f4cb3c2f06
2020-08-12T17:35:16.098Z,1597253716.098 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-08-12T17:35:16.099Z,1597253716.099 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Tue May 26 08:17:09 PDT 2020
2020-08-12T17:35:16.101Z,1597253716.101 [SBIT](INFO): Beginning SBIT in 34.000000 seconds.
2020-08-12T17:35:16.101Z,1597253716.101 [IBIT](INFO): Initialize IBIT Component.
2020-08-12T17:35:16.102Z,1597253716.102 [CBIT](DEBUG): Initialize CBIT Component.
2020-08-12T17:35:16.103Z,1597253716.103 [logger ThreadHandler](INFO): Handler Thread ID is 7841
2020-08-12T17:35:16.113Z,1597253716.113 [CBIT](DEBUG): Initialized mux pins.
2020-08-12T17:35:16.113Z,1597253716.113 [CBIT](DEBUG): Initializing the watchdog timer.
2020-08-12T17:35:16.121Z,1597253716.121 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7842
2020-08-12T17:35:16.122Z,1597253716.122 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-08-12T17:35:16.133Z,1597253716.133 [Onboard ThreadHandler](INFO): Handler Thread ID is 7843
2020-08-12T17:35:16.138Z,1597253716.138 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-08-12T17:35:16.138Z,1597253716.138 [CBIT](DEBUG): Initializing heartbeat.
2020-08-12T17:35:16.169Z,1597253716.169 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7844
2020-08-12T17:35:16.178Z,1597253716.178 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7845
2020-08-12T17:35:16.178Z,1597253716.178 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-08-12T17:35:16.181Z,1597253716.181 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2020-08-12T17:35:16.183Z,1597253716.183 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7847
2020-08-12T17:35:16.184Z,1597253716.184 [WetLabsBB2FL](INFO): Powering down
2020-08-12T17:35:16.209Z,1597253716.209 [CBIT](DEBUG): Deactivating GF circuits.
2020-08-12T17:35:16.209Z,1597253716.209 [CBIT](DEBUG): Deactivating emergency mode.
2020-08-12T17:35:16.214Z,1597253716.214 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7848
2020-08-12T17:35:16.217Z,1597253716.217 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-08-12T17:35:16.217Z,1597253716.217 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-08-12T17:35:16.217Z,1597253716.217 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-08-12T17:35:16.217Z,1597253716.217 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-08-12T17:35:16.217Z,1597253716.217 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-08-12T17:35:16.218Z,1597253716.218 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-08-12T17:35:16.218Z,1597253716.218 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-08-12T17:35:16.218Z,1597253716.218 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-08-12T17:35:16.218Z,1597253716.218 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-08-12T17:35:16.218Z,1597253716.218 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-08-12T17:35:16.219Z,1597253716.219 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-08-12T17:35:16.219Z,1597253716.219 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-08-12T17:35:16.219Z,1597253716.219 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-08-12T17:35:16.219Z,1597253716.219 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-08-12T17:35:16.219Z,1597253716.219 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-08-12T17:35:16.220Z,1597253716.220 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-08-12T17:35:16.245Z,1597253716.245 [CBIT](DEBUG): Backplane powered.
2020-08-12T17:35:16.246Z,1597253716.246 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-08-12T17:35:16.271Z,1597253716.271 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-12T17:35:16.282Z,1597253716.282 [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>


2020-08-12T17:35:16.283Z,1597253716.283 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-08-12T17:35:16.342Z,1597253716.342 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-08-12T17:35:16.343Z,1597253716.343 [Default:A.Wait](DEBUG): Construct Wait.
2020-08-12T17:35:16.361Z,1597253716.361 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-12T17:35:16.392Z,1597253716.392 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-08-12T17:35:16.394Z,1597253716.394 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-08-12T17:35:16.408Z,1597253716.408 [Default:E.Execute](DEBUG): Construct Execute.
2020-08-12T17:35:16.411Z,1597253716.411 [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>


2020-08-12T17:35:16.433Z,1597253716.433 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,DAT,BPC1,AMEcho,ESPComponent,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,Reporter,LogSplitter,
2020-08-12T17:35:16.438Z,1597253716.438 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-12T17:35:16.475Z,1597253716.475 [Depth_Keller](ERROR): Pressure reading out of range: 1925.893799 decibar
2020-08-12T17:35:16.478Z,1597253716.478 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-12T17:35:16.478Z,1597253716.478 [DAT](INFO): Powering up
2020-08-12T17:35:16.478Z,1597253716.478 [DAT](DEBUG): Initializing DAT.
2020-08-12T17:35:16.573Z,1597253716.573 [Radio_Surface](INFO): Powering up
2020-08-12T17:35:16.574Z,1597253716.574 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-12T17:35:16.678Z,1597253716.678 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-08-12T17:35:16.715Z,1597253716.715 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-08-12T17:35:16.726Z,1597253716.726 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-08-12T17:35:16.727Z,1597253716.727 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-08-12T17:35:16.734Z,1597253716.734 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-08-12T17:35:16.735Z,1597253716.735 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-12T17:35:16.741Z,1597253716.741 [MassServo](DEBUG): Initializing MassServo.
2020-08-12T17:35:16.743Z,1597253716.743 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-12T17:35:16.749Z,1597253716.749 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-12T17:35:16.750Z,1597253716.750 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-08-12T17:35:16.757Z,1597253716.757 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-08-12T17:35:17.593Z,1597253717.593 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-08-12T17:35:17.593Z,1597253717.593 [RudderServo](FAULT): Rudder failed to initialize
2020-08-12T17:35:17.593Z,1597253717.593 [RudderServo] Communications Fault, FailCount= 1
2020-08-12T17:35:17.593Z,1597253717.593 [RudderServo](ERROR): Communications Fault
2020-08-12T17:35:17.740Z,1597253717.740 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-08-12T17:35:17.942Z,1597253717.942 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-12T17:35:17.942Z,1597253717.942 [RudderServo](INFO): Powering down
2020-08-12T17:35:18.270Z,1597253718.270 [CommandLine](IMPORTANT): got command ubat
2020-08-12T17:35:18.270Z,1597253718.270 [CommandLine](FAULT): Incomplete syntax. Try: help ubat
2020-08-12T17:35:18.566Z,1597253718.566 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-12T17:35:18.686Z,1597253718.686 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-12T17:35:18.690Z,1597253718.690 [CBIT](INFO): Clearing failed state for component RudderServo
2020-08-12T17:35:18.690Z,1597253718.690 [RudderServo] No Fault, FailCount= 1
2020-08-12T17:35:20.089Z,1597253720.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:20.497Z,1597253720.497 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:20.985Z,1597253720.985 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:21.697Z,1597253721.697 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:22.133Z,1597253722.133 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:22.601Z,1597253722.601 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:23.129Z,1597253723.129 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:23.585Z,1597253723.585 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:24.021Z,1597253724.021 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:24.625Z,1597253724.625 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:25.113Z,1597253725.113 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:25.517Z,1597253725.517 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:25.949Z,1597253725.949 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:26.393Z,1597253726.393 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:26.509Z,1597253726.509 [CBIT](CRITICAL): Environmental Failure. Press:14.855666 PSI. Humidity:57%. Temp:22 C. ABORTING MISSION
2020-08-12T17:35:26.510Z,1597253726.510 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals
2020-08-12T17:35:26.841Z,1597253726.841 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:26.987Z,1597253726.987 [CommandLine](FAULT): Scheduling is paused
2020-08-12T17:35:26.987Z,1597253726.987 [CBIT](INFO): Critical error at 20200812T173526
2020-08-12T17:35:27.321Z,1597253727.321 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:27.725Z,1597253727.725 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:28.125Z,1597253728.125 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:28.553Z,1597253728.553 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:28.957Z,1597253728.957 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:28.979Z,1597253728.979 [AMEcho](INFO): UART read: 
2020-08-12T17:35:29.269Z,1597253729.269 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-08-12T17:35:29.269Z,1597253729.269 [CTD_Seabird] Communications Fault, FailCount= 1
2020-08-12T17:35:29.269Z,1597253729.269 [CTD_Seabird](ERROR): Communications Fault
2020-08-12T17:35:29.401Z,1597253729.401 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:29.401Z,1597253729.401 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-12T17:35:29.401Z,1597253729.401 [AHRS_M2] Communications Fault, FailCount= 1
2020-08-12T17:35:29.401Z,1597253729.401 [AHRS_M2](ERROR): Communications Fault
2020-08-12T17:35:29.408Z,1597253729.408 [AMEcho](INFO): UART read: 
AIRMAR (R) Serial Flash Bootloader
2020-08-12T17:35:29.497Z,1597253729.497 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-12T17:35:29.498Z,1597253729.498 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-08-12T17:35:29.503Z,1597253729.503 [AHRS_M2](INFO): Powering down
2020-08-12T17:35:29.645Z,1597253729.645 [DAT](INFO): setting local address to 5
2020-08-12T17:35:29.673Z,1597253729.673 [CTD_Seabird](INFO): Powering down
2020-08-12T17:35:29.708Z,1597253729.708 [AMEcho](INFO): UART read: 
Copyright (C) 2005-2015 AIRMAR Technology Corp.
2020-08-12T17:35:29.923Z,1597253729.923 [DAT](INFO): set local address to 5
2020-08-12T17:35:29.925Z,1597253729.925 [AMEcho](INFO): UART read: 
All rights reserved.

2020-08-12T17:35:30.052Z,1597253730.052 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005215
2020-08-12T17:35:30.316Z,1597253730.316 [AMEcho](INFO): UART read: 

2020-08-12T17:35:30.333Z,1597253730.333 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-12T17:35:30.333Z,1597253730.333 [AHRS_M2] No Fault, FailCount= 1
2020-08-12T17:35:30.713Z,1597253730.713 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-12T17:35:30.758Z,1597253730.758 [AMEcho](INFO): UART read: 

2020-08-12T17:35:30.853Z,1597253730.853 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-08-12T17:35:30.853Z,1597253730.853 [CTD_Seabird] No Fault, FailCount= 1
2020-08-12T17:35:31.033Z,1597253731.033 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-08-12T17:35:31.035Z,1597253731.035 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2020-08-12T17:35:31.133Z,1597253731.133 [AMEcho](INFO): UART read: 

2020-08-12T17:35:31.528Z,1597253731.528 [AMEcho](INFO): UART read: 
$PAMTT,200m Mini Altimeter Kit (170kHz)
2020-08-12T17:35:31.933Z,1597253731.933 [AMEcho](INFO): UART read: 
$PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc.  All Rights Reserved.
2020-08-12T17:35:32.346Z,1597253732.346 [AMEcho](INFO): UART read: 
$PAMTT,POST,0,0,0,2,1,,0,0,,,,,,ER0183*46
2020-08-12T17:35:32.739Z,1597253732.739 [AMEcho](INFO): UART read: 
$PAMTT,QV,,0,0,,1.807,1.841,,*75
2020-08-12T17:35:33.144Z,1597253733.144 [AMEcho](INFO): UART read: 
$PAMTT,QPS,100438,201095-1,4*27
2020-08-12T17:35:33.548Z,1597253733.548 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:34.269Z,1597253734.269 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:34.276Z,1597253734.276 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:34.673Z,1597253734.673 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:34.680Z,1597253734.680 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:35.077Z,1597253735.077 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:35.084Z,1597253735.084 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:35.501Z,1597253735.501 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:35.508Z,1597253735.508 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:35.893Z,1597253735.893 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:35.899Z,1597253735.899 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:36.293Z,1597253736.293 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:36.300Z,1597253736.300 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:36.733Z,1597253736.733 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:36.740Z,1597253736.740 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:37.141Z,1597253737.141 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:37.159Z,1597253737.159 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:37.541Z,1597253737.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:37.548Z,1597253737.548 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:37.953Z,1597253737.953 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:37.960Z,1597253737.960 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:38.357Z,1597253738.357 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:38.364Z,1597253738.364 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:38.769Z,1597253738.769 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:39.161Z,1597253739.161 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:39.168Z,1597253739.168 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:39.573Z,1597253739.573 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:39.981Z,1597253739.981 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:40.425Z,1597253740.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:40.432Z,1597253740.432 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:40.829Z,1597253740.829 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:41.225Z,1597253741.225 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:41.232Z,1597253741.232 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:41.634Z,1597253741.634 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:42.045Z,1597253742.045 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:42.079Z,1597253742.079 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:42.497Z,1597253742.497 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:42.877Z,1597253742.877 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:43.285Z,1597253743.285 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:43.290Z,1597253743.290 [NAL9602](INFO): Powering up NAL9602
2020-08-12T17:35:43.292Z,1597253743.292 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:43.689Z,1597253743.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:43.689Z,1597253743.689 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-12T17:35:43.689Z,1597253743.689 [AHRS_M2] Communications Fault, FailCount= 2
2020-08-12T17:35:43.689Z,1597253743.689 [AHRS_M2](ERROR): Communications Fault
2020-08-12T17:35:43.721Z,1597253743.721 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-12T17:35:43.771Z,1597253743.771 [AHRS_M2](INFO): Powering down
2020-08-12T17:35:44.085Z,1597253744.085 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-08-12T17:35:44.085Z,1597253744.085 [CTD_Seabird] Communications Fault, FailCount= 2
2020-08-12T17:35:44.085Z,1597253744.085 [CTD_Seabird](ERROR): Communications Fault
2020-08-12T17:35:44.179Z,1597253744.179 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:44.225Z,1597253744.225 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-08-12T17:35:44.489Z,1597253744.489 [CTD_Seabird](INFO): Powering down
2020-08-12T17:35:44.613Z,1597253744.613 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-12T17:35:44.613Z,1597253744.613 [AHRS_M2] No Fault, FailCount= 2
2020-08-12T17:35:44.981Z,1597253744.981 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-12T17:35:45.403Z,1597253745.403 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:45.435Z,1597253745.435 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-08-12T17:35:45.435Z,1597253745.435 [CTD_Seabird] No Fault, FailCount= 2
2020-08-12T17:35:45.833Z,1597253745.833 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-08-12T17:35:45.835Z,1597253745.835 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2020-08-12T17:35:46.200Z,1597253746.200 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:47.412Z,1597253747.412 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:48.537Z,1597253748.537 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:48.544Z,1597253748.544 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:48.941Z,1597253748.941 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:49.345Z,1597253749.345 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:49.360Z,1597253749.360 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:49.753Z,1597253749.753 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:50.141Z,1597253750.141 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:50.147Z,1597253750.147 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:50.561Z,1597253750.561 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-12T17:35:50.583Z,1597253750.583 [SBIT](IMPORTANT): Beginning Startup BIT
2020-08-12T17:35:50.592Z,1597253750.592 [CBIT](IMPORTANT): Beginning ground fault scan
2020-08-12T17:35:51.357Z,1597253751.357 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:51.363Z,1597253751.363 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:51.829Z,1597253751.829 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:52.329Z,1597253752.329 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:52.336Z,1597253752.336 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:52.837Z,1597253752.837 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:53.169Z,1597253753.169 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:53.175Z,1597253753.175 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:53.821Z,1597253753.821 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:54.317Z,1597253754.317 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:54.334Z,1597253754.334 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:55.005Z,1597253755.005 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:55.020Z,1597253755.020 [NAL9602](INFO): NAL9602 initialized
2020-08-12T17:35:55.081Z,1597253755.081 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:55.505Z,1597253755.505 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:56.109Z,1597253756.109 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:56.154Z,1597253756.154 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:56.717Z,1597253756.717 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:57.161Z,1597253757.161 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:57.187Z,1597253757.187 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:57.617Z,1597253757.617 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:58.145Z,1597253758.145 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:35:58.145Z,1597253758.145 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-12T17:35:58.145Z,1597253758.145 [AHRS_M2] Communications Fault, FailCount= 3
2020-08-12T17:35:58.145Z,1597253758.145 [AHRS_M2](ERROR): Communications Fault
2020-08-12T17:35:58.162Z,1597253758.162 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:58.254Z,1597253758.254 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-12T17:35:58.259Z,1597253758.259 [AHRS_M2](INFO): Powering down
2020-08-12T17:35:58.894Z,1597253758.894 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-08-12T17:35:58.894Z,1597253758.894 [CTD_Seabird] Communications Fault, FailCount= 3
2020-08-12T17:35:58.894Z,1597253758.894 [CTD_Seabird](ERROR): Communications Fault
2020-08-12T17:35:59.072Z,1597253759.072 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:35:59.132Z,1597253759.132 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-12T17:35:59.132Z,1597253759.132 [AHRS_M2] No Fault, FailCount= 3
2020-08-12T17:35:59.133Z,1597253759.133 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-08-12T17:35:59.133Z,1597253759.133 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2020-08-12T17:35:59.297Z,1597253759.297 [CTD_Seabird](INFO): Powering down
2020-08-12T17:35:59.469Z,1597253759.469 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-12T17:36:00.284Z,1597253760.284 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:01.104Z,1597253761.104 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:01.948Z,1597253761.948 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.009505
CHAN A1 (24V): -0.007895
CHAN A2 (12V): -0.004420
CHAN A3 (5V): -0.002625
CHAN B0 (3.3V): -0.001032
CHAN B1 (3.15aV): -0.001232
CHAN B2 (3.15bV): -0.001120
CHAN B3 (GND): -0.000730
OPEN: 0.004694
Full Scale Calc: 4.765 mA, -1.589 mA
2020-08-12T17:36:02.305Z,1597253762.305 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:03.045Z,1597253763.045 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:03.086Z,1597253763.086 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:03.513Z,1597253763.513 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:03.989Z,1597253763.989 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:04.437Z,1597253764.437 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:04.455Z,1597253764.455 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:04.869Z,1597253764.869 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:05.333Z,1597253765.333 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:05.340Z,1597253765.340 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:05.789Z,1597253765.789 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:06.377Z,1597253766.377 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:06.384Z,1597253766.384 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:06.873Z,1597253766.873 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:07.325Z,1597253767.325 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:07.332Z,1597253767.332 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:07.785Z,1597253767.785 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:08.237Z,1597253768.237 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:08.254Z,1597253768.254 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:08.745Z,1597253768.745 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:09.201Z,1597253769.201 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:09.227Z,1597253769.227 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:09.693Z,1597253769.693 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:10.177Z,1597253770.177 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:10.192Z,1597253770.192 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:10.645Z,1597253770.645 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:11.153Z,1597253771.153 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:11.160Z,1597253771.160 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:11.757Z,1597253771.757 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:12.381Z,1597253772.381 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:12.381Z,1597253772.381 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-12T17:36:12.381Z,1597253772.381 [AHRS_M2] Communications Fault, FailCount= 4
2020-08-12T17:36:12.381Z,1597253772.381 [AHRS_M2](ERROR): Communications Fault
2020-08-12T17:36:12.388Z,1597253772.388 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:12.475Z,1597253772.475 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-12T17:36:12.489Z,1597253772.489 [AHRS_M2](INFO): Powering down
2020-08-12T17:36:13.322Z,1597253773.322 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:13.386Z,1597253773.386 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-12T17:36:13.386Z,1597253773.386 [AHRS_M2] No Fault, FailCount= 4
2020-08-12T17:36:13.693Z,1597253773.693 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-12T17:36:14.131Z,1597253774.131 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:14.191Z,1597253774.191 [CommandLine](IMPORTANT): got command quit
2020-08-12T17:36:15.193Z,1597253775.193 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:15.193Z,1597253775.193 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:15.285Z,1597253775.285 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-08-12T17:36:15.285Z,1597253775.285 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:15.286Z,1597253775.286 [CommandLine](INFO): Join timeout helper Thread ID is 7875
2020-08-12T17:36:15.301Z,1597253775.301 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-08-12T17:36:15.301Z,1597253775.301 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:15.302Z,1597253775.302 [NavChartDb](INFO): Join timeout helper Thread ID is 7876
2020-08-12T17:36:15.316Z,1597253775.316 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:16.132Z,1597253776.132 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:17.249Z,1597253777.249 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:17.286Z,1597253777.286 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:17.681Z,1597253777.681 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:17.823Z,1597253777.823 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:17.823Z,1597253777.823 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:17.829Z,1597253777.829 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-08-12T17:36:17.829Z,1597253777.829 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:17.829Z,1597253777.829 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7877
2020-08-12T17:36:18.113Z,1597253778.113 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:18.125Z,1597253778.125 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:18.204Z,1597253778.204 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:18.205Z,1597253778.205 [WetLabsBB2FL](INFO): Powering down
2020-08-12T17:36:18.209Z,1597253778.209 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:18.229Z,1597253778.229 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-08-12T17:36:18.229Z,1597253778.229 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:18.229Z,1597253778.229 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7878
2020-08-12T17:36:18.417Z,1597253778.417 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:18.418Z,1597253778.418 [CTD_Seabird](INFO): Powering down
2020-08-12T17:36:18.429Z,1597253778.429 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:18.429Z,1597253778.429 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-08-12T17:36:18.430Z,1597253778.430 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:18.430Z,1597253778.430 [Radio_Surface](INFO): Join timeout helper Thread ID is 7879
2020-08-12T17:36:18.513Z,1597253778.513 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:18.821Z,1597253778.821 [Radio_Surface](INFO): Powering down
2020-08-12T17:36:18.822Z,1597253778.822 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:18.822Z,1597253778.822 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:18.838Z,1597253778.838 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-08-12T17:36:18.838Z,1597253778.838 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:18.838Z,1597253778.838 [Onboard](INFO): Join timeout helper Thread ID is 7880
2020-08-12T17:36:18.909Z,1597253778.909 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:19.077Z,1597253779.077 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-08-12T17:36:19.329Z,1597253779.329 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:19.352Z,1597253779.352 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:19.737Z,1597253779.737 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:20.157Z,1597253780.157 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:20.168Z,1597253780.168 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:20.553Z,1597253780.553 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:20.953Z,1597253780.953 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:21.185Z,1597253781.185 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:21.186Z,1597253781.186 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:21.206Z,1597253781.206 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-08-12T17:36:21.206Z,1597253781.206 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:21.206Z,1597253781.206 [DataOverHttps](INFO): Join timeout helper Thread ID is 7881
2020-08-12T17:36:21.357Z,1597253781.357 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:21.368Z,1597253781.368 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:21.414Z,1597253781.414 [CBIT](FAULT): Humidity exceeds 50% of running average: Humidity:2296080 %. Average:259642.718750
2020-08-12T17:36:21.765Z,1597253781.765 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:22.089Z,1597253782.089 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:22.089Z,1597253782.089 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.094Z,1597253782.094 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-08-12T17:36:22.094Z,1597253782.094 [logger ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.094Z,1597253782.094 [logger](INFO): Join timeout helper Thread ID is 7882
2020-08-12T17:36:22.109Z,1597253782.109 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:22.109Z,1597253782.109 [logger ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.114Z,1597253782.114 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-08-12T17:36:22.114Z,1597253782.114 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.114Z,1597253782.114 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-08-12T17:36:22.114Z,1597253782.114 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.114Z,1597253782.114 [controlThread](INFO): Join timeout helper Thread ID is 7883
2020-08-12T17:36:22.161Z,1597253782.161 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-12T17:36:22.166Z,1597253782.166 [AMEcho](INFO): UART read: 
$SDDBT,,,,,,*45
2020-08-12T17:36:22.311Z,1597253782.311 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-12T17:36:22.311Z,1597253782.311 [controlThread](DEBUG): Uninitializing ControlThread
2020-08-12T17:36:22.312Z,1597253782.312 [AHRS_M2](INFO): Powering down
2020-08-12T17:36:22.382Z,1597253782.382 [NAL9602](INFO): Powering down
2020-08-12T17:36:22.383Z,1597253782.383 [DAT](INFO): Powering down
2020-08-12T17:36:22.669Z,1597253782.669 [AMEcho](INFO): Powering down
2020-08-12T17:36:22.724Z,1597253782.724 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-08-12T17:36:22.725Z,1597253782.725 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-08-12T17:36:22.725Z,1597253782.725 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-08-12T17:36:22.733Z,1597253782.733 [MissionManager](INFO): Uninitializing Mission Default
2020-08-12T17:36:22.735Z,1597253782.735 [MissionManager](INFO): Uninitializing Mission Startup
2020-08-12T17:36:22.777Z,1597253782.777 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-08-12T17:36:22.777Z,1597253782.777 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-08-12T17:36:22.778Z,1597253782.778 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-08-12T17:36:22.778Z,1597253782.778 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-08-12T17:36:22.778Z,1597253782.778 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-08-12T17:36:22.779Z,1597253782.779 [BuoyancyServo](INFO): Powering down
2020-08-12T17:36:22.793Z,1597253782.793 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-08-12T17:36:22.793Z,1597253782.793 [ElevatorServo](INFO): Powering down
2020-08-12T17:36:22.794Z,1597253782.794 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-12T17:36:22.794Z,1597253782.794 [MassServo](INFO): Powering down
2020-08-12T17:36:22.795Z,1597253782.795 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-12T17:36:22.795Z,1597253782.795 [RudderServo](INFO): Powering down
2020-08-12T17:36:22.796Z,1597253782.796 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-08-12T17:36:22.796Z,1597253782.796 [ThrusterServo](INFO): Powering down
2020-08-12T17:36:22.797Z,1597253782.797 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-08-12T17:36:22.797Z,1597253782.797 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-08-12T17:36:22.798Z,1597253782.798 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-08-12T17:36:22.798Z,1597253782.798 [CBIT](DEBUG): Powering off loads.
2020-08-12T17:36:22.809Z,1597253782.809 [CBIT](DEBUG): Disabling WDT.
2020-08-12T17:36:22.821Z,1597253782.821 [CBIT](DEBUG): Opening all GF detection circuits.
2020-08-12T17:36:22.822Z,1597253782.822 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.909Z,1597253782.909 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.911Z,1597253782.911 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.916Z,1597253782.916 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.952Z,1597253782.952 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.957Z,1597253782.957 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:22.991Z,1597253782.991 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-12T17:36:23.050Z,1597253783.050 [logger ThreadHandler](INFO): Thread cancelled.