2020-08-26T17:39:18.812Z,1598463558.812 [Supervisor](DEBUG): Initializing supervisor.
2020-08-26T17:39:18.815Z,1598463558.815 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-08-26T17:39:18.816Z,1598463558.816 [SyncHandler](INFO): Protected caller Thread ID is 7210
2020-08-26T17:39:18.816Z,1598463558.816 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-08-26T17:39:18.817Z,1598463558.817 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-08-26T17:39:18.818Z,1598463558.818 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7211
2020-08-26T17:39:18.822Z,1598463558.822 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-08-26T17:39:18.836Z,1598463558.836 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-08-26T17:39:18.837Z,1598463558.837 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-08-26T17:39:18.837Z,1598463558.837 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7212
2020-08-26T17:39:18.838Z,1598463558.838 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-08-26T17:39:18.838Z,1598463558.838 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-08-26T17:39:18.839Z,1598463558.839 [logger ThreadHandler](INFO): Protected caller Thread ID is 7213
2020-08-26T17:39:18.841Z,1598463558.841 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-08-26T17:39:18.841Z,1598463558.841 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-08-26T17:39:18.843Z,1598463558.843 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-08-26T17:39:19.268Z,1598463559.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-08-26T17:39:19.269Z,1598463559.269 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-08-26T17:39:19.408Z,1598463559.408 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-08-26T17:39:19.408Z,1598463559.408 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-08-26T17:39:19.487Z,1598463559.487 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-08-26T17:39:19.677Z,1598463559.677 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-08-26T17:39:19.678Z,1598463559.678 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-08-26T17:39:19.774Z,1598463559.774 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-08-26T17:39:19.774Z,1598463559.774 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-08-26T17:39:19.869Z,1598463559.869 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-08-26T17:39:19.869Z,1598463559.869 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-08-26T17:39:20.266Z,1598463560.266 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-08-26T17:39:20.266Z,1598463560.266 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-08-26T17:39:20.367Z,1598463560.367 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-08-26T17:39:20.367Z,1598463560.367 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-08-26T17:39:20.815Z,1598463560.815 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-08-26T17:39:20.816Z,1598463560.816 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-08-26T17:39:21.007Z,1598463561.007 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-08-26T17:39:21.008Z,1598463561.008 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-08-26T17:39:21.318Z,1598463561.318 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-08-26T17:39:21.319Z,1598463561.319 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-08-26T17:39:21.531Z,1598463561.531 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-08-26T17:39:21.532Z,1598463561.532 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-08-26T17:39:21.671Z,1598463561.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-08-26T17:39:21.671Z,1598463561.671 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-08-26T17:39:22.322Z,1598463562.322 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-08-26T17:39:22.323Z,1598463562.323 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-08-26T17:39:22.644Z,1598463562.644 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-08-26T17:39:22.645Z,1598463562.645 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-08-26T17:39:22.848Z,1598463562.848 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-08-26T17:39:22.850Z,1598463562.850 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2020-08-26T17:39:22.850Z,1598463562.850 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2020-08-26T17:39:23.039Z,1598463563.039 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2020-08-26T17:39:23.120Z,1598463563.120 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2020-08-26T17:39:23.267Z,1598463563.267 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2020-08-26T17:39:23.382Z,1598463563.382 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2020-08-26T17:39:23.687Z,1598463563.687 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-08-26T17:39:23.687Z,1598463563.687 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2020-08-26T17:39:23.916Z,1598463563.916 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2020-08-26T17:39:24.160Z,1598463564.160 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2020-08-26T17:39:24.524Z,1598463564.524 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2020-08-26T17:39:24.666Z,1598463564.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2020-08-26T17:39:24.761Z,1598463564.761 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2020-08-26T17:39:24.858Z,1598463564.858 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2020-08-26T17:39:24.859Z,1598463564.859 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-08-26T17:39:24.870Z,1598463564.870 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-08-26T17:39:24.890Z,1598463564.890 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-08-26T17:39:24.890Z,1598463564.890 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-08-26T17:39:24.968Z,1598463564.968 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-08-26T17:39:24.968Z,1598463564.968 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-08-26T17:39:25.017Z,1598463565.017 [VerticalControl](DEBUG): Construct VerticalControl.
2020-08-26T17:39:25.126Z,1598463565.126 [VerticalControl] Loaded
2020-08-26T17:39:25.126Z,1598463565.126 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-08-26T17:39:25.127Z,1598463565.127 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-08-26T17:39:25.204Z,1598463565.204 [HorizontalControl] Loaded
2020-08-26T17:39:25.205Z,1598463565.205 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-08-26T17:39:25.205Z,1598463565.205 [SpeedControl](DEBUG): Construct SpeedControl.
2020-08-26T17:39:25.211Z,1598463565.211 [SpeedControl] Loaded
2020-08-26T17:39:25.211Z,1598463565.211 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-08-26T17:39:25.211Z,1598463565.211 [LoopControl](DEBUG): Construct LoopControl.
2020-08-26T17:39:25.212Z,1598463565.212 [LoopControl] Loaded
2020-08-26T17:39:25.212Z,1598463565.212 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-08-26T17:39:25.213Z,1598463565.213 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-08-26T17:39:25.213Z,1598463565.213 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-08-26T17:39:25.359Z,1598463565.359 [BuoyancyServo] Loaded
2020-08-26T17:39:25.359Z,1598463565.359 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-08-26T17:39:25.387Z,1598463565.387 [ElevatorServo] Loaded
2020-08-26T17:39:25.387Z,1598463565.387 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-08-26T17:39:25.414Z,1598463565.414 [MassServo] Loaded
2020-08-26T17:39:25.414Z,1598463565.414 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-08-26T17:39:25.441Z,1598463565.441 [RudderServo] Loaded
2020-08-26T17:39:25.441Z,1598463565.441 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-08-26T17:39:25.467Z,1598463565.467 [ThrusterServo] Loaded
2020-08-26T17:39:25.467Z,1598463565.467 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-08-26T17:39:25.468Z,1598463565.468 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-08-26T17:39:25.468Z,1598463565.468 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-08-26T17:39:25.509Z,1598463565.509 [DepthRateCalculator] Loaded
2020-08-26T17:39:25.509Z,1598463565.509 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-08-26T17:39:25.514Z,1598463565.514 [PitchRateCalculator] Loaded
2020-08-26T17:39:25.515Z,1598463565.515 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-08-26T17:39:25.529Z,1598463565.529 [SpeedCalculator] Loaded
2020-08-26T17:39:25.529Z,1598463565.529 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-08-26T17:39:25.550Z,1598463565.550 [TempGradientCalculator] Loaded
2020-08-26T17:39:25.550Z,1598463565.550 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-08-26T17:39:25.555Z,1598463565.555 [YawRateCalculator] Loaded
2020-08-26T17:39:25.555Z,1598463565.555 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-08-26T17:39:25.584Z,1598463565.584 [ElevatorOffsetCalculator] Loaded
2020-08-26T17:39:25.584Z,1598463565.584 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-08-26T17:39:25.585Z,1598463565.585 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-08-26T17:39:25.585Z,1598463565.585 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-08-26T17:39:25.704Z,1598463565.704 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-08-26T17:39:25.704Z,1598463565.704 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-08-26T17:39:25.724Z,1598463565.724 [NavChart] Loaded
2020-08-26T17:39:25.724Z,1598463565.724 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-08-26T17:39:25.728Z,1598463565.728 [UniversalFixResidualReporter] Loaded
2020-08-26T17:39:25.728Z,1598463565.728 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-08-26T17:39:25.729Z,1598463565.729 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-08-26T17:39:25.729Z,1598463565.729 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-08-26T17:39:26.052Z,1598463566.052 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-08-26T17:39:26.057Z,1598463566.057 [AHRS_M2](INFO): created writer for : platform_orientation
2020-08-26T17:39:26.059Z,1598463566.059 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-08-26T17:39:26.064Z,1598463566.064 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-08-26T17:39:26.065Z,1598463566.065 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-08-26T17:39:26.070Z,1598463566.070 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-08-26T17:39:26.070Z,1598463566.070 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-08-26T17:39:26.076Z,1598463566.076 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-08-26T17:39:26.145Z,1598463566.145 [AHRS_M2] Loaded
2020-08-26T17:39:26.145Z,1598463566.145 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-08-26T17:39:26.220Z,1598463566.220 [DataOverHttps] Loaded
2020-08-26T17:39:26.220Z,1598463566.220 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-08-26T17:39:26.222Z,1598463566.222 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4084F4E0
2020-08-26T17:39:26.222Z,1598463566.222 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7295
2020-08-26T17:39:26.252Z,1598463566.252 [Depth_Keller] Loaded
2020-08-26T17:39:26.252Z,1598463566.252 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-08-26T17:39:26.362Z,1598463566.362 [NAL9602] Loaded
2020-08-26T17:39:26.363Z,1598463566.363 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-08-26T17:39:26.410Z,1598463566.410 [Onboard] Loaded
2020-08-26T17:39:26.410Z,1598463566.410 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-08-26T17:39:26.411Z,1598463566.411 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4087F4E0
2020-08-26T17:39:26.412Z,1598463566.412 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7296
2020-08-26T17:39:26.431Z,1598463566.431 [Radio_Surface] Loaded
2020-08-26T17:39:26.431Z,1598463566.431 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-08-26T17:39:26.432Z,1598463566.432 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408AF4E0
2020-08-26T17:39:26.432Z,1598463566.432 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7297
2020-08-26T17:39:26.580Z,1598463566.580 [DAT] Loaded
2020-08-26T17:39:26.581Z,1598463566.581 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-08-26T17:39:28.059Z,1598463568.059 [BPC1] Loaded
2020-08-26T17:39:28.060Z,1598463568.060 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-08-26T17:39:28.060Z,1598463568.060 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-08-26T17:39:28.061Z,1598463568.061 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-08-26T17:39:28.149Z,1598463568.149 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-08-26T17:39:28.150Z,1598463568.150 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-08-26T17:39:28.249Z,1598463568.249 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-08-26T17:39:28.249Z,1598463568.249 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-08-26T17:39:28.276Z,1598463568.276 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-08-26T17:39:28.277Z,1598463568.277 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-08-26T17:39:28.494Z,1598463568.494 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-08-26T17:39:28.499Z,1598463568.499 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-08-26T17:39:28.499Z,1598463568.499 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-08-26T17:39:28.504Z,1598463568.504 [CTD_Seabird](INFO): created writer for : depth
2020-08-26T17:39:28.505Z,1598463568.505 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-08-26T17:39:28.509Z,1598463568.509 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-08-26T17:39:28.510Z,1598463568.510 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-08-26T17:39:28.515Z,1598463568.515 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-08-26T17:39:28.516Z,1598463568.516 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-08-26T17:39:28.521Z,1598463568.521 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-08-26T17:39:28.521Z,1598463568.521 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-08-26T17:39:28.527Z,1598463568.527 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-08-26T17:39:28.527Z,1598463568.527 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-08-26T17:39:28.532Z,1598463568.532 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-08-26T17:39:28.559Z,1598463568.559 [CTD_Seabird] Loaded
2020-08-26T17:39:28.560Z,1598463568.560 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-08-26T17:39:28.561Z,1598463568.561 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A554E0
2020-08-26T17:39:28.561Z,1598463568.561 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7298
2020-08-26T17:39:28.610Z,1598463568.610 [ESPComponent] Loaded
2020-08-26T17:39:28.610Z,1598463568.610 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-08-26T17:39:28.640Z,1598463568.640 [PAR_Licor] Loaded
2020-08-26T17:39:28.640Z,1598463568.640 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-08-26T17:39:28.662Z,1598463568.662 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-08-26T17:39:28.662Z,1598463568.662 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-08-26T17:39:28.666Z,1598463568.666 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-08-26T17:39:28.666Z,1598463568.666 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-08-26T17:39:28.671Z,1598463568.671 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-08-26T17:39:28.671Z,1598463568.671 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-08-26T17:39:28.675Z,1598463568.675 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-08-26T17:39:28.675Z,1598463568.675 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-08-26T17:39:28.679Z,1598463568.679 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-08-26T17:39:28.679Z,1598463568.679 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-08-26T17:39:28.684Z,1598463568.684 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-08-26T17:39:28.684Z,1598463568.684 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-08-26T17:39:28.688Z,1598463568.688 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-08-26T17:39:28.688Z,1598463568.688 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-08-26T17:39:28.692Z,1598463568.692 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-08-26T17:39:28.696Z,1598463568.696 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-08-26T17:39:28.697Z,1598463568.697 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-26T17:39:28.697Z,1598463568.697 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-26T17:39:28.701Z,1598463568.701 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-26T17:39:28.701Z,1598463568.701 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-26T17:39:28.705Z,1598463568.705 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-26T17:39:28.705Z,1598463568.705 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-26T17:39:28.710Z,1598463568.710 [WetLabsBB2FL] Loaded
2020-08-26T17:39:28.710Z,1598463568.710 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-08-26T17:39:28.711Z,1598463568.711 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A854E0
2020-08-26T17:39:28.711Z,1598463568.711 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7299
2020-08-26T17:39:28.712Z,1598463568.712 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-08-26T17:39:28.713Z,1598463568.713 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-08-26T17:39:29.315Z,1598463569.315 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-08-26T17:39:29.316Z,1598463569.316 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-08-26T17:39:29.449Z,1598463569.449 [SBIT](DEBUG): Construct Startup Built In Test.
2020-08-26T17:39:29.460Z,1598463569.460 [SBIT] Loaded
2020-08-26T17:39:29.460Z,1598463569.460 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-08-26T17:39:29.461Z,1598463569.461 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-08-26T17:39:29.474Z,1598463569.474 [IBIT] Loaded
2020-08-26T17:39:29.474Z,1598463569.474 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-08-26T17:39:29.477Z,1598463569.477 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-08-26T17:39:29.616Z,1598463569.616 [CBIT] Loaded
2020-08-26T17:39:29.616Z,1598463569.616 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-08-26T17:39:29.616Z,1598463569.616 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-08-26T17:39:29.620Z,1598463569.620 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-08-26T17:39:29.621Z,1598463569.621 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-08-26T17:39:29.628Z,1598463569.628 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-08-26T17:39:29.629Z,1598463569.629 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B634E0
2020-08-26T17:39:29.629Z,1598463569.629 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7300
2020-08-26T17:39:29.634Z,1598463569.634 [Supervisor](INFO): Main Thread ID is 6839
2020-08-26T17:39:29.634Z,1598463569.634 [Supervisor](DEBUG): Running supervisor.
2020-08-26T17:39:29.634Z,1598463569.634 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7301
2020-08-26T17:39:29.637Z,1598463569.637 [controlThread ThreadHandler](INFO): Handler Thread ID is 7302
2020-08-26T17:39:29.637Z,1598463569.637 [controlThread](DEBUG): Initializing ControlThread
2020-08-26T17:39:29.638Z,1598463569.638 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-08-26T17:39:29.640Z,1598463569.640 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-08-26T17:39:29.641Z,1598463569.641 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-08-26T17:39:29.641Z,1598463569.641 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-08-26T17:39:29.642Z,1598463569.642 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-08-26T17:39:29.643Z,1598463569.643 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-08-26T17:39:29.643Z,1598463569.643 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-08-26T17:39:29.643Z,1598463569.643 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-08-26T17:39:29.644Z,1598463569.644 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-08-26T17:39:29.644Z,1598463569.644 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-08-26T17:39:29.646Z,1598463569.646 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-08-26T17:39:29.646Z,1598463569.646 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-08-26T17:39:29.653Z,1598463569.653 [SBIT](INFO): Initialize SBIT Component.
2020-08-26T17:39:29.654Z,1598463569.654 [SBIT](IMPORTANT): git: 2020-08-18a-30-g8cc0a1c87
2020-08-26T17:39:29.654Z,1598463569.654 [SBIT](INFO): git hash: 8cc0a1c87b994ada9a621eded1d43a5b5e56617e
2020-08-26T17:39:29.654Z,1598463569.654 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-08-26T17:39:29.655Z,1598463569.655 [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-26T17:39:29.656Z,1598463569.656 [SBIT](INFO): Beginning SBIT in 34.000000 seconds.
2020-08-26T17:39:29.657Z,1598463569.657 [IBIT](INFO): Initialize IBIT Component.
2020-08-26T17:39:29.658Z,1598463569.658 [CBIT](DEBUG): Initialize CBIT Component.
2020-08-26T17:39:29.659Z,1598463569.659 [logger ThreadHandler](INFO): Handler Thread ID is 7303
2020-08-26T17:39:29.669Z,1598463569.669 [CBIT](DEBUG): Initialized mux pins.
2020-08-26T17:39:29.669Z,1598463569.669 [CBIT](DEBUG): Initializing the watchdog timer.
2020-08-26T17:39:29.677Z,1598463569.677 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7304
2020-08-26T17:39:29.678Z,1598463569.678 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-08-26T17:39:29.689Z,1598463569.689 [Onboard ThreadHandler](INFO): Handler Thread ID is 7305
2020-08-26T17:39:29.693Z,1598463569.693 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-08-26T17:39:29.693Z,1598463569.693 [CBIT](DEBUG): Initializing heartbeat.
2020-08-26T17:39:29.707Z,1598463569.707 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7306
2020-08-26T17:39:29.725Z,1598463569.725 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7307
2020-08-26T17:39:29.726Z,1598463569.726 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-08-26T17:39:29.730Z,1598463569.730 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7309
2020-08-26T17:39:29.731Z,1598463569.731 [WetLabsBB2FL](INFO): Powering down
2020-08-26T17:39:29.753Z,1598463569.753 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7310
2020-08-26T17:39:29.756Z,1598463569.756 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-08-26T17:39:29.757Z,1598463569.757 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-08-26T17:39:29.757Z,1598463569.757 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-08-26T17:39:29.757Z,1598463569.757 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-08-26T17:39:29.757Z,1598463569.757 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-08-26T17:39:29.757Z,1598463569.757 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-08-26T17:39:29.757Z,1598463569.757 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-08-26T17:39:29.757Z,1598463569.757 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-08-26T17:39:29.758Z,1598463569.758 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-08-26T17:39:29.758Z,1598463569.758 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-08-26T17:39:29.758Z,1598463569.758 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-08-26T17:39:29.758Z,1598463569.758 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-08-26T17:39:29.758Z,1598463569.758 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-08-26T17:39:29.758Z,1598463569.758 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-08-26T17:39:29.759Z,1598463569.759 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-08-26T17:39:29.759Z,1598463569.759 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-08-26T17:39:29.765Z,1598463569.765 [CBIT](DEBUG): Deactivating GF circuits.
2020-08-26T17:39:29.765Z,1598463569.765 [CBIT](DEBUG): Deactivating emergency mode.
2020-08-26T17:39:29.801Z,1598463569.801 [CBIT](DEBUG): Backplane powered.
2020-08-26T17:39:29.802Z,1598463569.802 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-08-26T17:39:29.812Z,1598463569.812 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-26T17:39:29.823Z,1598463569.823 [MissionManager](DEBUG):
2020-08-26T17:39:29.823Z,1598463569.823 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-08-26T17:39:29.891Z,1598463569.891 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-08-26T17:39:29.892Z,1598463569.892 [Default:A.Wait](DEBUG): Construct Wait.
2020-08-26T17:39:29.910Z,1598463569.910 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-26T17:39:29.936Z,1598463569.936 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-08-26T17:39:29.939Z,1598463569.939 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-08-26T17:39:29.964Z,1598463569.964 [Default:E.Execute](DEBUG): Construct Execute.
2020-08-26T17:39:29.968Z,1598463569.968 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2020-08-26T17:39:29.972Z,1598463569.972 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,DAT,BPC1,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-26T17:39:29.995Z,1598463569.995 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-26T17:39:30.034Z,1598463570.034 [Depth_Keller](ERROR): Pressure reading out of range: 1925.893799 decibar
2020-08-26T17:39:30.037Z,1598463570.037 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-26T17:39:30.037Z,1598463570.037 [DAT](INFO): Powering up
2020-08-26T17:39:30.037Z,1598463570.037 [DAT](DEBUG): Initializing DAT.
2020-08-26T17:39:30.113Z,1598463570.113 [Radio_Surface](INFO): Powering up
2020-08-26T17:39:30.125Z,1598463570.125 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-08-26T17:39:30.133Z,1598463570.133 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-26T17:39:30.193Z,1598463570.193 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-08-26T17:39:30.201Z,1598463570.201 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-08-26T17:39:30.202Z,1598463570.202 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-08-26T17:39:30.213Z,1598463570.213 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-08-26T17:39:30.214Z,1598463570.214 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-26T17:39:30.234Z,1598463570.234 [MassServo](DEBUG): Initializing MassServo.
2020-08-26T17:39:30.235Z,1598463570.235 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-26T17:39:30.249Z,1598463570.249 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-26T17:39:30.250Z,1598463570.250 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-08-26T17:39:30.261Z,1598463570.261 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-08-26T17:39:31.113Z,1598463571.113 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-08-26T17:39:31.113Z,1598463571.113 [RudderServo](FAULT): Rudder failed to initialize
2020-08-26T17:39:31.113Z,1598463571.113 [RudderServo] Communications Fault, FailCount= 1
2020-08-26T17:39:31.113Z,1598463571.113 [RudderServo](ERROR): Communications Fault
2020-08-26T17:39:31.224Z,1598463571.224 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-08-26T17:39:31.394Z,1598463571.394 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-26T17:39:31.394Z,1598463571.394 [RudderServo](INFO): Powering down
2020-08-26T17:39:32.059Z,1598463572.059 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-26T17:39:32.178Z,1598463572.178 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-26T17:39:32.182Z,1598463572.182 [CBIT](INFO): Clearing failed state for component RudderServo
2020-08-26T17:39:32.182Z,1598463572.182 [RudderServo] No Fault, FailCount= 1
2020-08-26T17:39:33.573Z,1598463573.573 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:33.977Z,1598463573.977 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:34.473Z,1598463574.473 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:35.053Z,1598463575.053 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:35.473Z,1598463575.473 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:35.925Z,1598463575.925 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:36.377Z,1598463576.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:36.973Z,1598463576.973 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:37.529Z,1598463577.529 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:37.933Z,1598463577.933 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:38.433Z,1598463578.433 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:38.881Z,1598463578.881 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:39.269Z,1598463579.269 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:39.689Z,1598463579.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:40.121Z,1598463580.121 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:40.529Z,1598463580.529 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:40.965Z,1598463580.965 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:41.365Z,1598463581.365 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:41.805Z,1598463581.805 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:42.217Z,1598463582.217 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:42.617Z,1598463582.617 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:42.624Z,1598463582.624 [DAT](INFO): commRate: 800
2020-08-26T17:39:42.625Z,1598463582.625 [DAT](INFO): commRate: 800
2020-08-26T17:39:43.045Z,1598463583.045 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:43.045Z,1598463583.045 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-26T17:39:43.045Z,1598463583.045 [AHRS_M2] Communications Fault, FailCount= 1
2020-08-26T17:39:43.045Z,1598463583.045 [AHRS_M2](ERROR): Communications Fault
2020-08-26T17:39:43.050Z,1598463583.050 [DAT](INFO): entering command mode
2020-08-26T17:39:43.117Z,1598463583.117 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-26T17:39:43.122Z,1598463583.122 [AHRS_M2](INFO): Powering down
2020-08-26T17:39:43.199Z,1598463583.199 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:43.530Z,1598463583.530 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:43.934Z,1598463583.934 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:43.951Z,1598463583.951 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-26T17:39:43.952Z,1598463583.952 [AHRS_M2] No Fault, FailCount= 1
2020-08-26T17:39:44.333Z,1598463584.333 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-26T17:39:44.347Z,1598463584.347 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:44.742Z,1598463584.742 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:45.146Z,1598463585.146 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:45.562Z,1598463585.562 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:45.954Z,1598463585.954 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:46.370Z,1598463586.370 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:46.762Z,1598463586.762 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:47.166Z,1598463587.166 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:47.881Z,1598463587.881 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:47.886Z,1598463587.886 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:48.293Z,1598463588.293 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:48.295Z,1598463588.295 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:48.689Z,1598463588.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:48.707Z,1598463588.707 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:49.113Z,1598463589.113 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:49.118Z,1598463589.118 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:49.525Z,1598463589.525 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:49.530Z,1598463589.530 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:49.937Z,1598463589.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:49.951Z,1598463589.951 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:50.357Z,1598463590.357 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:50.370Z,1598463590.370 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:50.753Z,1598463590.753 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:50.758Z,1598463590.758 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:51.157Z,1598463591.157 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:51.162Z,1598463591.162 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:51.541Z,1598463591.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:51.546Z,1598463591.546 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:51.957Z,1598463591.957 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:51.962Z,1598463591.962 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:52.361Z,1598463592.361 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:52.366Z,1598463592.366 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:52.773Z,1598463592.773 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:52.778Z,1598463592.778 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:53.165Z,1598463593.165 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:53.177Z,1598463593.177 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:53.565Z,1598463593.565 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:53.570Z,1598463593.570 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:53.969Z,1598463593.969 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:53.974Z,1598463593.974 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:54.377Z,1598463594.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:54.382Z,1598463594.382 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:54.777Z,1598463594.777 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:54.783Z,1598463594.783 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:55.181Z,1598463595.181 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:55.186Z,1598463595.186 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:55.585Z,1598463595.585 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:55.590Z,1598463595.590 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:55.997Z,1598463595.997 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:56.002Z,1598463596.002 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:56.401Z,1598463596.401 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:56.414Z,1598463596.414 [NAL9602](INFO): Powering up NAL9602
2020-08-26T17:39:56.415Z,1598463596.415 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:56.805Z,1598463596.805 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:56.810Z,1598463596.810 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:57.209Z,1598463597.209 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:39:57.209Z,1598463597.209 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-26T17:39:57.209Z,1598463597.209 [AHRS_M2] Communications Fault, FailCount= 2
2020-08-26T17:39:57.209Z,1598463597.209 [AHRS_M2](ERROR): Communications Fault
2020-08-26T17:39:57.214Z,1598463597.214 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:57.299Z,1598463597.299 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-26T17:39:57.313Z,1598463597.313 [AHRS_M2](INFO): Powering down
2020-08-26T17:39:57.387Z,1598463597.387 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:57.710Z,1598463597.710 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:58.114Z,1598463598.114 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-26T17:39:58.114Z,1598463598.114 [DAT](FAULT): failed to enter command mode
2020-08-26T17:39:58.155Z,1598463598.155 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-26T17:39:58.155Z,1598463598.155 [AHRS_M2] No Fault, FailCount= 2
2020-08-26T17:39:58.512Z,1598463598.512 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-26T17:39:58.531Z,1598463598.531 [DAT](INFO): entering command mode
2020-08-26T17:39:58.935Z,1598463598.935 [DAT](INFO): setting verbose to 3
2020-08-26T17:39:59.327Z,1598463599.327 [DAT](INFO): set verbose to 3
2020-08-26T17:39:59.328Z,1598463599.328 [DAT](INFO): setting DatVerbose to 27440
2020-08-26T17:39:59.731Z,1598463599.731 [DAT](INFO): set DatVerbose to 27440
2020-08-26T17:39:59.732Z,1598463599.732 [DAT](INFO): setting transmit power to 8
2020-08-26T17:40:00.147Z,1598463600.147 [DAT](INFO): set transmit power to 8
2020-08-26T17:40:00.148Z,1598463600.148 [DAT](INFO): setting local address to 5
2020-08-26T17:40:00.539Z,1598463600.539 [DAT](INFO): set local address to 5
2020-08-26T17:40:02.069Z,1598463602.069 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:40:02.461Z,1598463602.461 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:40:02.877Z,1598463602.877 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:40:03.273Z,1598463603.273 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:40:03.677Z,1598463603.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:40:04.089Z,1598463604.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-08-26T17:40:04.150Z,1598463604.150 [SBIT](IMPORTANT): Beginning Startup BIT
2020-08-26T17:40:04.154Z,1598463604.154 [CBIT](IMPORTANT): Beginning ground fault scan
2020-08-26T17:40:04.909Z,1598463604.909 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:05.329Z,1598463605.329 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:05.833Z,1598463605.833 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:06.329Z,1598463606.329 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:06.817Z,1598463606.817 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:07.137Z,1598463607.137 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:07.785Z,1598463607.785 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:07.798Z,1598463607.798 [NAL9602](INFO): NAL9602 initialized
2020-08-26T17:40:08.349Z,1598463608.349 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:08.881Z,1598463608.881 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:09.369Z,1598463609.369 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:10.017Z,1598463610.017 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:10.441Z,1598463610.441 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:10.861Z,1598463610.861 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:11.273Z,1598463611.273 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:11.785Z,1598463611.785 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:11.785Z,1598463611.785 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-26T17:40:11.785Z,1598463611.785 [AHRS_M2] Communications Fault, FailCount= 3
2020-08-26T17:40:11.785Z,1598463611.785 [AHRS_M2](ERROR): Communications Fault
2020-08-26T17:40:11.862Z,1598463611.862 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-26T17:40:11.876Z,1598463611.876 [AHRS_M2](INFO): Powering down
2020-08-26T17:40:12.733Z,1598463612.733 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-26T17:40:12.733Z,1598463612.733 [AHRS_M2] No Fault, FailCount= 3
2020-08-26T17:40:13.077Z,1598463613.077 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-26T17:40:15.545Z,1598463615.545 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008580
CHAN A1 (24V): -0.007487
CHAN A2 (12V): -0.004938
CHAN A3 (5V): -0.002389
CHAN B0 (3.3V): -0.000995
CHAN B1 (3.15aV): -0.001182
CHAN B2 (3.15bV): -0.000919
CHAN B3 (GND): 0.000300
OPEN: 0.004512
Full Scale Calc: 4.765 mA, -1.589 mA
2020-08-26T17:40:16.621Z,1598463616.621 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:17.049Z,1598463617.049 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:17.469Z,1598463617.469 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:17.869Z,1598463617.869 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:18.257Z,1598463618.257 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:18.669Z,1598463618.669 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:19.073Z,1598463619.073 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:19.501Z,1598463619.501 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:20.077Z,1598463620.077 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:20.533Z,1598463620.533 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:20.969Z,1598463620.969 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:21.425Z,1598463621.425 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:21.893Z,1598463621.893 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:22.365Z,1598463622.365 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:22.829Z,1598463622.829 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:23.281Z,1598463623.281 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:23.717Z,1598463623.717 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:24.157Z,1598463624.157 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:24.605Z,1598463624.605 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:25.125Z,1598463625.125 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:25.745Z,1598463625.745 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:26.149Z,1598463626.149 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:26.149Z,1598463626.149 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-26T17:40:26.149Z,1598463626.149 [AHRS_M2] Communications Fault, FailCount= 4
2020-08-26T17:40:26.149Z,1598463626.149 [AHRS_M2](ERROR): Communications Fault
2020-08-26T17:40:26.225Z,1598463626.225 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-26T17:40:26.230Z,1598463626.230 [AHRS_M2](INFO): Powering down
2020-08-26T17:40:27.105Z,1598463627.105 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-26T17:40:27.106Z,1598463627.106 [AHRS_M2] No Fault, FailCount= 4
2020-08-26T17:40:27.440Z,1598463627.440 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-26T17:40:30.997Z,1598463630.997 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:31.421Z,1598463631.421 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:31.853Z,1598463631.853 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:32.257Z,1598463632.257 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:32.673Z,1598463632.673 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:33.077Z,1598463633.077 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:33.497Z,1598463633.497 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:33.893Z,1598463633.893 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:34.289Z,1598463634.289 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:34.693Z,1598463634.693 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:35.097Z,1598463635.097 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:35.497Z,1598463635.497 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:35.901Z,1598463635.901 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:36.389Z,1598463636.389 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:36.793Z,1598463636.793 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:37.197Z,1598463637.197 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:37.613Z,1598463637.613 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:38.017Z,1598463638.017 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:38.441Z,1598463638.441 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:38.833Z,1598463638.833 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:39.237Z,1598463639.237 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:39.641Z,1598463639.641 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:40.037Z,1598463640.037 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:40.449Z,1598463640.449 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-08-26T17:40:40.449Z,1598463640.449 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-08-26T17:40:40.449Z,1598463640.449 [AHRS_M2] Communications Fault, FailCount= 5
2020-08-26T17:40:40.449Z,1598463640.449 [AHRS_M2](ERROR): Communications Fault
2020-08-26T17:40:40.474Z,1598463640.474 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-08-26T17:40:40.475Z,1598463640.475 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2020-08-26T17:40:40.529Z,1598463640.529 [AHRS_M2](INFO): Powering down
2020-08-26T17:40:40.624Z,1598463640.624 [CommandLine](FAULT): Scheduling is paused
2020-08-26T17:40:40.625Z,1598463640.625 [CBIT](INFO): Critical error at 20200826T174040
2020-08-26T17:40:40.625Z,1598463640.625 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-08-26T17:40:58.338Z,1598463658.338 [SBIT](IMPORTANT): SBIT PASSED
2020-08-26T17:40:58.339Z,1598463658.339 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-08-26T17:40:58.340Z,1598463658.340 [SBIT](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool;
2020-08-26T17:40:58.340Z,1598463658.340 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count;
2020-08-26T17:40:58.340Z,1598463658.340 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;
2020-08-26T17:40:58.340Z,1598463658.340 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool;
2020-08-26T17:40:58.340Z,1598463658.340 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2020-08-26T17:40:58.340Z,1598463658.340 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;
2020-08-26T17:40:58.340Z,1598463658.340 [SBIT](IMPORTANT): Express linearApproximation WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 0.100000 microgram_per_liter;
2020-08-26T17:40:58.341Z,1598463658.341 [SBIT](IMPORTANT): Express linearApproximation depth 5.000000 meter;
2020-08-26T17:40:58.341Z,1598463658.341 [SBIT](IMPORTANT): Express linearApproximation latitude 0.005000 degree;
2020-08-26T17:40:58.341Z,1598463658.341 [SBIT](IMPORTANT): Express linearApproximation longitude 0.005000 degree;
2020-08-26T17:40:58.341Z,1598463658.341 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=168 cubic_centimeter;
2020-08-26T17:40:58.341Z,1598463658.341 [SBIT](IMPORTANT): VerticalControl.massDefault=3.7 millimeter;
2020-08-26T17:40:58.728Z,1598463658.728 [MissionManager](IMPORTANT): Started mission Startup
2020-08-26T17:40:58.728Z,1598463658.728 [Startup] Running Loop=1
2020-08-26T17:40:58.728Z,1598463658.728 [Startup](DEBUG): Aggregate::initialize Startup
2020-08-26T17:40:58.728Z,1598463658.728 [Startup:A.GoToSurface] Running Loop=1
2020-08-26T17:40:58.728Z,1598463658.728 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-26T17:40:58.729Z,1598463658.729 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-26T17:40:58.729Z,1598463658.729 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-26T17:40:58.730Z,1598463658.730 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-26T17:40:58.730Z,1598463658.730 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-26T17:40:58.730Z,1598463658.730 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-26T17:40:58.732Z,1598463658.732 [Startup:StartupSatComms] Running Loop=1
2020-08-26T17:40:58.732Z,1598463658.732 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-08-26T17:40:58.732Z,1598463658.732 [Startup:StartupSatComms:A] Running Loop=1
2020-08-26T17:40:59.140Z,1598463659.140 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-08-26T17:41:29.854Z,1598463689.854 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-08-26T17:41:29.854Z,1598463689.854 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-08-26T17:41:29.854Z,1598463689.854 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-26T17:41:29.865Z,1598463689.865 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-26T17:41:30.311Z,1598463690.311 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-26T17:41:30.311Z,1598463690.311 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-08-26T17:41:57.363Z,1598463717.363 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005340
2020-08-26T17:41:58.922Z,1598463718.922 [Startup:StartupSatComms:A](INFO): Timed out from 2020-08-26T17:40:58.7Z
2020-08-26T17:41:58.922Z,1598463718.922 [Startup:StartupSatComms:A] Stopped
2020-08-26T17:41:58.923Z,1598463718.923 [Startup:StartupSatComms:B] Running Loop=1
2020-08-26T17:41:59.323Z,1598463719.323 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-08-26T17:42:05.372Z,1598463725.372 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200826T161416/Courier0028.lzma
2020-08-26T17:42:06.375Z,1598463726.375 [DataOverHttps](INFO): Moved sent file to Logs/20200826T161416/Courier0028.lzma.bak
2020-08-26T17:42:06.375Z,1598463726.375 [DataOverHttps](INFO): SBD MOMSN=12620687
2020-08-26T17:42:21.556Z,1598463741.556 [DataOverHttps](INFO): Sending 211 bytes from file Logs/20200826T173918/Courier0000.lzma
2020-08-26T17:42:22.558Z,1598463742.558 [DataOverHttps](INFO): Moved sent file to Logs/20200826T173918/Courier0000.lzma.bak
2020-08-26T17:42:22.559Z,1598463742.559 [DataOverHttps](INFO): SBD MOMSN=12620689
2020-08-26T17:42:37.637Z,1598463757.637 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20200826T161416/Express0029.lzma
2020-08-26T17:42:38.638Z,1598463758.638 [DataOverHttps](INFO): Moved sent file to Logs/20200826T161416/Express0029.lzma.bak
2020-08-26T17:42:38.639Z,1598463758.639 [DataOverHttps](INFO): SBD MOMSN=12620693
2020-08-26T17:42:53.822Z,1598463773.822 [DataOverHttps](INFO): Sending 1192 bytes from file Logs/20200826T173918/Express0001.lzma
2020-08-26T17:42:54.822Z,1598463774.822 [DataOverHttps](INFO): Moved sent file to Logs/20200826T173918/Express0001.lzma.bak
2020-08-26T17:42:54.822Z,1598463774.822 [DataOverHttps](INFO): SBD MOMSN=12620699
2020-08-26T17:42:56.737Z,1598463776.737 [Startup:StartupSatComms:B] Stopped
2020-08-26T17:42:56.737Z,1598463776.737 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-08-26T17:42:56.737Z,1598463776.737 [Startup:StartupSatComms] Stopped
2020-08-26T17:42:56.737Z,1598463776.737 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-08-26T17:42:56.738Z,1598463776.738 [Startup](INFO): Completed Startup
2020-08-26T17:42:56.738Z,1598463776.738 [MissionManager](INFO): Startup is completed.
2020-08-26T17:42:56.738Z,1598463776.738 [MissionManager](INFO): Uninitializing Mission Startup
2020-08-26T17:42:56.738Z,1598463776.738 [Startup] Stopped
2020-08-26T17:42:56.739Z,1598463776.739 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-08-26T17:42:56.739Z,1598463776.739 [Startup:A.GoToSurface] Stopped
2020-08-26T17:42:56.739Z,1598463776.739 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-08-26T17:42:57.142Z,1598463777.142 [MissionManager](IMPORTANT): Started mission Default
2020-08-26T17:42:57.142Z,1598463777.142 [Default] Running Loop=1
2020-08-26T17:42:57.142Z,1598463777.142 [Default](DEBUG): Aggregate::initialize Default
2020-08-26T17:42:57.142Z,1598463777.142 [Default:B.GoToSurface] Running Loop=1
2020-08-26T17:42:57.142Z,1598463777.142 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-26T17:42:57.143Z,1598463777.143 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-26T17:42:57.143Z,1598463777.143 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-26T17:42:57.143Z,1598463777.143 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-26T17:42:57.144Z,1598463777.144 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-26T17:42:57.144Z,1598463777.144 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-26T17:42:57.144Z,1598463777.144 [Default:A.Wait] Running Loop=1
2020-08-26T17:42:57.144Z,1598463777.144 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-08-26T17:43:10.474Z,1598463790.474 [Default:A.Wait](INFO): Done Waiting.
2020-08-26T17:43:10.474Z,1598463790.474 [Default:A.Wait] Stopped
2020-08-26T17:43:10.474Z,1598463790.474 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-08-26T17:43:10.882Z,1598463790.882 [Default:CheckIn] Running Loop=1
2020-08-26T17:43:10.883Z,1598463790.883 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-08-26T17:43:10.883Z,1598463790.883 [Default:CheckIn:Read_GPS] Running Loop=1
2020-08-26T17:43:11.288Z,1598463791.288 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-08-26T17:43:30.685Z,1598463810.685 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-08-26T17:43:30.685Z,1598463810.685 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-08-26T17:43:30.685Z,1598463810.685 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-26T17:43:30.696Z,1598463810.696 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-26T17:43:31.102Z,1598463811.102 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-26T17:43:31.102Z,1598463811.102 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-08-26T17:45:11.666Z,1598463911.666 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-08-26T17:45:31.877Z,1598463931.877 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-08-26T17:45:31.877Z,1598463931.877 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-08-26T17:45:31.877Z,1598463931.877 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-26T17:45:31.887Z,1598463931.887 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-26T17:45:32.344Z,1598463932.344 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-26T17:45:32.344Z,1598463932.344 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-08-26T17:45:35.266Z,1598463935.266 [CommandLine](IMPORTANT): got command restart application
2020-08-26T17:45:36.273Z,1598463936.273 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:36.273Z,1598463936.273 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:36.317Z,1598463936.317 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2020-08-26T17:45:36.317Z,1598463936.317 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:36.318Z,1598463936.318 [CommandLine](INFO): Join timeout helper Thread ID is 7338
2020-08-26T17:45:36.326Z,1598463936.326 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-08-26T17:45:36.326Z,1598463936.326 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:36.326Z,1598463936.326 [NavChartDb](INFO): Join timeout helper Thread ID is 7339
2020-08-26T17:45:36.581Z,1598463936.581 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:36.581Z,1598463936.581 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:36.589Z,1598463936.589 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-08-26T17:45:36.589Z,1598463936.589 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:36.589Z,1598463936.589 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7340
2020-08-26T17:45:36.761Z,1598463936.761 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:36.761Z,1598463936.761 [WetLabsBB2FL](INFO): Powering down
2020-08-26T17:45:36.762Z,1598463936.762 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:36.777Z,1598463936.777 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-08-26T17:45:36.777Z,1598463936.777 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:36.777Z,1598463936.777 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7341
2020-08-26T17:45:37.225Z,1598463937.225 [CTD_Seabird](INFO): Powering down
2020-08-26T17:45:37.237Z,1598463937.237 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:37.237Z,1598463937.237 [CTD_Seabird](INFO): Powering down
2020-08-26T17:45:37.249Z,1598463937.249 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:37.257Z,1598463937.257 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-08-26T17:45:37.257Z,1598463937.257 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:37.257Z,1598463937.257 [Radio_Surface](INFO): Join timeout helper Thread ID is 7342
2020-08-26T17:45:37.413Z,1598463937.413 [Radio_Surface](INFO): Powering down
2020-08-26T17:45:37.414Z,1598463937.414 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:37.414Z,1598463937.414 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:37.422Z,1598463937.422 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-08-26T17:45:37.422Z,1598463937.422 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:37.422Z,1598463937.422 [Onboard](INFO): Join timeout helper Thread ID is 7343
2020-08-26T17:45:37.541Z,1598463937.541 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-08-26T17:45:39.997Z,1598463939.997 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:39.997Z,1598463939.997 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:40.001Z,1598463940.001 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-08-26T17:45:40.001Z,1598463940.001 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:40.002Z,1598463940.002 [DataOverHttps](INFO): Join timeout helper Thread ID is 7344
2020-08-26T17:45:40.377Z,1598463940.377 [CBIT](FAULT): Humidity exceeds 50% of running average: Humidity:2285304 %. Average:260285.359375
2020-08-26T17:45:40.553Z,1598463940.553 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:40.553Z,1598463940.553 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:40.569Z,1598463940.569 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-08-26T17:45:40.570Z,1598463940.570 [logger ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:40.570Z,1598463940.570 [logger](INFO): Join timeout helper Thread ID is 7345
2020-08-26T17:45:40.605Z,1598463940.605 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:40.605Z,1598463940.605 [logger ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:40.609Z,1598463940.609 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-08-26T17:45:40.609Z,1598463940.609 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:40.610Z,1598463940.610 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-08-26T17:45:40.610Z,1598463940.610 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:40.610Z,1598463940.610 [controlThread](INFO): Join timeout helper Thread ID is 7346
2020-08-26T17:45:40.741Z,1598463940.741 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-26T17:45:40.741Z,1598463940.741 [controlThread](DEBUG): Uninitializing ControlThread
2020-08-26T17:45:40.741Z,1598463940.741 [AHRS_M2](INFO): Powering down
2020-08-26T17:45:40.742Z,1598463940.742 [NAL9602](INFO): Powering down
2020-08-26T17:45:40.743Z,1598463940.743 [DAT](INFO): Powering down
2020-08-26T17:45:40.863Z,1598463940.863 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-08-26T17:45:40.864Z,1598463940.864 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-08-26T17:45:40.865Z,1598463940.865 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-08-26T17:45:40.865Z,1598463940.865 [MissionManager](INFO): Uninitializing Mission Default
2020-08-26T17:45:40.866Z,1598463940.866 [Default] Stopped
2020-08-26T17:45:40.866Z,1598463940.866 [Default](DEBUG): Aggregate::uninitialize Default
2020-08-26T17:45:40.866Z,1598463940.866 [Default:B.GoToSurface] Stopped
2020-08-26T17:45:40.866Z,1598463940.866 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-08-26T17:45:40.866Z,1598463940.866 [Default:CheckIn] Stopped
2020-08-26T17:45:40.866Z,1598463940.866 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-08-26T17:45:40.866Z,1598463940.866 [Default:CheckIn:Read_GPS] Stopped
2020-08-26T17:45:40.868Z,1598463940.868 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-08-26T17:45:40.869Z,1598463940.869 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-08-26T17:45:40.869Z,1598463940.869 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-08-26T17:45:40.870Z,1598463940.870 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-08-26T17:45:40.870Z,1598463940.870 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-08-26T17:45:40.870Z,1598463940.870 [BuoyancyServo](INFO): Powering down
2020-08-26T17:45:40.885Z,1598463940.885 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-08-26T17:45:40.885Z,1598463940.885 [ElevatorServo](INFO): Powering down
2020-08-26T17:45:40.886Z,1598463940.886 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-26T17:45:40.886Z,1598463940.886 [MassServo](INFO): Powering down
2020-08-26T17:45:40.887Z,1598463940.887 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-26T17:45:40.887Z,1598463940.887 [RudderServo](INFO): Powering down
2020-08-26T17:45:40.887Z,1598463940.887 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-08-26T17:45:40.888Z,1598463940.888 [ThrusterServo](INFO): Powering down
2020-08-26T17:45:40.888Z,1598463940.888 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-08-26T17:45:40.889Z,1598463940.889 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-08-26T17:45:40.889Z,1598463940.889 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-08-26T17:45:40.889Z,1598463940.889 [CBIT](DEBUG): Powering off loads.
2020-08-26T17:45:40.901Z,1598463940.901 [CBIT](DEBUG): Disabling WDT.
2020-08-26T17:45:40.912Z,1598463940.912 [CBIT](DEBUG): Opening all GF detection circuits.
2020-08-26T17:45:40.913Z,1598463940.913 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:41.011Z,1598463941.011 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:41.013Z,1598463941.013 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:41.018Z,1598463941.018 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:41.060Z,1598463941.060 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:41.066Z,1598463941.066 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:41.104Z,1598463941.104 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-26T17:45:41.168Z,1598463941.168 [logger ThreadHandler](INFO): Thread cancelled.