2020-05-15T18:52:45.781Z,1589568765.781 [Supervisor](DEBUG): Initializing supervisor.
2020-05-15T18:52:45.784Z,1589568765.784 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-05-15T18:52:45.784Z,1589568765.784 [SyncHandler](INFO): Protected caller Thread ID is 3760
2020-05-15T18:52:45.785Z,1589568765.785 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-05-15T18:52:45.786Z,1589568765.786 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-05-15T18:52:45.786Z,1589568765.786 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3761
2020-05-15T18:52:45.789Z,1589568765.789 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-05-15T18:52:45.801Z,1589568765.801 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-05-15T18:52:45.802Z,1589568765.802 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-05-15T18:52:45.802Z,1589568765.802 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3762
2020-05-15T18:52:45.803Z,1589568765.803 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-05-15T18:52:45.804Z,1589568765.804 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-05-15T18:52:45.804Z,1589568765.804 [logger ThreadHandler](INFO): Protected caller Thread ID is 3763
2020-05-15T18:52:45.806Z,1589568765.806 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-05-15T18:52:45.806Z,1589568765.806 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-05-15T18:52:45.808Z,1589568765.808 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-05-15T18:52:46.120Z,1589568766.120 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-05-15T18:52:46.120Z,1589568766.120 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-05-15T18:52:46.685Z,1589568766.685 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-05-15T18:52:46.685Z,1589568766.685 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-05-15T18:52:46.820Z,1589568766.820 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-05-15T18:52:46.820Z,1589568766.820 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-05-15T18:52:47.255Z,1589568767.255 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-05-15T18:52:47.256Z,1589568767.256 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-05-15T18:52:47.349Z,1589568767.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-05-15T18:52:47.350Z,1589568767.350 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-05-15T18:52:47.430Z,1589568767.430 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-05-15T18:52:47.720Z,1589568767.720 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-05-15T18:52:47.721Z,1589568767.721 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-05-15T18:52:47.862Z,1589568767.862 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-05-15T18:52:47.863Z,1589568767.863 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-05-15T18:52:47.963Z,1589568767.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-05-15T18:52:47.964Z,1589568767.964 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-05-15T18:52:48.430Z,1589568768.430 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-05-15T18:52:48.431Z,1589568768.431 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-05-15T18:52:48.823Z,1589568768.823 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-05-15T18:52:48.824Z,1589568768.824 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-05-15T18:52:48.924Z,1589568768.924 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-05-15T18:52:48.924Z,1589568768.924 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-05-15T18:52:49.106Z,1589568769.106 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-05-15T18:52:49.106Z,1589568769.106 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-05-15T18:52:49.303Z,1589568769.303 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-05-15T18:52:49.304Z,1589568769.304 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-05-15T18:52:49.521Z,1589568769.521 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-05-15T18:52:49.523Z,1589568769.523 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2020-05-15T18:52:49.524Z,1589568769.524 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2020-05-15T18:52:49.622Z,1589568769.622 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2020-05-15T18:52:49.772Z,1589568769.772 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2020-05-15T18:52:49.922Z,1589568769.922 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2020-05-15T18:52:50.102Z,1589568770.102 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2020-05-15T18:52:50.270Z,1589568770.270 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2020-05-15T18:52:50.579Z,1589568770.579 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2020-05-15T18:52:50.802Z,1589568770.802 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-05-15T18:52:50.803Z,1589568770.803 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2020-05-15T18:52:50.910Z,1589568770.910 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2020-05-15T18:52:51.002Z,1589568771.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2020-05-15T18:52:51.097Z,1589568771.097 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2020-05-15T18:52:51.189Z,1589568771.189 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/
2020-05-15T18:52:51.189Z,1589568771.189 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-05-15T18:52:51.196Z,1589568771.196 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-05-15T18:52:51.215Z,1589568771.215 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-05-15T18:52:51.216Z,1589568771.216 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-05-15T18:52:51.257Z,1589568771.257 [DepthRateCalculator] Loaded
2020-05-15T18:52:51.258Z,1589568771.258 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-05-15T18:52:51.263Z,1589568771.263 [PitchRateCalculator] Loaded
2020-05-15T18:52:51.264Z,1589568771.264 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-05-15T18:52:51.279Z,1589568771.279 [SpeedCalculator] Loaded
2020-05-15T18:52:51.279Z,1589568771.279 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-05-15T18:52:51.300Z,1589568771.300 [TempGradientCalculator] Loaded
2020-05-15T18:52:51.301Z,1589568771.301 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-05-15T18:52:51.306Z,1589568771.306 [YawRateCalculator] Loaded
2020-05-15T18:52:51.307Z,1589568771.307 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-05-15T18:52:51.346Z,1589568771.346 [ElevatorOffsetCalculator] Loaded
2020-05-15T18:52:51.346Z,1589568771.346 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-05-15T18:52:51.347Z,1589568771.347 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-05-15T18:52:51.347Z,1589568771.347 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-05-15T18:52:51.396Z,1589568771.396 [VerticalControl](DEBUG): Construct VerticalControl.
2020-05-15T18:52:51.496Z,1589568771.496 [VerticalControl] Loaded
2020-05-15T18:52:51.496Z,1589568771.496 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-05-15T18:52:51.497Z,1589568771.497 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-05-15T18:52:51.576Z,1589568771.576 [HorizontalControl] Loaded
2020-05-15T18:52:51.576Z,1589568771.576 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-05-15T18:52:51.577Z,1589568771.577 [SpeedControl](DEBUG): Construct SpeedControl.
2020-05-15T18:52:51.582Z,1589568771.582 [SpeedControl] Loaded
2020-05-15T18:52:51.582Z,1589568771.582 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-05-15T18:52:51.583Z,1589568771.583 [LoopControl](DEBUG): Construct LoopControl.
2020-05-15T18:52:51.584Z,1589568771.584 [LoopControl] Loaded
2020-05-15T18:52:51.584Z,1589568771.584 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-05-15T18:52:51.584Z,1589568771.584 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-05-15T18:52:51.585Z,1589568771.585 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-05-15T18:52:51.687Z,1589568771.687 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-05-15T18:52:51.687Z,1589568771.687 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-05-15T18:52:51.708Z,1589568771.708 [NavChart] Loaded
2020-05-15T18:52:51.708Z,1589568771.708 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-05-15T18:52:51.712Z,1589568771.712 [UniversalFixResidualReporter] Loaded
2020-05-15T18:52:51.712Z,1589568771.712 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-05-15T18:52:51.712Z,1589568771.712 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-05-15T18:52:51.713Z,1589568771.713 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-05-15T18:52:51.814Z,1589568771.814 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-05-15T18:52:51.815Z,1589568771.815 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-05-15T18:52:52.191Z,1589568772.191 [DataOverHttps] Loaded
2020-05-15T18:52:52.191Z,1589568772.191 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-05-15T18:52:52.192Z,1589568772.192 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408244E0
2020-05-15T18:52:52.192Z,1589568772.192 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3842
2020-05-15T18:52:52.230Z,1589568772.230 [Depth_Keller] Loaded
2020-05-15T18:52:52.230Z,1589568772.230 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-05-15T18:52:52.235Z,1589568772.235 [DropWeight] Loaded
2020-05-15T18:52:52.235Z,1589568772.235 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-05-15T18:52:52.337Z,1589568772.337 [NAL9602] Loaded
2020-05-15T18:52:52.338Z,1589568772.338 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-05-15T18:52:52.386Z,1589568772.386 [Onboard] Loaded
2020-05-15T18:52:52.386Z,1589568772.386 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-05-15T18:52:52.390Z,1589568772.390 [Radio_Surface] Loaded
2020-05-15T18:52:52.390Z,1589568772.390 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-05-15T18:52:52.391Z,1589568772.391 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408544E0
2020-05-15T18:52:52.391Z,1589568772.391 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3843
2020-05-15T18:52:52.525Z,1589568772.525 [DAT] Loaded
2020-05-15T18:52:52.526Z,1589568772.526 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-05-15T18:52:54.028Z,1589568774.028 [BPC1] Loaded
2020-05-15T18:52:54.029Z,1589568774.029 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-05-15T18:52:54.029Z,1589568774.029 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-05-15T18:52:54.030Z,1589568774.030 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-05-15T18:52:54.133Z,1589568774.133 [BuoyancyServo] Loaded
2020-05-15T18:52:54.133Z,1589568774.133 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-05-15T18:52:54.144Z,1589568774.144 [ElevatorServo] Loaded
2020-05-15T18:52:54.144Z,1589568774.144 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-05-15T18:52:54.155Z,1589568774.155 [MassServo] Loaded
2020-05-15T18:52:54.156Z,1589568774.156 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-05-15T18:52:54.167Z,1589568774.167 [RudderServo] Loaded
2020-05-15T18:52:54.167Z,1589568774.167 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-05-15T18:52:54.177Z,1589568774.177 [ThrusterServo] Loaded
2020-05-15T18:52:54.178Z,1589568774.178 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-05-15T18:52:54.178Z,1589568774.178 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-05-15T18:52:54.179Z,1589568774.179 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-05-15T18:52:54.260Z,1589568774.260 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-05-15T18:52:54.260Z,1589568774.260 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-05-15T18:52:54.286Z,1589568774.286 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-05-15T18:52:54.287Z,1589568774.287 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-05-15T18:52:54.598Z,1589568774.598 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-05-15T18:52:54.599Z,1589568774.599 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-05-15T18:52:54.809Z,1589568774.809 [ESPComponent] Loaded
2020-05-15T18:52:54.809Z,1589568774.809 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-05-15T18:52:54.823Z,1589568774.823 [PAR_Licor] Loaded
2020-05-15T18:52:54.824Z,1589568774.824 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-05-15T18:52:54.830Z,1589568774.830 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-05-15T18:52:54.831Z,1589568774.831 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-05-15T18:52:54.836Z,1589568774.836 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-05-15T18:52:54.836Z,1589568774.836 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-05-15T18:52:54.841Z,1589568774.841 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-05-15T18:52:54.841Z,1589568774.841 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-05-15T18:52:54.846Z,1589568774.846 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-05-15T18:52:54.846Z,1589568774.846 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-05-15T18:52:54.850Z,1589568774.850 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-05-15T18:52:54.850Z,1589568774.850 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-05-15T18:52:54.855Z,1589568774.855 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-05-15T18:52:54.855Z,1589568774.855 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-05-15T18:52:54.859Z,1589568774.859 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-05-15T18:52:54.859Z,1589568774.859 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-05-15T18:52:54.864Z,1589568774.864 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T18:52:54.868Z,1589568774.868 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T18:52:54.869Z,1589568774.869 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T18:52:54.869Z,1589568774.869 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T18:52:54.873Z,1589568774.873 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T18:52:54.874Z,1589568774.874 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T18:52:54.878Z,1589568774.878 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T18:52:54.878Z,1589568774.878 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T18:52:54.882Z,1589568774.882 [WetLabsBB2FL] Loaded
2020-05-15T18:52:54.883Z,1589568774.883 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-05-15T18:52:54.884Z,1589568774.884 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A6A4E0
2020-05-15T18:52:54.884Z,1589568774.884 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3844
2020-05-15T18:52:54.885Z,1589568774.885 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-05-15T18:52:54.885Z,1589568774.885 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-05-15T18:52:55.167Z,1589568775.167 [SBIT](DEBUG): Construct Startup Built In Test.
2020-05-15T18:52:55.178Z,1589568775.178 [SBIT] Loaded
2020-05-15T18:52:55.178Z,1589568775.178 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-05-15T18:52:55.192Z,1589568775.192 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-05-15T18:52:55.213Z,1589568775.213 [IBIT] Loaded
2020-05-15T18:52:55.213Z,1589568775.213 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-05-15T18:52:55.232Z,1589568775.232 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-05-15T18:52:55.418Z,1589568775.418 [CBIT] Loaded
2020-05-15T18:52:55.418Z,1589568775.418 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-05-15T18:52:55.419Z,1589568775.419 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-05-15T18:52:55.422Z,1589568775.422 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-05-15T18:52:55.423Z,1589568775.423 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-05-15T18:52:55.430Z,1589568775.430 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-05-15T18:52:55.431Z,1589568775.431 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AD54E0
2020-05-15T18:52:55.431Z,1589568775.431 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3845
2020-05-15T18:52:55.436Z,1589568775.436 [Supervisor](INFO): Main Thread ID is 3443
2020-05-15T18:52:55.436Z,1589568775.436 [Supervisor](DEBUG): Running supervisor.
2020-05-15T18:52:55.436Z,1589568775.436 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3846
2020-05-15T18:52:55.440Z,1589568775.440 [controlThread ThreadHandler](INFO): Handler Thread ID is 3847
2020-05-15T18:52:55.440Z,1589568775.440 [controlThread](DEBUG): Initializing ControlThread
2020-05-15T18:52:55.441Z,1589568775.441 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-05-15T18:52:55.441Z,1589568775.441 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-05-15T18:52:55.442Z,1589568775.442 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-05-15T18:52:55.442Z,1589568775.442 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-05-15T18:52:55.443Z,1589568775.443 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-05-15T18:52:55.443Z,1589568775.443 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-05-15T18:52:55.444Z,1589568775.444 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-05-15T18:52:55.445Z,1589568775.445 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-05-15T18:52:55.446Z,1589568775.446 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-05-15T18:52:55.446Z,1589568775.446 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-05-15T18:52:55.447Z,1589568775.447 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-05-15T18:52:55.448Z,1589568775.448 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-05-15T18:52:55.456Z,1589568775.456 [SBIT](INFO): Initialize SBIT Component.
2020-05-15T18:52:55.456Z,1589568775.456 [SBIT](IMPORTANT): git: 2020-02-26-39-g5ba86ef19
2020-05-15T18:52:55.456Z,1589568775.456 [SBIT](INFO): git hash: 5ba86ef19446a3a7971077fddc96013a7a660a2f
2020-05-15T18:52:55.457Z,1589568775.457 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-05-15T18:52:55.457Z,1589568775.457 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
2020-05-15T18:52:55.458Z,1589568775.458 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2020-05-15T18:52:55.459Z,1589568775.459 [IBIT](INFO): Initialize IBIT Component.
2020-05-15T18:52:55.460Z,1589568775.460 [CBIT](DEBUG): Initialize CBIT Component.
2020-05-15T18:52:55.461Z,1589568775.461 [logger ThreadHandler](INFO): Handler Thread ID is 3848
2020-05-15T18:52:55.471Z,1589568775.471 [CBIT](DEBUG): Initialized mux pins.
2020-05-15T18:52:55.472Z,1589568775.472 [CBIT](DEBUG): Initializing the watchdog timer.
2020-05-15T18:52:55.480Z,1589568775.480 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3849
2020-05-15T18:52:55.481Z,1589568775.481 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-05-15T18:52:55.492Z,1589568775.492 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3850
2020-05-15T18:52:55.496Z,1589568775.496 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-05-15T18:52:55.496Z,1589568775.496 [CBIT](DEBUG): Initializing heartbeat.
2020-05-15T18:52:55.504Z,1589568775.504 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3851
2020-05-15T18:52:55.505Z,1589568775.505 [WetLabsBB2FL](INFO): Powering down
2020-05-15T18:52:55.532Z,1589568775.532 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3852
2020-05-15T18:52:55.536Z,1589568775.536 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-05-15T18:52:55.536Z,1589568775.536 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-05-15T18:52:55.536Z,1589568775.536 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-05-15T18:52:55.536Z,1589568775.536 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-05-15T18:52:55.537Z,1589568775.537 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-05-15T18:52:55.537Z,1589568775.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-05-15T18:52:55.537Z,1589568775.537 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-05-15T18:52:55.537Z,1589568775.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-05-15T18:52:55.537Z,1589568775.537 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-05-15T18:52:55.537Z,1589568775.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-05-15T18:52:55.538Z,1589568775.538 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-05-15T18:52:55.538Z,1589568775.538 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-05-15T18:52:55.538Z,1589568775.538 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-05-15T18:52:55.538Z,1589568775.538 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-05-15T18:52:55.538Z,1589568775.538 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-05-15T18:52:55.539Z,1589568775.539 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-05-15T18:52:55.568Z,1589568775.568 [CBIT](DEBUG): Deactivating GF circuits.
2020-05-15T18:52:55.568Z,1589568775.568 [CBIT](DEBUG): Deactivating emergency mode.
2020-05-15T18:52:55.603Z,1589568775.603 [CBIT](DEBUG): Backplane powered.
2020-05-15T18:52:55.604Z,1589568775.604 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-05-15T18:52:55.614Z,1589568775.614 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-05-15T18:52:55.625Z,1589568775.625 [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-15T18:52:55.625Z,1589568775.625 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-05-15T18:52:55.687Z,1589568775.687 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-05-15T18:52:55.688Z,1589568775.688 [Default:A.Wait](DEBUG): Construct Wait.
2020-05-15T18:52:55.690Z,1589568775.690 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-05-15T18:52:55.733Z,1589568775.733 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-05-15T18:52:55.752Z,1589568775.752 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-05-15T18:52:55.757Z,1589568775.757 [Default:E.Execute](DEBUG): Construct Execute.
2020-05-15T18:52:55.783Z,1589568775.783 [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-15T18:52:55.788Z,1589568775.788 [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-15T18:52:55.844Z,1589568775.844 [Depth_Keller](ERROR): Pressure reading out of range: 1829.799438 decibar
2020-05-15T18:52:55.866Z,1589568775.866 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T18:52:55.866Z,1589568775.866 [DAT](INFO): Powering up
2020-05-15T18:52:55.867Z,1589568775.867 [DAT](DEBUG): Initializing DAT.
2020-05-15T18:52:55.896Z,1589568775.896 [Radio_Surface](INFO): Powering up
2020-05-15T18:52:55.936Z,1589568775.936 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T18:52:55.972Z,1589568775.972 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-05-15T18:52:56.023Z,1589568776.023 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-05-15T18:52:56.048Z,1589568776.048 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-05-15T18:52:56.049Z,1589568776.049 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-05-15T18:52:56.068Z,1589568776.068 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-05-15T18:52:56.069Z,1589568776.069 [MassServo](DEBUG): Initializing EZServoServo.
2020-05-15T18:52:56.080Z,1589568776.080 [MassServo](DEBUG): Initializing MassServo.
2020-05-15T18:52:56.081Z,1589568776.081 [RudderServo](DEBUG): Initializing EZServoServo.
2020-05-15T18:52:56.092Z,1589568776.092 [RudderServo](DEBUG): Initializing RudderServo.
2020-05-15T18:52:56.093Z,1589568776.093 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-05-15T18:52:56.111Z,1589568776.111 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-05-15T18:52:56.284Z,1589568776.284 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-05-15T18:52:56.960Z,1589568776.960 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-05-15T18:52:56.960Z,1589568776.960 [RudderServo](FAULT): Rudder failed to initialize
2020-05-15T18:52:56.960Z,1589568776.960 [RudderServo] Communications Fault, FailCount= 1
2020-05-15T18:52:56.960Z,1589568776.960 [RudderServo](ERROR): Communications Fault
2020-05-15T18:52:57.071Z,1589568777.071 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-05-15T18:52:57.276Z,1589568777.276 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-05-15T18:52:57.277Z,1589568777.277 [RudderServo](INFO): Powering down
2020-05-15T18:52:57.938Z,1589568777.938 [RudderServo](DEBUG): Initializing EZServoServo.
2020-05-15T18:52:58.056Z,1589568778.056 [RudderServo](DEBUG): Initializing RudderServo.
2020-05-15T18:52:58.060Z,1589568778.060 [CBIT](INFO): Clearing failed state for component RudderServo
2020-05-15T18:52:58.060Z,1589568778.060 [RudderServo] No Fault, FailCount= 1
2020-05-15T18:53:05.578Z,1589568785.578 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:53:05.582Z,1589568785.582 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:53:05.589Z,1589568785.589 [Onboard](IMPORTANT): Battery Current:8.857000 mA
2020-05-15T18:53:05.590Z,1589568785.590 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:53:05.590Z,1589568785.590 [Onboard](IMPORTANT): average counter: 0
2020-05-15T18:53:05.590Z,1589568785.590 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:53:15.675Z,1589568795.675 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:53:15.678Z,1589568795.678 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:53:15.722Z,1589568795.722 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:53:15.723Z,1589568795.723 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:53:15.723Z,1589568795.723 [Onboard](IMPORTANT): average counter: 1
2020-05-15T18:53:15.723Z,1589568795.723 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:53:16.117Z,1589568796.117 [SBIT](IMPORTANT): Beginning Startup BIT
2020-05-15T18:53:16.125Z,1589568796.125 [CBIT](IMPORTANT): Beginning ground fault scan
2020-05-15T18:53:22.622Z,1589568802.622 [NAL9602](INFO): Powering up NAL9602
2020-05-15T18:53:25.870Z,1589568805.870 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:53:25.873Z,1589568805.873 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:53:25.879Z,1589568805.879 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:53:25.879Z,1589568805.879 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:53:25.880Z,1589568805.880 [Onboard](IMPORTANT): average counter: 2
2020-05-15T18:53:25.880Z,1589568805.880 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:53:27.127Z,1589568807.127 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.024608
CHAN A1 (24V): 0.002666
CHAN A2 (12V): -0.004177
CHAN A3 (5V): 0.000283
CHAN B0 (3.3V): -0.001507
CHAN B1 (3.15aV): -0.000837
CHAN B2 (3.15bV): -0.001521
CHAN B3 (GND): -0.001327
OPEN: 0.003672
Full Scale Calc: 4.765 mA, -1.589 mA
2020-05-15T18:53:33.709Z,1589568813.709 [NAL9602](INFO): NAL9602 initialized
2020-05-15T18:53:36.154Z,1589568816.154 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:53:36.157Z,1589568816.157 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:53:36.163Z,1589568816.163 [Onboard](IMPORTANT): Battery Current:9.378000 mA
2020-05-15T18:53:36.163Z,1589568816.163 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:53:36.164Z,1589568816.164 [Onboard](IMPORTANT): average counter: 3
2020-05-15T18:53:36.164Z,1589568816.164 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:53:46.250Z,1589568826.250 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:53:46.253Z,1589568826.253 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:53:46.259Z,1589568826.259 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:53:46.306Z,1589568826.306 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:53:46.306Z,1589568826.306 [Onboard](IMPORTANT): average counter: 4
2020-05-15T18:53:46.306Z,1589568826.306 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:53:55.945Z,1589568835.945 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T18:53:55.945Z,1589568835.945 [DAT] Communications Fault, FailCount= 1
2020-05-15T18:53:55.946Z,1589568835.946 [DAT](ERROR): Communications Fault
2020-05-15T18:53:55.961Z,1589568835.961 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T18:53:56.350Z,1589568836.350 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:53:56.353Z,1589568836.353 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:53:56.390Z,1589568836.390 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:53:56.390Z,1589568836.390 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:53:56.391Z,1589568836.391 [Onboard](IMPORTANT): average counter: 5
2020-05-15T18:53:56.391Z,1589568836.391 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:53:56.391Z,1589568836.391 [Onboard](IMPORTANT): doing average stuff
2020-05-15T18:53:56.402Z,1589568836.402 [DAT](INFO): Powering down
2020-05-15T18:53:57.208Z,1589568837.208 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T18:53:57.208Z,1589568837.208 [DAT] No Fault, FailCount= 1
2020-05-15T18:53:59.677Z,1589568839.677 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T18:53:59.677Z,1589568839.677 [DAT](INFO): Powering up
2020-05-15T18:53:59.678Z,1589568839.678 [DAT](DEBUG): Initializing DAT.
2020-05-15T18:53:59.764Z,1589568839.764 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T18:54:06.550Z,1589568846.550 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:54:06.553Z,1589568846.553 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:54:06.559Z,1589568846.559 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:54:06.560Z,1589568846.560 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:54:06.560Z,1589568846.560 [Onboard](IMPORTANT): average counter: 0
2020-05-15T18:54:06.560Z,1589568846.560 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:54:09.409Z,1589568849.409 [SBIT](IMPORTANT): SBIT PASSED
2020-05-15T18:54:09.410Z,1589568849.410 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-05-15T18:54:09.411Z,1589568849.411 [SBIT](IMPORTANT): 

2020-05-15T18:54:09.411Z,1589568849.411 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2020-05-15T18:54:09.411Z,1589568849.411 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2020-05-15T18:54:09.411Z,1589568849.411 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2020-05-15T18:54:09.411Z,1589568849.411 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2020-05-15T18:54:09.411Z,1589568849.411 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool;

2020-05-15T18:54:09.818Z,1589568849.818 [MissionManager](IMPORTANT): Started mission Startup
2020-05-15T18:54:09.819Z,1589568849.819 [Startup] Running Loop=1
2020-05-15T18:54:09.819Z,1589568849.819 [Startup](DEBUG): Aggregate::initialize Startup
2020-05-15T18:54:09.819Z,1589568849.819 [Startup:A.GoToSurface] Running Loop=1
2020-05-15T18:54:09.819Z,1589568849.819 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-05-15T18:54:09.820Z,1589568849.820 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-05-15T18:54:09.820Z,1589568849.820 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-05-15T18:54:09.821Z,1589568849.821 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-05-15T18:54:09.821Z,1589568849.821 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-05-15T18:54:09.822Z,1589568849.822 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-05-15T18:54:09.823Z,1589568849.823 [Startup:StartupSatComms] Running Loop=1
2020-05-15T18:54:09.824Z,1589568849.824 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-05-15T18:54:09.824Z,1589568849.824 [Startup:StartupSatComms:A] Running Loop=1
2020-05-15T18:54:10.312Z,1589568850.312 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-05-15T18:54:16.647Z,1589568856.647 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:54:16.650Z,1589568856.650 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:54:16.656Z,1589568856.656 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:54:16.656Z,1589568856.656 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:54:16.656Z,1589568856.656 [Onboard](IMPORTANT): average counter: 1
2020-05-15T18:54:16.657Z,1589568856.657 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:54:26.742Z,1589568866.742 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:54:26.745Z,1589568866.745 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:54:26.788Z,1589568866.788 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T18:54:26.788Z,1589568866.788 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:54:26.788Z,1589568866.788 [Onboard](IMPORTANT): average counter: 2
2020-05-15T18:54:26.788Z,1589568866.788 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:54:36.846Z,1589568876.846 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:54:36.849Z,1589568876.849 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:54:36.855Z,1589568876.855 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:54:36.856Z,1589568876.856 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:54:36.856Z,1589568876.856 [Onboard](IMPORTANT): average counter: 3
2020-05-15T18:54:36.856Z,1589568876.856 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:54:46.943Z,1589568886.943 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:54:46.947Z,1589568886.947 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:54:46.953Z,1589568886.953 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:54:46.953Z,1589568886.953 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:54:46.953Z,1589568886.953 [Onboard](IMPORTANT): average counter: 4
2020-05-15T18:54:46.954Z,1589568886.954 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:54:55.856Z,1589568895.856 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T18:54:55.856Z,1589568895.856 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-05-15T18:54:55.856Z,1589568895.856 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T18:54:55.867Z,1589568895.867 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T18:54:56.264Z,1589568896.264 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T18:54:56.264Z,1589568896.264 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-05-15T18:54:57.061Z,1589568897.061 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:54:57.064Z,1589568897.064 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:54:57.070Z,1589568897.070 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:54:57.070Z,1589568897.070 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:54:57.071Z,1589568897.071 [Onboard](IMPORTANT): average counter: 5
2020-05-15T18:54:57.071Z,1589568897.071 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:54:57.071Z,1589568897.071 [Onboard](IMPORTANT): doing average stuff
2020-05-15T18:54:57.120Z,1589568897.120 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T18:54:59.871Z,1589568899.871 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T18:54:59.871Z,1589568899.871 [DAT] Communications Fault, FailCount= 2
2020-05-15T18:54:59.871Z,1589568899.871 [DAT](ERROR): Communications Fault
2020-05-15T18:54:59.887Z,1589568899.887 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T18:55:00.275Z,1589568900.275 [DAT](INFO): Powering down
2020-05-15T18:55:00.679Z,1589568900.679 [DAT](FAULT): LCB fault:  Software Overcurrent.
2020-05-15T18:55:00.680Z,1589568900.680 [DAT] Hardware Fault, FailCount= 2
2020-05-15T18:55:00.680Z,1589568900.680 [DAT](ERROR): Hardware Fault
2020-05-15T18:55:01.117Z,1589568901.117 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T18:55:01.117Z,1589568901.117 [DAT] No Fault, FailCount= 2
2020-05-15T18:55:03.508Z,1589568903.508 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T18:55:03.508Z,1589568903.508 [DAT](INFO): Powering up
2020-05-15T18:55:03.508Z,1589568903.508 [DAT](DEBUG): Initializing DAT.
2020-05-15T18:55:03.539Z,1589568903.539 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T18:55:07.159Z,1589568907.159 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:55:07.163Z,1589568907.163 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:55:07.169Z,1589568907.169 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:55:07.169Z,1589568907.169 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:55:07.170Z,1589568907.170 [Onboard](IMPORTANT): average counter: 0
2020-05-15T18:55:07.170Z,1589568907.170 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:55:09.983Z,1589568909.983 [Startup:StartupSatComms:A](INFO): Timed out from 2020-05-15T18:54:09.8Z
2020-05-15T18:55:09.983Z,1589568909.983 [Startup:StartupSatComms:A] Stopped
2020-05-15T18:55:09.983Z,1589568909.983 [Startup:StartupSatComms:B] Running Loop=1
2020-05-15T18:55:10.392Z,1589568910.392 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-05-15T18:55:17.260Z,1589568917.260 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:55:17.264Z,1589568917.264 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:55:17.270Z,1589568917.270 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:55:17.270Z,1589568917.270 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:55:17.270Z,1589568917.270 [Onboard](IMPORTANT): average counter: 1
2020-05-15T18:55:17.270Z,1589568917.270 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:55:23.192Z,1589568923.192 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005209
2020-05-15T18:55:27.363Z,1589568927.363 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:55:27.366Z,1589568927.366 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:55:27.372Z,1589568927.372 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:55:27.373Z,1589568927.373 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:55:27.373Z,1589568927.373 [Onboard](IMPORTANT): average counter: 2
2020-05-15T18:55:27.373Z,1589568927.373 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:55:37.058Z,1589568937.058 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2020-05-15T18:55:37.443Z,1589568937.443 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:55:37.446Z,1589568937.446 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:55:37.488Z,1589568937.488 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:55:37.488Z,1589568937.488 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:55:37.488Z,1589568937.488 [Onboard](IMPORTANT): average counter: 3
2020-05-15T18:55:37.488Z,1589568937.489 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:55:47.546Z,1589568947.546 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:55:47.549Z,1589568947.549 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:55:47.555Z,1589568947.555 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:55:47.556Z,1589568947.556 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:55:47.556Z,1589568947.556 [Onboard](IMPORTANT): average counter: 4
2020-05-15T18:55:47.556Z,1589568947.556 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:55:57.647Z,1589568957.647 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:55:57.650Z,1589568957.650 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:55:57.656Z,1589568957.656 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:55:57.656Z,1589568957.656 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:55:57.656Z,1589568957.656 [Onboard](IMPORTANT): average counter: 5
2020-05-15T18:55:57.656Z,1589568957.656 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:55:57.657Z,1589568957.657 [Onboard](IMPORTANT): doing average stuff
2020-05-15T18:55:57.702Z,1589568957.702 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T18:56:03.703Z,1589568963.703 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T18:56:03.703Z,1589568963.703 [DAT] Communications Fault, FailCount= 3
2020-05-15T18:56:03.704Z,1589568963.704 [DAT](ERROR): Communications Fault
2020-05-15T18:56:03.762Z,1589568963.762 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T18:56:04.122Z,1589568964.122 [DAT](INFO): Powering down
2020-05-15T18:56:04.952Z,1589568964.952 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T18:56:04.952Z,1589568964.952 [DAT] No Fault, FailCount= 3
2020-05-15T18:56:07.341Z,1589568967.341 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T18:56:07.342Z,1589568967.342 [DAT](INFO): Powering up
2020-05-15T18:56:07.342Z,1589568967.342 [DAT](DEBUG): Initializing DAT.
2020-05-15T18:56:07.390Z,1589568967.390 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T18:56:07.747Z,1589568967.747 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:56:07.750Z,1589568967.750 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:56:07.756Z,1589568967.756 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T18:56:07.757Z,1589568967.757 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:56:07.757Z,1589568967.757 [Onboard](IMPORTANT): average counter: 0
2020-05-15T18:56:07.757Z,1589568967.757 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:56:10.201Z,1589568970.201 [Startup:StartupSatComms:B](INFO): Timed out from 2020-05-15T18:55:09.0Z
2020-05-15T18:56:10.201Z,1589568970.201 [Startup:StartupSatComms:B] Stopped
2020-05-15T18:56:10.201Z,1589568970.201 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-05-15T18:56:10.201Z,1589568970.201 [Startup:StartupSatComms] Stopped
2020-05-15T18:56:10.201Z,1589568970.201 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-05-15T18:56:10.202Z,1589568970.202 [Startup](INFO): Completed Startup
2020-05-15T18:56:10.202Z,1589568970.202 [MissionManager](INFO): Startup is completed.
2020-05-15T18:56:10.202Z,1589568970.202 [MissionManager](INFO): Uninitializing Mission Startup
2020-05-15T18:56:10.202Z,1589568970.202 [Startup] Stopped
2020-05-15T18:56:10.202Z,1589568970.202 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-05-15T18:56:10.202Z,1589568970.202 [Startup:A.GoToSurface] Stopped
2020-05-15T18:56:10.202Z,1589568970.202 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-05-15T18:56:10.620Z,1589568970.620 [MissionManager](IMPORTANT): Started mission Default
2020-05-15T18:56:10.620Z,1589568970.620 [Default] Running Loop=1
2020-05-15T18:56:10.620Z,1589568970.620 [Default](DEBUG): Aggregate::initialize Default
2020-05-15T18:56:10.621Z,1589568970.621 [Default:B.GoToSurface] Running Loop=1
2020-05-15T18:56:10.621Z,1589568970.621 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-05-15T18:56:10.621Z,1589568970.621 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-05-15T18:56:10.621Z,1589568970.621 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-05-15T18:56:10.622Z,1589568970.622 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-05-15T18:56:10.622Z,1589568970.622 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-05-15T18:56:10.622Z,1589568970.622 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-05-15T18:56:10.623Z,1589568970.623 [Default:A.Wait] Running Loop=1
2020-05-15T18:56:10.623Z,1589568970.623 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-05-15T18:56:17.849Z,1589568977.849 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:56:17.853Z,1589568977.853 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:56:17.859Z,1589568977.859 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:56:17.859Z,1589568977.859 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:56:17.859Z,1589568977.859 [Onboard](IMPORTANT): average counter: 1
2020-05-15T18:56:17.859Z,1589568977.859 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:56:23.913Z,1589568983.913 [Default:A.Wait](INFO): Done Waiting.
2020-05-15T18:56:23.913Z,1589568983.913 [Default:A.Wait] Stopped
2020-05-15T18:56:23.913Z,1589568983.913 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-05-15T18:56:24.316Z,1589568984.316 [Default:CheckIn] Running Loop=1
2020-05-15T18:56:24.316Z,1589568984.316 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-05-15T18:56:24.316Z,1589568984.316 [Default:CheckIn:Read_GPS] Running Loop=1
2020-05-15T18:56:24.725Z,1589568984.725 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-05-15T18:56:27.949Z,1589568987.949 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:56:27.953Z,1589568987.953 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:56:27.958Z,1589568987.958 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:56:27.959Z,1589568987.959 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:56:27.959Z,1589568987.959 [Onboard](IMPORTANT): average counter: 2
2020-05-15T18:56:27.959Z,1589568987.959 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:56:38.046Z,1589568998.046 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:56:38.049Z,1589568998.049 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:56:38.056Z,1589568998.056 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:56:38.056Z,1589568998.056 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:56:38.056Z,1589568998.056 [Onboard](IMPORTANT): average counter: 3
2020-05-15T18:56:38.056Z,1589568998.056 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:56:48.149Z,1589569008.149 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:56:48.152Z,1589569008.152 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:56:48.158Z,1589569008.158 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T18:56:48.158Z,1589569008.158 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:56:48.159Z,1589569008.159 [Onboard](IMPORTANT): average counter: 4
2020-05-15T18:56:48.159Z,1589569008.159 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:56:57.055Z,1589569017.055 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T18:56:57.056Z,1589569017.056 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-05-15T18:56:57.056Z,1589569017.056 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T18:56:57.066Z,1589569017.066 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T18:56:57.465Z,1589569017.465 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T18:56:57.465Z,1589569017.465 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-05-15T18:56:58.248Z,1589569018.248 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:56:58.251Z,1589569018.251 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:56:58.257Z,1589569018.257 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:56:58.257Z,1589569018.257 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:56:58.257Z,1589569018.257 [Onboard](IMPORTANT): average counter: 5
2020-05-15T18:56:58.258Z,1589569018.258 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:56:58.258Z,1589569018.258 [Onboard](IMPORTANT): doing average stuff
2020-05-15T18:56:58.269Z,1589569018.269 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T18:57:07.542Z,1589569027.542 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T18:57:07.542Z,1589569027.542 [DAT] Communications Fault, FailCount= 4
2020-05-15T18:57:07.542Z,1589569027.542 [DAT](ERROR): Communications Fault
2020-05-15T18:57:07.601Z,1589569027.601 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T18:57:07.953Z,1589569027.953 [DAT](INFO): Powering down
2020-05-15T18:57:08.353Z,1589569028.353 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:57:08.356Z,1589569028.356 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:57:08.362Z,1589569028.362 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:57:08.362Z,1589569028.362 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:57:08.363Z,1589569028.363 [Onboard](IMPORTANT): average counter: 0
2020-05-15T18:57:08.363Z,1589569028.363 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:57:08.773Z,1589569028.773 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T18:57:08.773Z,1589569028.773 [DAT] No Fault, FailCount= 4
2020-05-15T18:57:11.171Z,1589569031.171 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T18:57:11.171Z,1589569031.171 [DAT](INFO): Powering up
2020-05-15T18:57:11.171Z,1589569031.171 [DAT](DEBUG): Initializing DAT.
2020-05-15T18:57:11.256Z,1589569031.256 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T18:57:18.465Z,1589569038.465 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:57:18.468Z,1589569038.468 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:57:18.474Z,1589569038.474 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T18:57:18.475Z,1589569038.475 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:57:18.475Z,1589569038.475 [Onboard](IMPORTANT): average counter: 1
2020-05-15T18:57:18.475Z,1589569038.475 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:57:28.556Z,1589569048.556 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:57:28.560Z,1589569048.560 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:57:28.566Z,1589569048.566 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:57:28.566Z,1589569048.566 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:57:28.566Z,1589569048.566 [Onboard](IMPORTANT): average counter: 2
2020-05-15T18:57:28.566Z,1589569048.566 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:57:38.661Z,1589569058.661 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:57:38.664Z,1589569058.664 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:57:38.706Z,1589569058.706 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:57:38.706Z,1589569058.706 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:57:38.706Z,1589569058.706 [Onboard](IMPORTANT): average counter: 3
2020-05-15T18:57:38.706Z,1589569058.706 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:57:48.747Z,1589569068.747 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:57:48.750Z,1589569068.750 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:57:48.756Z,1589569068.756 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:57:48.757Z,1589569068.757 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:57:48.757Z,1589569068.757 [Onboard](IMPORTANT): average counter: 4
2020-05-15T18:57:48.757Z,1589569068.757 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:57:58.848Z,1589569078.848 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:57:58.852Z,1589569078.852 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:57:58.857Z,1589569078.857 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:57:58.858Z,1589569078.858 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:57:58.858Z,1589569078.858 [Onboard](IMPORTANT): average counter: 5
2020-05-15T18:57:58.858Z,1589569078.858 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:57:58.858Z,1589569078.858 [Onboard](IMPORTANT): doing average stuff
2020-05-15T18:57:58.869Z,1589569078.869 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T18:58:08.946Z,1589569088.946 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:58:08.949Z,1589569088.949 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:58:08.984Z,1589569088.984 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:58:08.985Z,1589569088.985 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:58:08.985Z,1589569088.985 [Onboard](IMPORTANT): average counter: 0
2020-05-15T18:58:08.985Z,1589569088.985 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:58:11.382Z,1589569091.382 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T18:58:11.382Z,1589569091.382 [DAT] Communications Fault, FailCount= 5
2020-05-15T18:58:11.382Z,1589569091.382 [DAT](ERROR): Communications Fault
2020-05-15T18:58:11.449Z,1589569091.449 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T18:58:11.775Z,1589569091.775 [DAT](INFO): Powering down
2020-05-15T18:58:12.595Z,1589569092.595 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T18:58:12.595Z,1589569092.595 [DAT] No Fault, FailCount= 5
2020-05-15T18:58:15.012Z,1589569095.012 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T18:58:15.012Z,1589569095.012 [DAT](INFO): Powering up
2020-05-15T18:58:15.012Z,1589569095.012 [DAT](DEBUG): Initializing DAT.
2020-05-15T18:58:15.096Z,1589569095.096 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T18:58:19.047Z,1589569099.047 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:58:19.050Z,1589569099.050 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:58:19.056Z,1589569099.056 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:58:19.057Z,1589569099.057 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:58:19.057Z,1589569099.057 [Onboard](IMPORTANT): average counter: 1
2020-05-15T18:58:19.057Z,1589569099.057 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:58:29.149Z,1589569109.149 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:58:29.152Z,1589569109.152 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:58:29.158Z,1589569109.158 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:58:29.158Z,1589569109.158 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:58:29.159Z,1589569109.159 [Onboard](IMPORTANT): average counter: 2
2020-05-15T18:58:29.159Z,1589569109.159 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:58:37.613Z,1589569117.613 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-05-15T18:58:39.257Z,1589569119.257 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:58:39.260Z,1589569119.260 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:58:39.266Z,1589569119.266 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:58:39.266Z,1589569119.266 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:58:39.266Z,1589569119.266 [Onboard](IMPORTANT): average counter: 3
2020-05-15T18:58:39.267Z,1589569119.267 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:58:49.348Z,1589569129.348 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:58:49.352Z,1589569129.352 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:58:49.357Z,1589569129.357 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T18:58:49.358Z,1589569129.358 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:58:49.358Z,1589569129.358 [Onboard](IMPORTANT): average counter: 4
2020-05-15T18:58:49.358Z,1589569129.358 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:58:57.894Z,1589569137.894 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T18:58:57.894Z,1589569137.894 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-05-15T18:58:57.894Z,1589569137.894 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T18:58:57.950Z,1589569137.950 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T18:58:58.254Z,1589569138.254 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T18:58:58.254Z,1589569138.254 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-05-15T18:58:59.457Z,1589569139.457 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:58:59.460Z,1589569139.460 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:58:59.503Z,1589569139.503 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:58:59.504Z,1589569139.504 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:58:59.504Z,1589569139.504 [Onboard](IMPORTANT): average counter: 5
2020-05-15T18:58:59.504Z,1589569139.504 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:58:59.504Z,1589569139.504 [Onboard](IMPORTANT): doing average stuff
2020-05-15T18:58:59.541Z,1589569139.541 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T18:59:09.560Z,1589569149.560 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:59:09.564Z,1589569149.564 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:59:09.570Z,1589569149.570 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:59:09.571Z,1589569149.571 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:59:09.571Z,1589569149.571 [Onboard](IMPORTANT): average counter: 0
2020-05-15T18:59:09.571Z,1589569149.571 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:59:15.213Z,1589569155.213 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T18:59:15.213Z,1589569155.213 [DAT] Communications Fault, FailCount= 6
2020-05-15T18:59:15.213Z,1589569155.213 [DAT](ERROR): Communications Fault
2020-05-15T18:59:15.244Z,1589569155.244 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T18:59:15.610Z,1589569155.610 [DAT](INFO): Powering down
2020-05-15T18:59:16.444Z,1589569156.444 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T18:59:16.444Z,1589569156.444 [DAT] No Fault, FailCount= 6
2020-05-15T18:59:18.837Z,1589569158.837 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T18:59:18.837Z,1589569158.837 [DAT](INFO): Powering up
2020-05-15T18:59:18.838Z,1589569158.838 [DAT](DEBUG): Initializing DAT.
2020-05-15T18:59:18.888Z,1589569158.888 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T18:59:19.651Z,1589569159.651 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:59:19.654Z,1589569159.654 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:59:19.660Z,1589569159.660 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T18:59:19.661Z,1589569159.661 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:59:19.661Z,1589569159.661 [Onboard](IMPORTANT): average counter: 1
2020-05-15T18:59:19.661Z,1589569159.661 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:59:29.764Z,1589569169.764 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:59:29.767Z,1589569169.767 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:59:29.773Z,1589569169.773 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:59:29.773Z,1589569169.773 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:59:29.773Z,1589569169.773 [Onboard](IMPORTANT): average counter: 2
2020-05-15T18:59:29.773Z,1589569169.773 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:59:39.842Z,1589569179.842 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:59:39.845Z,1589569179.845 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:59:39.889Z,1589569179.889 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T18:59:39.889Z,1589569179.889 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:59:39.889Z,1589569179.889 [Onboard](IMPORTANT): average counter: 3
2020-05-15T18:59:39.889Z,1589569179.889 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T18:59:49.943Z,1589569189.943 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T18:59:49.947Z,1589569189.947 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T18:59:49.953Z,1589569189.953 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T18:59:49.953Z,1589569189.953 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T18:59:49.953Z,1589569189.953 [Onboard](IMPORTANT): average counter: 4
2020-05-15T18:59:49.953Z,1589569189.953 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:00:00.061Z,1589569200.061 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:00:00.064Z,1589569200.064 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:00:00.070Z,1589569200.070 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:00:00.070Z,1589569200.070 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:00:00.071Z,1589569200.071 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:00:00.071Z,1589569200.071 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:00:00.071Z,1589569200.071 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:00:00.082Z,1589569200.082 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:00:10.163Z,1589569210.163 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:00:10.167Z,1589569210.167 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:00:10.172Z,1589569210.172 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:00:10.173Z,1589569210.173 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:00:10.173Z,1589569210.173 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:00:10.173Z,1589569210.173 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:00:19.042Z,1589569219.042 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:00:19.042Z,1589569219.042 [DAT] Communications Fault, FailCount= 7
2020-05-15T19:00:19.042Z,1589569219.042 [DAT](ERROR): Communications Fault
2020-05-15T19:00:19.125Z,1589569219.125 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:00:19.450Z,1589569219.450 [DAT](INFO): Powering down
2020-05-15T19:00:20.246Z,1589569220.246 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:00:20.250Z,1589569220.250 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:00:20.288Z,1589569220.288 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:00:20.289Z,1589569220.289 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:00:20.289Z,1589569220.289 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:00:20.289Z,1589569220.289 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:00:20.376Z,1589569220.376 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:00:20.376Z,1589569220.376 [DAT] No Fault, FailCount= 7
2020-05-15T19:00:22.680Z,1589569222.680 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:00:22.680Z,1589569222.680 [DAT](INFO): Powering up
2020-05-15T19:00:22.680Z,1589569222.680 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:00:22.716Z,1589569222.716 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:00:30.346Z,1589569230.346 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:00:30.349Z,1589569230.349 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:00:30.355Z,1589569230.355 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:00:30.356Z,1589569230.356 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:00:30.356Z,1589569230.356 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:00:30.356Z,1589569230.356 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:00:40.453Z,1589569240.453 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:00:40.456Z,1589569240.456 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:00:40.462Z,1589569240.462 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:00:40.462Z,1589569240.462 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:00:40.462Z,1589569240.462 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:00:40.463Z,1589569240.463 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:00:50.556Z,1589569250.556 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:00:50.559Z,1589569250.559 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:00:50.565Z,1589569250.565 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:00:50.566Z,1589569250.566 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:00:50.566Z,1589569250.566 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:00:50.566Z,1589569250.566 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:00:59.067Z,1589569259.067 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T19:00:59.067Z,1589569259.067 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-05-15T19:00:59.067Z,1589569259.067 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T19:00:59.078Z,1589569259.078 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T19:00:59.472Z,1589569259.472 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T19:00:59.472Z,1589569259.472 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-05-15T19:01:00.650Z,1589569260.650 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:01:00.656Z,1589569260.656 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:01:00.664Z,1589569260.664 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:01:00.664Z,1589569260.664 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:01:00.664Z,1589569260.664 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:01:00.665Z,1589569260.665 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:01:00.665Z,1589569260.665 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:01:00.676Z,1589569260.676 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:01:10.759Z,1589569270.759 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:01:10.762Z,1589569270.762 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:01:10.768Z,1589569270.768 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:01:10.769Z,1589569270.769 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:01:10.769Z,1589569270.769 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:01:10.769Z,1589569270.769 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:01:20.847Z,1589569280.847 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:01:20.850Z,1589569280.850 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:01:20.856Z,1589569280.856 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:01:20.856Z,1589569280.856 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:01:20.856Z,1589569280.856 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:01:20.857Z,1589569280.857 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:01:22.880Z,1589569282.880 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:01:22.880Z,1589569282.880 [DAT] Communications Fault, FailCount= 8
2020-05-15T19:01:22.880Z,1589569282.880 [DAT](ERROR): Communications Fault
2020-05-15T19:01:22.901Z,1589569282.901 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:01:22.902Z,1589569282.902 [CBIT](FAULT): Communications Fault in component: DAT
2020-05-15T19:01:23.273Z,1589569283.273 [DAT](INFO): Powering down
2020-05-15T19:01:24.525Z,1589569284.525 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-05-15T18:56:24.3Z
2020-05-15T19:01:24.525Z,1589569284.525 [Default:CheckIn:Read_GPS] Stopped
2020-05-15T19:01:24.525Z,1589569284.525 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-05-15T19:01:24.933Z,1589569284.933 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-05-15T19:01:30.949Z,1589569290.949 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:01:30.952Z,1589569290.952 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:01:30.958Z,1589569290.958 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:01:30.958Z,1589569290.958 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:01:30.959Z,1589569290.959 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:01:30.959Z,1589569290.959 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:01:41.064Z,1589569301.064 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:01:41.067Z,1589569301.067 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:01:41.073Z,1589569301.073 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:01:41.073Z,1589569301.073 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:01:41.073Z,1589569301.073 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:01:41.073Z,1589569301.073 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:01:51.167Z,1589569311.167 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:01:51.170Z,1589569311.170 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:01:51.176Z,1589569311.176 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:01:51.177Z,1589569311.177 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:01:51.177Z,1589569311.177 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:01:51.177Z,1589569311.177 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:02:01.247Z,1589569321.247 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:02:01.250Z,1589569321.250 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:02:01.256Z,1589569321.256 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:02:01.257Z,1589569321.257 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:02:01.257Z,1589569321.257 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:02:01.257Z,1589569321.257 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:02:01.257Z,1589569321.257 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:02:01.268Z,1589569321.268 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:02:11.346Z,1589569331.346 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:02:11.349Z,1589569331.349 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:02:11.392Z,1589569331.392 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:02:11.392Z,1589569331.392 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:02:11.392Z,1589569331.392 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:02:11.393Z,1589569331.393 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:02:21.453Z,1589569341.453 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:02:21.471Z,1589569341.471 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:02:21.499Z,1589569341.499 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:02:21.499Z,1589569341.499 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:02:21.499Z,1589569341.499 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:02:21.499Z,1589569341.499 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:02:31.546Z,1589569351.546 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:02:31.549Z,1589569351.549 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:02:31.591Z,1589569351.591 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:02:31.592Z,1589569351.592 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:02:31.592Z,1589569351.592 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:02:31.592Z,1589569351.592 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:02:41.653Z,1589569361.653 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:02:41.656Z,1589569361.656 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:02:41.699Z,1589569361.699 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:02:41.699Z,1589569361.699 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:02:41.699Z,1589569361.699 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:02:41.699Z,1589569361.699 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:02:51.756Z,1589569371.756 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:02:51.760Z,1589569371.760 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:02:51.766Z,1589569371.766 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:02:51.766Z,1589569371.766 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:02:51.766Z,1589569371.766 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:02:51.766Z,1589569371.766 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:03:00.257Z,1589569380.257 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T19:03:00.257Z,1589569380.257 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-05-15T19:03:00.257Z,1589569380.257 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T19:03:00.352Z,1589569380.352 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T19:03:00.698Z,1589569380.698 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T19:03:00.698Z,1589569380.698 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-05-15T19:03:01.848Z,1589569381.848 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:03:01.851Z,1589569381.851 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:03:01.857Z,1589569381.857 [Onboard](IMPORTANT): Battery Current:8.335999 mA
2020-05-15T19:03:01.857Z,1589569381.857 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:03:01.857Z,1589569381.857 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:03:01.858Z,1589569381.858 [Onboard](IMPORTANT): average scaler: 6
2020-05-15T19:03:01.858Z,1589569381.858 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:03:01.869Z,1589569381.869 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:03:03.640Z,1589569383.640 [CommandLine](IMPORTANT): got command restart application
2020-05-15T19:03:04.652Z,1589569384.652 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2020-05-15T19:03:04.652Z,1589569384.652 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:03:04.652Z,1589569384.652 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:04.831Z,1589569384.831 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-05-15T19:03:04.832Z,1589569384.832 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:04.832Z,1589569384.832 [CommandLine](INFO): Join timeout helper Thread ID is 3891
2020-05-15T19:03:04.833Z,1589569384.833 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-05-15T19:03:04.833Z,1589569384.833 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:04.833Z,1589569384.833 [NavChartDb](INFO): Join timeout helper Thread ID is 3892
2020-05-15T19:03:04.868Z,1589569384.868 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:03:04.868Z,1589569384.868 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:04.875Z,1589569384.875 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-05-15T19:03:04.875Z,1589569384.875 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:04.876Z,1589569384.876 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3893
2020-05-15T19:03:05.064Z,1589569385.064 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:03:05.064Z,1589569385.064 [WetLabsBB2FL](INFO): Powering down
2020-05-15T19:03:05.065Z,1589569385.065 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.081Z,1589569385.081 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-05-15T19:03:05.081Z,1589569385.081 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.081Z,1589569385.081 [Radio_Surface](INFO): Join timeout helper Thread ID is 3894
2020-05-15T19:03:05.184Z,1589569385.184 [Radio_Surface](INFO): Powering down
2020-05-15T19:03:05.184Z,1589569385.184 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:03:05.185Z,1589569385.185 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.199Z,1589569385.199 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-05-15T19:03:05.199Z,1589569385.199 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.200Z,1589569385.200 [DataOverHttps](INFO): Join timeout helper Thread ID is 3895
2020-05-15T19:03:05.392Z,1589569385.392 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:03:05.392Z,1589569385.392 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.404Z,1589569385.404 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-05-15T19:03:05.404Z,1589569385.404 [logger ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.405Z,1589569385.405 [logger](INFO): Join timeout helper Thread ID is 3896
2020-05-15T19:03:05.424Z,1589569385.424 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:03:05.424Z,1589569385.424 [logger ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.444Z,1589569385.444 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-05-15T19:03:05.444Z,1589569385.444 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.444Z,1589569385.444 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-05-15T19:03:05.444Z,1589569385.444 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.445Z,1589569385.445 [controlThread](INFO): Join timeout helper Thread ID is 3897
2020-05-15T19:03:05.456Z,1589569385.456 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:03:05.456Z,1589569385.456 [controlThread](DEBUG): Uninitializing ControlThread
2020-05-15T19:03:05.457Z,1589569385.457 [NAL9602](INFO): Powering down
2020-05-15T19:03:05.458Z,1589569385.458 [DAT](INFO): Powering down
2020-05-15T19:03:05.479Z,1589569385.479 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-05-15T19:03:05.480Z,1589569385.480 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-05-15T19:03:05.481Z,1589569385.481 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-05-15T19:03:05.481Z,1589569385.481 [MissionManager](INFO): Uninitializing Mission Default
2020-05-15T19:03:05.481Z,1589569385.481 [Default] Stopped
2020-05-15T19:03:05.481Z,1589569385.481 [Default](DEBUG): Aggregate::uninitialize Default
2020-05-15T19:03:05.481Z,1589569385.481 [Default:B.GoToSurface] Stopped
2020-05-15T19:03:05.481Z,1589569385.481 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-05-15T19:03:05.481Z,1589569385.481 [Default:CheckIn] Stopped
2020-05-15T19:03:05.482Z,1589569385.482 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-05-15T19:03:05.482Z,1589569385.482 [Default:CheckIn:Read_Iridium] Stopped
2020-05-15T19:03:05.484Z,1589569385.484 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-05-15T19:03:05.484Z,1589569385.484 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-05-15T19:03:05.485Z,1589569385.485 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-05-15T19:03:05.485Z,1589569385.485 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-05-15T19:03:05.485Z,1589569385.485 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-05-15T19:03:05.485Z,1589569385.485 [BuoyancyServo](INFO): Powering down
2020-05-15T19:03:05.500Z,1589569385.500 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-05-15T19:03:05.500Z,1589569385.500 [ElevatorServo](INFO): Powering down
2020-05-15T19:03:05.500Z,1589569385.500 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-05-15T19:03:05.501Z,1589569385.501 [MassServo](INFO): Powering down
2020-05-15T19:03:05.501Z,1589569385.501 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-05-15T19:03:05.501Z,1589569385.501 [RudderServo](INFO): Powering down
2020-05-15T19:03:05.502Z,1589569385.502 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-05-15T19:03:05.502Z,1589569385.502 [ThrusterServo](INFO): Powering down
2020-05-15T19:03:05.503Z,1589569385.503 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-05-15T19:03:05.503Z,1589569385.503 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-05-15T19:03:05.504Z,1589569385.504 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-05-15T19:03:05.504Z,1589569385.504 [CBIT](DEBUG): Powering off loads.
2020-05-15T19:03:05.515Z,1589569385.515 [CBIT](DEBUG): Disabling WDT.
2020-05-15T19:03:05.527Z,1589569385.527 [CBIT](DEBUG): Opening all GF detection circuits.
2020-05-15T19:03:05.528Z,1589569385.528 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.610Z,1589569385.610 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.617Z,1589569385.617 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.689Z,1589569385.689 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.728Z,1589569385.728 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:03:05.864Z,1589569385.864 [logger ThreadHandler](INFO): Thread cancelled.