2020-01-24T17:58:31.950Z,1579888711.950 [Supervisor](DEBUG): Initializing supervisor. 2020-01-24T17:58:31.953Z,1579888711.953 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-01-24T17:58:31.953Z,1579888711.953 [SyncHandler](INFO): Protected caller Thread ID is 9193 2020-01-24T17:58:31.954Z,1579888711.954 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-01-24T17:58:31.955Z,1579888711.955 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-01-24T17:58:31.955Z,1579888711.955 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9194 2020-01-24T17:58:31.958Z,1579888711.958 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-01-24T17:58:31.970Z,1579888711.970 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-01-24T17:58:31.971Z,1579888711.971 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-01-24T17:58:31.971Z,1579888711.971 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9195 2020-01-24T17:58:31.972Z,1579888711.972 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-01-24T17:58:31.973Z,1579888711.973 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-01-24T17:58:31.973Z,1579888711.973 [logger ThreadHandler](INFO): Protected caller Thread ID is 9196 2020-01-24T17:58:31.975Z,1579888711.975 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-01-24T17:58:31.975Z,1579888711.975 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-01-24T17:58:31.977Z,1579888711.977 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-01-24T17:58:32.402Z,1579888712.402 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-01-24T17:58:32.403Z,1579888712.403 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-01-24T17:58:32.501Z,1579888712.501 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-01-24T17:58:32.501Z,1579888712.501 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-01-24T17:58:32.818Z,1579888712.818 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-01-24T17:58:32.818Z,1579888712.818 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-01-24T17:58:32.955Z,1579888712.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-01-24T17:58:32.956Z,1579888712.956 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-01-24T17:58:33.144Z,1579888713.144 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-01-24T17:58:33.145Z,1579888713.145 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-01-24T17:58:33.579Z,1579888713.579 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-01-24T17:58:33.580Z,1579888713.580 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-01-24T17:58:33.786Z,1579888713.786 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-01-24T17:58:33.786Z,1579888713.786 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-01-24T17:58:33.929Z,1579888713.929 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-01-24T17:58:33.929Z,1579888713.929 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-01-24T17:58:34.117Z,1579888714.117 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-01-24T17:58:34.117Z,1579888714.117 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-01-24T17:58:34.213Z,1579888714.213 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-01-24T17:58:34.214Z,1579888714.214 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-01-24T17:58:34.507Z,1579888714.507 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-01-24T17:58:34.508Z,1579888714.508 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-01-24T17:58:34.589Z,1579888714.589 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-01-24T17:58:34.693Z,1579888714.693 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-01-24T17:58:34.693Z,1579888714.693 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-01-24T17:58:35.315Z,1579888715.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-01-24T17:58:35.316Z,1579888715.316 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-01-24T17:58:35.714Z,1579888715.714 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-01-24T17:58:35.716Z,1579888715.716 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/ 2020-01-24T17:58:35.717Z,1579888715.717 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg 2020-01-24T17:58:35.926Z,1579888715.926 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg 2020-01-24T17:58:36.034Z,1579888716.034 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg 2020-01-24T17:58:36.448Z,1579888716.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg 2020-01-24T17:58:37.024Z,1579888717.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-01-24T17:58:37.024Z,1579888717.024 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg 2020-01-24T17:58:37.109Z,1579888717.109 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg 2020-01-24T17:58:37.203Z,1579888717.203 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg 2020-01-24T17:58:37.300Z,1579888717.300 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg 2020-01-24T17:58:37.384Z,1579888717.384 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg 2020-01-24T17:58:37.491Z,1579888717.491 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/workSite.cfg 2020-01-24T17:58:37.584Z,1579888717.584 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg 2020-01-24T17:58:37.765Z,1579888717.765 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg 2020-01-24T17:58:37.895Z,1579888717.895 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/ 2020-01-24T17:58:37.896Z,1579888717.896 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-01-24T17:58:37.899Z,1579888717.899 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-01-24T17:58:38.190Z,1579888718.190 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-01-24T17:58:38.195Z,1579888718.195 [AHRS_M2](INFO): created writer for : platform_orientation 2020-01-24T17:58:38.197Z,1579888718.197 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-01-24T17:58:38.201Z,1579888718.201 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-01-24T17:58:38.202Z,1579888718.202 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-01-24T17:58:38.207Z,1579888718.207 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-01-24T17:58:38.207Z,1579888718.207 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-01-24T17:58:38.212Z,1579888718.212 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-01-24T17:58:38.277Z,1579888718.277 [AHRS_M2] Loaded 2020-01-24T17:58:38.277Z,1579888718.277 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-01-24T17:58:38.363Z,1579888718.363 [DataOverHttps] Loaded 2020-01-24T17:58:38.363Z,1579888718.363 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-01-24T17:58:38.364Z,1579888718.364 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407684E0 2020-01-24T17:58:38.364Z,1579888718.364 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9278 2020-01-24T17:58:38.387Z,1579888718.387 [DDM] Loaded 2020-01-24T17:58:38.387Z,1579888718.387 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread. 2020-01-24T17:58:38.399Z,1579888718.399 [Depth_Keller] Loaded 2020-01-24T17:58:38.399Z,1579888718.399 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-01-24T17:58:38.403Z,1579888718.403 [DropWeight] Loaded 2020-01-24T17:58:38.404Z,1579888718.404 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2020-01-24T17:58:38.461Z,1579888718.461 [DUSBL_Hydroid] Loaded 2020-01-24T17:58:38.461Z,1579888718.461 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread. 2020-01-24T17:58:38.504Z,1579888718.504 [Micromodem] Loaded 2020-01-24T17:58:38.504Z,1579888718.504 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread. 2020-01-24T17:58:38.594Z,1579888718.594 [NAL9602] Loaded 2020-01-24T17:58:38.594Z,1579888718.594 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-01-24T17:58:38.631Z,1579888718.631 [Onboard] Loaded 2020-01-24T17:58:38.631Z,1579888718.631 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2020-01-24T17:58:38.636Z,1579888718.636 [PowerOnly] Loaded 2020-01-24T17:58:38.637Z,1579888718.637 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2020-01-24T17:58:38.643Z,1579888718.643 [Radio_Surface] Loaded 2020-01-24T17:58:38.643Z,1579888718.643 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-01-24T17:58:38.644Z,1579888718.644 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407984E0 2020-01-24T17:58:38.644Z,1579888718.644 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9279 2020-01-24T17:58:38.684Z,1579888718.684 [RDI_Pathfinder] Loaded 2020-01-24T17:58:38.684Z,1579888718.684 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2020-01-24T17:58:40.283Z,1579888720.283 [BPC1] Loaded 2020-01-24T17:58:40.283Z,1579888720.283 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-01-24T17:58:40.284Z,1579888720.284 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-01-24T17:58:40.284Z,1579888720.284 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-01-24T17:58:40.297Z,1579888720.297 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-01-24T17:58:40.297Z,1579888720.297 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-01-24T17:58:40.406Z,1579888720.406 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-01-24T17:58:40.406Z,1579888720.406 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-01-24T17:58:40.425Z,1579888720.425 [NavChart] Loaded 2020-01-24T17:58:40.425Z,1579888720.425 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-01-24T17:58:40.429Z,1579888720.429 [UniversalFixResidualReporter] Loaded 2020-01-24T17:58:40.429Z,1579888720.429 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-01-24T17:58:40.430Z,1579888720.430 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-01-24T17:58:40.430Z,1579888720.430 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-01-24T17:58:40.531Z,1579888720.531 [BuoyancyServo] Loaded 2020-01-24T17:58:40.531Z,1579888720.531 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-01-24T17:58:40.545Z,1579888720.545 [ElevatorServo] Loaded 2020-01-24T17:58:40.545Z,1579888720.545 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-01-24T17:58:40.559Z,1579888720.559 [MassServo] Loaded 2020-01-24T17:58:40.559Z,1579888720.559 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-01-24T17:58:40.574Z,1579888720.574 [RudderServo] Loaded 2020-01-24T17:58:40.574Z,1579888720.574 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-01-24T17:58:40.588Z,1579888720.588 [ThrusterServo] Loaded 2020-01-24T17:58:40.588Z,1579888720.588 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-01-24T17:58:40.588Z,1579888720.588 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-01-24T17:58:40.589Z,1579888720.589 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-01-24T17:58:40.765Z,1579888720.765 [PAR_Licor] Loaded 2020-01-24T17:58:40.766Z,1579888720.766 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-01-24T17:58:40.806Z,1579888720.806 [WetLabsSeaOWL_UV_A] Loaded 2020-01-24T17:58:40.806Z,1579888720.806 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2020-01-24T17:58:40.807Z,1579888720.807 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408EC4E0 2020-01-24T17:58:40.808Z,1579888720.808 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 9280 2020-01-24T17:58:40.808Z,1579888720.808 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-01-24T17:58:40.809Z,1579888720.809 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-01-24T17:58:41.116Z,1579888721.116 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-01-24T17:58:41.117Z,1579888721.117 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-01-24T17:58:41.298Z,1579888721.298 [DepthRateCalculator] Loaded 2020-01-24T17:58:41.298Z,1579888721.298 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-01-24T17:58:41.328Z,1579888721.328 [PitchRateCalculator] Loaded 2020-01-24T17:58:41.383Z,1579888721.383 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-01-24T17:58:41.454Z,1579888721.454 [SpeedCalculator] Loaded 2020-01-24T17:58:41.454Z,1579888721.454 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-01-24T17:58:41.506Z,1579888721.506 [TempGradientCalculator] Loaded 2020-01-24T17:58:41.507Z,1579888721.507 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-01-24T17:58:41.551Z,1579888721.551 [YawRateCalculator] Loaded 2020-01-24T17:58:41.552Z,1579888721.552 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-01-24T17:58:41.589Z,1579888721.589 [ElevatorOffsetCalculator] Loaded 2020-01-24T17:58:41.589Z,1579888721.589 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-01-24T17:58:41.589Z,1579888721.589 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-01-24T17:58:41.590Z,1579888721.590 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-01-24T17:58:41.721Z,1579888721.721 [SBIT](DEBUG): Construct Startup Built In Test. 2020-01-24T17:58:41.741Z,1579888721.741 [SBIT] Loaded 2020-01-24T17:58:41.742Z,1579888721.742 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-01-24T17:58:41.742Z,1579888721.742 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-01-24T17:58:41.754Z,1579888721.754 [IBIT] Loaded 2020-01-24T17:58:41.754Z,1579888721.754 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-01-24T17:58:41.757Z,1579888721.757 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-01-24T17:58:41.886Z,1579888721.886 [CBIT] Loaded 2020-01-24T17:58:41.886Z,1579888721.886 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-01-24T17:58:41.886Z,1579888721.886 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-01-24T17:58:41.887Z,1579888721.887 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-01-24T17:58:41.963Z,1579888721.963 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-01-24T17:58:41.963Z,1579888721.963 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-01-24T17:58:42.054Z,1579888722.054 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-01-24T17:58:42.054Z,1579888722.054 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-01-24T17:58:42.099Z,1579888722.099 [VerticalControl](DEBUG): Construct VerticalControl. 2020-01-24T17:58:42.176Z,1579888722.176 [VerticalControl] Loaded 2020-01-24T17:58:42.176Z,1579888722.176 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-01-24T17:58:42.176Z,1579888722.177 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-01-24T17:58:42.241Z,1579888722.241 [HorizontalControl] Loaded 2020-01-24T17:58:42.241Z,1579888722.241 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-01-24T17:58:42.242Z,1579888722.242 [SpeedControl](DEBUG): Construct SpeedControl. 2020-01-24T17:58:42.243Z,1579888722.243 [SpeedControl] Loaded 2020-01-24T17:58:42.244Z,1579888722.244 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-01-24T17:58:42.244Z,1579888722.244 [LoopControl](DEBUG): Construct LoopControl. 2020-01-24T17:58:42.245Z,1579888722.245 [LoopControl] Loaded 2020-01-24T17:58:42.245Z,1579888722.245 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-01-24T17:58:42.245Z,1579888722.245 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-01-24T17:58:42.246Z,1579888722.246 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-01-24T17:58:42.276Z,1579888722.276 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-01-24T17:58:42.279Z,1579888722.279 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-01-24T17:58:42.280Z,1579888722.280 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-01-24T17:58:42.286Z,1579888722.286 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-01-24T17:58:42.287Z,1579888722.287 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ACC4E0 2020-01-24T17:58:42.288Z,1579888722.288 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9281 2020-01-24T17:58:42.292Z,1579888722.292 [Supervisor](INFO): Main Thread ID is 8829 2020-01-24T17:58:42.292Z,1579888722.292 [Supervisor](DEBUG): Running supervisor. 2020-01-24T17:58:42.293Z,1579888722.293 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9282 2020-01-24T17:58:42.295Z,1579888722.295 [controlThread ThreadHandler](INFO): Handler Thread ID is 9283 2020-01-24T17:58:42.296Z,1579888722.296 [controlThread](DEBUG): Initializing ControlThread 2020-01-24T17:58:42.303Z,1579888722.303 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-01-24T17:58:42.303Z,1579888722.303 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-01-24T17:58:42.307Z,1579888722.307 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-01-24T17:58:42.308Z,1579888722.308 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-01-24T17:58:42.308Z,1579888722.308 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-01-24T17:58:42.308Z,1579888722.308 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-01-24T17:58:42.309Z,1579888722.309 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-01-24T17:58:42.309Z,1579888722.309 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-01-24T17:58:42.310Z,1579888722.310 [SBIT](INFO): Initialize SBIT Component. 2020-01-24T17:58:42.310Z,1579888722.310 [SBIT](IMPORTANT): git: 2019-12-03-78-gb92fbb9 2020-01-24T17:58:42.310Z,1579888722.310 [SBIT](INFO): git hash: b92fbb99b4c8d1793352820b784fbd968d0634e4 2020-01-24T17:58:42.311Z,1579888722.311 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-01-24T17:58:42.312Z,1579888722.312 [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-01-24T17:58:42.313Z,1579888722.313 [SBIT](INFO): Beginning SBIT in 39.000000 seconds. 2020-01-24T17:58:42.314Z,1579888722.314 [IBIT](INFO): Initialize IBIT Component. 2020-01-24T17:58:42.315Z,1579888722.315 [CBIT](DEBUG): Initialize CBIT Component. 2020-01-24T17:58:42.316Z,1579888722.316 [logger ThreadHandler](INFO): Handler Thread ID is 9284 2020-01-24T17:58:42.327Z,1579888722.327 [CBIT](DEBUG): Initialized mux pins. 2020-01-24T17:58:42.327Z,1579888722.327 [CBIT](DEBUG): Initializing the watchdog timer. 2020-01-24T17:58:42.335Z,1579888722.335 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9285 2020-01-24T17:58:42.336Z,1579888722.336 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-01-24T17:58:42.347Z,1579888722.347 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9286 2020-01-24T17:58:42.351Z,1579888722.351 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-01-24T17:58:42.351Z,1579888722.351 [CBIT](DEBUG): Initializing heartbeat. 2020-01-24T17:58:42.359Z,1579888722.359 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 9287 2020-01-24T17:58:42.360Z,1579888722.360 [WetLabsSeaOWL_UV_A](INFO): Powering down 2020-01-24T17:58:42.383Z,1579888722.383 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9288 2020-01-24T17:58:42.386Z,1579888722.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-01-24T17:58:42.387Z,1579888722.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-01-24T17:58:42.387Z,1579888722.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-01-24T17:58:42.387Z,1579888722.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-01-24T17:58:42.387Z,1579888722.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-01-24T17:58:42.388Z,1579888722.388 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-01-24T17:58:42.388Z,1579888722.388 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-01-24T17:58:42.388Z,1579888722.388 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-01-24T17:58:42.388Z,1579888722.388 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-01-24T17:58:42.388Z,1579888722.388 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-01-24T17:58:42.388Z,1579888722.388 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-01-24T17:58:42.389Z,1579888722.389 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-01-24T17:58:42.389Z,1579888722.389 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-01-24T17:58:42.389Z,1579888722.389 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-01-24T17:58:42.389Z,1579888722.389 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-01-24T17:58:42.389Z,1579888722.389 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-01-24T17:58:42.423Z,1579888722.423 [CBIT](DEBUG): Deactivating GF circuits. 2020-01-24T17:58:42.423Z,1579888722.423 [CBIT](DEBUG): Deactivating emergency mode. 2020-01-24T17:58:42.459Z,1579888722.459 [CBIT](DEBUG): Backplane powered. 2020-01-24T17:58:42.459Z,1579888722.459 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-01-24T17:58:42.461Z,1579888722.461 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-01-24T17:58:42.462Z,1579888722.462 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-01-24T17:58:42.462Z,1579888722.462 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-01-24T17:58:42.463Z,1579888722.463 [MissionManager](INFO): Loading Mission: Missions/underIce/StartupUnder.xml 2020-01-24T17:58:42.468Z,1579888722.468 [MissionManager](ERROR): Top node has no child nodes: Mission 2020-01-24T17:58:42.468Z,1579888722.468 [MissionManager](ERROR): Could not load startup mission. 2020-01-24T17:58:42.469Z,1579888722.469 [MissionManager](INFO): Loading Mission: Missions/underIce/DefaultUnder.xml 2020-01-24T17:58:42.681Z,1579888722.681 [MissionManager](INFO): DefineArg DefaultUnder.uModemCommsInterval = 5.000000 min 2020-01-24T17:58:42.723Z,1579888722.723 [MissionManager](INFO): DefineArg DefaultUnder.TransponderCode = 2.000000 count 2020-01-24T17:58:42.734Z,1579888722.734 [MissionManager](INFO): DefineArg DefaultUnder.AcousticUpdatePeriod = 60.000000 s 2020-01-24T17:58:42.737Z,1579888722.737 [MissionManager](INFO): DefineArg DefaultUnder.DockingAcousticUpdatePeriod = 2.500000 s 2020-01-24T17:58:42.751Z,1579888722.751 [Radio_Surface](INFO): Powering up 2020-01-24T17:58:42.774Z,1579888722.774 [MissionManager](INFO): DefineArg DefaultUnder.NumberOfPings = 1.000000 count 2020-01-24T17:58:42.777Z,1579888722.777 [MissionManager](INFO): DefineOutput DefaultUnder.TrackingUpdatePeriod = 60.000000 n/a 2020-01-24T17:58:42.800Z,1579888722.800 [MissionManager](INFO): DefineOutput DefaultUnder.Surface = -1.000000 count 2020-01-24T17:58:42.804Z,1579888722.804 [MissionManager](INFO): DefineOutput DefaultUnder.Docked = 0.000000 count 2020-01-24T17:58:42.823Z,1579888722.823 [MissionManager](INFO): DefineOutput DefaultUnder.Home = 1.000000 count 2020-01-24T17:58:42.826Z,1579888722.826 [MissionManager](INFO): DefineOutput DefaultUnder.DefaultMode = 0.000000 n/a 2020-01-24T17:58:42.834Z,1579888722.834 [MissionManager](INFO): DefineOutput DefaultUnder.CaptureMode = -1.000000 count 2020-01-24T17:58:42.837Z,1579888722.837 [MissionManager](INFO): DefineOutput DefaultUnder.ElapsedSinceDefaultStarted = 0.000000 min 2020-01-24T17:58:42.860Z,1579888722.860 [DefaultUnder:Notify:A:A:A.Wait](DEBUG): Construct Wait. 2020-01-24T17:58:42.882Z,1579888722.882 [DefaultUnder:Notify:A:C.Execute](DEBUG): Construct Execute. 2020-01-24T17:58:43.090Z,1579888723.090 [MissionManager](INFO): Inserting Stack: Missions/Insert/LineCapture.xml 2020-01-24T17:58:43.593Z,1579888723.593 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.DockDepth = 6.000000 _ 2020-01-24T17:58:43.597Z,1579888723.597 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.DockLat = 0.642341 _ 2020-01-24T17:58:43.628Z,1579888723.628 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.DockLon = -2.126200 _ 2020-01-24T17:58:43.631Z,1579888723.631 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.DetachRange = 8.000000 m 2020-01-24T17:58:43.634Z,1579888723.634 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.DetachTimeout = 30.000000 min 2020-01-24T17:58:43.650Z,1579888723.650 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.MidcourseDepth = 15.000000 m 2020-01-24T17:58:43.653Z,1579888723.653 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.MidcourseSpeed = 1.000000 m/s 2020-01-24T17:58:43.680Z,1579888723.680 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.MidcourseTimeout = 12.000000 h 2020-01-24T17:58:43.684Z,1579888723.684 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.TerminalRange = 650.000000 m 2020-01-24T17:58:43.699Z,1579888723.699 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.ArmRange = 40.000000 m 2020-01-24T17:58:43.702Z,1579888723.702 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.DockRange = 2.000000 m 2020-01-24T17:58:43.705Z,1579888723.705 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.DockTimeout = 60.000000 s 2020-01-24T17:58:43.718Z,1579888723.718 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.RolloutDistance = 250.000000 m 2020-01-24T17:58:43.721Z,1579888723.721 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.AcousticTimeout = 10.000000 min 2020-01-24T17:58:43.752Z,1579888723.752 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.TerminalSpeed = 0.800000 m/s 2020-01-24T17:58:43.756Z,1579888723.756 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.SearchTimeout = 60.000000 min 2020-01-24T17:58:43.775Z,1579888723.775 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.CircleRadius = 300.000000 m 2020-01-24T17:58:43.778Z,1579888723.778 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.CircleMaxError = 100.000000 m 2020-01-24T17:58:43.781Z,1579888723.781 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.CircleTurnToPort = 0 bool 2020-01-24T17:58:43.793Z,1579888723.793 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.DepthDeadband = 0.010000 m 2020-01-24T17:58:43.796Z,1579888723.796 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.RudderDeadband = 0.001000 arcdeg 2020-01-24T17:58:43.827Z,1579888723.827 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.MinAltitude = 5.000000 m 2020-01-24T17:58:43.831Z,1579888723.831 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.MaxDepth = 205.000000 m 2020-01-24T17:58:43.834Z,1579888723.834 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.MinOffshore = 500.000000 m 2020-01-24T17:58:43.854Z,1579888723.854 [MissionManager](INFO): DefineOutput DefaultUnder:LineCapture.Depth = 15.000000 n/a 2020-01-24T17:58:43.857Z,1579888723.857 [MissionManager](INFO): DefineOutput DefaultUnder:LineCapture.Speed = 1.000000 n/a 2020-01-24T17:58:43.868Z,1579888723.868 [MissionManager](INFO): DefineOutput DefaultUnder:LineCapture.DoneTimeout = -1.000000 count 2020-01-24T17:58:43.872Z,1579888723.872 [MissionManager](INFO): DefineOutput DefaultUnder:LineCapture.Done = 0.000000 count 2020-01-24T17:58:43.899Z,1579888723.899 [MissionManager](INFO): DefineOutput DefaultUnder:LineCapture.DetachFromDock = 1.000000 count 2020-01-24T17:58:43.903Z,1579888723.903 [MissionManager](INFO): DefineOutput DefaultUnder:LineCapture.Midcourse = 2.000000 count 2020-01-24T17:58:43.906Z,1579888723.906 [MissionManager](INFO): DefineOutput DefaultUnder:LineCapture.Terminal = 3.000000 count 2020-01-24T17:58:43.925Z,1579888723.925 [MissionManager](INFO): DefineOutput DefaultUnder:LineCapture.GuidanceMode = 1.000000 n/a 2020-01-24T17:58:43.937Z,1579888723.937 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.ElapsedRange = 0.000000 min 2020-01-24T17:58:43.948Z,1579888723.948 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture.Range = nan m 2020-01-24T17:58:43.950Z,1579888723.950 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2020-01-24T17:58:44.128Z,1579888724.128 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture:StandardEnvelopes.MinAltitude = 5.000000 m 2020-01-24T17:58:44.144Z,1579888724.144 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture:StandardEnvelopes.MaxDepth = 200.000000 m 2020-01-24T17:58:44.208Z,1579888724.208 [MissionManager](INFO): DefineArg DefaultUnder:LineCapture:StandardEnvelopes.MinOffshore = 2000.000000 m 2020-01-24T17:58:44.209Z,1579888724.209 [DefaultUnder:LineCapture:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2020-01-24T17:58:44.240Z,1579888724.240 [DefaultUnder:LineCapture:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2020-01-24T17:58:44.276Z,1579888724.276 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2020-01-24T17:58:44.386Z,1579888724.386 [DefaultUnder:LineCapture:H.Mass](DEBUG): Construct. 2020-01-24T17:58:44.490Z,1579888724.490 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:B.Buoyancy](DEBUG): Construct Buoyancy. 2020-01-24T17:58:44.494Z,1579888724.494 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:C.SetSpeed](DEBUG): Construct. 2020-01-24T17:58:44.497Z,1579888724.497 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:D.Pitch](DEBUG): Construct. 2020-01-24T17:58:44.521Z,1579888724.521 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:A.SetSpeed](DEBUG): Construct. 2020-01-24T17:58:44.540Z,1579888724.540 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:B.Pitch](DEBUG): Construct. 2020-01-24T17:58:44.567Z,1579888724.567 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](DEBUG): Construct. 2020-01-24T17:58:44.634Z,1579888724.634 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Construct Waypoint. 2020-01-24T17:58:44.660Z,1579888724.660 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:G.Circle](DEBUG): Construct. 2020-01-24T17:58:44.730Z,1579888724.730 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](DEBUG): Construct. 2020-01-24T17:58:44.792Z,1579888724.792 [DefaultUnder:LineCapture:K.Wait](DEBUG): Construct Wait. 2020-01-24T17:58:44.794Z,1579888724.794 [MissionManager](INFO): Inserting Stack: Missions/Insert/SetNavAcoustic.xml 2020-01-24T17:58:44.874Z,1579888724.874 [MissionManager](INFO): DefineArg DefaultUnder:SetNavAcoustic.DockLat = 0.642341 _ 2020-01-24T17:58:44.878Z,1579888724.878 [MissionManager](INFO): DefineArg DefaultUnder:SetNavAcoustic.DockLon = -2.126200 _ 2020-01-24T17:58:44.890Z,1579888724.890 [MissionManager](INFO): DefineArg DefaultUnder:SetNavAcoustic.DockRange = 2.000000 m 2020-01-24T17:58:44.901Z,1579888724.901 [MissionManager](INFO): DefineArg DefaultUnder:SetNavAcoustic.RangeTimeout = 5.000000 min 2020-01-24T17:58:44.923Z,1579888724.923 [DefaultUnder:SetNavAcoustic:UpdateNav:B.SetNav](DEBUG): Construct SetNav. 2020-01-24T17:58:44.927Z,1579888724.927 [DefaultUnder:F.Wait](DEBUG): Construct Wait. 2020-01-24T17:58:44.953Z,1579888724.953 [DefaultUnder:Default:Docked:run:B.Docked](DEBUG): Construct. 2020-01-24T17:58:45.002Z,1579888725.002 [DefaultUnder:Default:Surface:run:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-01-24T17:58:45.064Z,1579888725.064 [DefaultUnder:Default:Surface:run:SurfaceComms:Read_Iridium_uModem:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-01-24T17:58:45.066Z,1579888725.066 [DefaultUnder:Default:Surface:run:SurfaceComms:C.Wait](DEBUG): Construct Wait. 2020-01-24T17:58:45.127Z,1579888725.127 [MissionManager](DEBUG): How often to trigger uModem communications 5 Dock transponder Address. 2 How long to wait between acoustic queries while the mission is in an idle state (on the dock or surface). 60 How long to wait between acoustic queries while the mission is actively docking (line capture) 2.5 Number of pings requested each time. 1 How long to wait between acoustic queries. Mission variable (don't change). The mission will run in this mode to go to the surface after homing attempts have failed. -1 Mission variable (don't change). The mission will run in this mode when the vehicle is docked. 0 Mission variable (don't change). The mission will run in this mode when homing to the dock. 1 Mission variable (don't change). The mission sets this variable to switch between default modes. Mission variable (don't change). The mission sets this variable to reflect the termination status of the LineCapture insert. -1 0 5 Default mission has been running for Restarting logs. restart logs Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 2020-01-24T17:58:45.139Z,1579888725.139 [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-01-24T17:58:45.151Z,1579888725.151 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-01-24T17:58:45.192Z,1579888725.192 [DDM](INFO): Powering up 2020-01-24T17:58:45.192Z,1579888725.192 [DDM](DEBUG): Initializing DDM. 2020-01-24T17:58:45.301Z,1579888725.301 [DUSBL_Hydroid](INFO): Powering up 2020-01-24T17:58:45.301Z,1579888725.301 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid. 2020-01-24T17:58:45.505Z,1579888725.505 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-01-24T17:58:45.511Z,1579888725.511 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-01-24T17:58:45.512Z,1579888725.512 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-01-24T17:58:45.523Z,1579888725.523 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-01-24T17:58:45.524Z,1579888725.524 [MassServo](DEBUG): Initializing EZServoServo. 2020-01-24T17:58:45.531Z,1579888725.531 [MassServo](DEBUG): Initializing MassServo. 2020-01-24T17:58:45.532Z,1579888725.532 [RudderServo](DEBUG): Initializing EZServoServo. 2020-01-24T17:58:45.539Z,1579888725.539 [RudderServo](DEBUG): Initializing RudderServo. 2020-01-24T17:58:45.540Z,1579888725.540 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-01-24T17:58:45.547Z,1579888725.547 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-01-24T17:58:45.630Z,1579888725.630 [Micromodem](INFO): Powering up 2020-01-24T17:58:45.630Z,1579888725.630 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-24T17:58:50.603Z,1579888730.603 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33 2020-01-24T17:58:51.006Z,1579888731.006 [Micromodem](INFO): Nmea in: $CATMG,2020-01-24T17:58:50.883040Z,RTC,RTC*5E 2020-01-24T17:58:51.006Z,1579888731.006 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2020-01-24T17:58:50.883040Z,RTC,RTC*5E 2020-01-24T17:58:51.409Z,1579888731.409 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31 2020-01-24T17:58:51.409Z,1579888731.409 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31 2020-01-24T17:58:51.810Z,1579888731.810 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33 2020-01-24T17:58:51.810Z,1579888731.810 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64 2020-01-24T17:58:52.222Z,1579888732.222 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66 2020-01-24T17:58:52.222Z,1579888732.222 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F 2020-01-24T17:58:52.625Z,1579888732.625 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D 2020-01-24T17:58:52.626Z,1579888732.626 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E 2020-01-24T17:58:53.029Z,1579888733.029 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C 2020-01-24T17:58:53.029Z,1579888733.029 [Micromodem](INFO): Nmea out: $CCCFG,FC0,10000*46 2020-01-24T17:58:53.429Z,1579888733.429 [Micromodem](INFO): Nmea in: $CACFG,FC0,10000*44 2020-01-24T17:58:53.429Z,1579888733.429 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63 2020-01-24T17:58:53.837Z,1579888733.837 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61 2020-01-24T17:58:53.838Z,1579888733.838 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A 2020-01-24T17:58:54.213Z,1579888734.213 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38 2020-01-24T17:58:54.217Z,1579888734.217 [Micromodem](INFO): Nmea out: $CCCLK,2020,01,24,17,58,55*48 2020-01-24T17:58:54.634Z,1579888734.634 [Micromodem](INFO): Nmea in: $CACLK,2020,1,24,17,58,55*7A 2020-01-24T17:58:55.018Z,1579888735.018 [Micromodem](INFO): Nmea in: $CATMS,0,2020-01-24T17:58:56Z*79 2020-01-24T17:58:55.020Z,1579888735.020 [Micromodem](INFO): Nmea in: $CATMG,2020-01-24T17:58:56.026244Z,USER_CMD,RTC*18 2020-01-24T17:58:55.832Z,1579888735.832 [DDM](INFO): Dynamic Docking Module: 2020-01-24T17:58:58.690Z,1579888738.690 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder 2020-01-24T17:59:03.499Z,1579888743.499 [DUSBL_Hydroid](INFO): DUSBL Version:O 2020-01-24T17:59:08.758Z,1579888748.758 [NAL9602](INFO): Powering up NAL9602 2020-01-24T17:59:19.659Z,1579888759.659 [NAL9602](INFO): NAL9602 initialized 2020-01-24T17:59:20.619Z,1579888760.619 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2020-01-24T17:59:20.619Z,1579888760.619 [RDI_Pathfinder] Communications Fault, FailCount= 1 2020-01-24T17:59:20.619Z,1579888760.619 [RDI_Pathfinder](ERROR): Communications Fault 2020-01-24T17:59:20.619Z,1579888760.619 [RDI_Pathfinder](ERROR): Failed to parse: 2020-01-24T17:59:20.692Z,1579888760.692 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2020-01-24T17:59:20.971Z,1579888760.971 [RDI_Pathfinder](INFO): Powering down 2020-01-24T17:59:21.757Z,1579888761.757 [SBIT](IMPORTANT): Beginning Startup BIT 2020-01-24T17:59:21.761Z,1579888761.761 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2020-01-24T17:59:21.761Z,1579888761.761 [RDI_Pathfinder] No Fault, FailCount= 1 2020-01-24T17:59:21.762Z,1579888761.762 [CBIT](IMPORTANT): Beginning ground fault scan 2020-01-24T17:59:32.864Z,1579888772.864 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.009809 CHAN A1 (24V): -0.028576 CHAN A2 (12V): -0.007277 CHAN A3 (5V): -0.001825 CHAN B0 (3.3V): -0.000013 CHAN B1 (3.15aV): -0.000002 CHAN B2 (3.15bV): -0.000217 CHAN B3 (GND): 0.001748 OPEN: 0.005474 Full Scale Calc: 4.765 mA, -1.589 mA 2020-01-24T17:59:35.178Z,1579888775.178 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder 2020-01-24T18:00:15.141Z,1579888815.141 [SBIT](IMPORTANT): SBIT PASSED 2020-01-24T18:00:15.141Z,1579888815.141 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-01-24T18:00:15.142Z,1579888815.142 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter; 2020-01-24T18:00:15.142Z,1579888815.142 [SBIT](IMPORTANT): VerticalControl.massDefault=-5 millimeter; 2020-01-24T18:00:15.513Z,1579888815.513 [MissionManager](IMPORTANT): Started mission DefaultUnder 2020-01-24T18:00:15.513Z,1579888815.513 [DefaultUnder] Running Loop=1 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder](DEBUG): Aggregate::initialize DefaultUnder 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder:uModemComms] Running Loop=1 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder:uModemComms](DEBUG): Aggregate::initialize DefaultUnder:uModemComms 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder:Notify] Running Loop=1 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder:Notify](DEBUG): Aggregate::initialize DefaultUnder:Notify 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder:Notify:A] Running Loop=1 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder:Notify:A](DEBUG): Aggregate::initialize DefaultUnder:Notify:A 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder:Notify:A:A] Running Loop=1 2020-01-24T18:00:15.514Z,1579888815.514 [DefaultUnder:Notify:A:A](DEBUG): Aggregate::initialize DefaultUnder:Notify:A:A 2020-01-24T18:00:15.515Z,1579888815.515 [DefaultUnder:Notify:A:A:A.Wait] Running Loop=1 2020-01-24T18:00:15.515Z,1579888815.515 [DefaultUnder:Notify:A:A:A.Wait](DEBUG): Initialize Wait Component. 2020-01-24T18:00:15.515Z,1579888815.515 [DefaultUnder:C.] Running Loop=1 2020-01-24T18:00:15.515Z,1579888815.515 [DefaultUnder:C.](INFO): Initializing TrackAcousticContact. 2020-01-24T18:00:15.515Z,1579888815.515 [DefaultUnder:F.Wait] Running Loop=1 2020-01-24T18:00:15.515Z,1579888815.515 [DefaultUnder:F.Wait](DEBUG): Initialize Wait Component. 2020-01-24T18:00:15.516Z,1579888815.516 [DefaultUnder:C.] Running Loop=1 2020-01-24T18:00:15.517Z,1579888815.517 [DefaultUnder:Notify] Running Loop=1 2020-01-24T18:00:15.517Z,1579888815.517 [DefaultUnder:uModemComms] Running Loop=1 2020-01-24T18:00:15.517Z,1579888815.517 [DefaultUnder:uModemComms:CheckIn] Running Loop=1 2020-01-24T18:00:15.518Z,1579888815.518 [DefaultUnder:uModemComms:CheckIn](DEBUG): Aggregate::initialize DefaultUnder:uModemComms:CheckIn 2020-01-24T18:00:15.518Z,1579888815.518 [DefaultUnder:uModemComms:CheckIn:A] Running Loop=1 2020-01-24T18:00:15.518Z,1579888815.518 [DefaultUnder:uModemComms:CheckIn:A](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-01-24T18:00:28.841Z,1579888828.841 [DefaultUnder:F.Wait](INFO): Done Waiting. 2020-01-24T18:00:28.841Z,1579888828.841 [DefaultUnder:F.Wait] Stopped 2020-01-24T18:00:28.841Z,1579888828.841 [DefaultUnder:F.Wait](DEBUG): Uninitialize Wait Component. 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default] Running Loop=1 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default](DEBUG): Aggregate::initialize DefaultUnder:Default 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default:Docked] Running Loop=1 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default:Docked](DEBUG): Aggregate::initialize DefaultUnder:Default:Docked 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default:Docked:run] Running Loop=1 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default:Docked:run](DEBUG): Aggregate::initialize DefaultUnder:Default:Docked:run 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default:Docked:run:A] Running Loop=1 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default:Home] Running Loop=1 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default:Home](DEBUG): Aggregate::initialize DefaultUnder:Default:Home 2020-01-24T18:00:28.842Z,1579888828.842 [DefaultUnder:Default:Home:run] Running Loop=1 2020-01-24T18:00:28.843Z,1579888828.843 [DefaultUnder:Default:Home:run](DEBUG): Aggregate::initialize DefaultUnder:Default:Home:run 2020-01-24T18:00:28.843Z,1579888828.843 [DefaultUnder:Default:Home:run:A] Running Loop=1 2020-01-24T18:00:28.843Z,1579888828.843 [DefaultUnder:Default:Surface] Running Loop=1 2020-01-24T18:00:28.843Z,1579888828.843 [DefaultUnder:Default:Surface](DEBUG): Aggregate::initialize DefaultUnder:Default:Surface 2020-01-24T18:00:28.843Z,1579888828.843 [DefaultUnder:Default:Surface:run] Running Loop=1 2020-01-24T18:00:28.843Z,1579888828.843 [DefaultUnder:Default:Surface:run](DEBUG): Aggregate::initialize DefaultUnder:Default:Surface:run 2020-01-24T18:00:28.843Z,1579888828.843 [DefaultUnder:Default:Surface:run:B.GoToSurface] Running Loop=1 2020-01-24T18:00:28.843Z,1579888828.843 [DefaultUnder:Default:Surface:run:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-01-24T18:00:28.844Z,1579888828.844 [DefaultUnder:Default:Surface:run:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-01-24T18:00:28.844Z,1579888828.844 [DefaultUnder:Default:Surface:run:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-01-24T18:00:28.845Z,1579888828.845 [DefaultUnder:Default:Surface:run:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-01-24T18:00:28.845Z,1579888828.845 [DefaultUnder:Default:Surface:run:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-01-24T18:00:28.845Z,1579888828.845 [DefaultUnder:Default:Surface:run:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-01-24T18:00:28.846Z,1579888828.846 [DefaultUnder:Default:Surface:run:A] Running Loop=1 2020-01-24T18:00:29.255Z,1579888829.255 [DefaultUnder:Default:Surface] Stopped 2020-01-24T18:00:29.255Z,1579888829.255 [DefaultUnder:Default:Surface](DEBUG): Aggregate::uninitialize DefaultUnder:Default:Surface 2020-01-24T18:00:29.255Z,1579888829.255 [DefaultUnder:Default:Surface:run] Stopped 2020-01-24T18:00:29.255Z,1579888829.255 [DefaultUnder:Default:Surface:run](DEBUG): Aggregate::uninitialize DefaultUnder:Default:Surface:run 2020-01-24T18:00:29.255Z,1579888829.255 [DefaultUnder:Default:Surface:run:A] Stopped 2020-01-24T18:00:29.255Z,1579888829.255 [DefaultUnder:Default:Surface:run:B.GoToSurface] Stopped 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Surface:run:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Home] Stopped 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Home](DEBUG): Aggregate::uninitialize DefaultUnder:Default:Home 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Home:run] Stopped 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Home:run](DEBUG): Aggregate::uninitialize DefaultUnder:Default:Home:run 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Home:run:A] Stopped 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Docked] Running Loop=1 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Docked:run:A] Stopped 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Docked:run:B.Docked] Running Loop=1 2020-01-24T18:00:29.256Z,1579888829.256 [DefaultUnder:Default:Docked:run:B.Docked](DEBUG): Initialize. 2020-01-24T18:00:29.257Z,1579888829.257 [DefaultUnder:Default:Docked:run:B.Docked](INFO): Depth unspecified. Maintaining workSite beacon depth of 6.000000 m. 2020-01-24T18:00:30.898Z,1579888830.898 [DefaultUnder:Default:Docked:run:B.Docked](INFO): Detected possible state switch to DETACHED. 2020-01-24T18:00:54.341Z,1579888854.341 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-01-24T18:00:54.341Z,1579888854.341 [RDI_Pathfinder](ERROR): Failed to parse: :BS,-32768,-32768,-32768-32768,-32768,-32768,V 2020-01-24T18:01:15.706Z,1579888875.706 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:01:16.474Z,1579888876.474 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:01:16.893Z,1579888876.893 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:01:17.690Z,1579888877.690 [Micromodem](INFO): Nmea in: $SNTTA,0.000575,,,,180117.92*42 2020-01-24T18:01:20.109Z,1579888880.109 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:01:39.998Z,1579888899.998 [RDI_Pathfinder](ERROR): Failed to parse: :BE,-32768,-32768,-32768,V 2020-01-24T18:01:42.409Z,1579888902.409 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-01-24T18:01:42.409Z,1579888902.409 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-24T18:01:42.476Z,1579888902.476 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-24T18:01:42.818Z,1579888902.818 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-24T18:01:42.818Z,1579888902.818 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-01-24T18:01:46.877Z,1579888906.877 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005048 2020-01-24T18:01:54.447Z,1579888914.447 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200124T171354/Courier0019.lzma 2020-01-24T18:01:56.453Z,1579888916.453 [DataOverHttps](INFO): Moved sent file to Logs/20200124T171354/Courier0019.lzma.bak 2020-01-24T18:01:56.453Z,1579888916.453 [DataOverHttps](INFO): SBD MOMSN=12202063 2020-01-24T18:02:13.479Z,1579888933.479 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200124T175831/Courier0000.lzma 2020-01-24T18:02:15.484Z,1579888935.484 [DataOverHttps](INFO): Moved sent file to Logs/20200124T175831/Courier0000.lzma.bak 2020-01-24T18:02:15.484Z,1579888935.484 [DataOverHttps](INFO): SBD MOMSN=12202065 2020-01-24T18:02:15.964Z,1579888935.964 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:02:16.698Z,1579888936.698 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:02:17.116Z,1579888937.116 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:02:17.927Z,1579888937.927 [Micromodem](INFO): Nmea in: $SNTTA,0.000570,,,,180218.14*45 2020-01-24T18:02:20.347Z,1579888940.347 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:02:32.863Z,1579888952.863 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20200124T171354/Express0020.lzma 2020-01-24T18:02:34.869Z,1579888954.869 [DataOverHttps](INFO): Moved sent file to Logs/20200124T171354/Express0020.lzma.bak 2020-01-24T18:02:34.870Z,1579888954.870 [DataOverHttps](INFO): SBD MOMSN=12202068 2020-01-24T18:02:52.332Z,1579888972.332 [DataOverHttps](INFO): Sending 613 bytes from file Logs/20200124T175831/Express0001.lzma 2020-01-24T18:02:54.337Z,1579888974.337 [DataOverHttps](INFO): Moved sent file to Logs/20200124T175831/Express0001.lzma.bak 2020-01-24T18:02:54.337Z,1579888974.337 [DataOverHttps](INFO): SBD MOMSN=12202071 2020-01-24T18:02:55.578Z,1579888975.578 [DefaultUnder:uModemComms:CheckIn:A] Stopped 2020-01-24T18:02:55.579Z,1579888975.579 [DefaultUnder:uModemComms:CheckIn](INFO): Completed DefaultUnder:uModemComms:CheckIn 2020-01-24T18:02:55.579Z,1579888975.579 [DefaultUnder:uModemComms:CheckIn] Stopped 2020-01-24T18:02:55.579Z,1579888975.579 [DefaultUnder:uModemComms:CheckIn](DEBUG): Aggregate::uninitialize DefaultUnder:uModemComms:CheckIn 2020-01-24T18:03:16.218Z,1579888996.218 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:03:16.961Z,1579888996.961 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:03:17.352Z,1579888997.352 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:03:18.160Z,1579888998.160 [Micromodem](INFO): Nmea in: $SNTTA,0.000572,,,,180318.40*47 2020-01-24T18:03:20.586Z,1579889000.586 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:04:16.386Z,1579889056.386 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:04:17.146Z,1579889057.146 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:04:17.547Z,1579889057.547 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:04:18.362Z,1579889058.362 [Micromodem](INFO): Nmea in: $SNTTA,0.000573,,0.287984,,180418.59*5F 2020-01-24T18:04:20.880Z,1579889060.880 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:04:23.230Z,1579889063.230 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-01-24T18:04:35.365Z,1579889075.365 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-24T18:04:35.366Z,1579889075.366 [RDI_Pathfinder](ERROR): Failed to parse: :TS,20012411154457,35.0, -0.1, 0.0,1448.RA, 0.00, 0.00, 0.00, 0.00, 0.00 2020-01-24T18:04:43.442Z,1579889083.442 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2020-01-24T18:04:43.442Z,1579889083.442 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-24T18:04:43.453Z,1579889083.453 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-24T18:04:43.845Z,1579889083.845 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-24T18:04:43.845Z,1579889083.845 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2020-01-24T18:05:15.774Z,1579889115.774 [DefaultUnder:Notify:A:A:A.Wait](INFO): Done Waiting. 2020-01-24T18:05:15.774Z,1579889115.774 [DefaultUnder:Notify:A:A:A.Wait] Stopped 2020-01-24T18:05:15.775Z,1579889115.775 [DefaultUnder:Notify:A:A:A.Wait](DEBUG): Uninitialize Wait Component. 2020-01-24T18:05:15.775Z,1579889115.775 [DefaultUnder:Notify:A:A:B] Running Loop=1 2020-01-24T18:05:16.217Z,1579889116.217 [DefaultUnder:Notify:A:A:B] Stopped 2020-01-24T18:05:16.217Z,1579889116.217 [DefaultUnder:Notify:A:A:C] Running Loop=1 2020-01-24T18:05:16.582Z,1579889116.582 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:16.583Z,1579889116.583 [DefaultUnder:Notify:A:A:C](IMPORTANT): Default mission has been running for 5.011721 min 2020-01-24T18:05:16.583Z,1579889116.583 [DefaultUnder:Notify:A:A:C] Stopped 2020-01-24T18:05:16.583Z,1579889116.583 [DefaultUnder:Notify:A:A](INFO): Completed DefaultUnder:Notify:A:A 2020-01-24T18:05:16.584Z,1579889116.584 [DefaultUnder:Notify:A:A] Stopped 2020-01-24T18:05:16.584Z,1579889116.584 [DefaultUnder:Notify:A:A](DEBUG): Aggregate::uninitialize DefaultUnder:Notify:A:A 2020-01-24T18:05:16.584Z,1579889116.584 [DefaultUnder:Notify:A:A](INFO): Running loop #2 2020-01-24T18:05:16.584Z,1579889116.584 [DefaultUnder:Notify:A:A] Running Loop=2 2020-01-24T18:05:16.584Z,1579889116.584 [DefaultUnder:Notify:A:A](DEBUG): Aggregate::initialize DefaultUnder:Notify:A:A 2020-01-24T18:05:16.584Z,1579889116.584 [DefaultUnder:Notify:A:A:A.Wait] Running Loop=1 2020-01-24T18:05:16.584Z,1579889116.584 [DefaultUnder:Notify:A:A:A.Wait](DEBUG): Initialize Wait Component. 2020-01-24T18:05:17.398Z,1579889117.398 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:05:17.799Z,1579889117.799 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:05:18.608Z,1579889118.608 [Micromodem](INFO): Nmea in: $SNTTA,0.000570,,,,180518.84*4B 2020-01-24T18:05:21.041Z,1579889121.041 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:05:31.190Z,1579889131.190 [DefaultUnder:Default:Docked:run:B.Docked](IMPORTANT): VEHICLE DETACHED FROM DOCK. 2020-01-24T18:05:31.190Z,1579889131.190 [DefaultUnder:Default:Docked:run:B.Docked] Stopped 2020-01-24T18:05:31.190Z,1579889131.190 [DefaultUnder:Default:Docked:run:C] Running Loop=1 2020-01-24T18:05:31.585Z,1579889131.585 [DefaultUnder:Default:Docked:run:C] Stopped 2020-01-24T18:05:31.585Z,1579889131.585 [DefaultUnder:Default:Docked:run](INFO): Completed DefaultUnder:Default:Docked:run 2020-01-24T18:05:31.585Z,1579889131.585 [DefaultUnder:Default:Docked:run] Stopped 2020-01-24T18:05:31.585Z,1579889131.585 [DefaultUnder:Default:Docked:run](DEBUG): Aggregate::uninitialize DefaultUnder:Default:Docked:run 2020-01-24T18:05:31.585Z,1579889131.585 [DefaultUnder:Default:Docked](INFO): Completed DefaultUnder:Default:Docked 2020-01-24T18:05:31.982Z,1579889131.982 [DefaultUnder:Default:Home] Running Loop=1 2020-01-24T18:05:31.982Z,1579889131.982 [DefaultUnder:Default:Home](DEBUG): Aggregate::initialize DefaultUnder:Default:Home 2020-01-24T18:05:31.982Z,1579889131.982 [DefaultUnder:Default:Home:run] Running Loop=1 2020-01-24T18:05:31.982Z,1579889131.982 [DefaultUnder:Default:Home:run](DEBUG): Aggregate::initialize DefaultUnder:Default:Home:run 2020-01-24T18:05:31.982Z,1579889131.982 [DefaultUnder:Default:Home:run:A] Running Loop=1 2020-01-24T18:05:31.982Z,1579889131.982 [DefaultUnder:Default:Home] Running Loop=1 2020-01-24T18:05:31.982Z,1579889131.982 [DefaultUnder:Default:Home:run:A] Stopped 2020-01-24T18:05:31.982Z,1579889131.982 [DefaultUnder:Default:Home:run:B] Running Loop=1 2020-01-24T18:05:31.999Z,1579889131.999 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:31.999Z,1579889131.999 [DefaultUnder:uModemComms] Stopped 2020-01-24T18:05:31.000Z,1579889132.000 [DefaultUnder:uModemComms](DEBUG): Aggregate::uninitialize DefaultUnder:uModemComms 2020-01-24T18:05:32.390Z,1579889132.390 [DefaultUnder:Default:Home:run:B] Stopped 2020-01-24T18:05:32.390Z,1579889132.390 [DefaultUnder:Default:Home:run:C] Running Loop=1 2020-01-24T18:05:32.390Z,1579889132.390 [DefaultUnder:Default:Home:run:C](DEBUG): Aggregate::initialize DefaultUnder:Default:Home:run:C 2020-01-24T18:05:32.749Z,1579889132.749 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:05:32.841Z,1579889132.841 [DefaultUnder:LineCapture] Running Loop=1 2020-01-24T18:05:32.841Z,1579889132.841 [DefaultUnder:LineCapture](DEBUG): Aggregate::initialize DefaultUnder:LineCapture 2020-01-24T18:05:32.841Z,1579889132.841 [DefaultUnder:LineCapture:StandardEnvelopes] Running Loop=1 2020-01-24T18:05:32.841Z,1579889132.841 [DefaultUnder:LineCapture:StandardEnvelopes](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:StandardEnvelopes 2020-01-24T18:05:32.841Z,1579889132.841 [DefaultUnder:LineCapture:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2020-01-24T18:05:32.841Z,1579889132.841 [DefaultUnder:LineCapture:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2020-01-24T18:05:32.842Z,1579889132.842 [DefaultUnder:LineCapture:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2020-01-24T18:05:32.842Z,1579889132.842 [DefaultUnder:LineCapture:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2020-01-24T18:05:32.842Z,1579889132.842 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2020-01-24T18:05:32.842Z,1579889132.842 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2020-01-24T18:05:32.852Z,1579889132.852 [DefaultUnder:LineCapture:F] Running Loop=1 2020-01-24T18:05:32.852Z,1579889132.852 [DefaultUnder:LineCapture:G] Running Loop=1 2020-01-24T18:05:32.852Z,1579889132.852 [DefaultUnder:LineCapture:H.Mass] Running Loop=1 2020-01-24T18:05:32.852Z,1579889132.852 [DefaultUnder:LineCapture:H.Mass](DEBUG): Initialize. 2020-01-24T18:05:32.853Z,1579889132.853 [DefaultUnder:LineCapture:A] Running Loop=1 2020-01-24T18:05:32.853Z,1579889132.853 [DefaultUnder:LineCapture:H.Mass] Running Loop=1 2020-01-24T18:05:32.854Z,1579889132.854 [DefaultUnder:LineCapture:G] Running Loop=1 2020-01-24T18:05:32.855Z,1579889132.855 [DefaultUnder:LineCapture:F] Running Loop=1 2020-01-24T18:05:32.859Z,1579889132.859 [DefaultUnder:LineCapture:StandardEnvelopes] Running Loop=1 2020-01-24T18:05:32.859Z,1579889132.859 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2020-01-24T18:05:32.859Z,1579889132.859 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:32.860Z,1579889132.860 [DefaultUnder:LineCapture:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2020-01-24T18:05:32.860Z,1579889132.860 [DefaultUnder:LineCapture:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2020-01-24T18:05:32.861Z,1579889132.861 [DefaultUnder:LineCapture:A] Stopped 2020-01-24T18:05:32.861Z,1579889132.861 [DefaultUnder:LineCapture:C] Running Loop=1 2020-01-24T18:05:33.325Z,1579889133.325 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:05:33.401Z,1579889133.401 [DefaultUnder:LineCapture:C] Stopped 2020-01-24T18:05:33.401Z,1579889133.401 [DefaultUnder:LineCapture:D] Running Loop=1 2020-01-24T18:05:33.402Z,1579889133.402 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:33.754Z,1579889133.754 [DefaultUnder:LineCapture:D] Stopped 2020-01-24T18:05:33.755Z,1579889133.755 [DefaultUnder:LineCapture:E] Running Loop=1 2020-01-24T18:05:33.755Z,1579889133.755 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:34.113Z,1579889134.113 [Micromodem](INFO): Nmea in: $SNTTA,0.000566,,,,180534.19*46 2020-01-24T18:05:34.178Z,1579889134.178 [DefaultUnder:LineCapture:E] Stopped 2020-01-24T18:05:34.178Z,1579889134.178 [DefaultUnder:LineCapture:HomingSequence] Running Loop=1 2020-01-24T18:05:34.178Z,1579889134.178 [DefaultUnder:LineCapture:HomingSequence](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence 2020-01-24T18:05:34.179Z,1579889134.179 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock] Running Loop=1 2020-01-24T18:05:34.179Z,1579889134.179 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:DetachFromDock 2020-01-24T18:05:34.179Z,1579889134.179 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide] Running Loop=1 2020-01-24T18:05:34.179Z,1579889134.179 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide 2020-01-24T18:05:34.179Z,1579889134.179 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock] Running Loop=1 2020-01-24T18:05:34.179Z,1579889134.179 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](DEBUG): Initialize. 2020-01-24T18:05:34.180Z,1579889134.180 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance] Running Loop=1 2020-01-24T18:05:34.180Z,1579889134.180 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance 2020-01-24T18:05:34.180Z,1579889134.180 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide] Running Loop=1 2020-01-24T18:05:34.180Z,1579889134.180 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide 2020-01-24T18:05:34.180Z,1579889134.180 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:B] Running Loop=1 2020-01-24T18:05:34.180Z,1579889134.180 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance] Running Loop=1 2020-01-24T18:05:34.180Z,1579889134.180 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:TerminalGuidance 2020-01-24T18:05:34.180Z,1579889134.180 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide] Running Loop=1 2020-01-24T18:05:34.181Z,1579889134.181 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide 2020-01-24T18:05:34.181Z,1579889134.181 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:C] Running Loop=1 2020-01-24T18:05:34.181Z,1579889134.181 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:D] Running Loop=1 2020-01-24T18:05:34.181Z,1579889134.181 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:A] Running Loop=1 2020-01-24T18:05:34.181Z,1579889134.181 [DefaultUnder:LineCapture:HomingSequence:A] Running Loop=1 2020-01-24T18:05:34.181Z,1579889134.181 [DefaultUnder:LineCapture:HomingSequence:A](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:A 2020-01-24T18:05:34.181Z,1579889134.181 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:34.560Z,1579889134.560 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance] Stopped 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:HomingSequence:TerminalGuidance 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide] Stopped 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:A] Stopped 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:C] Stopped 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:D] Stopped 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance] Stopped 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide] Stopped 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:B] Stopped 2020-01-24T18:05:34.561Z,1579889134.561 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock] Running Loop=1 2020-01-24T18:05:34.562Z,1579889134.562 [DefaultUnder:LineCapture:DiveCmd] Running Loop=1 2020-01-24T18:05:34.562Z,1579889134.562 [DefaultUnder:LineCapture:DiveCmd](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:DiveCmd 2020-01-24T18:05:34.562Z,1579889134.562 [DefaultUnder:LineCapture:DiveCmd:Guided] Running Loop=1 2020-01-24T18:05:34.562Z,1579889134.562 [DefaultUnder:LineCapture:DiveCmd:Guided](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:DiveCmd:Guided 2020-01-24T18:05:34.562Z,1579889134.562 [DefaultUnder:LineCapture:DiveCmd:Guided:dive] Running Loop=1 2020-01-24T18:05:34.562Z,1579889134.562 [DefaultUnder:LineCapture:DiveCmd:Guided:dive](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:DiveCmd:Guided:dive 2020-01-24T18:05:34.563Z,1579889134.563 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:A] Running Loop=1 2020-01-24T18:05:34.563Z,1579889134.563 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:B.Buoyancy] Running Loop=1 2020-01-24T18:05:34.563Z,1579889134.563 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:B.Buoyancy](DEBUG): Initialize Buoyancy Component. 2020-01-24T18:05:34.563Z,1579889134.563 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:C.SetSpeed] Running Loop=1 2020-01-24T18:05:34.563Z,1579889134.563 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:C.SetSpeed](DEBUG): Initialize. 2020-01-24T18:05:34.563Z,1579889134.563 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:D.Pitch] Running Loop=1 2020-01-24T18:05:34.563Z,1579889134.563 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:D.Pitch](DEBUG): Initialize. 2020-01-24T18:05:34.564Z,1579889134.564 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock] Running Loop=1 2020-01-24T18:05:34.564Z,1579889134.564 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock 2020-01-24T18:05:34.564Z,1579889134.564 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive] Running Loop=1 2020-01-24T18:05:34.564Z,1579889134.564 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive 2020-01-24T18:05:34.564Z,1579889134.564 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:A.SetSpeed] Running Loop=1 2020-01-24T18:05:34.564Z,1579889134.564 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:A.SetSpeed](DEBUG): Initialize. 2020-01-24T18:05:34.564Z,1579889134.564 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:B.Pitch] Running Loop=1 2020-01-24T18:05:34.564Z,1579889134.564 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:B.Pitch](DEBUG): Initialize. 2020-01-24T18:05:34.565Z,1579889134.565 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock] Running Loop=1 2020-01-24T18:05:34.565Z,1579889134.565 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:A.SetSpeed] Running Loop=1 2020-01-24T18:05:34.565Z,1579889134.565 [DefaultUnder:LineCapture:DiveCmd:Guided] Stopped 2020-01-24T18:05:34.565Z,1579889134.565 [DefaultUnder:LineCapture:DiveCmd:Guided](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:DiveCmd:Guided 2020-01-24T18:05:34.566Z,1579889134.566 [DefaultUnder:LineCapture:DiveCmd:Guided:dive] Stopped 2020-01-24T18:05:34.566Z,1579889134.566 [DefaultUnder:LineCapture:DiveCmd:Guided:dive](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:DiveCmd:Guided:dive 2020-01-24T18:05:34.566Z,1579889134.566 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:A] Stopped 2020-01-24T18:05:34.566Z,1579889134.566 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:B.Buoyancy] Stopped 2020-01-24T18:05:34.566Z,1579889134.566 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2020-01-24T18:05:34.566Z,1579889134.566 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:C.SetSpeed] Stopped 2020-01-24T18:05:34.566Z,1579889134.566 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:C.SetSpeed](DEBUG): Uninitialize. 2020-01-24T18:05:34.566Z,1579889134.566 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:D.Pitch] Stopped 2020-01-24T18:05:34.579Z,1579889134.579 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:34.580Z,1579889134.580 [DefaultUnder:LineCapture:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active. 2020-01-24T18:05:34.580Z,1579889134.580 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:34.942Z,1579889134.942 [PowerOnly](INFO): Powering up 2020-01-24T18:05:34.997Z,1579889134.997 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:35.476Z,1579889135.476 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:35.787Z,1579889135.787 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:36.156Z,1579889136.156 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:05:36.219Z,1579889136.219 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:36.637Z,1579889136.637 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:37.051Z,1579889137.051 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:37.412Z,1579889137.412 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:37.413Z,1579889137.413 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:37.834Z,1579889137.834 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:38.180Z,1579889138.180 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:05:38.296Z,1579889138.296 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:38.583Z,1579889138.583 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:05:38.660Z,1579889138.660 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:39.047Z,1579889139.047 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:39.424Z,1579889139.424 [Micromodem](INFO): Nmea in: $SNTTA,0.000569,,,,180539.62*48 2020-01-24T18:05:39.462Z,1579889139.462 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](INFO): Detaching from dock. 2020-01-24T18:05:39.463Z,1579889139.463 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:39.821Z,1579889139.821 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](INFO): Detected possible detachment. Starting timer. 2020-01-24T18:05:39.822Z,1579889139.822 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:40.247Z,1579889140.247 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:40.248Z,1579889140.248 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:40.652Z,1579889140.652 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:41.070Z,1579889141.070 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:41.438Z,1579889141.438 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:41.812Z,1579889141.812 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:05:41.917Z,1579889141.917 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:42.267Z,1579889142.267 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:42.679Z,1579889142.679 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:43.088Z,1579889143.088 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:43.089Z,1579889143.089 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:43.486Z,1579889143.486 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:43.838Z,1579889143.838 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:05:43.948Z,1579889143.948 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:44.243Z,1579889144.243 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:05:44.422Z,1579889144.422 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:44.693Z,1579889144.693 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:45.054Z,1579889145.054 [Micromodem](INFO): Nmea in: $SNTTA,0.000562,,,,180545.28*46 2020-01-24T18:05:45.142Z,1579889145.142 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:45.504Z,1579889145.504 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:45.885Z,1579889145.885 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:45.885Z,1579889145.885 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:46.313Z,1579889146.313 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:46.718Z,1579889146.718 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:47.116Z,1579889147.116 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:47.469Z,1579889147.469 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:05:47.536Z,1579889147.536 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:47.922Z,1579889147.922 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:48.316Z,1579889148.316 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:48.717Z,1579889148.717 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:48.718Z,1579889148.718 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:49.133Z,1579889149.133 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:49.493Z,1579889149.493 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:05:49.602Z,1579889149.602 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:49.902Z,1579889149.902 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:05:50.006Z,1579889150.006 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:50.332Z,1579889150.332 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-24T18:05:50.332Z,1579889150.332 [RDI_Pathfinder](ERROR): Failed to parse: :TS,200124115.0, -0.1, 0.0,1448.9, 0 2020-01-24T18:05:50.348Z,1579889150.348 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:50.713Z,1579889150.713 [Micromodem](INFO): Nmea in: $SNTTA,0.000565,,,,180550.94*42 2020-01-24T18:05:50.761Z,1579889150.761 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:51.138Z,1579889151.138 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:51.542Z,1579889151.542 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:51.544Z,1579889151.544 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:51.946Z,1579889151.946 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:52.373Z,1579889152.373 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:52.777Z,1579889152.777 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:53.131Z,1579889153.131 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:05:53.193Z,1579889153.193 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:53.576Z,1579889153.576 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:53.973Z,1579889153.973 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:54.390Z,1579889154.390 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:54.390Z,1579889154.390 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:54.782Z,1579889154.782 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:55.146Z,1579889155.146 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:05:55.277Z,1579889155.277 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:55.559Z,1579889155.559 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:05:55.686Z,1579889155.686 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:56.078Z,1579889156.078 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:56.358Z,1579889156.358 [Micromodem](INFO): Nmea in: $SNTTA,0.000568,,,,180556.58*49 2020-01-24T18:05:56.433Z,1579889156.433 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:56.825Z,1579889156.825 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:57.363Z,1579889157.363 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:57.364Z,1579889157.364 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:05:57.634Z,1579889157.634 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:58.082Z,1579889158.082 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:58.450Z,1579889158.450 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:58.776Z,1579889158.776 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:05:58.855Z,1579889158.855 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:59.238Z,1579889159.238 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:05:59.655Z,1579889159.655 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:00.059Z,1579889160.059 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby. 2020-01-24T18:06:00.060Z,1579889160.060 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:00.061Z,1579889160.061 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:00.438Z,1579889160.438 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:00.795Z,1579889160.795 [DDM](FAULT): Could not parse latch state 2020-01-24T18:06:00.795Z,1579889160.795 [DDM] Communications Fault, FailCount= 1 2020-01-24T18:06:00.795Z,1579889160.795 [DDM](ERROR): Communications Fault 2020-01-24T18:06:00.802Z,1579889160.802 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:00.927Z,1579889160.927 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:00.942Z,1579889160.942 [CBIT](ERROR): Communications Fault in component: DDM 2020-01-24T18:06:01.170Z,1579889161.170 [DDM](INFO): Powering down 2020-01-24T18:06:01.264Z,1579889161.264 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:01.342Z,1579889161.342 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:01.638Z,1579889161.638 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:02.001Z,1579889162.001 [Micromodem](INFO): Nmea in: $SNTTA,0.000581,,,,180602.24*47 2020-01-24T18:06:02.074Z,1579889162.074 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:02.087Z,1579889162.087 [CBIT](INFO): Clearing failed state for component DDM 2020-01-24T18:06:02.087Z,1579889162.087 [DDM] No Fault, FailCount= 0 2020-01-24T18:06:02.454Z,1579889162.454 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:02.820Z,1579889162.820 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:02.821Z,1579889162.821 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:03.265Z,1579889163.265 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:03.655Z,1579889163.655 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:04.066Z,1579889164.066 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:04.402Z,1579889164.402 [DDM](INFO): Powering up 2020-01-24T18:06:04.403Z,1579889164.403 [DDM](DEBUG): Initializing DDM. 2020-01-24T18:06:04.421Z,1579889164.421 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:04.513Z,1579889164.513 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:04.872Z,1579889164.872 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:05.307Z,1579889165.307 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:05.680Z,1579889165.680 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:05.681Z,1579889165.681 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:06.086Z,1579889166.086 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:06.435Z,1579889166.435 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:06.521Z,1579889166.521 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:06.849Z,1579889166.849 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:06.926Z,1579889166.926 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:07.288Z,1579889167.288 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:07.653Z,1579889167.653 [Micromodem](INFO): Nmea in: $SNTTA,0.000573,,,,180607.88*49 2020-01-24T18:06:07.718Z,1579889167.718 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:08.161Z,1579889168.161 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:08.486Z,1579889168.486 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2020-01-24T18:06:08.489Z,1579889168.489 [BPC1](INFO): Received data from all battery sticks. 2020-01-24T18:06:08.504Z,1579889168.504 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:08.505Z,1579889168.505 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:08.908Z,1579889168.908 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:09.321Z,1579889169.321 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:09.692Z,1579889169.692 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:10.061Z,1579889170.061 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:10.120Z,1579889170.120 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:10.508Z,1579889170.508 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:10.926Z,1579889170.926 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:11.346Z,1579889171.346 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:11.351Z,1579889171.351 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:11.736Z,1579889171.736 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:12.086Z,1579889172.086 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:12.206Z,1579889172.206 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:12.491Z,1579889172.491 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:12.541Z,1579889172.541 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:12.932Z,1579889172.932 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:13.314Z,1579889173.314 [Micromodem](INFO): Nmea in: $SNTTA,0.000577,,,,180613.53*4E 2020-01-24T18:06:13.395Z,1579889173.395 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:13.731Z,1579889173.731 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:14.137Z,1579889174.137 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:14.138Z,1579889174.138 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:14.560Z,1579889174.560 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:14.907Z,1579889174.907 [DDM](INFO): Dynamic Docking Module:!C REMUS Capture Rev 1.1 2020-01-24T18:06:15.079Z,1579889175.079 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:15.392Z,1579889175.392 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:15.748Z,1579889175.748 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:15.790Z,1579889175.790 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:16.210Z,1579889176.210 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:16.592Z,1579889176.592 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:17.012Z,1579889177.012 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:17.013Z,1579889177.013 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:17.435Z,1579889177.435 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](INFO): DDM at standby. 2020-01-24T18:06:17.455Z,1579889177.455 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:17.774Z,1579889177.774 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:17.884Z,1579889177.884 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](IMPORTANT): Undocking sequence complete. 2020-01-24T18:06:17.884Z,1579889177.884 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock] Stopped 2020-01-24T18:06:17.884Z,1579889177.884 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:B] Running Loop=1 2020-01-24T18:06:17.885Z,1579889177.885 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:18.160Z,1579889178.160 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:18.235Z,1579889178.235 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:B](INFO): Transitioning to midcourse guidance. 2020-01-24T18:06:18.235Z,1579889178.235 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:B] Stopped 2020-01-24T18:06:18.236Z,1579889178.236 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:C] Running Loop=1 2020-01-24T18:06:18.237Z,1579889178.237 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:18.601Z,1579889178.601 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide:C] Stopped 2020-01-24T18:06:18.601Z,1579889178.601 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide](INFO): Completed DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide 2020-01-24T18:06:18.601Z,1579889178.601 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide] Stopped 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:HomingSequence:DetachFromDock:guide 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:HomingSequence:DetachFromDock](INFO): Completed DefaultUnder:LineCapture:HomingSequence:DetachFromDock 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock] Stopped 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive] Stopped 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:A.SetSpeed] Stopped 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:A.SetSpeed](DEBUG): Uninitialize. 2020-01-24T18:06:18.602Z,1579889178.602 [DefaultUnder:LineCapture:DiveCmd:DriftAwayFromDock:dive:B.Pitch] Stopped 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided] Running Loop=1 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:DiveCmd:Guided 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided:dive] Running Loop=1 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided:dive](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:DiveCmd:Guided:dive 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:A] Running Loop=1 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:B.Buoyancy] Running Loop=1 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:B.Buoyancy](DEBUG): Initialize Buoyancy Component. 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:C.SetSpeed] Running Loop=1 2020-01-24T18:06:18.603Z,1579889178.603 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:C.SetSpeed](DEBUG): Initialize. 2020-01-24T18:06:18.604Z,1579889178.604 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:D.Pitch] Running Loop=1 2020-01-24T18:06:18.604Z,1579889178.604 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:D.Pitch](DEBUG): Initialize. 2020-01-24T18:06:18.604Z,1579889178.604 [DefaultUnder:LineCapture:DiveCmd:Guided] Running Loop=1 2020-01-24T18:06:18.604Z,1579889178.604 [DefaultUnder:LineCapture:DiveCmd:Guided:dive] Running Loop=1 2020-01-24T18:06:18.604Z,1579889178.604 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:D.Pitch] Running Loop=1 2020-01-24T18:06:18.604Z,1579889178.604 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:C.SetSpeed] Running Loop=1 2020-01-24T18:06:18.604Z,1579889178.604 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:B.Buoyancy] Running Loop=1 2020-01-24T18:06:18.605Z,1579889178.605 [DefaultUnder:LineCapture:DiveCmd:Guided:dive:A] Running Loop=1 2020-01-24T18:06:18.605Z,1579889178.605 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:18.972Z,1579889178.972 [Micromodem](INFO): Nmea in: $SNTTA,0.000572,,0.347401,,180619.22*5C 2020-01-24T18:06:19.039Z,1579889179.039 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance] Running Loop=1 2020-01-24T18:06:19.039Z,1579889179.039 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance 2020-01-24T18:06:19.039Z,1579889179.039 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide] Running Loop=1 2020-01-24T18:06:19.039Z,1579889179.039 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide 2020-01-24T18:06:19.040Z,1579889179.040 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:B] Running Loop=1 2020-01-24T18:06:19.040Z,1579889179.040 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance] Running Loop=1 2020-01-24T18:06:19.041Z,1579889179.041 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:B](INFO): Navigating to dock waypoint ( 36.803400 arcdeg , -121.822300 arcdeg ) 2020-01-24T18:06:19.041Z,1579889179.041 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:B] Stopped 2020-01-24T18:06:19.041Z,1579889179.041 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:C] Running Loop=1 2020-01-24T18:06:19.043Z,1579889179.043 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:19.391Z,1579889179.391 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:C] Stopped 2020-01-24T18:06:19.391Z,1579889179.391 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:D] Running Loop=1 2020-01-24T18:06:19.393Z,1579889179.393 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:19.796Z,1579889179.796 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:D] Stopped 2020-01-24T18:06:19.796Z,1579889179.796 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint] Running Loop=1 2020-01-24T18:06:19.796Z,1579889179.796 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:19.800Z,1579889179.800 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:19.801Z,1579889179.801 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:20.220Z,1579889180.220 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:20.225Z,1579889180.225 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:20.624Z,1579889180.624 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:20.628Z,1579889180.628 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:21.034Z,1579889181.034 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:21.038Z,1579889181.038 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:21.376Z,1579889181.376 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:21.429Z,1579889181.429 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:21.433Z,1579889181.433 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:21.814Z,1579889181.814 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:21.819Z,1579889181.819 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:22.246Z,1579889182.246 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:22.251Z,1579889182.251 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:22.635Z,1579889182.635 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:22.652Z,1579889182.652 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:22.653Z,1579889182.653 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:23.039Z,1579889183.039 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:23.043Z,1579889183.043 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:23.402Z,1579889183.402 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:23.521Z,1579889183.521 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:23.529Z,1579889183.529 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:23.815Z,1579889183.815 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:23.858Z,1579889183.858 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:23.881Z,1579889183.881 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:24.256Z,1579889184.256 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:24.263Z,1579889184.263 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:24.617Z,1579889184.617 [Micromodem](INFO): Nmea in: $SNTTA,0.000569,,,,180624.84*4F 2020-01-24T18:06:24.688Z,1579889184.688 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:24.692Z,1579889184.692 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:25.085Z,1579889185.085 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:25.090Z,1579889185.090 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:25.452Z,1579889185.452 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:25.456Z,1579889185.456 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:25.457Z,1579889185.457 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:25.866Z,1579889185.866 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:25.870Z,1579889185.870 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:26.287Z,1579889186.287 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:26.299Z,1579889186.299 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:26.663Z,1579889186.663 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:26.667Z,1579889186.667 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:27.032Z,1579889187.032 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:27.082Z,1579889187.082 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:27.087Z,1579889187.087 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:27.487Z,1579889187.487 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:27.491Z,1579889187.491 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:27.906Z,1579889187.906 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:27.910Z,1579889187.910 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:28.295Z,1579889188.295 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:28.299Z,1579889188.299 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:28.300Z,1579889188.300 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:28.692Z,1579889188.692 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:28.696Z,1579889188.696 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:29.054Z,1579889189.054 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:29.170Z,1579889189.170 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:29.173Z,1579889189.173 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:29.465Z,1579889189.465 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:29.532Z,1579889189.532 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:29.535Z,1579889189.535 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:29.902Z,1579889189.902 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:29.906Z,1579889189.906 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:30.266Z,1579889190.266 [Micromodem](INFO): Nmea in: $SNTTA,0.000573,,,,180630.50*48 2020-01-24T18:06:30.337Z,1579889190.337 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:30.341Z,1579889190.341 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:30.714Z,1579889190.714 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:30.732Z,1579889190.732 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:31.124Z,1579889191.124 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:31.152Z,1579889191.152 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:31.153Z,1579889191.153 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:31.518Z,1579889191.518 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:31.522Z,1579889191.522 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:31.936Z,1579889191.936 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:31.944Z,1579889191.944 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:32.365Z,1579889192.365 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:32.369Z,1579889192.369 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:32.701Z,1579889192.701 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:32.738Z,1579889192.738 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:32.746Z,1579889192.746 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:33.138Z,1579889193.138 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:33.142Z,1579889193.142 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:33.579Z,1579889193.579 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:33.591Z,1579889193.591 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:33.958Z,1579889193.958 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:33.962Z,1579889193.962 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:33.967Z,1579889193.967 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:34.408Z,1579889194.408 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:34.432Z,1579889194.432 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:34.710Z,1579889194.710 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:34.843Z,1579889194.843 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:34.852Z,1579889194.852 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:35.130Z,1579889195.130 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:35.242Z,1579889195.242 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:35.246Z,1579889195.246 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:35.546Z,1579889195.546 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:35.565Z,1579889195.565 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:35.939Z,1579889195.939 [Micromodem](INFO): Nmea in: $SNTTA,0.000572,,,,180636.15*4E 2020-01-24T18:06:35.991Z,1579889195.991 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-01-24T18:06:35.991Z,1579889195.991 [RDI_Pathfinder](ERROR): Failed to parse: :BS,-32768,-3276,V 2020-01-24T18:06:36.039Z,1579889196.039 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:36.042Z,1579889196.042 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:36.374Z,1579889196.374 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:36.378Z,1579889196.378 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:36.778Z,1579889196.778 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:36.783Z,1579889196.783 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:36.784Z,1579889196.784 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:37.188Z,1579889197.188 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:37.192Z,1579889197.192 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:37.573Z,1579889197.573 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:37.577Z,1579889197.577 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:38.017Z,1579889198.017 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:38.022Z,1579889198.022 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:38.344Z,1579889198.344 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:38.404Z,1579889198.404 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:38.409Z,1579889198.409 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:38.781Z,1579889198.781 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:38.802Z,1579889198.802 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:39.193Z,1579889199.193 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:39.202Z,1579889199.202 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:39.603Z,1579889199.603 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:39.607Z,1579889199.607 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:39.608Z,1579889199.608 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:40.030Z,1579889200.030 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:40.034Z,1579889200.034 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:40.370Z,1579889200.370 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:40.482Z,1579889200.482 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:40.493Z,1579889200.493 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:40.783Z,1579889200.783 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:40.849Z,1579889200.849 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:40.853Z,1579889200.853 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:41.230Z,1579889201.230 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:41.234Z,1579889201.234 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:41.596Z,1579889201.596 [Micromodem](INFO): Nmea in: $SNTTA,0.000576,,,,180641.81*47 2020-01-24T18:06:41.646Z,1579889201.646 [DefaultUnder:SetNavAcoustic] Running Loop=1 2020-01-24T18:06:41.646Z,1579889201.646 [DefaultUnder:SetNavAcoustic](DEBUG): Aggregate::initialize DefaultUnder:SetNavAcoustic 2020-01-24T18:06:41.646Z,1579889201.646 [DefaultUnder:SetNavAcoustic:UpdateNav] Running Loop=1 2020-01-24T18:06:41.647Z,1579889201.647 [DefaultUnder:SetNavAcoustic:UpdateNav](DEBUG): Aggregate::initialize DefaultUnder:SetNavAcoustic:UpdateNav 2020-01-24T18:06:41.647Z,1579889201.647 [DefaultUnder:SetNavAcoustic:UpdateNav:A] Running Loop=1 2020-01-24T18:06:41.647Z,1579889201.647 [DefaultUnder:SetNavAcoustic:UpdateNav:A](INFO): Reseting nav to dock location at range 0.840001 m 2020-01-24T18:06:41.647Z,1579889201.647 [DefaultUnder:SetNavAcoustic:UpdateNav:A] Stopped 2020-01-24T18:06:41.648Z,1579889201.648 [DefaultUnder:SetNavAcoustic:UpdateNav:B.SetNav] Running Loop=1 2020-01-24T18:06:41.648Z,1579889201.648 [DefaultUnder:SetNavAcoustic:UpdateNav:B.SetNav](DEBUG): Initialize SetNavComponent. 2020-01-24T18:06:41.648Z,1579889201.648 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:41.652Z,1579889201.652 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:42.027Z,1579889202.027 [DefaultUnder:SetNavAcoustic:UpdateNav:B.SetNav](INFO): SetNav fix at 20200124T180642: (36.803398, -121.822304) 2020-01-24T18:06:42.027Z,1579889202.027 [DefaultUnder:SetNavAcoustic:UpdateNav:B.SetNav] Stopped 2020-01-24T18:06:42.027Z,1579889202.027 [DefaultUnder:SetNavAcoustic:UpdateNav:B.SetNav](DEBUG): Uninitialize SetNavComponent. 2020-01-24T18:06:42.028Z,1579889202.028 [DefaultUnder:SetNavAcoustic:UpdateNav](INFO): Completed DefaultUnder:SetNavAcoustic:UpdateNav 2020-01-24T18:06:42.028Z,1579889202.028 [DefaultUnder:SetNavAcoustic:UpdateNav] Stopped 2020-01-24T18:06:42.028Z,1579889202.028 [DefaultUnder:SetNavAcoustic:UpdateNav](DEBUG): Aggregate::uninitialize DefaultUnder:SetNavAcoustic:UpdateNav 2020-01-24T18:06:42.028Z,1579889202.028 [DefaultUnder:SetNavAcoustic](INFO): Completed DefaultUnder:SetNavAcoustic 2020-01-24T18:06:42.028Z,1579889202.028 [DefaultUnder:SetNavAcoustic] Stopped 2020-01-24T18:06:42.028Z,1579889202.028 [DefaultUnder:SetNavAcoustic](DEBUG): Aggregate::uninitialize DefaultUnder:SetNavAcoustic 2020-01-24T18:06:42.029Z,1579889202.029 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:42.063Z,1579889202.063 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange] Running Loop=1 2020-01-24T18:06:42.063Z,1579889202.063 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange 2020-01-24T18:06:42.063Z,1579889202.063 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange:A] Running Loop=1 2020-01-24T18:06:42.064Z,1579889202.064 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange:A](INFO): Transitioning to terminal guidance at range 0.840001 m 2020-01-24T18:06:42.064Z,1579889202.064 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange:A] Stopped 2020-01-24T18:06:42.064Z,1579889202.064 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange:B] Running Loop=1 2020-01-24T18:06:42.066Z,1579889202.066 [DefaultUnder:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active. 2020-01-24T18:06:42.446Z,1579889202.446 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Initialize WaypointComponent. 2020-01-24T18:06:42.448Z,1579889202.448 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange:B] Stopped 2020-01-24T18:06:42.448Z,1579889202.448 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange](INFO): Completed DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange 2020-01-24T18:06:42.448Z,1579889202.448 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange] Stopped 2020-01-24T18:06:42.448Z,1579889202.448 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:CheckRange 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance] Running Loop=1 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:TerminalGuidance 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide] Running Loop=1 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide](DEBUG): Aggregate::initialize DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:C] Running Loop=1 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:D] Running Loop=1 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:A] Running Loop=1 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance] Running Loop=1 2020-01-24T18:06:42.856Z,1579889202.856 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:D] Running Loop=1 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:C] Running Loop=1 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:A](INFO): Terminal guidance. 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:A] Stopped 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:E] Running Loop=1 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance] Stopped 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide] Stopped 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide](DEBUG): Aggregate::uninitialize DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint] Stopped 2020-01-24T18:06:42.857Z,1579889202.857 [DefaultUnder:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Uninitialize WaypointComponent. 2020-01-24T18:06:43.268Z,1579889203.268 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:E] Stopped 2020-01-24T18:06:43.268Z,1579889203.268 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:F] Running Loop=1 2020-01-24T18:06:43.679Z,1579889203.679 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:F] Stopped 2020-01-24T18:06:43.679Z,1579889203.679 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture] Running Loop=1 2020-01-24T18:06:43.679Z,1579889203.679 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](DEBUG): Initialize. 2020-01-24T18:06:44.046Z,1579889204.046 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:44.920Z,1579889204.920 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:45.299Z,1579889205.299 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:45.349Z,1579889205.349 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-01-24T18:06:45.349Z,1579889205.349 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00 2020-01-24T18:06:46.118Z,1579889206.118 [Micromodem](INFO): Nmea in: $SNTTA,0.000576,,,,180646.36*4C 2020-01-24T18:06:46.551Z,1579889206.551 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:46.970Z,1579889206.970 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-01-24T18:06:46.970Z,1579889206.970 [RDI_Pathfinder](ERROR): Failed to parse: :BD, +0.00, + +0.00, 0.00,431.99 2020-01-24T18:06:48.532Z,1579889208.532 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:49.369Z,1579889209.369 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:50.149Z,1579889210.149 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:50.562Z,1579889210.562 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:51.369Z,1579889211.369 [Micromodem](INFO): Nmea in: $SNTTA,0.000580,,,,180651.59*4A 2020-01-24T18:06:52.217Z,1579889212.217 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:53.780Z,1579889213.780 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:06:55.062Z,1579889215.062 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:55.805Z,1579889215.805 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:06:56.214Z,1579889216.214 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:06:57.029Z,1579889217.029 [Micromodem](INFO): Nmea in: $SNTTA,0.000574,,,,180657.25*4C 2020-01-24T18:06:57.859Z,1579889217.859 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:06:59.443Z,1579889219.443 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:07:00.677Z,1579889220.677 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:01.461Z,1579889221.461 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:01.867Z,1579889221.867 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:02.693Z,1579889222.693 [Micromodem](INFO): Nmea in: $SNTTA,0.000580,,,,180702.90*48 2020-01-24T18:07:03.528Z,1579889223.528 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:05.096Z,1579889225.096 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:07:06.332Z,1579889226.332 [PowerOnly](INFO): Powering down 2020-01-24T18:07:06.357Z,1579889226.357 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:07.110Z,1579889227.110 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:07.515Z,1579889227.515 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:08.340Z,1579889228.340 [Micromodem](INFO): Nmea in: $SNTTA,0.000582,,,,180708.55*49 2020-01-24T18:07:09.207Z,1579889229.207 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:10.760Z,1579889230.760 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:07:11.000Z,1579889232.000 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:12.777Z,1579889232.777 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:13.178Z,1579889233.178 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:14.007Z,1579889234.007 [Micromodem](INFO): Nmea in: $SNTTA,0.000584,,,,180714.22*42 2020-01-24T18:07:14.825Z,1579889234.825 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:15.204Z,1579889235.204 [NAL9602](INFO): Not Powering down - fast GPS 2020-01-24T18:07:16.408Z,1579889236.408 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:07:17.661Z,1579889237.661 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:18.433Z,1579889238.433 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:18.835Z,1579889238.835 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:19.657Z,1579889239.657 [Micromodem](INFO): Nmea in: $SNTTA,0.000587,,,,180719.88*4C 2020-01-24T18:07:20.485Z,1579889240.485 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:22.064Z,1579889242.064 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:07:23.347Z,1579889243.347 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:24.075Z,1579889244.075 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:24.491Z,1579889244.491 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:25.328Z,1579889245.328 [Micromodem](INFO): Nmea in: $SNTTA,0.000582,,,,180725.52*41 2020-01-24T18:07:25.755Z,1579889245.755 [PowerOnly](INFO): Powering up 2020-01-24T18:07:27.778Z,1579889247.778 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:28.525Z,1579889248.525 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:28.944Z,1579889248.944 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:29.750Z,1579889249.750 [Micromodem](INFO): Nmea in: $SNTTA,0.000578,,,,180729.97*41 2020-01-24T18:07:30.593Z,1579889250.593 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:32.176Z,1579889252.176 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:07:33.425Z,1579889253.425 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:34.181Z,1579889254.181 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:34.594Z,1579889254.594 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:35.409Z,1579889255.409 [Micromodem](INFO): Nmea in: $SNTTA,0.000585,,,,180735.63*45 2020-01-24T18:07:36.246Z,1579889256.246 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:37.816Z,1579889257.816 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:07:39.086Z,1579889259.086 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:39.862Z,1579889259.862 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:40.243Z,1579889260.243 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:41.104Z,1579889261.104 [Micromodem](INFO): Nmea in: $SNTTA,0.000576,,,,180741.31*4D 2020-01-24T18:07:41.162Z,1579889261.162 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](INFO): Final approach. Armed for intercept at range: 0.84 m. 2020-01-24T18:07:43.540Z,1579889263.540 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:44.297Z,1579889264.297 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:44.695Z,1579889264.695 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:45.130Z,1579889265.130 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-24T18:07:45.130Z,1579889265.130 [RDI_Pathfinder](ERROR): Failed to parse: :TS,20012411185457,35.0, -0.1, 48.9, 0 2020-01-24T18:07:45.523Z,1579889265.523 [Micromodem](INFO): Nmea in: $SNTTA,0.000578,,,,180745.74*46 2020-01-24T18:07:45.596Z,1579889265.596 [DefaultUnder:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](INFO): Intercept lockout. Range: 0.84 m. 2020-01-24T18:07:47.984Z,1579889267.984 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:48.729Z,1579889268.729 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:49.135Z,1579889269.135 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:49.988Z,1579889269.988 [Micromodem](INFO): Nmea in: $SNTTA,0.000575,,,,180750.17*4A 2020-01-24T18:07:52.424Z,1579889272.424 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:53.176Z,1579889273.176 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:53.575Z,1579889273.575 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:54.420Z,1579889274.420 [Micromodem](INFO): Nmea in: $SNTTA,0.000581,,,,180754.62*47 2020-01-24T18:07:56.846Z,1579889276.846 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:07:57.616Z,1579889277.616 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:07:58.027Z,1579889278.027 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:07:58.862Z,1579889278.862 [Micromodem](INFO): Nmea in: $SNTTA,0.000577,,,,180759.06*41 2020-01-24T18:08:01.294Z,1579889281.294 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:02.061Z,1579889282.061 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:02.467Z,1579889282.467 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:03.315Z,1579889283.315 [Micromodem](INFO): Nmea in: $SNTTA,0.000582,,,,180803.51*49 2020-01-24T18:08:04.110Z,1579889284.110 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:05.692Z,1579889285.692 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:08:06.967Z,1579889286.967 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:07.720Z,1579889287.720 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:08.134Z,1579889288.134 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:08.942Z,1579889288.942 [Micromodem](INFO): Nmea in: $SNTTA,0.000589,,,,180809.16*4B 2020-01-24T18:08:09.774Z,1579889289.774 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:11.352Z,1579889291.352 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:08:12.603Z,1579889292.603 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:13.374Z,1579889293.374 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:13.779Z,1579889293.779 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:14.608Z,1579889294.608 [Micromodem](INFO): Nmea in: $SNTTA,0.000566,,,,180814.82*4B 2020-01-24T18:08:17.060Z,1579889297.060 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:17.826Z,1579889297.826 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:18.239Z,1579889298.239 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:19.061Z,1579889299.061 [Micromodem](INFO): Nmea in: $SNTTA,0.000580,,,,180819.27*41 2020-01-24T18:08:21.558Z,1579889301.558 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:22.298Z,1579889302.298 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:22.714Z,1579889302.714 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:23.528Z,1579889303.528 [Micromodem](INFO): Nmea in: $SNTTA,0.000568,,,,180823.74*48 2020-01-24T18:08:26.017Z,1579889306.017 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:26.741Z,1579889306.741 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:27.147Z,1579889307.147 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:27.988Z,1579889307.988 [Micromodem](INFO): Nmea in: $SNTTA,0.000578,,,,180828.18*48 2020-01-24T18:08:30.401Z,1579889310.401 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:31.185Z,1579889311.185 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:31.600Z,1579889311.600 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:32.427Z,1579889312.427 [Micromodem](INFO): Nmea in: $SNTTA,0.000571,,,,180832.63*46 2020-01-24T18:08:34.856Z,1579889314.856 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:35.627Z,1579889315.627 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:36.035Z,1579889316.035 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:36.864Z,1579889316.864 [Micromodem](INFO): Nmea in: $SNTTA,0.000573,,,,180837.07*43 2020-01-24T18:08:39.370Z,1579889319.370 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:40.069Z,1579889320.069 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:40.475Z,1579889320.475 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6A 2020-01-24T18:08:41.293Z,1579889321.293 [Micromodem](INFO): Nmea in: $SNTTA,0.000573,,,,180841.51*41 2020-01-24T18:08:42.198Z,1579889322.198 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:43.704Z,1579889323.704 [DUSBL_Hydroid](ERROR): No response from remote modem. 2020-01-24T18:08:45.013Z,1579889325.013 [DefaultUnder:C.](INFO): *** querying acoustic contact *** 2020-01-24T18:08:45.353Z,1579889325.353 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-01-24T18:08:45.353Z,1579889325.353 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00 2020-01-24T18:08:45.726Z,1579889325.726 [Micromodem](INFO): Nmea out: $CCPGT,1,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*77 2020-01-24T18:08:46.133Z,1579889326.133 [Micromodem](INFO): Nmea in: $SNPGT,1,10000,40,0,1000,2400