2020-05-29T20:43:31.812Z,1590785011.812 [Supervisor](DEBUG): Initializing supervisor.
2020-05-29T20:43:31.815Z,1590785011.815 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-05-29T20:43:31.816Z,1590785011.816 [SyncHandler](INFO): Protected caller Thread ID is 5861
2020-05-29T20:43:31.816Z,1590785011.816 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-05-29T20:43:31.817Z,1590785011.817 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-05-29T20:43:31.818Z,1590785011.818 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5862
2020-05-29T20:43:31.821Z,1590785011.821 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-05-29T20:43:31.838Z,1590785011.838 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-05-29T20:43:31.839Z,1590785011.839 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-05-29T20:43:31.839Z,1590785011.839 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5863
2020-05-29T20:43:31.840Z,1590785011.840 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-05-29T20:43:31.841Z,1590785011.841 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-05-29T20:43:31.841Z,1590785011.841 [logger ThreadHandler](INFO): Protected caller Thread ID is 5864
2020-05-29T20:43:31.844Z,1590785011.844 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-05-29T20:43:31.844Z,1590785011.844 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-05-29T20:43:31.846Z,1590785011.846 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-05-29T20:43:32.199Z,1590785012.199 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-05-29T20:43:32.200Z,1590785012.200 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-05-29T20:43:32.925Z,1590785012.925 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-05-29T20:43:32.926Z,1590785012.926 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-05-29T20:43:33.150Z,1590785013.150 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-05-29T20:43:33.150Z,1590785013.150 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-05-29T20:43:33.922Z,1590785013.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-05-29T20:43:33.923Z,1590785013.923 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-05-29T20:43:34.022Z,1590785014.022 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-05-29T20:43:34.023Z,1590785014.023 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-05-29T20:43:34.102Z,1590785014.102 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-05-29T20:43:34.458Z,1590785014.458 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-05-29T20:43:34.458Z,1590785014.458 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-05-29T20:43:34.619Z,1590785014.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-05-29T20:43:34.620Z,1590785014.620 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-05-29T20:43:34.728Z,1590785014.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-05-29T20:43:34.729Z,1590785014.729 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-05-29T20:43:34.958Z,1590785014.958 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-05-29T20:43:34.958Z,1590785014.958 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-05-29T20:43:35.560Z,1590785015.560 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-05-29T20:43:35.561Z,1590785015.561 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-05-29T20:43:36.097Z,1590785016.097 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-05-29T20:43:36.098Z,1590785016.098 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-05-29T20:43:36.206Z,1590785016.206 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-05-29T20:43:36.207Z,1590785016.207 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-05-29T20:43:36.410Z,1590785016.410 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-05-29T20:43:36.410Z,1590785016.410 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-05-29T20:43:36.660Z,1590785016.660 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-05-29T20:43:36.660Z,1590785016.660 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-05-29T20:43:36.933Z,1590785016.933 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-05-29T20:43:36.935Z,1590785016.935 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2020-05-29T20:43:36.936Z,1590785016.936 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2020-05-29T20:43:37.034Z,1590785017.034 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2020-05-29T20:43:37.182Z,1590785017.182 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2020-05-29T20:43:37.266Z,1590785017.266 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2020-05-29T20:43:37.348Z,1590785017.348 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2020-05-29T20:43:37.456Z,1590785017.456 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2020-05-29T20:43:37.653Z,1590785017.653 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2020-05-29T20:43:37.962Z,1590785017.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-05-29T20:43:37.963Z,1590785017.963 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2020-05-29T20:43:38.123Z,1590785018.123 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2020-05-29T20:43:38.226Z,1590785018.226 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2020-05-29T20:43:38.408Z,1590785018.408 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2020-05-29T20:43:38.545Z,1590785018.545 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/
2020-05-29T20:43:38.545Z,1590785018.545 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-05-29T20:43:38.554Z,1590785018.554 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-05-29T20:43:38.713Z,1590785018.713 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-05-29T20:43:38.713Z,1590785018.713 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-05-29T20:43:38.733Z,1590785018.733 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-05-29T20:43:38.733Z,1590785018.733 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-05-29T20:43:38.863Z,1590785018.863 [DepthRateCalculator] Loaded
2020-05-29T20:43:38.863Z,1590785018.863 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-05-29T20:43:38.870Z,1590785018.870 [PitchRateCalculator] Loaded
2020-05-29T20:43:38.870Z,1590785018.870 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-05-29T20:43:38.889Z,1590785018.889 [SpeedCalculator] Loaded
2020-05-29T20:43:38.889Z,1590785018.889 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-05-29T20:43:38.916Z,1590785018.916 [TempGradientCalculator] Loaded
2020-05-29T20:43:38.916Z,1590785018.916 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-05-29T20:43:38.923Z,1590785018.923 [YawRateCalculator] Loaded
2020-05-29T20:43:38.923Z,1590785018.923 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-05-29T20:43:39.130Z,1590785019.130 [ElevatorOffsetCalculator] Loaded
2020-05-29T20:43:39.131Z,1590785019.131 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-05-29T20:43:39.131Z,1590785019.131 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-05-29T20:43:39.132Z,1590785019.132 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-05-29T20:43:39.181Z,1590785019.181 [VerticalControl](DEBUG): Construct VerticalControl.
2020-05-29T20:43:39.302Z,1590785019.302 [VerticalControl] Loaded
2020-05-29T20:43:39.302Z,1590785019.302 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-05-29T20:43:39.303Z,1590785019.303 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-05-29T20:43:39.403Z,1590785019.403 [HorizontalControl] Loaded
2020-05-29T20:43:39.404Z,1590785019.404 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-05-29T20:43:39.404Z,1590785019.404 [SpeedControl](DEBUG): Construct SpeedControl.
2020-05-29T20:43:39.411Z,1590785019.411 [SpeedControl] Loaded
2020-05-29T20:43:39.411Z,1590785019.411 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-05-29T20:43:39.412Z,1590785019.412 [LoopControl](DEBUG): Construct LoopControl.
2020-05-29T20:43:39.412Z,1590785019.412 [LoopControl] Loaded
2020-05-29T20:43:39.413Z,1590785019.413 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-05-29T20:43:39.413Z,1590785019.413 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-05-29T20:43:39.414Z,1590785019.414 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-05-29T20:43:39.552Z,1590785019.552 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-05-29T20:43:39.552Z,1590785019.552 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-05-29T20:43:39.577Z,1590785019.577 [NavChart] Loaded
2020-05-29T20:43:39.578Z,1590785019.578 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-05-29T20:43:39.583Z,1590785019.583 [UniversalFixResidualReporter] Loaded
2020-05-29T20:43:39.583Z,1590785019.583 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-05-29T20:43:39.584Z,1590785019.584 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-05-29T20:43:39.584Z,1590785019.584 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-05-29T20:43:39.688Z,1590785019.688 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-05-29T20:43:39.688Z,1590785019.688 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-05-29T20:43:40.095Z,1590785020.095 [DataOverHttps] Loaded
2020-05-29T20:43:40.095Z,1590785020.095 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-05-29T20:43:40.096Z,1590785020.096 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408FC4E0
2020-05-29T20:43:40.097Z,1590785020.097 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5946
2020-05-29T20:43:40.114Z,1590785020.114 [Depth_Keller] Loaded
2020-05-29T20:43:40.115Z,1590785020.115 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-05-29T20:43:40.121Z,1590785020.121 [DropWeight] Loaded
2020-05-29T20:43:40.121Z,1590785020.121 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-05-29T20:43:40.241Z,1590785020.241 [NAL9602] Loaded
2020-05-29T20:43:40.242Z,1590785020.242 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-05-29T20:43:40.290Z,1590785020.290 [Onboard] Loaded
2020-05-29T20:43:40.290Z,1590785020.290 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-05-29T20:43:40.295Z,1590785020.295 [Radio_Surface] Loaded
2020-05-29T20:43:40.295Z,1590785020.295 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-05-29T20:43:40.296Z,1590785020.296 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092C4E0
2020-05-29T20:43:40.296Z,1590785020.296 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5947
2020-05-29T20:43:40.471Z,1590785020.471 [DAT] Loaded
2020-05-29T20:43:40.472Z,1590785020.472 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-05-29T20:43:42.527Z,1590785022.527 [BPC1] Loaded
2020-05-29T20:43:42.527Z,1590785022.527 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-05-29T20:43:42.527Z,1590785022.527 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-05-29T20:43:42.528Z,1590785022.528 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-05-29T20:43:42.639Z,1590785022.639 [BuoyancyServo] Loaded
2020-05-29T20:43:42.640Z,1590785022.640 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-05-29T20:43:42.654Z,1590785022.654 [ElevatorServo] Loaded
2020-05-29T20:43:42.655Z,1590785022.655 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-05-29T20:43:42.668Z,1590785022.668 [MassServo] Loaded
2020-05-29T20:43:42.669Z,1590785022.669 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-05-29T20:43:42.683Z,1590785022.683 [RudderServo] Loaded
2020-05-29T20:43:42.683Z,1590785022.683 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-05-29T20:43:42.696Z,1590785022.696 [ThrusterServo] Loaded
2020-05-29T20:43:42.697Z,1590785022.697 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-05-29T20:43:42.697Z,1590785022.697 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-05-29T20:43:42.698Z,1590785022.698 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-05-29T20:43:42.783Z,1590785022.783 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-05-29T20:43:42.784Z,1590785022.784 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-05-29T20:43:42.811Z,1590785022.811 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-05-29T20:43:42.812Z,1590785022.812 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-05-29T20:43:43.427Z,1590785023.427 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-05-29T20:43:43.428Z,1590785023.428 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-05-29T20:43:43.718Z,1590785023.718 [ESPComponent] Loaded
2020-05-29T20:43:43.719Z,1590785023.719 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-05-29T20:43:43.737Z,1590785023.737 [PAR_Licor] Loaded
2020-05-29T20:43:43.737Z,1590785023.737 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-05-29T20:43:43.746Z,1590785023.746 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-05-29T20:43:43.747Z,1590785023.747 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-05-29T20:43:43.753Z,1590785023.753 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-05-29T20:43:43.753Z,1590785023.753 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-05-29T20:43:43.758Z,1590785023.758 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-05-29T20:43:43.758Z,1590785023.758 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-05-29T20:43:43.763Z,1590785023.763 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-05-29T20:43:43.763Z,1590785023.763 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-05-29T20:43:43.768Z,1590785023.768 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-05-29T20:43:43.768Z,1590785023.768 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-05-29T20:43:43.774Z,1590785023.774 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-05-29T20:43:43.774Z,1590785023.774 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-05-29T20:43:43.779Z,1590785023.779 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-05-29T20:43:43.779Z,1590785023.779 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-05-29T20:43:43.784Z,1590785023.784 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-05-29T20:43:43.789Z,1590785023.789 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-05-29T20:43:43.790Z,1590785023.790 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-05-29T20:43:43.790Z,1590785023.790 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-05-29T20:43:43.795Z,1590785023.795 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-05-29T20:43:43.795Z,1590785023.795 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-05-29T20:43:43.800Z,1590785023.800 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-05-29T20:43:43.800Z,1590785023.800 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-05-29T20:43:43.805Z,1590785023.805 [WetLabsBB2FL] Loaded
2020-05-29T20:43:43.806Z,1590785023.806 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-05-29T20:43:43.807Z,1590785023.807 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BD14E0
2020-05-29T20:43:43.807Z,1590785023.807 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5948
2020-05-29T20:43:43.808Z,1590785023.808 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-05-29T20:43:43.809Z,1590785023.809 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-05-29T20:43:43.949Z,1590785023.949 [SBIT](DEBUG): Construct Startup Built In Test.
2020-05-29T20:43:43.963Z,1590785023.963 [SBIT] Loaded
2020-05-29T20:43:43.963Z,1590785023.963 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-05-29T20:43:43.964Z,1590785023.964 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-05-29T20:43:43.982Z,1590785023.982 [IBIT] Loaded
2020-05-29T20:43:43.982Z,1590785023.982 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-05-29T20:43:43.986Z,1590785023.986 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-05-29T20:43:44.171Z,1590785024.171 [CBIT] Loaded
2020-05-29T20:43:44.171Z,1590785024.171 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-05-29T20:43:44.171Z,1590785024.171 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-05-29T20:43:44.176Z,1590785024.176 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-05-29T20:43:44.177Z,1590785024.177 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-05-29T20:43:44.187Z,1590785024.187 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-05-29T20:43:44.189Z,1590785024.189 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C4D4E0
2020-05-29T20:43:44.189Z,1590785024.189 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5949
2020-05-29T20:43:44.195Z,1590785024.195 [Supervisor](INFO): Main Thread ID is 5860
2020-05-29T20:43:44.195Z,1590785024.195 [Supervisor](DEBUG): Running supervisor.
2020-05-29T20:43:44.196Z,1590785024.196 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5950
2020-05-29T20:43:44.199Z,1590785024.199 [controlThread ThreadHandler](INFO): Handler Thread ID is 5951
2020-05-29T20:43:44.199Z,1590785024.199 [controlThread](DEBUG): Initializing ControlThread
2020-05-29T20:43:44.200Z,1590785024.200 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-05-29T20:43:44.201Z,1590785024.201 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-05-29T20:43:44.201Z,1590785024.201 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-05-29T20:43:44.201Z,1590785024.201 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-05-29T20:43:44.202Z,1590785024.202 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-05-29T20:43:44.203Z,1590785024.203 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-05-29T20:43:44.203Z,1590785024.203 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-05-29T20:43:44.205Z,1590785024.205 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-05-29T20:43:44.206Z,1590785024.206 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-05-29T20:43:44.207Z,1590785024.207 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-05-29T20:43:44.208Z,1590785024.208 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-05-29T20:43:44.208Z,1590785024.208 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-05-29T20:43:44.220Z,1590785024.220 [SBIT](INFO): Initialize SBIT Component.
2020-05-29T20:43:44.220Z,1590785024.220 [SBIT](IMPORTANT): git: 2020-05-06_C-4-ge907442
2020-05-29T20:43:44.220Z,1590785024.220 [SBIT](INFO): git hash: e907442e8d324ef9e313fad2e4afa1f9562153e8
2020-05-29T20:43:44.221Z,1590785024.221 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-05-29T20:43:44.221Z,1590785024.221 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
2020-05-29T20:43:44.222Z,1590785024.222 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2020-05-29T20:43:44.223Z,1590785024.223 [IBIT](INFO): Initialize IBIT Component.
2020-05-29T20:43:44.224Z,1590785024.224 [CBIT](DEBUG): Initialize CBIT Component.
2020-05-29T20:43:44.225Z,1590785024.225 [logger ThreadHandler](INFO): Handler Thread ID is 5952
2020-05-29T20:43:44.237Z,1590785024.237 [CBIT](DEBUG): Initialized mux pins.
2020-05-29T20:43:44.237Z,1590785024.237 [CBIT](DEBUG): Initializing the watchdog timer.
2020-05-29T20:43:44.245Z,1590785024.245 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5953
2020-05-29T20:43:44.246Z,1590785024.246 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-05-29T20:43:44.257Z,1590785024.257 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5954
2020-05-29T20:43:44.261Z,1590785024.261 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-05-29T20:43:44.261Z,1590785024.261 [CBIT](DEBUG): Initializing heartbeat.
2020-05-29T20:43:44.269Z,1590785024.269 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5955
2020-05-29T20:43:44.271Z,1590785024.271 [WetLabsBB2FL](INFO): Powering down
2020-05-29T20:43:44.298Z,1590785024.298 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5956
2020-05-29T20:43:44.301Z,1590785024.301 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-05-29T20:43:44.302Z,1590785024.302 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-05-29T20:43:44.302Z,1590785024.302 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-05-29T20:43:44.302Z,1590785024.302 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-05-29T20:43:44.302Z,1590785024.302 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-05-29T20:43:44.302Z,1590785024.302 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-05-29T20:43:44.303Z,1590785024.303 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-05-29T20:43:44.303Z,1590785024.303 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-05-29T20:43:44.303Z,1590785024.303 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-05-29T20:43:44.303Z,1590785024.303 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-05-29T20:43:44.303Z,1590785024.303 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-05-29T20:43:44.303Z,1590785024.303 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-05-29T20:43:44.304Z,1590785024.304 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-05-29T20:43:44.304Z,1590785024.304 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-05-29T20:43:44.304Z,1590785024.304 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-05-29T20:43:44.304Z,1590785024.304 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-05-29T20:43:44.333Z,1590785024.333 [CBIT](DEBUG): Deactivating GF circuits.
2020-05-29T20:43:44.333Z,1590785024.333 [CBIT](DEBUG): Deactivating emergency mode.
2020-05-29T20:43:44.369Z,1590785024.369 [CBIT](DEBUG): Backplane powered.
2020-05-29T20:43:44.370Z,1590785024.370 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-05-29T20:43:44.380Z,1590785024.380 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-05-29T20:43:44.414Z,1590785024.414 [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-29T20:43:44.415Z,1590785024.415 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-05-29T20:43:44.484Z,1590785024.484 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-05-29T20:43:44.485Z,1590785024.485 [Default:A.Wait](DEBUG): Construct Wait.
2020-05-29T20:43:44.487Z,1590785024.487 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-05-29T20:43:44.534Z,1590785024.534 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-05-29T20:43:44.546Z,1590785024.546 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-05-29T20:43:44.569Z,1590785024.569 [Default:E.Execute](DEBUG): Construct Execute.
2020-05-29T20:43:44.572Z,1590785024.572 [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-29T20:43:44.593Z,1590785024.593 [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-29T20:43:44.609Z,1590785024.609 [Depth_Keller](ERROR): Pressure reading out of range: 1829.799438 decibar
2020-05-29T20:43:44.642Z,1590785024.642 [DAT](INFO): Start
2020-05-29T20:43:44.645Z,1590785024.645 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-29T20:43:44.645Z,1590785024.645 [DAT](INFO): Powering up
2020-05-29T20:43:44.645Z,1590785024.645 [DAT](DEBUG): Initializing DAT.
2020-05-29T20:43:44.661Z,1590785024.661 [Radio_Surface](INFO): Powering up
2020-05-29T20:43:44.697Z,1590785024.697 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-29T20:43:44.808Z,1590785024.808 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-05-29T20:43:44.857Z,1590785024.857 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-05-29T20:43:44.866Z,1590785024.866 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-05-29T20:43:44.867Z,1590785024.867 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-05-29T20:43:44.873Z,1590785024.873 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-05-29T20:43:44.874Z,1590785024.874 [MassServo](DEBUG): Initializing EZServoServo.
2020-05-29T20:43:44.889Z,1590785024.889 [MassServo](DEBUG): Initializing MassServo.
2020-05-29T20:43:44.890Z,1590785024.890 [RudderServo](DEBUG): Initializing EZServoServo.
2020-05-29T20:43:44.897Z,1590785024.897 [RudderServo](DEBUG): Initializing RudderServo.
2020-05-29T20:43:44.898Z,1590785024.898 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-05-29T20:43:44.905Z,1590785024.905 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-05-29T20:43:45.059Z,1590785025.059 [DAT](INFO): Starting
2020-05-29T20:43:45.063Z,1590785025.063 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-05-29T20:43:45.426Z,1590785025.426 [DAT](INFO): Starting
2020-05-29T20:43:45.789Z,1590785025.789 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-05-29T20:43:45.789Z,1590785025.789 [RudderServo](FAULT): Rudder failed to initialize
2020-05-29T20:43:45.789Z,1590785025.789 [RudderServo] Communications Fault, FailCount= 1
2020-05-29T20:43:45.789Z,1590785025.789 [RudderServo](ERROR): Communications Fault
2020-05-29T20:43:45.900Z,1590785025.900 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-05-29T20:43:45.932Z,1590785025.932 [DAT](INFO): Starting
2020-05-29T20:43:46.094Z,1590785026.094 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-05-29T20:43:46.094Z,1590785026.094 [RudderServo](INFO): Powering down
2020-05-29T20:43:46.332Z,1590785026.332 [DAT](INFO): Starting
2020-05-29T20:43:46.732Z,1590785026.732 [DAT](INFO): Starting
2020-05-29T20:43:46.823Z,1590785026.823 [RudderServo](DEBUG): Initializing EZServoServo.
2020-05-29T20:43:46.942Z,1590785026.942 [RudderServo](DEBUG): Initializing RudderServo.
2020-05-29T20:43:46.946Z,1590785026.946 [CBIT](INFO): Clearing failed state for component RudderServo
2020-05-29T20:43:46.946Z,1590785026.946 [RudderServo] No Fault, FailCount= 1
2020-05-29T20:43:47.136Z,1590785027.136 [DAT](INFO): Starting
2020-05-29T20:43:47.541Z,1590785027.541 [DAT](INFO): Starting
2020-05-29T20:43:47.944Z,1590785027.944 [DAT](INFO): Starting
2020-05-29T20:43:48.349Z,1590785028.349 [DAT](INFO): Starting
2020-05-29T20:43:48.752Z,1590785028.752 [DAT](INFO): Starting
2020-05-29T20:43:49.157Z,1590785029.157 [DAT](INFO): Starting
2020-05-29T20:43:49.561Z,1590785029.561 [DAT](INFO): Starting
2020-05-29T20:43:49.965Z,1590785029.965 [DAT](INFO): Starting
2020-05-29T20:43:50.373Z,1590785030.373 [DAT](INFO): Starting
2020-05-29T20:43:50.773Z,1590785030.773 [DAT](INFO): Starting
2020-05-29T20:43:51.178Z,1590785031.178 [DAT](INFO): Starting
2020-05-29T20:43:51.591Z,1590785031.591 [DAT](INFO): Starting
2020-05-29T20:43:51.985Z,1590785031.985 [DAT](INFO): Starting
2020-05-29T20:43:52.389Z,1590785032.389 [DAT](INFO): Starting
2020-05-29T20:43:52.797Z,1590785032.797 [DAT](INFO): Starting
2020-05-29T20:43:53.196Z,1590785033.196 [DAT](INFO): Starting
2020-05-29T20:43:53.601Z,1590785033.601 [DAT](INFO): Starting
2020-05-29T20:43:54.015Z,1590785034.015 [DAT](INFO): Starting
2020-05-29T20:43:54.422Z,1590785034.422 [DAT](INFO): Starting
2020-05-29T20:43:54.813Z,1590785034.813 [DAT](INFO): Starting
2020-05-29T20:43:55.222Z,1590785035.222 [DAT](INFO): Starting
2020-05-29T20:43:55.621Z,1590785035.621 [DAT](INFO): Starting
2020-05-29T20:43:56.025Z,1590785036.025 [DAT](INFO): Starting
2020-05-29T20:43:56.027Z,1590785036.027 [DAT](INFO): unknown deviceResponse_: Teledyne Benthos DAT-900 Series

2020-05-29T20:43:56.441Z,1590785036.441 [DAT](INFO): Starting
2020-05-29T20:43:56.832Z,1590785036.832 [DAT](INFO): Starting
2020-05-29T20:43:57.237Z,1590785037.237 [DAT](INFO): Starting
2020-05-29T20:43:57.641Z,1590785037.641 [DAT](INFO): Starting
2020-05-29T20:43:57.642Z,1590785037.642 [DAT](INFO): unknown deviceResponse_: MF Frequency Band

2020-05-29T20:43:57.644Z,1590785037.644 [DAT](INFO): unknown deviceResponse_: Directional Acoustic Transponder version 8.14.0

2020-05-29T20:43:57.644Z,1590785037.644 [DAT](INFO): unknown deviceResponse_: May 29 2020 20:42:01 

2020-05-29T20:43:58.045Z,1590785038.045 [DAT](INFO): Starting
2020-05-29T20:43:58.120Z,1590785038.120 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004346
2020-05-29T20:43:58.449Z,1590785038.449 [DAT](INFO): Starting
2020-05-29T20:43:58.450Z,1590785038.450 [DAT](INFO): unknown deviceResponse_: Features enabled [Bearing]

2020-05-29T20:43:58.452Z,1590785038.452 [DAT](INFO): commRate: 800
2020-05-29T20:43:58.452Z,1590785038.452 [DAT](INFO): unknown deviceResponse_: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2020-05-29T20:43:58.452Z,1590785038.452 [DAT](INFO): commRate: 800
2020-05-29T20:43:58.853Z,1590785038.853 [DAT](INFO): Starting
2020-05-29T20:43:58.854Z,1590785038.854 [DAT](INFO): commRate: 800
2020-05-29T20:43:59.257Z,1590785039.257 [DAT](INFO): Starting
2020-05-29T20:43:59.258Z,1590785039.258 [DAT](INFO): commRate: 800
2020-05-29T20:43:59.661Z,1590785039.661 [DAT](INFO): Starting
2020-05-29T20:43:59.662Z,1590785039.662 [DAT](INFO): commRate: 800
2020-05-29T20:44:00.065Z,1590785040.065 [DAT](INFO): Starting
2020-05-29T20:44:00.066Z,1590785040.066 [DAT](INFO): commRate: 800
2020-05-29T20:44:00.470Z,1590785040.470 [DAT](INFO): Starting
2020-05-29T20:44:00.470Z,1590785040.470 [DAT](INFO): commRate: 800
2020-05-29T20:44:00.872Z,1590785040.872 [DAT](INFO): Starting
2020-05-29T20:44:00.873Z,1590785040.873 [DAT](INFO): commRate: 800
2020-05-29T20:44:01.277Z,1590785041.277 [DAT](INFO): Starting
2020-05-29T20:44:01.278Z,1590785041.278 [DAT](INFO): commRate: 800
2020-05-29T20:44:01.680Z,1590785041.680 [DAT](INFO): Starting
2020-05-29T20:44:01.681Z,1590785041.681 [DAT](INFO): commRate: 800
2020-05-29T20:44:02.085Z,1590785042.085 [DAT](INFO): Starting
2020-05-29T20:44:02.085Z,1590785042.085 [DAT](INFO): commRate: 800
2020-05-29T20:44:02.488Z,1590785042.488 [DAT](INFO): Starting
2020-05-29T20:44:02.488Z,1590785042.488 [DAT](INFO): commRate: 800
2020-05-29T20:44:02.893Z,1590785042.893 [DAT](INFO): Starting
2020-05-29T20:44:02.894Z,1590785042.894 [DAT](INFO): commRate: 800
2020-05-29T20:44:03.296Z,1590785043.296 [DAT](INFO): Starting
2020-05-29T20:44:03.297Z,1590785043.297 [DAT](INFO): commRate: 800
2020-05-29T20:44:03.702Z,1590785043.702 [DAT](INFO): Starting
2020-05-29T20:44:03.702Z,1590785043.702 [DAT](INFO): commRate: 800
2020-05-29T20:44:04.104Z,1590785044.104 [DAT](INFO): Starting
2020-05-29T20:44:04.105Z,1590785044.105 [DAT](INFO): commRate: 800
2020-05-29T20:44:04.521Z,1590785044.521 [DAT](INFO): Starting
2020-05-29T20:44:04.521Z,1590785044.521 [DAT](INFO): commRate: 800
2020-05-29T20:44:04.913Z,1590785044.913 [DAT](INFO): Starting
2020-05-29T20:44:04.913Z,1590785044.913 [DAT](INFO): commRate: 800
2020-05-29T20:44:04.966Z,1590785044.966 [SBIT](IMPORTANT): Beginning Startup BIT
2020-05-29T20:44:04.978Z,1590785044.978 [CBIT](IMPORTANT): Beginning ground fault scan
2020-05-29T20:44:05.317Z,1590785045.317 [DAT](INFO): Starting
2020-05-29T20:44:05.318Z,1590785045.318 [DAT](INFO): commRate: 800
2020-05-29T20:44:05.720Z,1590785045.720 [DAT](INFO): Starting
2020-05-29T20:44:05.721Z,1590785045.721 [DAT](INFO): commRate: 800
2020-05-29T20:44:06.126Z,1590785046.126 [DAT](INFO): Starting
2020-05-29T20:44:06.126Z,1590785046.126 [DAT](INFO): commRate: 800
2020-05-29T20:44:06.528Z,1590785046.528 [DAT](INFO): Starting
2020-05-29T20:44:06.529Z,1590785046.529 [DAT](INFO): commRate: 800
2020-05-29T20:44:06.940Z,1590785046.940 [DAT](INFO): Starting
2020-05-29T20:44:06.941Z,1590785046.941 [DAT](INFO): commRate: 800
2020-05-29T20:44:07.477Z,1590785047.477 [DAT](INFO): Starting
2020-05-29T20:44:07.477Z,1590785047.477 [DAT](INFO): commRate: 800
2020-05-29T20:44:07.857Z,1590785047.857 [DAT](INFO): Starting
2020-05-29T20:44:07.858Z,1590785047.858 [DAT](INFO): commRate: 800
2020-05-29T20:44:08.260Z,1590785048.260 [DAT](INFO): Starting
2020-05-29T20:44:08.261Z,1590785048.261 [DAT](INFO): commRate: 800
2020-05-29T20:44:08.664Z,1590785048.664 [DAT](INFO): Starting
2020-05-29T20:44:08.665Z,1590785048.665 [DAT](INFO): commRate: 800
2020-05-29T20:44:09.081Z,1590785049.081 [DAT](INFO): Starting
2020-05-29T20:44:09.081Z,1590785049.081 [DAT](INFO): commRate: 800
2020-05-29T20:44:09.476Z,1590785049.476 [DAT](INFO): Starting
2020-05-29T20:44:09.478Z,1590785049.478 [DAT](INFO): commRate: 800
2020-05-29T20:44:09.877Z,1590785049.877 [DAT](INFO): Starting
2020-05-29T20:44:09.878Z,1590785049.878 [DAT](INFO): commRate: 800
2020-05-29T20:44:10.267Z,1590785050.267 [NAL9602](INFO): Powering up NAL9602
2020-05-29T20:44:10.283Z,1590785050.283 [DAT](INFO): Starting
2020-05-29T20:44:10.283Z,1590785050.283 [DAT](INFO): commRate: 800
2020-05-29T20:44:10.685Z,1590785050.685 [DAT](INFO): Starting
2020-05-29T20:44:10.685Z,1590785050.685 [DAT](INFO): commRate: 800
2020-05-29T20:44:11.090Z,1590785051.090 [DAT](INFO): Starting
2020-05-29T20:44:11.090Z,1590785051.090 [DAT](INFO): commRate: 800
2020-05-29T20:44:11.494Z,1590785051.494 [DAT](INFO): Starting
2020-05-29T20:44:11.494Z,1590785051.494 [DAT](INFO): commRate: 800
2020-05-29T20:44:11.897Z,1590785051.897 [DAT](INFO): Starting
2020-05-29T20:44:11.897Z,1590785051.897 [DAT](INFO): commRate: 800
2020-05-29T20:44:12.305Z,1590785052.305 [DAT](INFO): Starting
2020-05-29T20:44:12.306Z,1590785052.306 [DAT](INFO): commRate: 800
2020-05-29T20:44:12.705Z,1590785052.705 [DAT](INFO): Starting
2020-05-29T20:44:12.706Z,1590785052.706 [DAT](INFO): commRate: 800
2020-05-29T20:44:13.109Z,1590785053.109 [DAT](INFO): Starting
2020-05-29T20:44:13.109Z,1590785053.109 [DAT](INFO): commRate: 800
2020-05-29T20:44:13.513Z,1590785053.513 [DAT](INFO): Starting
2020-05-29T20:44:13.514Z,1590785053.514 [DAT](INFO): commRate: 800
2020-05-29T20:44:13.916Z,1590785053.916 [DAT](INFO): Starting
2020-05-29T20:44:13.917Z,1590785053.917 [DAT](INFO): commRate: 800
2020-05-29T20:44:14.321Z,1590785054.321 [DAT](INFO): Starting
2020-05-29T20:44:14.321Z,1590785054.321 [DAT](INFO): commRate: 800
2020-05-29T20:44:14.740Z,1590785054.740 [DAT](INFO): Starting
2020-05-29T20:44:14.740Z,1590785054.740 [DAT](INFO): commRate: 800
2020-05-29T20:44:15.129Z,1590785055.129 [DAT](INFO): Starting
2020-05-29T20:44:15.129Z,1590785055.129 [DAT](INFO): commRate: 800
2020-05-29T20:44:15.532Z,1590785055.532 [DAT](INFO): Starting
2020-05-29T20:44:15.534Z,1590785055.534 [DAT](INFO): commRate: 800
2020-05-29T20:44:15.937Z,1590785055.937 [DAT](INFO): Starting
2020-05-29T20:44:15.938Z,1590785055.938 [DAT](INFO): commRate: 800
2020-05-29T20:44:16.048Z,1590785056.048 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.028449
CHAN A1 (24V): 0.008254
CHAN A2 (12V): -0.001609
CHAN A3 (5V): -0.001759
CHAN B0 (3.3V): -0.001084
CHAN B1 (3.15aV): -0.001029
CHAN B2 (3.15bV): -0.001244
CHAN B3 (GND): -0.001860
OPEN: 0.003931
Full Scale Calc: 4.765 mA, -1.589 mA
2020-05-29T20:44:16.344Z,1590785056.344 [DAT](INFO): Starting
2020-05-29T20:44:16.344Z,1590785056.344 [DAT](INFO): commRate: 800
2020-05-29T20:44:16.745Z,1590785056.745 [DAT](INFO): Starting
2020-05-29T20:44:16.745Z,1590785056.745 [DAT](INFO): commRate: 800
2020-05-29T20:44:17.148Z,1590785057.148 [DAT](INFO): Starting
2020-05-29T20:44:17.149Z,1590785057.149 [DAT](INFO): commRate: 800
2020-05-29T20:44:17.553Z,1590785057.553 [DAT](INFO): Starting
2020-05-29T20:44:17.553Z,1590785057.553 [DAT](INFO): commRate: 800
2020-05-29T20:44:17.967Z,1590785057.967 [DAT](INFO): Starting
2020-05-29T20:44:17.968Z,1590785057.968 [DAT](INFO): commRate: 800
2020-05-29T20:44:18.379Z,1590785058.379 [DAT](INFO): Starting
2020-05-29T20:44:18.380Z,1590785058.380 [DAT](INFO): commRate: 800
2020-05-29T20:44:18.764Z,1590785058.764 [DAT](INFO): Starting
2020-05-29T20:44:18.765Z,1590785058.765 [DAT](INFO): commRate: 800
2020-05-29T20:44:19.169Z,1590785059.169 [DAT](INFO): Starting
2020-05-29T20:44:19.169Z,1590785059.169 [DAT](INFO): commRate: 800
2020-05-29T20:44:19.582Z,1590785059.582 [DAT](INFO): Starting
2020-05-29T20:44:19.582Z,1590785059.582 [DAT](INFO): commRate: 800
2020-05-29T20:44:19.981Z,1590785059.981 [DAT](INFO): Starting
2020-05-29T20:44:19.982Z,1590785059.982 [DAT](INFO): commRate: 800
2020-05-29T20:44:20.381Z,1590785060.381 [DAT](INFO): Starting
2020-05-29T20:44:20.381Z,1590785060.381 [DAT](INFO): commRate: 800
2020-05-29T20:44:20.932Z,1590785060.932 [DAT](INFO): Starting
2020-05-29T20:44:20.933Z,1590785060.933 [DAT](INFO): commRate: 800
2020-05-29T20:44:21.303Z,1590785061.303 [NAL9602](INFO): NAL9602 initialized
2020-05-29T20:44:21.317Z,1590785061.317 [DAT](INFO): Starting
2020-05-29T20:44:21.318Z,1590785061.318 [DAT](INFO): commRate: 800
2020-05-29T20:44:21.729Z,1590785061.729 [DAT](INFO): Starting
2020-05-29T20:44:21.730Z,1590785061.730 [DAT](INFO): commRate: 800
2020-05-29T20:44:22.151Z,1590785062.151 [DAT](INFO): Starting
2020-05-29T20:44:22.152Z,1590785062.152 [DAT](INFO): commRate: 800
2020-05-29T20:44:22.544Z,1590785062.544 [DAT](INFO): Starting
2020-05-29T20:44:22.544Z,1590785062.544 [DAT](INFO): commRate: 800
2020-05-29T20:44:22.951Z,1590785062.951 [DAT](INFO): Starting
2020-05-29T20:44:22.951Z,1590785062.951 [DAT](INFO): commRate: 800
2020-05-29T20:44:23.351Z,1590785063.351 [DAT](INFO): Starting
2020-05-29T20:44:23.352Z,1590785063.352 [DAT](INFO): commRate: 800
2020-05-29T20:44:23.755Z,1590785063.755 [DAT](INFO): Starting
2020-05-29T20:44:23.755Z,1590785063.755 [DAT](INFO): commRate: 800
2020-05-29T20:44:24.164Z,1590785064.164 [DAT](INFO): Starting
2020-05-29T20:44:24.165Z,1590785064.165 [DAT](INFO): commRate: 800
2020-05-29T20:44:24.563Z,1590785064.563 [DAT](INFO): Starting
2020-05-29T20:44:24.564Z,1590785064.564 [DAT](INFO): commRate: 800
2020-05-29T20:44:24.966Z,1590785064.966 [DAT](INFO): Starting
2020-05-29T20:44:24.966Z,1590785064.966 [DAT](INFO): commRate: 800
2020-05-29T20:44:25.360Z,1590785065.360 [DAT](INFO): Starting
2020-05-29T20:44:25.360Z,1590785065.360 [DAT](INFO): commRate: 800
2020-05-29T20:44:25.772Z,1590785065.772 [DAT](INFO): Starting
2020-05-29T20:44:25.773Z,1590785065.773 [DAT](INFO): commRate: 800
2020-05-29T20:44:26.165Z,1590785066.165 [DAT](INFO): Starting
2020-05-29T20:44:26.166Z,1590785066.166 [DAT](INFO): commRate: 800
2020-05-29T20:44:26.569Z,1590785066.569 [DAT](INFO): Starting
2020-05-29T20:44:26.570Z,1590785066.570 [DAT](INFO): commRate: 800
2020-05-29T20:44:26.978Z,1590785066.978 [DAT](INFO): Starting
2020-05-29T20:44:26.978Z,1590785066.978 [DAT](INFO): commRate: 800
2020-05-29T20:44:27.378Z,1590785067.378 [DAT](INFO): Starting
2020-05-29T20:44:27.378Z,1590785067.378 [DAT](INFO): commRate: 800
2020-05-29T20:44:27.781Z,1590785067.781 [DAT](INFO): Starting
2020-05-29T20:44:27.781Z,1590785067.781 [DAT](INFO): commRate: 800
2020-05-29T20:44:28.186Z,1590785068.186 [DAT](INFO): Starting
2020-05-29T20:44:28.186Z,1590785068.186 [DAT](INFO): commRate: 800
2020-05-29T20:44:28.604Z,1590785068.604 [DAT](INFO): Starting
2020-05-29T20:44:28.604Z,1590785068.604 [DAT](INFO): commRate: 800
2020-05-29T20:44:29.011Z,1590785069.011 [DAT](INFO): Starting
2020-05-29T20:44:29.011Z,1590785069.011 [DAT](INFO): commRate: 800
2020-05-29T20:44:29.416Z,1590785069.416 [DAT](INFO): Starting
2020-05-29T20:44:29.417Z,1590785069.417 [DAT](INFO): commRate: 800
2020-05-29T20:44:29.816Z,1590785069.816 [DAT](INFO): Starting
2020-05-29T20:44:29.816Z,1590785069.816 [DAT](INFO): commRate: 800
2020-05-29T20:44:30.207Z,1590785070.207 [DAT](INFO): Starting
2020-05-29T20:44:30.207Z,1590785070.207 [DAT](INFO): commRate: 800
2020-05-29T20:44:30.616Z,1590785070.616 [DAT](INFO): Starting
2020-05-29T20:44:30.616Z,1590785070.616 [DAT](INFO): commRate: 800
2020-05-29T20:44:31.014Z,1590785071.013 [DAT](INFO): Starting
2020-05-29T20:44:31.014Z,1590785071.014 [DAT](INFO): commRate: 800
2020-05-29T20:44:31.423Z,1590785071.423 [DAT](INFO): Starting
2020-05-29T20:44:31.423Z,1590785071.423 [DAT](INFO): commRate: 800
2020-05-29T20:44:31.821Z,1590785071.821 [DAT](INFO): Starting
2020-05-29T20:44:31.822Z,1590785071.822 [DAT](INFO): commRate: 800
2020-05-29T20:44:32.230Z,1590785072.230 [DAT](INFO): Starting
2020-05-29T20:44:32.231Z,1590785072.231 [DAT](INFO): commRate: 800
2020-05-29T20:44:32.629Z,1590785072.629 [DAT](INFO): Starting
2020-05-29T20:44:32.629Z,1590785072.629 [DAT](INFO): commRate: 800
2020-05-29T20:44:33.034Z,1590785073.034 [DAT](INFO): Starting
2020-05-29T20:44:33.034Z,1590785073.034 [DAT](INFO): commRate: 800
2020-05-29T20:44:33.437Z,1590785073.437 [DAT](INFO): Starting
2020-05-29T20:44:33.438Z,1590785073.438 [DAT](INFO): commRate: 800
2020-05-29T20:44:33.855Z,1590785073.855 [DAT](INFO): Starting
2020-05-29T20:44:33.856Z,1590785073.856 [DAT](INFO): commRate: 800
2020-05-29T20:44:34.263Z,1590785074.263 [DAT](INFO): Starting
2020-05-29T20:44:34.264Z,1590785074.264 [DAT](INFO): commRate: 800
2020-05-29T20:44:34.669Z,1590785074.669 [DAT](INFO): Starting
2020-05-29T20:44:34.669Z,1590785074.669 [DAT](INFO): commRate: 800
2020-05-29T20:44:35.075Z,1590785075.075 [DAT](INFO): Starting
2020-05-29T20:44:35.075Z,1590785075.075 [DAT](INFO): commRate: 800
2020-05-29T20:44:35.459Z,1590785075.459 [DAT](INFO): Starting
2020-05-29T20:44:35.460Z,1590785075.460 [DAT](INFO): commRate: 800
2020-05-29T20:44:35.865Z,1590785075.865 [DAT](INFO): Starting
2020-05-29T20:44:35.866Z,1590785075.866 [DAT](INFO): commRate: 800
2020-05-29T20:44:36.265Z,1590785076.265 [DAT](INFO): Starting
2020-05-29T20:44:36.266Z,1590785076.266 [DAT](INFO): commRate: 800
2020-05-29T20:44:36.669Z,1590785076.669 [DAT](INFO): Starting
2020-05-29T20:44:36.670Z,1590785076.670 [DAT](INFO): commRate: 800
2020-05-29T20:44:37.073Z,1590785077.073 [DAT](INFO): Starting
2020-05-29T20:44:37.073Z,1590785077.073 [DAT](INFO): commRate: 800
2020-05-29T20:44:37.480Z,1590785077.480 [DAT](INFO): Starting
2020-05-29T20:44:37.480Z,1590785077.480 [DAT](INFO): commRate: 800
2020-05-29T20:44:37.881Z,1590785077.881 [DAT](INFO): Starting
2020-05-29T20:44:37.882Z,1590785077.882 [DAT](INFO): commRate: 800
2020-05-29T20:44:38.285Z,1590785078.285 [DAT](INFO): Starting
2020-05-29T20:44:38.286Z,1590785078.286 [DAT](INFO): commRate: 800
2020-05-29T20:44:38.687Z,1590785078.687 [DAT](INFO): Starting
2020-05-29T20:44:38.687Z,1590785078.687 [DAT](INFO): commRate: 800
2020-05-29T20:44:39.107Z,1590785079.107 [DAT](INFO): Starting
2020-05-29T20:44:39.108Z,1590785079.108 [DAT](INFO): commRate: 800
2020-05-29T20:44:39.515Z,1590785079.515 [DAT](INFO): Starting
2020-05-29T20:44:39.516Z,1590785079.516 [DAT](INFO): commRate: 800
2020-05-29T20:44:39.919Z,1590785079.919 [DAT](INFO): Starting
2020-05-29T20:44:39.920Z,1590785079.920 [DAT](INFO): commRate: 800
2020-05-29T20:44:40.320Z,1590785080.320 [DAT](INFO): Starting
2020-05-29T20:44:40.320Z,1590785080.320 [DAT](INFO): commRate: 800
2020-05-29T20:44:40.712Z,1590785080.712 [DAT](INFO): Starting
2020-05-29T20:44:40.712Z,1590785080.712 [DAT](INFO): commRate: 800
2020-05-29T20:44:41.118Z,1590785081.118 [DAT](INFO): Starting
2020-05-29T20:44:41.119Z,1590785081.119 [DAT](INFO): commRate: 800
2020-05-29T20:44:41.517Z,1590785081.517 [DAT](INFO): Starting
2020-05-29T20:44:41.518Z,1590785081.518 [DAT](INFO): commRate: 800
2020-05-29T20:44:41.922Z,1590785081.922 [DAT](INFO): Starting
2020-05-29T20:44:41.922Z,1590785081.922 [DAT](INFO): commRate: 800
2020-05-29T20:44:42.325Z,1590785082.325 [DAT](INFO): Starting
2020-05-29T20:44:42.325Z,1590785082.325 [DAT](INFO): commRate: 800
2020-05-29T20:44:42.734Z,1590785082.734 [DAT](INFO): Starting
2020-05-29T20:44:42.735Z,1590785082.735 [DAT](INFO): commRate: 800
2020-05-29T20:44:43.133Z,1590785083.133 [DAT](INFO): Starting
2020-05-29T20:44:43.134Z,1590785083.134 [DAT](INFO): commRate: 800
2020-05-29T20:44:43.537Z,1590785083.537 [DAT](INFO): Starting
2020-05-29T20:44:43.538Z,1590785083.538 [DAT](INFO): commRate: 800
2020-05-29T20:44:43.941Z,1590785083.941 [DAT](INFO): Starting
2020-05-29T20:44:43.942Z,1590785083.942 [DAT](INFO): commRate: 800
2020-05-29T20:44:44.359Z,1590785084.359 [DAT](INFO): Starting
2020-05-29T20:44:44.360Z,1590785084.360 [DAT](INFO): commRate: 800
2020-05-29T20:44:44.766Z,1590785084.766 [DAT](INFO): Starting
2020-05-29T20:44:44.767Z,1590785084.767 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-29T20:44:44.767Z,1590785084.767 [DAT] Communications Fault, FailCount= 1
2020-05-29T20:44:44.767Z,1590785084.767 [DAT](ERROR): Communications Fault
2020-05-29T20:44:44.869Z,1590785084.869 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-29T20:44:45.196Z,1590785085.196 [DAT](INFO): Stop
2020-05-29T20:44:45.196Z,1590785085.196 [DAT](INFO): uninitialize
2020-05-29T20:44:45.196Z,1590785085.196 [DAT](INFO): Powering down
2020-05-29T20:44:45.587Z,1590785085.587 [DAT](INFO): Stopping
2020-05-29T20:44:45.961Z,1590785085.961 [DAT](INFO): Stopped
2020-05-29T20:44:46.058Z,1590785086.058 [CBIT](INFO): Clearing failed state for component DAT
2020-05-29T20:44:46.058Z,1590785086.058 [DAT] No Fault, FailCount= 1
2020-05-29T20:44:46.365Z,1590785086.365 [DAT](INFO): Start
2020-05-29T20:44:46.770Z,1590785086.770 [DAT](INFO): Start
2020-05-29T20:44:47.176Z,1590785087.176 [DAT](INFO): Start
2020-05-29T20:44:47.715Z,1590785087.715 [DAT](INFO): Start
2020-05-29T20:44:48.108Z,1590785088.108 [DAT](INFO): Start
2020-05-29T20:44:48.510Z,1590785088.510 [DAT](INFO): Start
2020-05-29T20:44:48.512Z,1590785088.512 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-29T20:44:48.512Z,1590785088.512 [DAT](INFO): Powering up
2020-05-29T20:44:48.512Z,1590785088.512 [DAT](DEBUG): Initializing DAT.
2020-05-29T20:44:48.609Z,1590785088.609 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-29T20:44:48.919Z,1590785088.919 [DAT](INFO): Starting
2020-05-29T20:44:49.338Z,1590785089.338 [DAT](INFO): Starting
2020-05-29T20:44:49.740Z,1590785089.740 [DAT](INFO): Starting
2020-05-29T20:44:50.140Z,1590785090.140 [DAT](INFO): Starting
2020-05-29T20:44:50.545Z,1590785090.545 [DAT](INFO): Starting
2020-05-29T20:44:50.947Z,1590785090.947 [DAT](INFO): Starting
2020-05-29T20:44:51.337Z,1590785091.337 [DAT](INFO): Starting
2020-05-29T20:44:51.742Z,1590785091.742 [DAT](INFO): Starting
2020-05-29T20:44:52.149Z,1590785092.149 [DAT](INFO): Starting
2020-05-29T20:44:52.550Z,1590785092.550 [DAT](INFO): Starting
2020-05-29T20:44:52.955Z,1590785092.955 [DAT](INFO): Starting
2020-05-29T20:44:53.358Z,1590785093.358 [DAT](INFO): Starting
2020-05-29T20:44:53.766Z,1590785093.766 [DAT](INFO): Starting
2020-05-29T20:44:54.170Z,1590785094.170 [DAT](INFO): Starting
2020-05-29T20:44:54.588Z,1590785094.588 [DAT](INFO): Starting
2020-05-29T20:44:54.987Z,1590785094.987 [DAT](INFO): Starting
2020-05-29T20:44:55.405Z,1590785095.405 [DAT](INFO): Starting
2020-05-29T20:44:55.795Z,1590785095.795 [DAT](INFO): Starting
2020-05-29T20:44:56.185Z,1590785096.185 [DAT](INFO): Starting
2020-05-29T20:44:56.590Z,1590785096.590 [DAT](INFO): Starting
2020-05-29T20:44:56.992Z,1590785096.992 [DAT](INFO): Starting
2020-05-29T20:44:57.404Z,1590785097.404 [DAT](INFO): Starting
2020-05-29T20:44:57.801Z,1590785097.801 [DAT](INFO): Starting
2020-05-29T20:44:58.205Z,1590785098.205 [DAT](INFO): Starting
2020-05-29T20:44:58.609Z,1590785098.609 [DAT](INFO): Starting
2020-05-29T20:44:59.017Z,1590785099.017 [DAT](INFO): Starting
2020-05-29T20:44:59.094Z,1590785099.094 [SBIT](IMPORTANT): SBIT PASSED
2020-05-29T20:44:59.094Z,1590785099.094 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-05-29T20:44:59.095Z,1590785099.095 [SBIT](IMPORTANT): 

2020-05-29T20:44:59.095Z,1590785099.095 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2020-05-29T20:44:59.095Z,1590785099.095 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2020-05-29T20:44:59.095Z,1590785099.095 [SBIT](IMPORTANT): DAT.sbdAddress=9 enum;

2020-05-29T20:44:59.095Z,1590785099.095 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2020-05-29T20:44:59.095Z,1590785099.095 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2020-05-29T20:44:59.096Z,1590785099.096 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool;

2020-05-29T20:44:59.420Z,1590785099.420 [DAT](INFO): Starting
2020-05-29T20:44:59.479Z,1590785099.479 [MissionManager](IMPORTANT): Started mission Startup
2020-05-29T20:44:59.479Z,1590785099.479 [Startup] Running Loop=1
2020-05-29T20:44:59.479Z,1590785099.479 [Startup](DEBUG): Aggregate::initialize Startup
2020-05-29T20:44:59.480Z,1590785099.480 [Startup:A.GoToSurface] Running Loop=1
2020-05-29T20:44:59.480Z,1590785099.480 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-05-29T20:44:59.480Z,1590785099.480 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-05-29T20:44:59.513Z,1590785099.513 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-05-29T20:44:59.513Z,1590785099.513 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-05-29T20:44:59.514Z,1590785099.514 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-05-29T20:44:59.514Z,1590785099.514 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-05-29T20:44:59.516Z,1590785099.516 [Startup:StartupSatComms] Running Loop=1
2020-05-29T20:44:59.516Z,1590785099.516 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-05-29T20:44:59.516Z,1590785099.516 [Startup:StartupSatComms:A] Running Loop=1
2020-05-29T20:44:59.835Z,1590785099.835 [DAT](INFO): Starting
2020-05-29T20:44:59.837Z,1590785099.837 [DAT](INFO): unknown deviceResponse_: Teledyne Benthos DAT-900 Series

2020-05-29T20:44:59.891Z,1590785099.891 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-05-29T20:45:00.243Z,1590785100.243 [DAT](INFO): Starting
2020-05-29T20:45:00.649Z,1590785100.649 [DAT](INFO): Starting
2020-05-29T20:45:01.047Z,1590785101.047 [DAT](INFO): Starting
2020-05-29T20:45:01.450Z,1590785101.450 [DAT](INFO): Starting
2020-05-29T20:45:01.452Z,1590785101.452 [DAT](INFO): unknown deviceResponse_: MF Frequency Band

2020-05-29T20:45:01.453Z,1590785101.453 [DAT](INFO): unknown deviceResponse_: Directional Acoustic Transponder version 8.14.0

2020-05-29T20:45:01.454Z,1590785101.454 [DAT](INFO): unknown deviceResponse_: May 29 2020 20:43:05 

2020-05-29T20:45:01.842Z,1590785101.842 [DAT](INFO): Starting
2020-05-29T20:45:02.247Z,1590785102.247 [DAT](INFO): Starting
2020-05-29T20:45:02.249Z,1590785102.249 [DAT](INFO): unknown deviceResponse_: Features enabled [Bearing]

2020-05-29T20:45:02.662Z,1590785102.662 [DAT](INFO): Starting
2020-05-29T20:45:02.664Z,1590785102.664 [DAT](INFO): commRate: 800
2020-05-29T20:45:02.664Z,1590785102.664 [DAT](INFO): unknown deviceResponse_: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2020-05-29T20:45:02.664Z,1590785102.664 [DAT](INFO): commRate: 800
2020-05-29T20:45:03.058Z,1590785103.058 [DAT](INFO): Starting
2020-05-29T20:45:03.059Z,1590785103.059 [DAT](INFO): commRate: 800
2020-05-29T20:45:03.458Z,1590785103.458 [DAT](INFO): Starting
2020-05-29T20:45:03.459Z,1590785103.459 [DAT](INFO): commRate: 800
2020-05-29T20:45:03.862Z,1590785103.862 [DAT](INFO): Starting
2020-05-29T20:45:03.863Z,1590785103.863 [DAT](INFO): commRate: 800
2020-05-29T20:45:04.277Z,1590785104.277 [DAT](INFO): Starting
2020-05-29T20:45:04.278Z,1590785104.278 [DAT](INFO): commRate: 800
2020-05-29T20:45:04.676Z,1590785104.676 [DAT](INFO): Starting
2020-05-29T20:45:04.676Z,1590785104.676 [DAT](INFO): commRate: 800
2020-05-29T20:45:05.223Z,1590785105.223 [DAT](INFO): Starting
2020-05-29T20:45:05.224Z,1590785105.224 [DAT](INFO): commRate: 800
2020-05-29T20:45:05.640Z,1590785105.640 [DAT](INFO): Starting
2020-05-29T20:45:05.641Z,1590785105.641 [DAT](INFO): commRate: 800
2020-05-29T20:45:06.023Z,1590785106.023 [DAT](INFO): Starting
2020-05-29T20:45:06.023Z,1590785106.023 [DAT](INFO): commRate: 800
2020-05-29T20:45:06.427Z,1590785106.427 [DAT](INFO): Starting
2020-05-29T20:45:06.428Z,1590785106.428 [DAT](INFO): commRate: 800
2020-05-29T20:45:06.820Z,1590785106.820 [DAT](INFO): Starting
2020-05-29T20:45:06.821Z,1590785106.821 [DAT](INFO): commRate: 800
2020-05-29T20:45:07.227Z,1590785107.227 [DAT](INFO): Starting
2020-05-29T20:45:07.228Z,1590785107.228 [DAT](INFO): commRate: 800
2020-05-29T20:45:07.625Z,1590785107.625 [DAT](INFO): Starting
2020-05-29T20:45:07.626Z,1590785107.626 [DAT](INFO): commRate: 800
2020-05-29T20:45:08.029Z,1590785108.029 [DAT](INFO): Starting
2020-05-29T20:45:08.030Z,1590785108.030 [DAT](INFO): commRate: 800
2020-05-29T20:45:08.435Z,1590785108.435 [DAT](INFO): Starting
2020-05-29T20:45:08.436Z,1590785108.436 [DAT](INFO): commRate: 800
2020-05-29T20:45:08.843Z,1590785108.843 [DAT](INFO): Starting
2020-05-29T20:45:08.844Z,1590785108.844 [DAT](INFO): commRate: 800
2020-05-29T20:45:09.245Z,1590785109.245 [DAT](INFO): Starting
2020-05-29T20:45:09.246Z,1590785109.246 [DAT](INFO): commRate: 800
2020-05-29T20:45:09.649Z,1590785109.649 [DAT](INFO): Starting
2020-05-29T20:45:09.650Z,1590785109.650 [DAT](INFO): commRate: 800
2020-05-29T20:45:10.053Z,1590785110.053 [DAT](INFO): Starting
2020-05-29T20:45:10.054Z,1590785110.054 [DAT](INFO): commRate: 800
2020-05-29T20:45:10.472Z,1590785110.472 [DAT](INFO): Starting
2020-05-29T20:45:10.472Z,1590785110.472 [DAT](INFO): commRate: 800
2020-05-29T20:45:10.875Z,1590785110.875 [DAT](INFO): Starting
2020-05-29T20:45:10.876Z,1590785110.876 [DAT](INFO): commRate: 800
2020-05-29T20:45:11.275Z,1590785111.275 [DAT](INFO): Starting
2020-05-29T20:45:11.276Z,1590785111.276 [DAT](INFO): commRate: 800
2020-05-29T20:45:11.683Z,1590785111.683 [DAT](INFO): Starting
2020-05-29T20:45:11.683Z,1590785111.683 [DAT](INFO): commRate: 800
2020-05-29T20:45:12.075Z,1590785112.075 [DAT](INFO): Starting
2020-05-29T20:45:12.076Z,1590785112.076 [DAT](INFO): commRate: 800
2020-05-29T20:45:12.470Z,1590785112.470 [DAT](INFO): Starting
2020-05-29T20:45:12.471Z,1590785112.471 [DAT](INFO): commRate: 800
2020-05-29T20:45:12.882Z,1590785112.882 [DAT](INFO): Starting
2020-05-29T20:45:12.882Z,1590785112.882 [DAT](INFO): commRate: 800
2020-05-29T20:45:13.281Z,1590785113.281 [DAT](INFO): Starting
2020-05-29T20:45:13.282Z,1590785113.282 [DAT](INFO): commRate: 800
2020-05-29T20:45:13.689Z,1590785113.689 [DAT](INFO): Starting
2020-05-29T20:45:13.690Z,1590785113.690 [DAT](INFO): commRate: 800
2020-05-29T20:45:14.093Z,1590785114.093 [DAT](INFO): Starting
2020-05-29T20:45:14.094Z,1590785114.094 [DAT](INFO): commRate: 800
2020-05-29T20:45:14.494Z,1590785114.494 [DAT](INFO): Starting
2020-05-29T20:45:14.494Z,1590785114.494 [DAT](INFO): commRate: 800
2020-05-29T20:45:14.901Z,1590785114.901 [DAT](INFO): Starting
2020-05-29T20:45:14.902Z,1590785114.902 [DAT](INFO): commRate: 800
2020-05-29T20:45:15.302Z,1590785115.302 [DAT](INFO): Starting
2020-05-29T20:45:15.303Z,1590785115.303 [DAT](INFO): commRate: 800
2020-05-29T20:45:15.734Z,1590785115.734 [DAT](INFO): Starting
2020-05-29T20:45:15.735Z,1590785115.735 [DAT](INFO): commRate: 800
2020-05-29T20:45:16.128Z,1590785116.128 [DAT](INFO): Starting
2020-05-29T20:45:16.129Z,1590785116.129 [DAT](INFO): commRate: 800
2020-05-29T20:45:16.531Z,1590785116.531 [DAT](INFO): Starting
2020-05-29T20:45:16.531Z,1590785116.531 [DAT](INFO): commRate: 800
2020-05-29T20:45:16.931Z,1590785116.931 [DAT](INFO): Starting
2020-05-29T20:45:16.932Z,1590785116.932 [DAT](INFO): commRate: 800
2020-05-29T20:45:17.326Z,1590785117.326 [DAT](INFO): Starting
2020-05-29T20:45:17.326Z,1590785117.326 [DAT](INFO): commRate: 800
2020-05-29T20:45:17.730Z,1590785117.730 [DAT](INFO): Starting
2020-05-29T20:45:17.730Z,1590785117.730 [DAT](INFO): commRate: 800
2020-05-29T20:45:18.133Z,1590785118.133 [DAT](INFO): Starting
2020-05-29T20:45:18.134Z,1590785118.134 [DAT](INFO): commRate: 800
2020-05-29T20:45:18.537Z,1590785118.537 [DAT](INFO): Starting
2020-05-29T20:45:18.537Z,1590785118.537 [DAT](INFO): commRate: 800
2020-05-29T20:45:18.945Z,1590785118.945 [DAT](INFO): Starting
2020-05-29T20:45:18.945Z,1590785118.945 [DAT](INFO): commRate: 800
2020-05-29T20:45:19.338Z,1590785119.338 [DAT](INFO): Starting
2020-05-29T20:45:19.339Z,1590785119.339 [DAT](INFO): commRate: 800
2020-05-29T20:45:19.746Z,1590785119.746 [DAT](INFO): Starting
2020-05-29T20:45:19.746Z,1590785119.746 [DAT](INFO): commRate: 800
2020-05-29T20:45:20.158Z,1590785120.158 [DAT](INFO): Starting
2020-05-29T20:45:20.159Z,1590785120.159 [DAT](INFO): commRate: 800
2020-05-29T20:45:20.557Z,1590785120.557 [DAT](INFO): Starting
2020-05-29T20:45:20.558Z,1590785120.558 [DAT](INFO): commRate: 800
2020-05-29T20:45:20.975Z,1590785120.975 [DAT](INFO): Starting
2020-05-29T20:45:20.976Z,1590785120.976 [DAT](INFO): commRate: 800
2020-05-29T20:45:21.379Z,1590785121.379 [DAT](INFO): Starting
2020-05-29T20:45:21.379Z,1590785121.379 [DAT](INFO): commRate: 800
2020-05-29T20:45:21.784Z,1590785121.784 [DAT](INFO): Starting
2020-05-29T20:45:21.785Z,1590785121.785 [DAT](INFO): commRate: 800
2020-05-29T20:45:22.179Z,1590785122.179 [DAT](INFO): Starting
2020-05-29T20:45:22.180Z,1590785122.180 [DAT](INFO): commRate: 800
2020-05-29T20:45:22.578Z,1590785122.578 [DAT](INFO): Starting
2020-05-29T20:45:22.578Z,1590785122.578 [DAT](INFO): commRate: 800
2020-05-29T20:45:22.979Z,1590785122.979 [DAT](INFO): Starting
2020-05-29T20:45:22.979Z,1590785122.979 [DAT](INFO): commRate: 800
2020-05-29T20:45:23.385Z,1590785123.385 [DAT](INFO): Starting
2020-05-29T20:45:23.386Z,1590785123.386 [DAT](INFO): commRate: 800
2020-05-29T20:45:23.785Z,1590785123.785 [DAT](INFO): Starting
2020-05-29T20:45:23.786Z,1590785123.786 [DAT](INFO): commRate: 800
2020-05-29T20:45:24.193Z,1590785124.193 [DAT](INFO): Starting
2020-05-29T20:45:24.194Z,1590785124.194 [DAT](INFO): commRate: 800
2020-05-29T20:45:24.596Z,1590785124.596 [DAT](INFO): Starting
2020-05-29T20:45:24.597Z,1590785124.597 [DAT](INFO): commRate: 800
2020-05-29T20:45:25.002Z,1590785125.002 [DAT](INFO): Starting
2020-05-29T20:45:25.003Z,1590785125.003 [DAT](INFO): commRate: 800
2020-05-29T20:45:25.405Z,1590785125.405 [DAT](INFO): Starting
2020-05-29T20:45:25.405Z,1590785125.405 [DAT](INFO): commRate: 800
2020-05-29T20:45:25.821Z,1590785125.821 [DAT](INFO): Starting
2020-05-29T20:45:25.821Z,1590785125.821 [DAT](INFO): commRate: 800
2020-05-29T20:45:26.223Z,1590785126.223 [DAT](INFO): Starting
2020-05-29T20:45:26.223Z,1590785126.223 [DAT](INFO): commRate: 800
2020-05-29T20:45:26.631Z,1590785126.631 [DAT](INFO): Starting
2020-05-29T20:45:26.632Z,1590785126.632 [DAT](INFO): commRate: 800
2020-05-29T20:45:27.036Z,1590785127.036 [DAT](INFO): Starting
2020-05-29T20:45:27.036Z,1590785127.036 [DAT](INFO): commRate: 800
2020-05-29T20:45:27.438Z,1590785127.438 [DAT](INFO): Starting
2020-05-29T20:45:27.439Z,1590785127.439 [DAT](INFO): commRate: 800
2020-05-29T20:45:27.829Z,1590785127.829 [DAT](INFO): Starting
2020-05-29T20:45:27.829Z,1590785127.829 [DAT](INFO): commRate: 800
2020-05-29T20:45:28.236Z,1590785128.236 [DAT](INFO): Starting
2020-05-29T20:45:28.237Z,1590785128.237 [DAT](INFO): commRate: 800
2020-05-29T20:45:28.633Z,1590785128.633 [DAT](INFO): Starting
2020-05-29T20:45:28.634Z,1590785128.634 [DAT](INFO): commRate: 800
2020-05-29T20:45:29.041Z,1590785129.041 [DAT](INFO): Starting
2020-05-29T20:45:29.042Z,1590785129.042 [DAT](INFO): commRate: 800
2020-05-29T20:45:29.445Z,1590785129.445 [DAT](INFO): Starting
2020-05-29T20:45:29.446Z,1590785129.446 [DAT](INFO): commRate: 800
2020-05-29T20:45:29.849Z,1590785129.849 [DAT](INFO): Starting
2020-05-29T20:45:29.850Z,1590785129.850 [DAT](INFO): commRate: 800
2020-05-29T20:45:30.256Z,1590785130.256 [DAT](INFO): Starting
2020-05-29T20:45:30.257Z,1590785130.257 [DAT](INFO): commRate: 800
2020-05-29T20:45:30.658Z,1590785130.658 [DAT](INFO): Starting
2020-05-29T20:45:30.658Z,1590785130.658 [DAT](INFO): commRate: 800
2020-05-29T20:45:31.057Z,1590785131.057 [DAT](INFO): Starting
2020-05-29T20:45:31.058Z,1590785131.058 [DAT](INFO): commRate: 800
2020-05-29T20:45:31.475Z,1590785131.475 [DAT](INFO): Starting
2020-05-29T20:45:31.476Z,1590785131.476 [DAT](INFO): commRate: 800
2020-05-29T20:45:31.881Z,1590785131.881 [DAT](INFO): Starting
2020-05-29T20:45:31.881Z,1590785131.881 [DAT](INFO): commRate: 800
2020-05-29T20:45:32.288Z,1590785132.288 [DAT](INFO): Starting
2020-05-29T20:45:32.289Z,1590785132.289 [DAT](INFO): commRate: 800
2020-05-29T20:45:32.688Z,1590785132.688 [DAT](INFO): Starting
2020-05-29T20:45:32.688Z,1590785132.688 [DAT](INFO): commRate: 800
2020-05-29T20:45:33.081Z,1590785133.081 [DAT](INFO): Starting
2020-05-29T20:45:33.081Z,1590785133.081 [DAT](INFO): commRate: 800
2020-05-29T20:45:33.484Z,1590785133.484 [DAT](INFO): Starting
2020-05-29T20:45:33.485Z,1590785133.485 [DAT](INFO): commRate: 800
2020-05-29T20:45:34.021Z,1590785134.021 [DAT](INFO): Starting
2020-05-29T20:45:34.022Z,1590785134.022 [DAT](INFO): commRate: 800
2020-05-29T20:45:34.393Z,1590785134.393 [DAT](INFO): Starting
2020-05-29T20:45:34.394Z,1590785134.394 [DAT](INFO): commRate: 800
2020-05-29T20:45:34.798Z,1590785134.798 [DAT](INFO): Starting
2020-05-29T20:45:34.799Z,1590785134.799 [DAT](INFO): commRate: 800
2020-05-29T20:45:35.197Z,1590785135.197 [DAT](INFO): Starting
2020-05-29T20:45:35.198Z,1590785135.198 [DAT](INFO): commRate: 800
2020-05-29T20:45:35.602Z,1590785135.602 [DAT](INFO): Starting
2020-05-29T20:45:35.602Z,1590785135.602 [DAT](INFO): commRate: 800
2020-05-29T20:45:36.025Z,1590785136.025 [DAT](INFO): Starting
2020-05-29T20:45:36.026Z,1590785136.026 [DAT](INFO): commRate: 800
2020-05-29T20:45:36.424Z,1590785136.424 [DAT](INFO): Starting
2020-05-29T20:45:36.425Z,1590785136.425 [DAT](INFO): commRate: 800
2020-05-29T20:45:36.830Z,1590785136.830 [DAT](INFO): Starting
2020-05-29T20:45:36.831Z,1590785136.831 [DAT](INFO): commRate: 800
2020-05-29T20:45:37.232Z,1590785137.232 [DAT](INFO): Starting
2020-05-29T20:45:37.232Z,1590785137.232 [DAT](INFO): commRate: 800
2020-05-29T20:45:37.631Z,1590785137.631 [DAT](INFO): Starting
2020-05-29T20:45:37.631Z,1590785137.631 [DAT](INFO): commRate: 800
2020-05-29T20:45:38.029Z,1590785138.029 [DAT](INFO): Starting
2020-05-29T20:45:38.030Z,1590785138.030 [DAT](INFO): commRate: 800
2020-05-29T20:45:38.429Z,1590785138.429 [DAT](INFO): Starting
2020-05-29T20:45:38.430Z,1590785138.430 [DAT](INFO): commRate: 800
2020-05-29T20:45:38.834Z,1590785138.834 [DAT](INFO): Starting
2020-05-29T20:45:38.834Z,1590785138.834 [DAT](INFO): commRate: 800
2020-05-29T20:45:39.240Z,1590785139.240 [DAT](INFO): Starting
2020-05-29T20:45:39.240Z,1590785139.240 [DAT](INFO): commRate: 800
2020-05-29T20:45:39.645Z,1590785139.645 [DAT](INFO): Starting
2020-05-29T20:45:39.646Z,1590785139.646 [DAT](INFO): commRate: 800
2020-05-29T20:45:40.045Z,1590785140.045 [DAT](INFO): Starting
2020-05-29T20:45:40.046Z,1590785140.046 [DAT](INFO): commRate: 800
2020-05-29T20:45:40.447Z,1590785140.447 [DAT](INFO): Starting
2020-05-29T20:45:40.447Z,1590785140.447 [DAT](INFO): commRate: 800
2020-05-29T20:45:40.855Z,1590785140.855 [DAT](INFO): Starting
2020-05-29T20:45:40.856Z,1590785140.856 [DAT](INFO): commRate: 800
2020-05-29T20:45:41.264Z,1590785141.264 [DAT](INFO): Starting
2020-05-29T20:45:41.265Z,1590785141.265 [DAT](INFO): commRate: 800
2020-05-29T20:45:41.679Z,1590785141.679 [DAT](INFO): Starting
2020-05-29T20:45:41.679Z,1590785141.679 [DAT](INFO): commRate: 800
2020-05-29T20:45:42.082Z,1590785142.082 [DAT](INFO): Starting
2020-05-29T20:45:42.083Z,1590785142.083 [DAT](INFO): commRate: 800
2020-05-29T20:45:42.479Z,1590785142.479 [DAT](INFO): Starting
2020-05-29T20:45:42.479Z,1590785142.479 [DAT](INFO): commRate: 800
2020-05-29T20:45:42.887Z,1590785142.887 [DAT](INFO): Starting
2020-05-29T20:45:42.888Z,1590785142.888 [DAT](INFO): commRate: 800
2020-05-29T20:45:43.282Z,1590785143.282 [DAT](INFO): Starting
2020-05-29T20:45:43.283Z,1590785143.283 [DAT](INFO): commRate: 800
2020-05-29T20:45:43.686Z,1590785143.686 [DAT](INFO): Starting
2020-05-29T20:45:43.686Z,1590785143.686 [DAT](INFO): commRate: 800
2020-05-29T20:45:44.089Z,1590785144.089 [DAT](INFO): Starting
2020-05-29T20:45:44.090Z,1590785144.090 [DAT](INFO): commRate: 800
2020-05-29T20:45:44.497Z,1590785144.497 [DAT](INFO): Starting
2020-05-29T20:45:44.498Z,1590785144.498 [DAT](INFO): commRate: 800
2020-05-29T20:45:44.510Z,1590785144.510 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-05-29T20:45:44.510Z,1590785144.510 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-05-29T20:45:44.510Z,1590785144.510 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-05-29T20:45:44.523Z,1590785144.523 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-05-29T20:45:44.893Z,1590785144.893 [DAT](INFO): Starting
2020-05-29T20:45:44.894Z,1590785144.894 [DAT](INFO): commRate: 800
2020-05-29T20:45:44.934Z,1590785144.934 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-05-29T20:45:44.934Z,1590785144.934 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-05-29T20:45:45.299Z,1590785145.299 [DAT](INFO): Starting
2020-05-29T20:45:45.299Z,1590785145.299 [DAT](INFO): commRate: 800
2020-05-29T20:45:45.703Z,1590785145.703 [DAT](INFO): Starting
2020-05-29T20:45:45.704Z,1590785145.704 [DAT](INFO): commRate: 800
2020-05-29T20:45:46.135Z,1590785146.135 [DAT](INFO): Starting
2020-05-29T20:45:46.135Z,1590785146.135 [DAT](INFO): commRate: 800
2020-05-29T20:45:46.509Z,1590785146.509 [DAT](INFO): Starting
2020-05-29T20:45:46.510Z,1590785146.510 [DAT](INFO): commRate: 800
2020-05-29T20:45:46.926Z,1590785146.926 [DAT](INFO): Starting
2020-05-29T20:45:46.927Z,1590785146.927 [DAT](INFO): commRate: 800
2020-05-29T20:45:47.331Z,1590785147.331 [DAT](INFO): Starting
2020-05-29T20:45:47.332Z,1590785147.332 [DAT](INFO): commRate: 800
2020-05-29T20:45:47.735Z,1590785147.735 [DAT](INFO): Starting
2020-05-29T20:45:47.736Z,1590785147.736 [DAT](INFO): commRate: 800
2020-05-29T20:45:48.147Z,1590785148.147 [DAT](INFO): Starting
2020-05-29T20:45:48.147Z,1590785148.147 [DAT](INFO): commRate: 800
2020-05-29T20:45:48.529Z,1590785148.529 [DAT](INFO): Starting
2020-05-29T20:45:48.530Z,1590785148.530 [DAT](INFO): commRate: 800
2020-05-29T20:45:48.937Z,1590785148.937 [DAT](INFO): Starting
2020-05-29T20:45:48.937Z,1590785148.937 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-05-29T20:45:48.937Z,1590785148.937 [DAT] Communications Fault, FailCount= 2
2020-05-29T20:45:48.937Z,1590785148.937 [DAT](ERROR): Communications Fault
2020-05-29T20:45:49.022Z,1590785149.022 [CBIT](ERROR): Communications Fault in component: DAT
2020-05-29T20:45:49.338Z,1590785149.338 [DAT](INFO): Stop
2020-05-29T20:45:49.338Z,1590785149.338 [DAT](INFO): uninitialize
2020-05-29T20:45:49.338Z,1590785149.338 [DAT](INFO): Powering down
2020-05-29T20:45:49.745Z,1590785149.745 [DAT](INFO): Stopping
2020-05-29T20:45:50.150Z,1590785150.150 [DAT](INFO): Stopped
2020-05-29T20:45:50.169Z,1590785150.169 [CBIT](INFO): Clearing failed state for component DAT
2020-05-29T20:45:50.169Z,1590785150.169 [DAT] No Fault, FailCount= 2
2020-05-29T20:45:50.553Z,1590785150.553 [DAT](INFO): Start
2020-05-29T20:45:50.960Z,1590785150.960 [DAT](INFO): Start
2020-05-29T20:45:51.257Z,1590785151.257 [CommandLine](IMPORTANT): got command stop
2020-05-29T20:45:51.258Z,1590785151.258 [CommandLine](IMPORTANT): Scheduling is paused
2020-05-29T20:45:51.258Z,1590785151.258 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2020-05-29T20:45:51.358Z,1590785151.358 [DAT](INFO): Start
2020-05-29T20:45:51.765Z,1590785151.765 [DAT](INFO): Start
2020-05-29T20:45:52.183Z,1590785152.183 [DAT](INFO): Start
2020-05-29T20:45:52.582Z,1590785152.582 [DAT](INFO): Start
2020-05-29T20:45:52.584Z,1590785152.584 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-05-29T20:45:52.584Z,1590785152.584 [DAT](INFO): Powering up
2020-05-29T20:45:52.584Z,1590785152.584 [DAT](DEBUG): Initializing DAT.
2020-05-29T20:45:52.605Z,1590785152.605 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-05-29T20:45:52.987Z,1590785152.987 [DAT](INFO): Starting
2020-05-29T20:45:53.392Z,1590785153.392 [DAT](INFO): Starting
2020-05-29T20:45:53.781Z,1590785153.781 [DAT](INFO): Starting
2020-05-29T20:45:54.186Z,1590785154.186 [DAT](INFO): Starting
2020-05-29T20:45:54.591Z,1590785154.591 [DAT](INFO): Starting
2020-05-29T20:45:54.997Z,1590785154.997 [DAT](INFO): Starting
2020-05-29T20:45:55.401Z,1590785155.401 [DAT](INFO): Starting
2020-05-29T20:45:55.806Z,1590785155.806 [DAT](INFO): Starting
2020-05-29T20:45:56.216Z,1590785156.216 [DAT](INFO): Starting
2020-05-29T20:45:56.614Z,1590785156.614 [DAT](INFO): Starting
2020-05-29T20:45:57.022Z,1590785157.022 [DAT](INFO): Starting
2020-05-29T20:45:57.440Z,1590785157.440 [DAT](INFO): Starting
2020-05-29T20:45:57.835Z,1590785157.835 [DAT](INFO): Starting
2020-05-29T20:45:58.243Z,1590785158.243 [DAT](INFO): Starting
2020-05-29T20:45:58.647Z,1590785158.647 [DAT](INFO): Starting
2020-05-29T20:45:59.034Z,1590785159.034 [DAT](INFO): Starting
2020-05-29T20:45:59.437Z,1590785159.437 [DAT](INFO): Starting
2020-05-29T20:45:59.843Z,1590785159.843 [DAT](INFO): Starting
2020-05-29T20:45:59.860Z,1590785159.860 [Startup:StartupSatComms:A](INFO): Timed out from 2020-05-29T20:44:59.5Z
2020-05-29T20:45:59.860Z,1590785159.860 [Startup:StartupSatComms:A] Stopped
2020-05-29T20:45:59.860Z,1590785159.860 [Startup:StartupSatComms:B] Running Loop=1
2020-05-29T20:46:00.249Z,1590785160.249 [DAT](INFO): Starting
2020-05-29T20:46:00.264Z,1590785160.264 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-05-29T20:46:00.650Z,1590785160.650 [DAT](INFO): Starting
2020-05-29T20:46:01.053Z,1590785161.053 [DAT](INFO): Starting
2020-05-29T20:46:01.458Z,1590785161.458 [DAT](INFO): Starting
2020-05-29T20:46:01.866Z,1590785161.866 [DAT](INFO): Starting
2020-05-29T20:46:02.265Z,1590785162.265 [DAT](INFO): Starting
2020-05-29T20:46:02.687Z,1590785162.687 [DAT](INFO): Starting
2020-05-29T20:46:03.099Z,1590785163.099 [DAT](INFO): Starting
2020-05-29T20:46:03.495Z,1590785163.495 [DAT](INFO): Starting
2020-05-29T20:46:03.903Z,1590785163.903 [DAT](INFO): Starting
2020-05-29T20:46:03.905Z,1590785163.905 [DAT](INFO): unknown deviceResponse_: Teledyne Benthos DAT-900 Series

2020-05-29T20:46:04.287Z,1590785164.287 [DAT](INFO): Starting
2020-05-29T20:46:04.650Z,1590785164.650 [CommandLine](IMPORTANT): got command show stack
2020-05-29T20:46:04.650Z,1590785164.650 [CommandLine](IMPORTANT): Behavior Stack:

2020-05-29T20:46:04.650Z,1590785164.650 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2020-05-29T20:46:04.650Z,1590785164.650 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B
2020-05-29T20:46:04.724Z,1590785164.724 [DAT](INFO): Starting
2020-05-29T20:46:05.093Z,1590785165.093 [DAT](INFO): Starting
2020-05-29T20:46:05.498Z,1590785165.498 [DAT](INFO): Starting
2020-05-29T20:46:05.499Z,1590785165.499 [DAT](INFO): unknown deviceResponse_: MF Frequency Band

2020-05-29T20:46:05.501Z,1590785165.501 [DAT](INFO): unknown deviceResponse_: Directional Acoustic Transponder version 8.14.0

2020-05-29T20:46:05.501Z,1590785165.501 [DAT](INFO): unknown deviceResponse_: May 29 2020 20:44:09 

2020-05-29T20:46:05.900Z,1590785165.900 [DAT](INFO): Starting
2020-05-29T20:46:06.324Z,1590785166.324 [DAT](INFO): Starting
2020-05-29T20:46:06.326Z,1590785166.326 [DAT](INFO): unknown deviceResponse_: Features enabled [Bearing]

2020-05-29T20:46:06.709Z,1590785166.709 [DAT](INFO): Starting
2020-05-29T20:46:06.711Z,1590785166.711 [DAT](INFO): commRate: 800
2020-05-29T20:46:06.711Z,1590785166.711 [DAT](INFO): unknown deviceResponse_: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2020-05-29T20:46:06.712Z,1590785166.712 [DAT](INFO): commRate: 800
2020-05-29T20:46:07.114Z,1590785167.114 [DAT](INFO): Starting
2020-05-29T20:46:07.115Z,1590785167.115 [DAT](INFO): commRate: 800
2020-05-29T20:46:07.517Z,1590785167.517 [DAT](INFO): Starting
2020-05-29T20:46:07.518Z,1590785167.518 [DAT](INFO): commRate: 800
2020-05-29T20:46:07.935Z,1590785167.935 [DAT](INFO): Starting
2020-05-29T20:46:07.936Z,1590785167.936 [DAT](INFO): commRate: 800
2020-05-29T20:46:08.337Z,1590785168.337 [DAT](INFO): Starting
2020-05-29T20:46:08.338Z,1590785168.338 [DAT](INFO): commRate: 800
2020-05-29T20:46:08.684Z,1590785168.684 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200528T162828/Courier0004.lzma
2020-05-29T20:46:08.748Z,1590785168.748 [DAT](INFO): Starting
2020-05-29T20:46:08.749Z,1590785168.749 [DAT](INFO): commRate: 800
2020-05-29T20:46:09.147Z,1590785169.147 [DAT](INFO): Starting
2020-05-29T20:46:09.147Z,1590785169.147 [DAT](INFO): commRate: 800
2020-05-29T20:46:09.539Z,1590785169.539 [DAT](INFO): Starting
2020-05-29T20:46:09.540Z,1590785169.540 [DAT](INFO): commRate: 800
2020-05-29T20:46:09.687Z,1590785169.687 [DataOverHttps](INFO): Moved sent file to Logs/20200528T162828/Courier0004.lzma.bak
2020-05-29T20:46:09.687Z,1590785169.687 [DataOverHttps](INFO): SBD MOMSN=12356629
2020-05-29T20:46:09.948Z,1590785169.948 [DAT](INFO): Starting
2020-05-29T20:46:09.949Z,1590785169.949 [DAT](INFO): commRate: 800
2020-05-29T20:46:10.345Z,1590785170.345 [DAT](INFO): Starting
2020-05-29T20:46:10.346Z,1590785170.346 [DAT](INFO): commRate: 800
2020-05-29T20:46:10.750Z,1590785170.750 [DAT](INFO): Starting
2020-05-29T20:46:10.750Z,1590785170.750 [DAT](INFO): commRate: 800
2020-05-29T20:46:11.154Z,1590785171.154 [DAT](INFO): Starting
2020-05-29T20:46:11.154Z,1590785171.154 [DAT](INFO): commRate: 800
2020-05-29T20:46:11.562Z,1590785171.562 [DAT](INFO): Starting
2020-05-29T20:46:11.563Z,1590785171.563 [DAT](INFO): commRate: 800
2020-05-29T20:46:11.962Z,1590785171.962 [DAT](INFO): Starting
2020-05-29T20:46:11.963Z,1590785171.963 [DAT](INFO): commRate: 800
2020-05-29T20:46:12.365Z,1590785172.365 [DAT](INFO): Starting
2020-05-29T20:46:12.365Z,1590785172.365 [DAT](INFO): commRate: 800
2020-05-29T20:46:12.605Z,1590785172.605 [CommandLine](IMPORTANT): got command stop
2020-05-29T20:46:12.770Z,1590785172.770 [DAT](INFO): Starting
2020-05-29T20:46:12.770Z,1590785172.770 [DAT](INFO): commRate: 800
2020-05-29T20:46:13.187Z,1590785173.187 [DAT](INFO): Starting
2020-05-29T20:46:13.187Z,1590785173.187 [DAT](INFO): commRate: 800
2020-05-29T20:46:13.595Z,1590785173.595 [DAT](INFO): Starting
2020-05-29T20:46:13.595Z,1590785173.595 [DAT](INFO): commRate: 800
2020-05-29T20:46:13.000Z,1590785174.000 [DAT](INFO): Starting
2020-05-29T20:46:14.000Z,1590785174.000 [DAT](INFO): commRate: 800
2020-05-29T20:46:14.390Z,1590785174.390 [CommandLine](IMPORTANT): got command quit
2020-05-29T20:46:14.405Z,1590785174.405 [DAT](INFO): Starting
2020-05-29T20:46:14.406Z,1590785174.406 [DAT](INFO): commRate: 800
2020-05-29T20:46:14.798Z,1590785174.798 [DAT](INFO): Starting
2020-05-29T20:46:14.798Z,1590785174.798 [DAT](INFO): commRate: 800
2020-05-29T20:46:15.200Z,1590785175.200 [DAT](INFO): Starting
2020-05-29T20:46:15.200Z,1590785175.200 [DAT](INFO): commRate: 800
2020-05-29T20:46:15.393Z,1590785175.393 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-29T20:46:15.393Z,1590785175.393 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:15.505Z,1590785175.505 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-05-29T20:46:15.505Z,1590785175.505 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:15.506Z,1590785175.506 [CommandLine](INFO): Join timeout helper Thread ID is 5978
2020-05-29T20:46:15.513Z,1590785175.513 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-05-29T20:46:15.513Z,1590785175.513 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:15.513Z,1590785175.513 [NavChartDb](INFO): Join timeout helper Thread ID is 5979
2020-05-29T20:46:15.597Z,1590785175.597 [DAT](INFO): Starting
2020-05-29T20:46:15.598Z,1590785175.598 [DAT](INFO): commRate: 800
2020-05-29T20:46:15.729Z,1590785175.729 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-29T20:46:15.729Z,1590785175.729 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:15.749Z,1590785175.749 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-05-29T20:46:15.749Z,1590785175.749 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:15.749Z,1590785175.749 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5980
2020-05-29T20:46:16.002Z,1590785176.002 [DAT](INFO): Starting
2020-05-29T20:46:16.002Z,1590785176.002 [DAT](INFO): commRate: 800
2020-05-29T20:46:16.045Z,1590785176.045 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-29T20:46:16.046Z,1590785176.046 [WetLabsBB2FL](INFO): Powering down
2020-05-29T20:46:16.047Z,1590785176.047 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:16.057Z,1590785176.057 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-05-29T20:46:16.057Z,1590785176.057 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:16.057Z,1590785176.057 [Radio_Surface](INFO): Join timeout helper Thread ID is 5981
2020-05-29T20:46:16.257Z,1590785176.257 [Radio_Surface](INFO): Powering down
2020-05-29T20:46:16.258Z,1590785176.258 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-29T20:46:16.258Z,1590785176.258 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:16.269Z,1590785176.269 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-05-29T20:46:16.269Z,1590785176.269 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:16.269Z,1590785176.269 [DataOverHttps](INFO): Join timeout helper Thread ID is 5982
2020-05-29T20:46:16.419Z,1590785176.419 [DAT](INFO): Starting
2020-05-29T20:46:16.420Z,1590785176.420 [DAT](INFO): commRate: 800
2020-05-29T20:46:16.985Z,1590785176.985 [DAT](INFO): Starting
2020-05-29T20:46:16.985Z,1590785176.985 [DAT](INFO): commRate: 800
2020-05-29T20:46:17.361Z,1590785177.361 [DAT](INFO): Starting
2020-05-29T20:46:17.361Z,1590785177.361 [DAT](INFO): commRate: 800
2020-05-29T20:46:17.767Z,1590785177.767 [DAT](INFO): Starting
2020-05-29T20:46:17.768Z,1590785177.768 [DAT](INFO): commRate: 800
2020-05-29T20:46:18.188Z,1590785178.188 [DAT](INFO): Starting
2020-05-29T20:46:18.188Z,1590785178.188 [DAT](INFO): commRate: 800
2020-05-29T20:46:18.200Z,1590785178.200 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-29T20:46:18.216Z,1590785178.216 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:18.218Z,1590785178.218 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-05-29T20:46:18.218Z,1590785178.218 [logger ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:18.218Z,1590785178.218 [logger](INFO): Join timeout helper Thread ID is 5983
2020-05-29T20:46:18.221Z,1590785178.221 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-29T20:46:18.221Z,1590785178.221 [logger ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:18.230Z,1590785178.230 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-05-29T20:46:18.230Z,1590785178.230 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:18.230Z,1590785178.230 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-05-29T20:46:18.230Z,1590785178.230 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:18.230Z,1590785178.230 [controlThread](INFO): Join timeout helper Thread ID is 5984
2020-05-29T20:46:18.237Z,1590785178.237 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-05-29T20:46:18.237Z,1590785178.237 [controlThread](DEBUG): Uninitializing ControlThread
2020-05-29T20:46:18.238Z,1590785178.238 [NAL9602](INFO): Powering down
2020-05-29T20:46:18.239Z,1590785178.239 [DAT](INFO): uninitialize
2020-05-29T20:46:18.239Z,1590785178.239 [DAT](INFO): Powering down
2020-05-29T20:46:18.383Z,1590785178.383 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-05-29T20:46:18.384Z,1590785178.384 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-05-29T20:46:18.405Z,1590785178.405 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-05-29T20:46:18.406Z,1590785178.406 [MissionManager](INFO): Uninitializing Mission Default
2020-05-29T20:46:18.408Z,1590785178.408 [MissionManager](INFO): Uninitializing Mission Startup
2020-05-29T20:46:18.409Z,1590785178.409 [Startup] Stopped
2020-05-29T20:46:18.409Z,1590785178.409 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-05-29T20:46:18.409Z,1590785178.409 [Startup:A.GoToSurface] Stopped
2020-05-29T20:46:18.409Z,1590785178.409 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-05-29T20:46:18.409Z,1590785178.409 [Startup:StartupSatComms] Stopped
2020-05-29T20:46:18.409Z,1590785178.409 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-05-29T20:46:18.409Z,1590785178.409 [Startup:StartupSatComms:B] Stopped
2020-05-29T20:46:18.417Z,1590785178.417 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-05-29T20:46:18.417Z,1590785178.417 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-05-29T20:46:18.418Z,1590785178.418 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-05-29T20:46:18.418Z,1590785178.418 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-05-29T20:46:18.419Z,1590785178.419 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-05-29T20:46:18.419Z,1590785178.419 [BuoyancyServo](INFO): Powering down
2020-05-29T20:46:18.433Z,1590785178.433 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-05-29T20:46:18.433Z,1590785178.433 [ElevatorServo](INFO): Powering down
2020-05-29T20:46:18.434Z,1590785178.434 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-05-29T20:46:18.434Z,1590785178.434 [MassServo](INFO): Powering down
2020-05-29T20:46:18.435Z,1590785178.435 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-05-29T20:46:18.435Z,1590785178.435 [RudderServo](INFO): Powering down
2020-05-29T20:46:18.436Z,1590785178.436 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-05-29T20:46:18.436Z,1590785178.436 [ThrusterServo](INFO): Powering down
2020-05-29T20:46:18.437Z,1590785178.437 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-05-29T20:46:18.438Z,1590785178.438 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-05-29T20:46:18.438Z,1590785178.438 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-05-29T20:46:18.438Z,1590785178.438 [CBIT](DEBUG): Powering off loads.
2020-05-29T20:46:18.453Z,1590785178.453 [CBIT](DEBUG): Disabling WDT.
2020-05-29T20:46:18.465Z,1590785178.465 [CBIT](DEBUG): Opening all GF detection circuits.
2020-05-29T20:46:18.466Z,1590785178.466 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:18.832Z,1590785178.832 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:18.853Z,1590785178.853 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:19.034Z,1590785179.034 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:19.144Z,1590785179.144 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-05-29T20:46:19.439Z,1590785179.439 [logger ThreadHandler](INFO): Thread cancelled.