2020-10-13T18:51:58.484Z,1602615118.484 [Supervisor](DEBUG): Initializing supervisor.
2020-10-13T18:51:58.487Z,1602615118.487 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-10-13T18:51:58.488Z,1602615118.488 [SyncHandler](INFO): Protected caller Thread ID is 4080
2020-10-13T18:51:58.488Z,1602615118.488 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-10-13T18:51:58.489Z,1602615118.489 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-10-13T18:51:58.490Z,1602615118.490 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4081
2020-10-13T18:51:58.494Z,1602615118.494 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-10-13T18:51:58.508Z,1602615118.508 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-10-13T18:51:58.509Z,1602615118.509 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-10-13T18:51:58.509Z,1602615118.509 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4082
2020-10-13T18:51:58.510Z,1602615118.510 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-10-13T18:51:58.511Z,1602615118.511 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-10-13T18:51:58.511Z,1602615118.511 [logger ThreadHandler](INFO): Protected caller Thread ID is 4083
2020-10-13T18:51:58.513Z,1602615118.513 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-10-13T18:51:58.514Z,1602615118.514 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-10-13T18:51:58.515Z,1602615118.515 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-10-13T18:51:58.785Z,1602615118.785 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-10-13T18:51:58.786Z,1602615118.786 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-10-13T18:51:58.866Z,1602615118.866 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-10-13T18:51:59.304Z,1602615119.304 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-10-13T18:51:59.305Z,1602615119.305 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-10-13T18:51:59.637Z,1602615119.637 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-10-13T18:51:59.637Z,1602615119.637 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-10-13T18:51:59.733Z,1602615119.733 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-10-13T18:51:59.734Z,1602615119.734 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-10-13T18:52:00.031Z,1602615120.031 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-10-13T18:52:00.032Z,1602615120.032 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-10-13T18:52:00.227Z,1602615120.227 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-10-13T18:52:00.227Z,1602615120.227 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-10-13T18:52:00.712Z,1602615120.712 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-10-13T18:52:00.713Z,1602615120.713 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-10-13T18:52:00.816Z,1602615120.816 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-10-13T18:52:00.816Z,1602615120.816 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-10-13T18:52:00.916Z,1602615120.916 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-10-13T18:52:00.917Z,1602615120.917 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-10-13T18:52:01.586Z,1602615121.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-10-13T18:52:01.586Z,1602615121.586 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-10-13T18:52:02.015Z,1602615122.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-10-13T18:52:02.016Z,1602615122.016 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-10-13T18:52:02.442Z,1602615122.442 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-10-13T18:52:02.443Z,1602615122.443 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-10-13T18:52:02.591Z,1602615122.591 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-10-13T18:52:02.591Z,1602615122.591 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-10-13T18:52:02.740Z,1602615122.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-10-13T18:52:02.740Z,1602615122.740 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-10-13T18:52:02.948Z,1602615122.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-10-13T18:52:02.950Z,1602615122.950 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2020-10-13T18:52:02.950Z,1602615122.950 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2020-10-13T18:52:03.040Z,1602615123.040 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2020-10-13T18:52:03.125Z,1602615123.125 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2020-10-13T18:52:03.225Z,1602615123.225 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2020-10-13T18:52:03.308Z,1602615123.308 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2020-10-13T18:52:03.403Z,1602615123.403 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2020-10-13T18:52:03.503Z,1602615123.503 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2020-10-13T18:52:03.712Z,1602615123.712 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2020-10-13T18:52:03.788Z,1602615123.788 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2020-10-13T18:52:03.952Z,1602615123.952 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2020-10-13T18:52:04.098Z,1602615124.098 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2020-10-13T18:52:04.215Z,1602615124.215 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2020-10-13T18:52:04.451Z,1602615124.451 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-10-13T18:52:04.452Z,1602615124.452 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2020-10-13T18:52:04.452Z,1602615124.452 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-10-13T18:52:04.463Z,1602615124.463 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-10-13T18:52:04.529Z,1602615124.529 [VerticalControl](DEBUG): Construct VerticalControl.
2020-10-13T18:52:04.643Z,1602615124.643 [VerticalControl] Loaded
2020-10-13T18:52:04.643Z,1602615124.643 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-10-13T18:52:04.644Z,1602615124.644 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-10-13T18:52:04.725Z,1602615124.725 [HorizontalControl] Loaded
2020-10-13T18:52:04.725Z,1602615124.725 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-10-13T18:52:04.726Z,1602615124.726 [SpeedControl](DEBUG): Construct SpeedControl.
2020-10-13T18:52:04.731Z,1602615124.731 [SpeedControl] Loaded
2020-10-13T18:52:04.731Z,1602615124.731 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-10-13T18:52:04.732Z,1602615124.732 [LoopControl](DEBUG): Construct LoopControl.
2020-10-13T18:52:04.732Z,1602615124.732 [LoopControl] Loaded
2020-10-13T18:52:04.733Z,1602615124.733 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-10-13T18:52:04.733Z,1602615124.733 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-10-13T18:52:04.734Z,1602615124.734 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-10-13T18:52:04.764Z,1602615124.764 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-10-13T18:52:04.764Z,1602615124.764 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-10-13T18:52:04.893Z,1602615124.893 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-10-13T18:52:04.893Z,1602615124.893 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-10-13T18:52:05.042Z,1602615125.042 [BuoyancyServo] Loaded
2020-10-13T18:52:05.042Z,1602615125.042 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-10-13T18:52:05.071Z,1602615125.071 [ElevatorServo] Loaded
2020-10-13T18:52:05.071Z,1602615125.071 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-10-13T18:52:05.099Z,1602615125.099 [MassServo] Loaded
2020-10-13T18:52:05.099Z,1602615125.099 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-10-13T18:52:05.127Z,1602615125.127 [RudderServo] Loaded
2020-10-13T18:52:05.127Z,1602615125.127 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-10-13T18:52:05.154Z,1602615125.154 [ThrusterServo] Loaded
2020-10-13T18:52:05.154Z,1602615125.154 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-10-13T18:52:05.155Z,1602615125.155 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-10-13T18:52:05.155Z,1602615125.155 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-10-13T18:52:05.297Z,1602615125.297 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-10-13T18:52:05.297Z,1602615125.297 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-10-13T18:52:05.318Z,1602615125.318 [NavChart] Loaded
2020-10-13T18:52:05.318Z,1602615125.318 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-10-13T18:52:05.322Z,1602615125.322 [UniversalFixResidualReporter] Loaded
2020-10-13T18:52:05.322Z,1602615125.322 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-10-13T18:52:05.323Z,1602615125.323 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-10-13T18:52:05.323Z,1602615125.323 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-10-13T18:52:05.462Z,1602615125.462 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-10-13T18:52:05.463Z,1602615125.463 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-10-13T18:52:06.026Z,1602615126.026 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-10-13T18:52:06.031Z,1602615126.031 [AHRS_M2](INFO): created writer for : platform_orientation
2020-10-13T18:52:06.033Z,1602615126.033 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-10-13T18:52:06.039Z,1602615126.039 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-10-13T18:52:06.039Z,1602615126.039 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-10-13T18:52:06.044Z,1602615126.044 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-10-13T18:52:06.045Z,1602615126.045 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-10-13T18:52:06.050Z,1602615126.050 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-10-13T18:52:06.232Z,1602615126.232 [AHRS_M2] Loaded
2020-10-13T18:52:06.233Z,1602615126.233 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-10-13T18:52:06.414Z,1602615126.414 [DataOverHttps] Loaded
2020-10-13T18:52:06.414Z,1602615126.414 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-10-13T18:52:06.417Z,1602615126.417 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408A14E0
2020-10-13T18:52:06.418Z,1602615126.418 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4168
2020-10-13T18:52:06.449Z,1602615126.449 [Depth_Keller] Loaded
2020-10-13T18:52:06.449Z,1602615126.449 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-10-13T18:52:06.454Z,1602615126.454 [DropWeight] Loaded
2020-10-13T18:52:06.454Z,1602615126.454 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-10-13T18:52:06.569Z,1602615126.569 [NAL9602] Loaded
2020-10-13T18:52:06.570Z,1602615126.570 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-10-13T18:52:06.619Z,1602615126.619 [Onboard] Loaded
2020-10-13T18:52:06.620Z,1602615126.620 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-10-13T18:52:06.621Z,1602615126.621 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408D14E0
2020-10-13T18:52:06.621Z,1602615126.621 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4169
2020-10-13T18:52:06.642Z,1602615126.642 [Radio_Surface] Loaded
2020-10-13T18:52:06.642Z,1602615126.642 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-10-13T18:52:06.643Z,1602615126.643 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409014E0
2020-10-13T18:52:06.643Z,1602615126.643 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4170
2020-10-13T18:52:08.575Z,1602615128.575 [BPC1] Loaded
2020-10-13T18:52:08.575Z,1602615128.575 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-10-13T18:52:08.608Z,1602615128.608 [AMEcho] Loaded
2020-10-13T18:52:08.609Z,1602615128.609 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2020-10-13T18:52:08.609Z,1602615128.609 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-10-13T18:52:08.610Z,1602615128.610 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-10-13T18:52:08.665Z,1602615128.665 [DepthRateCalculator] Loaded
2020-10-13T18:52:08.666Z,1602615128.666 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-10-13T18:52:08.671Z,1602615128.671 [PitchRateCalculator] Loaded
2020-10-13T18:52:08.671Z,1602615128.671 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-10-13T18:52:08.683Z,1602615128.683 [SpeedCalculator] Loaded
2020-10-13T18:52:08.683Z,1602615128.683 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-10-13T18:52:08.705Z,1602615128.705 [TempGradientCalculator] Loaded
2020-10-13T18:52:08.705Z,1602615128.705 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-10-13T18:52:08.711Z,1602615128.711 [YawRateCalculator] Loaded
2020-10-13T18:52:08.711Z,1602615128.711 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-10-13T18:52:08.741Z,1602615128.741 [ElevatorOffsetCalculator] Loaded
2020-10-13T18:52:08.741Z,1602615128.741 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-10-13T18:52:08.742Z,1602615128.742 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-10-13T18:52:08.742Z,1602615128.742 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-10-13T18:52:09.044Z,1602615129.044 [CANONSampler] Loaded
2020-10-13T18:52:09.044Z,1602615129.044 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2020-10-13T18:52:09.072Z,1602615129.072 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-10-13T18:52:09.078Z,1602615129.078 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-10-13T18:52:09.078Z,1602615129.078 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-10-13T18:52:09.083Z,1602615129.083 [CTD_Seabird](INFO): created writer for : depth
2020-10-13T18:52:09.084Z,1602615129.084 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-10-13T18:52:09.089Z,1602615129.089 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-10-13T18:52:09.089Z,1602615129.089 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-10-13T18:52:09.095Z,1602615129.095 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-10-13T18:52:09.095Z,1602615129.095 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-10-13T18:52:09.100Z,1602615129.100 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-10-13T18:52:09.101Z,1602615129.101 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-10-13T18:52:09.107Z,1602615129.107 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-10-13T18:52:09.107Z,1602615129.107 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-10-13T18:52:09.113Z,1602615129.113 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-10-13T18:52:09.113Z,1602615129.113 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): mass_concentration_of_oxygen_in_sea_water
2020-10-13T18:52:09.119Z,1602615129.119 [CTD_Seabird](INFO): created writer for : mass_concentration_of_oxygen_in_sea_water
2020-10-13T18:52:09.119Z,1602615129.119 [CTD_Seabird](DEBUG): LcmSlateWriter::add(DAtaURI): CTD_Seabird.sea_water_dissolved_oxygen_freq
2020-10-13T18:52:09.120Z,1602615129.120 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): dataName: sea_water_dissolved_oxygen_freq
2020-10-13T18:52:09.153Z,1602615129.153 [CTD_Seabird] Loaded
2020-10-13T18:52:09.153Z,1602615129.153 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-10-13T18:52:09.157Z,1602615129.157 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A0D4E0
2020-10-13T18:52:09.157Z,1602615129.157 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4171
2020-10-13T18:52:09.189Z,1602615129.189 [PAR_Licor] Loaded
2020-10-13T18:52:09.189Z,1602615129.189 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-10-13T18:52:09.211Z,1602615129.211 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-10-13T18:52:09.211Z,1602615129.211 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-10-13T18:52:09.216Z,1602615129.216 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-10-13T18:52:09.216Z,1602615129.216 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-10-13T18:52:09.220Z,1602615129.220 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-10-13T18:52:09.220Z,1602615129.220 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-10-13T18:52:09.225Z,1602615129.225 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-10-13T18:52:09.225Z,1602615129.225 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-10-13T18:52:09.229Z,1602615129.229 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-10-13T18:52:09.229Z,1602615129.229 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-10-13T18:52:09.234Z,1602615129.234 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-10-13T18:52:09.234Z,1602615129.234 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-10-13T18:52:09.238Z,1602615129.238 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-10-13T18:52:09.238Z,1602615129.238 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-10-13T18:52:09.243Z,1602615129.243 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-10-13T18:52:09.248Z,1602615129.248 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-10-13T18:52:09.248Z,1602615129.248 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-10-13T18:52:09.248Z,1602615129.248 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-10-13T18:52:09.253Z,1602615129.253 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-10-13T18:52:09.253Z,1602615129.253 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-10-13T18:52:09.257Z,1602615129.257 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-10-13T18:52:09.257Z,1602615129.257 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-10-13T18:52:09.262Z,1602615129.262 [WetLabsBB2FL] Loaded
2020-10-13T18:52:09.262Z,1602615129.262 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-10-13T18:52:09.263Z,1602615129.263 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A3D4E0
2020-10-13T18:52:09.263Z,1602615129.263 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4172
2020-10-13T18:52:09.264Z,1602615129.264 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-10-13T18:52:09.265Z,1602615129.265 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-10-13T18:52:09.306Z,1602615129.306 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-10-13T18:52:09.307Z,1602615129.307 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-10-13T18:52:09.649Z,1602615129.649 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-10-13T18:52:09.650Z,1602615129.650 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-10-13T18:52:09.815Z,1602615129.815 [SBIT](DEBUG): Construct Startup Built In Test.
2020-10-13T18:52:09.827Z,1602615129.827 [SBIT] Loaded
2020-10-13T18:52:09.827Z,1602615129.827 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-10-13T18:52:09.828Z,1602615129.828 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-10-13T18:52:09.841Z,1602615129.841 [IBIT] Loaded
2020-10-13T18:52:09.841Z,1602615129.841 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-10-13T18:52:09.844Z,1602615129.844 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-10-13T18:52:09.986Z,1602615129.986 [CBIT] Loaded
2020-10-13T18:52:09.986Z,1602615129.986 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-10-13T18:52:09.987Z,1602615129.987 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-10-13T18:52:09.987Z,1602615129.987 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-10-13T18:52:10.087Z,1602615130.087 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-10-13T18:52:10.091Z,1602615130.091 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-10-13T18:52:10.092Z,1602615130.092 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-10-13T18:52:10.100Z,1602615130.100 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-10-13T18:52:10.105Z,1602615130.105 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B634E0
2020-10-13T18:52:10.105Z,1602615130.105 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4173
2020-10-13T18:52:10.110Z,1602615130.110 [Supervisor](INFO): Main Thread ID is 4078
2020-10-13T18:52:10.110Z,1602615130.110 [Supervisor](DEBUG): Running supervisor.
2020-10-13T18:52:10.111Z,1602615130.111 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4174
2020-10-13T18:52:10.114Z,1602615130.114 [controlThread ThreadHandler](INFO): Handler Thread ID is 4175
2020-10-13T18:52:10.114Z,1602615130.114 [controlThread](DEBUG): Initializing ControlThread
2020-10-13T18:52:10.115Z,1602615130.115 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-10-13T18:52:10.117Z,1602615130.117 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-10-13T18:52:10.117Z,1602615130.117 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-10-13T18:52:10.118Z,1602615130.118 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-10-13T18:52:10.120Z,1602615130.120 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-10-13T18:52:10.120Z,1602615130.120 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-10-13T18:52:10.127Z,1602615130.127 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-10-13T18:52:10.127Z,1602615130.127 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-10-13T18:52:10.127Z,1602615130.127 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-10-13T18:52:10.128Z,1602615130.128 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-10-13T18:52:10.128Z,1602615130.128 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-10-13T18:52:10.129Z,1602615130.129 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-10-13T18:52:10.133Z,1602615130.133 [SBIT](INFO): Initialize SBIT Component.
2020-10-13T18:52:10.134Z,1602615130.134 [SBIT](IMPORTANT): git: 2020-08-31-8-g854e668
2020-10-13T18:52:10.134Z,1602615130.134 [SBIT](INFO): git hash: 854e6687b208db53e020f4ee03a001432cc94599
2020-10-13T18:52:10.134Z,1602615130.134 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-10-13T18:52:10.135Z,1602615130.135 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Nov 13 12:38:10 PST 2019
2020-10-13T18:52:10.136Z,1602615130.136 [SBIT](INFO): Beginning SBIT in 68.000000 seconds.
2020-10-13T18:52:10.137Z,1602615130.137 [logger ThreadHandler](INFO): Handler Thread ID is 4176
2020-10-13T18:52:10.153Z,1602615130.153 [IBIT](INFO): Initialize IBIT Component.
2020-10-13T18:52:10.154Z,1602615130.154 [CBIT](DEBUG): Initialize CBIT Component.
2020-10-13T18:52:10.161Z,1602615130.161 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4177
2020-10-13T18:52:10.162Z,1602615130.162 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-10-13T18:52:10.165Z,1602615130.165 [CBIT](DEBUG): Initialized mux pins.
2020-10-13T18:52:10.165Z,1602615130.165 [CBIT](DEBUG): Initializing the watchdog timer.
2020-10-13T18:52:10.173Z,1602615130.173 [Onboard ThreadHandler](INFO): Handler Thread ID is 4178
2020-10-13T18:52:10.189Z,1602615130.189 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-10-13T18:52:10.189Z,1602615130.189 [CBIT](DEBUG): Initializing heartbeat.
2020-10-13T18:52:10.191Z,1602615130.191 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4179
2020-10-13T18:52:10.213Z,1602615130.213 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4180
2020-10-13T18:52:10.214Z,1602615130.214 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-10-13T18:52:10.218Z,1602615130.218 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4182
2020-10-13T18:52:10.219Z,1602615130.219 [WetLabsBB2FL](INFO): Powering down
2020-10-13T18:52:10.261Z,1602615130.261 [CBIT](DEBUG): Deactivating GF circuits.
2020-10-13T18:52:10.261Z,1602615130.261 [CBIT](DEBUG): Deactivating emergency mode.
2020-10-13T18:52:10.297Z,1602615130.297 [CBIT](DEBUG): Backplane powered.
2020-10-13T18:52:10.298Z,1602615130.298 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-10-13T18:52:10.352Z,1602615130.352 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-10-13T18:52:10.357Z,1602615130.357 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4183
2020-10-13T18:52:10.476Z,1602615130.476 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-10-13T18:52:10.476Z,1602615130.476 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-10-13T18:52:10.477Z,1602615130.477 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-10-13T18:52:10.477Z,1602615130.477 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-10-13T18:52:10.477Z,1602615130.477 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-10-13T18:52:10.477Z,1602615130.477 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-10-13T18:52:10.477Z,1602615130.477 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-10-13T18:52:10.478Z,1602615130.478 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-10-13T18:52:10.478Z,1602615130.478 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-10-13T18:52:10.478Z,1602615130.478 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-10-13T18:52:10.478Z,1602615130.478 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-10-13T18:52:10.478Z,1602615130.478 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-10-13T18:52:10.479Z,1602615130.479 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-10-13T18:52:10.479Z,1602615130.479 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-10-13T18:52:10.479Z,1602615130.479 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-10-13T18:52:10.479Z,1602615130.479 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-10-13T18:52:10.481Z,1602615130.481 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2020-10-13T18:52:10.489Z,1602615130.489 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-10-13T18:52:10.597Z,1602615130.597 [Radio_Surface](INFO): Powering up
2020-10-13T18:52:10.608Z,1602615130.608 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-10-13T18:52:10.609Z,1602615130.609 [Default:A.Wait](DEBUG): Construct Wait.
2020-10-13T18:52:10.611Z,1602615130.611 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-10-13T18:52:10.688Z,1602615130.688 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-10-13T18:52:10.691Z,1602615130.691 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-10-13T18:52:10.717Z,1602615130.717 [Default:E.Execute](DEBUG): Construct Execute.
2020-10-13T18:52:10.755Z,1602615130.755 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2020-10-13T18:52:10.769Z,1602615130.769 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,BPC1,AMEcho,CANONSampler,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-10-13T18:52:10.777Z,1602615130.777 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-10-13T18:52:10.890Z,1602615130.890 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2020-10-13T18:52:10.917Z,1602615130.917 [AMEcho](INFO): Powering up
2020-10-13T18:52:10.937Z,1602615130.937 [CANONSampler](INFO): Powering down
2020-10-13T18:52:10.969Z,1602615130.969 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-10-13T18:52:11.016Z,1602615131.016 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:52:11.021Z,1602615131.021 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-10-13T18:52:11.022Z,1602615131.022 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:52:11.033Z,1602615131.033 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-10-13T18:52:11.034Z,1602615131.034 [MassServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:52:11.041Z,1602615131.041 [MassServo](DEBUG): Initializing MassServo.
2020-10-13T18:52:11.042Z,1602615131.042 [RudderServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:52:11.049Z,1602615131.049 [RudderServo](DEBUG): Initializing RudderServo.
2020-10-13T18:52:11.050Z,1602615131.050 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:52:11.057Z,1602615131.057 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:52:11.365Z,1602615131.365 [AMEcho](INFO): Powering down
2020-10-13T18:52:11.913Z,1602615131.913 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-10-13T18:52:11.913Z,1602615131.913 [RudderServo](FAULT): Rudder failed to initialize
2020-10-13T18:52:11.913Z,1602615131.913 [RudderServo] Communications Fault, FailCount= 1
2020-10-13T18:52:11.913Z,1602615131.913 [RudderServo](ERROR): Communications Fault
2020-10-13T18:52:12.013Z,1602615132.013 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-10-13T18:52:12.220Z,1602615132.220 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-10-13T18:52:12.223Z,1602615132.223 [RudderServo](INFO): Powering down
2020-10-13T18:52:12.871Z,1602615132.871 [RudderServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:52:12.994Z,1602615132.994 [RudderServo](DEBUG): Initializing RudderServo.
2020-10-13T18:52:12.998Z,1602615132.998 [CBIT](INFO): Clearing failed state for component RudderServo
2020-10-13T18:52:12.998Z,1602615132.998 [RudderServo] No Fault, FailCount= 1
2020-10-13T18:52:14.537Z,1602615134.537 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:14.686Z,1602615134.686 [ThrusterServo](INFO): Sent FORWARD direction
2020-10-13T18:52:14.941Z,1602615134.941 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:15.581Z,1602615135.581 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:16.053Z,1602615136.053 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:16.473Z,1602615136.473 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:17.065Z,1602615137.065 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:17.517Z,1602615137.517 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:18.021Z,1602615138.021 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:18.525Z,1602615138.525 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:19.021Z,1602615139.021 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:19.505Z,1602615139.505 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:19.977Z,1602615139.977 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:20.477Z,1602615140.477 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:20.957Z,1602615140.957 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:21.433Z,1602615141.433 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:21.929Z,1602615141.929 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:22.409Z,1602615142.409 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:22.877Z,1602615142.877 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:23.265Z,1602615143.265 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-10-13T18:52:23.265Z,1602615143.265 [CTD_Seabird] Communications Fault, FailCount= 1
2020-10-13T18:52:23.265Z,1602615143.265 [CTD_Seabird](ERROR): Communications Fault
2020-10-13T18:52:23.357Z,1602615143.357 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:23.489Z,1602615143.489 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-10-13T18:52:23.664Z,1602615143.664 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005410
2020-10-13T18:52:23.669Z,1602615143.669 [CTD_Seabird](INFO): Powering down
2020-10-13T18:52:23.809Z,1602615143.809 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:23.809Z,1602615143.809 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-10-13T18:52:23.809Z,1602615143.809 [AHRS_M2] Communications Fault, FailCount= 1
2020-10-13T18:52:23.809Z,1602615143.809 [AHRS_M2](ERROR): Communications Fault
2020-10-13T18:52:23.965Z,1602615143.965 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-10-13T18:52:23.970Z,1602615143.970 [AHRS_M2](INFO): Powering down
2020-10-13T18:52:24.829Z,1602615144.829 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-10-13T18:52:24.829Z,1602615144.829 [AHRS_M2] No Fault, FailCount= 1
2020-10-13T18:52:24.830Z,1602615144.830 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-10-13T18:52:24.830Z,1602615144.830 [CTD_Seabird] No Fault, FailCount= 1
2020-10-13T18:52:25.013Z,1602615145.013 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-10-13T18:52:25.181Z,1602615145.181 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-10-13T18:52:28.737Z,1602615148.737 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:29.137Z,1602615149.137 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:29.541Z,1602615149.541 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:29.965Z,1602615149.965 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:30.385Z,1602615150.385 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:30.801Z,1602615150.801 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:31.213Z,1602615151.213 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:31.617Z,1602615151.617 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:32.109Z,1602615152.109 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:32.509Z,1602615152.509 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:32.921Z,1602615152.921 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:33.369Z,1602615153.369 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:33.801Z,1602615153.801 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:34.225Z,1602615154.225 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:34.649Z,1602615154.649 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:35.069Z,1602615155.069 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:35.465Z,1602615155.465 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:35.881Z,1602615155.881 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:36.317Z,1602615156.317 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:36.733Z,1602615156.733 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:36.738Z,1602615156.738 [NAL9602](INFO): Powering up NAL9602
2020-10-13T18:52:37.149Z,1602615157.149 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:37.553Z,1602615157.553 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:37.981Z,1602615157.981 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:38.397Z,1602615158.397 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:38.397Z,1602615158.397 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-10-13T18:52:38.397Z,1602615158.397 [AHRS_M2] Communications Fault, FailCount= 2
2020-10-13T18:52:38.397Z,1602615158.397 [AHRS_M2](ERROR): Communications Fault
2020-10-13T18:52:38.482Z,1602615158.482 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-10-13T18:52:38.487Z,1602615158.487 [AHRS_M2](INFO): Powering down
2020-10-13T18:52:39.069Z,1602615159.069 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-10-13T18:52:39.069Z,1602615159.069 [CTD_Seabird] Communications Fault, FailCount= 2
2020-10-13T18:52:39.069Z,1602615159.069 [CTD_Seabird](ERROR): Communications Fault
2020-10-13T18:52:39.365Z,1602615159.365 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-10-13T18:52:39.365Z,1602615159.365 [AHRS_M2] No Fault, FailCount= 2
2020-10-13T18:52:39.366Z,1602615159.366 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-10-13T18:52:39.473Z,1602615159.473 [CTD_Seabird](INFO): Powering down
2020-10-13T18:52:39.696Z,1602615159.696 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-10-13T18:52:40.580Z,1602615160.580 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-10-13T18:52:40.580Z,1602615160.580 [CTD_Seabird] No Fault, FailCount= 2
2020-10-13T18:52:40.817Z,1602615160.817 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-10-13T18:52:43.253Z,1602615163.253 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:43.685Z,1602615163.685 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:44.121Z,1602615164.121 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:44.549Z,1602615164.549 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:44.953Z,1602615164.953 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:45.389Z,1602615165.389 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:45.829Z,1602615165.829 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:46.273Z,1602615166.273 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:46.689Z,1602615166.689 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:47.109Z,1602615167.109 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:47.521Z,1602615167.521 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:47.977Z,1602615167.977 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:47.983Z,1602615167.983 [NAL9602](INFO): NAL9602 initialized
2020-10-13T18:52:48.485Z,1602615168.485 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:48.921Z,1602615168.921 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:49.337Z,1602615169.337 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:49.757Z,1602615169.757 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:50.169Z,1602615170.169 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:50.597Z,1602615170.597 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:50.981Z,1602615170.981 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:51.393Z,1602615171.393 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:51.797Z,1602615171.797 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:52.209Z,1602615172.209 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:52.629Z,1602615172.629 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:52.629Z,1602615172.629 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-10-13T18:52:52.629Z,1602615172.629 [AHRS_M2] Communications Fault, FailCount= 3
2020-10-13T18:52:52.629Z,1602615172.629 [AHRS_M2](ERROR): Communications Fault
2020-10-13T18:52:52.715Z,1602615172.715 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-10-13T18:52:52.724Z,1602615172.724 [AHRS_M2](INFO): Powering down
2020-10-13T18:52:53.589Z,1602615173.589 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-10-13T18:52:53.589Z,1602615173.589 [AHRS_M2] No Fault, FailCount= 3
2020-10-13T18:52:53.869Z,1602615173.869 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-10-13T18:52:53.870Z,1602615173.870 [CTD_Seabird] Communications Fault, FailCount= 3
2020-10-13T18:52:53.870Z,1602615173.870 [CTD_Seabird](ERROR): Communications Fault
2020-10-13T18:52:53.929Z,1602615173.929 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-10-13T18:52:54.041Z,1602615174.041 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-10-13T18:52:54.041Z,1602615174.041 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2020-10-13T18:52:54.273Z,1602615174.273 [CTD_Seabird](INFO): Powering down
2020-10-13T18:52:57.481Z,1602615177.481 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:57.897Z,1602615177.897 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:58.297Z,1602615178.297 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:58.701Z,1602615178.701 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:59.105Z,1602615179.105 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:59.513Z,1602615179.513 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:52:59.917Z,1602615179.917 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:00.317Z,1602615180.317 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:00.721Z,1602615180.721 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:00.750Z,1602615180.750 [CommandLine](IMPORTANT): got command show variable prop
2020-10-13T18:53:00.853Z,1602615180.853 [CommandLine](IMPORTANT): platform_propeller_rotation_rate (radian_per_second)
2020-10-13T18:53:00.860Z,1602615180.860 [CommandLine](IMPORTANT): Config/Simulator.designPropEff (none)
2020-10-13T18:53:00.876Z,1602615180.876 [CommandLine](IMPORTANT): SpeedControl.propPitch (meter_per_radian)
2020-10-13T18:53:00.959Z,1602615180.959 [CommandLine](IMPORTANT): SpeedControl.propOmegaAction (radian_per_second)
2020-10-13T18:53:00.973Z,1602615180.973 [CommandLine](IMPORTANT): ThrusterServo.platform_propeller_rotation_rate (radian_per_second)
2020-10-13T18:53:01.189Z,1602615181.189 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:01.593Z,1602615181.593 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:02.005Z,1602615182.005 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:02.417Z,1602615182.417 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:02.813Z,1602615182.813 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:03.213Z,1602615183.213 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:03.613Z,1602615183.613 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:04.029Z,1602615184.029 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:04.421Z,1602615184.421 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:04.821Z,1602615184.821 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:05.226Z,1602615185.226 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:05.653Z,1602615185.653 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:06.065Z,1602615186.065 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:06.449Z,1602615186.449 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:06.873Z,1602615186.873 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:06.873Z,1602615186.873 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-10-13T18:53:06.873Z,1602615186.873 [AHRS_M2] Communications Fault, FailCount= 4
2020-10-13T18:53:06.873Z,1602615186.873 [AHRS_M2](ERROR): Communications Fault
2020-10-13T18:53:06.969Z,1602615186.969 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-10-13T18:53:06.974Z,1602615186.974 [AHRS_M2](INFO): Powering down
2020-10-13T18:53:07.824Z,1602615187.824 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-10-13T18:53:07.825Z,1602615187.825 [AHRS_M2] No Fault, FailCount= 4
2020-10-13T18:53:08.185Z,1602615188.185 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-10-13T18:53:10.589Z,1602615190.589 [CommandLine](IMPORTANT): got command report mod ThrusterServo.platform_propeller_rotation_rate
2020-10-13T18:53:10.649Z,1602615190.649 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 0.000000 rad/s
2020-10-13T18:53:11.741Z,1602615191.741 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:12.153Z,1602615192.153 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:12.557Z,1602615192.557 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:12.949Z,1602615192.949 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:13.357Z,1602615193.357 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:13.785Z,1602615193.785 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:14.177Z,1602615194.177 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:14.593Z,1602615194.593 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:14.985Z,1602615194.985 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:15.393Z,1602615195.393 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:15.801Z,1602615195.801 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:16.221Z,1602615196.221 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:16.633Z,1602615196.633 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:17.017Z,1602615197.017 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:17.421Z,1602615197.421 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:17.825Z,1602615197.825 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:18.245Z,1602615198.245 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:18.677Z,1602615198.677 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:18.734Z,1602615198.734 [SBIT](IMPORTANT): Beginning Startup BIT
2020-10-13T18:53:18.770Z,1602615198.770 [CBIT](IMPORTANT): Beginning ground fault scan
2020-10-13T18:53:19.093Z,1602615199.093 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2020-10-13T18:53:20.561Z,1602615200.561 [CommandLine](IMPORTANT): got command maintain control SpeedControl.propOmegaAction -150.000000 revolution_per_minute
2020-10-13T18:53:20.562Z,1602615200.562 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread.
2020-10-13T18:53:20.619Z,1602615200.619 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,BPC1,AMEcho,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-10-13T18:53:21.265Z,1602615201.265 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-10-13T18:53:21.265Z,1602615201.265 [AHRS_M2] Communications Fault, FailCount= 5
2020-10-13T18:53:21.265Z,1602615201.265 [AHRS_M2](ERROR): Communications Fault
2020-10-13T18:53:21.385Z,1602615201.385 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-10-13T18:53:21.386Z,1602615201.386 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2020-10-13T18:53:21.641Z,1602615201.641 [AHRS_M2](INFO): Powering down
2020-10-13T18:53:21.855Z,1602615201.855 [CommandLine](FAULT): Scheduling is paused
2020-10-13T18:53:21.856Z,1602615201.856 [CBIT](INFO): Critical error at 20201013T185321
2020-10-13T18:53:21.856Z,1602615201.856 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-10-13T18:53:22.297Z,1602615202.297 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:22.297Z,1602615202.297 [ThrusterServo](FAULT): Thruster reporting ready to receive command while a command should still be executing. Uninitializing and Re-Initializing.

2020-10-13T18:53:22.297Z,1602615202.297 [ThrusterServo] Hardware Fault, FailCount= 1
2020-10-13T18:53:22.297Z,1602615202.297 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:53:22.301Z,1602615202.301 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:53:22.303Z,1602615202.303 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:53:22.538Z,1602615202.538 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:53:22.538Z,1602615202.538 [ThrusterServo](INFO): Powering down
2020-10-13T18:53:23.378Z,1602615203.378 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:53:23.498Z,1602615203.498 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:53:23.502Z,1602615203.502 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-10-13T18:53:23.502Z,1602615203.502 [ThrusterServo] No Fault, FailCount= 1
2020-10-13T18:53:26.158Z,1602615206.158 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 0.000000 rad/s
2020-10-13T18:53:26.546Z,1602615206.546 [ThrusterServo](INFO): POWER CYCLE
2020-10-13T18:53:27.746Z,1602615207.746 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:53:28.173Z,1602615208.173 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:28.174Z,1602615208.174 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:28.203Z,1602615208.203 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:53:28.577Z,1602615208.577 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:28.578Z,1602615208.578 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:28.965Z,1602615208.965 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:28.966Z,1602615208.966 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:29.361Z,1602615209.361 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:29.362Z,1602615209.362 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:29.370Z,1602615209.370 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.016468
CHAN A1 (24V): -0.180818
CHAN A2 (12V): -0.002480
CHAN A3 (5V): -0.001751
CHAN B0 (3.3V): -0.000316
CHAN B1 (3.15aV): -0.000178
CHAN B2 (3.15bV): -0.000143
CHAN B3 (GND): -0.000091
OPEN: -0.000345
Full Scale Calc: 4.765 mA, -1.589 mA
2020-10-13T18:53:29.781Z,1602615209.781 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:29.782Z,1602615209.782 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:30.171Z,1602615210.171 [ThrusterServo](FAULT): Overload Error
2020-10-13T18:53:30.171Z,1602615210.171 [ThrusterServo] Hardware Fault, FailCount= 2
2020-10-13T18:53:30.171Z,1602615210.171 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:53:30.171Z,1602615210.171 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:30.176Z,1602615210.176 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:53:30.177Z,1602615210.177 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:53:30.558Z,1602615210.558 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:53:30.558Z,1602615210.558 [ThrusterServo](INFO): Powering down
2020-10-13T18:53:31.366Z,1602615211.366 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:53:31.486Z,1602615211.486 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:53:31.490Z,1602615211.490 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-10-13T18:53:31.490Z,1602615211.490 [ThrusterServo] No Fault, FailCount= 2
2020-10-13T18:53:34.311Z,1602615214.311 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:53:34.690Z,1602615214.690 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:53:35.109Z,1602615215.109 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:35.110Z,1602615215.110 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:35.517Z,1602615215.517 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:35.518Z,1602615215.518 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:35.913Z,1602615215.913 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:35.914Z,1602615215.914 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:36.329Z,1602615216.329 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:36.330Z,1602615216.330 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:36.723Z,1602615216.723 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:36.724Z,1602615216.724 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:37.129Z,1602615217.129 [ThrusterServo](FAULT): Overload Error
2020-10-13T18:53:37.129Z,1602615217.129 [ThrusterServo] Hardware Fault, FailCount= 3
2020-10-13T18:53:37.129Z,1602615217.129 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:53:37.129Z,1602615217.129 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:37.133Z,1602615217.133 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:53:37.134Z,1602615217.134 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:53:37.498Z,1602615217.498 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:53:37.498Z,1602615217.498 [ThrusterServo](INFO): Powering down
2020-10-13T18:53:38.338Z,1602615218.338 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:53:38.458Z,1602615218.458 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:53:38.462Z,1602615218.462 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-10-13T18:53:38.462Z,1602615218.462 [ThrusterServo] No Fault, FailCount= 3
2020-10-13T18:53:41.490Z,1602615221.490 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:53:41.902Z,1602615221.902 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:53:42.325Z,1602615222.325 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:42.326Z,1602615222.326 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:42.728Z,1602615222.728 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:42.729Z,1602615222.729 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:43.153Z,1602615223.153 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:43.154Z,1602615223.154 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:43.550Z,1602615223.550 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:43.551Z,1602615223.551 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:43.961Z,1602615223.961 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:43.962Z,1602615223.962 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:53:44.373Z,1602615224.373 [ThrusterServo](FAULT): Overload Error
2020-10-13T18:53:44.373Z,1602615224.373 [ThrusterServo] Hardware Fault, FailCount= 4
2020-10-13T18:53:44.373Z,1602615224.373 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:53:44.373Z,1602615224.373 [ThrusterServo](INFO): CHECKING
2020-10-13T18:53:44.377Z,1602615224.377 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:53:44.378Z,1602615224.378 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:53:44.746Z,1602615224.746 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:53:44.746Z,1602615224.746 [ThrusterServo](INFO): Powering down
2020-10-13T18:53:45.694Z,1602615225.694 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:53:45.814Z,1602615225.814 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:53:45.819Z,1602615225.819 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-10-13T18:53:45.819Z,1602615225.819 [ThrusterServo] No Fault, FailCount= 4
2020-10-13T18:53:48.399Z,1602615228.399 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:53:48.788Z,1602615228.788 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:53:48.830Z,1602615228.830 [CommandLine](IMPORTANT): got command failComponent hardware ThrusterServo
2020-10-13T18:53:48.830Z,1602615228.830 [ThrusterServo] Hardware Fault, FailCount= 5
2020-10-13T18:53:48.830Z,1602615228.830 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:53:48.831Z,1602615228.831 [CommandLine](IMPORTANT): ThrusterServo failureMode is Hardware Fault
2020-10-13T18:53:49.182Z,1602615229.182 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:53:49.182Z,1602615229.182 [ThrusterServo](INFO): Powering down
2020-10-13T18:53:49.186Z,1602615229.186 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:53:49.187Z,1602615229.187 [CBIT](CRITICAL): Hardware Fault in component: ThrusterServo
2020-10-13T18:53:49.188Z,1602615229.188 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:53:49.590Z,1602615229.590 [CBIT](INFO): Critical error at 20201013T185349
2020-10-13T18:53:50.058Z,1602615230.058 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:53:50.178Z,1602615230.178 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:53:58.870Z,1602615238.870 [CommandLine](IMPORTANT): got command failComponent none ThrusterServo
2020-10-13T18:53:58.870Z,1602615238.870 [ThrusterServo] No Fault, FailCount= 5
2020-10-13T18:53:58.870Z,1602615238.870 [CommandLine](IMPORTANT): ThrusterServo failureMode is No Fault
2020-10-13T18:54:01.350Z,1602615241.350 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:54:01.759Z,1602615241.759 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:54:02.169Z,1602615242.169 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:02.170Z,1602615242.170 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:54:02.595Z,1602615242.595 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:02.596Z,1602615242.596 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:54:02.993Z,1602615242.993 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:02.994Z,1602615242.994 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:54:03.465Z,1602615243.465 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:03.466Z,1602615243.466 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:54:03.973Z,1602615243.973 [ThrusterServo](FAULT): Overload Error
2020-10-13T18:54:03.973Z,1602615243.973 [ThrusterServo] Hardware Fault, FailCount= 6
2020-10-13T18:54:03.973Z,1602615243.973 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:54:03.973Z,1602615243.973 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:03.977Z,1602615243.977 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:54:03.978Z,1602615243.978 [CBIT](CRITICAL): Hardware Fault in component: ThrusterServo
2020-10-13T18:54:03.979Z,1602615243.979 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:54:04.130Z,1602615244.130 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:54:04.130Z,1602615244.130 [ThrusterServo](INFO): Powering down
2020-10-13T18:54:04.132Z,1602615244.132 [CBIT](INFO): Critical error at 20201013T185403
2020-10-13T18:54:04.926Z,1602615244.926 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:54:05.043Z,1602615245.043 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:54:10.164Z,1602615250.164 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-10-13T18:54:10.164Z,1602615250.164 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-10-13T18:54:10.164Z,1602615250.164 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-13T18:54:10.230Z,1602615250.230 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-13T18:54:10.677Z,1602615250.677 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-13T18:54:10.677Z,1602615250.677 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-10-13T18:54:12.039Z,1602615252.039 [CommandLine](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 150.000000 revolution_per_minute
2020-10-13T18:54:12.587Z,1602615252.587 [SBIT](IMPORTANT): SBIT PASSED
2020-10-13T18:54:12.587Z,1602615252.587 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-10-13T18:54:12.588Z,1602615252.588 [SBIT](IMPORTANT): AMEcho.enabled=1 bool;

2020-10-13T18:54:12.588Z,1602615252.588 [SBIT](IMPORTANT): ElevatorOffsetCalculator.loadAtStartup=1 bool;

2020-10-13T18:54:12.589Z,1602615252.589 [SBIT](IMPORTANT): Express linearApproximation AMEcho.altitude 1.000000 meter;

2020-10-13T18:54:12.589Z,1602615252.589 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 1.000000 meter;

2020-10-13T18:54:12.589Z,1602615252.589 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=315.128269 cubic_centimeter;

2020-10-13T18:54:12.589Z,1602615252.589 [SBIT](IMPORTANT): VerticalControl.massDefault=-12.025033 millimeter;

2020-10-13T18:54:12.990Z,1602615252.990 [MissionManager](IMPORTANT): Started mission Startup
2020-10-13T18:54:12.990Z,1602615252.990 [Startup] Running Loop=1
2020-10-13T18:54:12.990Z,1602615252.990 [Startup](DEBUG): Aggregate::initialize Startup
2020-10-13T18:54:12.990Z,1602615252.990 [Startup:A.GoToSurface] Running Loop=1
2020-10-13T18:54:12.990Z,1602615252.990 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-10-13T18:54:12.991Z,1602615252.991 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-10-13T18:54:12.991Z,1602615252.991 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-10-13T18:54:12.992Z,1602615252.992 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-10-13T18:54:12.992Z,1602615252.992 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-10-13T18:54:12.992Z,1602615252.992 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-10-13T18:54:12.994Z,1602615252.994 [Startup:StartupSatComms] Running Loop=1
2020-10-13T18:54:12.994Z,1602615252.994 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-10-13T18:54:12.994Z,1602615252.994 [Startup:StartupSatComms:A] Running Loop=1
2020-10-13T18:54:13.394Z,1602615253.394 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-10-13T18:54:13.767Z,1602615253.767 [AMEcho](INFO): Powering up
2020-10-13T18:54:14.594Z,1602615254.594 [CommandLine](IMPORTANT): got command failComponent
2020-10-13T18:54:14.594Z,1602615254.594 [CommandLine](IMPORTANT): Failed components:
2020-10-13T18:54:14.594Z,1602615254.594 [CommandLine](IMPORTANT): ThrusterServo: Hardware Fault
2020-10-13T18:54:14.594Z,1602615254.594 [CommandLine](IMPORTANT): AHRS_M2: Communications Fault
2020-10-13T18:54:14.594Z,1602615254.594 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault
2020-10-13T18:54:18.327Z,1602615258.327 [CommandLine](IMPORTANT): got command failComponent none ThrusterServo
2020-10-13T18:54:18.327Z,1602615258.327 [ThrusterServo] No Fault, FailCount= 6
2020-10-13T18:54:18.327Z,1602615258.327 [CommandLine](IMPORTANT): ThrusterServo failureMode is No Fault
2020-10-13T18:54:20.685Z,1602615260.685 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:54:21.068Z,1602615261.068 [ThrusterServo](INFO): POWER CYCLE
2020-10-13T18:54:21.192Z,1602615261.192 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 0.000000 rad/s
2020-10-13T18:54:22.670Z,1602615262.670 [ThrusterServo](INFO): Sent FORWARD direction
2020-10-13T18:54:23.101Z,1602615263.101 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:23.102Z,1602615263.102 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:23.107Z,1602615263.107 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:54:23.513Z,1602615263.513 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:23.514Z,1602615263.514 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:23.909Z,1602615263.909 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:23.910Z,1602615263.910 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:24.325Z,1602615264.325 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:24.326Z,1602615264.326 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:24.717Z,1602615264.717 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:24.718Z,1602615264.718 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:25.189Z,1602615265.189 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:25.190Z,1602615265.190 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:25.625Z,1602615265.625 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:25.626Z,1602615265.626 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:25.981Z,1602615265.981 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:25.982Z,1602615265.982 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:26.377Z,1602615266.377 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:26.378Z,1602615266.378 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:26.753Z,1602615266.753 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:26.754Z,1602615266.754 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:27.096Z,1602615267.096 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-10-13T18:54:27.096Z,1602615267.096 [AMEcho] Communications Fault, FailCount= 1
2020-10-13T18:54:27.096Z,1602615267.096 [AMEcho](ERROR): Communications Fault
2020-10-13T18:54:27.140Z,1602615267.140 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:27.157Z,1602615267.157 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:27.161Z,1602615267.161 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-10-13T18:54:27.673Z,1602615267.673 [AMEcho](INFO): Powering down
2020-10-13T18:54:27.729Z,1602615267.729 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:27.730Z,1602615267.730 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:27.957Z,1602615267.957 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:27.958Z,1602615267.958 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:28.345Z,1602615268.345 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:28.346Z,1602615268.346 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:28.350Z,1602615268.350 [CBIT](INFO): Clearing failed state for component AMEcho
2020-10-13T18:54:28.350Z,1602615268.350 [AMEcho] No Fault, FailCount= 1
2020-10-13T18:54:28.711Z,1602615268.711 [AMEcho](INFO): Powering up
2020-10-13T18:54:28.769Z,1602615268.769 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:28.770Z,1602615268.770 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:29.153Z,1602615269.153 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:29.154Z,1602615269.154 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:29.569Z,1602615269.569 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:29.570Z,1602615269.570 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:29.964Z,1602615269.964 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:29.965Z,1602615269.965 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:30.381Z,1602615270.381 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:30.382Z,1602615270.382 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:30.793Z,1602615270.793 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:30.794Z,1602615270.794 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:31.193Z,1602615271.193 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:31.194Z,1602615271.194 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:31.628Z,1602615271.628 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:31.628Z,1602615271.628 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:31.989Z,1602615271.989 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:31.990Z,1602615271.990 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:32.397Z,1602615272.397 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:32.398Z,1602615272.398 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:32.789Z,1602615272.789 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:32.790Z,1602615272.790 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:33.197Z,1602615273.197 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:33.198Z,1602615273.198 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:33.617Z,1602615273.617 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:33.618Z,1602615273.618 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:34.009Z,1602615274.009 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:34.010Z,1602615274.010 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:34.421Z,1602615274.421 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:34.422Z,1602615274.422 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:34.817Z,1602615274.817 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:34.818Z,1602615274.818 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:35.225Z,1602615275.225 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:35.226Z,1602615275.226 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:35.649Z,1602615275.649 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:35.650Z,1602615275.650 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:36.049Z,1602615276.049 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:36.050Z,1602615276.050 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:36.481Z,1602615276.481 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:36.482Z,1602615276.482 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:36.885Z,1602615276.885 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:36.886Z,1602615276.886 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:37.253Z,1602615277.253 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:37.254Z,1602615277.254 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:37.657Z,1602615277.657 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:37.658Z,1602615277.658 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:38.046Z,1602615278.046 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:38.046Z,1602615278.046 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:38.515Z,1602615278.515 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:38.515Z,1602615278.515 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:38.934Z,1602615278.934 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:38.934Z,1602615278.934 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:39.218Z,1602615279.218 [BPC1](ERROR): BPC1A: No match for serial number 0001 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2020-10-13T18:54:39.301Z,1602615279.301 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:39.302Z,1602615279.302 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:39.693Z,1602615279.693 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:39.694Z,1602615279.694 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:39.797Z,1602615279.797 [CommandLine](IMPORTANT): got command maintain clear
2020-10-13T18:54:40.089Z,1602615280.089 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:40.090Z,1602615280.090 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:2621.439697
2020-10-13T18:54:40.099Z,1602615280.099 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,BPC1,AMEcho,CANONSampler,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-10-13T18:54:40.481Z,1602615280.481 [ThrusterServo](INFO): CHECKING
2020-10-13T18:54:40.482Z,1602615280.482 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:0.000000
2020-10-13T18:54:40.994Z,1602615280.994 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 0.000000 rad/s
2020-10-13T18:54:42.054Z,1602615282.054 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-10-13T18:54:42.054Z,1602615282.054 [AMEcho] Communications Fault, FailCount= 2
2020-10-13T18:54:42.054Z,1602615282.054 [AMEcho](ERROR): Communications Fault
2020-10-13T18:54:42.097Z,1602615282.097 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-10-13T18:54:42.613Z,1602615282.613 [AMEcho](INFO): Powering down
2020-10-13T18:54:43.279Z,1602615283.279 [CBIT](INFO): Clearing failed state for component AMEcho
2020-10-13T18:54:43.279Z,1602615283.279 [AMEcho] No Fault, FailCount= 2
2020-10-13T18:54:43.656Z,1602615283.656 [AMEcho](INFO): Powering up
2020-10-13T18:54:50.091Z,1602615290.091 [CommandLine](IMPORTANT): got command report mod ThrusterServo.platform_propeller_rotation_rate
2020-10-13T18:54:57.005Z,1602615297.005 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-10-13T18:54:57.005Z,1602615297.005 [AMEcho] Communications Fault, FailCount= 3
2020-10-13T18:54:57.005Z,1602615297.005 [AMEcho](ERROR): Communications Fault
2020-10-13T18:54:57.020Z,1602615297.020 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-10-13T18:54:57.021Z,1602615297.021 [CBIT](CRITICAL): Communications Fault in component: AMEcho
2020-10-13T18:54:57.589Z,1602615297.589 [AMEcho](INFO): Powering down
2020-10-13T18:54:57.608Z,1602615297.608 [CBIT](INFO): Critical error at 20201013T185457
2020-10-13T18:55:00.933Z,1602615300.933 [CommandLine](IMPORTANT): got command failComponent
2020-10-13T18:55:00.933Z,1602615300.933 [CommandLine](IMPORTANT): Failed components:
2020-10-13T18:55:00.934Z,1602615300.934 [CommandLine](IMPORTANT): AHRS_M2: Communications Fault
2020-10-13T18:55:00.934Z,1602615300.934 [CommandLine](IMPORTANT): AMEcho: Communications Fault
2020-10-13T18:55:00.934Z,1602615300.934 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault
2020-10-13T18:55:03.598Z,1602615303.598 [CommandLine](IMPORTANT): got command maintain
2020-10-13T18:55:13.172Z,1602615313.172 [Startup:StartupSatComms:A](INFO): Timed out from 2020-10-13T18:54:12.0Z
2020-10-13T18:55:13.172Z,1602615313.172 [Startup:StartupSatComms:A] Stopped
2020-10-13T18:55:13.172Z,1602615313.172 [Startup:StartupSatComms:B] Running Loop=1
2020-10-13T18:55:13.582Z,1602615313.582 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-10-13T18:55:14.951Z,1602615314.951 [CommandLine](IMPORTANT): got command maintain control SpeedControl.propOmegaAction -150.000000 revolution_per_minute
2020-10-13T18:55:14.952Z,1602615314.952 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread.
2020-10-13T18:55:15.243Z,1602615315.243 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,BPC1,AMEcho,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-10-13T18:55:16.816Z,1602615316.816 [ThrusterServo](INFO): POWER CYCLE
2020-10-13T18:55:18.439Z,1602615318.439 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:55:18.917Z,1602615318.917 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:18.918Z,1602615318.918 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:18.952Z,1602615318.952 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:55:19.329Z,1602615319.329 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:19.330Z,1602615319.330 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:19.701Z,1602615319.701 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:19.702Z,1602615319.702 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:20.101Z,1602615320.101 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:20.102Z,1602615320.102 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:20.491Z,1602615320.491 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:20.492Z,1602615320.492 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:20.881Z,1602615320.881 [ThrusterServo](FAULT): Overload Error
2020-10-13T18:55:20.881Z,1602615320.881 [ThrusterServo] Hardware Fault, FailCount= 1
2020-10-13T18:55:20.881Z,1602615320.881 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:55:20.881Z,1602615320.881 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:20.886Z,1602615320.886 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:55:20.887Z,1602615320.887 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:55:21.251Z,1602615321.251 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:55:21.251Z,1602615321.251 [ThrusterServo](INFO): Powering down
2020-10-13T18:55:22.053Z,1602615322.053 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:55:22.170Z,1602615322.170 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:55:22.174Z,1602615322.174 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-10-13T18:55:22.174Z,1602615322.174 [ThrusterServo] No Fault, FailCount= 1
2020-10-13T18:55:24.107Z,1602615324.107 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-10-13T18:55:24.107Z,1602615324.107 [CTD_Seabird] No Fault, FailCount= 3
2020-10-13T18:55:24.329Z,1602615324.329 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-10-13T18:55:24.931Z,1602615324.931 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:55:25.358Z,1602615325.358 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:55:25.749Z,1602615325.749 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:25.750Z,1602615325.750 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:26.145Z,1602615326.145 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:26.146Z,1602615326.146 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:26.521Z,1602615326.521 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:26.522Z,1602615326.522 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:26.925Z,1602615326.925 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:26.926Z,1602615326.926 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:27.341Z,1602615327.341 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:27.342Z,1602615327.342 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:27.733Z,1602615327.733 [ThrusterServo](FAULT): Overload Error
2020-10-13T18:55:27.733Z,1602615327.733 [ThrusterServo] Hardware Fault, FailCount= 2
2020-10-13T18:55:27.733Z,1602615327.733 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:55:27.733Z,1602615327.733 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:27.737Z,1602615327.737 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:55:27.744Z,1602615327.744 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:55:28.132Z,1602615328.132 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:55:28.132Z,1602615328.132 [ThrusterServo](INFO): Powering down
2020-10-13T18:55:28.940Z,1602615328.940 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:55:29.054Z,1602615329.054 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:55:29.057Z,1602615329.057 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-10-13T18:55:29.058Z,1602615329.058 [ThrusterServo] No Fault, FailCount= 2
2020-10-13T18:55:31.773Z,1602615331.773 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:55:32.303Z,1602615332.303 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:55:32.737Z,1602615332.737 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:32.738Z,1602615332.738 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:33.033Z,1602615333.033 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:33.034Z,1602615333.034 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:33.445Z,1602615333.445 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:33.446Z,1602615333.446 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:33.853Z,1602615333.853 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:33.854Z,1602615333.854 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:34.245Z,1602615334.245 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:34.246Z,1602615334.246 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:34.641Z,1602615334.641 [ThrusterServo](FAULT): Overload Error
2020-10-13T18:55:34.641Z,1602615334.641 [ThrusterServo] Hardware Fault, FailCount= 3
2020-10-13T18:55:34.641Z,1602615334.641 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:55:34.641Z,1602615334.641 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:34.645Z,1602615334.645 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:55:34.646Z,1602615334.646 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:55:34.983Z,1602615334.983 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:55:34.983Z,1602615334.983 [ThrusterServo](INFO): Powering down
2020-10-13T18:55:35.792Z,1602615335.792 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:55:35.910Z,1602615335.910 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:55:35.913Z,1602615335.913 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-10-13T18:55:35.913Z,1602615335.913 [ThrusterServo] No Fault, FailCount= 3
2020-10-13T18:55:35.950Z,1602615335.950 [DataOverHttps](INFO): Sending 103 bytes from file Logs/20201012T120739/Courier0519.lzma
2020-10-13T18:55:36.951Z,1602615336.951 [DataOverHttps](INFO): Moved sent file to Logs/20201012T120739/Courier0519.lzma.bak
2020-10-13T18:55:36.951Z,1602615336.951 [DataOverHttps](INFO): SBD MOMSN=12891010
2020-10-13T18:55:37.381Z,1602615337.381 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-10-13T18:55:37.381Z,1602615337.381 [CTD_Seabird] Communications Fault, FailCount= 1
2020-10-13T18:55:37.381Z,1602615337.381 [CTD_Seabird](ERROR): Communications Fault
2020-10-13T18:55:37.410Z,1602615337.410 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-10-13T18:55:37.793Z,1602615337.793 [CTD_Seabird](INFO): Powering down
2020-10-13T18:55:38.634Z,1602615338.634 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:55:39.042Z,1602615339.042 [ThrusterServo](INFO): Sent REVERSE direction2621
2020-10-13T18:55:39.073Z,1602615339.073 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-10-13T18:55:39.073Z,1602615339.073 [CTD_Seabird] No Fault, FailCount= 1
2020-10-13T18:55:39.133Z,1602615339.133 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-10-13T18:55:39.481Z,1602615339.481 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:39.482Z,1602615339.482 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:39.873Z,1602615339.873 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:39.873Z,1602615339.873 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:40.281Z,1602615340.281 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:40.282Z,1602615340.282 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:40.681Z,1602615340.681 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:40.682Z,1602615340.682 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:41.112Z,1602615341.112 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:41.113Z,1602615341.113 [ThrusterServo](INFO): Actual15.705328 controller:2621.000000 motor:-2621.439697
2020-10-13T18:55:41.485Z,1602615341.485 [ThrusterServo](FAULT): Overload Error
2020-10-13T18:55:41.485Z,1602615341.485 [ThrusterServo] Hardware Fault, FailCount= 4
2020-10-13T18:55:41.485Z,1602615341.485 [ThrusterServo](ERROR): Hardware Fault
2020-10-13T18:55:41.485Z,1602615341.485 [ThrusterServo](INFO): CHECKING
2020-10-13T18:55:41.501Z,1602615341.501 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2020-10-13T18:55:41.502Z,1602615341.502 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate no_value
2020-10-13T18:55:41.542Z,1602615341.542 [CommandLine](IMPORTANT): got command maintain clear
2020-10-13T18:55:41.879Z,1602615341.879 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:55:41.879Z,1602615341.879 [ThrusterServo](INFO): Powering down
2020-10-13T18:55:41.888Z,1602615341.888 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,BPC1,AMEcho,CANONSampler,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-10-13T18:55:42.804Z,1602615342.804 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-10-13T18:55:42.804Z,1602615342.804 [ThrusterServo] No Fault, FailCount= 4
2020-10-13T18:55:43.066Z,1602615343.066 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-13T18:55:43.073Z,1602615343.073 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-13T18:55:45.899Z,1602615345.899 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 15.705328 rad/s
2020-10-13T18:55:46.380Z,1602615346.380 [ThrusterServo](INFO): POWER CYCLE
2020-10-13T18:55:46.502Z,1602615346.502 [Reporter](INFO): ThrusterServo.platform_propeller_rotation_rate 0.000000 rad/s
2020-10-13T18:55:52.185Z,1602615352.185 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-10-13T18:55:52.185Z,1602615352.185 [CTD_Seabird] Communications Fault, FailCount= 2
2020-10-13T18:55:52.185Z,1602615352.185 [CTD_Seabird](ERROR): Communications Fault
2020-10-13T18:55:52.382Z,1602615352.382 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-10-13T18:55:52.589Z,1602615352.589 [CTD_Seabird](INFO): Powering down
2020-10-13T18:55:53.590Z,1602615353.590 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-10-13T18:55:53.590Z,1602615353.590 [CTD_Seabird] No Fault, FailCount= 2
2020-10-13T18:55:53.929Z,1602615353.929 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-10-13T18:56:01.029Z,1602615361.029 [DataOverHttps](INFO): Sending 253 bytes from file Logs/20201013T185158/Courier0000.lzma
2020-10-13T18:56:02.031Z,1602615362.031 [DataOverHttps](INFO): Moved sent file to Logs/20201013T185158/Courier0000.lzma.bak
2020-10-13T18:56:02.031Z,1602615362.031 [DataOverHttps](INFO): SBD MOMSN=12891014
2020-10-13T18:56:06.981Z,1602615366.981 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-10-13T18:56:06.981Z,1602615366.981 [CTD_Seabird] Communications Fault, FailCount= 3
2020-10-13T18:56:06.981Z,1602615366.981 [CTD_Seabird](ERROR): Communications Fault
2020-10-13T18:56:07.334Z,1602615367.334 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-10-13T18:56:07.335Z,1602615367.335 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2020-10-13T18:56:07.385Z,1602615367.385 [CTD_Seabird](INFO): Powering down
2020-10-13T18:56:10.973Z,1602615370.973 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-10-13T18:56:10.973Z,1602615370.973 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-10-13T18:56:10.974Z,1602615370.974 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-13T18:56:10.984Z,1602615370.984 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-13T18:56:11.385Z,1602615371.385 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-13T18:56:11.385Z,1602615371.385 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-10-13T18:56:13.462Z,1602615373.462 [Startup:StartupSatComms:B](INFO): Timed out from 2020-10-13T18:55:13.2Z
2020-10-13T18:56:13.462Z,1602615373.462 [Startup:StartupSatComms:B] Stopped
2020-10-13T18:56:13.462Z,1602615373.462 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-10-13T18:56:13.462Z,1602615373.462 [Startup:StartupSatComms] Stopped
2020-10-13T18:56:13.462Z,1602615373.462 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-10-13T18:56:13.463Z,1602615373.463 [Startup](INFO): Completed Startup
2020-10-13T18:56:13.463Z,1602615373.463 [MissionManager](INFO): Startup is completed.
2020-10-13T18:56:13.463Z,1602615373.463 [MissionManager](INFO): Uninitializing Mission Startup
2020-10-13T18:56:13.463Z,1602615373.463 [Startup] Stopped
2020-10-13T18:56:13.463Z,1602615373.463 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-10-13T18:56:13.463Z,1602615373.463 [Startup:A.GoToSurface] Stopped
2020-10-13T18:56:13.463Z,1602615373.463 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-10-13T18:56:13.806Z,1602615373.806 [MissionManager](IMPORTANT): Started mission Default
2020-10-13T18:56:13.806Z,1602615373.806 [Default] Running Loop=1
2020-10-13T18:56:13.806Z,1602615373.806 [Default](DEBUG): Aggregate::initialize Default
2020-10-13T18:56:13.806Z,1602615373.806 [Default:B.GoToSurface] Running Loop=1
2020-10-13T18:56:13.806Z,1602615373.806 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-10-13T18:56:13.807Z,1602615373.807 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-10-13T18:56:13.807Z,1602615373.807 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-10-13T18:56:13.807Z,1602615373.807 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-10-13T18:56:13.808Z,1602615373.808 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-10-13T18:56:13.808Z,1602615373.808 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-10-13T18:56:13.808Z,1602615373.808 [Default:A.Wait] Running Loop=1
2020-10-13T18:56:13.808Z,1602615373.808 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-10-13T18:56:18.314Z,1602615378.314 [DataOverHttps](INFO): Sending 157 bytes from file Logs/20201012T120739/Express0520.lzma
2020-10-13T18:56:19.315Z,1602615379.315 [DataOverHttps](INFO): Moved sent file to Logs/20201012T120739/Express0520.lzma.bak
2020-10-13T18:56:19.315Z,1602615379.315 [DataOverHttps](INFO): SBD MOMSN=12891022
2020-10-13T18:56:27.152Z,1602615387.152 [Default:A.Wait](INFO): Done Waiting.
2020-10-13T18:56:27.152Z,1602615387.152 [Default:A.Wait] Stopped
2020-10-13T18:56:27.152Z,1602615387.152 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-10-13T18:56:27.542Z,1602615387.542 [Default:CheckIn] Running Loop=1
2020-10-13T18:56:27.543Z,1602615387.543 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-10-13T18:56:27.543Z,1602615387.543 [Default:CheckIn:Read_GPS] Running Loop=1
2020-10-13T18:56:27.950Z,1602615387.950 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-10-13T18:57:51.547Z,1602615471.547 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-10-13T18:57:57.239Z,1602615477.239 [CBIT](INFO): Clearing failed state for component AMEcho
2020-10-13T18:57:57.240Z,1602615477.240 [AMEcho] No Fault, FailCount= 3
2020-10-13T18:57:57.622Z,1602615477.622 [AMEcho](INFO): Powering up
2020-10-13T18:58:10.941Z,1602615490.941 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-10-13T18:58:10.941Z,1602615490.941 [AMEcho] Communications Fault, FailCount= 1
2020-10-13T18:58:10.941Z,1602615490.941 [AMEcho](ERROR): Communications Fault
2020-10-13T18:58:10.956Z,1602615490.956 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-10-13T18:58:11.509Z,1602615491.509 [AMEcho](INFO): Powering down
2020-10-13T18:58:12.227Z,1602615492.227 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-10-13T18:58:12.227Z,1602615492.227 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-10-13T18:58:12.228Z,1602615492.228 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-13T18:58:12.266Z,1602615492.266 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-13T18:58:12.267Z,1602615492.267 [CBIT](INFO): Clearing failed state for component AMEcho
2020-10-13T18:58:12.267Z,1602615492.267 [AMEcho] No Fault, FailCount= 1
2020-10-13T18:58:12.577Z,1602615492.577 [AMEcho](INFO): Powering up
2020-10-13T18:58:12.649Z,1602615492.649 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-13T18:58:12.649Z,1602615492.649 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-10-13T18:58:21.478Z,1602615501.478 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-10-13T18:58:21.478Z,1602615501.478 [AHRS_M2] No Fault, FailCount= 5
2020-10-13T18:58:21.841Z,1602615501.841 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-10-13T18:58:23.215Z,1602615503.215 [CommandLine](IMPORTANT): got command restart application
2020-10-13T18:58:24.221Z,1602615504.221 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:24.221Z,1602615504.221 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:24.293Z,1602615504.293 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-10-13T18:58:24.293Z,1602615504.293 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:24.294Z,1602615504.294 [CommandLine](INFO): Join timeout helper Thread ID is 4242
2020-10-13T18:58:24.294Z,1602615504.294 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-10-13T18:58:24.294Z,1602615504.294 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:24.295Z,1602615504.295 [NavChartDb](INFO): Join timeout helper Thread ID is 4243
2020-10-13T18:58:24.445Z,1602615504.445 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:24.445Z,1602615504.445 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:24.453Z,1602615504.453 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-10-13T18:58:24.453Z,1602615504.453 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:24.453Z,1602615504.453 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4244
2020-10-13T18:58:24.905Z,1602615504.905 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:24.906Z,1602615504.906 [WetLabsBB2FL](INFO): Powering down
2020-10-13T18:58:24.906Z,1602615504.906 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:24.925Z,1602615504.925 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-10-13T18:58:24.925Z,1602615504.925 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:24.925Z,1602615504.925 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4245
2020-10-13T18:58:25.281Z,1602615505.281 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:25.281Z,1602615505.281 [CTD_Seabird](INFO): Powering down
2020-10-13T18:58:25.293Z,1602615505.293 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:25.313Z,1602615505.313 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-10-13T18:58:25.313Z,1602615505.313 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:25.313Z,1602615505.313 [Radio_Surface](INFO): Join timeout helper Thread ID is 4246
2020-10-13T18:58:25.397Z,1602615505.397 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:25.613Z,1602615505.613 [Radio_Surface](INFO): Powering down
2020-10-13T18:58:25.614Z,1602615505.614 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:25.614Z,1602615505.614 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:25.618Z,1602615505.618 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-10-13T18:58:25.618Z,1602615505.618 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:25.618Z,1602615505.618 [Onboard](INFO): Join timeout helper Thread ID is 4247
2020-10-13T18:58:25.957Z,1602615505.957 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:25.975Z,1602615505.975 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-10-13T18:58:25.975Z,1602615505.975 [AMEcho] Communications Fault, FailCount= 2
2020-10-13T18:58:25.975Z,1602615505.975 [AMEcho](ERROR): Communications Fault
2020-10-13T18:58:26.032Z,1602615506.032 [CBIT](ERROR): Communications Fault in component: AMEcho
2020-10-13T18:58:26.369Z,1602615506.369 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:26.557Z,1602615506.557 [AMEcho](INFO): Powering down
2020-10-13T18:58:26.913Z,1602615506.913 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:27.321Z,1602615507.321 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:27.370Z,1602615507.370 [CBIT](INFO): Clearing failed state for component AMEcho
2020-10-13T18:58:27.370Z,1602615507.370 [AMEcho] No Fault, FailCount= 2
2020-10-13T18:58:27.741Z,1602615507.741 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:27.766Z,1602615507.766 [AMEcho](INFO): Powering up
2020-10-13T18:58:28.137Z,1602615508.137 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:28.577Z,1602615508.577 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:28.977Z,1602615508.977 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:29.381Z,1602615509.381 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:29.785Z,1602615509.785 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:30.189Z,1602615510.189 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:30.485Z,1602615510.485 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:30.485Z,1602615510.485 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:30.501Z,1602615510.501 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-10-13T18:58:30.502Z,1602615510.502 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:30.502Z,1602615510.502 [DataOverHttps](INFO): Join timeout helper Thread ID is 4249
2020-10-13T18:58:30.601Z,1602615510.601 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:31.017Z,1602615511.017 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:31.397Z,1602615511.397 [AHRS_M2](ERROR): Subscribe Accelerations UART error: serial timeout
2020-10-13T18:58:31.413Z,1602615511.413 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:31.416Z,1602615511.416 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.430Z,1602615511.430 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-10-13T18:58:31.430Z,1602615511.430 [logger ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.430Z,1602615511.430 [logger](INFO): Join timeout helper Thread ID is 4250
2020-10-13T18:58:31.457Z,1602615511.457 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:31.457Z,1602615511.457 [logger ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.469Z,1602615511.469 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-10-13T18:58:31.470Z,1602615511.470 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.470Z,1602615511.470 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-10-13T18:58:31.470Z,1602615511.470 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.470Z,1602615511.470 [controlThread](INFO): Join timeout helper Thread ID is 4251
2020-10-13T18:58:31.481Z,1602615511.481 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-13T18:58:31.481Z,1602615511.481 [controlThread](DEBUG): Uninitializing ControlThread
2020-10-13T18:58:31.481Z,1602615511.481 [AHRS_M2](INFO): Powering down
2020-10-13T18:58:31.553Z,1602615511.553 [NAL9602](INFO): Powering down
2020-10-13T18:58:31.721Z,1602615511.721 [AMEcho](INFO): Powering down
2020-10-13T18:58:31.723Z,1602615511.723 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-10-13T18:58:31.724Z,1602615511.724 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-10-13T18:58:31.724Z,1602615511.724 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-10-13T18:58:31.725Z,1602615511.725 [MissionManager](INFO): Uninitializing Mission Default
2020-10-13T18:58:31.725Z,1602615511.725 [Default] Stopped
2020-10-13T18:58:31.725Z,1602615511.725 [Default](DEBUG): Aggregate::uninitialize Default
2020-10-13T18:58:31.725Z,1602615511.725 [Default:B.GoToSurface] Stopped
2020-10-13T18:58:31.725Z,1602615511.725 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-10-13T18:58:31.725Z,1602615511.725 [Default:CheckIn] Stopped
2020-10-13T18:58:31.725Z,1602615511.725 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-10-13T18:58:31.726Z,1602615511.726 [Default:CheckIn:Read_GPS] Stopped
2020-10-13T18:58:31.728Z,1602615511.728 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-10-13T18:58:31.728Z,1602615511.728 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-10-13T18:58:31.728Z,1602615511.728 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-10-13T18:58:31.729Z,1602615511.729 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-10-13T18:58:31.729Z,1602615511.729 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-10-13T18:58:31.729Z,1602615511.729 [BuoyancyServo](INFO): Powering down
2020-10-13T18:58:31.741Z,1602615511.741 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-10-13T18:58:31.741Z,1602615511.741 [ElevatorServo](INFO): Powering down
2020-10-13T18:58:31.742Z,1602615511.742 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-10-13T18:58:31.742Z,1602615511.742 [MassServo](INFO): Powering down
2020-10-13T18:58:31.743Z,1602615511.743 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-10-13T18:58:31.743Z,1602615511.743 [RudderServo](INFO): Powering down
2020-10-13T18:58:31.744Z,1602615511.744 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-13T18:58:31.744Z,1602615511.744 [ThrusterServo](INFO): Powering down
2020-10-13T18:58:31.744Z,1602615511.744 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-10-13T18:58:31.745Z,1602615511.745 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-10-13T18:58:31.745Z,1602615511.745 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-10-13T18:58:31.745Z,1602615511.745 [CBIT](DEBUG): Powering off loads.
2020-10-13T18:58:31.757Z,1602615511.757 [CBIT](DEBUG): Disabling WDT.
2020-10-13T18:58:31.769Z,1602615511.769 [CBIT](DEBUG): Opening all GF detection circuits.
2020-10-13T18:58:31.770Z,1602615511.770 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.866Z,1602615511.866 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.868Z,1602615511.868 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.874Z,1602615511.874 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.906Z,1602615511.906 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.911Z,1602615511.911 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:31.953Z,1602615511.953 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-13T18:58:32.005Z,1602615512.005 [logger ThreadHandler](INFO): Thread cancelled.