2020-05-15T19:37:29.369Z,1589571449.369 [Supervisor](DEBUG): Initializing supervisor.
2020-05-15T19:37:29.372Z,1589571449.372 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-05-15T19:37:29.372Z,1589571449.372 [SyncHandler](INFO): Protected caller Thread ID is 4556
2020-05-15T19:37:29.373Z,1589571449.373 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-05-15T19:37:29.374Z,1589571449.374 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-05-15T19:37:29.374Z,1589571449.374 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4557
2020-05-15T19:37:29.377Z,1589571449.377 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-05-15T19:37:29.389Z,1589571449.389 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-05-15T19:37:29.390Z,1589571449.390 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-05-15T19:37:29.390Z,1589571449.390 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4558
2020-05-15T19:37:29.391Z,1589571449.391 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-05-15T19:37:29.392Z,1589571449.392 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-05-15T19:37:29.392Z,1589571449.392 [logger ThreadHandler](INFO): Protected caller Thread ID is 4559
2020-05-15T19:37:29.394Z,1589571449.394 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-05-15T19:37:29.395Z,1589571449.395 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-05-15T19:37:29.396Z,1589571449.396 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-05-15T19:37:29.708Z,1589571449.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-05-15T19:37:29.708Z,1589571449.708 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-05-15T19:37:30.292Z,1589571450.292 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-05-15T19:37:30.293Z,1589571450.293 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-05-15T19:37:30.515Z,1589571450.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-05-15T19:37:30.516Z,1589571450.516 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-05-15T19:37:30.953Z,1589571450.953 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-05-15T19:37:30.953Z,1589571450.953 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-05-15T19:37:31.048Z,1589571451.048 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-05-15T19:37:31.049Z,1589571451.049 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-05-15T19:37:31.129Z,1589571451.129 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-05-15T19:37:31.421Z,1589571451.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-05-15T19:37:31.422Z,1589571451.422 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-05-15T19:37:31.563Z,1589571451.563 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-05-15T19:37:31.564Z,1589571451.564 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-05-15T19:37:31.665Z,1589571451.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-05-15T19:37:31.666Z,1589571451.666 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-05-15T19:37:32.133Z,1589571452.133 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-05-15T19:37:32.134Z,1589571452.134 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-05-15T19:37:32.528Z,1589571452.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-05-15T19:37:32.528Z,1589571452.528 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-05-15T19:37:32.629Z,1589571452.629 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-05-15T19:37:32.629Z,1589571452.629 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-05-15T19:37:32.811Z,1589571452.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-05-15T19:37:32.812Z,1589571452.812 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-05-15T19:37:33.009Z,1589571453.009 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-05-15T19:37:33.010Z,1589571453.010 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-05-15T19:37:33.228Z,1589571453.228 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-05-15T19:37:33.230Z,1589571453.230 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2020-05-15T19:37:33.231Z,1589571453.231 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2020-05-15T19:37:33.330Z,1589571453.330 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2020-05-15T19:37:33.464Z,1589571453.464 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2020-05-15T19:37:33.548Z,1589571453.548 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2020-05-15T19:37:33.630Z,1589571453.630 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2020-05-15T19:37:33.733Z,1589571453.733 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2020-05-15T19:37:33.908Z,1589571453.908 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2020-05-15T19:37:34.132Z,1589571454.132 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-05-15T19:37:34.133Z,1589571454.133 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2020-05-15T19:37:34.241Z,1589571454.241 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2020-05-15T19:37:34.333Z,1589571454.333 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2020-05-15T19:37:34.429Z,1589571454.429 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2020-05-15T19:37:34.522Z,1589571454.522 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/
2020-05-15T19:37:34.522Z,1589571454.522 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-05-15T19:37:34.528Z,1589571454.528 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-05-15T19:37:34.549Z,1589571454.549 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-05-15T19:37:34.549Z,1589571454.549 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-05-15T19:37:34.591Z,1589571454.591 [DepthRateCalculator] Loaded
2020-05-15T19:37:34.591Z,1589571454.591 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-05-15T19:37:34.597Z,1589571454.597 [PitchRateCalculator] Loaded
2020-05-15T19:37:34.598Z,1589571454.598 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-05-15T19:37:34.614Z,1589571454.614 [SpeedCalculator] Loaded
2020-05-15T19:37:34.614Z,1589571454.614 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-05-15T19:37:34.635Z,1589571454.635 [TempGradientCalculator] Loaded
2020-05-15T19:37:34.635Z,1589571454.635 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-05-15T19:37:34.641Z,1589571454.641 [YawRateCalculator] Loaded
2020-05-15T19:37:34.641Z,1589571454.641 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-05-15T19:37:34.681Z,1589571454.681 [ElevatorOffsetCalculator] Loaded
2020-05-15T19:37:34.681Z,1589571454.681 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-05-15T19:37:34.681Z,1589571454.681 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-05-15T19:37:34.682Z,1589571454.682 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-05-15T19:37:34.732Z,1589571454.732 [VerticalControl](DEBUG): Construct VerticalControl.
2020-05-15T19:37:34.833Z,1589571454.833 [VerticalControl] Loaded
2020-05-15T19:37:34.833Z,1589571454.833 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-05-15T19:37:34.834Z,1589571454.834 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-05-15T19:37:34.914Z,1589571454.914 [HorizontalControl] Loaded
2020-05-15T19:37:34.915Z,1589571454.915 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-05-15T19:37:34.915Z,1589571454.915 [SpeedControl](DEBUG): Construct SpeedControl.
2020-05-15T19:37:34.920Z,1589571454.920 [SpeedControl] Loaded
2020-05-15T19:37:34.921Z,1589571454.921 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-05-15T19:37:34.921Z,1589571454.921 [LoopControl](DEBUG): Construct LoopControl.
2020-05-15T19:37:34.922Z,1589571454.922 [LoopControl] Loaded
2020-05-15T19:37:34.922Z,1589571454.922 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-05-15T19:37:34.922Z,1589571454.922 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-05-15T19:37:34.923Z,1589571454.923 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-05-15T19:37:35.028Z,1589571455.028 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-05-15T19:37:35.029Z,1589571455.029 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-05-15T19:37:35.049Z,1589571455.049 [NavChart] Loaded
2020-05-15T19:37:35.050Z,1589571455.050 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-05-15T19:37:35.054Z,1589571455.054 [UniversalFixResidualReporter] Loaded
2020-05-15T19:37:35.054Z,1589571455.054 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-05-15T19:37:35.054Z,1589571455.054 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-05-15T19:37:35.055Z,1589571455.055 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-05-15T19:37:35.157Z,1589571455.157 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-05-15T19:37:35.157Z,1589571455.157 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-05-15T19:37:35.542Z,1589571455.542 [DataOverHttps] Loaded
2020-05-15T19:37:35.542Z,1589571455.542 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-05-15T19:37:35.543Z,1589571455.543 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408244E0
2020-05-15T19:37:35.544Z,1589571455.544 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4638
2020-05-15T19:37:35.582Z,1589571455.582 [Depth_Keller] Loaded
2020-05-15T19:37:35.583Z,1589571455.583 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-05-15T19:37:35.587Z,1589571455.587 [DropWeight] Loaded
2020-05-15T19:37:35.588Z,1589571455.588 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-05-15T19:37:35.692Z,1589571455.692 [NAL9602] Loaded
2020-05-15T19:37:35.692Z,1589571455.692 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-05-15T19:37:35.742Z,1589571455.742 [Onboard] Loaded
2020-05-15T19:37:35.742Z,1589571455.742 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-05-15T19:37:35.745Z,1589571455.745 [Radio_Surface] Loaded
2020-05-15T19:37:35.746Z,1589571455.746 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-05-15T19:37:35.747Z,1589571455.747 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408544E0
2020-05-15T19:37:35.747Z,1589571455.747 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4639
2020-05-15T19:37:35.884Z,1589571455.884 [DAT] Loaded
2020-05-15T19:37:35.884Z,1589571455.884 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-05-15T19:37:37.422Z,1589571457.422 [BPC1] Loaded
2020-05-15T19:37:37.422Z,1589571457.422 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-05-15T19:37:37.423Z,1589571457.423 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-05-15T19:37:37.423Z,1589571457.423 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-05-15T19:37:37.737Z,1589571457.737 [BuoyancyServo] Loaded
2020-05-15T19:37:37.738Z,1589571457.738 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-05-15T19:37:37.749Z,1589571457.749 [ElevatorServo] Loaded
2020-05-15T19:37:37.749Z,1589571457.749 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-05-15T19:37:37.767Z,1589571457.767 [MassServo] Loaded
2020-05-15T19:37:37.767Z,1589571457.767 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-05-15T19:37:37.778Z,1589571457.778 [RudderServo] Loaded
2020-05-15T19:37:37.778Z,1589571457.778 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-05-15T19:37:37.789Z,1589571457.789 [ThrusterServo] Loaded
2020-05-15T19:37:37.789Z,1589571457.789 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-05-15T19:37:37.790Z,1589571457.790 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-05-15T19:37:37.790Z,1589571457.790 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-05-15T19:37:37.984Z,1589571457.984 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-05-15T19:37:37.985Z,1589571457.985 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-05-15T19:37:38.012Z,1589571458.012 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-05-15T19:37:38.012Z,1589571458.012 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-05-15T19:37:38.341Z,1589571458.341 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-05-15T19:37:38.341Z,1589571458.341 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-05-15T19:37:38.556Z,1589571458.556 [ESPComponent] Loaded
2020-05-15T19:37:38.556Z,1589571458.556 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-05-15T19:37:38.571Z,1589571458.571 [PAR_Licor] Loaded
2020-05-15T19:37:38.571Z,1589571458.571 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-05-15T19:37:38.578Z,1589571458.578 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-05-15T19:37:38.578Z,1589571458.578 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-05-15T19:37:38.584Z,1589571458.584 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-05-15T19:37:38.584Z,1589571458.584 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-05-15T19:37:38.589Z,1589571458.589 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-05-15T19:37:38.589Z,1589571458.589 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-05-15T19:37:38.593Z,1589571458.593 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-05-15T19:37:38.594Z,1589571458.594 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-05-15T19:37:38.598Z,1589571458.598 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-05-15T19:37:38.598Z,1589571458.598 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-05-15T19:37:38.603Z,1589571458.603 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-05-15T19:37:38.603Z,1589571458.603 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-05-15T19:37:38.607Z,1589571458.607 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-05-15T19:37:38.608Z,1589571458.608 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-05-15T19:37:38.612Z,1589571458.612 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:37:38.617Z,1589571458.617 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:37:38.617Z,1589571458.617 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:37:38.617Z,1589571458.617 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:37:38.622Z,1589571458.622 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:37:38.622Z,1589571458.622 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:37:38.626Z,1589571458.626 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:37:38.627Z,1589571458.627 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-05-15T19:37:38.631Z,1589571458.631 [WetLabsBB2FL] Loaded
2020-05-15T19:37:38.631Z,1589571458.631 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-05-15T19:37:38.632Z,1589571458.632 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A6A4E0
2020-05-15T19:37:38.633Z,1589571458.633 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4640
2020-05-15T19:37:38.633Z,1589571458.633 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-05-15T19:37:38.634Z,1589571458.634 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-05-15T19:37:38.774Z,1589571458.774 [SBIT](DEBUG): Construct Startup Built In Test.
2020-05-15T19:37:38.785Z,1589571458.785 [SBIT] Loaded
2020-05-15T19:37:38.785Z,1589571458.785 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-05-15T19:37:38.786Z,1589571458.786 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-05-15T19:37:38.799Z,1589571458.799 [IBIT] Loaded
2020-05-15T19:37:38.799Z,1589571458.799 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-05-15T19:37:38.802Z,1589571458.802 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-05-15T19:37:38.943Z,1589571458.943 [CBIT] Loaded
2020-05-15T19:37:38.943Z,1589571458.943 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-05-15T19:37:38.943Z,1589571458.943 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-05-15T19:37:38.947Z,1589571458.947 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-05-15T19:37:38.948Z,1589571458.948 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-05-15T19:37:38.954Z,1589571458.954 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-05-15T19:37:38.955Z,1589571458.955 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AD54E0
2020-05-15T19:37:38.956Z,1589571458.956 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4641
2020-05-15T19:37:38.960Z,1589571458.960 [Supervisor](INFO): Main Thread ID is 3443
2020-05-15T19:37:38.960Z,1589571458.960 [Supervisor](DEBUG): Running supervisor.
2020-05-15T19:37:38.961Z,1589571458.961 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4642
2020-05-15T19:37:38.964Z,1589571458.964 [controlThread ThreadHandler](INFO): Handler Thread ID is 4643
2020-05-15T19:37:38.965Z,1589571458.965 [controlThread](DEBUG): Initializing ControlThread
2020-05-15T19:37:38.966Z,1589571458.966 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-05-15T19:37:38.966Z,1589571458.966 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-05-15T19:37:38.966Z,1589571458.966 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-05-15T19:37:38.967Z,1589571458.967 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-05-15T19:37:38.967Z,1589571458.967 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-05-15T19:37:38.968Z,1589571458.968 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-05-15T19:37:38.968Z,1589571458.968 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-05-15T19:37:38.970Z,1589571458.970 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-05-15T19:37:38.971Z,1589571458.971 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-05-15T19:37:38.971Z,1589571458.971 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-05-15T19:37:38.972Z,1589571458.972 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-05-15T19:37:38.972Z,1589571458.972 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-05-15T19:37:38.980Z,1589571458.980 [SBIT](INFO): Initialize SBIT Component.
2020-05-15T19:37:38.980Z,1589571458.980 [SBIT](IMPORTANT): git: 2020-02-26-39-g5ba86ef19
2020-05-15T19:37:38.980Z,1589571458.980 [SBIT](INFO): git hash: 5ba86ef19446a3a7971077fddc96013a7a660a2f
2020-05-15T19:37:38.981Z,1589571458.981 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-05-15T19:37:38.981Z,1589571458.981 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
2020-05-15T19:37:38.982Z,1589571458.982 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2020-05-15T19:37:38.983Z,1589571458.983 [IBIT](INFO): Initialize IBIT Component.
2020-05-15T19:37:38.984Z,1589571458.984 [CBIT](DEBUG): Initialize CBIT Component.
2020-05-15T19:37:38.985Z,1589571458.985 [logger ThreadHandler](INFO): Handler Thread ID is 4644
2020-05-15T19:37:38.995Z,1589571458.995 [CBIT](DEBUG): Initialized mux pins.
2020-05-15T19:37:38.996Z,1589571458.996 [CBIT](DEBUG): Initializing the watchdog timer.
2020-05-15T19:37:39.004Z,1589571459.004 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4645
2020-05-15T19:37:39.005Z,1589571459.005 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-05-15T19:37:39.016Z,1589571459.016 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4646
2020-05-15T19:37:39.019Z,1589571459.019 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-05-15T19:37:39.020Z,1589571459.020 [CBIT](DEBUG): Initializing heartbeat.
2020-05-15T19:37:39.028Z,1589571459.028 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4647
2020-05-15T19:37:39.029Z,1589571459.029 [WetLabsBB2FL](INFO): Powering down
2020-05-15T19:37:39.056Z,1589571459.056 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4648
2020-05-15T19:37:39.059Z,1589571459.059 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-05-15T19:37:39.059Z,1589571459.059 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-05-15T19:37:39.060Z,1589571459.060 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-05-15T19:37:39.060Z,1589571459.060 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-05-15T19:37:39.060Z,1589571459.060 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-05-15T19:37:39.060Z,1589571459.060 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-05-15T19:37:39.060Z,1589571459.060 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-05-15T19:37:39.061Z,1589571459.061 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-05-15T19:37:39.061Z,1589571459.061 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-05-15T19:37:39.061Z,1589571459.061 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-05-15T19:37:39.061Z,1589571459.061 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-05-15T19:37:39.061Z,1589571459.061 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-05-15T19:37:39.062Z,1589571459.062 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-05-15T19:37:39.062Z,1589571459.062 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-05-15T19:37:39.062Z,1589571459.062 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-05-15T19:37:39.062Z,1589571459.062 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-05-15T19:37:39.091Z,1589571459.091 [CBIT](DEBUG): Deactivating GF circuits.
2020-05-15T19:37:39.092Z,1589571459.092 [CBIT](DEBUG): Deactivating emergency mode.
2020-05-15T19:37:39.127Z,1589571459.127 [CBIT](DEBUG): Backplane powered.
2020-05-15T19:37:39.128Z,1589571459.128 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-05-15T19:37:39.138Z,1589571459.138 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-05-15T19:37:39.149Z,1589571459.149 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2020-05-15T19:37:39.149Z,1589571459.149 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-05-15T19:37:39.216Z,1589571459.216 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-05-15T19:37:39.217Z,1589571459.217 [Default:A.Wait](DEBUG): Construct Wait.
2020-05-15T19:37:39.218Z,1589571459.218 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-05-15T19:37:39.261Z,1589571459.261 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-05-15T19:37:39.280Z,1589571459.280 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-05-15T19:37:39.285Z,1589571459.285 [Default:E.Execute](DEBUG): Construct Execute.
2020-05-15T19:37:39.313Z,1589571459.313 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2020-05-15T19:37:39.318Z,1589571459.318 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,DropWeight,NAL9602,Onboard,DAT,BPC1,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-05-15T19:37:39.325Z,1589571459.325 [Depth_Keller](ERROR): Pressure reading out of range: 1829.799438 decibar
2020-05-15T19:37:39.346Z,1589571459.346 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:37:39.347Z,1589571459.347 [DAT](INFO): Powering up
2020-05-15T19:37:39.347Z,1589571459.347 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:37:39.390Z,1589571459.390 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:37:39.418Z,1589571459.418 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-05-15T19:37:39.420Z,1589571459.420 [Radio_Surface](INFO): Powering up
2020-05-15T19:37:39.458Z,1589571459.458 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:37:39.468Z,1589571459.468 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-05-15T19:37:39.469Z,1589571459.469 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:37:39.480Z,1589571459.480 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-05-15T19:37:39.481Z,1589571459.481 [MassServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:37:39.492Z,1589571459.492 [MassServo](DEBUG): Initializing MassServo.
2020-05-15T19:37:39.493Z,1589571459.493 [RudderServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:37:39.504Z,1589571459.504 [RudderServo](DEBUG): Initializing RudderServo.
2020-05-15T19:37:39.505Z,1589571459.505 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-05-15T19:37:39.540Z,1589571459.540 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-05-15T19:37:39.785Z,1589571459.785 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-05-15T19:37:49.035Z,1589571469.035 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:37:49.038Z,1589571469.038 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:37:49.045Z,1589571469.045 [Onboard](IMPORTANT): Battery Current:9.378000 mA
2020-05-15T19:37:49.046Z,1589571469.046 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:37:49.046Z,1589571469.046 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:37:49.046Z,1589571469.046 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:37:49.046Z,1589571469.046 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:37:59.130Z,1589571479.130 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:37:59.133Z,1589571479.133 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:37:59.173Z,1589571479.173 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:37:59.173Z,1589571479.173 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:37:59.173Z,1589571479.173 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:37:59.173Z,1589571479.173 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:37:59.174Z,1589571479.174 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:37:59.588Z,1589571479.588 [SBIT](IMPORTANT): Beginning Startup BIT
2020-05-15T19:37:59.592Z,1589571479.592 [CBIT](IMPORTANT): Beginning ground fault scan
2020-05-15T19:38:05.794Z,1589571485.794 [NAL9602](INFO): Powering up NAL9602
2020-05-15T19:38:09.434Z,1589571489.434 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:38:09.456Z,1589571489.456 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:38:09.462Z,1589571489.462 [Onboard](IMPORTANT): Battery Current:8.335999 mA
2020-05-15T19:38:09.462Z,1589571489.462 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:38:09.462Z,1589571489.462 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:38:09.463Z,1589571489.463 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:38:09.463Z,1589571489.463 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:38:10.294Z,1589571490.294 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.024596
CHAN A1 (24V): 0.003572
CHAN A2 (12V): -0.003380
CHAN A3 (5V): 0.001115
CHAN B0 (3.3V): -0.001369
CHAN B1 (3.15aV): -0.001064
CHAN B2 (3.15bV): -0.001890
CHAN B3 (GND): -0.001933
OPEN: 0.003661
Full Scale Calc: 4.765 mA, -1.589 mA
2020-05-15T19:38:16.781Z,1589571496.781 [NAL9602](INFO): NAL9602 initialized
2020-05-15T19:38:19.628Z,1589571499.628 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:38:19.631Z,1589571499.631 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:38:19.674Z,1589571499.674 [Onboard](IMPORTANT): Battery Current:8.336000 mA
2020-05-15T19:38:19.674Z,1589571499.674 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:38:19.674Z,1589571499.674 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:38:19.674Z,1589571499.674 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:38:19.675Z,1589571499.675 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:38:29.728Z,1589571509.728 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:38:29.731Z,1589571509.731 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:38:29.772Z,1589571509.772 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:38:29.772Z,1589571509.772 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:38:29.772Z,1589571509.772 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:38:29.772Z,1589571509.772 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:38:29.773Z,1589571509.773 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:38:39.407Z,1589571519.407 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:38:39.407Z,1589571519.407 [DAT] Communications Fault, FailCount= 1
2020-05-15T19:38:39.408Z,1589571519.408 [DAT](ERROR): Communications Fault
2020-05-15T19:38:39.466Z,1589571519.466 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:38:39.820Z,1589571519.820 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:38:39.823Z,1589571519.823 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:38:39.829Z,1589571519.829 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:38:39.829Z,1589571519.829 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:38:39.829Z,1589571519.829 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:38:39.830Z,1589571519.830 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:38:39.830Z,1589571519.830 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:38:39.830Z,1589571519.830 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:38:39.836Z,1589571519.836 [Onboard](IMPORTANT): main buf100000000

2020-05-15T19:38:39.841Z,1589571519.841 [Onboard](IMPORTANT): backup buf99999995


2020-05-15T19:38:39.842Z,1589571519.842 [Onboard](IMPORTANT): lastCharge-1.000000
2020-05-15T19:38:39.842Z,1589571519.842 [Onboard](IMPORTANT): charge200000000.000000
2020-05-15T19:38:39.842Z,1589571519.842 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:38:39.842Z,1589571519.842 [Onboard](IMPORTANT): avgCurrent:52546.871094
2020-05-15T19:38:39.843Z,1589571519.843 [Onboard](IMPORTANT): Average Battery Power:808.276001 W
2020-05-15T19:38:39.843Z,1589571519.843 [DAT](INFO): Powering down
2020-05-15T19:38:40.669Z,1589571520.669 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:38:40.669Z,1589571520.669 [DAT] No Fault, FailCount= 1
2020-05-15T19:38:43.122Z,1589571523.122 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:38:43.122Z,1589571523.122 [DAT](INFO): Powering up
2020-05-15T19:38:43.122Z,1589571523.122 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:38:43.200Z,1589571523.200 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:38:49.990Z,1589571529.990 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:38:50.012Z,1589571530.012 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:38:50.018Z,1589571530.018 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:38:50.018Z,1589571530.018 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:38:50.019Z,1589571530.019 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:38:50.019Z,1589571530.019 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:38:50.019Z,1589571530.019 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:38:53.700Z,1589571533.700 [SBIT](IMPORTANT): SBIT PASSED
2020-05-15T19:38:53.700Z,1589571533.700 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-05-15T19:38:53.701Z,1589571533.701 [SBIT](IMPORTANT): 

2020-05-15T19:38:53.701Z,1589571533.701 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2020-05-15T19:38:53.701Z,1589571533.701 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2020-05-15T19:38:53.701Z,1589571533.701 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2020-05-15T19:38:53.701Z,1589571533.701 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2020-05-15T19:38:53.701Z,1589571533.701 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool;

2020-05-15T19:38:54.056Z,1589571534.056 [MissionManager](IMPORTANT): Started mission Startup
2020-05-15T19:38:54.057Z,1589571534.057 [Startup] Running Loop=1
2020-05-15T19:38:54.057Z,1589571534.057 [Startup](DEBUG): Aggregate::initialize Startup
2020-05-15T19:38:54.057Z,1589571534.057 [Startup:A.GoToSurface] Running Loop=1
2020-05-15T19:38:54.057Z,1589571534.057 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-05-15T19:38:54.058Z,1589571534.058 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-05-15T19:38:54.058Z,1589571534.058 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-05-15T19:38:54.058Z,1589571534.058 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-05-15T19:38:54.059Z,1589571534.059 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-05-15T19:38:54.060Z,1589571534.060 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-05-15T19:38:54.062Z,1589571534.062 [Startup:StartupSatComms] Running Loop=1
2020-05-15T19:38:54.062Z,1589571534.062 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-05-15T19:38:54.062Z,1589571534.062 [Startup:StartupSatComms:A] Running Loop=1
2020-05-15T19:38:54.461Z,1589571534.461 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-05-15T19:39:00.091Z,1589571540.091 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:39:00.094Z,1589571540.094 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:39:00.100Z,1589571540.100 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:39:00.100Z,1589571540.100 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:39:00.100Z,1589571540.100 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:39:00.101Z,1589571540.101 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:39:00.101Z,1589571540.101 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:39:10.191Z,1589571550.191 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:39:10.194Z,1589571550.194 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:39:10.200Z,1589571550.200 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:39:10.200Z,1589571550.200 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:39:10.201Z,1589571550.201 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:39:10.201Z,1589571550.201 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:39:10.201Z,1589571550.201 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:39:20.292Z,1589571560.292 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:39:20.295Z,1589571560.295 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:39:20.301Z,1589571560.301 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T19:39:20.302Z,1589571560.302 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:39:20.302Z,1589571560.302 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:39:20.302Z,1589571560.302 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:39:20.302Z,1589571560.302 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:39:30.391Z,1589571570.391 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:39:30.394Z,1589571570.394 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:39:30.400Z,1589571570.400 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:39:30.400Z,1589571570.400 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:39:30.400Z,1589571570.400 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:39:30.401Z,1589571570.401 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:39:30.401Z,1589571570.401 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:39:39.283Z,1589571579.283 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T19:39:39.283Z,1589571579.283 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-05-15T19:39:39.283Z,1589571579.283 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T19:39:39.293Z,1589571579.293 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T19:39:39.705Z,1589571579.705 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T19:39:39.705Z,1589571579.705 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-05-15T19:39:40.495Z,1589571580.495 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:39:40.499Z,1589571580.499 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:39:40.504Z,1589571580.504 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:39:40.505Z,1589571580.505 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:39:40.505Z,1589571580.505 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:39:40.505Z,1589571580.505 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:39:40.505Z,1589571580.505 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:39:40.505Z,1589571580.505 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:39:40.511Z,1589571580.511 [Onboard](IMPORTANT): main buf100000000

2020-05-15T19:39:40.593Z,1589571580.593 [Onboard](IMPORTANT): backup buf99999995


2020-05-15T19:39:40.593Z,1589571580.593 [Onboard](IMPORTANT): lastCharge200000000.000000
2020-05-15T19:39:40.594Z,1589571580.594 [Onboard](IMPORTANT): charge200000000.000000
2020-05-15T19:39:40.594Z,1589571580.594 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:39:40.595Z,1589571580.595 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:39:40.595Z,1589571580.595 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:39:40.595Z,1589571580.595 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:39:43.322Z,1589571583.322 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:39:43.322Z,1589571583.322 [DAT] Communications Fault, FailCount= 2
2020-05-15T19:39:43.322Z,1589571583.322 [DAT](ERROR): Communications Fault
2020-05-15T19:39:43.386Z,1589571583.386 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:39:43.730Z,1589571583.730 [DAT](INFO): Powering down
2020-05-15T19:39:44.553Z,1589571584.553 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:39:44.554Z,1589571584.554 [DAT] No Fault, FailCount= 2
2020-05-15T19:39:46.951Z,1589571586.951 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:39:46.951Z,1589571586.951 [DAT](INFO): Powering up
2020-05-15T19:39:46.951Z,1589571586.951 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:39:46.980Z,1589571586.980 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:39:50.593Z,1589571590.593 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:39:50.596Z,1589571590.596 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:39:50.603Z,1589571590.603 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:39:50.604Z,1589571590.604 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:39:50.604Z,1589571590.604 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:39:50.604Z,1589571590.604 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:39:50.604Z,1589571590.604 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:39:54.253Z,1589571594.253 [Startup:StartupSatComms:A](INFO): Timed out from 2020-05-15T19:38:54.1Z
2020-05-15T19:39:54.253Z,1589571594.253 [Startup:StartupSatComms:A] Stopped
2020-05-15T19:39:54.253Z,1589571594.253 [Startup:StartupSatComms:B] Running Loop=1
2020-05-15T19:39:54.649Z,1589571594.649 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-05-15T19:40:00.692Z,1589571600.692 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:40:00.696Z,1589571600.696 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:40:00.702Z,1589571600.702 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:40:00.702Z,1589571600.702 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:40:00.702Z,1589571600.702 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:40:00.702Z,1589571600.702 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:40:00.703Z,1589571600.703 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:40:06.668Z,1589571606.668 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005172
2020-05-15T19:40:10.796Z,1589571610.796 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:40:10.799Z,1589571610.799 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:40:10.805Z,1589571610.805 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:40:10.805Z,1589571610.805 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:40:10.805Z,1589571610.805 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:40:10.805Z,1589571610.805 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:40:10.806Z,1589571610.806 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:40:20.901Z,1589571620.901 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:40:20.904Z,1589571620.904 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:40:20.910Z,1589571620.910 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:40:20.910Z,1589571620.910 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:40:20.911Z,1589571620.911 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:40:20.911Z,1589571620.911 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:40:20.911Z,1589571620.911 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:40:31.004Z,1589571631.004 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:40:31.007Z,1589571631.007 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:40:31.012Z,1589571631.012 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:40:31.012Z,1589571631.012 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:40:31.012Z,1589571631.012 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:40:31.013Z,1589571631.013 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:40:31.013Z,1589571631.013 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:40:35.457Z,1589571635.457 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-05-15T19:40:41.104Z,1589571641.104 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:40:41.108Z,1589571641.108 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:40:41.113Z,1589571641.113 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:40:41.114Z,1589571641.114 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:40:41.114Z,1589571641.114 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:40:41.114Z,1589571641.114 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:40:41.114Z,1589571641.114 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:40:41.114Z,1589571641.114 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:40:41.120Z,1589571641.120 [Onboard](IMPORTANT): main buf100000000

2020-05-15T19:40:41.126Z,1589571641.126 [Onboard](IMPORTANT): backup buf99999995


2020-05-15T19:40:41.126Z,1589571641.126 [Onboard](IMPORTANT): lastCharge200000000.000000
2020-05-15T19:40:41.126Z,1589571641.126 [Onboard](IMPORTANT): charge200000000.000000
2020-05-15T19:40:41.127Z,1589571641.127 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:40:41.127Z,1589571641.127 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:40:41.127Z,1589571641.127 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:40:41.127Z,1589571641.127 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:40:47.156Z,1589571647.156 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:40:47.156Z,1589571647.156 [DAT] Communications Fault, FailCount= 3
2020-05-15T19:40:47.157Z,1589571647.157 [DAT](ERROR): Communications Fault
2020-05-15T19:40:47.177Z,1589571647.177 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:40:47.547Z,1589571647.547 [DAT](INFO): Powering down
2020-05-15T19:40:48.381Z,1589571648.381 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:40:48.381Z,1589571648.381 [DAT] No Fault, FailCount= 3
2020-05-15T19:40:50.785Z,1589571650.785 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:40:50.786Z,1589571650.786 [DAT](INFO): Powering up
2020-05-15T19:40:50.786Z,1589571650.786 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:40:50.799Z,1589571650.799 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:40:51.205Z,1589571651.205 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:40:51.208Z,1589571651.208 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:40:51.214Z,1589571651.214 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:40:51.215Z,1589571651.215 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:40:51.215Z,1589571651.215 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:40:51.215Z,1589571651.215 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:40:51.216Z,1589571651.216 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:40:54.464Z,1589571654.464 [Startup:StartupSatComms:B](INFO): Timed out from 2020-05-15T19:39:54.3Z
2020-05-15T19:40:54.464Z,1589571654.464 [Startup:StartupSatComms:B] Stopped
2020-05-15T19:40:54.464Z,1589571654.464 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-05-15T19:40:54.464Z,1589571654.464 [Startup:StartupSatComms] Stopped
2020-05-15T19:40:54.464Z,1589571654.464 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-05-15T19:40:54.465Z,1589571654.465 [Startup](INFO): Completed Startup
2020-05-15T19:40:54.465Z,1589571654.465 [MissionManager](INFO): Startup is completed.
2020-05-15T19:40:54.465Z,1589571654.465 [MissionManager](INFO): Uninitializing Mission Startup
2020-05-15T19:40:54.465Z,1589571654.465 [Startup] Stopped
2020-05-15T19:40:54.465Z,1589571654.465 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-05-15T19:40:54.466Z,1589571654.466 [Startup:A.GoToSurface] Stopped
2020-05-15T19:40:54.466Z,1589571654.466 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-05-15T19:40:54.836Z,1589571654.836 [MissionManager](IMPORTANT): Started mission Default
2020-05-15T19:40:54.836Z,1589571654.836 [Default] Running Loop=1
2020-05-15T19:40:54.836Z,1589571654.836 [Default](DEBUG): Aggregate::initialize Default
2020-05-15T19:40:54.837Z,1589571654.837 [Default:B.GoToSurface] Running Loop=1
2020-05-15T19:40:54.837Z,1589571654.837 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-05-15T19:40:54.837Z,1589571654.837 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-05-15T19:40:54.837Z,1589571654.837 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-05-15T19:40:54.837Z,1589571654.837 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-05-15T19:40:54.838Z,1589571654.838 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-05-15T19:40:54.838Z,1589571654.838 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-05-15T19:40:54.838Z,1589571654.838 [Default:A.Wait] Running Loop=1
2020-05-15T19:40:54.838Z,1589571654.838 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-05-15T19:41:01.290Z,1589571661.290 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:41:01.294Z,1589571661.294 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:41:01.300Z,1589571661.300 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:41:01.301Z,1589571661.301 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:41:01.301Z,1589571661.301 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:41:01.301Z,1589571661.301 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:41:01.301Z,1589571661.301 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:41:08.181Z,1589571668.181 [Default:A.Wait](INFO): Done Waiting.
2020-05-15T19:41:08.181Z,1589571668.181 [Default:A.Wait] Stopped
2020-05-15T19:41:08.181Z,1589571668.181 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-05-15T19:41:08.577Z,1589571668.577 [Default:CheckIn] Running Loop=1
2020-05-15T19:41:08.577Z,1589571668.577 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-05-15T19:41:08.577Z,1589571668.577 [Default:CheckIn:Read_GPS] Running Loop=1
2020-05-15T19:41:08.972Z,1589571668.972 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-05-15T19:41:11.393Z,1589571671.393 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:41:11.396Z,1589571671.396 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:41:11.402Z,1589571671.402 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:41:11.402Z,1589571671.402 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:41:11.402Z,1589571671.402 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:41:11.402Z,1589571671.402 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:41:11.403Z,1589571671.403 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:41:21.493Z,1589571681.493 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:41:21.496Z,1589571681.496 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:41:21.503Z,1589571681.503 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:41:21.503Z,1589571681.503 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:41:21.503Z,1589571681.503 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:41:21.503Z,1589571681.503 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:41:21.503Z,1589571681.503 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:41:31.593Z,1589571691.593 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:41:31.597Z,1589571691.597 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:41:31.603Z,1589571691.603 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:41:31.604Z,1589571691.604 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:41:31.604Z,1589571691.604 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:41:31.604Z,1589571691.604 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:41:31.604Z,1589571691.604 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:41:40.551Z,1589571700.551 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T19:41:40.551Z,1589571700.551 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-05-15T19:41:40.551Z,1589571700.551 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T19:41:40.562Z,1589571700.562 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T19:41:40.929Z,1589571700.929 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T19:41:40.929Z,1589571700.929 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-05-15T19:41:41.690Z,1589571701.690 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:41:41.694Z,1589571701.694 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:41:41.700Z,1589571701.700 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:41:41.700Z,1589571701.700 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:41:41.701Z,1589571701.701 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:41:41.701Z,1589571701.701 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:41:41.701Z,1589571701.701 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:41:41.701Z,1589571701.701 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:41:41.707Z,1589571701.707 [Onboard](IMPORTANT): main buf100000000

2020-05-15T19:41:41.712Z,1589571701.712 [Onboard](IMPORTANT): backup buf99999995


2020-05-15T19:41:41.713Z,1589571701.713 [Onboard](IMPORTANT): lastCharge200000000.000000
2020-05-15T19:41:41.713Z,1589571701.713 [Onboard](IMPORTANT): charge200000000.000000
2020-05-15T19:41:41.713Z,1589571701.713 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:41:41.714Z,1589571701.714 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:41:41.714Z,1589571701.714 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:41:41.714Z,1589571701.714 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:41:50.979Z,1589571710.979 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:41:50.979Z,1589571710.979 [DAT] Communications Fault, FailCount= 4
2020-05-15T19:41:50.980Z,1589571710.980 [DAT](ERROR): Communications Fault
2020-05-15T19:41:51.052Z,1589571711.052 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:41:51.384Z,1589571711.384 [DAT](INFO): Powering down
2020-05-15T19:41:51.788Z,1589571711.788 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:41:51.792Z,1589571711.792 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:41:51.797Z,1589571711.797 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:41:51.798Z,1589571711.798 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:41:51.798Z,1589571711.798 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:41:51.798Z,1589571711.798 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:41:51.798Z,1589571711.798 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:41:52.230Z,1589571712.230 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:41:52.230Z,1589571712.230 [DAT] No Fault, FailCount= 4
2020-05-15T19:41:54.628Z,1589571714.628 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:41:54.628Z,1589571714.628 [DAT](INFO): Powering up
2020-05-15T19:41:54.629Z,1589571714.629 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:41:54.668Z,1589571714.668 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:42:01.895Z,1589571721.895 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:42:01.898Z,1589571721.898 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:42:01.904Z,1589571721.904 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:42:01.905Z,1589571721.905 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:42:01.905Z,1589571721.905 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:42:01.905Z,1589571721.905 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:42:01.905Z,1589571721.905 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:42:11.986Z,1589571731.986 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:42:11.990Z,1589571731.990 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:42:12.026Z,1589571732.026 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:42:12.026Z,1589571732.026 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:42:12.026Z,1589571732.026 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:42:12.027Z,1589571732.027 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:42:12.027Z,1589571732.027 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:42:22.092Z,1589571742.092 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:42:22.096Z,1589571742.096 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:42:22.102Z,1589571742.102 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:42:22.102Z,1589571742.102 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:42:22.102Z,1589571742.102 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:42:22.102Z,1589571742.102 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:42:22.102Z,1589571742.102 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:42:32.204Z,1589571752.204 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:42:32.207Z,1589571752.207 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:42:32.213Z,1589571752.213 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:42:32.214Z,1589571752.214 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:42:32.214Z,1589571752.214 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:42:32.214Z,1589571752.214 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:42:32.214Z,1589571752.214 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:42:42.305Z,1589571762.305 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:42:42.308Z,1589571762.308 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:42:42.314Z,1589571762.314 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:42:42.314Z,1589571762.314 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:42:42.314Z,1589571762.314 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:42:42.314Z,1589571762.314 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:42:42.314Z,1589571762.314 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:42:42.315Z,1589571762.315 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:42:42.320Z,1589571762.320 [Onboard](IMPORTANT): main buf100000000

2020-05-15T19:42:42.326Z,1589571762.326 [Onboard](IMPORTANT): backup buf99999995


2020-05-15T19:42:42.326Z,1589571762.326 [Onboard](IMPORTANT): lastCharge200000000.000000
2020-05-15T19:42:42.326Z,1589571762.326 [Onboard](IMPORTANT): charge200000000.000000
2020-05-15T19:42:42.327Z,1589571762.327 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:42:42.327Z,1589571762.327 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:42:42.327Z,1589571762.327 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:42:42.328Z,1589571762.328 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:42:52.399Z,1589571772.399 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:42:52.403Z,1589571772.403 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:42:52.409Z,1589571772.409 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:42:52.409Z,1589571772.409 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:42:52.409Z,1589571772.409 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:42:52.409Z,1589571772.409 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:42:52.409Z,1589571772.409 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:42:54.809Z,1589571774.809 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:42:54.809Z,1589571774.809 [DAT] Communications Fault, FailCount= 5
2020-05-15T19:42:54.809Z,1589571774.809 [DAT](ERROR): Communications Fault
2020-05-15T19:42:54.825Z,1589571774.825 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:42:55.214Z,1589571775.214 [DAT](INFO): Powering down
2020-05-15T19:42:56.036Z,1589571776.036 [CBIT](INFO): Clearing failed state for component DAT
2020-05-15T19:42:56.036Z,1589571776.036 [DAT] No Fault, FailCount= 5
2020-05-15T19:42:58.464Z,1589571778.464 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-15T19:42:58.464Z,1589571778.464 [DAT](INFO): Powering up
2020-05-15T19:42:58.464Z,1589571778.464 [DAT](DEBUG): Initializing DAT.
2020-05-15T19:42:58.540Z,1589571778.540 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-15T19:43:02.509Z,1589571782.509 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:43:02.512Z,1589571782.512 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:43:02.518Z,1589571782.518 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:43:02.519Z,1589571782.519 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:43:02.519Z,1589571782.519 [Onboard](IMPORTANT): average counter: 1
2020-05-15T19:43:02.519Z,1589571782.519 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:43:02.519Z,1589571782.519 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:43:12.590Z,1589571792.590 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:43:12.593Z,1589571792.593 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:43:12.599Z,1589571792.599 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:43:12.644Z,1589571792.644 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:43:12.644Z,1589571792.644 [Onboard](IMPORTANT): average counter: 2
2020-05-15T19:43:12.644Z,1589571792.644 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:43:12.644Z,1589571792.644 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:43:19.847Z,1589571799.847 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-05-15T19:43:22.690Z,1589571802.690 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:43:22.694Z,1589571802.694 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:43:22.700Z,1589571802.700 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:43:22.700Z,1589571802.700 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:43:22.700Z,1589571802.700 [Onboard](IMPORTANT): average counter: 3
2020-05-15T19:43:22.700Z,1589571802.700 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:43:22.700Z,1589571802.700 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:43:32.805Z,1589571812.805 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:43:32.808Z,1589571812.808 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:43:32.814Z,1589571812.814 [Onboard](IMPORTANT): Battery Current:6.773000 mA
2020-05-15T19:43:32.814Z,1589571812.814 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:43:32.814Z,1589571812.814 [Onboard](IMPORTANT): average counter: 4
2020-05-15T19:43:32.814Z,1589571812.814 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:43:32.815Z,1589571812.815 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:43:41.691Z,1589571821.691 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-15T19:43:41.691Z,1589571821.691 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-05-15T19:43:41.692Z,1589571821.692 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-15T19:43:41.739Z,1589571821.739 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-15T19:43:42.133Z,1589571822.133 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-15T19:43:42.133Z,1589571822.133 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-05-15T19:43:42.908Z,1589571822.908 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:43:42.912Z,1589571822.912 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:43:42.918Z,1589571822.918 [Onboard](IMPORTANT): Battery Current:7.815000 mA
2020-05-15T19:43:42.919Z,1589571822.919 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:43:42.919Z,1589571822.919 [Onboard](IMPORTANT): average counter: 5
2020-05-15T19:43:42.919Z,1589571822.919 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:43:42.919Z,1589571822.919 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:43:42.919Z,1589571822.919 [Onboard](IMPORTANT): doing average stuff
2020-05-15T19:43:42.928Z,1589571822.928 [Onboard](IMPORTANT): main buf100000000

2020-05-15T19:43:42.934Z,1589571822.934 [Onboard](IMPORTANT): backup buf99999995


2020-05-15T19:43:42.934Z,1589571822.934 [Onboard](IMPORTANT): lastCharge200000000.000000
2020-05-15T19:43:42.935Z,1589571822.935 [Onboard](IMPORTANT): charge200000000.000000
2020-05-15T19:43:42.935Z,1589571822.935 [Onboard](IMPORTANT): Average Battery Current:0.000000 mA
2020-05-15T19:43:42.935Z,1589571822.935 [Onboard](IMPORTANT): avgVoltageIdx:6
2020-05-15T19:43:42.936Z,1589571822.936 [Onboard](IMPORTANT): avgCurrent:0.000000
2020-05-15T19:43:42.936Z,1589571822.936 [Onboard](IMPORTANT): Average Battery Power:0.000000 W
2020-05-15T19:43:53.008Z,1589571833.008 [Onboard](IMPORTANT): Main Battery Voltage:15.382000 V
2020-05-15T19:43:53.012Z,1589571833.012 [Onboard](IMPORTANT): Backup Battery Voltage:15.382000 V
2020-05-15T19:43:53.018Z,1589571833.018 [Onboard](IMPORTANT): Battery Current:7.294000 mA
2020-05-15T19:43:53.018Z,1589571833.018 [Onboard](IMPORTANT): using main battery for universal
2020-05-15T19:43:53.018Z,1589571833.018 [Onboard](IMPORTANT): average counter: 0
2020-05-15T19:43:53.018Z,1589571833.018 [Onboard](IMPORTANT): average volt scaler: 1
2020-05-15T19:43:53.018Z,1589571833.018 [Onboard](IMPORTANT): average fg timeout scaler: 6
2020-05-15T19:43:54.892Z,1589571834.892 [CommandLine](IMPORTANT): got command restart application
2020-05-15T19:43:55.906Z,1589571835.906 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2020-05-15T19:43:55.906Z,1589571835.906 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:43:55.906Z,1589571835.906 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.059Z,1589571836.059 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-05-15T19:43:56.060Z,1589571836.060 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.060Z,1589571836.060 [CommandLine](INFO): Join timeout helper Thread ID is 4684
2020-05-15T19:43:56.065Z,1589571836.065 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-05-15T19:43:56.065Z,1589571836.065 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.066Z,1589571836.066 [NavChartDb](INFO): Join timeout helper Thread ID is 4685
2020-05-15T19:43:56.316Z,1589571836.316 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:43:56.316Z,1589571836.316 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.323Z,1589571836.323 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-05-15T19:43:56.324Z,1589571836.324 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.324Z,1589571836.324 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4686
2020-05-15T19:43:56.612Z,1589571836.612 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:43:56.612Z,1589571836.612 [WetLabsBB2FL](INFO): Powering down
2020-05-15T19:43:56.613Z,1589571836.613 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.631Z,1589571836.631 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-05-15T19:43:56.632Z,1589571836.632 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.632Z,1589571836.632 [Radio_Surface](INFO): Join timeout helper Thread ID is 4687
2020-05-15T19:43:56.768Z,1589571836.768 [Radio_Surface](INFO): Powering down
2020-05-15T19:43:56.768Z,1589571836.768 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:43:56.769Z,1589571836.769 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.783Z,1589571836.783 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-05-15T19:43:56.784Z,1589571836.784 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:56.784Z,1589571836.784 [DataOverHttps](INFO): Join timeout helper Thread ID is 4688
2020-05-15T19:43:58.658Z,1589571838.658 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-15T19:43:58.658Z,1589571838.658 [DAT] Communications Fault, FailCount= 6
2020-05-15T19:43:58.658Z,1589571838.658 [DAT](ERROR): Communications Fault
2020-05-15T19:43:58.705Z,1589571838.705 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-15T19:43:59.062Z,1589571839.062 [DAT](INFO): Powering down
2020-05-15T19:43:59.771Z,1589571839.771 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:43:59.783Z,1589571839.783 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:59.785Z,1589571839.785 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-05-15T19:43:59.785Z,1589571839.785 [logger ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:59.785Z,1589571839.785 [logger](INFO): Join timeout helper Thread ID is 4689
2020-05-15T19:43:59.824Z,1589571839.824 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:43:59.824Z,1589571839.824 [logger ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:59.825Z,1589571839.825 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-05-15T19:43:59.825Z,1589571839.825 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:59.825Z,1589571839.825 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-05-15T19:43:59.825Z,1589571839.825 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:59.826Z,1589571839.826 [controlThread](INFO): Join timeout helper Thread ID is 4690
2020-05-15T19:43:59.831Z,1589571839.832 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-15T19:43:59.832Z,1589571839.832 [controlThread](DEBUG): Uninitializing ControlThread
2020-05-15T19:43:59.832Z,1589571839.832 [NAL9602](INFO): Powering down
2020-05-15T19:43:59.833Z,1589571839.833 [DAT](INFO): Powering down
2020-05-15T19:43:59.855Z,1589571839.855 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-05-15T19:43:59.861Z,1589571839.861 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-05-15T19:43:59.865Z,1589571839.865 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-05-15T19:43:59.866Z,1589571839.866 [MissionManager](INFO): Uninitializing Mission Default
2020-05-15T19:43:59.866Z,1589571839.866 [Default] Stopped
2020-05-15T19:43:59.866Z,1589571839.866 [Default](DEBUG): Aggregate::uninitialize Default
2020-05-15T19:43:59.866Z,1589571839.866 [Default:B.GoToSurface] Stopped
2020-05-15T19:43:59.866Z,1589571839.866 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-05-15T19:43:59.866Z,1589571839.866 [Default:CheckIn] Stopped
2020-05-15T19:43:59.866Z,1589571839.866 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-05-15T19:43:59.866Z,1589571839.866 [Default:CheckIn:Read_GPS] Stopped
2020-05-15T19:43:59.870Z,1589571839.870 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-05-15T19:43:59.872Z,1589571839.872 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-05-15T19:43:59.872Z,1589571839.872 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-05-15T19:43:59.872Z,1589571839.872 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-05-15T19:43:59.873Z,1589571839.873 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-05-15T19:43:59.873Z,1589571839.873 [BuoyancyServo](INFO): Powering down
2020-05-15T19:43:59.888Z,1589571839.888 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-05-15T19:43:59.888Z,1589571839.888 [ElevatorServo](INFO): Powering down
2020-05-15T19:43:59.888Z,1589571839.888 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-05-15T19:43:59.889Z,1589571839.889 [MassServo](INFO): Powering down
2020-05-15T19:43:59.889Z,1589571839.889 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-05-15T19:43:59.889Z,1589571839.889 [RudderServo](INFO): Powering down
2020-05-15T19:43:59.890Z,1589571839.890 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-05-15T19:43:59.890Z,1589571839.890 [ThrusterServo](INFO): Powering down
2020-05-15T19:43:59.891Z,1589571839.891 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-05-15T19:43:59.891Z,1589571839.891 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-05-15T19:43:59.892Z,1589571839.892 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-05-15T19:43:59.892Z,1589571839.892 [CBIT](DEBUG): Powering off loads.
2020-05-15T19:43:59.903Z,1589571839.903 [CBIT](DEBUG): Disabling WDT.
2020-05-15T19:43:59.915Z,1589571839.915 [CBIT](DEBUG): Opening all GF detection circuits.
2020-05-15T19:43:59.916Z,1589571839.916 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:43:59.999Z,1589571839.999 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:44:00.005Z,1589571840.005 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:44:00.061Z,1589571840.061 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:44:00.087Z,1589571840.087 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-15T19:44:00.143Z,1589571840.143 [logger ThreadHandler](INFO): Thread cancelled.