2020-05-15T19:10:48.730Z,1589569848.730 [Supervisor](DEBUG): Initializing supervisor.
2020-05-15T19:10:48.732Z,1589569848.732 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-05-15T19:10:48.733Z,1589569848.733 [SyncHandler](INFO): Protected caller Thread ID is 4149
2020-05-15T19:10:48.733Z,1589569848.733 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-05-15T19:10:48.734Z,1589569848.734 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-05-15T19:10:48.734Z,1589569848.734 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4150
2020-05-15T19:10:48.737Z,1589569848.737 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-05-15T19:10:48.749Z,1589569848.749 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-05-15T19:10:48.750Z,1589569848.750 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-05-15T19:10:48.751Z,1589569848.751 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4151
2020-05-15T19:10:48.752Z,1589569848.752 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-05-15T19:10:48.752Z,1589569848.752 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-05-15T19:10:48.753Z,1589569848.753 [logger ThreadHandler](INFO): Protected caller Thread ID is 4152
2020-05-15T19:10:48.755Z,1589569848.755 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-05-15T19:10:48.755Z,1589569848.755 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-05-15T19:10:48.757Z,1589569848.757 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-05-15T19:10:49.068Z,1589569849.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-05-15T19:10:49.069Z,1589569849.069 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-05-15T19:10:49.635Z,1589569849.635 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-05-15T19:10:49.635Z,1589569849.635 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-05-15T19:10:49.776Z,1589569849.776 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-05-15T19:10:49.777Z,1589569849.777 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-05-15T19:10:50.223Z,1589569850.223 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-05-15T19:10:50.223Z,1589569850.223 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-05-15T19:10:50.318Z,1589569850.318 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-05-15T19:10:50.319Z,1589569850.319 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-05-15T19:10:50.398Z,1589569850.398 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-05-15T19:10:50.690Z,1589569850.690 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-05-15T19:10:50.690Z,1589569850.690 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-05-15T19:10:50.831Z,1589569850.831 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-05-15T19:10:50.832Z,1589569850.832 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-05-15T19:10:50.932Z,1589569850.932 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-05-15T19:10:50.933Z,1589569850.933 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-05-15T19:10:51.400Z,1589569851.400 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-05-15T19:10:51.400Z,1589569851.400 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-05-15T19:10:51.794Z,1589569851.794 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-05-15T19:10:51.795Z,1589569851.795 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-05-15T19:10:51.895Z,1589569851.895 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-05-15T19:10:51.895Z,1589569851.895 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-05-15T19:10:52.083Z,1589569852.083 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-05-15T19:10:52.083Z,1589569852.083 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-05-15T19:10:52.280Z,1589569852.280 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-05-15T19:10:52.280Z,1589569852.280 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-05-15T19:10:52.498Z,1589569852.498 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-05-15T19:10:52.500Z,1589569852.500 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2020-05-15T19:10:52.501Z,1589569852.501 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2020-05-15T19:10:52.600Z,1589569852.600 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2020-05-15T19:10:52.734Z,1589569852.734 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2020-05-15T19:10:52.817Z,1589569852.817 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2020-05-15T19:10:52.899Z,1589569852.899 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2020-05-15T19:10:53.002Z,1589569853.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2020-05-15T19:10:53.176Z,1589569853.176 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2020-05-15T19:10:53.400Z,1589569853.400 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-05-15T19:10:53.400Z,1589569853.400 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2020-05-15T19:10:53.507Z,1589569853.507 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2020-05-15T19:10:53.600Z,1589569853.600 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2020-05-15T19:10:53.695Z,1589569853.695 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2020-05-15T19:10:53.787Z,1589569853.787 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/
2020-05-15T19:10:53.788Z,1589569853.788 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-05-15T19:10:53.794Z,1589569853.794 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-05-15T19:10:53.814Z,1589569853.814 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-05-15T19:10:53.814Z,1589569853.814 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-05-15T19:10:53.855Z,1589569853.855 [DepthRateCalculator] Loaded
2020-05-15T19:10:53.855Z,1589569853.855 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-05-15T19:10:53.861Z,1589569853.861 [PitchRateCalculator] Loaded
2020-05-15T19:10:53.862Z,1589569853.862 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-05-15T19:10:53.878Z,1589569853.878 [SpeedCalculator] Loaded
2020-05-15T19:10:53.878Z,1589569853.878 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-05-15T19:10:53.898Z,1589569853.898 [TempGradientCalculator] Loaded
2020-05-15T19:10:53.899Z,1589569853.899 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-05-15T19:10:53.904Z,1589569853.904 [YawRateCalculator] Loaded
2020-05-15T19:10:53.905Z,1589569853.905 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-05-15T19:10:53.944Z,1589569853.944 [ElevatorOffsetCalculator] Loaded
2020-05-15T19:10:53.945Z,1589569853.945 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-05-15T19:10:53.945Z,1589569853.945 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-05-15T19:10:53.945Z,1589569853.945 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-05-15T19:10:53.994Z,1589569853.994 [VerticalControl](DEBUG): Construct VerticalControl.
2020-05-15T19:10:54.095Z,1589569854.095 [VerticalControl] Loaded
2020-05-15T19:10:54.095Z,1589569854.095 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-05-15T19:10:54.096Z,1589569854.096 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-05-15T19:10:54.176Z,1589569854.176 [HorizontalControl] Loaded
2020-05-15T19:10:54.176Z,1589569854.176 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-05-15T19:10:54.176Z,1589569854.176 [SpeedControl](DEBUG): Construct SpeedControl.
2020-05-15T19:10:54.182Z,1589569854.182 [SpeedControl] Loaded
2020-05-15T19:10:54.182Z,1589569854.182 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-05-15T19:10:54.182Z,1589569854.182 [LoopControl](DEBUG): Construct LoopControl.
2020-05-15T19:10:54.183Z,1589569854.183 [LoopControl] Loaded
2020-05-15T19:10:54.183Z,1589569854.183 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-05-15T19:10:54.184Z,1589569854.184 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-05-15T19:10:54.184Z,1589569854.184 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-05-15T19:10:54.287Z,1589569854.287 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-05-15T19:10:54.287Z,1589569854.287 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-05-15T19:10:54.308Z,1589569854.308 [NavChart] Loaded
2020-05-15T19:10:54.308Z,1589569854.308 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-05-15T19:10:54.312Z,1589569854.312 [UniversalFixResidualReporter] Loaded
2020-05-15T19:10:54.312Z,1589569854.312 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-05-15T19:10:54.313Z,1589569854.313 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-05-15T19:10:54.313Z,1589569854.313 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-05-15T19:10:54.413Z,1589569854.413 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-05-15T19:10:54.413Z,1589569854.413 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-05-15T19:10:54.793Z,1589569854.793 [DataOverHttps] Loaded
2020-05-15T19:10:54.794Z,1589569854.794 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-05-15T19:10:54.795Z,1589569854.795 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408244E0
2020-05-15T19:10:54.795Z,1589569854.795 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4231
2020-05-15T19:10:54.834Z,1589569854.834 [Depth_Keller] Loaded
2020-05-15T19:10:54.835Z,1589569854.835 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-05-15T19:10:54.839Z,1589569854.839 [DropWeight] Loaded
2020-05-15T19:10:54.840Z,1589569854.840 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-05-15T19:10:54.942Z,1589569854.942 [NAL9602] Loaded
2020-05-15T19:10:54.942Z,1589569854.942 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-05-15T19:10:54.991Z,1589569854.991 [Onboard] Loaded
2020-05-15T19:10:54.992Z,1589569854.992 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-05-15T19:10:54.995Z,1589569854.995 [Radio_Surface] Loaded
2020-05-15T19:10:54.995Z,1589569854.995 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-05-15T19:10:54.996Z,1589569854.996 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408544E0
2020-05-15T19:10:54.996Z,1589569854.996 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4232
2020-05-15T19:10:55.218Z,1589569855.218 [DAT] Loaded
2020-05-15T19:10:55.218Z,1589569855.218 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-05-15T19:10:57.045Z,1589569857.045 [BPC1] Loaded
2020-05-15T19:10:57.046Z,1589569857.046 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-05-15T19:10:57.046Z,1589569857.046 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-05-15T19:10:57.047Z,1589569857.047 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-05-15T19:10:57.150Z,1589569857.150 [BuoyancyServo] Loaded
2020-05-15T19:10:57.150Z,1589569857.150 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-05-15T19:10:57.161Z,1589569857.161 [ElevatorServo] Loaded
2020-05-15T19:10:57.162Z,1589569857.162 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-05-15T19:10:57.173Z,1589569857.173 [MassServo] Loaded
2020-05-15T19:10:57.173Z,1589569857.173 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-05-15T19:10:57.184Z,1589569857.184 [RudderServo] Loaded
2020-05-15T19:10:57.184Z,1589569857.184 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-05-15T19:10:57.195Z,1589569857.195 [ThrusterServo] Loaded
2020-05-15T19:10:57.195Z,1589569857.195 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-05-15T19:10:57.196Z,1589569857.196 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-05-15T19:10:57.196Z,1589569857.196 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-05-15T19:10:57.278Z,1589569857.278 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-05-15T19:10:57.278Z,1589569857.278 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-05-15T19:10:57.305Z,1589569857.305 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-05-15T19:10:57.305Z,1589569857.305 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-05-15T19:10:57.617Z,1589569857.617 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-05-15T19:10:57.617Z,1589569857.617 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-05-15T19:10:57.828Z,1589569857.828 [ESPComponent] Loaded
2020-05-15T19:10:57.828Z,1589569857.828 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-05-15T19:10:57.842Z,1589569857.842 [PAR_Licor] Loaded
2020-05-15T19:10:57.843Z,1589569857.843 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-05-15T19:10:57.850Z,1589569857.850 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-05-15T19:10:57.850Z,1589569857.850 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-05-15T19:10:57.856Z,1589569857.856 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-05-15T19:10:57.856Z,1589569857.856 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-05-15T19:10:57.860Z,1589569857.860 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-05-15T19:10:57.861Z,1589569857.861 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-05-15T19:10:57.865Z,1589569857.865 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-05-15T19:10:57.865Z,1589569857.865 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-05-15T19:10:57.870Z,1589569857.870 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-05-15T19:10:57.870Z,1589569857.870 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-05-15T19:10:57.874Z,1589569857.874 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-05-15T19:10:57.875Z,1589569857.875 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-05-15T19:10:57.879Z,1589569857.879 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-05-15T19:10:57.879Z,1589569857.879 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-05-15T19:10:57.884Z,1589569857.884 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:10:57.888Z,1589569857.888 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:10:57.889Z,1589569857.889 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:10:57.889Z,1589569857.889 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:10:57.893Z,1589569857.893 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:10:57.893Z,1589569857.893 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:10:57.898Z,1589569857.898 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:10:57.898Z,1589569857.898 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:10:57.902Z,1589569857.902 [WetLabsBB2FL] Loaded
2020-05-15T19:10:57.902Z,1589569857.902 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-05-15T19:10:57.904Z,1589569857.904 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A6A4E0
2020-05-15T19:10:57.904Z,1589569857.904 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4233
2020-05-15T19:10:57.905Z,1589569857.905 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-05-15T19:10:57.905Z,1589569857.905 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-05-15T19:10:58.042Z,1589569858.042 [SBIT](DEBUG): Construct Startup Built In Test.
2020-05-15T19:10:58.053Z,1589569858.053 [SBIT] Loaded
2020-05-15T19:10:58.054Z,1589569858.054 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-05-15T19:10:58.054Z,1589569858.054 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-05-15T19:10:58.067Z,1589569858.067 [IBIT] Loaded
2020-05-15T19:10:58.067Z,1589569858.067 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-05-15T19:10:58.071Z,1589569858.071 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-05-15T19:10:58.210Z,1589569858.210 [CBIT] Loaded
2020-05-15T19:10:58.210Z,1589569858.210 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-05-15T19:10:58.211Z,1589569858.211 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-05-15T19:10:58.215Z,1589569858.215 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-05-15T19:10:58.216Z,1589569858.216 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-05-15T19:10:58.222Z,1589569858.222 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-05-15T19:10:58.223Z,1589569858.223 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AD54E0
2020-05-15T19:10:58.223Z,1589569858.223 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4234
2020-05-15T19:10:58.228Z,1589569858.228 [Supervisor](INFO): Main Thread ID is 3443
2020-05-15T19:10:58.228Z,1589569858.228 [Supervisor](DEBUG): Running supervisor.
2020-05-15T19:10:58.229Z,1589569858.229 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4235
2020-05-15T19:10:58.232Z,1589569858.232 [controlThread ThreadHandler](INFO): Handler Thread ID is 4236
2020-05-15T19:10:58.233Z,1589569858.233 [controlThread](DEBUG): Initializing ControlThread
2020-05-15T19:10:58.233Z,1589569858.233 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-05-15T19:10:58.234Z,1589569858.234 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-05-15T19:10:58.234Z,1589569858.234 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-05-15T19:10:58.235Z,1589569858.235 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-05-15T19:10:58.235Z,1589569858.235 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-05-15T19:10:58.236Z,1589569858.236 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-05-15T19:10:58.236Z,1589569858.236 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-05-15T19:10:58.238Z,1589569858.238 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-05-15T19:10:58.238Z,1589569858.238 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-05-15T19:10:58.239Z,1589569858.239 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-05-15T19:10:58.240Z,1589569858.240 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-05-15T19:10:58.240Z,1589569858.240 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-05-15T19:10:58.248Z,1589569858.248 [SBIT](INFO): Initialize SBIT Component.
2020-05-15T19:10:58.248Z,1589569858.248 [SBIT](IMPORTANT): git: 2020-02-26-39-g5ba86ef19
2020-05-15T19:10:58.248Z,1589569858.248 [SBIT](INFO): git hash: 5ba86ef19446a3a7971077fddc96013a7a660a2f
2020-05-15T19:10:58.249Z,1589569858.249 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-05-15T19:10:58.249Z,1589569858.249 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
2020-05-15T19:10:58.250Z,1589569858.250 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2020-05-15T19:10:58.251Z,1589569858.251 [IBIT](INFO): Initialize IBIT Component.
2020-05-15T19:10:58.252Z,1589569858.252 [CBIT](DEBUG): Initialize CBIT Component.
2020-05-15T19:10:58.252Z,1589569858.252 [logger ThreadHandler](INFO): Handler Thread ID is 4237
2020-05-15T19:10:58.264Z,1589569858.264 [CBIT](DEBUG): Initialized mux pins.
2020-05-15T19:10:58.264Z,1589569858.264 [CBIT](DEBUG): Initializing the watchdog timer.
2020-05-15T19:10:58.272Z,1589569858.272 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4238
2020-05-15T19:10:58.273Z,1589569858.273 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-05-15T19:10:58.284Z,1589569858.284 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4239
2020-05-15T19:10:58.287Z,1589569858.287 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-05-15T19:10:58.288Z,1589569858.288 [CBIT](DEBUG): Initializing heartbeat.
2020-05-15T19:10:58.296Z,1589569858.296 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4240
2020-05-15T19:10:58.297Z,1589569858.297 [WetLabsBB2FL](INFO): Powering down
2020-05-15T19:10:58.324Z,1589569858.324 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4241
2020-05-15T19:10:58.327Z,1589569858.327 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-05-15T19:10:58.327Z,1589569858.327 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-05-15T19:10:58.328Z,1589569858.328 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-05-15T19:10:58.328Z,1589569858.328 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-05-15T19:10:58.328Z,1589569858.328 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-05-15T19:10:58.328Z,1589569858.328 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-05-15T19:10:58.328Z,1589569858.328 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-05-15T19:10:58.329Z,1589569858.329 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-05-15T19:10:58.329Z,1589569858.329 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-05-15T19:10:58.329Z,1589569858.329 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-05-15T19:10:58.329Z,1589569858.329 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-05-15T19:10:58.329Z,1589569858.329 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-05-15T19:10:58.330Z,1589569858.330 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-05-15T19:10:58.330Z,1589569858.330 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-05-15T19:10:58.330Z,1589569858.330 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-05-15T19:10:58.330Z,1589569858.330 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-05-15T19:10:58.359Z,1589569858.359 [CBIT](DEBUG): Deactivating GF circuits.
2020-05-15T19:10:58.360Z,1589569858.360 [CBIT](DEBUG): Deactivating emergency mode.
2020-05-15T19:10:58.395Z,1589569858.395 [CBIT](DEBUG): Backplane powered.
2020-05-15T19:10:58.396Z,1589569858.396 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-05-15T19:10:58.406Z,1589569858.406 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-05-15T19:10:58.417Z,1589569858.417 [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-05-15T19:10:58.417Z,1589569858.417 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-05-15T19:10:58.484Z,1589569858.484 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-05-15T19:10:58.485Z,1589569858.485 [Default:A.Wait](DEBUG): Construct Wait.
2020-05-15T19:10:58.486Z,1589569858.486 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-05-15T19:10:58.533Z,1589569858.533 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-05-15T19:10:58.536Z,1589569858.536 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-05-15T19:10:58.558Z,1589569858.558 [Default:E.Execute](DEBUG): Construct Execute.
2020-05-15T19:10:58.561Z,1589569858.561 [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-05-15T19:10:58.571Z,1589569858.571 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,DropWeight,NAL9602,Onboard,DAT,BPC1,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-05-15T19:10:58.598Z,1589569858.598 [Depth_Keller](ERROR): Pressure reading out of range: 1829.799438 decibar
2020-05-15T19:10:58.644Z,1589569858.644 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:10:58.644Z,1589569858.644 [DAT](INFO): Powering up
2020-05-15T19:10:58.644Z,1589569858.644 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:10:58.688Z,1589569858.688 [Radio_Surface](INFO): Powering up
2020-05-15T19:10:58.721Z,1589569858.721 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-05-15T19:10:58.732Z,1589569858.732 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:10:58.778Z,1589569858.778 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:10:58.803Z,1589569858.803 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-05-15T19:10:58.820Z,1589569858.820 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:10:58.824Z,1589569858.824 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-05-15T19:10:58.825Z,1589569858.825 [MassServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:10:58.848Z,1589569858.848 [MassServo](DEBUG): Initializing MassServo.
2020-05-15T19:10:58.849Z,1589569858.849 [RudderServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:10:58.880Z,1589569858.880 [RudderServo](DEBUG): Initializing RudderServo.
2020-05-15T19:10:58.881Z,1589569858.881 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:10:58.888Z,1589569858.888 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-05-15T19:10:59.025Z,1589569859.025 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-05-15T19:10:59.736Z,1589569859.736 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-05-15T19:10:59.736Z,1589569859.736 [RudderServo](FAULT): Rudder failed to initialize
2020-05-15T19:10:59.736Z,1589569859.736 [RudderServo] Communications Fault, FailCount= 1
2020-05-15T19:10:59.736Z,1589569859.736 [RudderServo](ERROR): Communications Fault
2020-05-15T19:10:59.847Z,1589569859.847 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-05-15T19:11:00.021Z,1589569860.021 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-05-15T19:11:00.021Z,1589569860.021 [RudderServo](INFO): Powering down
2020-05-15T19:11:00.731Z,1589569860.731 [RudderServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:11:00.864Z,1589569860.864 [RudderServo](DEBUG): Initializing RudderServo.
2020-05-15T19:11:00.868Z,1589569860.868 [CBIT](INFO): Clearing failed state for component RudderServo
2020-05-15T19:11:00.868Z,1589569860.868 [RudderServo] No Fault, FailCount= 1
2020-05-15T19:11:08.383Z,1589569868.383 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:11:08.387Z,1589569868.387 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:11:08.407Z,1589569868.407 [Onboard](IMPORTANT): Battery Current:8.335999 mA
2020-05-15T19:11:08.408Z,1589569868.408 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:11:08.408Z,1589569868.408 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:11:08.408Z,1589569868.408 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:11:08.408Z,1589569868.408 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:11:18.457Z,1589569878.457 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:11:18.481Z,1589569878.481 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:11:18.488Z,1589569878.488 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:11:18.488Z,1589569878.488 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:11:18.489Z,1589569878.489 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:11:18.489Z,1589569878.489 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:11:18.489Z,1589569878.489 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:11:18.906Z,1589569878.906 [SBIT](IMPORTANT): Beginning Startup BIT
2020-05-15T19:11:18.943Z,1589569878.943 [CBIT](IMPORTANT): Beginning ground fault scan
2020-05-15T19:11:25.010Z,1589569885.010 [NAL9602](INFO): Powering up NAL9602
2020-05-15T19:11:28.656Z,1589569888.656 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:11:28.660Z,1589569888.660 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:11:28.666Z,1589569888.666 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T19:11:28.666Z,1589569888.666 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:11:28.666Z,1589569888.666 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:11:28.667Z,1589569888.667 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:11:28.667Z,1589569888.667 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:11:29.915Z,1589569889.915 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.024944
CHAN A1 (24V): 0.003168
CHAN A2 (12V): -0.003954
CHAN A3 (5V): 0.000877
CHAN B0 (3.3V): -0.001307
CHAN B1 (3.15aV): -0.001025
CHAN B2 (3.15bV): -0.001688
CHAN B3 (GND): -0.000996
OPEN: 0.003928
Full Scale Calc: 4.765 mA, -1.589 mA
2020-05-15T19:11:36.081Z,1589569896.081 [NAL9602](INFO): NAL9602 initialized
2020-05-15T19:11:38.926Z,1589569898.926 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:11:38.929Z,1589569898.929 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:11:38.935Z,1589569898.935 [Onboard](IMPORTANT): Battery Current:9.899000 mA
2020-05-15T19:11:38.936Z,1589569898.936 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:11:38.936Z,1589569898.936 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:11:38.936Z,1589569898.936 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:11:38.936Z,1589569898.936 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:11:49.026Z,1589569909.026 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:11:49.029Z,1589569909.029 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:11:49.035Z,1589569909.035 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:11:49.035Z,1589569909.035 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:11:49.035Z,1589569909.035 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:11:49.036Z,1589569909.036 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:11:49.036Z,1589569909.036 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:11:58.715Z,1589569918.715 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:11:58.715Z,1589569918.715 [DAT] Communications Fault, FailCount= 1
2020-05-15T19:11:58.716Z,1589569918.716 [DAT](ERROR): Communications Fault
2020-05-15T19:11:58.774Z,1589569918.774 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:11:59.123Z,1589569919.123 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:11:59.126Z,1589569919.126 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:11:59.132Z,1589569919.132 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:11:59.132Z,1589569919.132 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:11:59.132Z,1589569919.132 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:11:59.133Z,1589569919.133 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:11:59.133Z,1589569919.133 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:11:59.133Z,1589569919.133 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:11:59.185Z,1589569919.185 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:11:59.186Z,1589569919.186 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:11:59.186Z,1589569919.186 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:11:59.186Z,1589569919.186 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:11:59.186Z,1589569919.186 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:11:59.187Z,1589569919.187 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:11:59.187Z,1589569919.187 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:11:59.187Z,1589569919.187 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:11:59.190Z,1589569919.190 [DAT](INFO): Powering down
2020-05-15T19:11:59.948Z,1589569919.948 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:11:59.948Z,1589569919.948 [DAT] No Fault, FailCount= 1
2020-05-15T19:12:02.465Z,1589569922.465 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:12:02.465Z,1589569922.465 [DAT](INFO): Powering up
2020-05-15T19:12:02.465Z,1589569922.465 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:12:02.483Z,1589569922.483 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:12:09.330Z,1589569929.330 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:12:09.333Z,1589569929.333 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:12:09.369Z,1589569929.369 [Onboard](IMPORTANT): Battery Current:8.335999 mA
2020-05-15T19:12:09.369Z,1589569929.369 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:12:09.369Z,1589569929.369 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:12:09.369Z,1589569929.369 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:12:09.370Z,1589569929.370 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:12:12.982Z,1589569932.982 [SBIT](IMPORTANT): SBIT PASSED
2020-05-15T19:12:12.982Z,1589569932.982 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-05-15T19:12:13.021Z,1589569933.021 [SBIT](IMPORTANT): 

2020-05-15T19:12:13.021Z,1589569933.021 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2020-05-15T19:12:13.021Z,1589569933.021 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2020-05-15T19:12:13.021Z,1589569933.021 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2020-05-15T19:12:13.021Z,1589569933.021 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2020-05-15T19:12:13.021Z,1589569933.021 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool;

2020-05-15T19:12:13.386Z,1589569933.386 [MissionManager](IMPORTANT): Started mission Startup
2020-05-15T19:12:13.386Z,1589569933.386 [Startup] Running Loop=1
2020-05-15T19:12:13.386Z,1589569933.386 [Startup](DEBUG): Aggregate::initialize Startup
2020-05-15T19:12:13.386Z,1589569933.386 [Startup:A.GoToSurface] Running Loop=1
2020-05-15T19:12:13.386Z,1589569933.386 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-05-15T19:12:13.387Z,1589569933.387 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-05-15T19:12:13.388Z,1589569933.388 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-05-15T19:12:13.388Z,1589569933.388 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-05-15T19:12:13.388Z,1589569933.388 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-05-15T19:12:13.389Z,1589569933.389 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-05-15T19:12:13.390Z,1589569933.390 [Startup:StartupSatComms] Running Loop=1
2020-05-15T19:12:13.391Z,1589569933.391 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-05-15T19:12:13.391Z,1589569933.391 [Startup:StartupSatComms:A] Running Loop=1
2020-05-15T19:12:13.797Z,1589569933.797 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-05-15T19:12:19.431Z,1589569939.431 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:12:19.435Z,1589569939.435 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:12:19.441Z,1589569939.441 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:12:19.441Z,1589569939.441 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:12:19.441Z,1589569939.441 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:12:19.441Z,1589569939.441 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:12:19.442Z,1589569939.442 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:12:29.531Z,1589569949.531 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:12:29.534Z,1589569949.534 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:12:29.576Z,1589569949.576 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T19:12:29.577Z,1589569949.577 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:12:29.577Z,1589569949.577 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:12:29.577Z,1589569949.577 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:12:29.577Z,1589569949.577 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:12:39.635Z,1589569959.635 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:12:39.638Z,1589569959.638 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:12:39.644Z,1589569959.644 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:12:39.644Z,1589569959.644 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:12:39.645Z,1589569959.645 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:12:39.645Z,1589569959.645 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:12:39.645Z,1589569959.645 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:12:49.733Z,1589569969.733 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:12:49.736Z,1589569969.736 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:12:49.742Z,1589569969.742 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:12:49.742Z,1589569969.742 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:12:49.742Z,1589569969.742 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:12:49.743Z,1589569969.743 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:12:49.743Z,1589569969.743 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:12:58.643Z,1589569978.643 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T19:12:58.643Z,1589569978.643 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-05-15T19:12:58.643Z,1589569978.643 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T19:12:58.654Z,1589569978.654 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T19:12:59.049Z,1589569979.049 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T19:12:59.049Z,1589569979.049 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-05-15T19:12:59.831Z,1589569979.831 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:12:59.834Z,1589569979.834 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:12:59.877Z,1589569979.877 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:12:59.877Z,1589569979.877 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:12:59.878Z,1589569979.878 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:12:59.878Z,1589569979.878 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:12:59.878Z,1589569979.878 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:12:59.878Z,1589569979.878 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:12:59.928Z,1589569979.928 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:12:59.929Z,1589569979.929 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:12:59.929Z,1589569979.929 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:12:59.929Z,1589569979.929 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:12:59.929Z,1589569979.929 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:12:59.929Z,1589569979.929 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:12:59.930Z,1589569979.930 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:12:59.930Z,1589569979.930 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:12:59.930Z,1589569979.930 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:13:02.659Z,1589569982.659 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:13:02.660Z,1589569982.660 [DAT] Communications Fault, FailCount= 2
2020-05-15T19:13:02.660Z,1589569982.660 [DAT](ERROR): Communications Fault
2020-05-15T19:13:02.714Z,1589569982.714 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:13:03.069Z,1589569983.069 [DAT](INFO): Powering down
2020-05-15T19:13:03.902Z,1589569983.902 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:13:03.902Z,1589569983.902 [DAT] No Fault, FailCount= 2
2020-05-15T19:13:06.293Z,1589569986.293 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:13:06.294Z,1589569986.294 [DAT](INFO): Powering up
2020-05-15T19:13:06.294Z,1589569986.294 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:13:06.364Z,1589569986.364 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:13:09.932Z,1589569989.932 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:13:09.935Z,1589569989.935 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:13:09.941Z,1589569989.941 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:13:09.941Z,1589569989.941 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:13:09.942Z,1589569989.942 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:13:09.942Z,1589569989.942 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:13:09.942Z,1589569989.942 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:13:13.593Z,1589569993.593 [Startup:StartupSatComms:A](INFO): Timed out from 2020-05-15T19:12:13.4Z
2020-05-15T19:13:13.593Z,1589569993.593 [Startup:StartupSatComms:A] Stopped
2020-05-15T19:13:13.593Z,1589569993.593 [Startup:StartupSatComms:B] Running Loop=1
2020-05-15T19:13:13.993Z,1589569993.993 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-05-15T19:13:20.041Z,1589570000.041 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:13:20.044Z,1589570000.044 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:13:20.050Z,1589570000.050 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:13:20.050Z,1589570000.050 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:13:20.050Z,1589570000.050 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:13:20.050Z,1589570000.050 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:13:20.051Z,1589570000.051 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:13:25.968Z,1589570005.968 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005171
2020-05-15T19:13:30.145Z,1589570010.145 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:13:30.148Z,1589570010.148 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:13:30.154Z,1589570010.154 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:13:30.154Z,1589570010.154 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:13:30.154Z,1589570010.154 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:13:30.155Z,1589570010.155 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:13:30.155Z,1589570010.155 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:13:40.237Z,1589570020.237 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:13:40.240Z,1589570020.240 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:13:40.246Z,1589570020.246 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T19:13:40.247Z,1589570020.247 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:13:40.247Z,1589570020.247 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:13:40.247Z,1589570020.247 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:13:40.247Z,1589570020.247 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:13:50.345Z,1589570030.345 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:13:50.348Z,1589570030.348 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:13:50.354Z,1589570030.354 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:13:50.355Z,1589570030.355 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:13:50.355Z,1589570030.355 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:13:50.355Z,1589570030.355 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:13:50.356Z,1589570030.356 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:14:00.430Z,1589570040.430 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:14:00.433Z,1589570040.433 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:14:00.439Z,1589570040.439 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:14:00.439Z,1589570040.439 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:14:00.440Z,1589570040.440 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:14:00.440Z,1589570040.440 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:14:00.440Z,1589570040.440 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:14:00.440Z,1589570040.440 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:14:00.533Z,1589570040.533 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:14:00.534Z,1589570040.534 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:14:00.534Z,1589570040.534 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:14:00.534Z,1589570040.534 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:14:00.534Z,1589570040.534 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:14:00.535Z,1589570040.535 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:14:00.535Z,1589570040.535 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:14:00.535Z,1589570040.535 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:14:00.535Z,1589570040.535 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:14:06.500Z,1589570046.500 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:14:06.500Z,1589570046.500 [DAT] Communications Fault, FailCount= 3
2020-05-15T19:14:06.501Z,1589570046.501 [DAT](ERROR): Communications Fault
2020-05-15T19:14:06.521Z,1589570046.521 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:14:06.906Z,1589570046.906 [DAT](INFO): Powering down
2020-05-15T19:14:07.733Z,1589570047.733 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:14:07.733Z,1589570047.733 [DAT] No Fault, FailCount= 3
2020-05-15T19:14:10.126Z,1589570050.126 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:14:10.127Z,1589570050.127 [DAT](INFO): Powering up
2020-05-15T19:14:10.127Z,1589570050.127 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:14:10.190Z,1589570050.190 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:14:10.531Z,1589570050.531 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:14:10.534Z,1589570050.534 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:14:10.540Z,1589570050.540 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:14:10.541Z,1589570050.541 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:14:10.541Z,1589570050.541 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:14:10.541Z,1589570050.541 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:14:10.541Z,1589570050.541 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:14:13.781Z,1589570053.781 [Startup:StartupSatComms:B](INFO): Timed out from 2020-05-15T19:13:13.6Z
2020-05-15T19:14:13.781Z,1589570053.781 [Startup:StartupSatComms:B] Stopped
2020-05-15T19:14:13.781Z,1589570053.781 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-05-15T19:14:13.781Z,1589570053.781 [Startup:StartupSatComms] Stopped
2020-05-15T19:14:13.782Z,1589570053.782 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-05-15T19:14:13.782Z,1589570053.782 [Startup](INFO): Completed Startup
2020-05-15T19:14:13.782Z,1589570053.782 [MissionManager](INFO): Startup is completed.
2020-05-15T19:14:13.783Z,1589570053.783 [MissionManager](INFO): Uninitializing Mission Startup
2020-05-15T19:14:13.783Z,1589570053.783 [Startup] Stopped
2020-05-15T19:14:13.783Z,1589570053.783 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-05-15T19:14:13.783Z,1589570053.783 [Startup:A.GoToSurface] Stopped
2020-05-15T19:14:13.783Z,1589570053.783 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-05-15T19:14:14.204Z,1589570054.204 [MissionManager](IMPORTANT): Started mission Default
2020-05-15T19:14:14.204Z,1589570054.204 [Default] Running Loop=1
2020-05-15T19:14:14.204Z,1589570054.204 [Default](DEBUG): Aggregate::initialize Default
2020-05-15T19:14:14.204Z,1589570054.204 [Default:B.GoToSurface] Running Loop=1
2020-05-15T19:14:14.204Z,1589570054.204 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-05-15T19:14:14.204Z,1589570054.204 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-05-15T19:14:14.205Z,1589570054.205 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-05-15T19:14:14.205Z,1589570054.205 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-05-15T19:14:14.205Z,1589570054.205 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-05-15T19:14:14.206Z,1589570054.206 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-05-15T19:14:14.206Z,1589570054.206 [Default:A.Wait] Running Loop=1
2020-05-15T19:14:14.206Z,1589570054.206 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-05-15T19:14:20.634Z,1589570060.634 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:14:20.638Z,1589570060.638 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:14:20.644Z,1589570060.644 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:14:20.644Z,1589570060.644 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:14:20.644Z,1589570060.644 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:14:20.644Z,1589570060.644 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:14:20.645Z,1589570060.645 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:14:27.571Z,1589570067.571 [Default:A.Wait](INFO): Done Waiting.
2020-05-15T19:14:27.571Z,1589570067.571 [Default:A.Wait] Stopped
2020-05-15T19:14:27.571Z,1589570067.571 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-05-15T19:14:27.944Z,1589570067.944 [Default:CheckIn] Running Loop=1
2020-05-15T19:14:27.944Z,1589570067.944 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-05-15T19:14:27.944Z,1589570067.944 [Default:CheckIn:Read_GPS] Running Loop=1
2020-05-15T19:14:28.345Z,1589570068.345 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-05-15T19:14:30.730Z,1589570070.730 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:14:30.733Z,1589570070.733 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:14:30.774Z,1589570070.774 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:14:30.774Z,1589570070.774 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:14:30.774Z,1589570070.774 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:14:30.774Z,1589570070.774 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:14:30.775Z,1589570070.775 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:14:40.830Z,1589570080.830 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:14:40.833Z,1589570080.833 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:14:40.869Z,1589570080.869 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:14:40.870Z,1589570080.870 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:14:40.870Z,1589570080.870 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:14:40.870Z,1589570080.870 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:14:40.870Z,1589570080.870 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:14:50.930Z,1589570090.930 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:14:50.933Z,1589570090.933 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:14:50.939Z,1589570090.939 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:14:50.939Z,1589570090.939 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:14:50.939Z,1589570090.939 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:14:50.940Z,1589570090.940 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:14:50.940Z,1589570090.940 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:14:57.516Z,1589570097.516 [CommandLine](IMPORTANT): got command report mod platform_average_current
2020-05-15T19:14:57.860Z,1589570097.860 [Reporter](INFO): platform_average_current 0.000000 mA
2020-05-15T19:14:59.462Z,1589570099.462 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T19:14:59.462Z,1589570099.462 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-05-15T19:14:59.462Z,1589570099.462 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T19:14:59.473Z,1589570099.473 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T19:14:59.849Z,1589570099.849 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T19:14:59.849Z,1589570099.849 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-05-15T19:15:01.034Z,1589570101.034 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:15:01.038Z,1589570101.038 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:15:01.044Z,1589570101.044 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:15:01.044Z,1589570101.044 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:15:01.044Z,1589570101.044 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:15:01.044Z,1589570101.044 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:15:01.045Z,1589570101.045 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:15:01.045Z,1589570101.045 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:15:01.056Z,1589570101.056 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:15:01.056Z,1589570101.056 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:15:01.057Z,1589570101.057 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:15:01.057Z,1589570101.057 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:15:01.057Z,1589570101.057 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:15:01.057Z,1589570101.057 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:15:01.058Z,1589570101.058 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:15:01.058Z,1589570101.058 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:15:01.058Z,1589570101.058 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:15:10.330Z,1589570110.330 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:15:10.330Z,1589570110.330 [DAT] Communications Fault, FailCount= 4
2020-05-15T19:15:10.330Z,1589570110.330 [DAT](ERROR): Communications Fault
2020-05-15T19:15:10.387Z,1589570110.387 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:15:10.721Z,1589570110.721 [DAT](INFO): Powering down
2020-05-15T19:15:11.128Z,1589570111.128 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:15:11.131Z,1589570111.131 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:15:11.137Z,1589570111.137 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:15:11.137Z,1589570111.137 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:15:11.137Z,1589570111.137 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:15:11.138Z,1589570111.138 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:15:11.138Z,1589570111.138 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:15:11.559Z,1589570111.559 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:15:11.559Z,1589570111.559 [DAT] No Fault, FailCount= 4
2020-05-15T19:15:13.958Z,1589570113.958 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:15:13.959Z,1589570113.959 [DAT](INFO): Powering up
2020-05-15T19:15:13.959Z,1589570113.959 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:15:14.043Z,1589570114.043 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:15:21.239Z,1589570121.239 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:15:21.242Z,1589570121.242 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:15:21.284Z,1589570121.284 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:15:21.284Z,1589570121.284 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:15:21.284Z,1589570121.284 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:15:21.284Z,1589570121.284 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:15:21.285Z,1589570121.285 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:15:31.351Z,1589570131.351 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:15:31.355Z,1589570131.355 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:15:31.361Z,1589570131.361 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:15:31.361Z,1589570131.361 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:15:31.361Z,1589570131.361 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:15:31.361Z,1589570131.361 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:15:31.362Z,1589570131.362 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:15:41.453Z,1589570141.453 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:15:41.476Z,1589570141.476 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:15:41.482Z,1589570141.482 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:15:41.483Z,1589570141.483 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:15:41.483Z,1589570141.483 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:15:41.483Z,1589570141.483 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:15:41.483Z,1589570141.483 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:15:51.552Z,1589570151.552 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:15:51.555Z,1589570151.555 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:15:51.561Z,1589570151.561 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:15:51.562Z,1589570151.562 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:15:51.562Z,1589570151.562 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:15:51.562Z,1589570151.562 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:15:51.562Z,1589570151.562 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:16:01.653Z,1589570161.653 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:16:01.656Z,1589570161.656 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:16:01.662Z,1589570161.662 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:16:01.662Z,1589570161.662 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:16:01.662Z,1589570161.662 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:16:01.662Z,1589570161.662 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:16:01.663Z,1589570161.663 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:16:01.663Z,1589570161.663 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:16:01.674Z,1589570161.674 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:16:01.674Z,1589570161.674 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:16:01.674Z,1589570161.674 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:16:01.675Z,1589570161.675 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:16:01.675Z,1589570161.675 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:16:01.675Z,1589570161.675 [Onboard](IMPORTANT): Adding to average power:15.382000
2020-05-15T19:16:01.675Z,1589570161.675 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:16:01.675Z,1589570161.675 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:16:01.676Z,1589570161.676 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:16:11.734Z,1589570171.734 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:16:11.737Z,1589570171.737 [Onboard](IMPORTANT): Backup Battery Voltage:15.422000 V
2020-05-15T19:16:11.744Z,1589570171.744 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:16:11.744Z,1589570171.744 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:16:11.744Z,1589570171.744 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:16:11.744Z,1589570171.744 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:16:11.744Z,1589570171.744 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:16:14.160Z,1589570174.160 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:16:14.160Z,1589570174.160 [DAT] Communications Fault, FailCount= 5
2020-05-15T19:16:14.160Z,1589570174.160 [DAT](ERROR): Communications Fault
2020-05-15T19:16:14.216Z,1589570174.216 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:16:14.559Z,1589570174.559 [DAT](INFO): Powering down
2020-05-15T19:16:15.392Z,1589570175.392 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:16:15.392Z,1589570175.392 [DAT] No Fault, FailCount= 5
2020-05-15T19:16:17.808Z,1589570177.808 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:16:17.808Z,1589570177.808 [DAT](INFO): Powering up
2020-05-15T19:16:17.808Z,1589570177.808 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:16:17.902Z,1589570177.902 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:16:21.840Z,1589570181.840 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:16:21.843Z,1589570181.843 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:16:21.849Z,1589570181.849 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:16:21.849Z,1589570181.849 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:16:21.850Z,1589570181.850 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:16:21.850Z,1589570181.850 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:16:21.850Z,1589570181.850 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:16:31.937Z,1589570191.937 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:16:31.941Z,1589570191.941 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:16:31.947Z,1589570191.947 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:16:32.001Z,1589570192.001 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:16:32.002Z,1589570192.002 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:16:32.002Z,1589570192.002 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:16:32.002Z,1589570192.002 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:16:37.552Z,1589570197.552 [CommandLine](IMPORTANT): got command restart application
2020-05-15T19:16:38.564Z,1589570198.564 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2020-05-15T19:16:38.565Z,1589570198.565 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:16:38.565Z,1589570198.565 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:38.595Z,1589570198.595 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-05-15T19:16:38.596Z,1589570198.596 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:38.596Z,1589570198.596 [CommandLine](INFO): Join timeout helper Thread ID is 4274
2020-05-15T19:16:38.597Z,1589570198.597 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-05-15T19:16:38.597Z,1589570198.597 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:38.597Z,1589570198.597 [NavChartDb](INFO): Join timeout helper Thread ID is 4275
2020-05-15T19:16:38.912Z,1589570198.912 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:16:38.912Z,1589570198.912 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:38.919Z,1589570198.919 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-05-15T19:16:38.920Z,1589570198.920 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:38.920Z,1589570198.920 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4276
2020-05-15T19:16:39.068Z,1589570199.068 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:16:39.068Z,1589570199.068 [WetLabsBB2FL](INFO): Powering down
2020-05-15T19:16:39.069Z,1589570199.069 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.079Z,1589570199.079 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-05-15T19:16:39.080Z,1589570199.080 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.080Z,1589570199.080 [Radio_Surface](INFO): Join timeout helper Thread ID is 4277
2020-05-15T19:16:39.311Z,1589570199.311 [Radio_Surface](INFO): Powering down
2020-05-15T19:16:39.312Z,1589570199.312 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:16:39.313Z,1589570199.313 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.323Z,1589570199.323 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-05-15T19:16:39.324Z,1589570199.324 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.324Z,1589570199.324 [DataOverHttps](INFO): Join timeout helper Thread ID is 4278
2020-05-15T19:16:39.340Z,1589570199.340 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:16:39.340Z,1589570199.340 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.344Z,1589570199.344 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-05-15T19:16:39.344Z,1589570199.344 [logger ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.345Z,1589570199.345 [logger](INFO): Join timeout helper Thread ID is 4279
2020-05-15T19:16:39.352Z,1589570199.352 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:16:39.352Z,1589570199.352 [logger ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.364Z,1589570199.364 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-05-15T19:16:39.364Z,1589570199.364 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.364Z,1589570199.364 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-05-15T19:16:39.365Z,1589570199.365 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.365Z,1589570199.365 [controlThread](INFO): Join timeout helper Thread ID is 4280
2020-05-15T19:16:39.588Z,1589570199.588 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:16:39.588Z,1589570199.588 [controlThread](DEBUG): Uninitializing ControlThread
2020-05-15T19:16:39.589Z,1589570199.589 [NAL9602](INFO): Powering down
2020-05-15T19:16:39.590Z,1589570199.590 [DAT](INFO): Powering down
2020-05-15T19:16:39.729Z,1589570199.729 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-05-15T19:16:39.730Z,1589570199.730 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-05-15T19:16:39.730Z,1589570199.730 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-05-15T19:16:39.731Z,1589570199.731 [MissionManager](INFO): Uninitializing Mission Default
2020-05-15T19:16:39.731Z,1589570199.731 [Default] Stopped
2020-05-15T19:16:39.731Z,1589570199.731 [Default](DEBUG): Aggregate::uninitialize Default
2020-05-15T19:16:39.731Z,1589570199.731 [Default:B.GoToSurface] Stopped
2020-05-15T19:16:39.731Z,1589570199.731 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-05-15T19:16:39.731Z,1589570199.731 [Default:CheckIn] Stopped
2020-05-15T19:16:39.732Z,1589570199.732 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-05-15T19:16:39.732Z,1589570199.732 [Default:CheckIn:Read_GPS] Stopped
2020-05-15T19:16:39.734Z,1589570199.734 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-05-15T19:16:39.734Z,1589570199.734 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-05-15T19:16:39.734Z,1589570199.734 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-05-15T19:16:39.735Z,1589570199.735 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-05-15T19:16:39.735Z,1589570199.735 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-05-15T19:16:39.735Z,1589570199.735 [BuoyancyServo](INFO): Powering down
2020-05-15T19:16:39.748Z,1589570199.748 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-05-15T19:16:39.748Z,1589570199.748 [ElevatorServo](INFO): Powering down
2020-05-15T19:16:39.748Z,1589570199.748 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-05-15T19:16:39.749Z,1589570199.749 [MassServo](INFO): Powering down
2020-05-15T19:16:39.749Z,1589570199.749 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-05-15T19:16:39.749Z,1589570199.749 [RudderServo](INFO): Powering down
2020-05-15T19:16:39.750Z,1589570199.750 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-05-15T19:16:39.750Z,1589570199.750 [ThrusterServo](INFO): Powering down
2020-05-15T19:16:39.751Z,1589570199.751 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-05-15T19:16:39.751Z,1589570199.751 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-05-15T19:16:39.752Z,1589570199.752 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-05-15T19:16:39.752Z,1589570199.752 [CBIT](DEBUG): Powering off loads.
2020-05-15T19:16:39.763Z,1589570199.763 [CBIT](DEBUG): Disabling WDT.
2020-05-15T19:16:39.775Z,1589570199.775 [CBIT](DEBUG): Opening all GF detection circuits.
2020-05-15T19:16:39.776Z,1589570199.776 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.852Z,1589570199.852 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.859Z,1589570199.859 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.914Z,1589570199.914 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.941Z,1589570199.941 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:16:39.997Z,1589570199.997 [logger ThreadHandler](INFO): Thread cancelled.