2020-02-04T21:21:04.512Z,1580851264.512 [Supervisor](DEBUG): Initializing supervisor.
2020-02-04T21:21:04.515Z,1580851264.515 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-02-04T21:21:04.515Z,1580851264.515 [SyncHandler](INFO): Protected caller Thread ID is 3773
2020-02-04T21:21:04.516Z,1580851264.516 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-02-04T21:21:04.517Z,1580851264.517 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-02-04T21:21:04.517Z,1580851264.517 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3774
2020-02-04T21:21:04.520Z,1580851264.520 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-02-04T21:21:04.532Z,1580851264.532 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-02-04T21:21:04.533Z,1580851264.533 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-02-04T21:21:04.533Z,1580851264.533 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3775
2020-02-04T21:21:04.534Z,1580851264.534 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-02-04T21:21:04.535Z,1580851264.535 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-02-04T21:21:04.535Z,1580851264.535 [logger ThreadHandler](INFO): Protected caller Thread ID is 3776
2020-02-04T21:21:04.537Z,1580851264.537 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-02-04T21:21:04.538Z,1580851264.538 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-02-04T21:21:04.539Z,1580851264.539 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-02-04T21:21:04.981Z,1580851264.981 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-02-04T21:21:04.982Z,1580851264.982 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-02-04T21:21:05.079Z,1580851265.079 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-02-04T21:21:05.079Z,1580851265.079 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-02-04T21:21:05.399Z,1580851265.399 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-02-04T21:21:05.400Z,1580851265.400 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-02-04T21:21:05.538Z,1580851265.538 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-02-04T21:21:05.538Z,1580851265.538 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-02-04T21:21:06.030Z,1580851266.030 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-02-04T21:21:06.030Z,1580851266.030 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-02-04T21:21:06.481Z,1580851266.481 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-02-04T21:21:06.481Z,1580851266.481 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-02-04T21:21:06.692Z,1580851266.692 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-02-04T21:21:06.692Z,1580851266.692 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-02-04T21:21:06.836Z,1580851266.836 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-02-04T21:21:06.836Z,1580851266.836 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-02-04T21:21:07.029Z,1580851267.029 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-02-04T21:21:07.030Z,1580851267.030 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-02-04T21:21:07.125Z,1580851267.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-02-04T21:21:07.125Z,1580851267.125 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-02-04T21:21:07.427Z,1580851267.427 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-02-04T21:21:07.428Z,1580851267.428 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-02-04T21:21:07.507Z,1580851267.507 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-02-04T21:21:07.609Z,1580851267.609 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-02-04T21:21:07.610Z,1580851267.610 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-02-04T21:21:08.257Z,1580851268.257 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-02-04T21:21:08.257Z,1580851268.257 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-02-04T21:21:08.669Z,1580851268.669 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-02-04T21:21:08.671Z,1580851268.671 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2020-02-04T21:21:08.672Z,1580851268.672 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2020-02-04T21:21:08.885Z,1580851268.885 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2020-02-04T21:21:08.984Z,1580851268.984 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2020-02-04T21:21:09.083Z,1580851269.083 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2020-02-04T21:21:09.310Z,1580851269.310 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-02-04T21:21:09.310Z,1580851269.310 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2020-02-04T21:21:09.394Z,1580851269.394 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2020-02-04T21:21:09.487Z,1580851269.487 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2020-02-04T21:21:09.583Z,1580851269.583 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2020-02-04T21:21:09.666Z,1580851269.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2020-02-04T21:21:09.773Z,1580851269.773 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/workSite.cfg
2020-02-04T21:21:09.865Z,1580851269.865 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2020-02-04T21:21:10.051Z,1580851270.051 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2020-02-04T21:21:10.181Z,1580851270.181 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-02-04T21:21:10.186Z,1580851270.186 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-02-04T21:21:10.504Z,1580851270.504 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-02-04T21:21:10.509Z,1580851270.509 [AHRS_M2](INFO): created writer for : platform_orientation
2020-02-04T21:21:10.511Z,1580851270.511 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-02-04T21:21:10.516Z,1580851270.516 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-02-04T21:21:10.516Z,1580851270.516 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-02-04T21:21:10.521Z,1580851270.521 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-02-04T21:21:10.522Z,1580851270.522 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-02-04T21:21:10.527Z,1580851270.527 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-02-04T21:21:10.596Z,1580851270.596 [AHRS_M2] Loaded
2020-02-04T21:21:10.596Z,1580851270.596 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-02-04T21:21:10.677Z,1580851270.677 [DataOverHttps] Loaded
2020-02-04T21:21:10.677Z,1580851270.677 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-02-04T21:21:10.678Z,1580851270.678 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407684E0
2020-02-04T21:21:10.678Z,1580851270.678 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3858
2020-02-04T21:21:10.702Z,1580851270.702 [DDM] Loaded
2020-02-04T21:21:10.702Z,1580851270.702 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread.
2020-02-04T21:21:10.715Z,1580851270.715 [Depth_Keller] Loaded
2020-02-04T21:21:10.715Z,1580851270.715 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-02-04T21:21:10.719Z,1580851270.719 [DropWeight] Loaded
2020-02-04T21:21:10.720Z,1580851270.720 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-02-04T21:21:10.860Z,1580851270.860 [DUSBL_Hydroid] Loaded
2020-02-04T21:21:10.860Z,1580851270.860 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2020-02-04T21:21:11.076Z,1580851271.076 [Micromodem] Loaded
2020-02-04T21:21:11.085Z,1580851271.085 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2020-02-04T21:21:11.478Z,1580851271.478 [NAL9602] Loaded
2020-02-04T21:21:11.479Z,1580851271.479 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-02-04T21:21:11.717Z,1580851271.717 [Onboard] Loaded
2020-02-04T21:21:11.717Z,1580851271.717 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-02-04T21:21:11.723Z,1580851271.723 [PowerOnly] Loaded
2020-02-04T21:21:11.723Z,1580851271.723 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2020-02-04T21:21:11.729Z,1580851271.729 [Radio_Surface] Loaded
2020-02-04T21:21:11.729Z,1580851271.729 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-02-04T21:21:11.730Z,1580851271.730 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407984E0
2020-02-04T21:21:11.731Z,1580851271.731 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3859
2020-02-04T21:21:11.773Z,1580851271.773 [RDI_Pathfinder] Loaded
2020-02-04T21:21:11.774Z,1580851271.774 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-02-04T21:21:13.209Z,1580851273.209 [BPC1] Loaded
2020-02-04T21:21:13.209Z,1580851273.209 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-02-04T21:21:13.210Z,1580851273.210 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-02-04T21:21:13.210Z,1580851273.210 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-02-04T21:21:13.223Z,1580851273.223 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-02-04T21:21:13.223Z,1580851273.223 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-02-04T21:21:13.337Z,1580851273.337 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-02-04T21:21:13.338Z,1580851273.338 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-02-04T21:21:13.358Z,1580851273.358 [NavChart] Loaded
2020-02-04T21:21:13.358Z,1580851273.358 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-02-04T21:21:13.362Z,1580851273.362 [UniversalFixResidualReporter] Loaded
2020-02-04T21:21:13.362Z,1580851273.362 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-02-04T21:21:13.363Z,1580851273.363 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-02-04T21:21:13.363Z,1580851273.363 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-02-04T21:21:13.468Z,1580851273.468 [BuoyancyServo] Loaded
2020-02-04T21:21:13.469Z,1580851273.469 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-02-04T21:21:13.483Z,1580851273.483 [ElevatorServo] Loaded
2020-02-04T21:21:13.484Z,1580851273.484 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-02-04T21:21:13.498Z,1580851273.498 [MassServo] Loaded
2020-02-04T21:21:13.498Z,1580851273.498 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-02-04T21:21:13.514Z,1580851273.514 [RudderServo] Loaded
2020-02-04T21:21:13.514Z,1580851273.514 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-02-04T21:21:13.528Z,1580851273.528 [ThrusterServo] Loaded
2020-02-04T21:21:13.528Z,1580851273.528 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-02-04T21:21:13.529Z,1580851273.529 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-02-04T21:21:13.529Z,1580851273.529 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-02-04T21:21:13.713Z,1580851273.713 [PAR_Licor] Loaded
2020-02-04T21:21:13.713Z,1580851273.713 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-02-04T21:21:13.756Z,1580851273.756 [WetLabsSeaOWL_UV_A] Loaded
2020-02-04T21:21:13.757Z,1580851273.757 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2020-02-04T21:21:13.758Z,1580851273.758 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408EC4E0
2020-02-04T21:21:13.758Z,1580851273.758 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 3860
2020-02-04T21:21:13.759Z,1580851273.759 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-02-04T21:21:13.759Z,1580851273.759 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-02-04T21:21:14.086Z,1580851274.086 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-02-04T21:21:14.087Z,1580851274.087 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-02-04T21:21:14.127Z,1580851274.127 [DepthRateCalculator] Loaded
2020-02-04T21:21:14.127Z,1580851274.127 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-02-04T21:21:14.132Z,1580851274.132 [PitchRateCalculator] Loaded
2020-02-04T21:21:14.133Z,1580851274.133 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-02-04T21:21:14.145Z,1580851274.145 [SpeedCalculator] Loaded
2020-02-04T21:21:14.145Z,1580851274.145 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-02-04T21:21:14.165Z,1580851274.165 [TempGradientCalculator] Loaded
2020-02-04T21:21:14.166Z,1580851274.166 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-02-04T21:21:14.171Z,1580851274.171 [YawRateCalculator] Loaded
2020-02-04T21:21:14.171Z,1580851274.171 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-02-04T21:21:14.211Z,1580851274.211 [ElevatorOffsetCalculator] Loaded
2020-02-04T21:21:14.211Z,1580851274.211 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-02-04T21:21:14.212Z,1580851274.212 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-02-04T21:21:14.212Z,1580851274.212 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-02-04T21:21:14.346Z,1580851274.346 [SBIT](DEBUG): Construct Startup Built In Test.
2020-02-04T21:21:14.367Z,1580851274.367 [SBIT] Loaded
2020-02-04T21:21:14.368Z,1580851274.368 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-02-04T21:21:14.368Z,1580851274.368 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-02-04T21:21:14.380Z,1580851274.380 [IBIT] Loaded
2020-02-04T21:21:14.381Z,1580851274.381 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-02-04T21:21:14.384Z,1580851274.384 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-02-04T21:21:14.519Z,1580851274.519 [CBIT] Loaded
2020-02-04T21:21:14.519Z,1580851274.519 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-02-04T21:21:14.520Z,1580851274.520 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-02-04T21:21:14.520Z,1580851274.520 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-02-04T21:21:14.600Z,1580851274.600 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-02-04T21:21:14.601Z,1580851274.601 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-02-04T21:21:14.696Z,1580851274.696 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-02-04T21:21:14.696Z,1580851274.696 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-02-04T21:21:14.743Z,1580851274.743 [VerticalControl](DEBUG): Construct VerticalControl.
2020-02-04T21:21:14.825Z,1580851274.825 [VerticalControl] Loaded
2020-02-04T21:21:14.825Z,1580851274.825 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-02-04T21:21:14.826Z,1580851274.826 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-02-04T21:21:14.895Z,1580851274.895 [HorizontalControl] Loaded
2020-02-04T21:21:14.895Z,1580851274.895 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-02-04T21:21:14.896Z,1580851274.896 [SpeedControl](DEBUG): Construct SpeedControl.
2020-02-04T21:21:14.897Z,1580851274.897 [SpeedControl] Loaded
2020-02-04T21:21:14.898Z,1580851274.898 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-02-04T21:21:14.898Z,1580851274.898 [LoopControl](DEBUG): Construct LoopControl.
2020-02-04T21:21:14.899Z,1580851274.899 [LoopControl] Loaded
2020-02-04T21:21:14.899Z,1580851274.899 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-02-04T21:21:14.899Z,1580851274.899 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-02-04T21:21:14.900Z,1580851274.900 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-02-04T21:21:14.931Z,1580851274.931 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-02-04T21:21:14.935Z,1580851274.935 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-02-04T21:21:14.936Z,1580851274.936 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-02-04T21:21:14.942Z,1580851274.942 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-02-04T21:21:14.943Z,1580851274.943 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ACC4E0
2020-02-04T21:21:14.944Z,1580851274.944 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3861
2020-02-04T21:21:14.948Z,1580851274.948 [Supervisor](INFO): Main Thread ID is 2752
2020-02-04T21:21:14.948Z,1580851274.948 [Supervisor](DEBUG): Running supervisor.
2020-02-04T21:21:14.949Z,1580851274.949 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3862
2020-02-04T21:21:14.951Z,1580851274.951 [controlThread ThreadHandler](INFO): Handler Thread ID is 3863
2020-02-04T21:21:14.952Z,1580851274.952 [controlThread](DEBUG): Initializing ControlThread
2020-02-04T21:21:14.961Z,1580851274.961 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-02-04T21:21:14.961Z,1580851274.961 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-02-04T21:21:14.965Z,1580851274.965 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-02-04T21:21:14.965Z,1580851274.965 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-02-04T21:21:14.966Z,1580851274.966 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-02-04T21:21:14.966Z,1580851274.966 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-02-04T21:21:14.967Z,1580851274.967 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-02-04T21:21:14.967Z,1580851274.967 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-02-04T21:21:14.967Z,1580851274.967 [SBIT](INFO): Initialize SBIT Component.
2020-02-04T21:21:14.968Z,1580851274.968 [SBIT](IMPORTANT): git: 2020-01-26-7-g33cfb7a
2020-02-04T21:21:14.968Z,1580851274.968 [SBIT](INFO): git hash: 33cfb7a74ac29a70c1d69f5633740566e309ca44
2020-02-04T21:21:14.968Z,1580851274.968 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-02-04T21:21:14.970Z,1580851274.970 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Nov 13 12:38:10 PST 2019
2020-02-04T21:21:14.971Z,1580851274.971 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2020-02-04T21:21:14.971Z,1580851274.971 [IBIT](INFO): Initialize IBIT Component.
2020-02-04T21:21:14.972Z,1580851274.972 [CBIT](DEBUG): Initialize CBIT Component.
2020-02-04T21:21:14.973Z,1580851274.973 [logger ThreadHandler](INFO): Handler Thread ID is 3864
2020-02-04T21:21:14.985Z,1580851274.985 [CBIT](DEBUG): Initialized mux pins.
2020-02-04T21:21:14.985Z,1580851274.985 [CBIT](DEBUG): Initializing the watchdog timer.
2020-02-04T21:21:14.993Z,1580851274.993 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3865
2020-02-04T21:21:14.994Z,1580851274.994 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-02-04T21:21:15.005Z,1580851275.005 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3866
2020-02-04T21:21:15.009Z,1580851275.009 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-02-04T21:21:15.009Z,1580851275.009 [CBIT](DEBUG): Initializing heartbeat.
2020-02-04T21:21:15.017Z,1580851275.017 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 3867
2020-02-04T21:21:15.018Z,1580851275.018 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-02-04T21:21:15.045Z,1580851275.045 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3868
2020-02-04T21:21:15.048Z,1580851275.048 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-02-04T21:21:15.048Z,1580851275.048 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-02-04T21:21:15.049Z,1580851275.049 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-02-04T21:21:15.049Z,1580851275.049 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-02-04T21:21:15.049Z,1580851275.049 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-02-04T21:21:15.049Z,1580851275.049 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-02-04T21:21:15.050Z,1580851275.050 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-02-04T21:21:15.050Z,1580851275.050 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-02-04T21:21:15.050Z,1580851275.050 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-02-04T21:21:15.050Z,1580851275.050 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-02-04T21:21:15.050Z,1580851275.050 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-02-04T21:21:15.050Z,1580851275.050 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-02-04T21:21:15.051Z,1580851275.051 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-02-04T21:21:15.051Z,1580851275.051 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-02-04T21:21:15.051Z,1580851275.051 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-02-04T21:21:15.051Z,1580851275.051 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-02-04T21:21:15.081Z,1580851275.081 [CBIT](DEBUG): Deactivating GF circuits.
2020-02-04T21:21:15.081Z,1580851275.081 [CBIT](DEBUG): Deactivating emergency mode.
2020-02-04T21:21:15.117Z,1580851275.117 [CBIT](DEBUG): Backplane powered.
2020-02-04T21:21:15.117Z,1580851275.117 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-02-04T21:21:15.119Z,1580851275.119 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-02-04T21:21:15.119Z,1580851275.119 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-02-04T21:21:15.120Z,1580851275.120 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-02-04T21:21:15.121Z,1580851275.121 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-02-04T21:21:15.131Z,1580851275.131 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-04T21:21:15.149Z,1580851275.149 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2020-02-04T21:21:15.150Z,1580851275.150 [MissionManager](INFO): Loading Mission: Missions/underIce/DefaultWithUndock.xml
2020-02-04T21:21:15.231Z,1580851275.231 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2020-02-04T21:21:15.246Z,1580851275.246 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 30.000000 min
2020-02-04T21:21:15.269Z,1580851275.269 [MissionManager](INFO): DefineArg DefaultWithUndock.MicromodemCommsInterval = 2.000000 min
2020-02-04T21:21:15.270Z,1580851275.270 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2020-02-04T21:21:15.272Z,1580851275.272 [DefaultWithUndock:B.Undock](DEBUG): Construct.
2020-02-04T21:21:15.297Z,1580851275.297 [DefaultWithUndock:C.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-04T21:21:15.335Z,1580851275.335 [DefaultWithUndock:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-02-04T21:21:15.350Z,1580851275.350 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-02-04T21:21:15.355Z,1580851275.355 [DefaultWithUndock:F.Execute](DEBUG): Construct Execute.
2020-02-04T21:21:15.379Z,1580851275.379 [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="DefaultWithUndock">

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

    <DefineArg Name="DetachTimeout"><Description>
        Maximum time duration for the vehicle to reach the approach depth after detaching form the dock.
        The vehicle will switch over to midcourse guidance after the timeout is expired.
    </Description><Units:minute/><Value>30</Value></DefineArg>

    <DefineArg Name="MicromodemCommsInterval"><Description>
        How often to trigger Umodem communications
    </Description><Units:minute/><Value>2</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>30</Value></Setting>
    </Guidance:Wait>

    <!-- Leave the dock if necessary --> 
    <Guidance:Undock>
        <Sequence/>
        <Timeout Duration="DetachTimeout">
            <Syslog Severity="Important">Timed out while trying to detach from dock at current depth of <Universal:depth/><Units:meter/>.</Syslog>
        </Timeout>
    </Guidance:Undock>

    <!-- This mission assumes open water so from here on it's the same old default that's always used -->
    <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-02-04T21:21:15.384Z,1580851275.384 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DDM,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,PowerOnly,RDI_Pathfinder,BPC1,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-02-04T21:21:15.403Z,1580851275.403 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-02-04T21:21:15.409Z,1580851275.409 [Radio_Surface](INFO): Powering up
2020-02-04T21:21:15.439Z,1580851275.439 [DDM](INFO): Powering up
2020-02-04T21:21:15.440Z,1580851275.440 [DDM](DEBUG): Initializing DDM.
2020-02-04T21:21:15.462Z,1580851275.462 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2020-02-04T21:21:15.463Z,1580851275.463 [DUSBL_Hydroid](INFO): Powering up
2020-02-04T21:21:15.463Z,1580851275.463 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2020-02-04T21:21:15.630Z,1580851275.630 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-02-04T21:21:15.660Z,1580851275.660 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:21:15.673Z,1580851275.673 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-02-04T21:21:15.674Z,1580851275.674 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:21:15.681Z,1580851275.681 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-04T21:21:15.682Z,1580851275.682 [MassServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:21:15.689Z,1580851275.689 [MassServo](DEBUG): Initializing MassServo.
2020-02-04T21:21:15.690Z,1580851275.690 [RudderServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:21:15.697Z,1580851275.697 [RudderServo](DEBUG): Initializing RudderServo.
2020-02-04T21:21:15.698Z,1580851275.698 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:21:15.705Z,1580851275.705 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-02-04T21:21:15.811Z,1580851275.811 [Micromodem](INFO): Powering up
2020-02-04T21:21:15.811Z,1580851275.811 [Micromodem](DEBUG): Initializing Micromodem.
2020-02-04T21:21:15.862Z,1580851275.862 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-02-04T21:21:16.581Z,1580851276.581 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-02-04T21:21:16.581Z,1580851276.581 [RudderServo](FAULT): Rudder failed to initialize
2020-02-04T21:21:16.581Z,1580851276.581 [RudderServo] Communications Fault, FailCount= 1
2020-02-04T21:21:16.581Z,1580851276.581 [RudderServo](ERROR): Communications Fault
2020-02-04T21:21:16.692Z,1580851276.692 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-02-04T21:21:16.894Z,1580851276.894 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-02-04T21:21:16.894Z,1580851276.894 [RudderServo](INFO): Powering down
2020-02-04T21:21:17.551Z,1580851277.551 [RudderServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:21:17.670Z,1580851277.670 [RudderServo](DEBUG): Initializing RudderServo.
2020-02-04T21:21:17.674Z,1580851277.674 [CBIT](INFO): Clearing failed state for component RudderServo
2020-02-04T21:21:17.674Z,1580851277.674 [RudderServo] No Fault, FailCount= 1
2020-02-04T21:21:20.779Z,1580851280.779 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33

2020-02-04T21:21:24.824Z,1580851284.824 [Micromodem](INFO): Nmea in: $CATMG,2020-02-04T21:21:24.274045Z,RTC,RTC*50

2020-02-04T21:21:24.824Z,1580851284.824 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2020-02-04T21:21:24.274045Z,RTC,RTC*50

2020-02-04T21:21:26.024Z,1580851286.024 [DDM](INFO): Dynamic Docking Module:!C REMUS Capture Rev 1.1
2020-02-04T21:21:28.872Z,1580851288.872 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2020-02-04T21:21:32.087Z,1580851292.087 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33

2020-02-04T21:21:32.484Z,1580851292.484 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31

2020-02-04T21:21:32.485Z,1580851292.485 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2020-02-04T21:21:32.888Z,1580851292.888 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2020-02-04T21:21:32.889Z,1580851292.889 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64

2020-02-04T21:21:33.291Z,1580851293.291 [DUSBL_Hydroid](INFO): DUSBL Version:O
2020-02-04T21:21:33.307Z,1580851293.307 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV21214AU,20373*1C
 expected 7A
2020-02-04T21:21:33.307Z,1580851293.307 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64

2020-02-04T21:21:34.099Z,1580851294.099 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66

2020-02-04T21:21:34.099Z,1580851294.099 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F

2020-02-04T21:21:34.503Z,1580851294.503 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66

2020-02-04T21:21:34.503Z,1580851294.503 [Micromodem](ERROR): CFG response from modem unexpected: $CACFG,nav.dt.txtrig_gpio4,1*66

2020-02-04T21:21:34.909Z,1580851294.909 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D

2020-02-04T21:21:34.909Z,1580851294.909 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E

2020-02-04T21:21:35.311Z,1580851295.311 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C

2020-02-04T21:21:35.311Z,1580851295.311 [Micromodem](INFO): Nmea out: $CCCFG,FC0,10000*46

2020-02-04T21:21:35.727Z,1580851295.727 [Micromodem](INFO): Nmea in: $CACFG,FC0,10000*44

2020-02-04T21:21:35.727Z,1580851295.727 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63

2020-02-04T21:21:36.119Z,1580851296.119 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61

2020-02-04T21:21:36.119Z,1580851296.119 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A

2020-02-04T21:21:36.523Z,1580851296.523 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38

2020-02-04T21:21:36.523Z,1580851296.523 [Micromodem](INFO): Nmea out: $CCCLK,2020,02,04,21,21,37*46

2020-02-04T21:21:36.939Z,1580851296.939 [Micromodem](INFO): Nmea in: $CACLK,2020,2,4,21,21,37*44

2020-02-04T21:21:36.940Z,1580851296.940 [Micromodem](INFO): Nmea in: $CATMS,0,2020-02-04T21:21:38Z*7B

2020-02-04T21:21:36.946Z,1580851296.946 [Micromodem](INFO): Nmea in: $CATMG,2020-02-04T21:21:38.026014Z,USER_CMD,RTC*1D

2020-02-04T21:21:41.784Z,1580851301.784 [NAL9602](INFO): Powering up NAL9602
2020-02-04T21:21:52.683Z,1580851312.683 [NAL9602](INFO): NAL9602 initialized
2020-02-04T21:21:54.356Z,1580851314.356 [SBIT](IMPORTANT): Beginning Startup BIT
2020-02-04T21:21:54.399Z,1580851314.399 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-04T21:22:05.426Z,1580851325.426 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.015078
CHAN A1 (24V): -0.029205
CHAN A2 (12V): -0.006814
CHAN A3 (5V): -0.001633
CHAN B0 (3.3V): 0.000034
CHAN B1 (3.15aV): -0.000029
CHAN B2 (3.15bV): 0.000513
CHAN B3 (GND): 0.002256
OPEN: 0.005355
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-04T21:22:34.640Z,1580851354.640 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-02-04T21:22:38.346Z,1580851358.346 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-04T21:22:47.680Z,1580851367.680 [SBIT](IMPORTANT): SBIT PASSED
2020-02-04T21:22:47.680Z,1580851367.680 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-02-04T21:22:47.681Z,1580851367.681 [SBIT](IMPORTANT): DUSBL_Hydroid.detectionThreshold=30 count;

2020-02-04T21:22:47.682Z,1580851367.682 [SBIT](IMPORTANT): DUSBL_Hydroid.verbosity=3 enum;

2020-02-04T21:22:47.682Z,1580851367.682 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter;

2020-02-04T21:22:47.682Z,1580851367.682 [SBIT](IMPORTANT): VerticalControl.massDefault=0.5 centimeter;

2020-02-04T21:22:48.064Z,1580851368.064 [MissionManager](IMPORTANT): Started mission Startup
2020-02-04T21:22:48.065Z,1580851368.065 [Startup] Running Loop=1
2020-02-04T21:22:48.065Z,1580851368.065 [Startup](DEBUG): Aggregate::initialize Startup
2020-02-04T21:22:48.065Z,1580851368.065 [Startup:A.GoToSurface] Running Loop=1
2020-02-04T21:22:48.065Z,1580851368.065 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-04T21:22:48.066Z,1580851368.066 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-04T21:22:48.066Z,1580851368.066 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-04T21:22:48.066Z,1580851368.066 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-04T21:22:48.067Z,1580851368.067 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-04T21:22:48.067Z,1580851368.067 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-04T21:22:48.068Z,1580851368.068 [Startup:StartupSatComms] Running Loop=1
2020-02-04T21:22:48.069Z,1580851368.069 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-02-04T21:22:48.069Z,1580851368.069 [Startup:StartupSatComms:A] Running Loop=1
2020-02-04T21:22:48.463Z,1580851368.463 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-02-04T21:23:22.851Z,1580851402.851 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-02-04T21:23:48.272Z,1580851428.272 [Startup:StartupSatComms:A](INFO): Timed out from 2020-02-04T21:22:48.1Z
2020-02-04T21:23:48.272Z,1580851428.272 [Startup:StartupSatComms:A] Stopped
2020-02-04T21:23:48.273Z,1580851428.273 [Startup:StartupSatComms:B] Running Loop=1
2020-02-04T21:23:48.703Z,1580851428.703 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-02-04T21:24:15.302Z,1580851455.302 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-02-04T21:24:15.302Z,1580851455.302 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T21:24:15.332Z,1580851455.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T21:24:15.719Z,1580851455.719 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T21:24:15.719Z,1580851455.719 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-02-04T21:24:22.746Z,1580851462.746 [CommandLine](IMPORTANT): got command strobe off
2020-02-04T21:24:22.746Z,1580851462.746 [CommandLine](IMPORTANT): Deactivating strobe
2020-02-04T21:24:31.306Z,1580851471.306 [CommandLine](IMPORTANT): got command show stack
2020-02-04T21:24:31.306Z,1580851471.306 [CommandLine](IMPORTANT): Behavior Stack:

2020-02-04T21:24:31.306Z,1580851471.306 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2020-02-04T21:24:31.306Z,1580851471.306 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B
2020-02-04T21:24:40.423Z,1580851480.423 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004839
2020-02-04T21:24:47.960Z,1580851487.960 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200204T203336/Courier0007.lzma
2020-02-04T21:24:48.459Z,1580851488.459 [Startup:StartupSatComms:B](INFO): Timed out from 2020-02-04T21:23:48.3Z
2020-02-04T21:24:48.459Z,1580851488.459 [Startup:StartupSatComms:B] Stopped
2020-02-04T21:24:48.459Z,1580851488.459 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-02-04T21:24:48.459Z,1580851488.459 [Startup:StartupSatComms] Stopped
2020-02-04T21:24:48.459Z,1580851488.459 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-02-04T21:24:48.460Z,1580851488.460 [Startup](INFO): Completed Startup
2020-02-04T21:24:48.460Z,1580851488.460 [MissionManager](INFO): Startup is completed.
2020-02-04T21:24:48.460Z,1580851488.460 [MissionManager](INFO): Uninitializing Mission Startup
2020-02-04T21:24:48.460Z,1580851488.460 [Startup] Stopped
2020-02-04T21:24:48.460Z,1580851488.460 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-02-04T21:24:48.461Z,1580851488.461 [Startup:A.GoToSurface] Stopped
2020-02-04T21:24:48.462Z,1580851488.462 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-04T21:24:48.899Z,1580851488.899 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2020-02-04T21:24:48.900Z,1580851488.900 [DefaultWithUndock] Running Loop=1
2020-02-04T21:24:48.900Z,1580851488.900 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2020-02-04T21:24:48.900Z,1580851488.900 [DefaultWithUndock:C.GoToSurface] Running Loop=1
2020-02-04T21:24:48.900Z,1580851488.900 [DefaultWithUndock:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-04T21:24:48.900Z,1580851488.900 [DefaultWithUndock:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-04T21:24:48.900Z,1580851488.900 [DefaultWithUndock:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-04T21:24:48.905Z,1580851488.905 [DefaultWithUndock:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-04T21:24:48.931Z,1580851488.931 [DefaultWithUndock:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-04T21:24:48.933Z,1580851488.933 [DefaultWithUndock:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-04T21:24:48.933Z,1580851488.933 [DefaultWithUndock:A.Wait] Running Loop=1
2020-02-04T21:24:48.933Z,1580851488.933 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2020-02-04T21:24:49.959Z,1580851489.959 [DataOverHttps](INFO): Moved sent file to Logs/20200204T203336/Courier0007.lzma.bak
2020-02-04T21:24:49.959Z,1580851489.959 [DataOverHttps](INFO): SBD MOMSN=12218203
2020-02-04T21:25:02.649Z,1580851502.649 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-02-04T21:25:11.390Z,1580851511.390 [CommandLine](IMPORTANT): got command show stack
2020-02-04T21:25:11.390Z,1580851511.390 [CommandLine](IMPORTANT): Behavior Stack:

2020-02-04T21:25:11.390Z,1580851511.390 [DefaultWithUndock](IMPORTANT): Priority 0: DefaultWithUndock:A.Wait
2020-02-04T21:25:11.390Z,1580851511.390 [DefaultWithUndock](IMPORTANT): Priority 1: DefaultWithUndock:C.GoToSurface
2020-02-04T21:25:19.135Z,1580851519.135 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2020-02-04T21:25:19.135Z,1580851519.135 [DefaultWithUndock:A.Wait] Stopped
2020-02-04T21:25:19.136Z,1580851519.136 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T21:25:19.136Z,1580851519.136 [DefaultWithUndock:B.Undock] Running Loop=1
2020-02-04T21:25:19.136Z,1580851519.136 [DefaultWithUndock:B.Undock](DEBUG): Initialize.
2020-02-04T21:25:19.951Z,1580851519.951 [PowerOnly](INFO): Powering up
2020-02-04T21:25:22.027Z,1580851522.027 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool
2020-02-04T21:25:24.068Z,1580851524.068 [DefaultWithUndock:B.Undock](INFO): Detaching from dock.
2020-02-04T21:25:24.436Z,1580851524.436 [DefaultWithUndock:B.Undock](INFO): Detected possible detachment. Starting timer.
2020-02-04T21:25:24.746Z,1580851524.746 [CommandLine](IMPORTANT): got command show stack
2020-02-04T21:25:24.746Z,1580851524.746 [CommandLine](IMPORTANT): Behavior Stack:

2020-02-04T21:25:24.746Z,1580851524.746 [DefaultWithUndock](IMPORTANT): Priority 0: DefaultWithUndock:B.Undock
2020-02-04T21:25:24.746Z,1580851524.746 [DefaultWithUndock](IMPORTANT): Priority 1: DefaultWithUndock:C.GoToSurface
2020-02-04T21:25:44.714Z,1580851544.714 [DefaultWithUndock:B.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby.
2020-02-04T21:25:47.472Z,1580851547.472 [DefaultWithUndock:B.Undock](INFO): DDM at standby.
2020-02-04T21:25:47.850Z,1580851547.850 [DefaultWithUndock:B.Undock](IMPORTANT): Undocking sequence complete.
2020-02-04T21:25:47.851Z,1580851547.851 [DefaultWithUndock:B.Undock] Stopped
2020-02-04T21:25:48.271Z,1580851548.271 [DefaultWithUndock:CheckIn] Running Loop=1
2020-02-04T21:25:48.271Z,1580851548.271 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-04T21:25:48.271Z,1580851548.271 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-04T21:25:48.681Z,1580851548.681 [DefaultWithUndock:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-02-04T21:26:01.537Z,1580851561.537 [NAL9602](INFO): SBD MO Status=2, MOMSN=10321, MT Status=2, MTMSN=0
2020-02-04T21:26:01.537Z,1580851561.537 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-02-04T21:26:21.487Z,1580851581.487 [CommandLine](IMPORTANT): got command show variable range
2020-02-04T21:26:21.490Z,1580851581.490 [CommandLine](IMPORTANT): acoustic_contact_range (unknown)
2020-02-04T21:26:21.586Z,1580851581.586 [CommandLine](IMPORTANT): BR_Ping1D.minRange (meter)
2020-02-04T21:26:21.586Z,1580851581.586 [CommandLine](IMPORTANT): BR_Ping1D.maxRange (meter)
2020-02-04T21:26:21.652Z,1580851581.652 [CommandLine](IMPORTANT): DUSBL_Hydroid.acoustic_contact_range (meter)
2020-02-04T21:26:21.653Z,1580851581.653 [CommandLine](IMPORTANT): Micromodem.range_request (count)
2020-02-04T21:26:21.654Z,1580851581.654 [CommandLine](IMPORTANT): Micromodem.range (meter)
2020-02-04T21:26:21.658Z,1580851581.658 [CommandLine](IMPORTANT): RDI_Pathfinder.Beam1Range (meter)
2020-02-04T21:26:21.658Z,1580851581.658 [CommandLine](IMPORTANT): RDI_Pathfinder.Beam2Range (meter)
2020-02-04T21:26:21.658Z,1580851581.658 [CommandLine](IMPORTANT): RDI_Pathfinder.Beam3Range (meter)
2020-02-04T21:26:21.659Z,1580851581.659 [CommandLine](IMPORTANT): RDI_Pathfinder.Beam4Range (meter)
2020-02-04T21:26:25.445Z,1580851585.445 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-02-04T21:26:25.822Z,1580851585.822 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-02-04T21:26:25.822Z,1580851585.822 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,     ,        +0.00,        +0.00,   0.00,297.00
2020-02-04T21:26:32.686Z,1580851592.686 [CommandLine](IMPORTANT): got command report touch acoustic_contact_range
2020-02-04T21:26:34.707Z,1580851594.707 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T21:26:34.707Z,1580851594.707 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T21:26:38.397Z,1580851598.397 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-02-04T21:26:51.242Z,1580851611.242 [PowerOnly](INFO): Powering down
2020-02-04T21:27:06.573Z,1580851626.573 [NAL9602](INFO): SBD MO Status=2, MOMSN=10321, MT Status=2, MTMSN=0
2020-02-04T21:27:06.574Z,1580851626.574 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-02-04T21:27:06.992Z,1580851626.992 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-02-04T21:27:16.314Z,1580851636.314 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-02-04T21:27:16.314Z,1580851636.314 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T21:27:16.332Z,1580851636.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T21:27:16.734Z,1580851636.734 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T21:27:16.734Z,1580851636.734 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-02-04T21:27:22.662Z,1580851642.662 [DataOverHttps](IMPORTANT): SBD MTMSN=20200204T212710
2020-02-04T21:27:30.209Z,1580851650.209 [DataOverHttps](INFO): Received command:run Maintenance/DUSBL.xml
2020-02-04T21:27:30.289Z,1580851650.289 [CommandLine](IMPORTANT): got command run ./Missions/Maintenance/DUSBL.xml
2020-02-04T21:27:30.289Z,1580851650.289 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/DUSBL.xml
2020-02-04T21:27:30.318Z,1580851650.318 [MissionManager](INFO): DefineArg DUSBL.MissionTimeout = 90.000000 min
2020-02-04T21:27:30.322Z,1580851650.322 [MissionManager](INFO): DefineArg DUSBL.NumberOfRequests = 10.000000 count
2020-02-04T21:27:30.325Z,1580851650.325 [MissionManager](INFO): DefineArg DUSBL.TransponderCode = 2.000000 count
2020-02-04T21:27:30.329Z,1580851650.329 [MissionManager](INFO): DefineArg DUSBL.NumberOfPings = 1.000000 count
2020-02-04T21:27:30.332Z,1580851650.332 [MissionManager](INFO): DefineArg DUSBL.EnabledDUSBL = DUSBL_Hydroid.loadAtStartup
2020-02-04T21:27:30.366Z,1580851650.366 [DUSBL:A.Pitch](DEBUG): Construct.
2020-02-04T21:27:30.372Z,1580851650.372 [DUSBL:B.SetSpeed](DEBUG): Construct.
2020-02-04T21:27:30.440Z,1580851650.440 [DUSBL:RequestRepeater:C.Wait](DEBUG): Construct Wait.
2020-02-04T21:27:30.456Z,1580851650.456 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Control="Tethys/Control"
         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/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd"
       Id="DUSBL">

    <Description>
        This mission is requests a DUSBL arming.
    </Description>

    <DefineArg Name="MissionTimeout"><Description>
        How long to let the mission run.
    </Description><Units:minute/><Value>90</Value></DefineArg>

    <DefineArg Name="NumberOfRequests"><Description>
        Number of pings to requst.
    </Description><Units:count/><Value>10</Value></DefineArg>

    <DefineArg Name="TransponderCode"><Description>
        Transponder Address.
    </Description><Units:count/><Value>2</Value></DefineArg>   

    <DefineArg Name="NumberOfPings"><Description>
        Number of pings requested each time.
    </Description><Units:count/><Value>1</Value></DefineArg>      
    
    <DefineArg Name="EnabledDUSBL"><Description>
        Automatically set to true if the DUSBL is enabled. Set to false to disable
        reading from the DUSBL.
    </Description><Sensor:DUSBL_Hydroid.loadAtStartup/></DefineArg>    

    <Timeout Duration="MissionTimeout"/>

    <Guidance:Pitch>
        <Parallel/>
        <Setting><Guidance:Pitch.massPosition/><Control:VerticalControl.massDefault/></Setting>
    </Guidance:Pitch>

    <Guidance:SetSpeed>
        <Parallel/>
        <Setting><Guidance:SetSpeed.speed/><Units:meter_per_second/><Value>0</Value></Setting>
    </Guidance:SetSpeed>

    <ReadData>
        <When>
            <Arg Name="EnabledDUSBL"/>
        </When>
            <Universal:acoustic_contact_range/>
            <Universal:acoustic_contact_direction_vehicle_frame/>
    </ReadData>
    
      <Aggregate Id="RequestRepeater">

        <Sequence Repeat="NumberOfRequests"/>
        <Assign><Parallel/><Sensor:DUSBL_Hydroid.transponderCode/><Arg Name="TransponderCode"/></Assign>
        <Assign><Parallel/><Sensor:DUSBL_Hydroid.pingRequested/><Arg Name="NumberOfPings"/></Assign>
          <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:second/><Value>90</Value></Setting>
          </Guidance:Wait>
      </Aggregate>    
</Mission>


2020-02-04T21:27:30.470Z,1580851650.470 [DefaultWithUndock] Stopped
2020-02-04T21:27:30.470Z,1580851650.470 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-02-04T21:27:30.470Z,1580851650.470 [DefaultWithUndock:C.GoToSurface] Stopped
2020-02-04T21:27:30.470Z,1580851650.470 [DefaultWithUndock:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-04T21:27:30.470Z,1580851650.470 [DefaultWithUndock:CheckIn] Stopped
2020-02-04T21:27:30.471Z,1580851650.471 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-04T21:27:30.471Z,1580851650.471 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-04T21:27:30.471Z,1580851650.471 [MissionManager](IMPORTANT): Started mission DUSBL
2020-02-04T21:27:30.471Z,1580851650.471 [DUSBL] Running Loop=1
2020-02-04T21:27:30.471Z,1580851650.471 [DUSBL](DEBUG): Aggregate::initialize DUSBL
2020-02-04T21:27:30.471Z,1580851650.471 [DUSBL:A.Pitch] Running Loop=1
2020-02-04T21:27:30.471Z,1580851650.471 [DUSBL:A.Pitch](DEBUG): Initialize.
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:B.SetSpeed] Running Loop=1
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:B.SetSpeed](DEBUG): Initialize.
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:C] Running Loop=1
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:RequestRepeater] Running Loop=1
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:RequestRepeater:A] Running Loop=1
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:RequestRepeater:B] Running Loop=1
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2020-02-04T21:27:30.472Z,1580851650.472 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2020-02-04T21:27:30.475Z,1580851650.475 [CommandLine](IMPORTANT): Running ./Missions/Maintenance/DUSBL.xml
2020-02-04T21:27:30.473Z,1580851650.473 [DUSBL:RequestRepeater:B] Running Loop=1
2020-02-04T21:27:30.481Z,1580851650.481 [DUSBL:RequestRepeater:A] Running Loop=1
2020-02-04T21:27:30.482Z,1580851650.482 [DUSBL:C](DEBUG): Initialize ReadDataComponent to sense acoustic_contact_range
2020-02-04T21:27:30.483Z,1580851650.483 [DUSBL:C](DEBUG): Initialize ReadDataComponent to sense acoustic_contact_direction_vehicle_frame
2020-02-04T21:27:30.483Z,1580851650.483 [DUSBL:B.SetSpeed] Running Loop=1
2020-02-04T21:27:30.483Z,1580851650.483 [DUSBL:A.Pitch] Running Loop=1
2020-02-04T21:27:32.023Z,1580851652.023 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:27:32.023Z,1580851652.023 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:27:32.023Z,1580851652.023 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:27:32.024Z,1580851652.024 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:27:32.427Z,1580851652.427 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
O
2020-02-04T21:27:32.427Z,1580851652.427 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:27:32.427Z,1580851652.427 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:27:32.429Z,1580851652.429 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:27:32.850Z,1580851652.850 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:27:33.658Z,1580851653.658 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212733.90*51

2020-02-04T21:27:36.063Z,1580851656.063 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2020-02-04T21:27:36.063Z,1580851656.063 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2020-02-04T21:27:36.063Z,1580851656.063 [DUSBL_Hydroid](ERROR): No response from remote modem.
2020-02-04T21:27:36.463Z,1580851656.463 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:27:36.463Z,1580851656.463 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:27:36.463Z,1580851656.463 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:27:36.464Z,1580851656.464 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:27:36.871Z,1580851656.871 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2020-02-04T21:27:36.871Z,1580851656.871 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:27:36.871Z,1580851656.871 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:27:36.872Z,1580851656.872 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:27:37.277Z,1580851657.277 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:27:37.687Z,1580851657.687 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,236,000,00292,188,80,80,28,FF
2020-02-04T21:27:37.687Z,1580851657.687 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:27:37.722Z,1580851657.722 [Reporter](INFO): acoustic_contact_range 1.979998 m
2020-02-04T21:27:38.091Z,1580851658.091 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212738.34*54

2020-02-04T21:27:40.507Z,1580851660.507 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:27:40.507Z,1580851660.507 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:27:40.507Z,1580851660.507 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:27:40.508Z,1580851660.508 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:27:40.917Z,1580851660.917 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
236,000,00292,188,80,80,28,FF
2020-02-04T21:27:40.917Z,1580851660.917 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:27:40.917Z,1580851660.917 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:27:40.919Z,1580851660.919 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:27:41.318Z,1580851661.318 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:27:41.719Z,1580851661.719 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,011,000,0028A,184,80,80,8B,FF
2020-02-04T21:27:41.719Z,1580851661.719 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:27:41.825Z,1580851661.825 [Reporter](INFO): acoustic_contact_range 1.500000 m
2020-02-04T21:27:42.137Z,1580851662.137 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212742.39*54

2020-02-04T21:27:44.547Z,1580851664.547 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:27:44.547Z,1580851664.547 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:27:44.547Z,1580851664.547 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:27:44.548Z,1580851664.548 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:27:44.954Z,1580851664.954 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
011,000,0028A,184,80,80,8B,FF
2020-02-04T21:27:44.955Z,1580851664.955 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:27:44.955Z,1580851664.955 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:27:44.956Z,1580851664.956 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:27:45.358Z,1580851665.358 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:27:45.767Z,1580851665.767 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,EF6,000,00289,186,80,80,B3,FF
2020-02-04T21:27:45.768Z,1580851665.768 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:27:45.969Z,1580851665.969 [Reporter](INFO): acoustic_contact_range 1.440000 m
2020-02-04T21:27:46.179Z,1580851666.179 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212746.43*5D

2020-02-04T21:27:47.342Z,1580851667.342 [CommandLine](IMPORTANT): got command show variable xangle
2020-02-04T21:27:47.442Z,1580851667.442 [CommandLine](IMPORTANT): DUSBL_Hydroid.xAngle (angular_degree)
2020-02-04T21:27:48.590Z,1580851668.590 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:27:48.590Z,1580851668.590 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:27:48.590Z,1580851668.590 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:27:48.591Z,1580851668.591 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:27:48.998Z,1580851668.998 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
EF6,000,00289,186,80,80,B3,FF
2020-02-04T21:27:48.998Z,1580851668.998 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:27:48.999Z,1580851668.999 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:27:48.000Z,1580851669.000 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:27:49.411Z,1580851669.411 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:27:49.802Z,1580851669.802 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,FF1,000,0028A,183,80,80,C0,FF
2020-02-04T21:27:49.803Z,1580851669.803 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:27:49.914Z,1580851669.914 [Reporter](INFO): acoustic_contact_range 1.500000 m
2020-02-04T21:27:50.213Z,1580851670.213 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212750.48*51

2020-02-04T21:27:52.642Z,1580851672.642 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:27:52.642Z,1580851672.642 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:27:52.643Z,1580851672.643 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:27:52.643Z,1580851672.643 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:27:53.034Z,1580851673.034 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
FF1,000,0028A,183,80,80,C0,FF
2020-02-04T21:27:53.035Z,1580851673.035 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:27:53.035Z,1580851673.035 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:27:53.036Z,1580851673.036 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:27:53.441Z,1580851673.441 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:27:54.261Z,1580851674.261 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212754.51*5D

2020-02-04T21:27:58.705Z,1580851678.705 [DUSBL_Hydroid](INFO): Setting waiting for range response to false due to timeout. Elapsed:6.061857
2020-02-04T21:27:58.705Z,1580851678.705 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:27:58.705Z,1580851678.705 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:27:58.706Z,1580851678.706 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:27:58.706Z,1580851678.706 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:27:59.094Z,1580851679.094 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
FF1,000,0028A,183,80,80,C0,FF
2020-02-04T21:27:59.095Z,1580851679.095 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:27:59.095Z,1580851679.095 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:27:59.096Z,1580851679.096 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:27:59.501Z,1580851679.501 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:27:59.975Z,1580851679.975 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,0DE,000,00290,187,80,80,BE,FF
2020-02-04T21:27:59.976Z,1580851679.976 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:28:00.208Z,1580851680.208 [Reporter](INFO): acoustic_contact_range 1.860000 m
2020-02-04T21:28:00.349Z,1580851680.349 [Micromodem](INFO): Nmea in: $SNTTA,0.001637,,,,212800.57*48

2020-02-04T21:28:01.469Z,1580851681.469 [CommandLine](IMPORTANT): got command report touch DUSBL_Hydroid.xAngle
2020-02-04T21:28:02.822Z,1580851682.822 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:02.822Z,1580851682.822 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:02.822Z,1580851682.822 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:02.823Z,1580851682.823 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:03.202Z,1580851683.202 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
0DE,000,00290,187,80,80,BE,FF
2020-02-04T21:28:03.202Z,1580851683.202 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:03.202Z,1580851683.202 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:03.204Z,1580851683.204 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:03.609Z,1580851683.609 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:03.667Z,1580851683.667 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2020-02-04T21:28:04.010Z,1580851684.010 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,F9F,000,00287,186,80,80,18,FF
2020-02-04T21:28:04.011Z,1580851684.011 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:28:04.149Z,1580851684.149 [Reporter](INFO): acoustic_contact_range 1.319999 m
2020-02-04T21:28:04.153Z,1580851684.153 [Reporter](INFO): DUSBL_Hydroid.xAngle 4.850000 arcdeg
2020-02-04T21:28:04.427Z,1580851684.427 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212804.68*5D

2020-02-04T21:28:06.842Z,1580851686.842 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:06.842Z,1580851686.842 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:06.842Z,1580851686.842 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:06.843Z,1580851686.843 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:07.242Z,1580851687.242 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
F9F,000,00287,186,80,80,18,FF
2020-02-04T21:28:07.242Z,1580851687.242 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:07.243Z,1580851687.243 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:07.244Z,1580851687.244 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:07.659Z,1580851687.659 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:08.465Z,1580851688.465 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212808.72*5A

2020-02-04T21:28:10.874Z,1580851690.874 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
7,186,80,80,18,FF
2020-02-04T21:28:10.875Z,1580851690.875 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
7,186,80,80,18,FF
2020-02-04T21:28:10.875Z,1580851690.875 [DUSBL_Hydroid](ERROR): No response from remote modem.
2020-02-04T21:28:11.282Z,1580851691.282 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:11.282Z,1580851691.282 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:11.282Z,1580851691.282 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:11.283Z,1580851691.283 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:11.693Z,1580851691.693 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
7,186,80,80,18,FF
2020-02-04T21:28:11.693Z,1580851691.693 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:11.693Z,1580851691.693 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:11.694Z,1580851691.694 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:12.089Z,1580851692.089 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:12.498Z,1580851692.498 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,1C3,000,0029B,186,80,80,38,FF
2020-02-04T21:28:12.499Z,1580851692.499 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:28:12.579Z,1580851692.579 [Reporter](INFO): acoustic_contact_range 2.520000 m
2020-02-04T21:28:12.579Z,1580851692.579 [Reporter](INFO): DUSBL_Hydroid.xAngle -22.549999 arcdeg
2020-02-04T21:28:12.914Z,1580851692.914 [Micromodem](INFO): Nmea in: $SNTTA,0.002004,,,,212813.17*4B

2020-02-04T21:28:15.326Z,1580851695.326 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:15.326Z,1580851695.326 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:15.326Z,1580851695.326 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:15.327Z,1580851695.327 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:15.730Z,1580851695.730 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
1C3,000,0029B,186,80,80,38,FF
2020-02-04T21:28:15.730Z,1580851695.730 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:15.731Z,1580851695.731 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:15.732Z,1580851695.732 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:16.138Z,1580851696.138 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:16.183Z,1580851696.183 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-04T21:28:16.539Z,1580851696.539 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,22E,000,002D7,188,80,80,6F,FF
2020-02-04T21:28:16.539Z,1580851696.539 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:28:16.685Z,1580851696.685 [Reporter](INFO): acoustic_contact_range 6.119999 m
2020-02-04T21:28:16.686Z,1580851696.686 [Reporter](INFO): DUSBL_Hydroid.xAngle -27.899999 arcdeg
2020-02-04T21:28:16.958Z,1580851696.958 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212817.21*52

2020-02-04T21:28:19.362Z,1580851699.362 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:19.362Z,1580851699.362 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:19.362Z,1580851699.362 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:19.363Z,1580851699.363 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:19.770Z,1580851699.770 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
22E,000,002D7,188,80,80,6F,FF
2020-02-04T21:28:19.770Z,1580851699.770 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:19.771Z,1580851699.771 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:19.772Z,1580851699.772 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:20.180Z,1580851700.180 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:20.570Z,1580851700.570 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,3FE,000,002DB,189,80,80,70,FF
2020-02-04T21:28:20.571Z,1580851700.571 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:28:20.679Z,1580851700.679 [Reporter](INFO): acoustic_contact_range 6.359998 m
2020-02-04T21:28:20.680Z,1580851700.680 [Reporter](INFO): DUSBL_Hydroid.xAngle -51.099999 arcdeg
2020-02-04T21:28:20.989Z,1580851700.989 [Micromodem](INFO): Nmea in: $SNTTA,0.004610,,,,212821.24*4F

2020-02-04T21:28:22.646Z,1580851702.646 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-02-04T21:28:22.647Z,1580851702.647 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,        +0.0  +0.00,        +0.00,   0.00,413.99
2020-02-04T21:28:23.406Z,1580851703.406 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:23.406Z,1580851703.406 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:23.406Z,1580851703.406 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:23.407Z,1580851703.407 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:23.458Z,1580851703.458 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
3FE,000,002DB,189,80,80,70,FF
2020-02-04T21:28:23.458Z,1580851703.458 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:23.458Z,1580851703.458 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:23.459Z,1580851703.459 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:23.805Z,1580851703.805 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:24.214Z,1580851704.214 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,17B,000,00311,186,80,80,0E,FF
2020-02-04T21:28:24.215Z,1580851704.215 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:28:24.316Z,1580851704.316 [Reporter](INFO): acoustic_contact_range 9.599998 m
2020-02-04T21:28:24.316Z,1580851704.316 [Reporter](INFO): DUSBL_Hydroid.xAngle -18.950000 arcdeg
2020-02-04T21:28:25.023Z,1580851705.023 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212824.93*5B

2020-02-04T21:28:27.042Z,1580851707.042 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:27.042Z,1580851707.042 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:27.042Z,1580851707.042 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:27.043Z,1580851707.043 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:27.458Z,1580851707.458 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
17B,000,00311,186,80,80,0E,FF
2020-02-04T21:28:27.458Z,1580851707.458 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:27.459Z,1580851707.459 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:27.460Z,1580851707.460 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:27.849Z,1580851707.849 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:28.672Z,1580851708.672 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212828.94*50

2020-02-04T21:28:31.094Z,1580851711.094 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
1,186,80,80,0E,FF
2020-02-04T21:28:31.095Z,1580851711.095 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
1,186,80,80,0E,FF
2020-02-04T21:28:31.095Z,1580851711.095 [DUSBL_Hydroid](ERROR): No response from remote modem.
2020-02-04T21:28:31.483Z,1580851711.483 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:31.483Z,1580851711.483 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:31.483Z,1580851711.483 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:31.484Z,1580851711.484 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:31.887Z,1580851711.887 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
1,186,80,80,0E,FF
2020-02-04T21:28:31.887Z,1580851711.887 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:31.887Z,1580851711.887 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:31.888Z,1580851711.888 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:32.289Z,1580851712.289 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:33.108Z,1580851713.108 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212833.36*52

2020-02-04T21:28:35.519Z,1580851715.519 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
1,186,80,80,0E,FF
2020-02-04T21:28:35.519Z,1580851715.519 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
1,186,80,80,0E,FF
2020-02-04T21:28:35.519Z,1580851715.519 [DUSBL_Hydroid](ERROR): No response from remote modem.
2020-02-04T21:28:35.930Z,1580851715.930 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:35.930Z,1580851715.930 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:35.930Z,1580851715.930 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:35.931Z,1580851715.931 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:36.330Z,1580851716.330 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
1,186,80,80,0E,FF
2020-02-04T21:28:36.330Z,1580851716.330 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:36.331Z,1580851716.331 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:36.332Z,1580851716.332 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:36.737Z,1580851716.737 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:37.142Z,1580851717.142 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,FE5,000,002B5,183,80,80,21,FF
2020-02-04T21:28:37.143Z,1580851717.143 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:28:37.279Z,1580851717.279 [Reporter](INFO): acoustic_contact_range 4.080000 m
2020-02-04T21:28:37.280Z,1580851717.280 [Reporter](INFO): DUSBL_Hydroid.xAngle 1.350000 arcdeg
2020-02-04T21:28:37.548Z,1580851717.548 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212837.80*5B

2020-02-04T21:28:39.966Z,1580851719.966 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:39.966Z,1580851719.966 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:39.966Z,1580851719.966 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:39.967Z,1580851719.967 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:40.383Z,1580851720.383 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
FE5,000,002B5,183,80,80,21,FF
2020-02-04T21:28:40.383Z,1580851720.383 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:40.383Z,1580851720.383 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:40.384Z,1580851720.384 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:40.789Z,1580851720.789 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:41.183Z,1580851721.183 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,338,000,002BA,18A,80,80,1D,FF
2020-02-04T21:28:41.183Z,1580851721.183 [DUSBL_Hydroid](INFO): publishing direction and range info
2020-02-04T21:28:41.304Z,1580851721.304 [Reporter](INFO): acoustic_contact_range 4.380000 m
2020-02-04T21:28:41.309Z,1580851721.309 [Reporter](INFO): DUSBL_Hydroid.xAngle -41.200002 arcdeg
2020-02-04T21:28:41.608Z,1580851721.608 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212841.86*5C

2020-02-04T21:28:44.010Z,1580851724.010 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2020-02-04T21:28:44.010Z,1580851724.010 [DUSBL_Hydroid](INFO): ****** received ping request ******
2020-02-04T21:28:44.010Z,1580851724.010 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 30
2020-02-04T21:28:44.011Z,1580851724.011 [DUSBL_Hydroid](INFO): ****** ping requested ******
2020-02-04T21:28:44.410Z,1580851724.410 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
338,000,002BA,18A,80,80,1D,FF
2020-02-04T21:28:44.410Z,1580851724.410 [DUSBL_Hydroid](INFO): Command Ack
2020-02-04T21:28:44.411Z,1580851724.411 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2020-02-04T21:28:44.412Z,1580851724.412 [Micromodem](INFO): Nmea out: $CCPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*3E

2020-02-04T21:28:44.606Z,1580851724.606 [CommandLine](IMPORTANT): got command stop
2020-02-04T21:28:44.606Z,1580851724.606 [CommandLine](IMPORTANT): Scheduling is paused
2020-02-04T21:28:44.606Z,1580851724.606 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2020-02-04T21:28:44.817Z,1580851724.817 [Micromodem](INFO): Nmea in: $SNPGT,0,14500,28,6F8F7A90,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*23

2020-02-04T21:28:44.912Z,1580851724.912 [MissionManager](INFO): MissionManager is completed.
2020-02-04T21:28:44.912Z,1580851724.912 [MissionManager](INFO): Uninitializing Mission DUSBL
2020-02-04T21:28:44.912Z,1580851724.912 [DUSBL] Stopped
2020-02-04T21:28:44.912Z,1580851724.912 [DUSBL](DEBUG): Aggregate::uninitialize DUSBL
2020-02-04T21:28:44.912Z,1580851724.912 [DUSBL:A.Pitch] Stopped
2020-02-04T21:28:44.912Z,1580851724.912 [DUSBL:B.SetSpeed] Stopped
2020-02-04T21:28:44.912Z,1580851724.912 [DUSBL:B.SetSpeed](DEBUG): Uninitialize.
2020-02-04T21:28:44.912Z,1580851724.912 [DUSBL:C] Stopped
2020-02-04T21:28:44.912Z,1580851724.912 [DUSBL:RequestRepeater] Stopped
2020-02-04T21:28:44.913Z,1580851724.913 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2020-02-04T21:28:44.913Z,1580851724.913 [DUSBL:RequestRepeater:A] Stopped
2020-02-04T21:28:44.913Z,1580851724.913 [DUSBL:RequestRepeater:B] Stopped
2020-02-04T21:28:44.913Z,1580851724.913 [DUSBL:RequestRepeater:C.Wait] Stopped
2020-02-04T21:28:44.913Z,1580851724.913 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T21:28:45.271Z,1580851725.271 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2020-02-04T21:28:45.271Z,1580851725.271 [DefaultWithUndock] Running Loop=1
2020-02-04T21:28:45.271Z,1580851725.271 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2020-02-04T21:28:45.271Z,1580851725.271 [DefaultWithUndock:C.GoToSurface] Running Loop=1
2020-02-04T21:28:45.271Z,1580851725.271 [DefaultWithUndock:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-04T21:28:45.272Z,1580851725.272 [DefaultWithUndock:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-04T21:28:45.272Z,1580851725.272 [DefaultWithUndock:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-04T21:28:45.272Z,1580851725.272 [DefaultWithUndock:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-04T21:28:45.272Z,1580851725.272 [DefaultWithUndock:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-04T21:28:45.273Z,1580851725.273 [DefaultWithUndock:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-04T21:28:45.273Z,1580851725.273 [DefaultWithUndock:A.Wait] Running Loop=1
2020-02-04T21:28:45.273Z,1580851725.273 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2020-02-04T21:28:45.631Z,1580851725.631 [Micromodem](INFO): Nmea in: $SNTTA,,,,,212845.89*57

2020-02-04T21:29:01.155Z,1580851741.155 [CommandLine](IMPORTANT): got command show variable DUSBL_hydroid.verbosity
2020-02-04T21:29:01.224Z,1580851741.224 [CommandLine](IMPORTANT): DUSBL_Hydroid.verbosity (enum)
2020-02-04T21:29:07.519Z,1580851747.519 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-02-04T21:29:10.113Z,1580851750.113 [CommandLine](IMPORTANT): got command get DUSBL_Hydroid.verbosity
2020-02-04T21:29:10.113Z,1580851750.113 [CommandLine](IMPORTANT): DUSBL_Hydroid.verbosity 3 enum
2020-02-04T21:29:10.776Z,1580851750.776 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-02-04T21:29:15.575Z,1580851755.575 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2020-02-04T21:29:15.575Z,1580851755.575 [DefaultWithUndock:A.Wait] Stopped
2020-02-04T21:29:15.575Z,1580851755.575 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T21:29:15.575Z,1580851755.575 [DefaultWithUndock:B.Undock] Running Loop=1
2020-02-04T21:29:15.575Z,1580851755.575 [DefaultWithUndock:B.Undock](DEBUG): Initialize.
2020-02-04T21:29:16.347Z,1580851756.347 [PowerOnly](INFO): Powering up
2020-02-04T21:29:19.232Z,1580851759.232 [DefaultWithUndock:B.Undock](INFO): Detaching from dock.
2020-02-04T21:29:19.650Z,1580851759.650 [DefaultWithUndock:B.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby.
2020-02-04T21:29:19.979Z,1580851759.979 [CommandLine](INFO): End of History
2020-02-04T21:29:19.980Z,1580851759.980 [CommandLine](INFO): End of History
2020-02-04T21:29:20.012Z,1580851760.012 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T21:29:20.012Z,1580851760.012 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,-32768,-3:BE,-32768,-32768,-32768,V
2020-02-04T21:29:20.016Z,1580851760.016 [CommandLine](INFO): End of History
2020-02-04T21:29:20.054Z,1580851760.054 [CommandLine](INFO): End of History
2020-02-04T21:29:20.055Z,1580851760.055 [CommandLine](INFO): End of History
2020-02-04T21:29:20.056Z,1580851760.056 [CommandLine](INFO): End of History
2020-02-04T21:29:20.062Z,1580851760.062 [CommandLine](INFO): End of History
2020-02-04T21:29:20.063Z,1580851760.063 [CommandLine](INFO): End of History
2020-02-04T21:29:20.077Z,1580851760.077 [CommandLine](INFO): End of History
2020-02-04T21:29:20.078Z,1580851760.078 [CommandLine](INFO): End of History
2020-02-04T21:29:20.080Z,1580851760.080 [CommandLine](INFO): End of History
2020-02-04T21:29:20.089Z,1580851760.089 [CommandLine](INFO): End of History
2020-02-04T21:29:20.091Z,1580851760.091 [CommandLine](INFO): End of History
2020-02-04T21:29:20.092Z,1580851760.092 [CommandLine](INFO): End of History
2020-02-04T21:29:20.110Z,1580851760.110 [CommandLine](INFO): End of History
2020-02-04T21:29:20.111Z,1580851760.111 [CommandLine](INFO): End of History
2020-02-04T21:29:20.112Z,1580851760.112 [CommandLine](INFO): End of History
2020-02-04T21:29:20.123Z,1580851760.123 [CommandLine](INFO): End of History
2020-02-04T21:29:20.133Z,1580851760.133 [CommandLine](INFO): End of History
2020-02-04T21:29:20.134Z,1580851760.134 [CommandLine](INFO): End of History
2020-02-04T21:29:20.136Z,1580851760.136 [CommandLine](INFO): End of History
2020-02-04T21:29:20.145Z,1580851760.145 [CommandLine](INFO): End of History
2020-02-04T21:29:20.147Z,1580851760.147 [CommandLine](INFO): End of History
2020-02-04T21:29:20.148Z,1580851760.148 [CommandLine](INFO): End of History
2020-02-04T21:29:20.157Z,1580851760.157 [CommandLine](INFO): End of History
2020-02-04T21:29:20.159Z,1580851760.159 [CommandLine](INFO): End of History
2020-02-04T21:29:20.160Z,1580851760.160 [CommandLine](INFO): End of History
2020-02-04T21:29:20.170Z,1580851760.170 [CommandLine](INFO): End of History
2020-02-04T21:29:20.171Z,1580851760.171 [CommandLine](INFO): End of History
2020-02-04T21:29:20.172Z,1580851760.172 [CommandLine](INFO): End of History
2020-02-04T21:29:20.182Z,1580851760.182 [CommandLine](INFO): End of History
2020-02-04T21:29:20.183Z,1580851760.183 [CommandLine](INFO): End of History
2020-02-04T21:29:20.184Z,1580851760.184 [CommandLine](INFO): End of History
2020-02-04T21:29:20.202Z,1580851760.202 [CommandLine](INFO): End of History
2020-02-04T21:29:20.203Z,1580851760.203 [CommandLine](INFO): End of History
2020-02-04T21:29:20.204Z,1580851760.204 [CommandLine](INFO): End of History
2020-02-04T21:29:20.217Z,1580851760.217 [CommandLine](INFO): End of History
2020-02-04T21:29:20.218Z,1580851760.218 [CommandLine](INFO): End of History
2020-02-04T21:29:20.220Z,1580851760.220 [CommandLine](INFO): End of History
2020-02-04T21:29:20.229Z,1580851760.229 [CommandLine](INFO): End of History
2020-02-04T21:29:20.231Z,1580851760.231 [CommandLine](INFO): End of History
2020-02-04T21:29:20.232Z,1580851760.232 [CommandLine](INFO): End of History
2020-02-04T21:29:20.241Z,1580851760.241 [CommandLine](INFO): End of History
2020-02-04T21:29:20.243Z,1580851760.243 [CommandLine](INFO): End of History
2020-02-04T21:29:20.244Z,1580851760.244 [CommandLine](INFO): End of History
2020-02-04T21:29:20.254Z,1580851760.254 [CommandLine](INFO): End of History
2020-02-04T21:29:20.255Z,1580851760.255 [CommandLine](INFO): End of History
2020-02-04T21:29:20.256Z,1580851760.256 [CommandLine](INFO): End of History
2020-02-04T21:29:20.266Z,1580851760.266 [CommandLine](INFO): End of History
2020-02-04T21:29:20.267Z,1580851760.267 [CommandLine](INFO): End of History
2020-02-04T21:29:20.268Z,1580851760.268 [CommandLine](INFO): End of History
2020-02-04T21:29:20.278Z,1580851760.278 [CommandLine](INFO): End of History
2020-02-04T21:29:20.279Z,1580851760.279 [CommandLine](INFO): End of History
2020-02-04T21:29:20.281Z,1580851760.281 [CommandLine](INFO): End of History
2020-02-04T21:29:20.288Z,1580851760.288 [CommandLine](INFO): End of History
2020-02-04T21:29:20.301Z,1580851760.301 [CommandLine](INFO): End of History
2020-02-04T21:29:20.303Z,1580851760.303 [CommandLine](INFO): End of History
2020-02-04T21:29:20.304Z,1580851760.304 [CommandLine](INFO): End of History
2020-02-04T21:29:20.314Z,1580851760.314 [CommandLine](INFO): End of History
2020-02-04T21:29:20.315Z,1580851760.315 [CommandLine](INFO): End of History
2020-02-04T21:29:20.317Z,1580851760.317 [CommandLine](INFO): End of History
2020-02-04T21:29:20.322Z,1580851760.322 [CommandLine](INFO): End of History
2020-02-04T21:29:20.324Z,1580851760.324 [CommandLine](INFO): End of History
2020-02-04T21:29:20.337Z,1580851760.337 [CommandLine](INFO): End of History
2020-02-04T21:29:20.339Z,1580851760.339 [CommandLine](INFO): End of History
2020-02-04T21:29:20.340Z,1580851760.340 [CommandLine](INFO): End of History
2020-02-04T21:29:20.378Z,1580851760.378 [CommandLine](INFO): End of History
2020-02-04T21:29:20.379Z,1580851760.379 [CommandLine](INFO): End of History
2020-02-04T21:29:20.381Z,1580851760.381 [CommandLine](INFO): End of History
2020-02-04T21:29:20.382Z,1580851760.382 [CommandLine](INFO): End of History
2020-02-04T21:29:20.383Z,1580851760.383 [CommandLine](INFO): End of History
2020-02-04T21:29:20.409Z,1580851760.409 [CommandLine](INFO): End of History
2020-02-04T21:29:20.441Z,1580851760.441 [CommandLine](INFO): End of History
2020-02-04T21:29:20.444Z,1580851760.444 [CommandLine](INFO): End of History
2020-02-04T21:29:20.469Z,1580851760.469 [CommandLine](INFO): End of History
2020-02-04T21:29:21.650Z,1580851761.650 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-04T21:29:21.651Z,1580851761.651 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020414422449,35.0, -0,   0.00,   0.00
2020-02-04T21:29:22.467Z,1580851762.467 [DefaultWithUndock:B.Undock](INFO): DDM at standby.
2020-02-04T21:29:22.865Z,1580851762.865 [DefaultWithUndock:B.Undock](IMPORTANT): Undocking sequence complete.
2020-02-04T21:29:22.865Z,1580851762.865 [DefaultWithUndock:B.Undock] Stopped
2020-02-04T21:29:23.234Z,1580851763.234 [DefaultWithUndock:CheckIn] Running Loop=1
2020-02-04T21:29:23.235Z,1580851763.235 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-04T21:29:23.235Z,1580851763.235 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-04T21:29:38.187Z,1580851778.187 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-02-04T21:29:38.210Z,1580851778.210 [BPC1](INFO): Received data from all battery sticks.
2020-02-04T21:29:57.997Z,1580851797.997 [RDI_Pathfinder](ERROR): Failed to parse:
:8,-32768,-32768,V
2020-02-04T21:30:17.384Z,1580851817.384 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-02-04T21:30:17.384Z,1580851817.384 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T21:30:17.394Z,1580851817.394 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T21:30:17.811Z,1580851817.811 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T21:30:17.812Z,1580851817.812 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-02-04T21:30:22.629Z,1580851822.629 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T21:30:22.629Z,1580851822.629 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T21:30:47.649Z,1580851847.649 [PowerOnly](INFO): Powering down
2020-02-04T21:31:21.381Z,1580851881.381 [CommandLine](IMPORTANT): got command show variable detectionThresshold
2020-02-04T21:31:24.022Z,1580851884.022 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-04T21:31:24.022Z,1580851884.022 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020414442649,35.0, -0.,1448.9,  0
2020-02-04T21:31:33.608Z,1580851893.608 [CommandLine](IMPORTANT): got command get DUSBL_Hydroid.detectionThreshold
2020-02-04T21:31:33.609Z,1580851893.609 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold 30 count
2020-02-04T21:31:37.376Z,1580851897.376 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T21:31:37.376Z,1580851897.376 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T21:31:54.304Z,1580851914.304 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-02-04T21:31:54.304Z,1580851914.304 [NAL9602] Data Fault, FailCount= 1
2020-02-04T21:31:54.304Z,1580851914.304 [NAL9602](ERROR): Data Fault
2020-02-04T21:31:54.368Z,1580851914.368 [CBIT](ERROR): Data Fault in component: NAL9602
2020-02-04T21:31:54.709Z,1580851914.709 [NAL9602](INFO): Powering down
2020-02-04T21:31:55.560Z,1580851915.560 [CBIT](INFO): Clearing failed state for component NAL9602
2020-02-04T21:31:55.560Z,1580851915.560 [NAL9602] No Fault, FailCount= 1
2020-02-04T21:32:25.011Z,1580851945.011 [NAL9602](INFO): Powering up NAL9602
2020-02-04T21:32:35.917Z,1580851955.917 [NAL9602](INFO): NAL9602 initialized
2020-02-04T21:32:56.000Z,1580851977.000 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-02-04T21:32:56.000Z,1580851977.000 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,        +0.00,        +0.   +0.00,   0.00,687.98
2020-02-04T21:33:18.382Z,1580851998.382 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-02-04T21:33:18.382Z,1580851998.382 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T21:33:18.392Z,1580851998.392 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T21:33:18.793Z,1580851998.793 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T21:33:18.793Z,1580851998.793 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-02-04T21:34:23.491Z,1580852063.491 [DefaultWithUndock:CheckIn:Read_GPS](INFO): Timed out from 2020-02-04T21:29:23.2Z
2020-02-04T21:34:23.491Z,1580852063.491 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-04T21:34:23.492Z,1580852063.492 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-04T21:34:23.876Z,1580852063.876 [DefaultWithUndock:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-02-04T21:34:31.017Z,1580852071.017 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20200204T203336/Courier0010.lzma
2020-02-04T21:34:33.022Z,1580852073.022 [DataOverHttps](INFO): Moved sent file to Logs/20200204T203336/Courier0010.lzma.bak
2020-02-04T21:34:33.023Z,1580852073.023 [DataOverHttps](INFO): SBD MOMSN=12218266
2020-02-04T21:34:50.097Z,1580852090.097 [DataOverHttps](INFO): Sending 108 bytes from file Logs/20200204T203336/Courier0013.lzma
2020-02-04T21:34:52.106Z,1580852092.106 [DataOverHttps](INFO): Moved sent file to Logs/20200204T203336/Courier0013.lzma.bak
2020-02-04T21:34:52.107Z,1580852092.107 [DataOverHttps](INFO): SBD MOMSN=12218269
2020-02-04T21:35:09.168Z,1580852109.168 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200204T205603/Courier0000.lzma
2020-02-04T21:35:11.174Z,1580852111.174 [DataOverHttps](INFO): Moved sent file to Logs/20200204T205603/Courier0000.lzma.bak
2020-02-04T21:35:11.174Z,1580852111.174 [DataOverHttps](INFO): SBD MOMSN=12218273
2020-02-04T21:35:28.181Z,1580852128.181 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20200204T205603/Courier0004.lzma
2020-02-04T21:35:30.186Z,1580852130.186 [DataOverHttps](INFO): Moved sent file to Logs/20200204T205603/Courier0004.lzma.bak
2020-02-04T21:35:30.187Z,1580852130.187 [DataOverHttps](INFO): SBD MOMSN=12218276
2020-02-04T21:35:47.260Z,1580852147.260 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200204T212104/Courier0000.lzma
2020-02-04T21:35:49.266Z,1580852149.266 [DataOverHttps](INFO): Moved sent file to Logs/20200204T212104/Courier0000.lzma.bak
2020-02-04T21:35:49.267Z,1580852149.267 [DataOverHttps](INFO): SBD MOMSN=12218278
2020-02-04T21:36:06.848Z,1580852166.848 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20200204T212104/Courier0004.lzma
2020-02-04T21:36:08.854Z,1580852168.854 [DataOverHttps](INFO): Moved sent file to Logs/20200204T212104/Courier0004.lzma.bak
2020-02-04T21:36:08.854Z,1580852168.854 [DataOverHttps](INFO): SBD MOMSN=12218281
2020-02-04T21:36:19.385Z,1580852179.385 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-02-04T21:36:19.385Z,1580852179.385 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T21:36:19.395Z,1580852179.395 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T21:36:19.821Z,1580852179.821 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T21:36:19.821Z,1580852179.821 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-02-04T21:36:20.635Z,1580852180.635 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2020-02-04T21:36:25.885Z,1580852185.885 [DataOverHttps](INFO): Sending 245 bytes from file Logs/20200204T191059/Express0017.lzma
2020-02-04T21:36:27.890Z,1580852187.890 [DataOverHttps](INFO): Moved sent file to Logs/20200204T191059/Express0017.lzma.bak
2020-02-04T21:36:27.891Z,1580852187.891 [DataOverHttps](INFO): SBD MOMSN=12218283
2020-02-04T21:36:44.957Z,1580852204.957 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20200204T201954/Express0001.lzma
2020-02-04T21:36:46.964Z,1580852206.964 [DataOverHttps](INFO): Moved sent file to Logs/20200204T201954/Express0001.lzma.bak
2020-02-04T21:36:46.965Z,1580852206.965 [DataOverHttps](INFO): SBD MOMSN=12218290
2020-02-04T21:37:01.001Z,1580852221.001 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T21:37:01.002Z,1580852221.002 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   I,-32768,-32768,-32768,-32768,V
2020-02-04T21:37:04.070Z,1580852224.070 [DataOverHttps](INFO): Sending 725 bytes from file Logs/20200204T202116/Express0001.lzma
2020-02-04T21:37:06.074Z,1580852226.074 [DataOverHttps](INFO): Moved sent file to Logs/20200204T202116/Express0001.lzma.bak
2020-02-04T21:37:06.074Z,1580852226.074 [DataOverHttps](INFO): SBD MOMSN=12218295
2020-02-04T21:37:23.157Z,1580852243.157 [DataOverHttps](INFO): Sending 263 bytes from file Logs/20200204T202116/Express0005.lzma
2020-02-04T21:37:25.162Z,1580852245.162 [DataOverHttps](INFO): Moved sent file to Logs/20200204T202116/Express0005.lzma.bak
2020-02-04T21:37:25.162Z,1580852245.162 [DataOverHttps](INFO): SBD MOMSN=12218312
2020-02-04T21:37:37.366Z,1580852257.366 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-02-04T21:37:37.366Z,1580852257.366 [RDI_Pathfinder](ERROR): Failed to parse:
:BS-32768,-32768,V
2020-02-04T21:37:42.214Z,1580852262.214 [DataOverHttps](INFO): Sending 1089 bytes from file Logs/20200204T203336/Express0001.lzma
2020-02-04T21:37:44.218Z,1580852264.218 [DataOverHttps](INFO): Moved sent file to Logs/20200204T203336/Express0001.lzma.bak
2020-02-04T21:37:44.218Z,1580852264.218 [DataOverHttps](INFO): SBD MOMSN=12218320
2020-02-04T21:38:00.038Z,1580852280.038 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2020-02-04T21:38:03.277Z,1580852283.277 [DataOverHttps](INFO): Sending 602 bytes from file Logs/20200204T203336/Express0005.lzma
2020-02-04T21:38:05.283Z,1580852285.283 [DataOverHttps](INFO): Moved sent file to Logs/20200204T203336/Express0005.lzma.bak
2020-02-04T21:38:05.283Z,1580852285.283 [DataOverHttps](INFO): SBD MOMSN=12218365
2020-02-04T21:38:22.361Z,1580852302.361 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20200204T203336/Express0008.lzma
2020-02-04T21:38:24.366Z,1580852304.366 [DataOverHttps](INFO): Moved sent file to Logs/20200204T203336/Express0008.lzma.bak
2020-02-04T21:38:24.367Z,1580852304.367 [DataOverHttps](INFO): SBD MOMSN=12218392
2020-02-04T21:38:41.526Z,1580852321.526 [DataOverHttps](INFO): Sending 581 bytes from file Logs/20200204T203336/Express0011.lzma
2020-02-04T21:38:43.530Z,1580852323.530 [DataOverHttps](INFO): Moved sent file to Logs/20200204T203336/Express0011.lzma.bak
2020-02-04T21:38:43.531Z,1580852323.531 [DataOverHttps](INFO): SBD MOMSN=12218400
2020-02-04T21:39:00.658Z,1580852340.658 [DataOverHttps](INFO): Sending 759 bytes from file Logs/20200204T203336/Express0014.lzma
2020-02-04T21:39:02.662Z,1580852342.662 [DataOverHttps](INFO): Moved sent file to Logs/20200204T203336/Express0014.lzma.bak
2020-02-04T21:39:02.662Z,1580852342.662 [DataOverHttps](INFO): SBD MOMSN=12218459
2020-02-04T21:39:08.474Z,1580852348.474 [DataOverHttps](INFO): Sending 603 bytes from file Logs/20200204T205603/Express0001.lzma
2020-02-04T21:39:10.472Z,1580852350.472 [DataOverHttps](INFO): Moved sent file to Logs/20200204T205603/Express0001.lzma.bak
2020-02-04T21:39:10.472Z,1580852350.472 [DataOverHttps](INFO): SBD MOMSN=12218492
2020-02-04T21:39:12.492Z,1580852352.492 [CommandLine](IMPORTANT): got command restart system
2020-02-04T21:39:14.607Z,1580852354.607 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T21:39:14.607Z,1580852354.607 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.762Z,1580852354.762 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-02-04T21:39:14.763Z,1580852354.763 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.763Z,1580852354.763 [CommandLine](INFO): Join timeout helper Thread ID is 3982
2020-02-04T21:39:14.774Z,1580852354.774 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-02-04T21:39:14.775Z,1580852354.775 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.775Z,1580852354.775 [NavChartDb](INFO): Join timeout helper Thread ID is 3983
2020-02-04T21:39:14.779Z,1580852354.779 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T21:39:14.779Z,1580852354.779 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.795Z,1580852354.795 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2020-02-04T21:39:14.795Z,1580852354.795 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.795Z,1580852354.795 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 3984
2020-02-04T21:39:14.835Z,1580852354.835 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T21:39:14.835Z,1580852354.835 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-02-04T21:39:14.836Z,1580852354.836 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.847Z,1580852354.847 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-02-04T21:39:14.847Z,1580852354.847 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.847Z,1580852354.847 [Radio_Surface](INFO): Join timeout helper Thread ID is 3985
2020-02-04T21:39:14.859Z,1580852354.859 [Radio_Surface](INFO): Powering down
2020-02-04T21:39:14.860Z,1580852354.860 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T21:39:14.860Z,1580852354.860 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.861Z,1580852354.861 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-02-04T21:39:14.861Z,1580852354.861 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:14.861Z,1580852354.861 [DataOverHttps](INFO): Join timeout helper Thread ID is 3986
2020-02-04T21:39:17.027Z,1580852357.027 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T21:39:17.032Z,1580852357.032 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.036Z,1580852357.036 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-02-04T21:39:17.036Z,1580852357.036 [logger ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.036Z,1580852357.036 [logger](INFO): Join timeout helper Thread ID is 3987
2020-02-04T21:39:17.051Z,1580852357.051 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T21:39:17.051Z,1580852357.051 [logger ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.055Z,1580852357.055 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-02-04T21:39:17.055Z,1580852357.055 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.056Z,1580852357.056 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-02-04T21:39:17.056Z,1580852357.056 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.056Z,1580852357.056 [controlThread](INFO): Join timeout helper Thread ID is 3988
2020-02-04T21:39:17.123Z,1580852357.123 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T21:39:17.123Z,1580852357.123 [controlThread](DEBUG): Uninitializing ControlThread
2020-02-04T21:39:17.123Z,1580852357.123 [AHRS_M2](INFO): Powering down
2020-02-04T21:39:17.195Z,1580852357.195 [DDM](INFO): Powering down
2020-02-04T21:39:17.291Z,1580852357.291 [DUSBL_Hydroid](INFO): Powering down
2020-02-04T21:39:17.363Z,1580852357.363 [Micromodem](INFO): Powering down
2020-02-04T21:39:17.459Z,1580852357.459 [NAL9602](INFO): Powering down
2020-02-04T21:39:17.531Z,1580852357.531 [RDI_Pathfinder](INFO): Powering down
2020-02-04T21:39:17.532Z,1580852357.532 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-02-04T21:39:17.533Z,1580852357.533 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-02-04T21:39:17.534Z,1580852357.534 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-02-04T21:39:17.534Z,1580852357.534 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock
2020-02-04T21:39:17.534Z,1580852357.534 [DefaultWithUndock] Stopped
2020-02-04T21:39:17.535Z,1580852357.535 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-02-04T21:39:17.535Z,1580852357.535 [DefaultWithUndock:C.GoToSurface] Stopped
2020-02-04T21:39:17.535Z,1580852357.535 [DefaultWithUndock:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-04T21:39:17.535Z,1580852357.535 [DefaultWithUndock:CheckIn] Stopped
2020-02-04T21:39:17.535Z,1580852357.535 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-04T21:39:17.535Z,1580852357.535 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-04T21:39:17.538Z,1580852357.538 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-02-04T21:39:17.539Z,1580852357.539 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-02-04T21:39:17.539Z,1580852357.539 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-02-04T21:39:17.539Z,1580852357.539 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-02-04T21:39:17.539Z,1580852357.539 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-02-04T21:39:17.539Z,1580852357.539 [BuoyancyServo](INFO): Powering down
2020-02-04T21:39:17.551Z,1580852357.551 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-04T21:39:17.551Z,1580852357.551 [ElevatorServo](INFO): Powering down
2020-02-04T21:39:17.552Z,1580852357.552 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-02-04T21:39:17.552Z,1580852357.552 [MassServo](INFO): Powering down
2020-02-04T21:39:17.553Z,1580852357.553 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-02-04T21:39:17.553Z,1580852357.553 [RudderServo](INFO): Powering down
2020-02-04T21:39:17.554Z,1580852357.554 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-02-04T21:39:17.554Z,1580852357.554 [ThrusterServo](INFO): Powering down
2020-02-04T21:39:17.555Z,1580852357.555 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-02-04T21:39:17.555Z,1580852357.555 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-02-04T21:39:17.556Z,1580852357.556 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-02-04T21:39:17.556Z,1580852357.556 [CBIT](DEBUG): Powering off loads.
2020-02-04T21:39:17.566Z,1580852357.566 [CBIT](DEBUG): Disabling WDT.
2020-02-04T21:39:17.578Z,1580852357.578 [CBIT](DEBUG): Opening all GF detection circuits.
2020-02-04T21:39:17.579Z,1580852357.579 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.633Z,1580852357.633 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.645Z,1580852357.645 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.689Z,1580852357.689 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.750Z,1580852357.750 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-04T21:39:17.812Z,1580852357.812 [logger ThreadHandler](INFO): Thread cancelled.