2020-06-25T21:03:26.081Z,1593119006.081 [Supervisor](DEBUG): Initializing supervisor.
2020-06-25T21:03:26.084Z,1593119006.084 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-06-25T21:03:26.085Z,1593119006.085 [SyncHandler](INFO): Protected caller Thread ID is 3601
2020-06-25T21:03:26.085Z,1593119006.085 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-06-25T21:03:26.086Z,1593119006.086 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-06-25T21:03:26.087Z,1593119006.087 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3602
2020-06-25T21:03:26.090Z,1593119006.090 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-06-25T21:03:26.102Z,1593119006.102 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-06-25T21:03:26.103Z,1593119006.103 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-06-25T21:03:26.104Z,1593119006.104 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3603
2020-06-25T21:03:26.104Z,1593119006.104 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-06-25T21:03:26.105Z,1593119006.105 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-06-25T21:03:26.106Z,1593119006.106 [logger ThreadHandler](INFO): Protected caller Thread ID is 3604
2020-06-25T21:03:26.108Z,1593119006.108 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-06-25T21:03:26.108Z,1593119006.108 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-06-25T21:03:26.110Z,1593119006.110 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-06-25T21:03:26.537Z,1593119006.537 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-06-25T21:03:26.538Z,1593119006.538 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-06-25T21:03:26.678Z,1593119006.678 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-06-25T21:03:26.678Z,1593119006.678 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-06-25T21:03:26.756Z,1593119006.756 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-06-25T21:03:26.948Z,1593119006.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-06-25T21:03:26.948Z,1593119006.948 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-06-25T21:03:27.044Z,1593119007.044 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-06-25T21:03:27.044Z,1593119007.044 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-06-25T21:03:27.139Z,1593119007.139 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-06-25T21:03:27.140Z,1593119007.140 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-06-25T21:03:27.523Z,1593119007.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-06-25T21:03:27.524Z,1593119007.524 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-06-25T21:03:27.624Z,1593119007.624 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-06-25T21:03:27.624Z,1593119007.624 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-06-25T21:03:28.190Z,1593119008.190 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-06-25T21:03:28.191Z,1593119008.191 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-06-25T21:03:28.379Z,1593119008.379 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-06-25T21:03:28.380Z,1593119008.380 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-06-25T21:03:28.682Z,1593119008.682 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-06-25T21:03:28.683Z,1593119008.683 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-06-25T21:03:28.895Z,1593119008.895 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-06-25T21:03:28.896Z,1593119008.896 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-06-25T21:03:29.034Z,1593119009.034 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-06-25T21:03:29.035Z,1593119009.035 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-06-25T21:03:29.690Z,1593119009.690 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-06-25T21:03:29.691Z,1593119009.691 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-06-25T21:03:30.011Z,1593119010.011 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-06-25T21:03:30.012Z,1593119010.012 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-06-25T21:03:30.222Z,1593119010.222 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-06-25T21:03:30.224Z,1593119010.224 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2020-06-25T21:03:30.225Z,1593119010.225 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2020-06-25T21:03:30.775Z,1593119010.775 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2020-06-25T21:03:30.856Z,1593119010.856 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2020-06-25T21:03:31.002Z,1593119011.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2020-06-25T21:03:31.085Z,1593119011.085 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2020-06-25T21:03:31.310Z,1593119011.310 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-06-25T21:03:31.311Z,1593119011.311 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2020-06-25T21:03:31.413Z,1593119011.413 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2020-06-25T21:03:31.518Z,1593119011.518 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2020-06-25T21:03:31.610Z,1593119011.610 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2020-06-25T21:03:31.759Z,1593119011.759 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2020-06-25T21:03:31.854Z,1593119011.854 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2020-06-25T21:03:31.951Z,1593119011.951 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2020-06-25T21:03:31.951Z,1593119011.951 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-06-25T21:03:31.964Z,1593119011.964 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-06-25T21:03:31.978Z,1593119011.978 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-06-25T21:03:31.979Z,1593119011.979 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-06-25T21:03:32.027Z,1593119012.027 [VerticalControl](DEBUG): Construct VerticalControl.
2020-06-25T21:03:32.140Z,1593119012.140 [VerticalControl] Loaded
2020-06-25T21:03:32.141Z,1593119012.141 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-06-25T21:03:32.141Z,1593119012.141 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-06-25T21:03:32.210Z,1593119012.210 [HorizontalControl] Loaded
2020-06-25T21:03:32.210Z,1593119012.210 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-06-25T21:03:32.211Z,1593119012.211 [SpeedControl](DEBUG): Construct SpeedControl.
2020-06-25T21:03:32.217Z,1593119012.217 [SpeedControl] Loaded
2020-06-25T21:03:32.217Z,1593119012.217 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-06-25T21:03:32.218Z,1593119012.218 [LoopControl](DEBUG): Construct LoopControl.
2020-06-25T21:03:32.218Z,1593119012.218 [LoopControl] Loaded
2020-06-25T21:03:32.218Z,1593119012.218 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-06-25T21:03:32.219Z,1593119012.219 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-06-25T21:03:32.219Z,1593119012.219 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-06-25T21:03:32.323Z,1593119012.323 [BuoyancyServo] Loaded
2020-06-25T21:03:32.323Z,1593119012.323 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-06-25T21:03:32.335Z,1593119012.335 [ElevatorServo] Loaded
2020-06-25T21:03:32.335Z,1593119012.335 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-06-25T21:03:32.346Z,1593119012.346 [MassServo] Loaded
2020-06-25T21:03:32.346Z,1593119012.346 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-06-25T21:03:32.357Z,1593119012.357 [RudderServo] Loaded
2020-06-25T21:03:32.358Z,1593119012.358 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-06-25T21:03:32.368Z,1593119012.368 [ThrusterServo] Loaded
2020-06-25T21:03:32.369Z,1593119012.369 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-06-25T21:03:32.369Z,1593119012.369 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-06-25T21:03:32.370Z,1593119012.370 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-06-25T21:03:32.411Z,1593119012.411 [DepthRateCalculator] Loaded
2020-06-25T21:03:32.411Z,1593119012.411 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-06-25T21:03:32.416Z,1593119012.416 [PitchRateCalculator] Loaded
2020-06-25T21:03:32.417Z,1593119012.417 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-06-25T21:03:32.432Z,1593119012.432 [SpeedCalculator] Loaded
2020-06-25T21:03:32.432Z,1593119012.432 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-06-25T21:03:32.454Z,1593119012.454 [TempGradientCalculator] Loaded
2020-06-25T21:03:32.454Z,1593119012.454 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-06-25T21:03:32.459Z,1593119012.459 [YawRateCalculator] Loaded
2020-06-25T21:03:32.459Z,1593119012.459 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-06-25T21:03:32.489Z,1593119012.489 [ElevatorOffsetCalculator] Loaded
2020-06-25T21:03:32.489Z,1593119012.489 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-06-25T21:03:32.489Z,1593119012.489 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-06-25T21:03:32.490Z,1593119012.490 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-06-25T21:03:32.595Z,1593119012.595 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-06-25T21:03:32.595Z,1593119012.595 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-06-25T21:03:32.616Z,1593119012.616 [NavChart] Loaded
2020-06-25T21:03:32.616Z,1593119012.616 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-06-25T21:03:32.620Z,1593119012.620 [UniversalFixResidualReporter] Loaded
2020-06-25T21:03:32.620Z,1593119012.620 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-06-25T21:03:32.621Z,1593119012.621 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-06-25T21:03:32.622Z,1593119012.622 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-06-25T21:03:32.993Z,1593119012.993 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-06-25T21:03:32.998Z,1593119012.998 [AHRS_M2](INFO): created writer for : platform_orientation
2020-06-25T21:03:33.001Z,1593119013.001 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-06-25T21:03:33.006Z,1593119013.006 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-06-25T21:03:33.007Z,1593119013.007 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-06-25T21:03:33.011Z,1593119013.011 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-06-25T21:03:33.012Z,1593119013.012 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-06-25T21:03:33.017Z,1593119013.017 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-06-25T21:03:33.224Z,1593119013.224 [AHRS_M2] Loaded
2020-06-25T21:03:33.224Z,1593119013.224 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-06-25T21:03:33.326Z,1593119013.326 [DataOverHttps] Loaded
2020-06-25T21:03:33.326Z,1593119013.326 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-06-25T21:03:33.327Z,1593119013.327 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407F94E0
2020-06-25T21:03:33.327Z,1593119013.327 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3687
2020-06-25T21:03:33.340Z,1593119013.340 [Depth_Keller] Loaded
2020-06-25T21:03:33.341Z,1593119013.341 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-06-25T21:03:33.438Z,1593119013.438 [NAL9602] Loaded
2020-06-25T21:03:33.438Z,1593119013.438 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-06-25T21:03:33.488Z,1593119013.488 [Onboard] Loaded
2020-06-25T21:03:33.488Z,1593119013.488 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-06-25T21:03:33.489Z,1593119013.489 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408294E0
2020-06-25T21:03:33.490Z,1593119013.490 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3688
2020-06-25T21:03:33.493Z,1593119013.493 [Radio_Surface] Loaded
2020-06-25T21:03:33.493Z,1593119013.493 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-06-25T21:03:33.494Z,1593119013.494 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408594E0
2020-06-25T21:03:33.495Z,1593119013.495 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3689
2020-06-25T21:03:33.623Z,1593119013.623 [DAT] Loaded
2020-06-25T21:03:33.624Z,1593119013.624 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-06-25T21:03:35.140Z,1593119015.140 [BPC1] Loaded
2020-06-25T21:03:35.140Z,1593119015.140 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-06-25T21:03:35.147Z,1593119015.147 [AMEcho] Loaded
2020-06-25T21:03:35.148Z,1593119015.148 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2020-06-25T21:03:35.148Z,1593119015.148 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-06-25T21:03:35.149Z,1593119015.149 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-06-25T21:03:35.222Z,1593119015.222 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-06-25T21:03:35.223Z,1593119015.223 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-06-25T21:03:35.606Z,1593119015.606 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-06-25T21:03:35.607Z,1593119015.607 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-06-25T21:03:35.872Z,1593119015.872 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-06-25T21:03:35.873Z,1593119015.873 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-06-25T21:03:36.062Z,1593119016.062 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-06-25T21:03:36.068Z,1593119016.068 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-06-25T21:03:36.068Z,1593119016.068 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-06-25T21:03:36.073Z,1593119016.073 [CTD_Seabird](INFO): created writer for : depth
2020-06-25T21:03:36.073Z,1593119016.073 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-06-25T21:03:36.078Z,1593119016.078 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-06-25T21:03:36.079Z,1593119016.079 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-06-25T21:03:36.084Z,1593119016.084 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-06-25T21:03:36.085Z,1593119016.085 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-06-25T21:03:36.090Z,1593119016.090 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-06-25T21:03:36.091Z,1593119016.091 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-06-25T21:03:36.096Z,1593119016.096 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-06-25T21:03:36.096Z,1593119016.096 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-06-25T21:03:36.102Z,1593119016.102 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-06-25T21:03:36.129Z,1593119016.129 [CTD_Seabird] Loaded
2020-06-25T21:03:36.130Z,1593119016.130 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-06-25T21:03:36.131Z,1593119016.131 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409EF4E0
2020-06-25T21:03:36.131Z,1593119016.131 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3690
2020-06-25T21:03:36.162Z,1593119016.162 [ESPComponent] Loaded
2020-06-25T21:03:36.163Z,1593119016.163 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-06-25T21:03:36.177Z,1593119016.177 [PAR_Licor] Loaded
2020-06-25T21:03:36.177Z,1593119016.177 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-06-25T21:03:36.183Z,1593119016.183 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-06-25T21:03:36.184Z,1593119016.184 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-06-25T21:03:36.188Z,1593119016.188 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-06-25T21:03:36.188Z,1593119016.188 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-06-25T21:03:36.192Z,1593119016.192 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-06-25T21:03:36.193Z,1593119016.193 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-06-25T21:03:36.197Z,1593119016.197 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-06-25T21:03:36.197Z,1593119016.197 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-06-25T21:03:36.201Z,1593119016.201 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-06-25T21:03:36.201Z,1593119016.201 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-06-25T21:03:36.206Z,1593119016.206 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-06-25T21:03:36.206Z,1593119016.206 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-06-25T21:03:36.210Z,1593119016.210 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-06-25T21:03:36.210Z,1593119016.210 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-06-25T21:03:36.215Z,1593119016.215 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-06-25T21:03:36.220Z,1593119016.220 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-06-25T21:03:36.220Z,1593119016.220 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-06-25T21:03:36.220Z,1593119016.220 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-06-25T21:03:36.224Z,1593119016.224 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-06-25T21:03:36.225Z,1593119016.225 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-06-25T21:03:36.229Z,1593119016.229 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-06-25T21:03:36.229Z,1593119016.229 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-06-25T21:03:36.234Z,1593119016.234 [WetLabsBB2FL] Loaded
2020-06-25T21:03:36.234Z,1593119016.234 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-06-25T21:03:36.235Z,1593119016.235 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A1F4E0
2020-06-25T21:03:36.236Z,1593119016.236 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3691
2020-06-25T21:03:36.236Z,1593119016.236 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-06-25T21:03:36.237Z,1593119016.237 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-06-25T21:03:36.528Z,1593119016.528 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-06-25T21:03:36.529Z,1593119016.529 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-06-25T21:03:36.663Z,1593119016.663 [SBIT](DEBUG): Construct Startup Built In Test.
2020-06-25T21:03:36.674Z,1593119016.674 [SBIT] Loaded
2020-06-25T21:03:36.674Z,1593119016.674 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-06-25T21:03:36.675Z,1593119016.675 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-06-25T21:03:36.688Z,1593119016.688 [IBIT] Loaded
2020-06-25T21:03:36.688Z,1593119016.688 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-06-25T21:03:36.691Z,1593119016.691 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-06-25T21:03:36.829Z,1593119016.829 [CBIT] Loaded
2020-06-25T21:03:36.829Z,1593119016.829 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-06-25T21:03:36.830Z,1593119016.830 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-06-25T21:03:36.833Z,1593119016.833 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-06-25T21:03:36.834Z,1593119016.834 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-06-25T21:03:36.841Z,1593119016.841 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-06-25T21:03:36.842Z,1593119016.842 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AFF4E0
2020-06-25T21:03:36.842Z,1593119016.842 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3692
2020-06-25T21:03:36.847Z,1593119016.847 [Supervisor](INFO): Main Thread ID is 3600
2020-06-25T21:03:36.847Z,1593119016.847 [Supervisor](DEBUG): Running supervisor.
2020-06-25T21:03:36.848Z,1593119016.848 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3693
2020-06-25T21:03:36.851Z,1593119016.851 [controlThread ThreadHandler](INFO): Handler Thread ID is 3694
2020-06-25T21:03:36.851Z,1593119016.851 [controlThread](DEBUG): Initializing ControlThread
2020-06-25T21:03:36.852Z,1593119016.852 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-06-25T21:03:36.854Z,1593119016.854 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-06-25T21:03:36.854Z,1593119016.854 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-06-25T21:03:36.855Z,1593119016.855 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-06-25T21:03:36.856Z,1593119016.856 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-06-25T21:03:36.856Z,1593119016.856 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-06-25T21:03:36.857Z,1593119016.857 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-06-25T21:03:36.857Z,1593119016.857 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-06-25T21:03:36.858Z,1593119016.858 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-06-25T21:03:36.858Z,1593119016.858 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-06-25T21:03:36.859Z,1593119016.859 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-06-25T21:03:36.860Z,1593119016.860 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-06-25T21:03:36.865Z,1593119016.865 [SBIT](INFO): Initialize SBIT Component.
2020-06-25T21:03:36.866Z,1593119016.866 [SBIT](IMPORTANT): git: 2020-01-30-43-g2288ba088
2020-06-25T21:03:36.866Z,1593119016.866 [SBIT](INFO): git hash: 2288ba0885cb5e0ead12bdc4915239f4cb3c2f06
2020-06-25T21:03:36.866Z,1593119016.866 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-06-25T21:03:36.867Z,1593119016.867 [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-06-25T21:03:36.868Z,1593119016.868 [SBIT](INFO): Beginning SBIT in 34.000000 seconds.
2020-06-25T21:03:36.869Z,1593119016.869 [IBIT](INFO): Initialize IBIT Component.
2020-06-25T21:03:36.870Z,1593119016.870 [CBIT](DEBUG): Initialize CBIT Component.
2020-06-25T21:03:36.871Z,1593119016.871 [logger ThreadHandler](INFO): Handler Thread ID is 3695
2020-06-25T21:03:36.881Z,1593119016.881 [CBIT](DEBUG): Initialized mux pins.
2020-06-25T21:03:36.881Z,1593119016.881 [CBIT](DEBUG): Initializing the watchdog timer.
2020-06-25T21:03:36.889Z,1593119016.889 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3696
2020-06-25T21:03:36.891Z,1593119016.891 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-06-25T21:03:36.901Z,1593119016.901 [Onboard ThreadHandler](INFO): Handler Thread ID is 3697
2020-06-25T21:03:36.906Z,1593119016.906 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-06-25T21:03:36.906Z,1593119016.906 [CBIT](DEBUG): Initializing heartbeat.
2020-06-25T21:03:36.931Z,1593119016.931 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3698
2020-06-25T21:03:36.933Z,1593119016.933 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3699
2020-06-25T21:03:36.934Z,1593119016.934 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-06-25T21:03:36.938Z,1593119016.938 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2020-06-25T21:03:36.939Z,1593119016.939 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3701
2020-06-25T21:03:36.940Z,1593119016.940 [WetLabsBB2FL](INFO): Powering down
2020-06-25T21:03:36.977Z,1593119016.977 [CBIT](DEBUG): Deactivating GF circuits.
2020-06-25T21:03:36.977Z,1593119016.977 [CBIT](DEBUG): Deactivating emergency mode.
2020-06-25T21:03:37.013Z,1593119017.013 [CBIT](DEBUG): Backplane powered.
2020-06-25T21:03:37.086Z,1593119017.086 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-06-25T21:03:37.093Z,1593119017.093 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3702
2020-06-25T21:03:37.099Z,1593119017.099 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-06-25T21:03:37.099Z,1593119017.099 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-06-25T21:03:37.100Z,1593119017.100 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-06-25T21:03:37.100Z,1593119017.100 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-06-25T21:03:37.100Z,1593119017.100 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-06-25T21:03:37.100Z,1593119017.100 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-06-25T21:03:37.100Z,1593119017.100 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-06-25T21:03:37.101Z,1593119017.101 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-06-25T21:03:37.101Z,1593119017.101 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-06-25T21:03:37.101Z,1593119017.101 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-06-25T21:03:37.101Z,1593119017.101 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-06-25T21:03:37.101Z,1593119017.101 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-06-25T21:03:37.102Z,1593119017.102 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-06-25T21:03:37.102Z,1593119017.102 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-06-25T21:03:37.102Z,1593119017.102 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-06-25T21:03:37.102Z,1593119017.102 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-06-25T21:03:37.181Z,1593119017.181 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-06-25T21:03:37.200Z,1593119017.200 [MissionManager](DEBUG):
2020-06-25T21:03:37.221Z,1593119017.221 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-06-25T21:03:37.333Z,1593119017.333 [Radio_Surface](INFO): Powering up
2020-06-25T21:03:37.406Z,1593119017.406 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-06-25T21:03:37.407Z,1593119017.407 [Default:A.Wait](DEBUG): Construct Wait.
2020-06-25T21:03:37.417Z,1593119017.417 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-06-25T21:03:37.447Z,1593119017.447 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-06-25T21:03:37.466Z,1593119017.466 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-06-25T21:03:37.471Z,1593119017.471 [Default:E.Execute](DEBUG): Construct Execute.
2020-06-25T21:03:37.494Z,1593119017.494 [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-06-25T21:03:37.505Z,1593119017.505 [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-06-25T21:03:37.515Z,1593119017.515 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-06-25T21:03:37.654Z,1593119017.654 [Depth_Keller](ERROR): Pressure reading out of range: 1925.893799 decibar
2020-06-25T21:03:37.657Z,1593119017.657 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-06-25T21:03:37.657Z,1593119017.657 [DAT](INFO): Powering up
2020-06-25T21:03:37.658Z,1593119017.658 [DAT](DEBUG): Initializing DAT.
2020-06-25T21:03:37.745Z,1593119017.745 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-06-25T21:03:37.749Z,1593119017.749 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-06-25T21:03:37.815Z,1593119017.815 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-06-25T21:03:37.825Z,1593119017.825 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-06-25T21:03:37.827Z,1593119017.827 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-06-25T21:03:37.837Z,1593119017.837 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-06-25T21:03:37.838Z,1593119017.838 [MassServo](DEBUG): Initializing EZServoServo.
2020-06-25T21:03:37.849Z,1593119017.849 [MassServo](DEBUG): Initializing MassServo.
2020-06-25T21:03:37.850Z,1593119017.850 [RudderServo](DEBUG): Initializing EZServoServo.
2020-06-25T21:03:37.861Z,1593119017.861 [RudderServo](DEBUG): Initializing RudderServo.
2020-06-25T21:03:37.862Z,1593119017.862 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-06-25T21:03:37.873Z,1593119017.873 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-06-25T21:03:38.265Z,1593119018.265 [AMEcho](INFO): Powering down
2020-06-25T21:03:38.725Z,1593119018.725 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-06-25T21:03:38.725Z,1593119018.725 [RudderServo](FAULT): Rudder failed to initialize
2020-06-25T21:03:38.725Z,1593119018.725 [RudderServo] Communications Fault, FailCount= 1
2020-06-25T21:03:38.725Z,1593119018.725 [RudderServo](ERROR): Communications Fault
2020-06-25T21:03:38.837Z,1593119018.837 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-06-25T21:03:39.018Z,1593119019.018 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-06-25T21:03:39.018Z,1593119019.018 [RudderServo](INFO): Powering down
2020-06-25T21:03:39.697Z,1593119019.697 [RudderServo](DEBUG): Initializing EZServoServo.
2020-06-25T21:03:39.830Z,1593119019.830 [RudderServo](DEBUG): Initializing RudderServo.
2020-06-25T21:03:39.834Z,1593119019.834 [CBIT](INFO): Clearing failed state for component RudderServo
2020-06-25T21:03:39.834Z,1593119019.834 [RudderServo] No Fault, FailCount= 1
2020-06-25T21:03:41.189Z,1593119021.189 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-06-25T21:03:41.577Z,1593119021.577 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-06-25T21:03:43.971Z,1593119023.971 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2020-06-25T21:03:46.935Z,1593119026.935 [CBIT](CRITICAL): Environmental Failure. Press:14.855666 PSI. Humidity:53%. Temp:22 C. ABORTING MISSION
2020-06-25T21:03:46.935Z,1593119026.935 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals
2020-06-25T21:03:47.283Z,1593119027.283 [CommandLine](FAULT): Scheduling is paused
2020-06-25T21:03:47.283Z,1593119027.283 [CBIT](INFO): Critical error at 20200625T210346
2020-06-25T21:03:51.050Z,1593119031.050 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.058522
2020-06-25T21:03:51.226Z,1593119031.226 [DAT](INFO): setting local address to 5
2020-06-25T21:03:51.635Z,1593119031.635 [DAT](INFO): set local address to 5
2020-06-25T21:04:03.754Z,1593119043.754 [NAL9602](INFO): Powering up NAL9602
2020-06-25T21:04:11.459Z,1593119051.459 [SBIT](IMPORTANT): Beginning Startup BIT
2020-06-25T21:04:11.467Z,1593119051.467 [CBIT](IMPORTANT): Beginning ground fault scan
2020-06-25T21:04:14.676Z,1593119054.676 [NAL9602](INFO): NAL9602 initialized
2020-06-25T21:04:22.501Z,1593119062.501 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008671
CHAN A1 (24V): -0.007275
CHAN A2 (12V): -0.004761
CHAN A3 (5V): -0.003552
CHAN B0 (3.3V): -0.001622
CHAN B1 (3.15aV): -0.001153
CHAN B2 (3.15bV): -0.000894
CHAN B3 (GND): -0.000165
OPEN: 0.006407
Full Scale Calc: 4.765 mA, -1.589 mA
2020-06-25T21:04:36.972Z,1593119076.972 [CommandLine](IMPORTANT): got command show variable amecho
2020-06-25T21:04:37.152Z,1593119077.152 [CommandLine](IMPORTANT): AMEcho.loadControl (none)
2020-06-25T21:04:37.152Z,1593119077.152 [CommandLine](IMPORTANT): AMEcho.uart (none)
2020-06-25T21:04:37.152Z,1593119077.152 [CommandLine](IMPORTANT): AMEcho.baud (bit_per_second)
2020-06-25T21:04:37.157Z,1593119077.157 [CommandLine](IMPORTANT): AMEcho.loadAtStartup (bool)
2020-06-25T21:04:37.157Z,1593119077.157 [CommandLine](IMPORTANT): AMEcho.simulateHardware (bool)
2020-06-25T21:04:37.230Z,1593119077.230 [CommandLine](IMPORTANT): AMEcho.height_above_sea_floor (meter)
2020-06-25T21:04:37.236Z,1593119077.236 [CommandLine](IMPORTANT): AMEcho.component_voltage (volt)
2020-06-25T21:04:37.237Z,1593119077.237 [CommandLine](IMPORTANT): AMEcho.component_avgVoltage (volt)
2020-06-25T21:04:37.237Z,1593119077.237 [CommandLine](IMPORTANT): AMEcho.component_current (milliampere)
2020-06-25T21:04:37.237Z,1593119077.237 [CommandLine](IMPORTANT): AMEcho.component_avgCurrent (milliampere)
2020-06-25T21:04:41.659Z,1593119081.659 [CommandLine](IMPORTANT): got command failComponent
2020-06-25T21:04:41.659Z,1593119081.659 [CommandLine](IMPORTANT): Failed components:
2020-06-25T21:04:41.659Z,1593119081.659 [CommandLine](IMPORTANT): No failed Components.
2020-06-25T21:05:04.475Z,1593119104.475 [CommandLine](IMPORTANT): got command report mod height_above_sea_floor
2020-06-25T21:05:04.792Z,1593119104.792 [Reporter](INFO): height_above_sea_floor no_value
2020-06-25T21:05:05.611Z,1593119105.611 [SBIT](IMPORTANT): SBIT PASSED
2020-06-25T21:05:05.611Z,1593119105.611 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-06-25T21:05:05.612Z,1593119105.612 [SBIT](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool;
2020-06-25T21:05:05.612Z,1593119105.612 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count;
2020-06-25T21:05:05.612Z,1593119105.612 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;
2020-06-25T21:05:05.612Z,1593119105.612 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool;
2020-06-25T21:05:05.612Z,1593119105.612 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2020-06-25T21:05:05.612Z,1593119105.612 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;
2020-06-25T21:05:05.612Z,1593119105.612 [SBIT](IMPORTANT): Express linearApproximation WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 0.100000 microgram_per_liter;
2020-06-25T21:05:05.612Z,1593119105.612 [SBIT](IMPORTANT): Express linearApproximation depth 5.000000 meter;
2020-06-25T21:05:05.613Z,1593119105.613 [SBIT](IMPORTANT): Express linearApproximation latitude 0.005000 degree;
2020-06-25T21:05:05.613Z,1593119105.613 [SBIT](IMPORTANT): Express linearApproximation longitude 0.005000 degree;
2020-06-25T21:05:05.613Z,1593119105.613 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=168 cubic_centimeter;
2020-06-25T21:05:05.613Z,1593119105.613 [SBIT](IMPORTANT): VerticalControl.massDefault=3.7 millimeter;
2020-06-25T21:05:05.975Z,1593119105.975 [MissionManager](IMPORTANT): Started mission Startup
2020-06-25T21:05:05.975Z,1593119105.975 [Startup] Running Loop=1
2020-06-25T21:05:05.976Z,1593119105.976 [Startup](DEBUG): Aggregate::initialize Startup
2020-06-25T21:05:05.976Z,1593119105.976 [Startup:A.GoToSurface] Running Loop=1
2020-06-25T21:05:05.976Z,1593119105.976 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-06-25T21:05:05.976Z,1593119105.976 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-06-25T21:05:05.977Z,1593119105.977 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-06-25T21:05:05.977Z,1593119105.977 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-06-25T21:05:05.978Z,1593119105.978 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-06-25T21:05:05.978Z,1593119105.978 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-06-25T21:05:05.979Z,1593119105.979 [Startup:StartupSatComms] Running Loop=1
2020-06-25T21:05:05.980Z,1593119105.980 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-06-25T21:05:05.980Z,1593119105.980 [Startup:StartupSatComms:A] Running Loop=1
2020-06-25T21:05:06.395Z,1593119106.395 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-06-25T21:05:19.309Z,1593119119.309 [AMEcho](INFO): UART read:
2020-06-25T21:05:19.310Z,1593119119.310 [AMEcho](ERROR): only read -1 of 2 data items for altitude
2020-06-25T21:05:19.705Z,1593119119.705 [AMEcho](INFO): UART read:
AIRMAR (R) Serial Flash Bootloader
2020-06-25T21:05:19.705Z,1593119119.705 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:20.136Z,1593119120.136 [AMEcho](INFO): UART read:
Copyright (C) 2005-2015 AIRMAR Technology Corp.
2020-06-25T21:05:20.136Z,1593119120.136 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:20.524Z,1593119120.524 [AMEcho](INFO): UART read:
All rights reserved.
2020-06-25T21:05:20.524Z,1593119120.524 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:20.935Z,1593119120.935 [AMEcho](INFO): UART read:
2020-06-25T21:05:20.935Z,1593119120.935 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:21.396Z,1593119121.396 [AMEcho](INFO): UART read:
2020-06-25T21:05:21.396Z,1593119121.396 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:21.745Z,1593119121.745 [AMEcho](INFO): UART read:
2020-06-25T21:05:21.745Z,1593119121.745 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:22.161Z,1593119122.161 [AMEcho](INFO): UART read:
$PAMTT,200m Mini Altimeter Kit (170kHz)
2020-06-25T21:05:22.162Z,1593119122.162 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:22.554Z,1593119122.554 [AMEcho](INFO): UART read:
$PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc. All Rights Reserved.
2020-06-25T21:05:22.554Z,1593119122.554 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:22.972Z,1593119122.972 [AMEcho](INFO): UART read:
$PAMTT,POST,0,0,0,2,1,,0,0,,,,,,ER0183*46
2020-06-25T21:05:22.972Z,1593119122.972 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:23.381Z,1593119123.381 [AMEcho](INFO): UART read:
$PAMTT,QV,,0,0,,1.807,1.841,,*75
2020-06-25T21:05:23.381Z,1593119123.381 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:23.765Z,1593119123.765 [AMEcho](INFO): UART read:
$PAMTT,QPS,100438,201095-1,4*27
2020-06-25T21:05:23.765Z,1593119123.765 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:24.169Z,1593119124.169 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:24.169Z,1593119124.169 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:24.572Z,1593119124.572 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:24.585Z,1593119124.585 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:25.257Z,1593119125.257 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:25.257Z,1593119125.257 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:25.490Z,1593119125.490 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:25.490Z,1593119125.490 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:25.830Z,1593119125.830 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:25.831Z,1593119125.831 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:26.247Z,1593119126.247 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:26.247Z,1593119126.247 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:26.607Z,1593119126.607 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:26.607Z,1593119126.607 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:27.023Z,1593119127.023 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:27.024Z,1593119127.024 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:27.408Z,1593119127.408 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:27.409Z,1593119127.409 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:27.813Z,1593119127.813 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:27.813Z,1593119127.813 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:28.216Z,1593119128.216 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:28.216Z,1593119128.216 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:28.621Z,1593119128.621 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:28.621Z,1593119128.621 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:29.020Z,1593119129.020 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-06-25T21:05:29.020Z,1593119129.020 [AMEcho] Communications Fault, FailCount= 1
2020-06-25T21:05:29.021Z,1593119129.021 [AMEcho](ERROR): Communications Fault
2020-06-25T21:05:29.114Z,1593119129.114 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-06-25T21:05:29.589Z,1593119129.589 [AMEcho](INFO): Powering down
2020-06-25T21:05:30.256Z,1593119130.256 [CBIT](INFO): Clearing failed state for component AMEcho
2020-06-25T21:05:30.256Z,1593119130.256 [AMEcho] No Fault, FailCount= 1
2020-06-25T21:05:43.168Z,1593119143.168 [AMEcho](INFO): UART read: ÿ
2020-06-25T21:05:43.169Z,1593119143.169 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:43.565Z,1593119143.565 [AMEcho](INFO): UART read:
AIRMAR (R) Serial Flash Bootloader
2020-06-25T21:05:43.566Z,1593119143.566 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:43.978Z,1593119143.978 [AMEcho](INFO): UART read:
Copyright (C) 2005-2015 AIRMAR Technology Corp.
2020-06-25T21:05:43.978Z,1593119143.978 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:44.377Z,1593119144.377 [AMEcho](INFO): UART read:
All rights reserved.
2020-06-25T21:05:44.377Z,1593119144.377 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:44.777Z,1593119144.777 [AMEcho](INFO): UART read:
2020-06-25T21:05:44.777Z,1593119144.777 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:45.184Z,1593119145.184 [AMEcho](INFO): UART read:
2020-06-25T21:05:45.184Z,1593119145.184 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:45.594Z,1593119145.594 [AMEcho](INFO): UART read:
2020-06-25T21:05:45.595Z,1593119145.595 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:45.994Z,1593119145.994 [AMEcho](INFO): UART read:
$PAMTT,200m Mini Altimeter Kit (170kHz)
2020-06-25T21:05:45.995Z,1593119145.995 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:46.412Z,1593119146.412 [AMEcho](INFO): UART read:
$PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc. All Rights Reserved.
2020-06-25T21:05:46.413Z,1593119146.413 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:46.816Z,1593119146.816 [AMEcho](INFO): UART read:
$PAMTT,POST,0,0,0,2,1,,0,0,,,,,,ER0183*46
2020-06-25T21:05:46.816Z,1593119146.816 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:47.223Z,1593119147.223 [AMEcho](INFO): UART read:
$PAMTT,QV,,0,0,,1.807,1.841,,*75
2020-06-25T21:05:47.224Z,1593119147.224 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:47.616Z,1593119147.616 [AMEcho](INFO): UART read:
$PAMTT,QPS,100438,201095-1,4*27
2020-06-25T21:05:47.616Z,1593119147.616 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:48.014Z,1593119148.014 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:48.015Z,1593119148.015 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:48.417Z,1593119148.417 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:48.418Z,1593119148.418 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:48.817Z,1593119148.817 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:48.817Z,1593119148.817 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:49.229Z,1593119149.229 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:49.229Z,1593119149.229 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:49.634Z,1593119149.634 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:49.634Z,1593119149.634 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:50.037Z,1593119150.037 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:50.037Z,1593119150.037 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:50.445Z,1593119150.445 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:50.445Z,1593119150.445 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:50.845Z,1593119150.845 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:50.845Z,1593119150.845 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:51.310Z,1593119151.310 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:51.310Z,1593119151.310 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:51.753Z,1593119151.753 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:51.754Z,1593119151.754 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:52.081Z,1593119152.081 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:05:52.082Z,1593119152.082 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:05:52.886Z,1593119152.886 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-06-25T21:05:52.886Z,1593119152.886 [AMEcho] Communications Fault, FailCount= 2
2020-06-25T21:05:52.886Z,1593119152.886 [AMEcho](ERROR): Communications Fault
2020-06-25T21:05:52.929Z,1593119152.929 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-06-25T21:05:53.429Z,1593119153.429 [AMEcho](INFO): Powering down
2020-06-25T21:05:54.103Z,1593119154.103 [CBIT](INFO): Clearing failed state for component AMEcho
2020-06-25T21:05:54.103Z,1593119154.103 [AMEcho] No Fault, FailCount= 2
2020-06-25T21:06:03.562Z,1593119163.562 [CommandLine](IMPORTANT): got command report clear
2020-06-25T21:06:06.196Z,1593119166.196 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:06:06.209Z,1593119166.209 [Startup:StartupSatComms:A](INFO): Timed out from 2020-06-25T21:05:05.0Z
2020-06-25T21:06:06.209Z,1593119166.209 [Startup:StartupSatComms:A] Stopped
2020-06-25T21:06:06.209Z,1593119166.209 [Startup:StartupSatComms:B] Running Loop=1
2020-06-25T21:06:06.620Z,1593119166.620 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-06-25T21:06:07.000Z,1593119167.000 [AMEcho](INFO): UART read: ÿ
2020-06-25T21:06:07.001Z,1593119167.001 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:07.416Z,1593119167.416 [AMEcho](INFO): UART read:
AIRMAR (R) Serial Flash Bootloader
2020-06-25T21:06:07.416Z,1593119167.416 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:07.827Z,1593119167.827 [AMEcho](INFO): UART read:
Copyright (C) 2005-2015 AIRMAR Technology Corp.
2020-06-25T21:06:07.828Z,1593119167.828 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:08.231Z,1593119168.231 [AMEcho](INFO): UART read:
All rights reserved.
2020-06-25T21:06:08.232Z,1593119168.232 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:08.631Z,1593119168.631 [AMEcho](INFO): UART read:
2020-06-25T21:06:08.632Z,1593119168.632 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:09.017Z,1593119169.017 [AMEcho](INFO): UART read:
2020-06-25T21:06:09.017Z,1593119169.017 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:09.420Z,1593119169.420 [AMEcho](INFO): UART read:
2020-06-25T21:06:09.421Z,1593119169.421 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:09.833Z,1593119169.833 [AMEcho](INFO): UART read:
$PAMTT,200m Mini Altimeter Kit (170kHz)
2020-06-25T21:06:09.834Z,1593119169.834 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:10.231Z,1593119170.231 [AMEcho](INFO): UART read:
$PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc. All Rights Reserved.
2020-06-25T21:06:10.231Z,1593119170.231 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:10.633Z,1593119170.633 [AMEcho](INFO): UART read:
$PAMTT,POST,0,0,0,2,1,,0,0,,,,,,ER0183*46
2020-06-25T21:06:10.633Z,1593119170.633 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:11.041Z,1593119171.041 [AMEcho](INFO): UART read:
$PAMTT,QV,,0,0,,1.807,1.841,,*75
2020-06-25T21:06:11.041Z,1593119171.041 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:11.446Z,1593119171.446 [AMEcho](INFO): UART read:
$PAMTT,QPS,100438,201095-1,4*27
2020-06-25T21:06:11.447Z,1593119171.447 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:11.849Z,1593119171.849 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:11.849Z,1593119171.849 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:12.261Z,1593119172.261 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:12.261Z,1593119172.261 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:12.668Z,1593119172.668 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:12.668Z,1593119172.668 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:13.071Z,1593119173.071 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:13.072Z,1593119173.072 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:13.495Z,1593119173.495 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:13.496Z,1593119173.496 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:13.882Z,1593119173.882 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:06:13.890Z,1593119173.890 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:13.890Z,1593119173.890 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:13.974Z,1593119173.974 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20200624T212119/Courier0409.lzma
2020-06-25T21:06:14.290Z,1593119174.290 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:14.291Z,1593119174.291 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:14.694Z,1593119174.694 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:14.694Z,1593119174.694 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:14.975Z,1593119174.975 [DataOverHttps](INFO): Moved sent file to Logs/20200624T212119/Courier0409.lzma.bak
2020-06-25T21:06:14.975Z,1593119174.975 [DataOverHttps](INFO): SBD MOMSN=12402380
2020-06-25T21:06:15.077Z,1593119175.077 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:15.077Z,1593119175.077 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:15.481Z,1593119175.481 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:15.481Z,1593119175.481 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:15.895Z,1593119175.895 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:06:15.895Z,1593119175.895 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:06:16.696Z,1593119176.696 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-06-25T21:06:16.696Z,1593119176.696 [AMEcho] Communications Fault, FailCount= 3
2020-06-25T21:06:16.696Z,1593119176.696 [AMEcho](ERROR): Communications Fault
2020-06-25T21:06:16.712Z,1593119176.712 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-06-25T21:06:16.713Z,1593119176.713 [CBIT](CRITICAL): Communications Fault in component: AMEcho
2020-06-25T21:06:17.261Z,1593119177.261 [AMEcho](INFO): Powering down
2020-06-25T21:06:17.282Z,1593119177.282 [CBIT](INFO): Critical error at 20200625T210616
2020-06-25T21:06:29.230Z,1593119189.230 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:06:30.498Z,1593119190.498 [DataOverHttps](INFO): Sending 253 bytes from file Logs/20200625T205534/Courier0000.lzma
2020-06-25T21:06:31.499Z,1593119191.499 [DataOverHttps](INFO): Moved sent file to Logs/20200625T205534/Courier0000.lzma.bak
2020-06-25T21:06:31.499Z,1593119191.499 [DataOverHttps](INFO): SBD MOMSN=12402382
2020-06-25T21:06:36.913Z,1593119196.913 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-06-25T21:06:36.914Z,1593119196.914 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-25T21:06:36.928Z,1593119196.928 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-25T21:06:37.334Z,1593119197.334 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-25T21:06:37.335Z,1593119197.335 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-06-25T21:06:44.994Z,1593119204.994 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:06:46.941Z,1593119206.941 [DataOverHttps](INFO): Sending 250 bytes from file Logs/20200625T210326/Courier0000.lzma
2020-06-25T21:06:47.939Z,1593119207.939 [DataOverHttps](INFO): Moved sent file to Logs/20200625T210326/Courier0000.lzma.bak
2020-06-25T21:06:47.939Z,1593119207.939 [DataOverHttps](INFO): SBD MOMSN=12402386
2020-06-25T21:06:59.938Z,1593119219.938 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:07:03.464Z,1593119223.464 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20200624T212119/Express0410.lzma
2020-06-25T21:07:04.467Z,1593119224.467 [DataOverHttps](INFO): Moved sent file to Logs/20200624T212119/Express0410.lzma.bak
2020-06-25T21:07:04.468Z,1593119224.468 [DataOverHttps](INFO): SBD MOMSN=12402390
2020-06-25T21:07:06.419Z,1593119226.419 [Startup:StartupSatComms:B](INFO): Timed out from 2020-06-25T21:06:06.2Z
2020-06-25T21:07:06.419Z,1593119226.419 [Startup:StartupSatComms:B] Stopped
2020-06-25T21:07:06.419Z,1593119226.419 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-06-25T21:07:06.419Z,1593119226.419 [Startup:StartupSatComms] Stopped
2020-06-25T21:07:06.419Z,1593119226.419 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-06-25T21:07:06.420Z,1593119226.420 [Startup](INFO): Completed Startup
2020-06-25T21:07:06.420Z,1593119226.420 [MissionManager](INFO): Startup is completed.
2020-06-25T21:07:06.420Z,1593119226.420 [MissionManager](INFO): Uninitializing Mission Startup
2020-06-25T21:07:06.420Z,1593119226.420 [Startup] Stopped
2020-06-25T21:07:06.420Z,1593119226.420 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-06-25T21:07:06.420Z,1593119226.420 [Startup:A.GoToSurface] Stopped
2020-06-25T21:07:06.420Z,1593119226.420 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-06-25T21:07:06.803Z,1593119226.803 [MissionManager](IMPORTANT): Started mission Default
2020-06-25T21:07:06.803Z,1593119226.803 [Default] Running Loop=1
2020-06-25T21:07:06.803Z,1593119226.803 [Default](DEBUG): Aggregate::initialize Default
2020-06-25T21:07:06.803Z,1593119226.803 [Default:B.GoToSurface] Running Loop=1
2020-06-25T21:07:06.803Z,1593119226.803 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-06-25T21:07:06.804Z,1593119226.804 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-06-25T21:07:06.804Z,1593119226.804 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-06-25T21:07:06.804Z,1593119226.804 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-06-25T21:07:06.805Z,1593119226.805 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-06-25T21:07:06.805Z,1593119226.805 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-06-25T21:07:06.805Z,1593119226.805 [Default:A.Wait] Running Loop=1
2020-06-25T21:07:06.805Z,1593119226.805 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-06-25T21:07:14.872Z,1593119234.872 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:07:19.866Z,1593119239.866 [Default:A.Wait](INFO): Done Waiting.
2020-06-25T21:07:19.867Z,1593119239.867 [Default:A.Wait] Stopped
2020-06-25T21:07:19.867Z,1593119239.867 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-06-25T21:07:20.141Z,1593119240.141 [Default:CheckIn] Running Loop=1
2020-06-25T21:07:20.141Z,1593119240.141 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-25T21:07:20.141Z,1593119240.141 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-25T21:07:20.539Z,1593119240.539 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-06-25T21:07:30.224Z,1593119250.224 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:07:45.575Z,1593119265.575 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:07:46.938Z,1593119266.938 [DataOverHttps](INFO): Sending 313 bytes from file Logs/20200625T205534/Express0001.lzma
2020-06-25T21:07:47.939Z,1593119267.939 [DataOverHttps](INFO): Moved sent file to Logs/20200625T205534/Express0001.lzma.bak
2020-06-25T21:07:47.939Z,1593119267.939 [DataOverHttps](INFO): SBD MOMSN=12402392
2020-06-25T21:08:00.524Z,1593119280.524 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:08:15.880Z,1593119295.880 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:08:15.899Z,1593119295.899 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2020-06-25T21:08:30.824Z,1593119310.824 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:08:46.190Z,1593119326.190 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:09:01.542Z,1593119341.542 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:09:16.898Z,1593119356.898 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:09:16.924Z,1593119356.924 [CBIT](INFO): Clearing failed state for component AMEcho
2020-06-25T21:09:16.924Z,1593119356.924 [AMEcho] No Fault, FailCount= 3
2020-06-25T21:09:17.690Z,1593119357.690 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-06-25T21:09:29.816Z,1593119369.816 [AMEcho](INFO): UART read:
2020-06-25T21:09:29.816Z,1593119369.816 [AMEcho](ERROR): only read -1 of 2 data items for altitude
2020-06-25T21:09:30.232Z,1593119370.232 [AMEcho](INFO): UART read:
AIRMAR (R) Serial Flash Bootloader
2020-06-25T21:09:30.232Z,1593119370.232 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:30.648Z,1593119370.648 [AMEcho](INFO): UART read:
Copyright (C) 2005-2015 AIRMAR Technology Corp.
2020-06-25T21:09:30.648Z,1593119370.648 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:31.032Z,1593119371.032 [AMEcho](INFO): UART read:
All rights reserved.
2020-06-25T21:09:31.032Z,1593119371.032 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:31.518Z,1593119371.518 [AMEcho](INFO): UART read:
2020-06-25T21:09:31.518Z,1593119371.518 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:31.841Z,1593119371.841 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:09:31.848Z,1593119371.848 [AMEcho](INFO): UART read:
2020-06-25T21:09:31.849Z,1593119371.849 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:32.254Z,1593119372.254 [AMEcho](INFO): UART read:
2020-06-25T21:09:32.254Z,1593119372.254 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:32.655Z,1593119372.655 [AMEcho](INFO): UART read:
$PAMTT,200m Mini Altimeter Kit (170kHz)
2020-06-25T21:09:32.655Z,1593119372.655 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:33.056Z,1593119373.056 [AMEcho](INFO): UART read:
$PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc. All Rights Reserved.
2020-06-25T21:09:33.057Z,1593119373.057 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:33.468Z,1593119373.468 [AMEcho](INFO): UART read:
$PAMTT,POST,0,0,0,2,1,,0,0,,,,,,ER0183*46
2020-06-25T21:09:33.468Z,1593119373.468 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:33.863Z,1593119373.863 [AMEcho](INFO): UART read:
$PAMTT,QV,,0,0,,1.807,1.841,,*75
2020-06-25T21:09:33.864Z,1593119373.864 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:34.256Z,1593119374.256 [AMEcho](INFO): UART read:
$PAMTT,QPS,100438,201095-1,4*27
2020-06-25T21:09:34.257Z,1593119374.257 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:34.661Z,1593119374.661 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:34.661Z,1593119374.661 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:35.062Z,1593119375.062 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:35.063Z,1593119375.063 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:35.465Z,1593119375.465 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:35.465Z,1593119375.465 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:35.935Z,1593119375.935 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:35.935Z,1593119375.935 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:36.287Z,1593119376.287 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:36.287Z,1593119376.287 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:36.702Z,1593119376.702 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:36.702Z,1593119376.702 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:37.106Z,1593119377.106 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:37.107Z,1593119377.107 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:37.480Z,1593119377.480 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:37.481Z,1593119377.481 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:37.884Z,1593119377.884 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:37.884Z,1593119377.884 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:37.894Z,1593119377.894 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-06-25T21:09:37.894Z,1593119377.894 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-25T21:09:37.904Z,1593119377.904 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-25T21:09:38.299Z,1593119378.299 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:38.299Z,1593119378.299 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:38.314Z,1593119378.314 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-25T21:09:38.314Z,1593119378.314 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-06-25T21:09:38.697Z,1593119378.697 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:38.697Z,1593119378.697 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:39.111Z,1593119379.111 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:39.111Z,1593119379.111 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:39.523Z,1593119379.523 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-06-25T21:09:39.523Z,1593119379.523 [AMEcho] Communications Fault, FailCount= 1
2020-06-25T21:09:39.523Z,1593119379.523 [AMEcho](ERROR): Communications Fault
2020-06-25T21:09:39.568Z,1593119379.568 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-06-25T21:09:40.093Z,1593119380.093 [AMEcho](INFO): Powering down
2020-06-25T21:09:40.735Z,1593119380.735 [CBIT](INFO): Clearing failed state for component AMEcho
2020-06-25T21:09:40.735Z,1593119380.735 [AMEcho] No Fault, FailCount= 1
2020-06-25T21:09:46.780Z,1593119386.780 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:09:53.644Z,1593119393.644 [AMEcho](INFO): UART read:
2020-06-25T21:09:53.644Z,1593119393.644 [AMEcho](ERROR): only read -1 of 2 data items for altitude
2020-06-25T21:09:54.064Z,1593119394.064 [AMEcho](INFO): UART read:
AIRMAR (R) Serial Flash Bootloader
2020-06-25T21:09:54.065Z,1593119394.065 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:54.476Z,1593119394.476 [AMEcho](INFO): UART read:
Copyright (C) 2005-2015 AIRMAR Technology Corp.
2020-06-25T21:09:54.476Z,1593119394.476 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:54.869Z,1593119394.869 [AMEcho](INFO): UART read:
All rights reserved.
2020-06-25T21:09:54.869Z,1593119394.869 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:55.260Z,1593119395.260 [AMEcho](INFO): UART read:
2020-06-25T21:09:55.260Z,1593119395.260 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:55.660Z,1593119395.660 [AMEcho](INFO): UART read:
2020-06-25T21:09:55.661Z,1593119395.661 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:56.069Z,1593119396.069 [AMEcho](INFO): UART read:
2020-06-25T21:09:56.069Z,1593119396.069 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:56.474Z,1593119396.474 [AMEcho](INFO): UART read:
$PAMTT,200m Mini Altimeter Kit (170kHz)
2020-06-25T21:09:56.474Z,1593119396.474 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:56.874Z,1593119396.874 [AMEcho](INFO): UART read:
$PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc. All Rights Reserved.
2020-06-25T21:09:56.875Z,1593119396.875 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:57.287Z,1593119397.287 [AMEcho](INFO): UART read:
$PAMTT,POST,0,0,0,2,1,,0,0,,,,,,ER0183*46
2020-06-25T21:09:57.288Z,1593119397.288 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:57.703Z,1593119397.703 [AMEcho](INFO): UART read:
$PAMTT,QV,,0,0,,1.807,1.841,,*75
2020-06-25T21:09:57.704Z,1593119397.704 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:58.096Z,1593119398.096 [AMEcho](INFO): UART read:
$PAMTT,QPS,100438,201095-1,4*27
2020-06-25T21:09:58.097Z,1593119398.097 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:58.488Z,1593119398.488 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:58.489Z,1593119398.489 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:58.896Z,1593119398.896 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:58.897Z,1593119398.897 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:59.306Z,1593119399.306 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:59.306Z,1593119399.306 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:09:59.753Z,1593119399.753 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:09:59.753Z,1593119399.753 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:00.127Z,1593119400.127 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:00.128Z,1593119400.128 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:00.532Z,1593119400.532 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:00.532Z,1593119400.532 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:00.935Z,1593119400.935 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:00.935Z,1593119400.935 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:01.321Z,1593119401.321 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:01.321Z,1593119401.321 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:01.777Z,1593119401.777 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:01.777Z,1593119401.777 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:02.124Z,1593119402.124 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:10:02.132Z,1593119402.132 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:02.132Z,1593119402.132 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:02.614Z,1593119402.614 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:02.614Z,1593119402.614 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:03.366Z,1593119403.366 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-06-25T21:10:03.366Z,1593119403.366 [AMEcho] Communications Fault, FailCount= 2
2020-06-25T21:10:03.366Z,1593119403.366 [AMEcho](ERROR): Communications Fault
2020-06-25T21:10:03.398Z,1593119403.398 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-06-25T21:10:03.949Z,1593119403.949 [AMEcho](INFO): Powering down
2020-06-25T21:10:04.592Z,1593119404.592 [CBIT](INFO): Clearing failed state for component AMEcho
2020-06-25T21:10:04.592Z,1593119404.592 [AMEcho] No Fault, FailCount= 2
2020-06-25T21:10:17.494Z,1593119417.494 [AMEcho](INFO): UART read: ÿ
2020-06-25T21:10:17.494Z,1593119417.494 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:17.932Z,1593119417.932 [AMEcho](INFO): UART read:
AIRMAR (R) Serial Flash Bootloader
2020-06-25T21:10:17.932Z,1593119417.932 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:18.310Z,1593119418.310 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:10:18.318Z,1593119418.318 [AMEcho](INFO): UART read:
Copyright (C) 2005-2015 AIRMAR Technology Corp.
2020-06-25T21:10:18.318Z,1593119418.318 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:18.723Z,1593119418.723 [AMEcho](INFO): UART read:
All rights reserved.
2020-06-25T21:10:18.723Z,1593119418.723 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:19.118Z,1593119419.118 [AMEcho](INFO): UART read:
2020-06-25T21:10:19.118Z,1593119419.118 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:19.504Z,1593119419.504 [AMEcho](INFO): UART read:
2020-06-25T21:10:19.504Z,1593119419.504 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:19.912Z,1593119419.912 [AMEcho](INFO): UART read:
2020-06-25T21:10:19.913Z,1593119419.913 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:20.306Z,1593119420.306 [AMEcho](INFO): UART read:
$PAMTT,200m Mini Altimeter Kit (170kHz)
2020-06-25T21:10:20.306Z,1593119420.306 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:20.718Z,1593119420.718 [AMEcho](INFO): UART read:
$PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc. All Rights Reserved.
2020-06-25T21:10:20.718Z,1593119420.718 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:21.128Z,1593119421.128 [AMEcho](INFO): UART read:
$PAMTT,POST,0,0,0,2,1,,0,0,,,,,,ER0183*46
2020-06-25T21:10:21.128Z,1593119421.128 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:21.535Z,1593119421.535 [AMEcho](INFO): UART read:
$PAMTT,QV,,0,0,,1.807,1.841,,*75
2020-06-25T21:10:21.535Z,1593119421.535 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:21.938Z,1593119421.938 [AMEcho](INFO): UART read:
$PAMTT,QPS,100438,201095-1,4*27
2020-06-25T21:10:21.938Z,1593119421.938 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:22.329Z,1593119422.329 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:22.329Z,1593119422.329 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:22.728Z,1593119422.728 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:22.728Z,1593119422.728 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:23.145Z,1593119423.145 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:23.145Z,1593119423.145 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:23.537Z,1593119423.537 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:23.537Z,1593119423.537 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:23.963Z,1593119423.963 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:23.963Z,1593119423.963 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:24.363Z,1593119424.363 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:24.364Z,1593119424.364 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:24.763Z,1593119424.763 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:24.764Z,1593119424.764 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:25.157Z,1593119425.157 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:25.157Z,1593119425.157 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:25.570Z,1593119425.570 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:25.571Z,1593119425.571 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:25.975Z,1593119425.975 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:25.975Z,1593119425.975 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:26.383Z,1593119426.383 [AMEcho](INFO): UART read:
$SDDBT,,,,,,*45
2020-06-25T21:10:26.383Z,1593119426.383 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:10:27.176Z,1593119427.176 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-06-25T21:10:27.176Z,1593119427.176 [AMEcho] Communications Fault, FailCount= 3
2020-06-25T21:10:27.176Z,1593119427.176 [AMEcho](ERROR): Communications Fault
2020-06-25T21:10:27.281Z,1593119427.281 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-06-25T21:10:27.285Z,1593119427.285 [CBIT](CRITICAL): Communications Fault in component: AMEcho
2020-06-25T21:10:27.741Z,1593119427.741 [AMEcho](INFO): Powering down
2020-06-25T21:10:27.802Z,1593119427.802 [CBIT](INFO): Critical error at 20200625T211027
2020-06-25T21:10:33.244Z,1593119433.244 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:10:48.192Z,1593119448.192 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2020-06-25T21:12:20.339Z,1593119540.339 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-25T21:07:20.1Z
2020-06-25T21:12:20.339Z,1593119540.339 [Default:CheckIn:Read_GPS] Stopped
2020-06-25T21:12:20.339Z,1593119540.339 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-25T21:12:20.743Z,1593119540.743 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-06-25T21:12:27.788Z,1593119547.788 [DataOverHttps](INFO): Sending 94 bytes from file Logs/20200625T210326/Courier0004.lzma
2020-06-25T21:12:28.796Z,1593119548.796 [DataOverHttps](INFO): Moved sent file to Logs/20200625T210326/Courier0004.lzma.bak
2020-06-25T21:12:28.797Z,1593119548.797 [DataOverHttps](INFO): SBD MOMSN=12402404
2020-06-25T21:12:38.913Z,1593119558.913 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-06-25T21:12:38.913Z,1593119558.913 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-25T21:12:38.923Z,1593119558.923 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-25T21:12:39.299Z,1593119559.299 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-25T21:12:39.299Z,1593119559.299 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-06-25T21:12:44.315Z,1593119564.315 [DataOverHttps](INFO): Sending 1242 bytes from file Logs/20200625T210326/Express0001.lzma
2020-06-25T21:12:45.315Z,1593119565.315 [DataOverHttps](INFO): Moved sent file to Logs/20200625T210326/Express0001.lzma.bak
2020-06-25T21:12:45.315Z,1593119565.315 [DataOverHttps](INFO): SBD MOMSN=12402408
2020-06-25T21:13:00.745Z,1593119580.745 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20200625T210326/Express0005.lzma
2020-06-25T21:13:01.747Z,1593119581.747 [DataOverHttps](INFO): Moved sent file to Logs/20200625T210326/Express0005.lzma.bak
2020-06-25T21:13:01.747Z,1593119581.747 [DataOverHttps](INFO): SBD MOMSN=12402450
2020-06-25T21:13:03.146Z,1593119583.146 [Default:CheckIn:Read_Iridium] Stopped
2020-06-25T21:13:03.146Z,1593119583.146 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-25T21:13:03.146Z,1593119583.146 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-25T21:13:27.415Z,1593119607.415 [CBIT](INFO): Clearing failed state for component AMEcho
2020-06-25T21:13:27.416Z,1593119607.416 [AMEcho] No Fault, FailCount= 3
2020-06-25T21:13:37.155Z,1593119617.155 [CommandLine](IMPORTANT): got command restart application
2020-06-25T21:13:38.162Z,1593119618.162 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:38.164Z,1593119618.164 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:38.201Z,1593119618.201 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2020-06-25T21:13:38.201Z,1593119618.201 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:38.202Z,1593119618.202 [CommandLine](INFO): Join timeout helper Thread ID is 3747
2020-06-25T21:13:38.202Z,1593119618.202 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-06-25T21:13:38.202Z,1593119618.202 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:38.203Z,1593119618.203 [NavChartDb](INFO): Join timeout helper Thread ID is 3748
2020-06-25T21:13:38.421Z,1593119618.421 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:38.421Z,1593119618.421 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:38.433Z,1593119618.433 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-06-25T21:13:38.433Z,1593119618.433 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:38.433Z,1593119618.433 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3749
2020-06-25T21:13:38.464Z,1593119618.464 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:38.464Z,1593119618.464 [WetLabsBB2FL](INFO): Powering down
2020-06-25T21:13:38.465Z,1593119618.465 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:38.473Z,1593119618.473 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-06-25T21:13:38.473Z,1593119618.473 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:38.473Z,1593119618.473 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3750
2020-06-25T21:13:39.429Z,1593119619.429 [CTD_Seabird](INFO): Powering down
2020-06-25T21:13:39.441Z,1593119619.441 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:39.441Z,1593119619.441 [CTD_Seabird](INFO): Powering down
2020-06-25T21:13:39.457Z,1593119619.457 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:39.461Z,1593119619.461 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-06-25T21:13:39.461Z,1593119619.461 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:39.462Z,1593119619.462 [Radio_Surface](INFO): Join timeout helper Thread ID is 3751
2020-06-25T21:13:39.701Z,1593119619.701 [Radio_Surface](INFO): Powering down
2020-06-25T21:13:39.702Z,1593119619.702 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:39.702Z,1593119619.702 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:39.706Z,1593119619.706 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-06-25T21:13:39.706Z,1593119619.706 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:39.707Z,1593119619.707 [Onboard](INFO): Join timeout helper Thread ID is 3752
2020-06-25T21:13:40.297Z,1593119620.297 [AMEcho](INFO): UART read:
2020-06-25T21:13:40.297Z,1593119620.297 [AMEcho](ERROR): only read -1 of 2 data items for altitude
2020-06-25T21:13:40.692Z,1593119620.692 [AMEcho](INFO): UART read:
AIRMAR (R) Serial Flash Bootloader
2020-06-25T21:13:40.693Z,1593119620.693 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:13:41.104Z,1593119621.104 [AMEcho](INFO): UART read:
Copyright (C) 2005-2015 AIRMAR Technology Corp.
2020-06-25T21:13:41.104Z,1593119621.104 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:13:41.515Z,1593119621.515 [AMEcho](INFO): UART read:
All rights reserved.
2020-06-25T21:13:41.515Z,1593119621.515 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:13:41.919Z,1593119621.919 [AMEcho](INFO): UART read:
2020-06-25T21:13:41.919Z,1593119621.919 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:13:42.308Z,1593119622.308 [AMEcho](INFO): UART read:
2020-06-25T21:13:42.309Z,1593119622.309 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:13:42.386Z,1593119622.386 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:42.386Z,1593119622.386 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:42.402Z,1593119622.402 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-06-25T21:13:42.402Z,1593119622.402 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:42.402Z,1593119622.402 [DataOverHttps](INFO): Join timeout helper Thread ID is 3753
2020-06-25T21:13:42.720Z,1593119622.720 [AMEcho](INFO): UART read:
2020-06-25T21:13:42.720Z,1593119622.720 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:13:42.769Z,1593119622.769 [CBIT](FAULT): Humidity exceeds 50% of running average: Humidity:2296080 %. Average:236680.875000
2020-06-25T21:13:43.117Z,1593119623.117 [AMEcho](INFO): UART read:
$PAMTT,200m Mini Altimeter Kit (170kHz)
2020-06-25T21:13:43.118Z,1593119623.118 [AMEcho](ERROR): only read 0 of 2 data items for altitude
2020-06-25T21:13:43.329Z,1593119623.329 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:43.332Z,1593119623.332 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:43.338Z,1593119623.338 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-06-25T21:13:43.338Z,1593119623.338 [logger ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:43.339Z,1593119623.339 [logger](INFO): Join timeout helper Thread ID is 3754
2020-06-25T21:13:43.353Z,1593119623.353 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:43.353Z,1593119623.353 [logger ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:43.358Z,1593119623.358 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-06-25T21:13:43.358Z,1593119623.358 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:43.358Z,1593119623.358 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-06-25T21:13:43.358Z,1593119623.358 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:43.358Z,1593119623.358 [controlThread](INFO): Join timeout helper Thread ID is 3755
2020-06-25T21:13:43.505Z,1593119623.505 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-25T21:13:43.505Z,1593119623.505 [controlThread](DEBUG): Uninitializing ControlThread
2020-06-25T21:13:43.506Z,1593119623.506 [AHRS_M2](INFO): Powering down
2020-06-25T21:13:43.578Z,1593119623.578 [NAL9602](INFO): Powering down
2020-06-25T21:13:43.579Z,1593119623.579 [DAT](INFO): Powering down
2020-06-25T21:13:43.865Z,1593119623.865 [AMEcho](INFO): Powering down
2020-06-25T21:13:43.886Z,1593119623.886 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-06-25T21:13:43.887Z,1593119623.887 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-06-25T21:13:43.887Z,1593119623.887 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-06-25T21:13:43.887Z,1593119623.887 [MissionManager](INFO): Uninitializing Mission Default
2020-06-25T21:13:43.888Z,1593119623.888 [Default] Stopped
2020-06-25T21:13:43.888Z,1593119623.888 [Default](DEBUG): Aggregate::uninitialize Default
2020-06-25T21:13:43.888Z,1593119623.888 [Default:B.GoToSurface] Stopped
2020-06-25T21:13:43.888Z,1593119623.888 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-06-25T21:13:43.888Z,1593119623.888 [Default:CheckIn] Stopped
2020-06-25T21:13:43.888Z,1593119623.888 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-25T21:13:43.888Z,1593119623.888 [Default:CheckIn:C.Wait] Stopped
2020-06-25T21:13:43.888Z,1593119623.888 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-25T21:13:43.891Z,1593119623.891 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-06-25T21:13:43.891Z,1593119623.891 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-06-25T21:13:43.891Z,1593119623.891 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-06-25T21:13:43.892Z,1593119623.892 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-06-25T21:13:43.892Z,1593119623.892 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-06-25T21:13:43.892Z,1593119623.892 [BuoyancyServo](INFO): Powering down
2020-06-25T21:13:43.905Z,1593119623.905 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-06-25T21:13:43.905Z,1593119623.905 [ElevatorServo](INFO): Powering down
2020-06-25T21:13:43.906Z,1593119623.906 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-06-25T21:13:43.906Z,1593119623.906 [MassServo](INFO): Powering down
2020-06-25T21:13:43.907Z,1593119623.907 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-06-25T21:13:43.907Z,1593119623.907 [RudderServo](INFO): Powering down
2020-06-25T21:13:43.908Z,1593119623.908 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-06-25T21:13:43.908Z,1593119623.908 [ThrusterServo](INFO): Powering down
2020-06-25T21:13:43.909Z,1593119623.909 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-06-25T21:13:43.909Z,1593119623.909 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-06-25T21:13:43.909Z,1593119623.909 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-06-25T21:13:43.909Z,1593119623.909 [CBIT](DEBUG): Powering off loads.
2020-06-25T21:13:43.921Z,1593119623.921 [CBIT](DEBUG): Disabling WDT.
2020-06-25T21:13:43.933Z,1593119623.933 [CBIT](DEBUG): Opening all GF detection circuits.
2020-06-25T21:13:43.934Z,1593119623.934 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:44.007Z,1593119624.007 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:44.009Z,1593119624.009 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:44.014Z,1593119624.014 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:44.056Z,1593119624.056 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:44.061Z,1593119624.061 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:44.094Z,1593119624.094 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-25T21:13:44.153Z,1593119624.153 [logger ThreadHandler](INFO): Thread cancelled.