2020-08-25T15:30:07.348Z,1598369407.348 [Supervisor](DEBUG): Initializing supervisor.
2020-08-25T15:30:07.351Z,1598369407.351 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-08-25T15:30:07.351Z,1598369407.351 [SyncHandler](INFO): Protected caller Thread ID is 1228
2020-08-25T15:30:07.352Z,1598369407.352 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-08-25T15:30:07.353Z,1598369407.353 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-08-25T15:30:07.353Z,1598369407.353 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1229
2020-08-25T15:30:07.356Z,1598369407.356 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-08-25T15:30:07.368Z,1598369407.368 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-08-25T15:30:07.369Z,1598369407.369 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-08-25T15:30:07.370Z,1598369407.370 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1230
2020-08-25T15:30:07.370Z,1598369407.370 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-08-25T15:30:07.371Z,1598369407.371 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-08-25T15:30:07.371Z,1598369407.371 [logger ThreadHandler](INFO): Protected caller Thread ID is 1231
2020-08-25T15:30:07.373Z,1598369407.373 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-08-25T15:30:07.374Z,1598369407.374 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-08-25T15:30:07.375Z,1598369407.375 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-08-25T15:30:07.471Z,1598369407.471 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-08-25T15:30:07.472Z,1598369407.472 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-08-25T15:30:08.059Z,1598369408.059 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-08-25T15:30:08.060Z,1598369408.060 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-08-25T15:30:08.251Z,1598369408.251 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-08-25T15:30:08.251Z,1598369408.251 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-08-25T15:30:08.352Z,1598369408.352 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-08-25T15:30:08.352Z,1598369408.352 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-08-25T15:30:08.456Z,1598369408.456 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-08-25T15:30:08.457Z,1598369408.457 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-08-25T15:30:08.538Z,1598369408.538 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-08-25T15:30:08.675Z,1598369408.675 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-08-25T15:30:08.676Z,1598369408.676 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-08-25T15:30:08.962Z,1598369408.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-08-25T15:30:08.963Z,1598369408.963 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-08-25T15:30:09.413Z,1598369409.413 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-08-25T15:30:09.413Z,1598369409.413 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-08-25T15:30:09.556Z,1598369409.556 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-08-25T15:30:09.557Z,1598369409.557 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-08-25T15:30:09.743Z,1598369409.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-08-25T15:30:09.743Z,1598369409.743 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-08-25T15:30:10.205Z,1598369410.205 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-08-25T15:30:10.206Z,1598369410.206 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-08-25T15:30:10.420Z,1598369410.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-08-25T15:30:10.421Z,1598369410.421 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-08-25T15:30:10.622Z,1598369410.622 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-08-25T15:30:10.623Z,1598369410.623 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-08-25T15:30:11.027Z,1598369411.027 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-08-25T15:30:11.028Z,1598369411.028 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-08-25T15:30:11.355Z,1598369411.355 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-08-25T15:30:11.357Z,1598369411.357 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2020-08-25T15:30:11.358Z,1598369411.358 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2020-08-25T15:30:11.442Z,1598369411.442 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2020-08-25T15:30:11.609Z,1598369411.609 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2020-08-25T15:30:11.844Z,1598369411.844 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2020-08-25T15:30:11.947Z,1598369411.947 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2020-08-25T15:30:12.230Z,1598369412.230 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2020-08-25T15:30:12.589Z,1598369412.589 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2020-08-25T15:30:12.912Z,1598369412.912 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-08-25T15:30:12.912Z,1598369412.912 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2020-08-25T15:30:13.008Z,1598369413.008 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2020-08-25T15:30:13.108Z,1598369413.108 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2020-08-25T15:30:13.239Z,1598369413.239 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2020-08-25T15:30:13.339Z,1598369413.339 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-08-25T15:30:13.350Z,1598369413.350 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-08-25T15:30:13.427Z,1598369413.427 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-08-25T15:30:13.428Z,1598369413.428 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-08-25T15:30:13.476Z,1598369413.476 [VerticalControl](DEBUG): Construct VerticalControl.
2020-08-25T15:30:13.585Z,1598369413.585 [VerticalControl] Loaded
2020-08-25T15:30:13.586Z,1598369413.586 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-08-25T15:30:13.586Z,1598369413.586 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-08-25T15:30:13.665Z,1598369413.665 [HorizontalControl] Loaded
2020-08-25T15:30:13.665Z,1598369413.665 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-08-25T15:30:13.666Z,1598369413.666 [SpeedControl](DEBUG): Construct SpeedControl.
2020-08-25T15:30:13.671Z,1598369413.671 [SpeedControl] Loaded
2020-08-25T15:30:13.671Z,1598369413.671 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-08-25T15:30:13.672Z,1598369413.672 [LoopControl](DEBUG): Construct LoopControl.
2020-08-25T15:30:13.672Z,1598369413.672 [LoopControl] Loaded
2020-08-25T15:30:13.672Z,1598369413.672 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-08-25T15:30:13.673Z,1598369413.673 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-08-25T15:30:13.673Z,1598369413.673 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-08-25T15:30:13.714Z,1598369413.714 [DepthRateCalculator] Loaded
2020-08-25T15:30:13.714Z,1598369413.714 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-08-25T15:30:13.719Z,1598369413.719 [PitchRateCalculator] Loaded
2020-08-25T15:30:13.720Z,1598369413.720 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-08-25T15:30:13.735Z,1598369413.735 [SpeedCalculator] Loaded
2020-08-25T15:30:13.735Z,1598369413.735 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-08-25T15:30:13.756Z,1598369413.756 [TempGradientCalculator] Loaded
2020-08-25T15:30:13.756Z,1598369413.756 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-08-25T15:30:13.761Z,1598369413.761 [YawRateCalculator] Loaded
2020-08-25T15:30:13.761Z,1598369413.761 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-08-25T15:30:13.790Z,1598369413.790 [ElevatorOffsetCalculator] Loaded
2020-08-25T15:30:13.790Z,1598369413.790 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-08-25T15:30:13.790Z,1598369413.790 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-08-25T15:30:13.791Z,1598369413.791 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-08-25T15:30:13.817Z,1598369413.817 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-08-25T15:30:13.817Z,1598369413.817 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-08-25T15:30:13.902Z,1598369413.902 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-08-25T15:30:13.902Z,1598369413.902 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-08-25T15:30:14.192Z,1598369414.192 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-08-25T15:30:14.193Z,1598369414.193 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-08-25T15:30:14.293Z,1598369414.293 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-08-25T15:30:14.294Z,1598369414.294 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-08-25T15:30:14.640Z,1598369414.640 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-08-25T15:30:14.645Z,1598369414.645 [AHRS_M2](INFO): created writer for : platform_orientation
2020-08-25T15:30:14.647Z,1598369414.647 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-08-25T15:30:14.652Z,1598369414.652 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-08-25T15:30:14.653Z,1598369414.653 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-08-25T15:30:14.658Z,1598369414.658 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-08-25T15:30:14.658Z,1598369414.658 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-08-25T15:30:14.664Z,1598369414.664 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-08-25T15:30:14.734Z,1598369414.734 [AHRS_M2] Loaded
2020-08-25T15:30:14.735Z,1598369414.735 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-08-25T15:30:14.810Z,1598369414.810 [DataOverHttps] Loaded
2020-08-25T15:30:14.810Z,1598369414.810 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-08-25T15:30:14.811Z,1598369414.811 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090D4E0
2020-08-25T15:30:14.812Z,1598369414.812 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1313
2020-08-25T15:30:14.842Z,1598369414.842 [Depth_Keller] Loaded
2020-08-25T15:30:14.842Z,1598369414.842 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-08-25T15:30:14.956Z,1598369414.956 [NAL9602] Loaded
2020-08-25T15:30:14.956Z,1598369414.956 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-08-25T15:30:15.004Z,1598369415.004 [Onboard] Loaded
2020-08-25T15:30:15.005Z,1598369415.005 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-08-25T15:30:15.006Z,1598369415.006 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093D4E0
2020-08-25T15:30:15.006Z,1598369415.006 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1314
2020-08-25T15:30:15.025Z,1598369415.025 [Radio_Surface] Loaded
2020-08-25T15:30:15.025Z,1598369415.025 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-08-25T15:30:15.027Z,1598369415.027 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096D4E0
2020-08-25T15:30:15.027Z,1598369415.027 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1315
2020-08-25T15:30:15.051Z,1598369415.051 [DAT](CRITICAL): No configuration setting for: DAT.maxAckTimeouts
2020-08-25T15:30:15.178Z,1598369415.178 [DAT] Loaded
2020-08-25T15:30:15.179Z,1598369415.179 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-08-25T15:30:16.689Z,1598369416.689 [BPC1] Loaded
2020-08-25T15:30:16.689Z,1598369416.689 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-08-25T15:30:16.722Z,1598369416.722 [AMEcho] Loaded
2020-08-25T15:30:16.722Z,1598369416.722 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2020-08-25T15:30:16.722Z,1598369416.722 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-08-25T15:30:16.723Z,1598369416.723 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-08-25T15:30:17.068Z,1598369417.068 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-08-25T15:30:17.068Z,1598369417.068 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-08-25T15:30:17.138Z,1598369417.138 [NavChart] Loaded
2020-08-25T15:30:17.138Z,1598369417.138 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-08-25T15:30:17.142Z,1598369417.142 [UniversalFixResidualReporter] Loaded
2020-08-25T15:30:17.142Z,1598369417.142 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-08-25T15:30:17.163Z,1598369417.163 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-08-25T15:30:17.163Z,1598369417.163 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-08-25T15:30:17.303Z,1598369417.303 [SBIT](DEBUG): Construct Startup Built In Test.
2020-08-25T15:30:17.314Z,1598369417.314 [SBIT] Loaded
2020-08-25T15:30:17.314Z,1598369417.314 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-08-25T15:30:17.315Z,1598369417.315 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-08-25T15:30:17.327Z,1598369417.327 [IBIT] Loaded
2020-08-25T15:30:17.328Z,1598369417.328 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-08-25T15:30:17.331Z,1598369417.331 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-08-25T15:30:17.467Z,1598369417.467 [CBIT] Loaded
2020-08-25T15:30:17.468Z,1598369417.468 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-08-25T15:30:17.468Z,1598369417.468 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-08-25T15:30:17.469Z,1598369417.469 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-08-25T15:30:17.590Z,1598369417.590 [BuoyancyServo] Loaded
2020-08-25T15:30:17.590Z,1598369417.590 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-08-25T15:30:17.618Z,1598369417.618 [ElevatorServo] Loaded
2020-08-25T15:30:17.618Z,1598369417.618 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-08-25T15:30:17.646Z,1598369417.646 [MassServo] Loaded
2020-08-25T15:30:17.646Z,1598369417.646 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-08-25T15:30:17.674Z,1598369417.674 [RudderServo] Loaded
2020-08-25T15:30:17.674Z,1598369417.674 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-08-25T15:30:17.700Z,1598369417.700 [ThrusterServo] Loaded
2020-08-25T15:30:17.701Z,1598369417.701 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-08-25T15:30:17.701Z,1598369417.701 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-08-25T15:30:17.702Z,1598369417.702 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-08-25T15:30:17.720Z,1598369417.720 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-08-25T15:30:17.720Z,1598369417.720 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-08-25T15:30:17.959Z,1598369417.959 [BackSeatDriver] Loaded
2020-08-25T15:30:17.960Z,1598369417.960 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread.
2020-08-25T15:30:17.961Z,1598369417.961 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40B034E0
2020-08-25T15:30:17.961Z,1598369417.961 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 1316
2020-08-25T15:30:17.989Z,1598369417.989 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-08-25T15:30:17.995Z,1598369417.995 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-08-25T15:30:17.995Z,1598369417.995 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-08-25T15:30:18.000Z,1598369418.000 [CTD_Seabird](INFO): created writer for : depth
2020-08-25T15:30:18.001Z,1598369418.001 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-08-25T15:30:18.005Z,1598369418.005 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-08-25T15:30:18.006Z,1598369418.006 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-08-25T15:30:18.011Z,1598369418.011 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-08-25T15:30:18.012Z,1598369418.012 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-08-25T15:30:18.018Z,1598369418.018 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-08-25T15:30:18.019Z,1598369418.019 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-08-25T15:30:18.024Z,1598369418.024 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-08-25T15:30:18.024Z,1598369418.024 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-08-25T15:30:18.030Z,1598369418.030 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-08-25T15:30:18.057Z,1598369418.057 [CTD_Seabird] Loaded
2020-08-25T15:30:18.057Z,1598369418.057 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-08-25T15:30:18.058Z,1598369418.058 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B334E0
2020-08-25T15:30:18.059Z,1598369418.059 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1317
2020-08-25T15:30:18.081Z,1598369418.081 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-08-25T15:30:18.081Z,1598369418.081 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-08-25T15:30:18.086Z,1598369418.086 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-08-25T15:30:18.086Z,1598369418.086 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-08-25T15:30:18.090Z,1598369418.090 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-08-25T15:30:18.090Z,1598369418.090 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-08-25T15:30:18.094Z,1598369418.094 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-08-25T15:30:18.095Z,1598369418.095 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-08-25T15:30:18.099Z,1598369418.099 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-08-25T15:30:18.099Z,1598369418.099 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-08-25T15:30:18.103Z,1598369418.103 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-08-25T15:30:18.103Z,1598369418.103 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-08-25T15:30:18.108Z,1598369418.108 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-08-25T15:30:18.108Z,1598369418.108 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-08-25T15:30:18.112Z,1598369418.112 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-08-25T15:30:18.117Z,1598369418.117 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-08-25T15:30:18.117Z,1598369418.117 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-25T15:30:18.117Z,1598369418.117 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-25T15:30:18.122Z,1598369418.122 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-25T15:30:18.122Z,1598369418.122 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-25T15:30:18.126Z,1598369418.126 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-25T15:30:18.126Z,1598369418.126 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-25T15:30:18.131Z,1598369418.131 [WetLabsBB2FL] Loaded
2020-08-25T15:30:18.131Z,1598369418.131 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-08-25T15:30:18.132Z,1598369418.132 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B634E0
2020-08-25T15:30:18.132Z,1598369418.132 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1318
2020-08-25T15:30:18.133Z,1598369418.133 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-08-25T15:30:18.137Z,1598369418.137 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-08-25T15:30:18.137Z,1598369418.137 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-08-25T15:30:18.144Z,1598369418.144 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-08-25T15:30:18.145Z,1598369418.145 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B934E0
2020-08-25T15:30:18.145Z,1598369418.145 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1319
2020-08-25T15:30:18.150Z,1598369418.150 [Supervisor](INFO): Main Thread ID is 715
2020-08-25T15:30:18.150Z,1598369418.150 [Supervisor](DEBUG): Running supervisor.
2020-08-25T15:30:18.150Z,1598369418.150 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1320
2020-08-25T15:30:18.154Z,1598369418.154 [controlThread ThreadHandler](INFO): Handler Thread ID is 1321
2020-08-25T15:30:18.154Z,1598369418.154 [controlThread](DEBUG): Initializing ControlThread
2020-08-25T15:30:18.155Z,1598369418.155 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-08-25T15:30:18.157Z,1598369418.157 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-08-25T15:30:18.157Z,1598369418.157 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-08-25T15:30:18.158Z,1598369418.158 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-08-25T15:30:18.158Z,1598369418.158 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-08-25T15:30:18.159Z,1598369418.159 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-08-25T15:30:18.159Z,1598369418.159 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-08-25T15:30:18.159Z,1598369418.159 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-08-25T15:30:18.160Z,1598369418.160 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-08-25T15:30:18.160Z,1598369418.160 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-08-25T15:30:18.164Z,1598369418.164 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-08-25T15:30:18.164Z,1598369418.164 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-08-25T15:30:18.164Z,1598369418.164 [SBIT](INFO): Initialize SBIT Component.
2020-08-25T15:30:18.165Z,1598369418.165 [SBIT](IMPORTANT): git: 2020-08-18a-31-gbd628322e
2020-08-25T15:30:18.165Z,1598369418.165 [SBIT](INFO): git hash: bd628322e6debfac9e6880a33269f73ad5816ff1
2020-08-25T15:30:18.165Z,1598369418.165 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-08-25T15:30:18.167Z,1598369418.167 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2020-08-25T15:30:18.168Z,1598369418.168 [SBIT](INFO): Beginning SBIT in 65.000000 seconds.
2020-08-25T15:30:18.168Z,1598369418.168 [IBIT](INFO): Initialize IBIT Component.
2020-08-25T15:30:18.169Z,1598369418.169 [CBIT](DEBUG): Initialize CBIT Component.
2020-08-25T15:30:18.170Z,1598369418.170 [logger ThreadHandler](INFO): Handler Thread ID is 1322
2020-08-25T15:30:18.182Z,1598369418.182 [CBIT](DEBUG): Initialized mux pins.
2020-08-25T15:30:18.183Z,1598369418.183 [CBIT](DEBUG): Initializing the watchdog timer.
2020-08-25T15:30:18.187Z,1598369418.187 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1323
2020-08-25T15:30:18.188Z,1598369418.188 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-08-25T15:30:18.195Z,1598369418.195 [Onboard ThreadHandler](INFO): Handler Thread ID is 1324
2020-08-25T15:30:18.207Z,1598369418.207 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-08-25T15:30:18.207Z,1598369418.207 [CBIT](DEBUG): Initializing heartbeat.
2020-08-25T15:30:18.217Z,1598369418.217 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1325
2020-08-25T15:30:18.239Z,1598369418.239 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 1326
2020-08-25T15:30:18.251Z,1598369418.251 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1327
2020-08-25T15:30:18.251Z,1598369418.251 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-08-25T15:30:18.256Z,1598369418.256 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1329
2020-08-25T15:30:18.257Z,1598369418.257 [WetLabsBB2FL](INFO): Powering down
2020-08-25T15:30:18.278Z,1598369418.278 [CBIT](DEBUG): Deactivating GF circuits.
2020-08-25T15:30:18.278Z,1598369418.278 [CBIT](DEBUG): Deactivating emergency mode.
2020-08-25T15:30:18.291Z,1598369418.291 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1330
2020-08-25T15:30:18.294Z,1598369418.294 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-08-25T15:30:18.294Z,1598369418.294 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-08-25T15:30:18.294Z,1598369418.294 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-08-25T15:30:18.294Z,1598369418.294 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-08-25T15:30:18.294Z,1598369418.294 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-08-25T15:30:18.295Z,1598369418.295 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-08-25T15:30:18.295Z,1598369418.295 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-08-25T15:30:18.295Z,1598369418.295 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-08-25T15:30:18.295Z,1598369418.295 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-08-25T15:30:18.295Z,1598369418.295 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-08-25T15:30:18.295Z,1598369418.295 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-08-25T15:30:18.295Z,1598369418.295 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-08-25T15:30:18.296Z,1598369418.296 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-08-25T15:30:18.296Z,1598369418.296 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-08-25T15:30:18.296Z,1598369418.296 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-08-25T15:30:18.296Z,1598369418.296 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-08-25T15:30:18.314Z,1598369418.314 [CBIT](DEBUG): Backplane powered.
2020-08-25T15:30:18.316Z,1598369418.316 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-08-25T15:30:18.326Z,1598369418.326 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-25T15:30:18.337Z,1598369418.337 [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-08-25T15:30:18.337Z,1598369418.337 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-08-25T15:30:18.413Z,1598369418.413 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-08-25T15:30:18.430Z,1598369418.430 [Default:A.Wait](DEBUG): Construct Wait.
2020-08-25T15:30:18.432Z,1598369418.432 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-25T15:30:18.462Z,1598369418.462 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-08-25T15:30:18.465Z,1598369418.465 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-08-25T15:30:18.498Z,1598369418.498 [Default:E.Execute](DEBUG): Construct Execute.
2020-08-25T15:30:18.502Z,1598369418.502 [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-08-25T15:30:18.507Z,1598369418.507 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,DAT,BPC1,AMEcho,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-08-25T15:30:18.522Z,1598369418.522 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-25T15:30:18.623Z,1598369418.623 [Radio_Surface](INFO): Powering up
2020-08-25T15:30:18.659Z,1598369418.659 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-25T15:30:18.679Z,1598369418.679 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-25T15:30:18.679Z,1598369418.679 [DAT](INFO): Powering up
2020-08-25T15:30:18.679Z,1598369418.679 [DAT](DEBUG): Initializing DAT.
2020-08-25T15:30:18.727Z,1598369418.727 [AMEcho](INFO): Powering up
2020-08-25T15:30:18.760Z,1598369418.760 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-08-25T15:30:18.767Z,1598369418.767 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-08-25T15:30:18.768Z,1598369418.768 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-08-25T15:30:18.779Z,1598369418.779 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-08-25T15:30:18.780Z,1598369418.780 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-25T15:30:18.791Z,1598369418.791 [MassServo](DEBUG): Initializing MassServo.
2020-08-25T15:30:18.792Z,1598369418.792 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-25T15:30:18.807Z,1598369418.807 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-25T15:30:18.808Z,1598369418.808 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-08-25T15:30:18.815Z,1598369418.815 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-08-25T15:30:18.817Z,1598369418.817 [CommandLine](FAULT): Scheduling is paused
2020-08-25T15:30:18.817Z,1598369418.817 [CBIT](INFO): Critical error at 20200825T153015
2020-08-25T15:30:18.818Z,1598369418.818 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-08-25T15:30:19.634Z,1598369419.634 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-08-25T15:30:19.635Z,1598369419.635 [RudderServo](FAULT): Rudder failed to initialize
2020-08-25T15:30:19.635Z,1598369419.635 [RudderServo] Communications Fault, FailCount= 1
2020-08-25T15:30:19.635Z,1598369419.635 [RudderServo](ERROR): Communications Fault
2020-08-25T15:30:19.758Z,1598369419.758 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-08-25T15:30:19.911Z,1598369419.911 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-25T15:30:19.912Z,1598369419.912 [RudderServo](INFO): Powering down
2020-08-25T15:30:20.586Z,1598369420.586 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-25T15:30:20.703Z,1598369420.703 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-25T15:30:20.707Z,1598369420.707 [CBIT](INFO): Clearing failed state for component RudderServo
2020-08-25T15:30:20.708Z,1598369420.708 [RudderServo] No Fault, FailCount= 1
2020-08-25T15:30:31.085Z,1598369431.085 [DAT](INFO): commRate: 800
2020-08-25T15:30:31.086Z,1598369431.086 [DAT](INFO): commRate: 800
2020-08-25T15:30:31.488Z,1598369431.488 [DAT](INFO): entering command mode
2020-08-25T15:30:31.892Z,1598369431.892 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:32.059Z,1598369432.059 [AMEcho](INFO): Powering down
2020-08-25T15:30:32.296Z,1598369432.296 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:32.700Z,1598369432.700 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:33.104Z,1598369433.104 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:33.508Z,1598369433.508 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:33.912Z,1598369433.912 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:34.316Z,1598369434.316 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:34.720Z,1598369434.720 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:35.124Z,1598369435.124 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:35.528Z,1598369435.528 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:35.932Z,1598369435.932 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:36.336Z,1598369436.336 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:36.740Z,1598369436.740 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:37.144Z,1598369437.144 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:37.548Z,1598369437.548 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:37.952Z,1598369437.952 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:38.356Z,1598369438.356 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:38.760Z,1598369438.760 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:39.164Z,1598369439.164 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:39.568Z,1598369439.568 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:39.972Z,1598369439.972 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:40.380Z,1598369440.380 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:40.784Z,1598369440.784 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:41.184Z,1598369441.184 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:41.588Z,1598369441.588 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:41.988Z,1598369441.988 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:42.400Z,1598369442.400 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:42.813Z,1598369442.813 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:43.200Z,1598369443.200 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:43.608Z,1598369443.608 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:44.012Z,1598369444.012 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:44.412Z,1598369444.412 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:44.824Z,1598369444.824 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:45.232Z,1598369445.232 [NAL9602](INFO): Powering up NAL9602
2020-08-25T15:30:45.233Z,1598369445.233 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:45.628Z,1598369445.628 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:46.044Z,1598369446.044 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:46.436Z,1598369446.436 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:46.840Z,1598369446.840 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-25T15:30:46.840Z,1598369446.840 [DAT](FAULT): failed to enter command mode
2020-08-25T15:30:47.244Z,1598369447.244 [DAT](INFO): entering command mode
2020-08-25T15:30:47.661Z,1598369447.661 [DAT](INFO): setting verbose to 3
2020-08-25T15:30:48.049Z,1598369448.049 [DAT](INFO): set verbose to 3
2020-08-25T15:30:48.049Z,1598369448.049 [DAT](INFO): setting DatVerbose to 27440
2020-08-25T15:30:48.457Z,1598369448.457 [DAT](INFO): set DatVerbose to 27440
2020-08-25T15:30:48.457Z,1598369448.457 [DAT](INFO): setting transmit power to 8
2020-08-25T15:30:48.869Z,1598369448.869 [DAT](INFO): set transmit power to 8
2020-08-25T15:30:48.869Z,1598369448.869 [DAT](INFO): setting local address to 9
2020-08-25T15:30:49.266Z,1598369449.266 [DAT](INFO): set local address to 9
2020-08-25T15:30:56.136Z,1598369456.136 [NAL9602](INFO): NAL9602 initialized
2020-08-25T15:31:23.634Z,1598369483.634 [SBIT](IMPORTANT): Beginning Startup BIT
2020-08-25T15:31:23.638Z,1598369483.638 [CBIT](IMPORTANT): Beginning ground fault scan
2020-08-25T15:31:34.567Z,1598369494.567 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.009184
CHAN A1 (24V): 0.000753
CHAN A2 (12V): -0.007206
CHAN A3 (5V): -0.002213
CHAN B0 (3.3V): 0.000143
CHAN B1 (3.15aV): -0.000554
CHAN B2 (3.15bV): -0.000169
CHAN B3 (GND): 0.001830
OPEN: 0.005321
Full Scale Calc: 4.765 mA, -1.589 mA
2020-08-25T15:32:17.763Z,1598369537.763 [SBIT](IMPORTANT): SBIT PASSED
2020-08-25T15:32:17.763Z,1598369537.763 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-08-25T15:32:17.765Z,1598369537.765 [SBIT](IMPORTANT): BackSeatDriver.loadAtStartup=1 bool;

2020-08-25T15:32:17.765Z,1598369537.765 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere;

2020-08-25T15:32:17.765Z,1598369537.765 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2020-08-25T15:32:17.765Z,1598369537.765 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent;

2020-08-25T15:32:17.768Z,1598369537.768 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second;

2020-08-25T15:32:17.768Z,1598369537.768 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2020-08-25T15:32:17.768Z,1598369537.768 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=0 bool;

2020-08-25T15:32:17.768Z,1598369537.768 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=344.685708 cubic_centimeter;

2020-08-25T15:32:17.768Z,1598369537.768 [SBIT](IMPORTANT): VerticalControl.massDefault=11.293600 millimeter;

2020-08-25T15:32:17.768Z,1598369537.768 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool;

2020-08-25T15:32:18.151Z,1598369538.151 [MissionManager](IMPORTANT): Started mission Startup
2020-08-25T15:32:18.151Z,1598369538.151 [Startup] Running Loop=1
2020-08-25T15:32:18.152Z,1598369538.152 [Startup](DEBUG): Aggregate::initialize Startup
2020-08-25T15:32:18.152Z,1598369538.152 [Startup:A.GoToSurface] Running Loop=1
2020-08-25T15:32:18.152Z,1598369538.152 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-25T15:32:18.152Z,1598369538.152 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-25T15:32:18.153Z,1598369538.153 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-25T15:32:18.153Z,1598369538.153 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-25T15:32:18.154Z,1598369538.154 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-25T15:32:18.154Z,1598369538.154 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-25T15:32:18.155Z,1598369538.155 [Startup:StartupSatComms] Running Loop=1
2020-08-25T15:32:18.155Z,1598369538.155 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-08-25T15:32:18.155Z,1598369538.155 [Startup:StartupSatComms:A] Running Loop=1
2020-08-25T15:32:18.556Z,1598369538.556 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-08-25T15:32:18.957Z,1598369538.957 [AMEcho](INFO): Powering up
2020-08-25T15:32:31.482Z,1598369551.482 [AMEcho](INFO): 
2020-08-25T15:32:31.886Z,1598369551.886 [AMEcho](INFO): AIRMAR (R) Serial Flash Bootloader

2020-08-25T15:32:32.292Z,1598369552.292 [AMEcho](INFO): Copyright (C) 2005-2015 AIRMAR Technology Corp.

2020-08-25T15:32:32.708Z,1598369552.708 [AMEcho](INFO): All rights reserved.

2020-08-25T15:32:33.104Z,1598369553.104 [AMEcho](INFO): 

2020-08-25T15:32:33.501Z,1598369553.501 [AMEcho](INFO): 


2020-08-25T15:32:33.902Z,1598369553.902 [AMEcho](INFO): 

2020-08-25T15:32:34.311Z,1598369554.311 [AMEcho](INFO): $PAMTT,200m Mini Altimeter Kit (170kHz)

2020-08-25T15:32:34.711Z,1598369554.711 [AMEcho](INFO): $PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc.  All Rights Reserved.

2020-08-25T15:32:35.121Z,1598369555.121 [AMEcho](INFO): $PAMTT,POST,0,0,0,2,0,,0,0,,,,,,ER0183*47

2020-08-25T15:32:35.519Z,1598369555.519 [AMEcho](INFO): $PAMTT,QV,,0,0,,1.807,1.841,,*75

2020-08-25T15:32:35.923Z,1598369555.923 [AMEcho](INFO): $PAMTT,QPS,100438,201095-1,4*27

2020-08-25T15:32:36.327Z,1598369556.327 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:36.736Z,1598369556.736 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:37.134Z,1598369557.134 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:37.543Z,1598369557.543 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:37.943Z,1598369557.943 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:38.354Z,1598369558.354 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:38.889Z,1598369558.889 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:39.168Z,1598369559.168 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:39.584Z,1598369559.584 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:39.996Z,1598369559.996 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:40.774Z,1598369560.774 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:41.593Z,1598369561.593 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:42.790Z,1598369562.790 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:43.606Z,1598369563.606 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:44.814Z,1598369564.814 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:45.635Z,1598369565.635 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:46.834Z,1598369566.834 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:47.642Z,1598369567.642 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:48.863Z,1598369568.863 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:49.658Z,1598369569.658 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:50.484Z,1598369570.484 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:51.697Z,1598369571.697 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:52.522Z,1598369572.523 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:53.702Z,1598369573.702 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:54.510Z,1598369574.510 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:55.740Z,1598369575.740 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:32:56.544Z,1598369576.544 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:57.738Z,1598369577.738 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:58.551Z,1598369578.551 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:32:59.758Z,1598369579.758 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:33:00.586Z,1598369580.586 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:01.797Z,1598369581.797 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:02.586Z,1598369582.586 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:03.798Z,1598369583.798 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:04.606Z,1598369584.606 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:05.558Z,1598369585.558 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:06.656Z,1598369586.656 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:07.842Z,1598369587.842 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:08.668Z,1598369588.668 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:09.862Z,1598369589.862 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:33:10.666Z,1598369590.666 [AMEcho](INFO): $SDDBT,36.84,f,11.23,M,6.14,F*3D

2020-08-25T15:33:11.477Z,1598369591.477 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:12.683Z,1598369592.683 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:13.499Z,1598369593.499 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:14.713Z,1598369594.713 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:15.518Z,1598369595.518 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:16.730Z,1598369596.730 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:17.553Z,1598369597.553 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:18.442Z,1598369598.442 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-08-25T15:33:18.442Z,1598369598.442 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-25T15:33:18.444Z,1598369598.444 [Startup:StartupSatComms:A](INFO): Timed out from 2020-08-25T15:32:18.2Z
2020-08-25T15:33:18.444Z,1598369598.444 [Startup:StartupSatComms:A] Stopped
2020-08-25T15:33:18.444Z,1598369598.444 [Startup:StartupSatComms:B] Running Loop=1
2020-08-25T15:33:18.484Z,1598369598.484 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-25T15:33:18.821Z,1598369598.821 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:18.827Z,1598369598.827 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-08-25T15:33:18.836Z,1598369598.836 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-25T15:33:18.836Z,1598369598.836 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-08-25T15:33:19.588Z,1598369599.588 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:20.774Z,1598369600.774 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:21.574Z,1598369601.574 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:22.792Z,1598369602.792 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:23.591Z,1598369603.591 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:24.803Z,1598369604.803 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:25.614Z,1598369605.614 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:26.830Z,1598369606.830 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:27.639Z,1598369607.639 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:28.850Z,1598369608.850 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:29.659Z,1598369609.659 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:30.477Z,1598369610.477 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:31.678Z,1598369611.678 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:32.574Z,1598369612.574 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:33.698Z,1598369613.698 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:34.502Z,1598369614.502 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:35.725Z,1598369615.725 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:36.522Z,1598369616.522 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:37.738Z,1598369617.738 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:38.554Z,1598369618.554 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:39.768Z,1598369619.768 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:40.577Z,1598369620.577 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:41.409Z,1598369621.409 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004759
2020-08-25T15:33:41.785Z,1598369621.785 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:42.590Z,1598369622.590 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:43.798Z,1598369623.798 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:44.621Z,1598369624.621 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:45.567Z,1598369625.567 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:46.636Z,1598369626.636 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:47.834Z,1598369627.834 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:48.658Z,1598369628.658 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:48.942Z,1598369628.942 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200825T152347/Courier0007.lzma
2020-08-25T15:33:49.872Z,1598369629.872 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:49.945Z,1598369629.945 [DataOverHttps](INFO): Moved sent file to Logs/20200825T152347/Courier0007.lzma.bak
2020-08-25T15:33:49.945Z,1598369629.945 [DataOverHttps](INFO): SBD MOMSN=12614048
2020-08-25T15:33:50.684Z,1598369630.684 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:51.887Z,1598369631.887 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:52.682Z,1598369632.682 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:53.491Z,1598369633.491 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:54.707Z,1598369634.707 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:55.537Z,1598369635.537 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:56.726Z,1598369636.726 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:57.531Z,1598369637.531 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:58.770Z,1598369638.770 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:33:59.572Z,1598369639.572 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:00.772Z,1598369640.772 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:01.580Z,1598369641.580 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:02.782Z,1598369642.782 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:03.598Z,1598369643.598 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:04.013Z,1598369644.013 [CommandLine](IMPORTANT): got command configSet AMEcho.enabled 0.000000 bool
2020-08-25T15:34:04.397Z,1598369644.397 [AMEcho](ERROR): Setting 'enabled' to 0
2020-08-25T15:34:04.963Z,1598369644.963 [AMEcho](INFO): Powering down
2020-08-25T15:34:05.630Z,1598369645.630 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20200825T153007/Courier0000.lzma
2020-08-25T15:34:06.632Z,1598369646.632 [DataOverHttps](INFO): Moved sent file to Logs/20200825T153007/Courier0000.lzma.bak
2020-08-25T15:34:06.632Z,1598369646.632 [DataOverHttps](INFO): SBD MOMSN=12614055
2020-08-25T15:34:18.547Z,1598369658.547 [Startup:StartupSatComms:B](INFO): Timed out from 2020-08-25T15:33:18.4Z
2020-08-25T15:34:18.547Z,1598369658.547 [Startup:StartupSatComms:B] Stopped
2020-08-25T15:34:18.547Z,1598369658.547 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-08-25T15:34:18.547Z,1598369658.547 [Startup:StartupSatComms] Stopped
2020-08-25T15:34:18.547Z,1598369658.547 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-08-25T15:34:18.548Z,1598369658.548 [Startup](INFO): Completed Startup
2020-08-25T15:34:18.548Z,1598369658.548 [MissionManager](INFO): Startup is completed.
2020-08-25T15:34:18.548Z,1598369658.548 [MissionManager](INFO): Uninitializing Mission Startup
2020-08-25T15:34:18.549Z,1598369658.549 [Startup] Stopped
2020-08-25T15:34:18.549Z,1598369658.549 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-08-25T15:34:18.549Z,1598369658.549 [Startup:A.GoToSurface] Stopped
2020-08-25T15:34:18.549Z,1598369658.549 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-08-25T15:34:18.959Z,1598369658.959 [MissionManager](IMPORTANT): Started mission Default
2020-08-25T15:34:18.959Z,1598369658.959 [Default] Running Loop=1
2020-08-25T15:34:18.959Z,1598369658.959 [Default](DEBUG): Aggregate::initialize Default
2020-08-25T15:34:18.959Z,1598369658.959 [Default:B.GoToSurface] Running Loop=1
2020-08-25T15:34:18.959Z,1598369658.959 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-25T15:34:18.959Z,1598369658.959 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-25T15:34:18.960Z,1598369658.960 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-25T15:34:18.960Z,1598369658.960 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-25T15:34:18.960Z,1598369658.960 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-25T15:34:18.961Z,1598369658.961 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-25T15:34:18.961Z,1598369658.961 [Default:A.Wait] Running Loop=1
2020-08-25T15:34:18.961Z,1598369658.961 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-08-25T15:34:21.012Z,1598369661.012 [CommandLine](IMPORTANT): got command configSet AMEcho.enabled 1.000000 bool
2020-08-25T15:34:21.376Z,1598369661.376 [AMEcho](ERROR): Setting 'enabled' to 1
2020-08-25T15:34:21.784Z,1598369661.784 [AMEcho](INFO): Powering up
2020-08-25T15:34:25.435Z,1598369665.435 [DataOverHttps](INFO): Sending 358 bytes from file Logs/20200825T151723/Express0005.lzma
2020-08-25T15:34:26.440Z,1598369666.440 [DataOverHttps](INFO): Moved sent file to Logs/20200825T151723/Express0005.lzma.bak
2020-08-25T15:34:26.440Z,1598369666.440 [DataOverHttps](INFO): SBD MOMSN=12614059
2020-08-25T15:34:32.346Z,1598369672.346 [Default:A.Wait](INFO): Done Waiting.
2020-08-25T15:34:32.346Z,1598369672.346 [Default:A.Wait] Stopped
2020-08-25T15:34:32.346Z,1598369672.346 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-08-25T15:34:32.745Z,1598369672.745 [Default:CheckIn] Running Loop=1
2020-08-25T15:34:32.745Z,1598369672.745 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-08-25T15:34:32.745Z,1598369672.745 [Default:CheckIn:Read_GPS] Running Loop=1
2020-08-25T15:34:33.148Z,1598369673.148 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-08-25T15:34:34.350Z,1598369674.350 [AMEcho](INFO): 
2020-08-25T15:34:34.756Z,1598369674.756 [AMEcho](INFO): AIRMAR (R) Serial Flash Bootloader

2020-08-25T15:34:35.155Z,1598369675.155 [AMEcho](INFO): Copyright (C) 2005-2015 AIRMAR Technology Corp.

2020-08-25T15:34:35.562Z,1598369675.562 [AMEcho](INFO): All rights reserved.

2020-08-25T15:34:35.961Z,1598369675.961 [AMEcho](INFO): 

2020-08-25T15:34:36.384Z,1598369676.384 [AMEcho](INFO): 


2020-08-25T15:34:36.788Z,1598369676.788 [AMEcho](INFO): 

2020-08-25T15:34:37.193Z,1598369677.193 [AMEcho](INFO): $PAMTT,200m Mini Altimeter Kit (170kHz)

2020-08-25T15:34:37.590Z,1598369677.590 [AMEcho](INFO): $PAMTT,Copyright (C) 2013-2019 AIRMAR Technology, Inc.  All Rights Reserved.

2020-08-25T15:34:37.987Z,1598369677.987 [AMEcho](INFO): $PAMTT,POST,0,0,0,2,0,,0,0,,,,,,ER0183*47

2020-08-25T15:34:38.397Z,1598369678.397 [AMEcho](INFO): $PAMTT,QV,,0,0,,1.807,1.841,,*75

2020-08-25T15:34:38.861Z,1598369678.861 [AMEcho](INFO): $PAMTT,QPS,100438,201095-1,4*27

2020-08-25T15:34:39.206Z,1598369679.206 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:39.677Z,1598369679.677 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:40.024Z,1598369680.024 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:40.420Z,1598369680.420 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:40.828Z,1598369680.828 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:41.230Z,1598369681.230 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:41.629Z,1598369681.629 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:42.022Z,1598369682.022 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:42.430Z,1598369682.430 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:42.834Z,1598369682.834 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:43.638Z,1598369683.638 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:44.459Z,1598369684.459 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:45.676Z,1598369685.676 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:46.484Z,1598369686.484 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:47.682Z,1598369687.682 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:48.486Z,1598369688.486 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:49.299Z,1598369689.299 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:50.529Z,1598369690.529 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:51.319Z,1598369691.319 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:52.538Z,1598369692.538 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:53.341Z,1598369693.341 [CommandLine](IMPORTANT): got command report mod AMEcho.altitude
2020-08-25T15:34:53.372Z,1598369693.372 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:53.479Z,1598369693.479 [Reporter](INFO): AMEcho.altitude 11.300000 m
2020-08-25T15:34:54.561Z,1598369694.561 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:55.372Z,1598369695.372 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:56.578Z,1598369696.578 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:57.374Z,1598369697.374 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:58.586Z,1598369698.586 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:34:59.409Z,1598369699.409 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:00.607Z,1598369700.607 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:01.418Z,1598369701.418 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:02.640Z,1598369702.640 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:03.481Z,1598369703.481 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:04.650Z,1598369704.650 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:05.523Z,1598369705.523 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:06.341Z,1598369706.341 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:07.504Z,1598369707.504 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:08.305Z,1598369708.305 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:09.498Z,1598369709.498 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:10.315Z,1598369710.315 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:11.521Z,1598369711.521 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:12.364Z,1598369712.364 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:13.560Z,1598369713.560 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:14.346Z,1598369714.346 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:15.558Z,1598369715.558 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:16.369Z,1598369716.369 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:17.584Z,1598369717.584 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:18.404Z,1598369718.404 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:19.606Z,1598369719.606 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:20.413Z,1598369720.413 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:21.618Z,1598369721.618 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:22.422Z,1598369722.422 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:23.649Z,1598369723.648 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:24.499Z,1598369724.499 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:25.672Z,1598369725.672 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:26.466Z,1598369726.466 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:27.682Z,1598369727.682 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:28.493Z,1598369728.493 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:29.313Z,1598369729.313 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:30.502Z,1598369730.502 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:31.311Z,1598369731.311 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:32.528Z,1598369732.528 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:33.481Z,1598369733.481 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:34.568Z,1598369734.568 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:35.355Z,1598369735.355 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:36.564Z,1598369736.564 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:37.376Z,1598369737.376 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:38.593Z,1598369738.593 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:39.390Z,1598369739.390 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:40.606Z,1598369740.606 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:41.414Z,1598369741.414 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:42.622Z,1598369742.622 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:43.430Z,1598369743.430 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:44.650Z,1598369744.650 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:45.454Z,1598369745.454 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:46.676Z,1598369746.676 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:47.470Z,1598369747.470 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:48.692Z,1598369748.692 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:49.502Z,1598369749.502 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:50.312Z,1598369750.312 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:51.524Z,1598369751.524 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:52.322Z,1598369752.322 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:52.412Z,1598369752.412 [CommandLine](IMPORTANT): got command restart application
2020-08-25T15:35:53.415Z,1598369753.415 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:53.415Z,1598369753.415 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:53.442Z,1598369753.442 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-08-25T15:35:53.442Z,1598369753.442 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:53.443Z,1598369753.443 [CommandLine](INFO): Join timeout helper Thread ID is 1378
2020-08-25T15:35:53.444Z,1598369753.444 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-08-25T15:35:53.444Z,1598369753.444 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:53.444Z,1598369753.444 [NavChartDb](INFO): Join timeout helper Thread ID is 1379
2020-08-25T15:35:53.539Z,1598369753.539 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:53.663Z,1598369753.663 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:53.663Z,1598369753.663 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:53.670Z,1598369753.670 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-08-25T15:35:53.670Z,1598369753.670 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:53.671Z,1598369753.671 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1380
2020-08-25T15:35:54.063Z,1598369754.063 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:54.063Z,1598369754.063 [WetLabsBB2FL](INFO): Powering down
2020-08-25T15:35:54.064Z,1598369754.064 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:54.074Z,1598369754.074 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-08-25T15:35:54.074Z,1598369754.074 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:54.075Z,1598369754.075 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1381
2020-08-25T15:35:54.350Z,1598369754.350 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:54.627Z,1598369754.627 [CTD_Seabird](INFO): Powering down
2020-08-25T15:35:54.638Z,1598369754.638 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:54.639Z,1598369754.639 [CTD_Seabird](INFO): Powering down
2020-08-25T15:35:54.655Z,1598369754.655 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:54.658Z,1598369754.658 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler
2020-08-25T15:35:54.659Z,1598369754.659 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:54.659Z,1598369754.659 [BackSeatDriver](INFO): Join timeout helper Thread ID is 1382
2020-08-25T15:35:54.823Z,1598369754.823 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:54.824Z,1598369754.824 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:54.843Z,1598369754.843 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-08-25T15:35:54.843Z,1598369754.843 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:54.844Z,1598369754.844 [Radio_Surface](INFO): Join timeout helper Thread ID is 1383
2020-08-25T15:35:55.226Z,1598369755.226 [Radio_Surface](INFO): Powering down
2020-08-25T15:35:55.227Z,1598369755.227 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:55.228Z,1598369755.228 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:55.247Z,1598369755.247 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-08-25T15:35:55.247Z,1598369755.247 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:55.248Z,1598369755.248 [Onboard](INFO): Join timeout helper Thread ID is 1384
2020-08-25T15:35:55.399Z,1598369755.399 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-08-25T15:35:55.550Z,1598369755.550 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:56.362Z,1598369756.362 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:57.589Z,1598369757.589 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:58.414Z,1598369758.414 [AMEcho](INFO): $SDDBT,37.07,f,11.30,M,6.18,F*39

2020-08-25T15:35:58.466Z,1598369758.466 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:58.467Z,1598369758.467 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:58.471Z,1598369758.471 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-08-25T15:35:58.471Z,1598369758.471 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:58.472Z,1598369758.472 [DataOverHttps](INFO): Join timeout helper Thread ID is 1385
2020-08-25T15:35:58.834Z,1598369758.834 [CBIT](FAULT): Humidity exceeds 50% of running average: Humidity:2285304 %. Average:303220.093750
2020-08-25T15:35:59.192Z,1598369759.192 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-08-25T15:35:59.415Z,1598369759.415 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:59.415Z,1598369759.415 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:59.431Z,1598369759.431 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-08-25T15:35:59.431Z,1598369759.431 [logger ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:59.432Z,1598369759.432 [logger](INFO): Join timeout helper Thread ID is 1386
2020-08-25T15:35:59.438Z,1598369759.438 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:59.439Z,1598369759.439 [logger ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:59.451Z,1598369759.451 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-08-25T15:35:59.451Z,1598369759.451 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:59.451Z,1598369759.451 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-08-25T15:35:59.451Z,1598369759.451 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:35:59.452Z,1598369759.452 [controlThread](INFO): Join timeout helper Thread ID is 1387
2020-08-25T15:35:59.574Z,1598369759.574 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-25T15:35:59.575Z,1598369759.575 [controlThread](DEBUG): Uninitializing ControlThread
2020-08-25T15:35:59.575Z,1598369759.575 [AHRS_M2](INFO): Powering down
2020-08-25T15:35:59.647Z,1598369759.647 [NAL9602](INFO): Powering down
2020-08-25T15:35:59.648Z,1598369759.648 [DAT](INFO): Powering down
2020-08-25T15:35:59.934Z,1598369759.934 [AMEcho](INFO): Powering down
2020-08-25T15:35:59.936Z,1598369759.936 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-08-25T15:35:59.936Z,1598369759.936 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-08-25T15:35:59.937Z,1598369759.937 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-08-25T15:35:59.937Z,1598369759.937 [MissionManager](INFO): Uninitializing Mission Default
2020-08-25T15:35:59.937Z,1598369759.937 [Default] Stopped
2020-08-25T15:35:59.938Z,1598369759.938 [Default](DEBUG): Aggregate::uninitialize Default
2020-08-25T15:35:59.938Z,1598369759.938 [Default:B.GoToSurface] Stopped
2020-08-25T15:35:59.938Z,1598369759.938 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-08-25T15:35:59.938Z,1598369759.938 [Default:CheckIn] Stopped
2020-08-25T15:35:59.938Z,1598369759.938 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-08-25T15:35:59.938Z,1598369759.938 [Default:CheckIn:Read_GPS] Stopped
2020-08-25T15:35:59.941Z,1598369759.941 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-08-25T15:35:59.941Z,1598369759.941 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-08-25T15:35:59.941Z,1598369759.941 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-08-25T15:35:59.941Z,1598369759.941 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-08-25T15:35:59.942Z,1598369759.942 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-08-25T15:35:59.942Z,1598369759.942 [BuoyancyServo](INFO): Powering down
2020-08-25T15:35:59.954Z,1598369759.954 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-08-25T15:35:59.955Z,1598369759.955 [ElevatorServo](INFO): Powering down
2020-08-25T15:35:59.955Z,1598369759.955 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-25T15:35:59.955Z,1598369759.955 [MassServo](INFO): Powering down
2020-08-25T15:35:59.956Z,1598369759.956 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-25T15:35:59.956Z,1598369759.956 [RudderServo](INFO): Powering down
2020-08-25T15:35:59.957Z,1598369759.957 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-08-25T15:35:59.957Z,1598369759.957 [ThrusterServo](INFO): Powering down
2020-08-25T15:35:59.958Z,1598369759.958 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-08-25T15:35:59.958Z,1598369759.958 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-08-25T15:35:59.959Z,1598369759.959 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-08-25T15:35:59.959Z,1598369759.959 [CBIT](DEBUG): Powering off loads.
2020-08-25T15:35:59.970Z,1598369759.970 [CBIT](DEBUG): Disabling WDT.
2020-08-25T15:35:59.982Z,1598369759.982 [CBIT](DEBUG): Opening all GF detection circuits.
2020-08-25T15:35:59.983Z,1598369759.983 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:36:00.077Z,1598369760.077 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:36:00.079Z,1598369760.079 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:36:00.084Z,1598369760.084 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:36:00.147Z,1598369760.147 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:36:00.151Z,1598369760.151 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:36:00.154Z,1598369760.154 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:36:00.163Z,1598369760.163 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-25T15:36:00.225Z,1598369760.225 [logger ThreadHandler](INFO): Thread cancelled.