2020-12-08T21:32:04.970Z,1607463124.970 [Supervisor](DEBUG): Initializing supervisor.
2020-12-08T21:32:04.972Z,1607463124.972 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-12-08T21:32:04.973Z,1607463124.973 [SyncHandler](INFO): Protected caller Thread ID is 5551
2020-12-08T21:32:04.973Z,1607463124.973 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-12-08T21:32:04.974Z,1607463124.974 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-12-08T21:32:04.975Z,1607463124.975 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5552
2020-12-08T21:32:04.978Z,1607463124.978 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-12-08T21:32:04.994Z,1607463124.994 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-12-08T21:32:04.995Z,1607463124.995 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-12-08T21:32:04.995Z,1607463124.995 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5553
2020-12-08T21:32:04.996Z,1607463124.996 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-12-08T21:32:04.997Z,1607463124.997 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-12-08T21:32:04.997Z,1607463124.997 [logger ThreadHandler](INFO): Protected caller Thread ID is 5554
2020-12-08T21:32:04.999Z,1607463124.999 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-12-08T21:32:04.000Z,1607463125.000 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-12-08T21:32:05.005Z,1607463125.005 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-12-08T21:32:05.266Z,1607463125.266 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-12-08T21:32:05.268Z,1607463125.268 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-12-08T21:32:05.349Z,1607463125.349 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-12-08T21:32:05.804Z,1607463125.804 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-12-08T21:32:05.806Z,1607463125.806 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-12-08T21:32:06.111Z,1607463126.111 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-12-08T21:32:06.113Z,1607463126.113 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-12-08T21:32:06.210Z,1607463126.210 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-12-08T21:32:06.211Z,1607463126.211 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-12-08T21:32:06.494Z,1607463126.494 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-12-08T21:32:06.495Z,1607463126.495 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-12-08T21:32:06.682Z,1607463126.682 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-12-08T21:32:06.684Z,1607463126.684 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-12-08T21:32:07.148Z,1607463127.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-12-08T21:32:07.148Z,1607463127.148 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-12-08T21:32:07.255Z,1607463127.255 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-12-08T21:32:07.256Z,1607463127.256 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-12-08T21:32:07.356Z,1607463127.356 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-12-08T21:32:07.356Z,1607463127.356 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-12-08T21:32:07.986Z,1607463127.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-12-08T21:32:07.986Z,1607463127.986 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-12-08T21:32:08.395Z,1607463128.395 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-12-08T21:32:08.396Z,1607463128.396 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-12-08T21:32:08.582Z,1607463128.582 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-12-08T21:32:08.584Z,1607463128.584 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-12-08T21:32:08.727Z,1607463128.727 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-12-08T21:32:08.728Z,1607463128.728 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-12-08T21:32:08.874Z,1607463128.874 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-12-08T21:32:08.875Z,1607463128.875 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-12-08T21:32:09.082Z,1607463129.082 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-12-08T21:32:09.083Z,1607463129.083 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2020-12-08T21:32:09.086Z,1607463129.086 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2020-12-08T21:32:09.177Z,1607463129.177 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2020-12-08T21:32:09.263Z,1607463129.263 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2020-12-08T21:32:09.363Z,1607463129.363 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2020-12-08T21:32:09.448Z,1607463129.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2020-12-08T21:32:09.545Z,1607463129.545 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2020-12-08T21:32:09.645Z,1607463129.645 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2020-12-08T21:32:09.844Z,1607463129.844 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2020-12-08T21:32:09.922Z,1607463129.922 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2020-12-08T21:32:10.706Z,1607463130.706 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2020-12-08T21:32:11.184Z,1607463131.184 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2020-12-08T21:32:11.300Z,1607463131.300 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2020-12-08T21:32:11.545Z,1607463131.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-12-08T21:32:11.545Z,1607463131.545 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-12-08T21:32:11.557Z,1607463131.557 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-12-08T21:32:11.615Z,1607463131.615 [VerticalControl](DEBUG): Construct VerticalControl.
2020-12-08T21:32:11.672Z,1607463131.672 [VerticalControl] Loaded
2020-12-08T21:32:11.672Z,1607463131.672 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-12-08T21:32:11.673Z,1607463131.673 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-12-08T21:32:11.708Z,1607463131.708 [HorizontalControl] Loaded
2020-12-08T21:32:11.709Z,1607463131.709 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-12-08T21:32:11.709Z,1607463131.709 [SpeedControl](DEBUG): Construct SpeedControl.
2020-12-08T21:32:11.712Z,1607463131.712 [SpeedControl] Loaded
2020-12-08T21:32:11.713Z,1607463131.713 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-12-08T21:32:11.713Z,1607463131.713 [LoopControl](DEBUG): Construct LoopControl.
2020-12-08T21:32:11.714Z,1607463131.714 [LoopControl] Loaded
2020-12-08T21:32:11.714Z,1607463131.714 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-12-08T21:32:11.714Z,1607463131.714 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-12-08T21:32:11.715Z,1607463131.715 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-12-08T21:32:11.742Z,1607463131.742 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-12-08T21:32:11.742Z,1607463131.742 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-12-08T21:32:11.853Z,1607463131.853 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-12-08T21:32:11.854Z,1607463131.854 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-12-08T21:32:11.975Z,1607463131.975 [BuoyancyServo] Loaded
2020-12-08T21:32:11.976Z,1607463131.976 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-12-08T21:32:11.991Z,1607463131.991 [ElevatorServo] Loaded
2020-12-08T21:32:11.991Z,1607463131.991 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-12-08T21:32:12.006Z,1607463132.006 [MassServo] Loaded
2020-12-08T21:32:12.007Z,1607463132.007 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-12-08T21:32:12.021Z,1607463132.021 [RudderServo] Loaded
2020-12-08T21:32:12.021Z,1607463132.021 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-12-08T21:32:12.036Z,1607463132.036 [ThrusterServo] Loaded
2020-12-08T21:32:12.036Z,1607463132.036 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-12-08T21:32:12.036Z,1607463132.036 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-12-08T21:32:12.037Z,1607463132.037 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-12-08T21:32:12.127Z,1607463132.127 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-12-08T21:32:12.127Z,1607463132.127 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-12-08T21:32:12.138Z,1607463132.138 [NavChart] Loaded
2020-12-08T21:32:12.138Z,1607463132.138 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-12-08T21:32:12.142Z,1607463132.142 [UniversalFixResidualReporter] Loaded
2020-12-08T21:32:12.142Z,1607463132.142 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-12-08T21:32:12.142Z,1607463132.142 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-12-08T21:32:12.143Z,1607463132.143 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-12-08T21:32:12.257Z,1607463132.257 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-12-08T21:32:12.257Z,1607463132.257 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-12-08T21:32:12.650Z,1607463132.650 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-12-08T21:32:12.653Z,1607463132.653 [AHRS_M2](INFO): created writer for : platform_orientation
2020-12-08T21:32:12.654Z,1607463132.654 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-12-08T21:32:12.657Z,1607463132.657 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-12-08T21:32:12.658Z,1607463132.658 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-12-08T21:32:12.660Z,1607463132.660 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-12-08T21:32:12.661Z,1607463132.661 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-12-08T21:32:12.664Z,1607463132.664 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-12-08T21:32:12.700Z,1607463132.700 [AHRS_M2] Loaded
2020-12-08T21:32:12.700Z,1607463132.700 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-12-08T21:32:12.772Z,1607463132.772 [DataOverHttps] Loaded
2020-12-08T21:32:12.773Z,1607463132.773 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-12-08T21:32:12.774Z,1607463132.774 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408A34E0
2020-12-08T21:32:12.774Z,1607463132.774 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5639
2020-12-08T21:32:12.790Z,1607463132.790 [Depth_Keller] Loaded
2020-12-08T21:32:12.790Z,1607463132.790 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-12-08T21:32:12.793Z,1607463132.793 [DropWeight] Loaded
2020-12-08T21:32:12.793Z,1607463132.793 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-12-08T21:32:12.845Z,1607463132.845 [NAL9602] Loaded
2020-12-08T21:32:12.845Z,1607463132.845 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-12-08T21:32:12.870Z,1607463132.870 [Onboard] Loaded
2020-12-08T21:32:12.870Z,1607463132.870 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-12-08T21:32:12.871Z,1607463132.871 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408D34E0
2020-12-08T21:32:12.872Z,1607463132.872 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5640
2020-12-08T21:32:12.882Z,1607463132.882 [Radio_Surface] Loaded
2020-12-08T21:32:12.882Z,1607463132.882 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-12-08T21:32:12.883Z,1607463132.883 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409034E0
2020-12-08T21:32:12.883Z,1607463132.883 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5641
2020-12-08T21:32:13.632Z,1607463133.632 [BPC1] Loaded
2020-12-08T21:32:13.632Z,1607463133.632 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-12-08T21:32:13.650Z,1607463133.650 [AMEcho] Loaded
2020-12-08T21:32:13.651Z,1607463133.651 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2020-12-08T21:32:13.651Z,1607463133.651 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-12-08T21:32:13.651Z,1607463133.651 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-12-08T21:32:13.698Z,1607463133.698 [DepthRateCalculator] Loaded
2020-12-08T21:32:13.698Z,1607463133.698 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-12-08T21:32:13.701Z,1607463133.701 [PitchRateCalculator] Loaded
2020-12-08T21:32:13.701Z,1607463133.701 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-12-08T21:32:13.708Z,1607463133.708 [SpeedCalculator] Loaded
2020-12-08T21:32:13.708Z,1607463133.708 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-12-08T21:32:13.719Z,1607463133.719 [TempGradientCalculator] Loaded
2020-12-08T21:32:13.719Z,1607463133.719 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-12-08T21:32:13.722Z,1607463133.722 [YawRateCalculator] Loaded
2020-12-08T21:32:13.722Z,1607463133.722 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-12-08T21:32:13.737Z,1607463133.737 [ElevatorOffsetCalculator] Loaded
2020-12-08T21:32:13.737Z,1607463133.737 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-12-08T21:32:13.737Z,1607463133.737 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-12-08T21:32:13.738Z,1607463133.738 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-12-08T21:32:13.980Z,1607463133.980 [CANONSampler] Loaded
2020-12-08T21:32:13.980Z,1607463133.980 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2020-12-08T21:32:13.998Z,1607463133.998 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-12-08T21:32:14.001Z,1607463134.001 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-12-08T21:32:14.001Z,1607463134.001 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-12-08T21:32:14.003Z,1607463134.003 [CTD_Seabird](INFO): created writer for : depth
2020-12-08T21:32:14.004Z,1607463134.004 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-12-08T21:32:14.006Z,1607463134.006 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-12-08T21:32:14.007Z,1607463134.007 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-12-08T21:32:14.010Z,1607463134.010 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-12-08T21:32:14.010Z,1607463134.010 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-12-08T21:32:14.013Z,1607463134.013 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-12-08T21:32:14.014Z,1607463134.014 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-12-08T21:32:14.017Z,1607463134.017 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-12-08T21:32:14.017Z,1607463134.017 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-12-08T21:32:14.020Z,1607463134.020 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-12-08T21:32:14.020Z,1607463134.020 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): mass_concentration_of_oxygen_in_sea_water
2020-12-08T21:32:14.023Z,1607463134.023 [CTD_Seabird](INFO): created writer for : mass_concentration_of_oxygen_in_sea_water
2020-12-08T21:32:14.023Z,1607463134.023 [CTD_Seabird](DEBUG): LcmSlateWriter::add(DAtaURI): CTD_Seabird.sea_water_dissolved_oxygen_freq
2020-12-08T21:32:14.024Z,1607463134.024 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): dataName: sea_water_dissolved_oxygen_freq
2020-12-08T21:32:14.039Z,1607463134.039 [CTD_Seabird] Loaded
2020-12-08T21:32:14.040Z,1607463134.040 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-12-08T21:32:14.041Z,1607463134.041 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A114E0
2020-12-08T21:32:14.041Z,1607463134.041 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5642
2020-12-08T21:32:14.058Z,1607463134.058 [PAR_Licor] Loaded
2020-12-08T21:32:14.058Z,1607463134.058 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-12-08T21:32:14.070Z,1607463134.070 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-12-08T21:32:14.070Z,1607463134.070 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-12-08T21:32:14.072Z,1607463134.072 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-12-08T21:32:14.072Z,1607463134.072 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-12-08T21:32:14.074Z,1607463134.074 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-12-08T21:32:14.074Z,1607463134.074 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-12-08T21:32:14.076Z,1607463134.076 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-12-08T21:32:14.076Z,1607463134.076 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-12-08T21:32:14.078Z,1607463134.078 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-12-08T21:32:14.078Z,1607463134.078 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-12-08T21:32:14.080Z,1607463134.080 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-12-08T21:32:14.081Z,1607463134.081 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-12-08T21:32:14.082Z,1607463134.082 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-12-08T21:32:14.083Z,1607463134.083 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-12-08T21:32:14.084Z,1607463134.084 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-12-08T21:32:14.086Z,1607463134.086 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-12-08T21:32:14.087Z,1607463134.087 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-12-08T21:32:14.087Z,1607463134.087 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-12-08T21:32:14.089Z,1607463134.089 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-12-08T21:32:14.089Z,1607463134.089 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-12-08T21:32:14.091Z,1607463134.091 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-12-08T21:32:14.091Z,1607463134.091 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-12-08T21:32:14.093Z,1607463134.093 [WetLabsBB2FL] Loaded
2020-12-08T21:32:14.093Z,1607463134.093 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-12-08T21:32:14.094Z,1607463134.094 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A414E0
2020-12-08T21:32:14.095Z,1607463134.095 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5643
2020-12-08T21:32:14.095Z,1607463134.095 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-12-08T21:32:14.096Z,1607463134.096 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-12-08T21:32:14.132Z,1607463134.132 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-12-08T21:32:14.132Z,1607463134.132 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-12-08T21:32:14.432Z,1607463134.432 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-12-08T21:32:14.433Z,1607463134.433 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-12-08T21:32:14.574Z,1607463134.574 [SBIT](DEBUG): Construct Startup Built In Test.
2020-12-08T21:32:14.583Z,1607463134.583 [SBIT] Loaded
2020-12-08T21:32:14.583Z,1607463134.583 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-12-08T21:32:14.584Z,1607463134.584 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-12-08T21:32:14.596Z,1607463134.596 [IBIT] Loaded
2020-12-08T21:32:14.596Z,1607463134.596 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-12-08T21:32:14.599Z,1607463134.599 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-12-08T21:32:14.692Z,1607463134.692 [CBIT] Loaded
2020-12-08T21:32:14.692Z,1607463134.692 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-12-08T21:32:14.693Z,1607463134.693 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-12-08T21:32:14.693Z,1607463134.693 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-12-08T21:32:14.782Z,1607463134.782 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-12-08T21:32:14.786Z,1607463134.786 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-12-08T21:32:14.787Z,1607463134.787 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-12-08T21:32:14.795Z,1607463134.795 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-12-08T21:32:14.796Z,1607463134.796 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B684E0
2020-12-08T21:32:14.796Z,1607463134.796 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5644
2020-12-08T21:32:14.800Z,1607463134.800 [Supervisor](INFO): Main Thread ID is 5550
2020-12-08T21:32:14.800Z,1607463134.800 [Supervisor](DEBUG): Running supervisor.
2020-12-08T21:32:14.801Z,1607463134.801 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5645
2020-12-08T21:32:14.803Z,1607463134.803 [controlThread ThreadHandler](INFO): Handler Thread ID is 5646
2020-12-08T21:32:14.804Z,1607463134.804 [controlThread](DEBUG): Initializing ControlThread
2020-12-08T21:32:14.805Z,1607463134.805 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-12-08T21:32:14.806Z,1607463134.806 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-12-08T21:32:14.807Z,1607463134.807 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-12-08T21:32:14.807Z,1607463134.807 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-12-08T21:32:14.809Z,1607463134.809 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-12-08T21:32:14.810Z,1607463134.810 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-12-08T21:32:14.815Z,1607463134.815 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-12-08T21:32:14.815Z,1607463134.815 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-12-08T21:32:14.815Z,1607463134.815 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-12-08T21:32:14.816Z,1607463134.816 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-12-08T21:32:14.816Z,1607463134.816 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-12-08T21:32:14.817Z,1607463134.817 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-12-08T21:32:14.821Z,1607463134.821 [SBIT](INFO): Initialize SBIT Component.
2020-12-08T21:32:14.822Z,1607463134.822 [SBIT](IMPORTANT): git: 2020-11-25
2020-12-08T21:32:14.822Z,1607463134.822 [SBIT](INFO): git hash: 5e13bf84858840c906f3eccd44caf880a68d7500
2020-12-08T21:32:14.822Z,1607463134.822 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-12-08T21:32:14.823Z,1607463134.823 [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-12-08T21:32:14.824Z,1607463134.824 [SBIT](INFO): Beginning SBIT in 44.000000 seconds.
2020-12-08T21:32:14.825Z,1607463134.825 [IBIT](INFO): Initialize IBIT Component.
2020-12-08T21:32:14.826Z,1607463134.826 [CBIT](DEBUG): Initialize CBIT Component.
2020-12-08T21:32:14.827Z,1607463134.827 [logger ThreadHandler](INFO): Handler Thread ID is 5647
2020-12-08T21:32:14.837Z,1607463134.837 [CBIT](DEBUG): Initialized mux pins.
2020-12-08T21:32:14.837Z,1607463134.837 [CBIT](DEBUG): Initializing the watchdog timer.
2020-12-08T21:32:14.845Z,1607463134.845 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5648
2020-12-08T21:32:14.846Z,1607463134.846 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-12-08T21:32:14.857Z,1607463134.857 [Onboard ThreadHandler](INFO): Handler Thread ID is 5649
2020-12-08T21:32:14.861Z,1607463134.861 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-12-08T21:32:14.862Z,1607463134.862 [CBIT](DEBUG): Initializing heartbeat.
2020-12-08T21:32:14.886Z,1607463134.886 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5650
2020-12-08T21:32:14.889Z,1607463134.889 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5651
2020-12-08T21:32:14.890Z,1607463134.890 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-12-08T21:32:14.894Z,1607463134.894 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5653
2020-12-08T21:32:14.895Z,1607463134.895 [WetLabsBB2FL](INFO): Powering down
2020-12-08T21:32:14.917Z,1607463134.917 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5654
2020-12-08T21:32:14.926Z,1607463134.926 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-12-08T21:32:14.926Z,1607463134.926 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-12-08T21:32:14.926Z,1607463134.926 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-12-08T21:32:14.926Z,1607463134.926 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-12-08T21:32:14.927Z,1607463134.927 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-12-08T21:32:14.927Z,1607463134.927 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-12-08T21:32:14.927Z,1607463134.927 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-12-08T21:32:14.927Z,1607463134.927 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-12-08T21:32:14.927Z,1607463134.927 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-12-08T21:32:14.927Z,1607463134.927 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-12-08T21:32:14.927Z,1607463134.927 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-12-08T21:32:14.928Z,1607463134.928 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-12-08T21:32:14.928Z,1607463134.928 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-12-08T21:32:14.928Z,1607463134.928 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-12-08T21:32:14.928Z,1607463134.928 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-12-08T21:32:14.928Z,1607463134.928 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-12-08T21:32:14.933Z,1607463134.933 [CBIT](DEBUG): Deactivating GF circuits.
2020-12-08T21:32:14.933Z,1607463134.933 [CBIT](DEBUG): Deactivating emergency mode.
2020-12-08T21:32:14.969Z,1607463134.969 [CBIT](DEBUG): Backplane powered.
2020-12-08T21:32:14.970Z,1607463134.970 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-12-08T21:32:14.982Z,1607463134.982 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-12-08T21:32:15.009Z,1607463135.009 [MissionManager](DEBUG):
2020-12-08T21:32:15.010Z,1607463135.010 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-12-08T21:32:15.090Z,1607463135.090 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-12-08T21:32:15.091Z,1607463135.091 [Default:A.Wait](DEBUG): Construct Wait.
2020-12-08T21:32:15.093Z,1607463135.093 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-12-08T21:32:15.107Z,1607463135.107 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-12-08T21:32:15.126Z,1607463135.126 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-12-08T21:32:15.131Z,1607463135.131 [Default:E.Execute](DEBUG): Construct Execute.
2020-12-08T21:32:15.153Z,1607463135.153 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2020-12-08T21:32:15.173Z,1607463135.173 [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-12-08T21:32:15.178Z,1607463135.178 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-08T21:32:15.213Z,1607463135.213 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2020-12-08T21:32:15.257Z,1607463135.257 [AMEcho](INFO): Powering up
2020-12-08T21:32:15.259Z,1607463135.259 [AMEcho](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-12-08T21:32:15.285Z,1607463135.285 [CANONSampler](INFO): Powering down
2020-12-08T21:32:15.289Z,1607463135.289 [Radio_Surface](INFO): Powering up
2020-12-08T21:32:15.294Z,1607463135.294 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-12-08T21:32:15.301Z,1607463135.301 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-12-08T21:32:15.428Z,1607463135.428 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:32:15.442Z,1607463135.442 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-12-08T21:32:15.443Z,1607463135.443 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:32:15.469Z,1607463135.469 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-12-08T21:32:15.470Z,1607463135.470 [MassServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:32:15.477Z,1607463135.477 [MassServo](DEBUG): Initializing MassServo.
2020-12-08T21:32:15.478Z,1607463135.478 [RudderServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:32:15.485Z,1607463135.485 [RudderServo](DEBUG): Initializing RudderServo.
2020-12-08T21:32:15.486Z,1607463135.486 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:32:15.493Z,1607463135.493 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-12-08T21:32:15.695Z,1607463135.695 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2020-12-08T21:32:15.695Z,1607463135.695 [DropWeight] Hardware Fault, FailCount= 1
2020-12-08T21:32:15.695Z,1607463135.695 [DropWeight](ERROR): Hardware Fault
2020-12-08T21:32:15.865Z,1607463135.865 [AMEcho](INFO): Powering down
2020-12-08T21:32:15.904Z,1607463135.904 [CommandLine](FAULT): Scheduling is paused
2020-12-08T21:32:15.904Z,1607463135.904 [CBIT](INFO): Critical error at 20201208T213215
2020-12-08T21:32:15.904Z,1607463135.904 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-12-08T21:32:15.907Z,1607463135.907 [CBIT](ERROR): Hardware Fault in component: DropWeight
2020-12-08T21:32:15.907Z,1607463135.907 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2020-12-08T21:32:16.341Z,1607463136.341 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-12-08T21:32:16.341Z,1607463136.341 [RudderServo](FAULT): Rudder failed to initialize
2020-12-08T21:32:16.341Z,1607463136.341 [RudderServo] Communications Fault, FailCount= 1
2020-12-08T21:32:16.341Z,1607463136.341 [RudderServo](ERROR): Communications Fault
2020-12-08T21:32:16.439Z,1607463136.439 [CBIT](INFO): Critical error at 20201208T213215
2020-12-08T21:32:16.441Z,1607463136.441 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-12-08T21:32:16.451Z,1607463136.451 [AMEcho](IMPORTANT): Setting 'enabled' to 0
2020-12-08T21:32:16.451Z,1607463136.451 [AMEcho](IMPORTANT): Setting 'depthThreshold' to 20.000000
2020-12-08T21:32:16.642Z,1607463136.642 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-12-08T21:32:16.642Z,1607463136.642 [RudderServo](INFO): Powering down
2020-12-08T21:32:17.299Z,1607463137.299 [RudderServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:32:17.418Z,1607463137.418 [RudderServo](DEBUG): Initializing RudderServo.
2020-12-08T21:32:17.422Z,1607463137.422 [CBIT](INFO): Clearing failed state for component RudderServo
2020-12-08T21:32:17.422Z,1607463137.422 [RudderServo] No Fault, FailCount= 1
2020-12-08T21:32:27.223Z,1607463147.223 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004776
2020-12-08T21:32:43.114Z,1607463163.114 [NAL9602](INFO): Powering up NAL9602
2020-12-08T21:32:54.028Z,1607463174.028 [NAL9602](INFO): NAL9602 initialized
2020-12-08T21:32:59.341Z,1607463179.341 [SBIT](IMPORTANT): Beginning Startup BIT
2020-12-08T21:32:59.346Z,1607463179.346 [CBIT](IMPORTANT): Beginning ground fault scan
2020-12-08T21:33:10.609Z,1607463190.609 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.006664
CHAN A1 (24V): 0.000468
CHAN A2 (12V): -0.002177
CHAN A3 (5V): -0.001663
CHAN B0 (3.3V): 0.000296
CHAN B1 (3.15aV): -0.000237
CHAN B2 (3.15bV): -0.000107
CHAN B3 (GND): -0.000054
OPEN: -0.000418
Full Scale Calc: 4.765 mA, -1.589 mA
2020-12-08T21:33:53.428Z,1607463233.428 [SBIT](IMPORTANT): SBIT PASSED
2020-12-08T21:33:53.428Z,1607463233.428 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-12-08T21:33:53.429Z,1607463233.429 [SBIT](IMPORTANT): AMEcho.enabled=0 bool;
2020-12-08T21:33:53.429Z,1607463233.429 [SBIT](IMPORTANT): ElevatorOffsetCalculator.loadAtStartup=1 bool;
2020-12-08T21:33:53.429Z,1607463233.429 [SBIT](IMPORTANT): Express linearApproximation AMEcho.altitude 1.000000 meter;
2020-12-08T21:33:53.429Z,1607463233.429 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 1.000000 meter;
2020-12-08T21:33:53.429Z,1607463233.429 [SBIT](IMPORTANT): PAR_Licor.parCal=1.0914 none;
2020-12-08T21:33:53.429Z,1607463233.429 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=229.775315 cubic_centimeter;
2020-12-08T21:33:53.430Z,1607463233.430 [SBIT](IMPORTANT): VerticalControl.massDefault=-6.105428 millimeter;
2020-12-08T21:33:53.842Z,1607463233.842 [MissionManager](IMPORTANT): Started mission Startup
2020-12-08T21:33:53.842Z,1607463233.842 [Startup] Running Loop=1
2020-12-08T21:33:53.842Z,1607463233.842 [Startup](DEBUG): Aggregate::initialize Startup
2020-12-08T21:33:53.842Z,1607463233.842 [Startup:A.GoToSurface] Running Loop=1
2020-12-08T21:33:53.842Z,1607463233.842 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-12-08T21:33:53.843Z,1607463233.843 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-12-08T21:33:53.843Z,1607463233.843 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-12-08T21:33:53.844Z,1607463233.844 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-12-08T21:33:53.844Z,1607463233.844 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-12-08T21:33:53.844Z,1607463233.844 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-12-08T21:33:53.846Z,1607463233.846 [Startup:StartupSatComms] Running Loop=1
2020-12-08T21:33:53.846Z,1607463233.846 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-12-08T21:33:53.846Z,1607463233.846 [Startup:StartupSatComms:A] Running Loop=1
2020-12-08T21:33:54.261Z,1607463234.261 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-12-08T21:34:54.038Z,1607463294.038 [Startup:StartupSatComms:A](INFO): Timed out from 2020-12-08T21:33:53.8Z
2020-12-08T21:34:54.038Z,1607463294.038 [Startup:StartupSatComms:A] Stopped
2020-12-08T21:34:54.038Z,1607463294.038 [Startup:StartupSatComms:B] Running Loop=1
2020-12-08T21:34:54.427Z,1607463294.427 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-12-08T21:35:01.596Z,1607463301.596 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201203T195351/Courier0375.lzma
2020-12-08T21:35:02.599Z,1607463302.599 [DataOverHttps](INFO): Moved sent file to Logs/20201203T195351/Courier0375.lzma.bak
2020-12-08T21:35:02.599Z,1607463302.599 [DataOverHttps](INFO): SBD MOMSN=13421223
2020-12-08T21:35:15.061Z,1607463315.061 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-12-08T21:35:15.061Z,1607463315.061 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:35:15.074Z,1607463315.074 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-08T21:35:15.478Z,1607463315.478 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-08T21:35:15.478Z,1607463315.478 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-12-08T21:35:54.225Z,1607463354.225 [Startup:StartupSatComms:B](INFO): Timed out from 2020-12-08T21:34:54.0Z
2020-12-08T21:35:54.226Z,1607463354.226 [Startup:StartupSatComms:B] Stopped
2020-12-08T21:35:54.226Z,1607463354.226 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-12-08T21:35:54.226Z,1607463354.226 [Startup:StartupSatComms] Stopped
2020-12-08T21:35:54.226Z,1607463354.226 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-12-08T21:35:54.226Z,1607463354.226 [Startup](INFO): Completed Startup
2020-12-08T21:35:54.227Z,1607463354.227 [MissionManager](INFO): Startup is completed.
2020-12-08T21:35:54.227Z,1607463354.227 [MissionManager](INFO): Uninitializing Mission Startup
2020-12-08T21:35:54.227Z,1607463354.227 [Startup] Stopped
2020-12-08T21:35:54.227Z,1607463354.227 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-12-08T21:35:54.227Z,1607463354.227 [Startup:A.GoToSurface] Stopped
2020-12-08T21:35:54.227Z,1607463354.227 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-08T21:35:54.647Z,1607463354.647 [MissionManager](IMPORTANT): Started mission Default
2020-12-08T21:35:54.647Z,1607463354.647 [Default] Running Loop=1
2020-12-08T21:35:54.647Z,1607463354.647 [Default](DEBUG): Aggregate::initialize Default
2020-12-08T21:35:54.647Z,1607463354.647 [Default:B.GoToSurface] Running Loop=1
2020-12-08T21:35:54.647Z,1607463354.647 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-12-08T21:35:54.648Z,1607463354.648 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-12-08T21:35:54.648Z,1607463354.648 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-12-08T21:35:54.648Z,1607463354.648 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-12-08T21:35:54.648Z,1607463354.648 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-12-08T21:35:54.649Z,1607463354.649 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-12-08T21:35:54.649Z,1607463354.649 [Default:A.Wait] Running Loop=1
2020-12-08T21:35:54.649Z,1607463354.649 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-12-08T21:36:07.971Z,1607463367.971 [Default:A.Wait](INFO): Done Waiting.
2020-12-08T21:36:07.971Z,1607463367.971 [Default:A.Wait] Stopped
2020-12-08T21:36:07.971Z,1607463367.971 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-12-08T21:36:08.362Z,1607463368.362 [Default:CheckIn] Running Loop=1
2020-12-08T21:36:08.362Z,1607463368.362 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-12-08T21:36:08.362Z,1607463368.362 [Default:CheckIn:Read_GPS] Running Loop=1
2020-12-08T21:36:08.773Z,1607463368.773 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-12-08T21:37:57.026Z,1607463477.026 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-12-08T21:38:16.058Z,1607463496.058 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-12-08T21:38:16.058Z,1607463496.058 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:38:16.068Z,1607463496.068 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-08T21:38:16.441Z,1607463496.441 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-08T21:38:16.441Z,1607463496.441 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-12-08T21:39:09.080Z,1607463549.080 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20201208T213204/Courier0000.lzma
2020-12-08T21:39:10.082Z,1607463550.082 [DataOverHttps](INFO): Moved sent file to Logs/20201208T213204/Courier0000.lzma.bak
2020-12-08T21:39:10.083Z,1607463550.083 [DataOverHttps](INFO): SBD MOMSN=13421268
2020-12-08T21:39:39.654Z,1607463579.654 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-12-08T21:39:39.656Z,1607463579.656 [BPC1](INFO): Received data from all battery sticks.
2020-12-08T21:41:08.614Z,1607463668.614 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-12-08T21:36:08.4Z
2020-12-08T21:41:08.614Z,1607463668.614 [Default:CheckIn:Read_GPS] Stopped
2020-12-08T21:41:08.614Z,1607463668.614 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-12-08T21:41:09.023Z,1607463669.023 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-12-08T21:41:09.871Z,1607463669.871 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20201208T213204/Courier0004.lzma
2020-12-08T21:41:10.770Z,1607463670.770 [DataOverHttps](INFO): Moved sent file to Logs/20201208T213204/Courier0004.lzma.bak
2020-12-08T21:41:10.771Z,1607463670.771 [DataOverHttps](INFO): SBD MOMSN=13421273
2020-12-08T21:41:17.106Z,1607463677.106 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-12-08T21:41:17.107Z,1607463677.107 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:41:17.117Z,1607463677.117 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-08T21:41:17.526Z,1607463677.526 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-08T21:41:17.526Z,1607463677.526 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-12-08T21:41:26.092Z,1607463686.092 [DataOverHttps](INFO): Sending 110 bytes from file Logs/20201203T195351/Express0373.lzma
2020-12-08T21:41:27.095Z,1607463687.095 [DataOverHttps](INFO): Moved sent file to Logs/20201203T195351/Express0373.lzma.bak
2020-12-08T21:41:27.095Z,1607463687.095 [DataOverHttps](INFO): SBD MOMSN=13421275
2020-12-08T21:41:42.387Z,1607463702.387 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20201203T195351/Express0376.lzma
2020-12-08T21:41:43.387Z,1607463703.387 [DataOverHttps](INFO): Moved sent file to Logs/20201203T195351/Express0376.lzma.bak
2020-12-08T21:41:43.387Z,1607463703.387 [DataOverHttps](INFO): SBD MOMSN=13421278
2020-12-08T21:41:58.734Z,1607463718.734 [DataOverHttps](INFO): Sending 932 bytes from file Logs/20201208T213204/Express0001.lzma
2020-12-08T21:41:59.734Z,1607463719.734 [DataOverHttps](INFO): Moved sent file to Logs/20201208T213204/Express0001.lzma.bak
2020-12-08T21:41:59.735Z,1607463719.735 [DataOverHttps](INFO): SBD MOMSN=13421281
2020-12-08T21:42:14.988Z,1607463734.988 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20201208T213204/Express0005.lzma
2020-12-08T21:42:15.990Z,1607463735.990 [DataOverHttps](INFO): Moved sent file to Logs/20201208T213204/Express0005.lzma.bak
2020-12-08T21:42:15.991Z,1607463735.991 [DataOverHttps](INFO): SBD MOMSN=13421304
2020-12-08T21:42:17.304Z,1607463737.304 [Default:CheckIn:Read_Iridium] Stopped
2020-12-08T21:42:17.304Z,1607463737.304 [Default:CheckIn:C.Wait] Running Loop=1
2020-12-08T21:42:17.304Z,1607463737.304 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-08T21:42:56.064Z,1607463776.064 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-12-08T21:42:56.064Z,1607463776.064 [NAL9602] Data Fault, FailCount= 1
2020-12-08T21:42:56.064Z,1607463776.064 [NAL9602](ERROR): Data Fault
2020-12-08T21:42:56.091Z,1607463776.091 [CBIT](ERROR): Data Fault in component: NAL9602
2020-12-08T21:42:56.466Z,1607463776.466 [NAL9602](INFO): Powering down
2020-12-08T21:42:57.297Z,1607463777.297 [CBIT](INFO): Clearing failed state for component NAL9602
2020-12-08T21:42:57.297Z,1607463777.297 [NAL9602] No Fault, FailCount= 1
2020-12-08T21:43:26.770Z,1607463806.770 [NAL9602](INFO): Powering up NAL9602
2020-12-08T21:43:37.678Z,1607463817.678 [NAL9602](INFO): NAL9602 initialized
2020-12-08T21:44:18.088Z,1607463858.088 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-12-08T21:44:18.088Z,1607463858.088 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:44:18.098Z,1607463858.098 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-08T21:44:18.507Z,1607463858.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-08T21:44:18.508Z,1607463858.508 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-12-08T21:44:23.800Z,1607463863.800 [CommandLine](INFO): End of History
2020-12-08T21:44:23.811Z,1607463863.811 [CommandLine](INFO): End of History
2020-12-08T21:44:23.813Z,1607463863.813 [CommandLine](INFO): End of History
2020-12-08T21:44:23.870Z,1607463863.870 [CommandLine](INFO): End of History
2020-12-08T21:44:23.871Z,1607463863.871 [CommandLine](INFO): End of History
2020-12-08T21:44:23.874Z,1607463863.874 [CommandLine](INFO): End of History
2020-12-08T21:44:23.875Z,1607463863.875 [CommandLine](INFO): End of History
2020-12-08T21:44:23.899Z,1607463863.899 [CommandLine](INFO): End of History
2020-12-08T21:44:23.902Z,1607463863.902 [CommandLine](INFO): End of History
2020-12-08T21:44:23.904Z,1607463863.904 [CommandLine](INFO): End of History
2020-12-08T21:44:23.915Z,1607463863.915 [CommandLine](INFO): End of History
2020-12-08T21:44:23.998Z,1607463863.998 [CommandLine](INFO): End of History
2020-12-08T21:44:24.000Z,1607463864.000 [CommandLine](INFO): End of History
2020-12-08T21:44:24.002Z,1607463864.002 [CommandLine](INFO): End of History
2020-12-08T21:44:24.004Z,1607463864.004 [CommandLine](INFO): End of History
2020-12-08T21:44:24.512Z,1607463864.512 [CommandLine](INFO): End of History
2020-12-08T21:44:24.520Z,1607463864.520 [CommandLine](INFO): End of History
2020-12-08T21:44:24.528Z,1607463864.528 [CommandLine](INFO): End of History
2020-12-08T21:44:24.545Z,1607463864.545 [CommandLine](INFO): End of History
2020-12-08T21:44:24.609Z,1607463864.609 [CommandLine](INFO): End of History
2020-12-08T21:44:24.611Z,1607463864.611 [CommandLine](INFO): End of History
2020-12-08T21:44:24.613Z,1607463864.613 [CommandLine](INFO): End of History
2020-12-08T21:44:24.615Z,1607463864.615 [CommandLine](INFO): End of History
2020-12-08T21:44:24.617Z,1607463864.617 [CommandLine](INFO): End of History
2020-12-08T21:44:24.619Z,1607463864.619 [CommandLine](INFO): End of History
2020-12-08T21:44:24.630Z,1607463864.630 [CommandLine](INFO): End of History
2020-12-08T21:44:24.632Z,1607463864.632 [CommandLine](INFO): End of History
2020-12-08T21:44:24.634Z,1607463864.634 [CommandLine](INFO): End of History
2020-12-08T21:44:24.635Z,1607463864.635 [CommandLine](INFO): End of History
2020-12-08T21:44:24.654Z,1607463864.654 [CommandLine](INFO): End of History
2020-12-08T21:44:24.656Z,1607463864.656 [CommandLine](INFO): End of History
2020-12-08T21:44:24.793Z,1607463864.793 [CommandLine](INFO): End of History
2020-12-08T21:44:24.795Z,1607463864.795 [CommandLine](INFO): End of History
2020-12-08T21:44:24.797Z,1607463864.797 [CommandLine](INFO): End of History
2020-12-08T21:44:24.799Z,1607463864.799 [CommandLine](INFO): End of History
2020-12-08T21:44:25.912Z,1607463865.912 [CommandLine](INFO): End of History
2020-12-08T21:44:25.921Z,1607463865.921 [CommandLine](INFO): End of History
2020-12-08T21:44:25.930Z,1607463865.930 [CommandLine](INFO): End of History
2020-12-08T21:44:25.937Z,1607463865.937 [CommandLine](INFO): End of History
2020-12-08T21:44:25.946Z,1607463865.946 [CommandLine](INFO): End of History
2020-12-08T21:44:25.948Z,1607463865.948 [CommandLine](INFO): End of History
2020-12-08T21:44:25.950Z,1607463865.950 [CommandLine](INFO): End of History
2020-12-08T21:44:25.957Z,1607463865.957 [CommandLine](INFO): End of History
2020-12-08T21:44:26.023Z,1607463866.023 [CommandLine](INFO): End of History
2020-12-08T21:44:26.025Z,1607463866.025 [CommandLine](INFO): End of History
2020-12-08T21:44:26.027Z,1607463866.027 [CommandLine](INFO): End of History
2020-12-08T21:44:26.030Z,1607463866.030 [CommandLine](INFO): End of History
2020-12-08T21:44:26.032Z,1607463866.032 [CommandLine](INFO): End of History
2020-12-08T21:44:26.034Z,1607463866.034 [CommandLine](INFO): End of History
2020-12-08T21:44:26.036Z,1607463866.036 [CommandLine](INFO): End of History
2020-12-08T21:44:26.047Z,1607463866.047 [CommandLine](INFO): End of History
2020-12-08T21:44:26.048Z,1607463866.048 [CommandLine](INFO): End of History
2020-12-08T21:44:26.055Z,1607463866.055 [CommandLine](INFO): End of History
2020-12-08T21:44:26.061Z,1607463866.061 [CommandLine](INFO): End of History
2020-12-08T21:44:26.063Z,1607463866.063 [CommandLine](INFO): End of History
2020-12-08T21:44:26.079Z,1607463866.079 [CommandLine](INFO): End of History
2020-12-08T21:44:26.081Z,1607463866.081 [CommandLine](INFO): End of History
2020-12-08T21:44:26.083Z,1607463866.083 [CommandLine](INFO): End of History
2020-12-08T21:44:26.101Z,1607463866.101 [CommandLine](INFO): End of History
2020-12-08T21:44:26.103Z,1607463866.103 [CommandLine](INFO): End of History
2020-12-08T21:44:26.105Z,1607463866.105 [CommandLine](INFO): End of History
2020-12-08T21:44:26.107Z,1607463866.107 [CommandLine](INFO): End of History
2020-12-08T21:44:26.126Z,1607463866.126 [CommandLine](INFO): End of History
2020-12-08T21:44:26.687Z,1607463866.687 [CommandLine](INFO): End of History
2020-12-08T21:44:26.697Z,1607463866.697 [CommandLine](INFO): End of History
2020-12-08T21:44:26.725Z,1607463866.725 [CommandLine](INFO): End of History
2020-12-08T21:44:26.727Z,1607463866.727 [CommandLine](INFO): End of History
2020-12-08T21:44:26.742Z,1607463866.742 [CommandLine](INFO): End of History
2020-12-08T21:44:26.744Z,1607463866.744 [CommandLine](INFO): End of History
2020-12-08T21:44:26.746Z,1607463866.746 [CommandLine](INFO): End of History
2020-12-08T21:44:26.748Z,1607463866.748 [CommandLine](INFO): End of History
2020-12-08T21:44:26.751Z,1607463866.751 [CommandLine](INFO): End of History
2020-12-08T21:44:26.753Z,1607463866.753 [CommandLine](INFO): End of History
2020-12-08T21:44:26.755Z,1607463866.755 [CommandLine](INFO): End of History
2020-12-08T21:44:26.781Z,1607463866.781 [CommandLine](INFO): End of History
2020-12-08T21:44:26.852Z,1607463866.852 [CommandLine](INFO): End of History
2020-12-08T21:44:26.854Z,1607463866.854 [CommandLine](INFO): End of History
2020-12-08T21:44:26.856Z,1607463866.856 [CommandLine](INFO): End of History
2020-12-08T21:44:26.858Z,1607463866.858 [CommandLine](INFO): End of History
2020-12-08T21:44:26.859Z,1607463866.859 [CommandLine](INFO): End of History
2020-12-08T21:44:26.861Z,1607463866.861 [CommandLine](INFO): End of History
2020-12-08T21:44:26.863Z,1607463866.863 [CommandLine](INFO): End of History
2020-12-08T21:44:26.865Z,1607463866.865 [CommandLine](INFO): End of History
2020-12-08T21:44:26.867Z,1607463866.867 [CommandLine](INFO): End of History
2020-12-08T21:44:26.869Z,1607463866.869 [CommandLine](INFO): End of History
2020-12-08T21:44:26.871Z,1607463866.871 [CommandLine](INFO): End of History
2020-12-08T21:44:26.909Z,1607463866.909 [CommandLine](INFO): End of History
2020-12-08T21:44:26.911Z,1607463866.911 [CommandLine](INFO): End of History
2020-12-08T21:44:26.921Z,1607463866.921 [CommandLine](INFO): End of History
2020-12-08T21:44:26.923Z,1607463866.923 [CommandLine](INFO): End of History
2020-12-08T21:44:26.925Z,1607463866.925 [CommandLine](INFO): End of History
2020-12-08T21:44:27.696Z,1607463867.696 [CommandLine](INFO): End of History
2020-12-08T21:44:27.704Z,1607463867.704 [CommandLine](INFO): End of History
2020-12-08T21:44:27.709Z,1607463867.709 [CommandLine](INFO): End of History
2020-12-08T21:44:27.711Z,1607463867.711 [CommandLine](INFO): End of History
2020-12-08T21:44:27.727Z,1607463867.727 [CommandLine](INFO): End of History
2020-12-08T21:44:27.737Z,1607463867.737 [CommandLine](INFO): End of History
2020-12-08T21:44:27.739Z,1607463867.739 [CommandLine](INFO): End of History
2020-12-08T21:44:27.741Z,1607463867.741 [CommandLine](INFO): End of History
2020-12-08T21:44:27.850Z,1607463867.850 [CommandLine](INFO): End of History
2020-12-08T21:44:27.852Z,1607463867.852 [CommandLine](INFO): End of History
2020-12-08T21:44:27.854Z,1607463867.854 [CommandLine](INFO): End of History
2020-12-08T21:44:27.855Z,1607463867.855 [CommandLine](INFO): End of History
2020-12-08T21:44:27.857Z,1607463867.857 [CommandLine](INFO): End of History
2020-12-08T21:44:27.859Z,1607463867.859 [CommandLine](INFO): End of History
2020-12-08T21:44:27.861Z,1607463867.861 [CommandLine](INFO): End of History
2020-12-08T21:44:27.865Z,1607463867.865 [CommandLine](INFO): End of History
2020-12-08T21:44:27.955Z,1607463867.955 [CommandLine](INFO): End of History
2020-12-08T21:44:27.957Z,1607463867.957 [CommandLine](INFO): End of History
2020-12-08T21:44:27.959Z,1607463867.959 [CommandLine](INFO): End of History
2020-12-08T21:44:27.961Z,1607463867.961 [CommandLine](INFO): End of History
2020-12-08T21:44:30.036Z,1607463870.036 [CommandLine](INFO): End of History
2020-12-08T21:44:30.044Z,1607463870.044 [CommandLine](INFO): End of History
2020-12-08T21:44:30.049Z,1607463870.049 [CommandLine](INFO): End of History
2020-12-08T21:44:30.060Z,1607463870.060 [CommandLine](INFO): End of History
2020-12-08T21:44:30.062Z,1607463870.062 [CommandLine](INFO): End of History
2020-12-08T21:44:30.064Z,1607463870.064 [CommandLine](INFO): End of History
2020-12-08T21:44:30.071Z,1607463870.071 [CommandLine](INFO): End of History
2020-12-08T21:44:30.139Z,1607463870.139 [CommandLine](INFO): End of History
2020-12-08T21:44:30.141Z,1607463870.141 [CommandLine](INFO): End of History
2020-12-08T21:44:30.143Z,1607463870.143 [CommandLine](INFO): End of History
2020-12-08T21:44:30.145Z,1607463870.145 [CommandLine](INFO): End of History
2020-12-08T21:44:30.147Z,1607463870.147 [CommandLine](INFO): End of History
2020-12-08T21:44:30.149Z,1607463870.149 [CommandLine](INFO): End of History
2020-12-08T21:44:30.151Z,1607463870.151 [CommandLine](INFO): End of History
2020-12-08T21:44:30.162Z,1607463870.162 [CommandLine](INFO): End of History
2020-12-08T21:44:30.163Z,1607463870.163 [CommandLine](INFO): End of History
2020-12-08T21:44:30.166Z,1607463870.166 [CommandLine](INFO): End of History
2020-12-08T21:44:30.167Z,1607463870.167 [CommandLine](INFO): End of History
2020-12-08T21:44:30.174Z,1607463870.174 [CommandLine](INFO): End of History
2020-12-08T21:44:30.176Z,1607463870.176 [CommandLine](INFO): End of History
2020-12-08T21:44:30.218Z,1607463870.218 [CommandLine](INFO): End of History
2020-12-08T21:44:30.220Z,1607463870.220 [CommandLine](INFO): End of History
2020-12-08T21:44:30.234Z,1607463870.234 [CommandLine](INFO): End of History
2020-12-08T21:44:30.495Z,1607463870.495 [CommandLine](INFO): End of History
2020-12-08T21:44:30.497Z,1607463870.497 [CommandLine](INFO): End of History
2020-12-08T21:44:30.499Z,1607463870.499 [CommandLine](INFO): End of History
2020-12-08T21:44:30.501Z,1607463870.501 [CommandLine](INFO): End of History
2020-12-08T21:44:30.563Z,1607463870.563 [CommandLine](INFO): End of History
2020-12-08T21:44:30.565Z,1607463870.565 [CommandLine](INFO): End of History
2020-12-08T21:44:30.567Z,1607463870.567 [CommandLine](INFO): End of History
2020-12-08T21:44:30.570Z,1607463870.570 [CommandLine](INFO): End of History
2020-12-08T21:44:30.572Z,1607463870.572 [CommandLine](INFO): End of History
2020-12-08T21:44:30.574Z,1607463870.574 [CommandLine](INFO): End of History
2020-12-08T21:44:30.576Z,1607463870.576 [CommandLine](INFO): End of History
2020-12-08T21:44:30.578Z,1607463870.578 [CommandLine](INFO): End of History
2020-12-08T21:44:30.580Z,1607463870.580 [CommandLine](INFO): End of History
2020-12-08T21:44:30.638Z,1607463870.638 [CommandLine](INFO): End of History
2020-12-08T21:44:30.640Z,1607463870.640 [CommandLine](INFO): End of History
2020-12-08T21:44:30.654Z,1607463870.654 [CommandLine](INFO): End of History
2020-12-08T21:44:30.656Z,1607463870.656 [CommandLine](INFO): End of History
2020-12-08T21:44:30.658Z,1607463870.658 [CommandLine](INFO): End of History
2020-12-08T21:44:30.660Z,1607463870.660 [CommandLine](INFO): End of History
2020-12-08T21:44:30.683Z,1607463870.683 [CommandLine](INFO): End of History
2020-12-08T21:44:30.685Z,1607463870.685 [CommandLine](INFO): End of History
2020-12-08T21:44:30.687Z,1607463870.687 [CommandLine](INFO): End of History
2020-12-08T21:44:30.705Z,1607463870.705 [CommandLine](INFO): End of History
2020-12-08T21:44:30.707Z,1607463870.707 [CommandLine](INFO): End of History
2020-12-08T21:44:31.608Z,1607463871.608 [CommandLine](INFO): End of History
2020-12-08T21:44:31.616Z,1607463871.616 [CommandLine](INFO): End of History
2020-12-08T21:44:31.651Z,1607463871.651 [CommandLine](INFO): End of History
2020-12-08T21:44:31.653Z,1607463871.653 [CommandLine](INFO): End of History
2020-12-08T21:44:31.655Z,1607463871.655 [CommandLine](INFO): End of History
2020-12-08T21:44:31.668Z,1607463871.668 [CommandLine](INFO): End of History
2020-12-08T21:44:31.670Z,1607463871.670 [CommandLine](INFO): End of History
2020-12-08T21:44:31.672Z,1607463871.672 [CommandLine](INFO): End of History
2020-12-08T21:44:31.695Z,1607463871.695 [CommandLine](INFO): End of History
2020-12-08T21:44:31.696Z,1607463871.696 [CommandLine](INFO): End of History
2020-12-08T21:44:31.698Z,1607463871.698 [CommandLine](INFO): End of History
2020-12-08T21:44:31.700Z,1607463871.700 [CommandLine](INFO): End of History
2020-12-08T21:44:31.702Z,1607463871.702 [CommandLine](INFO): End of History
2020-12-08T21:44:31.704Z,1607463871.704 [CommandLine](INFO): End of History
2020-12-08T21:44:31.718Z,1607463871.718 [CommandLine](INFO): End of History
2020-12-08T21:44:31.720Z,1607463871.720 [CommandLine](INFO): End of History
2020-12-08T21:44:31.722Z,1607463871.722 [CommandLine](INFO): End of History
2020-12-08T21:44:31.724Z,1607463871.724 [CommandLine](INFO): End of History
2020-12-08T21:44:31.758Z,1607463871.758 [CommandLine](INFO): End of History
2020-12-08T21:44:31.760Z,1607463871.760 [CommandLine](INFO): End of History
2020-12-08T21:44:31.833Z,1607463871.833 [CommandLine](INFO): End of History
2020-12-08T21:44:31.835Z,1607463871.835 [CommandLine](INFO): End of History
2020-12-08T21:44:31.837Z,1607463871.837 [CommandLine](INFO): End of History
2020-12-08T21:44:31.839Z,1607463871.839 [CommandLine](INFO): End of History
2020-12-08T21:44:31.854Z,1607463871.854 [CommandLine](INFO): End of History
2020-12-08T21:44:31.856Z,1607463871.856 [CommandLine](INFO): End of History
2020-12-08T21:44:31.858Z,1607463871.858 [CommandLine](INFO): End of History
2020-12-08T21:44:31.860Z,1607463871.860 [CommandLine](INFO): End of History
2020-12-08T21:44:35.212Z,1607463875.212 [CommandLine](INFO): End of History
2020-12-08T21:44:35.220Z,1607463875.220 [CommandLine](INFO): End of History
2020-12-08T21:44:35.230Z,1607463875.230 [CommandLine](INFO): End of History
2020-12-08T21:44:35.736Z,1607463875.736 [CommandLine](INFO): End of History
2020-12-08T21:44:35.744Z,1607463875.744 [CommandLine](INFO): End of History
2020-12-08T21:44:35.746Z,1607463875.746 [CommandLine](INFO): End of History
2020-12-08T21:44:35.748Z,1607463875.748 [CommandLine](INFO): End of History
2020-12-08T21:44:37.967Z,1607463877.967 [CommandLine](INFO): End of History
2020-12-08T21:44:37.969Z,1607463877.969 [CommandLine](INFO): End of History
2020-12-08T21:44:37.971Z,1607463877.971 [CommandLine](INFO): End of History
2020-12-08T21:44:37.981Z,1607463877.981 [CommandLine](INFO): End of History
2020-12-08T21:44:38.488Z,1607463878.488 [CommandLine](INFO): End of History
2020-12-08T21:44:38.496Z,1607463878.496 [CommandLine](INFO): End of History
2020-12-08T21:44:38.501Z,1607463878.501 [CommandLine](INFO): End of History
2020-12-08T21:44:38.503Z,1607463878.503 [CommandLine](INFO): End of History
2020-12-08T21:44:38.563Z,1607463878.563 [CommandLine](INFO): End of History
2020-12-08T21:44:38.565Z,1607463878.565 [CommandLine](INFO): End of History
2020-12-08T21:44:38.567Z,1607463878.567 [CommandLine](INFO): End of History
2020-12-08T21:44:38.573Z,1607463878.573 [CommandLine](INFO): End of History
2020-12-08T21:47:15.855Z,1607464035.855 [CBIT](INFO): Clearing failed state for component DropWeight
2020-12-08T21:47:15.856Z,1607464035.856 [DropWeight] No Fault, FailCount= 1
2020-12-08T21:47:17.880Z,1607464037.880 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-12-08T21:47:17.880Z,1607464037.880 [Default:CheckIn:C.Wait] Stopped
2020-12-08T21:47:17.880Z,1607464037.880 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-08T21:47:17.880Z,1607464037.880 [Default:CheckIn:D] Running Loop=1
2020-12-08T21:47:18.284Z,1607464038.284 [Default:CheckIn:D] Stopped
2020-12-08T21:47:18.284Z,1607464038.284 [Default:CheckIn:E] Running Loop=1
2020-12-08T21:47:18.675Z,1607464038.675 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.393954 min
2020-12-08T21:47:18.675Z,1607464038.675 [Default:CheckIn:E] Stopped
2020-12-08T21:47:18.675Z,1607464038.675 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-12-08T21:47:18.675Z,1607464038.675 [Default:CheckIn] Stopped
2020-12-08T21:47:18.675Z,1607464038.675 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-12-08T21:47:18.675Z,1607464038.675 [Default:CheckIn](INFO): Running loop #2
2020-12-08T21:47:18.675Z,1607464038.675 [Default:CheckIn] Running Loop=2
2020-12-08T21:47:18.676Z,1607464038.676 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-12-08T21:47:18.676Z,1607464038.676 [Default:CheckIn:Read_GPS] Running Loop=1
2020-12-08T21:47:19.082Z,1607464039.082 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-12-08T21:47:19.082Z,1607464039.082 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:47:19.091Z,1607464039.091 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-08T21:47:19.499Z,1607464039.499 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-08T21:47:19.499Z,1607464039.499 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-12-08T21:49:06.953Z,1607464146.953 [CommandLine](IMPORTANT): got command ! sbit
2020-12-08T21:50:10.424Z,1607464210.424 [CommandLine](INFO): End of History
2020-12-08T21:50:10.442Z,1607464210.442 [CommandLine](INFO): End of History
2020-12-08T21:50:10.469Z,1607464210.469 [CommandLine](INFO): End of History
2020-12-08T21:50:10.471Z,1607464210.471 [CommandLine](INFO): End of History
2020-12-08T21:50:10.487Z,1607464210.487 [CommandLine](INFO): End of History
2020-12-08T21:50:10.489Z,1607464210.489 [CommandLine](INFO): End of History
2020-12-08T21:50:10.583Z,1607464210.583 [CommandLine](INFO): End of History
2020-12-08T21:50:10.586Z,1607464210.586 [CommandLine](INFO): End of History
2020-12-08T21:50:10.588Z,1607464210.588 [CommandLine](INFO): End of History
2020-12-08T21:50:10.590Z,1607464210.590 [CommandLine](INFO): End of History
2020-12-08T21:50:10.675Z,1607464210.675 [CommandLine](INFO): End of History
2020-12-08T21:50:10.680Z,1607464210.680 [CommandLine](INFO): End of History
2020-12-08T21:50:10.682Z,1607464210.682 [CommandLine](INFO): End of History
2020-12-08T21:50:10.684Z,1607464210.684 [CommandLine](INFO): End of History
2020-12-08T21:50:10.702Z,1607464210.702 [CommandLine](INFO): End of History
2020-12-08T21:50:10.704Z,1607464210.704 [CommandLine](INFO): End of History
2020-12-08T21:50:10.711Z,1607464210.711 [CommandLine](INFO): End of History
2020-12-08T21:50:10.725Z,1607464210.725 [CommandLine](INFO): End of History
2020-12-08T21:50:18.922Z,1607464218.922 [CommandLine](IMPORTANT): got command ! ibit
2020-12-08T21:50:20.075Z,1607464220.075 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-12-08T21:50:20.076Z,1607464220.076 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:50:20.086Z,1607464220.086 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-08T21:50:20.498Z,1607464220.498 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-08T21:50:20.498Z,1607464220.498 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-12-08T21:52:18.847Z,1607464338.847 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-12-08T21:47:18.7Z
2020-12-08T21:52:18.847Z,1607464338.847 [Default:CheckIn:Read_GPS] Stopped
2020-12-08T21:52:18.847Z,1607464338.847 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-12-08T21:52:33.960Z,1607464353.960 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201208T213204/Courier0007.lzma
2020-12-08T21:52:34.963Z,1607464354.963 [DataOverHttps](INFO): Moved sent file to Logs/20201208T213204/Courier0007.lzma.bak
2020-12-08T21:52:34.963Z,1607464354.963 [DataOverHttps](INFO): SBD MOMSN=13421367
2020-12-08T21:52:50.272Z,1607464370.272 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20201208T213204/Express0008.lzma
2020-12-08T21:52:51.275Z,1607464371.275 [DataOverHttps](INFO): Moved sent file to Logs/20201208T213204/Express0008.lzma.bak
2020-12-08T21:52:51.275Z,1607464371.275 [DataOverHttps](INFO): SBD MOMSN=13421369
2020-12-08T21:52:52.803Z,1607464372.803 [Default:CheckIn:Read_Iridium] Stopped
2020-12-08T21:52:52.803Z,1607464372.803 [Default:CheckIn:C.Wait] Running Loop=1
2020-12-08T21:52:52.803Z,1607464372.803 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-08T21:53:21.062Z,1607464401.062 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2020-12-08T21:53:21.062Z,1607464401.062 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:53:21.100Z,1607464401.100 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-08T21:53:21.477Z,1607464401.477 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-08T21:53:21.477Z,1607464401.477 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2020-12-08T21:53:39.634Z,1607464419.634 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-12-08T21:53:39.635Z,1607464419.635 [NAL9602] Data Fault, FailCount= 2
2020-12-08T21:53:39.635Z,1607464419.635 [NAL9602](ERROR): Data Fault
2020-12-08T21:53:39.650Z,1607464419.650 [CBIT](ERROR): Data Fault in component: NAL9602
2020-12-08T21:53:40.042Z,1607464420.042 [NAL9602](INFO): Powering down
2020-12-08T21:53:40.882Z,1607464420.882 [CBIT](INFO): Clearing failed state for component NAL9602
2020-12-08T21:53:40.882Z,1607464420.882 [NAL9602] No Fault, FailCount= 2
2020-12-08T21:54:10.357Z,1607464450.357 [NAL9602](INFO): Powering up NAL9602
2020-12-08T21:54:21.250Z,1607464461.250 [NAL9602](INFO): NAL9602 initialized
2020-12-08T21:56:18.413Z,1607464578.413 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2020-12-08T21:56:19.368Z,1607464579.368 [Depth_Keller](INFO): A/D timeout, 8 tries over 142 ms
2020-12-08T21:56:19.368Z,1607464579.368 [Depth_Keller] Data Fault, FailCount= 1
2020-12-08T21:56:19.368Z,1607464579.368 [Depth_Keller](ERROR): Data Fault
2020-12-08T21:56:19.473Z,1607464579.473 [CBIT](ERROR): Data Fault in component: Depth_Keller
2020-12-08T21:56:19.474Z,1607464579.474 [CBIT](INFO): Clearing failed state for component Depth_Keller
2020-12-08T21:56:19.474Z,1607464579.474 [Depth_Keller] No Fault, FailCount= 1
2020-12-08T21:56:20.817Z,1607464580.817 [ElevatorServo](ERROR): getPosition uart error serial timeout
2020-12-08T21:56:20.817Z,1607464580.817 [ElevatorServo](FAULT): Elevator uart error - getPosition.serial timeout
2020-12-08T21:56:20.817Z,1607464580.817 [ElevatorServo] Communications Fault, FailCount= 1
2020-12-08T21:56:20.817Z,1607464580.817 [ElevatorServo](ERROR): Communications Fault
2020-12-08T21:56:20.818Z,1607464580.818 [MassServo](FAULT): Command Overflow Error
2020-12-08T21:56:20.822Z,1607464580.822 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2020-12-08T21:56:20.943Z,1607464580.943 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-12-08T21:56:20.944Z,1607464580.944 [ElevatorServo](INFO): Powering down
2020-12-08T21:56:21.727Z,1607464581.727 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:56:21.727Z,1607464581.727 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-12-08T21:56:21.744Z,1607464581.744 [CBIT](INFO): Clearing failed state for component ElevatorServo
2020-12-08T21:56:21.744Z,1607464581.744 [ElevatorServo] No Fault, FailCount= 1
2020-12-08T21:56:22.101Z,1607464582.101 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2020-12-08T21:56:22.101Z,1607464582.101 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:56:22.114Z,1607464582.114 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-08T21:56:22.666Z,1607464582.666 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-08T21:56:22.666Z,1607464582.666 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2020-12-08T21:56:24.181Z,1607464584.181 [ElevatorServo](FAULT): Command Overflow Error
2020-12-08T21:56:24.181Z,1607464584.181 [ElevatorServo](FAULT): Elevator initialization uart error:no error
2020-12-08T21:56:24.181Z,1607464584.181 [ElevatorServo] Communications Fault, FailCount= 2
2020-12-08T21:56:24.181Z,1607464584.181 [ElevatorServo](ERROR): Communications Fault
2020-12-08T21:56:24.197Z,1607464584.197 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2020-12-08T21:56:24.563Z,1607464584.563 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-12-08T21:56:24.563Z,1607464584.563 [ElevatorServo](INFO): Powering down
2020-12-08T21:56:25.423Z,1607464585.423 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:56:25.423Z,1607464585.423 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-12-08T21:56:25.452Z,1607464585.452 [CBIT](INFO): Clearing failed state for component ElevatorServo
2020-12-08T21:56:25.452Z,1607464585.452 [ElevatorServo] No Fault, FailCount= 2
2020-12-08T21:57:14.623Z,1607464634.623 [NAL9602](ERROR): parseGSV uart error: serial timeout
2020-12-08T21:57:16.233Z,1607464636.233 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-08T21:57:16.233Z,1607464636.233 [AHRS_M2] Data Fault, FailCount= 1
2020-12-08T21:57:16.233Z,1607464636.233 [AHRS_M2](ERROR): Data Fault
2020-12-08T21:57:16.303Z,1607464636.303 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-08T21:57:16.625Z,1607464636.625 [AHRS_M2](INFO): Powering down
2020-12-08T21:57:17.490Z,1607464637.490 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-08T21:57:17.490Z,1607464637.490 [AHRS_M2] No Fault, FailCount= 1
2020-12-08T21:57:17.837Z,1607464637.837 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-08T21:57:49.437Z,1607464669.437 [NAL9602](ERROR): parseGSV uart error: serial timeout
2020-12-08T21:57:50.577Z,1607464670.577 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-08T21:57:50.577Z,1607464670.577 [AHRS_M2] Data Fault, FailCount= 1
2020-12-08T21:57:50.577Z,1607464670.577 [AHRS_M2](ERROR): Data Fault
2020-12-08T21:57:50.627Z,1607464670.627 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-08T21:57:50.969Z,1607464670.969 [AHRS_M2](INFO): Powering down
2020-12-08T21:57:51.818Z,1607464671.818 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-08T21:57:51.818Z,1607464671.818 [AHRS_M2] No Fault, FailCount= 1
2020-12-08T21:57:52.181Z,1607464672.181 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-08T21:57:53.429Z,1607464673.429 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-12-08T21:57:53.430Z,1607464673.430 [Default:CheckIn:C.Wait] Stopped
2020-12-08T21:57:53.430Z,1607464673.430 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-08T21:57:53.430Z,1607464673.430 [Default:CheckIn:D] Running Loop=1
2020-12-08T21:57:53.826Z,1607464673.826 [Default:CheckIn:D] Stopped
2020-12-08T21:57:53.826Z,1607464673.826 [Default:CheckIn:E] Running Loop=1
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.986314 min
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn:E] Stopped
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn] Stopped
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn](INFO): Running loop #3
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn] Running Loop=3
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-12-08T21:57:54.223Z,1607464674.223 [Default:CheckIn:Read_GPS] Running Loop=1
2020-12-08T21:58:20.985Z,1607464700.985 [NAL9602](ERROR): getFix uart error: serial timeout
2020-12-08T21:58:25.109Z,1607464705.109 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-08T21:58:25.109Z,1607464705.109 [AHRS_M2] Data Fault, FailCount= 1
2020-12-08T21:58:25.109Z,1607464705.109 [AHRS_M2](ERROR): Data Fault
2020-12-08T21:58:25.219Z,1607464705.219 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-08T21:58:25.501Z,1607464705.501 [AHRS_M2](INFO): Powering down
2020-12-08T21:58:26.385Z,1607464706.385 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-08T21:58:26.386Z,1607464706.386 [AHRS_M2] No Fault, FailCount= 1
2020-12-08T21:58:26.713Z,1607464706.713 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-08T21:58:38.005Z,1607464718.005 [MassServo](ERROR): getPosition uart error serial timeout
2020-12-08T21:58:38.005Z,1607464718.005 [MassServo](FAULT): Invalid EZ Servo response:""
2020-12-08T21:58:38.005Z,1607464718.005 [MassServo] Communications Fault, FailCount= 1
2020-12-08T21:58:38.005Z,1607464718.005 [MassServo](ERROR): Communications Fault
2020-12-08T21:58:38.009Z,1607464718.009 [CBIT](ERROR): Communications Fault in component: MassServo
2020-12-08T21:58:38.106Z,1607464718.106 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-12-08T21:58:38.106Z,1607464718.106 [MassServo](INFO): Powering down
2020-12-08T21:58:38.980Z,1607464718.980 [MassServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:58:38.980Z,1607464718.980 [MassServo](DEBUG): Initializing MassServo.
2020-12-08T21:58:38.986Z,1607464718.986 [CBIT](INFO): Clearing failed state for component MassServo
2020-12-08T21:58:38.986Z,1607464718.986 [MassServo] No Fault, FailCount= 1
2020-12-08T21:58:41.653Z,1607464721.653 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2020-12-08T21:58:41.653Z,1607464721.653 [MassServo] Communications Fault, FailCount= 2
2020-12-08T21:58:41.653Z,1607464721.653 [MassServo](ERROR): Communications Fault
2020-12-08T21:58:41.676Z,1607464721.676 [CBIT](ERROR): Communications Fault in component: MassServo
2020-12-08T21:58:41.731Z,1607464721.731 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-12-08T21:58:41.732Z,1607464721.732 [MassServo](INFO): Powering down
2020-12-08T21:58:42.553Z,1607464722.553 [MassServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:58:42.553Z,1607464722.553 [MassServo](DEBUG): Initializing MassServo.
2020-12-08T21:58:42.557Z,1607464722.557 [CBIT](INFO): Clearing failed state for component MassServo
2020-12-08T21:58:42.557Z,1607464722.557 [MassServo] No Fault, FailCount= 2
2020-12-08T21:58:44.881Z,1607464724.881 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2020-12-08T21:58:44.881Z,1607464724.881 [MassServo] Communications Fault, FailCount= 3
2020-12-08T21:58:44.881Z,1607464724.881 [MassServo](ERROR): Communications Fault
2020-12-08T21:58:44.885Z,1607464724.885 [CBIT](ERROR): Communications Fault in component: MassServo
2020-12-08T21:58:44.968Z,1607464724.968 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-12-08T21:58:44.968Z,1607464724.968 [MassServo](INFO): Powering down
2020-12-08T21:58:45.797Z,1607464725.797 [MassServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:58:45.798Z,1607464725.798 [MassServo](DEBUG): Initializing MassServo.
2020-12-08T21:58:45.802Z,1607464725.802 [CBIT](INFO): Clearing failed state for component MassServo
2020-12-08T21:58:45.802Z,1607464725.802 [MassServo] No Fault, FailCount= 3
2020-12-08T21:58:48.894Z,1607464728.894 [MassServo](FAULT): Mass initialization uart error:serial timeout
2020-12-08T21:58:48.894Z,1607464728.894 [MassServo] Communications Fault, FailCount= 4
2020-12-08T21:58:48.894Z,1607464728.894 [MassServo](ERROR): Communications Fault
2020-12-08T21:58:48.904Z,1607464728.904 [CBIT](ERROR): Communications Fault in component: MassServo
2020-12-08T21:58:49.060Z,1607464729.060 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-12-08T21:58:49.060Z,1607464729.060 [MassServo](INFO): Powering down
2020-12-08T21:58:49.815Z,1607464729.815 [MassServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:58:49.816Z,1607464729.816 [MassServo](DEBUG): Initializing MassServo.
2020-12-08T21:58:49.840Z,1607464729.840 [CBIT](INFO): Clearing failed state for component MassServo
2020-12-08T21:58:49.840Z,1607464729.840 [MassServo] No Fault, FailCount= 4
2020-12-08T21:58:52.513Z,1607464732.513 [MassServo](FAULT): Mass initialization uart error:serial timeout
2020-12-08T21:58:52.513Z,1607464732.513 [MassServo] Communications Fault, FailCount= 5
2020-12-08T21:58:52.513Z,1607464732.513 [MassServo](ERROR): Communications Fault
2020-12-08T21:58:52.545Z,1607464732.545 [CBIT](ERROR): Communications Fault in component: MassServo
2020-12-08T21:58:52.546Z,1607464732.546 [CBIT](CRITICAL): Communications Fault in component: MassServo
2020-12-08T21:58:52.691Z,1607464732.691 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-12-08T21:58:52.691Z,1607464732.691 [MassServo](INFO): Powering down
2020-12-08T21:58:52.713Z,1607464732.713 [CBIT](INFO): Critical error at 20201208T215852
2020-12-08T21:58:53.476Z,1607464733.476 [MassServo](DEBUG): Initializing EZServoServo.
2020-12-08T21:58:53.477Z,1607464733.477 [MassServo](DEBUG): Initializing MassServo.
2020-12-08T21:58:59.649Z,1607464739.649 [CBIT](CRITICAL): run-time exception #7
2020-12-08T21:58:59.649Z,1607464739.649 [CBIT](CRITICAL): Bad address: 0x4041E008
2020-12-08T21:58:59.650Z,1607464739.650 [CBIT](CRITICAL): Backtrace:
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x17ddd4]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xc8) [0x17d920]
2020-12-08T21:58:59.650Z,1607464739.650 [CBIT] Software Fault, FailCount= 1
2020-12-08T21:58:59.650Z,1607464739.650 [CBIT](ERROR): Software Fault
2020-12-08T21:58:59.661Z,1607464739.661 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-12-08T21:58:59.661Z,1607464739.661 [SyncHandler](INFO): Protected caller Thread ID is 5833
2020-12-08T21:59:00.044Z,1607464740.044 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-12-08T21:59:00.044Z,1607464740.044 [CBIT](DEBUG): Powering off loads.
2020-12-08T21:59:00.057Z,1607464740.057 [CBIT](DEBUG): Disabling WDT.
2020-12-08T21:59:00.077Z,1607464740.077 [CBIT](DEBUG): Opening all GF detection circuits.
2020-12-08T21:59:09.617Z,1607464749.617 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-08T21:59:09.617Z,1607464749.617 [AHRS_M2] Data Fault, FailCount= 1
2020-12-08T21:59:09.617Z,1607464749.617 [AHRS_M2](ERROR): Data Fault
2020-12-08T21:59:09.627Z,1607464749.627 [NAL9602](ERROR): parseGSV uart error: serial timeout
2020-12-08T21:59:10.008Z,1607464750.008 [AHRS_M2](INFO): Powering down
2020-12-08T21:59:22.950Z,1607464762.950 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2020-12-08T21:59:22.950Z,1607464762.950 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-08T21:59:32.722Z,1607464772.722 [CommandLine](IMPORTANT): got command quit
2020-12-08T21:59:33.729Z,1607464773.729 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:33.729Z,1607464773.729 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:33.849Z,1607464773.849 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2020-12-08T21:59:33.849Z,1607464773.849 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:33.850Z,1607464773.850 [CommandLine](INFO): Join timeout helper Thread ID is 5835
2020-12-08T21:59:33.856Z,1607464773.856 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-12-08T21:59:33.856Z,1607464773.856 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:33.856Z,1607464773.856 [NavChartDb](INFO): Join timeout helper Thread ID is 5836
2020-12-08T21:59:33.861Z,1607464773.861 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:33.861Z,1607464773.861 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:33.862Z,1607464773.862 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-12-08T21:59:33.862Z,1607464773.862 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:33.862Z,1607464773.862 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5837
2020-12-08T21:59:34.073Z,1607464774.073 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:34.073Z,1607464774.073 [WetLabsBB2FL](INFO): Powering down
2020-12-08T21:59:34.074Z,1607464774.074 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:34.077Z,1607464774.077 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-12-08T21:59:34.077Z,1607464774.077 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:34.077Z,1607464774.077 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5838
2020-12-08T21:59:34.713Z,1607464774.713 [CTD_Seabird](INFO): Powering down
2020-12-08T21:59:34.725Z,1607464774.725 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:34.725Z,1607464774.725 [CTD_Seabird](INFO): Powering down
2020-12-08T21:59:34.741Z,1607464774.741 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:34.745Z,1607464774.745 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-12-08T21:59:34.745Z,1607464774.745 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:34.745Z,1607464774.745 [Radio_Surface](INFO): Join timeout helper Thread ID is 5839
2020-12-08T21:59:35.037Z,1607464775.037 [Radio_Surface](INFO): Powering down
2020-12-08T21:59:35.038Z,1607464775.038 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:35.038Z,1607464775.038 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:35.050Z,1607464775.050 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-12-08T21:59:35.050Z,1607464775.050 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:35.050Z,1607464775.050 [Onboard](INFO): Join timeout helper Thread ID is 5840
2020-12-08T21:59:36.229Z,1607464776.229 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:36.229Z,1607464776.229 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:36.237Z,1607464776.237 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-12-08T21:59:36.238Z,1607464776.238 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:36.238Z,1607464776.238 [DataOverHttps](INFO): Join timeout helper Thread ID is 5841
2020-12-08T21:59:37.097Z,1607464777.097 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:37.097Z,1607464777.097 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.105Z,1607464777.105 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-12-08T21:59:37.106Z,1607464777.106 [logger ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.106Z,1607464777.106 [logger](INFO): Join timeout helper Thread ID is 5842
2020-12-08T21:59:37.133Z,1607464777.133 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:37.133Z,1607464777.133 [logger ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.145Z,1607464777.145 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-12-08T21:59:37.146Z,1607464777.146 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.146Z,1607464777.146 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-12-08T21:59:37.146Z,1607464777.146 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.146Z,1607464777.146 [controlThread](INFO): Join timeout helper Thread ID is 5843
2020-12-08T21:59:37.477Z,1607464777.477 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-08T21:59:37.477Z,1607464777.477 [controlThread](DEBUG): Uninitializing ControlThread
2020-12-08T21:59:37.477Z,1607464777.477 [AHRS_M2](INFO): Powering down
2020-12-08T21:59:37.478Z,1607464777.478 [NAL9602](INFO): Powering down
2020-12-08T21:59:37.480Z,1607464777.480 [AMEcho](INFO): Powering down
2020-12-08T21:59:37.481Z,1607464777.481 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-12-08T21:59:37.482Z,1607464777.482 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-12-08T21:59:37.482Z,1607464777.482 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-12-08T21:59:37.482Z,1607464777.482 [MissionManager](INFO): Uninitializing Mission Default
2020-12-08T21:59:37.483Z,1607464777.483 [Default] Stopped
2020-12-08T21:59:37.483Z,1607464777.483 [Default](DEBUG): Aggregate::uninitialize Default
2020-12-08T21:59:37.483Z,1607464777.483 [Default:B.GoToSurface] Stopped
2020-12-08T21:59:37.483Z,1607464777.483 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-08T21:59:37.483Z,1607464777.483 [Default:CheckIn] Stopped
2020-12-08T21:59:37.483Z,1607464777.483 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-12-08T21:59:37.483Z,1607464777.483 [Default:CheckIn:Read_GPS] Stopped
2020-12-08T21:59:37.485Z,1607464777.485 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-12-08T21:59:37.485Z,1607464777.485 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-12-08T21:59:37.486Z,1607464777.486 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-12-08T21:59:37.486Z,1607464777.486 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-12-08T21:59:37.486Z,1607464777.486 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-12-08T21:59:37.486Z,1607464777.486 [BuoyancyServo](INFO): Powering down
2020-12-08T21:59:37.501Z,1607464777.501 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-12-08T21:59:37.501Z,1607464777.501 [ElevatorServo](INFO): Powering down
2020-12-08T21:59:37.502Z,1607464777.502 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-12-08T21:59:37.502Z,1607464777.502 [MassServo](INFO): Powering down
2020-12-08T21:59:37.503Z,1607464777.503 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-12-08T21:59:37.503Z,1607464777.503 [RudderServo](INFO): Powering down
2020-12-08T21:59:37.504Z,1607464777.504 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-12-08T21:59:37.504Z,1607464777.504 [ThrusterServo](INFO): Powering down
2020-12-08T21:59:37.505Z,1607464777.505 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-12-08T21:59:37.505Z,1607464777.505 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-12-08T21:59:37.505Z,1607464777.505 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-12-08T21:59:37.505Z,1607464777.505 [CBIT](DEBUG): Powering off loads.
2020-12-08T21:59:37.517Z,1607464777.517 [CBIT](DEBUG): Disabling WDT.
2020-12-08T21:59:37.529Z,1607464777.529 [CBIT](DEBUG): Opening all GF detection circuits.
2020-12-08T21:59:37.529Z,1607464777.529 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.734Z,1607464777.734 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.736Z,1607464777.736 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.742Z,1607464777.742 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.774Z,1607464777.774 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.779Z,1607464777.779 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.821Z,1607464777.821 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-08T21:59:37.882Z,1607464777.882 [logger ThreadHandler](INFO): Thread cancelled.