2020-07-08T17:08:48.701Z,1594228128.701 [Supervisor](DEBUG): Initializing supervisor.
2020-07-08T17:08:48.703Z,1594228128.703 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-07-08T17:08:48.704Z,1594228128.704 [SyncHandler](INFO): Protected caller Thread ID is 819
2020-07-08T17:08:48.704Z,1594228128.704 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-07-08T17:08:48.705Z,1594228128.705 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-07-08T17:08:48.706Z,1594228128.706 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 820
2020-07-08T17:08:48.708Z,1594228128.708 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-07-08T17:08:48.721Z,1594228128.721 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-07-08T17:08:48.722Z,1594228128.722 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-07-08T17:08:48.723Z,1594228128.723 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 821
2020-07-08T17:08:48.723Z,1594228128.723 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-07-08T17:08:48.724Z,1594228128.724 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-07-08T17:08:48.724Z,1594228128.724 [logger ThreadHandler](INFO): Protected caller Thread ID is 822
2020-07-08T17:08:48.726Z,1594228128.726 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-07-08T17:08:48.727Z,1594228128.727 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-07-08T17:08:48.731Z,1594228128.731 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-07-08T17:08:48.825Z,1594228128.825 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-07-08T17:08:48.826Z,1594228128.826 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-07-08T17:08:49.015Z,1594228129.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-07-08T17:08:49.016Z,1594228129.016 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-07-08T17:08:49.215Z,1594228129.215 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-07-08T17:08:49.215Z,1594228129.215 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-07-08T17:08:49.349Z,1594228129.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-07-08T17:08:49.350Z,1594228129.350 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-07-08T17:08:49.928Z,1594228129.928 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-07-08T17:08:49.929Z,1594228129.929 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-07-08T17:08:50.375Z,1594228130.375 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-07-08T17:08:50.376Z,1594228130.376 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-07-08T17:08:50.830Z,1594228130.830 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-07-08T17:08:50.830Z,1594228130.830 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-07-08T17:08:51.168Z,1594228131.168 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-07-08T17:08:51.169Z,1594228131.169 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-07-08T17:08:51.490Z,1594228131.490 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-07-08T17:08:51.491Z,1594228131.491 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-07-08T17:08:51.894Z,1594228131.894 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-07-08T17:08:51.895Z,1594228131.895 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-07-08T17:08:52.076Z,1594228132.076 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-07-08T17:08:52.079Z,1594228132.079 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-07-08T17:08:52.844Z,1594228132.844 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-07-08T17:08:52.845Z,1594228132.845 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-07-08T17:08:52.927Z,1594228132.927 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-07-08T17:08:53.029Z,1594228133.029 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-07-08T17:08:53.031Z,1594228133.031 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-07-08T17:08:53.215Z,1594228133.215 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-07-08T17:08:53.216Z,1594228133.216 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-07-08T17:08:53.419Z,1594228133.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-07-08T17:08:53.421Z,1594228133.421 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2020-07-08T17:08:53.423Z,1594228133.423 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2020-07-08T17:08:53.507Z,1594228133.507 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2020-07-08T17:08:53.735Z,1594228133.735 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-07-08T17:08:53.735Z,1594228133.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2020-07-08T17:08:53.829Z,1594228133.829 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2020-07-08T17:08:53.987Z,1594228133.987 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2020-07-08T17:08:54.181Z,1594228134.181 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2020-07-08T17:08:54.265Z,1594228134.265 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2020-07-08T17:08:54.363Z,1594228134.363 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2020-07-08T17:08:54.453Z,1594228134.453 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2020-07-08T17:08:54.601Z,1594228134.601 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2020-07-08T17:08:54.702Z,1594228134.702 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2020-07-08T17:08:54.799Z,1594228134.799 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2020-07-08T17:08:54.803Z,1594228134.803 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-07-08T17:08:54.927Z,1594228134.927 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-07-08T17:08:54.928Z,1594228134.928 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-07-08T17:08:55.099Z,1594228135.099 [BuoyancyServo] Loaded
2020-07-08T17:08:55.099Z,1594228135.099 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-07-08T17:08:55.130Z,1594228135.130 [ElevatorServo] Loaded
2020-07-08T17:08:55.131Z,1594228135.131 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-07-08T17:08:55.160Z,1594228135.160 [MassServo] Loaded
2020-07-08T17:08:55.161Z,1594228135.161 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-07-08T17:08:55.191Z,1594228135.191 [RudderServo] Loaded
2020-07-08T17:08:55.192Z,1594228135.192 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-07-08T17:08:55.221Z,1594228135.221 [ThrusterServo] Loaded
2020-07-08T17:08:55.221Z,1594228135.221 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-07-08T17:08:55.221Z,1594228135.221 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-07-08T17:08:55.222Z,1594228135.222 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-07-08T17:08:55.382Z,1594228135.382 [SBIT](DEBUG): Construct Startup Built In Test.
2020-07-08T17:08:55.409Z,1594228135.409 [SBIT] Loaded
2020-07-08T17:08:55.409Z,1594228135.409 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-07-08T17:08:55.410Z,1594228135.410 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-07-08T17:08:55.439Z,1594228135.439 [IBIT] Loaded
2020-07-08T17:08:55.439Z,1594228135.439 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-07-08T17:08:55.442Z,1594228135.442 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-07-08T17:08:55.819Z,1594228135.819 [CBIT] Loaded
2020-07-08T17:08:55.819Z,1594228135.819 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-07-08T17:08:55.820Z,1594228135.820 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-07-08T17:08:55.822Z,1594228135.822 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-07-08T17:08:56.114Z,1594228136.114 [Aanderaa_O2] Loaded
2020-07-08T17:08:56.114Z,1594228136.114 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2020-07-08T17:08:56.142Z,1594228136.142 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-07-08T17:08:56.147Z,1594228136.147 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-07-08T17:08:56.148Z,1594228136.148 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-07-08T17:08:56.153Z,1594228136.153 [CTD_Seabird](INFO): created writer for : depth
2020-07-08T17:08:56.153Z,1594228136.153 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-07-08T17:08:56.159Z,1594228136.159 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-07-08T17:08:56.159Z,1594228136.159 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-07-08T17:08:56.164Z,1594228136.164 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-07-08T17:08:56.164Z,1594228136.164 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-07-08T17:08:56.170Z,1594228136.170 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-07-08T17:08:56.170Z,1594228136.170 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-07-08T17:08:56.176Z,1594228136.176 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-07-08T17:08:56.176Z,1594228136.176 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-07-08T17:08:56.181Z,1594228136.181 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-07-08T17:08:56.207Z,1594228136.207 [CTD_Seabird] Loaded
2020-07-08T17:08:56.207Z,1594228136.207 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-07-08T17:08:56.208Z,1594228136.208 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406764E0
2020-07-08T17:08:56.209Z,1594228136.209 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 905
2020-07-08T17:08:56.257Z,1594228136.257 [ESPComponent] Loaded
2020-07-08T17:08:56.257Z,1594228136.257 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-07-08T17:08:56.286Z,1594228136.286 [PAR_Licor] Loaded
2020-07-08T17:08:56.287Z,1594228136.287 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-07-08T17:08:56.308Z,1594228136.308 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-07-08T17:08:56.308Z,1594228136.308 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-07-08T17:08:56.312Z,1594228136.312 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-07-08T17:08:56.313Z,1594228136.313 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-07-08T17:08:56.317Z,1594228136.317 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-07-08T17:08:56.317Z,1594228136.317 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-07-08T17:08:56.321Z,1594228136.321 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-07-08T17:08:56.321Z,1594228136.321 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-07-08T17:08:56.325Z,1594228136.325 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-07-08T17:08:56.325Z,1594228136.325 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-07-08T17:08:56.330Z,1594228136.330 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-07-08T17:08:56.330Z,1594228136.330 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-07-08T17:08:56.334Z,1594228136.334 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-07-08T17:08:56.334Z,1594228136.334 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-07-08T17:08:56.338Z,1594228136.338 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-07-08T17:08:56.342Z,1594228136.342 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-07-08T17:08:56.343Z,1594228136.343 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-07-08T17:08:56.343Z,1594228136.343 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-07-08T17:08:56.347Z,1594228136.347 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-07-08T17:08:56.347Z,1594228136.347 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-07-08T17:08:56.351Z,1594228136.351 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-07-08T17:08:56.351Z,1594228136.351 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-07-08T17:08:56.356Z,1594228136.356 [WetLabsBB2FL] Loaded
2020-07-08T17:08:56.356Z,1594228136.356 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-07-08T17:08:56.357Z,1594228136.357 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406A64E0
2020-07-08T17:08:56.357Z,1594228136.357 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 906
2020-07-08T17:08:56.358Z,1594228136.358 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-07-08T17:08:56.360Z,1594228136.360 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-07-08T17:08:56.414Z,1594228136.414 [DepthRateCalculator] Loaded
2020-07-08T17:08:56.414Z,1594228136.414 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-07-08T17:08:56.419Z,1594228136.419 [PitchRateCalculator] Loaded
2020-07-08T17:08:56.419Z,1594228136.419 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-07-08T17:08:56.435Z,1594228136.435 [SpeedCalculator] Loaded
2020-07-08T17:08:56.435Z,1594228136.435 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-07-08T17:08:56.455Z,1594228136.455 [TempGradientCalculator] Loaded
2020-07-08T17:08:56.455Z,1594228136.455 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-07-08T17:08:56.461Z,1594228136.461 [YawRateCalculator] Loaded
2020-07-08T17:08:56.462Z,1594228136.462 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-07-08T17:08:56.493Z,1594228136.493 [ElevatorOffsetCalculator] Loaded
2020-07-08T17:08:56.494Z,1594228136.494 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-07-08T17:08:56.494Z,1594228136.494 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-07-08T17:08:56.495Z,1594228136.495 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-07-08T17:08:56.591Z,1594228136.591 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-07-08T17:08:56.592Z,1594228136.592 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-07-08T17:08:56.632Z,1594228136.632 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-07-08T17:08:56.633Z,1594228136.633 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-07-08T17:08:56.765Z,1594228136.765 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-07-08T17:08:56.766Z,1594228136.766 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-07-08T17:08:56.786Z,1594228136.786 [NavChart] Loaded
2020-07-08T17:08:56.786Z,1594228136.786 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-07-08T17:08:56.790Z,1594228136.790 [UniversalFixResidualReporter] Loaded
2020-07-08T17:08:56.790Z,1594228136.790 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-07-08T17:08:56.791Z,1594228136.791 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-07-08T17:08:56.791Z,1594228136.791 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-07-08T17:08:57.330Z,1594228137.330 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-07-08T17:08:57.335Z,1594228137.335 [AHRS_M2](INFO): created writer for : platform_orientation
2020-07-08T17:08:57.335Z,1594228137.335 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-07-08T17:08:57.340Z,1594228137.340 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-07-08T17:08:57.341Z,1594228137.341 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-07-08T17:08:57.346Z,1594228137.346 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-07-08T17:08:57.346Z,1594228137.346 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-07-08T17:08:57.351Z,1594228137.351 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-07-08T17:08:57.770Z,1594228137.770 [AHRS_M2] Loaded
2020-07-08T17:08:57.770Z,1594228137.770 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-07-08T17:08:58.059Z,1594228138.059 [DataOverHttps] Loaded
2020-07-08T17:08:58.059Z,1594228138.059 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-07-08T17:08:58.060Z,1594228138.060 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409C64E0
2020-07-08T17:08:58.060Z,1594228138.060 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 907
2020-07-08T17:08:58.090Z,1594228138.090 [Depth_Keller] Loaded
2020-07-08T17:08:58.090Z,1594228138.090 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-07-08T17:08:58.095Z,1594228138.095 [DropWeight] Loaded
2020-07-08T17:08:58.095Z,1594228138.095 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-07-08T17:08:58.337Z,1594228138.337 [DVL_micro] Loaded
2020-07-08T17:08:58.337Z,1594228138.337 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2020-07-08T17:08:58.603Z,1594228138.603 [NAL9602] Loaded
2020-07-08T17:08:58.604Z,1594228138.604 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-07-08T17:08:58.641Z,1594228138.641 [Onboard] Loaded
2020-07-08T17:08:58.641Z,1594228138.641 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-07-08T17:08:58.642Z,1594228138.642 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409F64E0
2020-07-08T17:08:58.643Z,1594228138.643 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 908
2020-07-08T17:08:58.662Z,1594228138.662 [Radio_Surface] Loaded
2020-07-08T17:08:58.662Z,1594228138.662 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-07-08T17:08:58.663Z,1594228138.663 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A264E0
2020-07-08T17:08:58.663Z,1594228138.663 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 909
2020-07-08T17:08:58.812Z,1594228138.812 [DAT] Loaded
2020-07-08T17:08:58.813Z,1594228138.813 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-07-08T17:09:00.078Z,1594228140.078 [BPC1] Loaded
2020-07-08T17:09:00.079Z,1594228140.079 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-07-08T17:09:00.079Z,1594228140.079 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-07-08T17:09:00.080Z,1594228140.080 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-07-08T17:09:00.203Z,1594228140.203 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-07-08T17:09:00.204Z,1594228140.204 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-07-08T17:09:00.269Z,1594228140.269 [VerticalControl](DEBUG): Construct VerticalControl.
2020-07-08T17:09:00.351Z,1594228140.351 [VerticalControl] Loaded
2020-07-08T17:09:00.351Z,1594228140.351 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-07-08T17:09:00.352Z,1594228140.352 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-07-08T17:09:00.419Z,1594228140.419 [HorizontalControl] Loaded
2020-07-08T17:09:00.420Z,1594228140.420 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-07-08T17:09:00.420Z,1594228140.420 [SpeedControl](DEBUG): Construct SpeedControl.
2020-07-08T17:09:00.422Z,1594228140.422 [SpeedControl] Loaded
2020-07-08T17:09:00.422Z,1594228140.422 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-07-08T17:09:00.423Z,1594228140.423 [LoopControl](DEBUG): Construct LoopControl.
2020-07-08T17:09:00.423Z,1594228140.423 [LoopControl] Loaded
2020-07-08T17:09:00.424Z,1594228140.424 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-07-08T17:09:00.424Z,1594228140.424 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-07-08T17:09:00.425Z,1594228140.425 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-07-08T17:09:00.455Z,1594228140.455 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-07-08T17:09:00.455Z,1594228140.455 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-07-08T17:09:00.784Z,1594228140.784 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-07-08T17:09:00.787Z,1594228140.787 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-07-08T17:09:00.788Z,1594228140.788 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-07-08T17:09:00.795Z,1594228140.795 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-07-08T17:09:00.796Z,1594228140.796 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B5D4E0
2020-07-08T17:09:00.796Z,1594228140.796 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 910
2020-07-08T17:09:00.801Z,1594228140.801 [Supervisor](INFO): Main Thread ID is 815
2020-07-08T17:09:00.801Z,1594228140.801 [Supervisor](DEBUG): Running supervisor.
2020-07-08T17:09:00.802Z,1594228140.802 [CommandLine ThreadHandler](INFO): Handler Thread ID is 911
2020-07-08T17:09:00.804Z,1594228140.804 [controlThread ThreadHandler](INFO): Handler Thread ID is 912
2020-07-08T17:09:00.804Z,1594228140.804 [controlThread](DEBUG): Initializing ControlThread
2020-07-08T17:09:00.806Z,1594228140.806 [SBIT](INFO): Initialize SBIT Component.
2020-07-08T17:09:00.807Z,1594228140.807 [SBIT](IMPORTANT): git: 2020-07-06
2020-07-08T17:09:00.807Z,1594228140.807 [SBIT](INFO): git hash: 27d6d613a5802cbc38609e1e9bc8b2bacbda1d86
2020-07-08T17:09:00.807Z,1594228140.807 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-07-08T17:09:00.808Z,1594228140.808 [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-07-08T17:09:00.810Z,1594228140.810 [SBIT](INFO): Beginning SBIT in 72.000000 seconds.
2020-07-08T17:09:00.810Z,1594228140.810 [IBIT](INFO): Initialize IBIT Component.
2020-07-08T17:09:00.811Z,1594228140.811 [CBIT](DEBUG): Initialize CBIT Component.
2020-07-08T17:09:00.812Z,1594228140.812 [logger ThreadHandler](INFO): Handler Thread ID is 913
2020-07-08T17:09:00.825Z,1594228140.825 [CBIT](DEBUG): Initialized mux pins.
2020-07-08T17:09:00.825Z,1594228140.825 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2020-07-08T17:09:00.825Z,1594228140.825 [CBIT](DEBUG): Initializing the watchdog timer.
2020-07-08T17:09:00.837Z,1594228140.837 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 914
2020-07-08T17:09:00.838Z,1594228140.838 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-07-08T17:09:00.842Z,1594228140.842 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 916
2020-07-08T17:09:00.843Z,1594228140.843 [WetLabsBB2FL](INFO): Powering down
2020-07-08T17:09:00.849Z,1594228140.849 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-07-08T17:09:00.849Z,1594228140.849 [CBIT](DEBUG): Initializing heartbeat.
2020-07-08T17:09:00.921Z,1594228140.921 [CBIT](DEBUG): Deactivating GF circuits.
2020-07-08T17:09:00.921Z,1594228140.921 [CBIT](DEBUG): Deactivating emergency mode.
2020-07-08T17:09:00.957Z,1594228140.957 [CBIT](DEBUG): Backplane powered.
2020-07-08T17:09:00.961Z,1594228140.961 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-07-08T17:09:00.961Z,1594228140.961 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-07-08T17:09:00.962Z,1594228140.962 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-07-08T17:09:00.962Z,1594228140.962 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-07-08T17:09:00.963Z,1594228140.963 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-07-08T17:09:00.963Z,1594228140.963 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-07-08T17:09:00.964Z,1594228140.964 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-07-08T17:09:00.965Z,1594228140.965 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-07-08T17:09:00.979Z,1594228140.979 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-07-08T17:09:00.981Z,1594228140.981 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 917
2020-07-08T17:09:00.982Z,1594228140.982 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-07-08T17:09:00.986Z,1594228140.986 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-07-08T17:09:00.989Z,1594228140.989 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-07-08T17:09:00.990Z,1594228140.990 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-07-08T17:09:00.995Z,1594228140.995 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-07-08T17:09:01.086Z,1594228141.086 [Onboard ThreadHandler](INFO): Handler Thread ID is 918
2020-07-08T17:09:01.096Z,1594228141.096 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 919
2020-07-08T17:09:01.126Z,1594228141.126 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 920
2020-07-08T17:09:01.143Z,1594228141.143 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-07-08T17:09:01.147Z,1594228141.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-07-08T17:09:01.147Z,1594228141.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-07-08T17:09:01.147Z,1594228141.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-07-08T17:09:01.148Z,1594228141.148 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-07-08T17:09:01.148Z,1594228141.148 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-07-08T17:09:01.148Z,1594228141.148 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-07-08T17:09:01.148Z,1594228141.148 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-07-08T17:09:01.148Z,1594228141.148 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-07-08T17:09:01.148Z,1594228141.148 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-07-08T17:09:01.149Z,1594228141.149 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-07-08T17:09:01.149Z,1594228141.149 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-07-08T17:09:01.149Z,1594228141.149 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-07-08T17:09:01.149Z,1594228141.149 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-07-08T17:09:01.149Z,1594228141.149 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-07-08T17:09:01.150Z,1594228141.150 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-07-08T17:09:01.150Z,1594228141.150 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-07-08T17:09:01.249Z,1594228141.249 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2020-07-08T17:09:01.250Z,1594228141.250 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-07-08T17:09:01.373Z,1594228141.373 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-07-08T17:09:01.374Z,1594228141.374 [Default:A.Wait](DEBUG): Construct Wait.
2020-07-08T17:09:01.376Z,1594228141.376 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-07-08T17:09:01.422Z,1594228141.422 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-07-08T17:09:01.425Z,1594228141.425 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-07-08T17:09:01.444Z,1594228141.444 [Default:E.Execute](DEBUG): Construct Execute.
2020-07-08T17:09:01.447Z,1594228141.447 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2020-07-08T17:09:01.453Z,1594228141.453 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,DAT,BPC1,PAR_Licor,Depth_Keller,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-07-08T17:09:01.501Z,1594228141.501 [Radio_Surface](INFO): Powering up
2020-07-08T17:09:01.503Z,1594228141.503 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-07-08T17:09:01.736Z,1594228141.736 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-07-08T17:09:01.736Z,1594228141.736 [DAT](INFO): Powering up
2020-07-08T17:09:01.736Z,1594228141.736 [DAT](DEBUG): Initializing DAT.
2020-07-08T17:09:01.801Z,1594228141.801 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-07-08T17:09:01.870Z,1594228141.870 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-07-08T17:09:01.877Z,1594228141.877 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-07-08T17:09:01.878Z,1594228141.878 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-07-08T17:09:01.889Z,1594228141.889 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-07-08T17:09:01.890Z,1594228141.890 [MassServo](DEBUG): Initializing EZServoServo.
2020-07-08T17:09:01.901Z,1594228141.901 [MassServo](DEBUG): Initializing MassServo.
2020-07-08T17:09:01.902Z,1594228141.902 [RudderServo](DEBUG): Initializing EZServoServo.
2020-07-08T17:09:01.913Z,1594228141.913 [RudderServo](DEBUG): Initializing RudderServo.
2020-07-08T17:09:01.914Z,1594228141.914 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-07-08T17:09:01.921Z,1594228141.921 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-07-08T17:09:02.015Z,1594228142.015 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2020-07-08T17:09:02.015Z,1594228142.015 [DropWeight] Hardware Fault, FailCount= 1
2020-07-08T17:09:02.016Z,1594228142.016 [DropWeight](ERROR): Hardware Fault
2020-07-08T17:09:02.051Z,1594228142.051 [CommandLine](FAULT): Scheduling is paused
2020-07-08T17:09:02.051Z,1594228142.051 [CBIT](INFO): Critical error at 20200708T170902
2020-07-08T17:09:02.052Z,1594228142.052 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-07-08T17:09:02.054Z,1594228142.054 [CBIT](ERROR): Hardware Fault in component: DropWeight
2020-07-08T17:09:02.055Z,1594228142.055 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2020-07-08T17:09:02.358Z,1594228142.358 [CBIT](INFO): Critical error at 20200708T170902
2020-07-08T17:09:11.629Z,1594228151.629 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:11.629Z,1594228151.629 [Aanderaa_O2] Communications Fault, FailCount= 1
2020-07-08T17:09:11.629Z,1594228151.629 [Aanderaa_O2](ERROR): Communications Fault
2020-07-08T17:09:11.718Z,1594228151.718 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2020-07-08T17:09:12.153Z,1594228152.153 [Aanderaa_O2](INFO): Powering down
2020-07-08T17:09:12.941Z,1594228152.941 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2020-07-08T17:09:12.941Z,1594228152.941 [Aanderaa_O2] No Fault, FailCount= 1
2020-07-08T17:09:13.889Z,1594228153.889 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:13.889Z,1594228153.889 [CTD_Seabird] Communications Fault, FailCount= 1
2020-07-08T17:09:13.889Z,1594228153.889 [CTD_Seabird](ERROR): Communications Fault
2020-07-08T17:09:14.153Z,1594228154.153 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-07-08T17:09:14.293Z,1594228154.293 [CTD_Seabird](INFO): Powering down
2020-07-08T17:09:15.365Z,1594228155.365 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-07-08T17:09:15.365Z,1594228155.365 [CTD_Seabird] No Fault, FailCount= 1
2020-07-08T17:09:15.637Z,1594228155.637 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-07-08T17:09:15.704Z,1594228155.704 [DAT](INFO): commRate: 800
2020-07-08T17:09:15.704Z,1594228155.704 [DAT](INFO): commRate: 800
2020-07-08T17:09:16.095Z,1594228156.095 [DAT](INFO): entering command mode
2020-07-08T17:09:16.499Z,1594228156.499 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:16.915Z,1594228156.915 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:17.307Z,1594228157.307 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:17.711Z,1594228157.711 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:18.115Z,1594228158.115 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:18.519Z,1594228158.519 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:18.922Z,1594228158.922 [DVL_micro](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:18.922Z,1594228158.922 [DVL_micro] Communications Fault, FailCount= 1
2020-07-08T17:09:18.922Z,1594228158.922 [DVL_micro](ERROR): Communications Fault
2020-07-08T17:09:18.923Z,1594228158.923 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:19.002Z,1594228159.002 [CBIT](ERROR): Communications Fault in component: DVL_micro
2020-07-08T17:09:19.397Z,1594228159.397 [DVL_micro](INFO): Powering down
2020-07-08T17:09:19.399Z,1594228159.399 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:19.725Z,1594228159.725 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-07-08T17:09:19.725Z,1594228159.725 [AHRS_M2] Data Fault, FailCount= 1
2020-07-08T17:09:19.725Z,1594228159.725 [AHRS_M2](ERROR): Data Fault
2020-07-08T17:09:19.730Z,1594228159.730 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:19.773Z,1594228159.773 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-07-08T17:09:20.117Z,1594228160.117 [AHRS_M2](INFO): Powering down
2020-07-08T17:09:20.195Z,1594228160.195 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:20.289Z,1594228160.289 [CBIT](INFO): Clearing failed state for component DVL_micro
2020-07-08T17:09:20.289Z,1594228160.289 [DVL_micro] No Fault, FailCount= 1
2020-07-08T17:09:20.527Z,1594228160.527 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:20.933Z,1594228160.933 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:21.017Z,1594228161.017 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-07-08T17:09:21.017Z,1594228161.017 [AHRS_M2] No Fault, FailCount= 1
2020-07-08T17:09:21.329Z,1594228161.329 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-07-08T17:09:21.351Z,1594228161.351 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:21.739Z,1594228161.739 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:22.142Z,1594228162.142 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:22.562Z,1594228162.562 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:22.966Z,1594228162.966 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:23.344Z,1594228163.344 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:23.345Z,1594228163.345 [Aanderaa_O2] Communications Fault, FailCount= 2
2020-07-08T17:09:23.345Z,1594228163.345 [Aanderaa_O2](ERROR): Communications Fault
2020-07-08T17:09:23.354Z,1594228163.354 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:23.445Z,1594228163.445 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2020-07-08T17:09:23.869Z,1594228163.869 [Aanderaa_O2](INFO): Powering down
2020-07-08T17:09:23.874Z,1594228163.874 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:24.163Z,1594228164.163 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:24.590Z,1594228164.590 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:24.649Z,1594228164.649 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2020-07-08T17:09:24.649Z,1594228164.649 [Aanderaa_O2] No Fault, FailCount= 2
2020-07-08T17:09:25.059Z,1594228165.059 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:25.399Z,1594228165.399 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:25.790Z,1594228165.790 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:26.191Z,1594228166.191 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:26.601Z,1594228166.601 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:27.002Z,1594228167.002 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:27.406Z,1594228167.406 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:27.821Z,1594228167.821 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:28.214Z,1594228168.214 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:28.618Z,1594228168.618 [NAL9602](INFO): Powering up NAL9602
2020-07-08T17:09:28.620Z,1594228168.620 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:28.697Z,1594228168.697 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:28.697Z,1594228168.697 [CTD_Seabird] Communications Fault, FailCount= 2
2020-07-08T17:09:28.697Z,1594228168.697 [CTD_Seabird](ERROR): Communications Fault
2020-07-08T17:09:29.023Z,1594228169.023 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:29.069Z,1594228169.069 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-07-08T17:09:29.101Z,1594228169.101 [CTD_Seabird](INFO): Powering down
2020-07-08T17:09:29.426Z,1594228169.426 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:29.830Z,1594228169.830 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:30.235Z,1594228170.235 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:30.296Z,1594228170.296 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2020-07-08T17:09:30.296Z,1594228170.296 [CTD_Seabird] No Fault, FailCount= 2
2020-07-08T17:09:30.445Z,1594228170.445 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-07-08T17:09:30.638Z,1594228170.638 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:31.042Z,1594228171.042 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:31.447Z,1594228171.447 [DAT](DEBUG): checking for command mode acknowledgment
2020-07-08T17:09:31.447Z,1594228171.447 [DAT](FAULT): failed to enter command mode
2020-07-08T17:09:31.853Z,1594228171.853 [DAT](INFO): entering command mode
2020-07-08T17:09:32.256Z,1594228172.256 [DAT](INFO): setting verbose to 3
2020-07-08T17:09:32.672Z,1594228172.672 [DAT](INFO): set verbose to 3
2020-07-08T17:09:32.672Z,1594228172.672 [DAT](INFO): setting DatVerbose to 27440
2020-07-08T17:09:33.076Z,1594228173.076 [DAT](INFO): set DatVerbose to 27440
2020-07-08T17:09:33.076Z,1594228173.076 [DAT](INFO): setting transmit power to 8
2020-07-08T17:09:33.471Z,1594228173.471 [DAT](INFO): set transmit power to 8
2020-07-08T17:09:33.471Z,1594228173.471 [DAT](INFO): setting local address to 4
2020-07-08T17:09:33.886Z,1594228173.886 [DAT](INFO): set local address to 4
2020-07-08T17:09:34.677Z,1594228174.677 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-07-08T17:09:34.677Z,1594228174.677 [AHRS_M2] Data Fault, FailCount= 2
2020-07-08T17:09:34.677Z,1594228174.677 [AHRS_M2](ERROR): Data Fault
2020-07-08T17:09:34.767Z,1594228174.767 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-07-08T17:09:35.061Z,1594228175.061 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:35.061Z,1594228175.061 [Aanderaa_O2] Communications Fault, FailCount= 3
2020-07-08T17:09:35.061Z,1594228175.061 [Aanderaa_O2](ERROR): Communications Fault
2020-07-08T17:09:35.065Z,1594228175.065 [AHRS_M2](INFO): Powering down
2020-07-08T17:09:35.195Z,1594228175.195 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2020-07-08T17:09:35.195Z,1594228175.195 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2020-07-08T17:09:35.585Z,1594228175.585 [Aanderaa_O2](INFO): Powering down
2020-07-08T17:09:35.933Z,1594228175.933 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-07-08T17:09:35.933Z,1594228175.933 [AHRS_M2] No Fault, FailCount= 2
2020-07-08T17:09:36.277Z,1594228176.277 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-07-08T17:09:37.898Z,1594228177.898 [DVL_micro](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:37.898Z,1594228177.898 [DVL_micro] Communications Fault, FailCount= 2
2020-07-08T17:09:37.898Z,1594228177.898 [DVL_micro](ERROR): Communications Fault
2020-07-08T17:09:37.958Z,1594228177.958 [CBIT](ERROR): Communications Fault in component: DVL_micro
2020-07-08T17:09:38.373Z,1594228178.373 [DVL_micro](INFO): Powering down
2020-07-08T17:09:39.156Z,1594228179.156 [CBIT](INFO): Clearing failed state for component DVL_micro
2020-07-08T17:09:39.156Z,1594228179.156 [DVL_micro] No Fault, FailCount= 2
2020-07-08T17:09:39.546Z,1594228179.546 [NAL9602](INFO): NAL9602 initialized
2020-07-08T17:09:43.497Z,1594228183.497 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:43.497Z,1594228183.497 [CTD_Seabird] Communications Fault, FailCount= 3
2020-07-08T17:09:43.497Z,1594228183.497 [CTD_Seabird](ERROR): Communications Fault
2020-07-08T17:09:43.613Z,1594228183.613 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2020-07-08T17:09:43.614Z,1594228183.614 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2020-07-08T17:09:43.901Z,1594228183.901 [CTD_Seabird](INFO): Powering down
2020-07-08T17:09:49.621Z,1594228189.621 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-07-08T17:09:49.621Z,1594228189.621 [AHRS_M2] Data Fault, FailCount= 3
2020-07-08T17:09:49.621Z,1594228189.621 [AHRS_M2](ERROR): Data Fault
2020-07-08T17:09:49.654Z,1594228189.654 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-07-08T17:09:50.013Z,1594228190.013 [AHRS_M2](INFO): Powering down
2020-07-08T17:09:50.850Z,1594228190.850 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-07-08T17:09:50.850Z,1594228190.850 [AHRS_M2] No Fault, FailCount= 3
2020-07-08T17:09:51.225Z,1594228191.225 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-07-08T17:09:56.970Z,1594228196.970 [DVL_micro](FAULT): Failed to initialize within timeout.
2020-07-08T17:09:56.970Z,1594228196.970 [DVL_micro] Communications Fault, FailCount= 3
2020-07-08T17:09:56.970Z,1594228196.970 [DVL_micro](ERROR): Communications Fault
2020-07-08T17:09:56.990Z,1594228196.990 [CBIT](ERROR): Communications Fault in component: DVL_micro
2020-07-08T17:09:56.990Z,1594228196.990 [CBIT](CRITICAL): Communications Fault in component: DVL_micro
2020-07-08T17:09:57.373Z,1594228197.373 [DVL_micro](INFO): Powering down
2020-07-08T17:09:57.396Z,1594228197.396 [CBIT](INFO): Critical error at 20200708T170956
2020-07-08T17:10:02.966Z,1594228202.966 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full
2020-07-08T17:10:03.382Z,1594228203.382 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full
2020-07-08T17:10:03.772Z,1594228203.772 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full
2020-07-08T17:10:04.164Z,1594228204.164 [AHRS_M2](ERROR): Read RFS packet UART error: serial buffer full
2020-07-08T17:10:04.573Z,1594228204.573 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-07-08T17:10:04.573Z,1594228204.573 [AHRS_M2] Data Fault, FailCount= 4
2020-07-08T17:10:04.573Z,1594228204.573 [AHRS_M2](ERROR): Data Fault
2020-07-08T17:10:04.622Z,1594228204.622 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-07-08T17:10:04.965Z,1594228204.965 [AHRS_M2](INFO): Powering down
2020-07-08T17:10:05.792Z,1594228205.792 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-07-08T17:10:05.792Z,1594228205.792 [AHRS_M2] No Fault, FailCount= 4
2020-07-08T17:10:06.176Z,1594228206.176 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-07-08T17:10:09.501Z,1594228209.501 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:09.909Z,1594228209.909 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:10.313Z,1594228210.313 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:10.721Z,1594228210.721 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:11.121Z,1594228211.121 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:11.521Z,1594228211.521 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:11.925Z,1594228211.925 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:12.333Z,1594228212.333 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:12.733Z,1594228212.733 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:13.141Z,1594228213.141 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:13.541Z,1594228213.541 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:13.554Z,1594228213.554 [SBIT](IMPORTANT): Beginning Startup BIT
2020-07-08T17:10:13.559Z,1594228213.559 [CBIT](IMPORTANT): Beginning ground fault scan
2020-07-08T17:10:14.177Z,1594228214.177 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:14.613Z,1594228214.613 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:15.041Z,1594228215.041 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:15.485Z,1594228215.485 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:16.081Z,1594228216.081 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:16.565Z,1594228216.565 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:17.013Z,1594228217.013 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:17.341Z,1594228217.341 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:17.981Z,1594228217.981 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:18.397Z,1594228218.397 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:18.937Z,1594228218.937 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:19.453Z,1594228219.453 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-07-08T17:10:19.453Z,1594228219.453 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-07-08T17:10:19.453Z,1594228219.453 [AHRS_M2] Communications Fault, FailCount= 5
2020-07-08T17:10:19.453Z,1594228219.453 [AHRS_M2](ERROR): Communications Fault
2020-07-08T17:10:19.546Z,1594228219.546 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-07-08T17:10:19.546Z,1594228219.546 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2020-07-08T17:10:19.565Z,1594228219.565 [AHRS_M2](INFO): Powering down
2020-07-08T17:10:19.704Z,1594228219.704 [CBIT](INFO): Critical error at 20200708T171019
2020-07-08T17:10:25.282Z,1594228225.282 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.006355
CHAN A1 (24V): -0.024096
CHAN A2 (12V): -0.005443
CHAN A3 (5V): -0.002981
CHAN B0 (3.3V): -0.000952
CHAN B1 (3.15aV): -0.001393
CHAN B2 (3.15bV): -0.001094
CHAN B3 (GND): -0.000063
OPEN: 0.007010
Full Scale Calc: 4.765 mA, -1.589 mA
2020-07-08T17:11:01.280Z,1594228261.280 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-07-08T17:11:01.280Z,1594228261.280 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-07-08T17:11:01.280Z,1594228261.280 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-07-08T17:11:01.291Z,1594228261.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-07-08T17:11:01.618Z,1594228261.618 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-07-08T17:11:01.618Z,1594228261.618 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-07-08T17:11:07.666Z,1594228267.666 [SBIT](IMPORTANT): SBIT PASSED
2020-07-08T17:11:07.667Z,1594228267.667 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2020-07-08T17:11:08.038Z,1594228268.038 [MissionManager](IMPORTANT): Started mission Startup
2020-07-08T17:11:08.038Z,1594228268.038 [Startup] Running Loop=1
2020-07-08T17:11:08.038Z,1594228268.038 [Startup](DEBUG): Aggregate::initialize Startup
2020-07-08T17:11:08.038Z,1594228268.038 [Startup:A.GoToSurface] Running Loop=1
2020-07-08T17:11:08.039Z,1594228268.039 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-07-08T17:11:08.039Z,1594228268.039 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-07-08T17:11:08.040Z,1594228268.040 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-07-08T17:11:08.040Z,1594228268.040 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-07-08T17:11:08.040Z,1594228268.040 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-07-08T17:11:08.041Z,1594228268.041 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-07-08T17:11:08.042Z,1594228268.042 [Startup:StartupSatComms] Running Loop=1
2020-07-08T17:11:08.042Z,1594228268.042 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-07-08T17:11:08.042Z,1594228268.042 [Startup:StartupSatComms:A] Running Loop=1
2020-07-08T17:11:08.457Z,1594228268.457 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-07-08T17:11:35.294Z,1594228295.294 [CommandLine](IMPORTANT): got command quit
2020-07-08T17:11:36.301Z,1594228296.301 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:36.301Z,1594228296.301 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:36.413Z,1594228296.413 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-07-08T17:11:36.413Z,1594228296.413 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:36.413Z,1594228296.413 [CommandLine](INFO): Join timeout helper Thread ID is 958
2020-07-08T17:11:36.414Z,1594228296.414 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-07-08T17:11:36.414Z,1594228296.414 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:36.415Z,1594228296.415 [NavChartDb](INFO): Join timeout helper Thread ID is 959
2020-07-08T17:11:36.485Z,1594228296.485 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:36.485Z,1594228296.485 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:36.493Z,1594228296.493 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-07-08T17:11:36.493Z,1594228296.493 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:36.493Z,1594228296.493 [Radio_Surface](INFO): Join timeout helper Thread ID is 960
2020-07-08T17:11:36.637Z,1594228296.637 [Radio_Surface](INFO): Powering down
2020-07-08T17:11:36.638Z,1594228296.638 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:36.638Z,1594228296.638 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:36.653Z,1594228296.653 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-07-08T17:11:36.653Z,1594228296.653 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:36.653Z,1594228296.653 [Onboard](INFO): Join timeout helper Thread ID is 961
2020-07-08T17:11:41.241Z,1594228301.241 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:41.241Z,1594228301.241 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:41.252Z,1594228301.252 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-07-08T17:11:41.252Z,1594228301.252 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:41.252Z,1594228301.252 [DataOverHttps](INFO): Join timeout helper Thread ID is 962
2020-07-08T17:11:41.647Z,1594228301.647 [CBIT](FAULT): Humidity exceeds 50% of running average: Humidity:2285304 %. Average:267119.281250
2020-07-08T17:11:41.657Z,1594228301.657 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:41.657Z,1594228301.657 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:41.670Z,1594228301.670 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-07-08T17:11:41.670Z,1594228301.670 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:41.670Z,1594228301.670 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 963
2020-07-08T17:11:42.157Z,1594228302.157 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:42.157Z,1594228302.157 [WetLabsBB2FL](INFO): Powering down
2020-07-08T17:11:42.158Z,1594228302.158 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.170Z,1594228302.170 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-07-08T17:11:42.170Z,1594228302.170 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.170Z,1594228302.170 [CTD_Seabird](INFO): Join timeout helper Thread ID is 964
2020-07-08T17:11:42.469Z,1594228302.469 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:42.469Z,1594228302.469 [CTD_Seabird](INFO): Powering down
2020-07-08T17:11:42.481Z,1594228302.481 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.489Z,1594228302.489 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-07-08T17:11:42.490Z,1594228302.490 [logger ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.490Z,1594228302.490 [logger](INFO): Join timeout helper Thread ID is 965
2020-07-08T17:11:42.501Z,1594228302.501 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:42.502Z,1594228302.502 [logger ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.509Z,1594228302.509 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-07-08T17:11:42.510Z,1594228302.510 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.510Z,1594228302.510 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-07-08T17:11:42.510Z,1594228302.510 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.510Z,1594228302.510 [controlThread](INFO): Join timeout helper Thread ID is 966
2020-07-08T17:11:42.769Z,1594228302.769 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-07-08T17:11:42.769Z,1594228302.769 [controlThread](DEBUG): Uninitializing ControlThread
2020-07-08T17:11:42.770Z,1594228302.770 [Aanderaa_O2](INFO): Powering down
2020-07-08T17:11:42.772Z,1594228302.772 [AHRS_M2](INFO): Powering down
2020-07-08T17:11:42.773Z,1594228302.773 [DVL_micro](INFO): Powering down
2020-07-08T17:11:42.774Z,1594228302.774 [NAL9602](INFO): Powering down
2020-07-08T17:11:42.775Z,1594228302.775 [DAT](INFO): Powering down
2020-07-08T17:11:42.894Z,1594228302.894 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-07-08T17:11:42.895Z,1594228302.895 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-07-08T17:11:42.896Z,1594228302.896 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-07-08T17:11:42.896Z,1594228302.896 [MissionManager](INFO): Uninitializing Mission Default
2020-07-08T17:11:42.898Z,1594228302.898 [MissionManager](INFO): Uninitializing Mission Startup
2020-07-08T17:11:42.898Z,1594228302.898 [Startup] Stopped
2020-07-08T17:11:42.898Z,1594228302.898 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-07-08T17:11:42.899Z,1594228302.899 [Startup:A.GoToSurface] Stopped
2020-07-08T17:11:42.899Z,1594228302.899 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-07-08T17:11:42.899Z,1594228302.899 [Startup:StartupSatComms] Stopped
2020-07-08T17:11:42.899Z,1594228302.899 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-07-08T17:11:42.899Z,1594228302.899 [Startup:StartupSatComms:A] Stopped
2020-07-08T17:11:42.901Z,1594228302.901 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-07-08T17:11:42.901Z,1594228302.901 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-07-08T17:11:42.901Z,1594228302.901 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-07-08T17:11:42.902Z,1594228302.902 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-07-08T17:11:42.902Z,1594228302.902 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-07-08T17:11:42.902Z,1594228302.902 [BuoyancyServo](INFO): Powering down
2020-07-08T17:11:42.917Z,1594228302.917 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-07-08T17:11:42.917Z,1594228302.917 [ElevatorServo](INFO): Powering down
2020-07-08T17:11:42.918Z,1594228302.918 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-07-08T17:11:42.918Z,1594228302.918 [MassServo](INFO): Powering down
2020-07-08T17:11:42.919Z,1594228302.919 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-07-08T17:11:42.919Z,1594228302.919 [RudderServo](INFO): Powering down
2020-07-08T17:11:42.920Z,1594228302.920 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-07-08T17:11:42.920Z,1594228302.920 [ThrusterServo](INFO): Powering down
2020-07-08T17:11:42.921Z,1594228302.921 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-07-08T17:11:42.921Z,1594228302.921 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-07-08T17:11:42.922Z,1594228302.922 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-07-08T17:11:42.922Z,1594228302.922 [CBIT](DEBUG): Powering off loads.
2020-07-08T17:11:42.933Z,1594228302.933 [CBIT](DEBUG): Disabling WDT.
2020-07-08T17:11:42.945Z,1594228302.945 [CBIT](DEBUG): Opening all GF detection circuits.
2020-07-08T17:11:42.946Z,1594228302.946 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.979Z,1594228302.979 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:42.985Z,1594228302.985 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:43.057Z,1594228303.057 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:43.058Z,1594228303.058 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:43.065Z,1594228303.065 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:43.118Z,1594228303.118 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-07-08T17:11:43.177Z,1594228303.177 [logger ThreadHandler](INFO): Thread cancelled.