2019-07-11T00:08:10.542Z,1562803690.542 [Supervisor](DEBUG): Initializing supervisor. 2019-07-11T00:08:10.545Z,1562803690.545 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-07-11T00:08:10.545Z,1562803690.545 [SyncHandler](INFO): Protected caller Thread ID is 2835 2019-07-11T00:08:10.546Z,1562803690.546 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-07-11T00:08:10.547Z,1562803690.547 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-07-11T00:08:10.547Z,1562803690.547 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2836 2019-07-11T00:08:10.550Z,1562803690.550 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-07-11T00:08:10.562Z,1562803690.562 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-07-11T00:08:10.563Z,1562803690.563 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-07-11T00:08:10.563Z,1562803690.563 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2837 2019-07-11T00:08:10.564Z,1562803690.564 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-07-11T00:08:10.565Z,1562803690.565 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-07-11T00:08:10.565Z,1562803690.565 [logger ThreadHandler](INFO): Protected caller Thread ID is 2838 2019-07-11T00:08:10.567Z,1562803690.567 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-07-11T00:08:10.568Z,1562803690.568 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-07-11T00:08:10.569Z,1562803690.569 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-07-11T00:08:10.996Z,1562803690.996 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-07-11T00:08:10.997Z,1562803690.997 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-07-11T00:08:11.095Z,1562803691.095 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-07-11T00:08:11.095Z,1562803691.095 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-07-11T00:08:11.420Z,1562803691.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-07-11T00:08:11.420Z,1562803691.420 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-07-11T00:08:11.562Z,1562803691.562 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-07-11T00:08:11.563Z,1562803691.563 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-07-11T00:08:11.759Z,1562803691.759 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-07-11T00:08:11.760Z,1562803691.760 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-07-11T00:08:12.214Z,1562803692.214 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-07-11T00:08:12.215Z,1562803692.215 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-07-11T00:08:12.424Z,1562803692.424 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-07-11T00:08:12.424Z,1562803692.424 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-07-11T00:08:12.570Z,1562803692.570 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-07-11T00:08:12.571Z,1562803692.571 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-07-11T00:08:12.771Z,1562803692.771 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-07-11T00:08:12.771Z,1562803692.771 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-07-11T00:08:12.868Z,1562803692.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-07-11T00:08:12.869Z,1562803692.869 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-07-11T00:08:13.176Z,1562803693.176 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-07-11T00:08:13.176Z,1562803693.176 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-07-11T00:08:13.257Z,1562803693.257 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-07-11T00:08:13.360Z,1562803693.360 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-07-11T00:08:13.360Z,1562803693.360 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-07-11T00:08:13.963Z,1562803693.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-07-11T00:08:13.963Z,1562803693.963 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-07-11T00:08:14.428Z,1562803694.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-07-11T00:08:14.430Z,1562803694.430 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/ 2019-07-11T00:08:14.431Z,1562803694.431 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg 2019-07-11T00:08:14.645Z,1562803694.645 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg 2019-07-11T00:08:14.747Z,1562803694.747 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg 2019-07-11T00:08:14.848Z,1562803694.848 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg 2019-07-11T00:08:15.075Z,1562803695.075 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-07-11T00:08:15.075Z,1562803695.075 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg 2019-07-11T00:08:15.161Z,1562803695.161 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg 2019-07-11T00:08:15.276Z,1562803695.276 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg 2019-07-11T00:08:15.538Z,1562803695.538 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg 2019-07-11T00:08:15.622Z,1562803695.622 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg 2019-07-11T00:08:15.732Z,1562803695.732 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg 2019-07-11T00:08:15.913Z,1562803695.913 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg 2019-07-11T00:08:16.045Z,1562803696.045 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/ 2019-07-11T00:08:16.045Z,1562803696.045 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2019-07-11T00:08:16.047Z,1562803696.047 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-07-11T00:08:16.429Z,1562803696.429 [AHRS_M2] Loaded 2019-07-11T00:08:16.429Z,1562803696.429 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2019-07-11T00:08:16.504Z,1562803696.504 [DataOverHttps] Loaded 2019-07-11T00:08:16.504Z,1562803696.504 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-07-11T00:08:16.505Z,1562803696.505 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407654E0 2019-07-11T00:08:16.506Z,1562803696.506 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2918 2019-07-11T00:08:16.519Z,1562803696.519 [Depth_Keller] Loaded 2019-07-11T00:08:16.519Z,1562803696.519 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-07-11T00:08:16.524Z,1562803696.524 [DropWeight] Loaded 2019-07-11T00:08:16.524Z,1562803696.524 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2019-07-11T00:08:16.582Z,1562803696.582 [DUSBL_Hydroid] Loaded 2019-07-11T00:08:16.582Z,1562803696.582 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread. 2019-07-11T00:08:16.631Z,1562803696.631 [Micromodem] Loaded 2019-07-11T00:08:16.631Z,1562803696.631 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread. 2019-07-11T00:08:16.729Z,1562803696.729 [NAL9602] Loaded 2019-07-11T00:08:16.730Z,1562803696.730 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-07-11T00:08:16.745Z,1562803696.745 [Onboard] Loaded 2019-07-11T00:08:16.746Z,1562803696.746 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-07-11T00:08:16.752Z,1562803696.752 [PowerOnly] Loaded 2019-07-11T00:08:16.752Z,1562803696.752 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2019-07-11T00:08:16.759Z,1562803696.759 [Radio_Surface] Loaded 2019-07-11T00:08:16.759Z,1562803696.759 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-07-11T00:08:16.760Z,1562803696.760 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407954E0 2019-07-11T00:08:16.760Z,1562803696.760 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2919 2019-07-11T00:08:16.816Z,1562803696.816 [RDI_Pathfinder] Loaded 2019-07-11T00:08:16.816Z,1562803696.816 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2019-07-11T00:08:18.294Z,1562803698.294 [BPC1] Loaded 2019-07-11T00:08:18.294Z,1562803698.294 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-07-11T00:08:18.295Z,1562803698.295 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-07-11T00:08:18.295Z,1562803698.295 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-07-11T00:08:18.309Z,1562803698.309 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-07-11T00:08:18.310Z,1562803698.310 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-07-11T00:08:18.418Z,1562803698.418 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-07-11T00:08:18.418Z,1562803698.418 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-07-11T00:08:18.439Z,1562803698.439 [NavChart] Loaded 2019-07-11T00:08:18.439Z,1562803698.439 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-07-11T00:08:18.443Z,1562803698.443 [UniversalFixResidualReporter] Loaded 2019-07-11T00:08:18.444Z,1562803698.444 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-07-11T00:08:18.444Z,1562803698.444 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-07-11T00:08:18.445Z,1562803698.445 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-07-11T00:08:18.552Z,1562803698.552 [BuoyancyServo] Loaded 2019-07-11T00:08:18.552Z,1562803698.552 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-07-11T00:08:18.567Z,1562803698.567 [ElevatorServo] Loaded 2019-07-11T00:08:18.568Z,1562803698.568 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-07-11T00:08:18.582Z,1562803698.582 [MassServo] Loaded 2019-07-11T00:08:18.583Z,1562803698.583 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-07-11T00:08:18.598Z,1562803698.598 [RudderServo] Loaded 2019-07-11T00:08:18.598Z,1562803698.598 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-07-11T00:08:18.613Z,1562803698.613 [ThrusterServo] Loaded 2019-07-11T00:08:18.613Z,1562803698.613 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-07-11T00:08:18.614Z,1562803698.614 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-07-11T00:08:18.614Z,1562803698.614 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-07-11T00:08:18.868Z,1562803698.868 [CTD_NeilBrown] Loaded 2019-07-11T00:08:18.868Z,1562803698.868 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2019-07-11T00:08:18.869Z,1562803698.869 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408E04E0 2019-07-11T00:08:18.869Z,1562803698.869 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 2920 2019-07-11T00:08:18.914Z,1562803698.914 [WetLabsSeaOWL_UV_A] Loaded 2019-07-11T00:08:18.915Z,1562803698.915 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2019-07-11T00:08:18.916Z,1562803698.916 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 409104E0 2019-07-11T00:08:18.916Z,1562803698.916 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 2921 2019-07-11T00:08:18.917Z,1562803698.917 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-07-11T00:08:18.917Z,1562803698.917 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-07-11T00:08:19.210Z,1562803699.210 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-07-11T00:08:19.210Z,1562803699.210 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-07-11T00:08:19.253Z,1562803699.253 [DepthRateCalculator] Loaded 2019-07-11T00:08:19.253Z,1562803699.253 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-07-11T00:08:19.259Z,1562803699.259 [PitchRateCalculator] Loaded 2019-07-11T00:08:19.259Z,1562803699.259 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-07-11T00:08:19.271Z,1562803699.271 [SpeedCalculator] Loaded 2019-07-11T00:08:19.272Z,1562803699.272 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-07-11T00:08:19.293Z,1562803699.293 [TempGradientCalculator] Loaded 2019-07-11T00:08:19.293Z,1562803699.293 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-07-11T00:08:19.299Z,1562803699.299 [YawRateCalculator] Loaded 2019-07-11T00:08:19.299Z,1562803699.299 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-07-11T00:08:19.341Z,1562803699.341 [ElevatorOffsetCalculator] Loaded 2019-07-11T00:08:19.341Z,1562803699.341 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-07-11T00:08:19.341Z,1562803699.341 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-07-11T00:08:19.342Z,1562803699.342 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-07-11T00:08:19.478Z,1562803699.478 [SBIT](DEBUG): Construct Startup Built In Test. 2019-07-11T00:08:19.500Z,1562803699.500 [SBIT] Loaded 2019-07-11T00:08:19.500Z,1562803699.500 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-07-11T00:08:19.501Z,1562803699.501 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-07-11T00:08:19.512Z,1562803699.512 [IBIT] Loaded 2019-07-11T00:08:19.513Z,1562803699.513 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-07-11T00:08:19.516Z,1562803699.516 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-07-11T00:08:19.658Z,1562803699.658 [CBIT] Loaded 2019-07-11T00:08:19.659Z,1562803699.659 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-07-11T00:08:19.659Z,1562803699.659 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-07-11T00:08:19.660Z,1562803699.660 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-07-11T00:08:19.743Z,1562803699.743 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-07-11T00:08:19.743Z,1562803699.743 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-07-11T00:08:19.841Z,1562803699.841 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-07-11T00:08:19.842Z,1562803699.842 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-07-11T00:08:19.910Z,1562803699.910 [VerticalControl](DEBUG): Construct VerticalControl. 2019-07-11T00:08:19.995Z,1562803699.995 [VerticalControl] Loaded 2019-07-11T00:08:19.995Z,1562803699.995 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-07-11T00:08:19.996Z,1562803699.996 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-07-11T00:08:20.054Z,1562803700.054 [HorizontalControl] Loaded 2019-07-11T00:08:20.054Z,1562803700.054 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-07-11T00:08:20.055Z,1562803700.055 [SpeedControl](DEBUG): Construct SpeedControl. 2019-07-11T00:08:20.056Z,1562803700.056 [SpeedControl] Loaded 2019-07-11T00:08:20.057Z,1562803700.057 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-07-11T00:08:20.057Z,1562803700.057 [LoopControl](DEBUG): Construct LoopControl. 2019-07-11T00:08:20.058Z,1562803700.058 [LoopControl] Loaded 2019-07-11T00:08:20.058Z,1562803700.058 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-07-11T00:08:20.059Z,1562803700.059 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-07-11T00:08:20.059Z,1562803700.059 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-07-11T00:08:20.091Z,1562803700.091 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-07-11T00:08:20.095Z,1562803700.095 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-07-11T00:08:20.096Z,1562803700.096 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-07-11T00:08:20.103Z,1562803700.103 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-07-11T00:08:20.104Z,1562803700.104 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AEC4E0 2019-07-11T00:08:20.105Z,1562803700.105 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2922 2019-07-11T00:08:20.109Z,1562803700.109 [Supervisor](INFO): Main Thread ID is 2834 2019-07-11T00:08:20.109Z,1562803700.109 [Supervisor](DEBUG): Running supervisor. 2019-07-11T00:08:20.110Z,1562803700.110 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2923 2019-07-11T00:08:20.113Z,1562803700.113 [controlThread ThreadHandler](INFO): Handler Thread ID is 2924 2019-07-11T00:08:20.113Z,1562803700.113 [controlThread](DEBUG): Initializing ControlThread 2019-07-11T00:08:20.122Z,1562803700.122 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-07-11T00:08:20.122Z,1562803700.122 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-07-11T00:08:20.123Z,1562803700.123 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-07-11T00:08:20.123Z,1562803700.123 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-07-11T00:08:20.124Z,1562803700.124 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-07-11T00:08:20.124Z,1562803700.124 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-07-11T00:08:20.125Z,1562803700.125 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-07-11T00:08:20.125Z,1562803700.125 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-07-11T00:08:20.125Z,1562803700.125 [SBIT](INFO): Initialize SBIT Component. 2019-07-11T00:08:20.126Z,1562803700.126 [SBIT](IMPORTANT): git: 2019-07-01-2-g8df750c 2019-07-11T00:08:20.126Z,1562803700.126 [SBIT](INFO): git hash: 8df750cfd7ab665d8785a0cb54650bf6fbbccb32 2019-07-11T00:08:20.127Z,1562803700.127 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-07-11T00:08:20.128Z,1562803700.128 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 2019-07-11T00:08:20.129Z,1562803700.129 [SBIT](INFO): Beginning SBIT in 28.000000 seconds. 2019-07-11T00:08:20.129Z,1562803700.129 [IBIT](INFO): Initialize IBIT Component. 2019-07-11T00:08:20.131Z,1562803700.131 [CBIT](DEBUG): Initialize CBIT Component. 2019-07-11T00:08:20.131Z,1562803700.131 [logger ThreadHandler](INFO): Handler Thread ID is 2925 2019-07-11T00:08:20.142Z,1562803700.142 [CBIT](DEBUG): Initialized mux pins. 2019-07-11T00:08:20.142Z,1562803700.142 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2019-07-11T00:08:20.142Z,1562803700.142 [CBIT](DEBUG): Initializing the watchdog timer. 2019-07-11T00:08:20.151Z,1562803700.151 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2926 2019-07-11T00:08:20.152Z,1562803700.152 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-07-11T00:08:20.163Z,1562803700.163 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2927 2019-07-11T00:08:20.166Z,1562803700.166 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-07-11T00:08:20.166Z,1562803700.166 [CBIT](DEBUG): Initializing heartbeat. 2019-07-11T00:08:20.175Z,1562803700.175 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 2928 2019-07-11T00:08:20.176Z,1562803700.176 [CTD_NeilBrown](INFO): Powering down 2019-07-11T00:08:20.205Z,1562803700.205 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 2929 2019-07-11T00:08:20.206Z,1562803700.206 [WetLabsSeaOWL_UV_A](INFO): Powering down 2019-07-11T00:08:20.233Z,1562803700.233 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2930 2019-07-11T00:08:20.236Z,1562803700.236 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-07-11T00:08:20.236Z,1562803700.236 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-07-11T00:08:20.236Z,1562803700.236 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-07-11T00:08:20.237Z,1562803700.237 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-07-11T00:08:20.237Z,1562803700.237 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-07-11T00:08:20.237Z,1562803700.237 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-07-11T00:08:20.237Z,1562803700.237 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-07-11T00:08:20.237Z,1562803700.237 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-07-11T00:08:20.238Z,1562803700.238 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-07-11T00:08:20.238Z,1562803700.238 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-07-11T00:08:20.238Z,1562803700.238 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-07-11T00:08:20.238Z,1562803700.238 [CBIT](DEBUG): Deactivating GF circuits. 2019-07-11T00:08:20.238Z,1562803700.238 [CBIT](DEBUG): Deactivating emergency mode. 2019-07-11T00:08:20.239Z,1562803700.239 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-07-11T00:08:20.239Z,1562803700.239 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-07-11T00:08:20.239Z,1562803700.239 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-07-11T00:08:20.239Z,1562803700.239 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-07-11T00:08:20.239Z,1562803700.239 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-07-11T00:08:20.274Z,1562803700.274 [CBIT](DEBUG): Backplane powered. 2019-07-11T00:08:20.275Z,1562803700.275 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-07-11T00:08:20.276Z,1562803700.276 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-07-11T00:08:20.277Z,1562803700.277 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-07-11T00:08:20.278Z,1562803700.278 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-07-11T00:08:20.278Z,1562803700.278 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-07-11T00:08:20.313Z,1562803700.313 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-07-11T00:08:20.387Z,1562803700.387 [MissionManager](DEBUG): 2019-07-11T00:08:20.388Z,1562803700.388 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-07-11T00:08:20.480Z,1562803700.480 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-07-11T00:08:20.481Z,1562803700.481 [Default:A.Wait](DEBUG): Construct Wait. 2019-07-11T00:08:20.483Z,1562803700.483 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-07-11T00:08:20.501Z,1562803700.501 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-07-11T00:08:20.548Z,1562803700.548 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-07-11T00:08:20.554Z,1562803700.554 [Default:E.Execute](DEBUG): Construct Execute. 2019-07-11T00:08:20.567Z,1562803700.567 [Radio_Surface](INFO): Powering up 2019-07-11T00:08:20.593Z,1562803700.593 [MissionManager](DEBUG): 0 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 Default mission has been running for Restarting logs and Default mission. restart logs 2019-07-11T00:08:20.597Z,1562803700.597 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,PowerOnly,RDI_Pathfinder,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-07-11T00:08:20.619Z,1562803700.619 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-07-11T00:08:20.660Z,1562803700.660 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar 2019-07-11T00:08:20.660Z,1562803700.660 [DUSBL_Hydroid](INFO): Powering up 2019-07-11T00:08:20.661Z,1562803700.661 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid. 2019-07-11T00:08:20.731Z,1562803700.731 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-07-11T00:08:20.748Z,1562803700.748 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-07-11T00:08:20.755Z,1562803700.755 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-07-11T00:08:20.756Z,1562803700.756 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-07-11T00:08:20.763Z,1562803700.763 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-07-11T00:08:20.763Z,1562803700.763 [MassServo](DEBUG): Initializing EZServoServo. 2019-07-11T00:08:20.771Z,1562803700.771 [MassServo](DEBUG): Initializing MassServo. 2019-07-11T00:08:20.771Z,1562803700.771 [RudderServo](DEBUG): Initializing EZServoServo. 2019-07-11T00:08:20.779Z,1562803700.779 [RudderServo](DEBUG): Initializing RudderServo. 2019-07-11T00:08:20.779Z,1562803700.779 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-07-11T00:08:20.787Z,1562803700.787 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-07-11T00:08:21.041Z,1562803701.041 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-07-11T00:08:21.041Z,1562803701.041 [DropWeight] Hardware Fault, FailCount= 1 2019-07-11T00:08:21.041Z,1562803701.041 [DropWeight](ERROR): Hardware Fault 2019-07-11T00:08:21.043Z,1562803701.043 [Micromodem](INFO): Powering up 2019-07-11T00:08:21.043Z,1562803701.043 [Micromodem](DEBUG): Initializing Micromodem. 2019-07-11T00:08:21.114Z,1562803701.114 [CommandLine](FAULT): Scheduling is paused 2019-07-11T00:08:21.114Z,1562803701.114 [CBIT](INFO): Critical error at 20190711T000821 2019-07-11T00:08:21.115Z,1562803701.115 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2019-07-11T00:08:21.117Z,1562803701.117 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-07-11T00:08:21.118Z,1562803701.118 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-07-11T00:08:21.728Z,1562803701.728 [CBIT](INFO): Critical error at 20190711T000821 2019-07-11T00:08:25.891Z,1562803705.891 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33 2019-07-11T00:08:26.301Z,1562803706.301 [Micromodem](INFO): Nmea in: $CATMG,2019-07-11T00:08:25Z,RTC,RTC*7C 2019-07-11T00:08:26.301Z,1562803706.301 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2019-07-11T00:08:25Z,RTC,RTC*7C 2019-07-11T00:08:26.701Z,1562803706.701 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31 2019-07-11T00:08:26.701Z,1562803706.701 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31 2019-07-11T00:08:27.092Z,1562803707.092 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33 2019-07-11T00:08:27.093Z,1562803707.093 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64 2019-07-11T00:08:27.513Z,1562803707.513 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66 2019-07-11T00:08:27.513Z,1562803707.513 [Micromodem](INFO): Nmea out: $CCCFG,nav.nst,1*4D 2019-07-11T00:08:27.916Z,1562803707.916 [Micromodem](INFO): Nmea in: $CACFG,nav.nst,1*4F 2019-07-11T00:08:27.917Z,1562803707.917 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F 2019-07-11T00:08:28.320Z,1562803708.320 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D 2019-07-11T00:08:28.321Z,1562803708.321 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E 2019-07-11T00:08:28.708Z,1562803708.708 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C 2019-07-11T00:08:28.709Z,1562803708.709 [Micromodem](INFO): Nmea out: $CCCFG,FC0,10000*46 2019-07-11T00:08:29.105Z,1562803709.105 [Micromodem](INFO): Nmea in: $CACFG,FC0,10000*44 2019-07-11T00:08:29.105Z,1562803709.105 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63 2019-07-11T00:08:29.504Z,1562803709.504 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61 2019-07-11T00:08:29.505Z,1562803709.505 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A 2019-07-11T00:08:29.945Z,1562803709.945 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38 2019-07-11T00:08:29.946Z,1562803709.946 [Micromodem](INFO): Nmea out: $CCCLK,2019,07,11,00,08,30*42 2019-07-11T00:08:30.305Z,1562803710.305 [Micromodem](INFO): Nmea in: $CACLK,2019,7,11,0,8,30*70 2019-07-11T00:08:30.709Z,1562803710.709 [Micromodem](INFO): Nmea in: $CATMS,0,2019-07-11T00:08:31Z*71 2019-07-11T00:08:30.710Z,1562803710.710 [Micromodem](INFO): Nmea in: $CATMG,2019-07-11T00:08:31Z,USER_CMD,RTC*38 2019-07-11T00:08:32.116Z,1562803712.116 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004596 2019-07-11T00:08:33.966Z,1562803713.966 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder 2019-07-11T00:08:38.790Z,1562803718.790 [DUSBL_Hydroid](INFO): DUSBL Version:O 2019-07-11T00:08:46.877Z,1562803726.877 [NAL9602](INFO): Powering up NAL9602 2019-07-11T00:08:48.516Z,1562803728.516 [SBIT](IMPORTANT): Beginning Startup BIT 2019-07-11T00:08:48.525Z,1562803728.525 [CBIT](IMPORTANT): Beginning ground fault scan 2019-07-11T00:08:57.859Z,1562803737.859 [NAL9602](INFO): NAL9602 initialized 2019-07-11T00:08:58.686Z,1562803738.686 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:08:59.568Z,1562803739.568 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.021992 CHAN A1 (24V): -0.026837 CHAN A2 (12V): -0.006682 CHAN A3 (5V): -0.002022 CHAN B0 (3.3V): 0.000073 CHAN B1 (3.15aV): 0.000089 CHAN B2 (3.15bV): 0.000164 CHAN B3 (GND): 0.001904 OPEN: 0.006906 Full Scale Calc: 4.765 mA, -1.589 mA 2019-07-11T00:09:24.284Z,1562803764.284 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 93.93, 94.42, 92.93, 0.00 2019-07-11T00:09:42.212Z,1562803782.212 [SBIT](IMPORTANT): SBIT PASSED 2019-07-11T00:09:42.264Z,1562803782.264 [CommandLine](IMPORTANT): got command configSet list 2019-07-11T00:09:42.264Z,1562803782.264 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-07-11T00:09:42.265Z,1562803782.265 [CommandLine](IMPORTANT): DUSBL_Hydroid.verbosity=3 count; 2019-07-11T00:09:42.265Z,1562803782.265 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2019-07-11T00:09:42.552Z,1562803782.552 [MissionManager](IMPORTANT): Started mission Startup 2019-07-11T00:09:42.552Z,1562803782.552 [Startup] Running Loop=1 2019-07-11T00:09:42.552Z,1562803782.552 [Startup](DEBUG): Aggregate::initialize Startup 2019-07-11T00:09:42.552Z,1562803782.552 [Startup:A.GoToSurface] Running Loop=1 2019-07-11T00:09:42.552Z,1562803782.552 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-11T00:09:42.553Z,1562803782.553 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-07-11T00:09:42.553Z,1562803782.553 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-07-11T00:09:42.554Z,1562803782.554 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-07-11T00:09:42.554Z,1562803782.554 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-11T00:09:42.555Z,1562803782.555 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-11T00:09:42.556Z,1562803782.556 [Startup:StartupSatComms] Running Loop=1 2019-07-11T00:09:42.556Z,1562803782.556 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-07-11T00:09:42.556Z,1562803782.556 [Startup:StartupSatComms:A] Running Loop=1 2019-07-11T00:09:42.972Z,1562803782.972 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-07-11T00:09:57.712Z,1562803797.712 [CommandLine](IMPORTANT): got command configSet DUSBL_Hydroid.verbosity 3.000000 count 2019-07-11T00:10:42.732Z,1562803842.732 [Startup:StartupSatComms:A](INFO): Timed out from 2019-07-11T00:09:42.6Z 2019-07-11T00:10:42.732Z,1562803842.732 [Startup:StartupSatComms:A] Stopped 2019-07-11T00:10:42.732Z,1562803842.732 [Startup:StartupSatComms:B] Running Loop=1 2019-07-11T00:10:43.156Z,1562803843.156 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-07-11T00:10:45.312Z,1562803845.312 [Micromodem](INFO): Outgoing frame #1, 64 bytes: EA7D265D000000005D00000400900000000000000000151D80030C5669BF31555EAE1409A708CE2489B0D24F922C4E73F3619C1A3D5DFEC97D4617D39DECC9F9 2019-07-11T00:10:45.313Z,1562803845.313 [Micromodem](INFO): Outgoing frame #2, 64 bytes: D51BC41B204C25CD7A8664304AFAB8BA88E6DBB679BD8E6AB23F2A74176E8DC9B99EA6EDEE643222BF77A3ECC0A03392CB3C1E84EE7812BD8FFB2232435191DA 2019-07-11T00:10:45.313Z,1562803845.313 [Micromodem](INFO): Outgoing frame #3, 11 bytes: 5ED8A150F436C6549C2000 2019-07-11T00:10:45.313Z,1562803845.313 [Micromodem](INFO): Nmea out: $CCCYC,0,1,9,1,0,3*53 2019-07-11T00:10:46.268Z,1562803846.268 [Micromodem](INFO): Nmea in: $CACYC,0,1,9,1,0,3*51 2019-07-11T00:10:46.672Z,1562803846.672 [Micromodem](INFO): Nmea in: $CADRQ,001046,1,9,0,64,1*4D 2019-07-11T00:10:46.673Z,1562803846.673 [Micromodem](INFO): Nmea out: $CCTXD,1,9,1,EA7D265D000000005D00000400900000000000000000151D80030C5669BF31555EAE1409A708CE2489B0D24F922C4E73F3619C1A3D5DFEC97D4617D39DECC9F9*0B 2019-07-11T00:10:47.072Z,1562803847.072 [Micromodem](INFO): Nmea in: $CATXD,1,9,1,64*71 2019-07-11T00:10:47.480Z,1562803847.480 [Micromodem](INFO): Nmea in: $CADRQ,001047,1,9,0,64,2*4F 2019-07-11T00:10:47.481Z,1562803847.481 [Micromodem](INFO): Nmea out: $CCTXD,1,9,1,D51BC41B204C25CD7A8664304AFAB8BA88E6DBB679BD8E6AB23F2A74176E8DC9B99EA6EDEE643222BF77A3ECC0A03392CB3C1E84EE7812BD8FFB2232435191DA*08 2019-07-11T00:10:47.851Z,1562803847.851 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20190711T000810/Courier0000.lzma 2019-07-11T00:10:47.916Z,1562803847.916 [Micromodem](INFO): Nmea in: $CATXD,1,9,1,64*71 2019-07-11T00:10:48.284Z,1562803848.284 [Micromodem](INFO): Nmea in: $CADRQ,001048,1,9,0,64,3*41 2019-07-11T00:10:48.285Z,1562803848.285 [Micromodem](INFO): Nmea out: $CCTXD,1,9,1,5ED8A150F436C6549C2000*73 2019-07-11T00:10:48.660Z,1562803848.660 [DataOverHttps](INFO): Moved sent file to Logs/20190711T000810/Courier0000.lzma.bak 2019-07-11T00:10:48.660Z,1562803848.660 [DataOverHttps](INFO): SBD MOMSN=11438455 2019-07-11T00:10:48.692Z,1562803848.692 [Micromodem](INFO): Nmea in: $CATXD,1,9,1,11*73 2019-07-11T00:10:49.100Z,1562803849.100 [Micromodem](INFO): Nmea in: $CATXP,139*49 2019-07-11T00:10:52.728Z,1562803852.728 [Micromodem](INFO): Nmea in: $CATXF,139*5F 2019-07-11T00:10:53.133Z,1562803853.133 [Micromodem](INFO): Nmea in: $CAXST,6,20190711,001049.054680,3,0,200,4000,10000,1,1,9,1,3,3,3,139*4F 2019-07-11T00:11:01.566Z,1562803861.566 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20190710T233220/Express0008.lzma 2019-07-11T00:11:02.372Z,1562803862.372 [DataOverHttps](INFO): Moved sent file to Logs/20190710T233220/Express0008.lzma.bak 2019-07-11T00:11:02.372Z,1562803862.372 [DataOverHttps](INFO): SBD MOMSN=11438460 2019-07-11T00:11:05.272Z,1562803865.272 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-07-11T00:11:05.273Z,1562803865.273 [RDI_Pathfinder](ERROR): Failed to parse: :TS,19071017195811,35.0, -0.1, 0.0,10 2019-07-11T00:11:15.650Z,1562803875.650 [DataOverHttps](INFO): Sending 435 bytes from file Logs/20190710T235531/Express0001.lzma 2019-07-11T00:11:16.456Z,1562803876.456 [DataOverHttps](INFO): Moved sent file to Logs/20190710T235531/Express0001.lzma.bak 2019-07-11T00:11:16.456Z,1562803876.456 [DataOverHttps](INFO): SBD MOMSN=11438463 2019-07-11T00:11:20.247Z,1562803880.247 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-07-11T00:11:20.247Z,1562803880.247 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-11T00:11:20.257Z,1562803880.257 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-11T00:11:20.662Z,1562803880.662 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-11T00:11:20.662Z,1562803880.662 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-07-11T00:11:30.627Z,1562803890.627 [DataOverHttps](INFO): Sending 711 bytes from file Logs/20190711T000810/Express0001.lzma 2019-07-11T00:11:31.432Z,1562803891.432 [DataOverHttps](INFO): Moved sent file to Logs/20190711T000810/Express0001.lzma.bak 2019-07-11T00:11:31.432Z,1562803891.432 [DataOverHttps](INFO): SBD MOMSN=11438474 2019-07-11T00:11:33.975Z,1562803893.975 [Startup:StartupSatComms:B] Stopped 2019-07-11T00:11:33.976Z,1562803893.976 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-07-11T00:11:33.976Z,1562803893.976 [Startup:StartupSatComms] Stopped 2019-07-11T00:11:33.976Z,1562803893.976 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-07-11T00:11:33.977Z,1562803893.977 [Startup](INFO): Completed Startup 2019-07-11T00:11:33.977Z,1562803893.977 [MissionManager](INFO): Startup is completed. 2019-07-11T00:11:33.977Z,1562803893.977 [MissionManager](INFO): Uninitializing Mission Startup 2019-07-11T00:11:33.977Z,1562803893.977 [Startup] Stopped 2019-07-11T00:11:33.977Z,1562803893.977 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-07-11T00:11:33.977Z,1562803893.977 [Startup:A.GoToSurface] Stopped 2019-07-11T00:11:33.977Z,1562803893.977 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-11T00:11:34.371Z,1562803894.371 [MissionManager](IMPORTANT): Started mission Default 2019-07-11T00:11:34.372Z,1562803894.372 [Default] Running Loop=1 2019-07-11T00:11:34.372Z,1562803894.372 [Default](DEBUG): Aggregate::initialize Default 2019-07-11T00:11:34.372Z,1562803894.372 [Default:B.GoToSurface] Running Loop=1 2019-07-11T00:11:34.372Z,1562803894.372 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-11T00:11:34.372Z,1562803894.372 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-07-11T00:11:34.373Z,1562803894.373 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-07-11T00:11:34.373Z,1562803894.373 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-07-11T00:11:34.373Z,1562803894.373 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-11T00:11:34.374Z,1562803894.374 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-11T00:11:34.374Z,1562803894.374 [Default:A.Wait] Running Loop=1 2019-07-11T00:11:34.374Z,1562803894.374 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-07-11T00:11:44.308Z,1562803904.308 [CommandLine](IMPORTANT): got command run ./Missions/DUSBL_Tracking.xml 2019-07-11T00:11:44.308Z,1562803904.308 [MissionManager](INFO): Loading Mission: ./Missions/DUSBL_Tracking.xml 2019-07-11T00:11:44.368Z,1562803904.368 [MissionManager](INFO): DefineArg DUSBL.MissionTimeout = 5.000000 min 2019-07-11T00:11:44.375Z,1562803904.375 [MissionManager](INFO): DefineArg DUSBL.TransponderCode = 2.000000 count 2019-07-11T00:11:44.383Z,1562803904.383 [MissionManager](INFO): DefineArg DUSBL.TrackingUpdatePeriod = 4.000000 s 2019-07-11T00:11:44.391Z,1562803904.391 [MissionManager](INFO): DefineArg DUSBL.NumberOfPings = 1.000000 count 2019-07-11T00:11:44.394Z,1562803904.394 [MissionManager](INFO): DefineArg DUSBL.EnabledDUSBL = DUSBL_Hydroid.loadAtStartup 2019-07-11T00:11:44.399Z,1562803904.399 [DUSBL:A.Pitch](DEBUG): Construct. 2019-07-11T00:11:44.414Z,1562803904.414 [DUSBL:B.SetSpeed](DEBUG): Construct. 2019-07-11T00:11:44.743Z,1562803904.743 [DUSBL:RequestRepeater:A.Wait](DEBUG): Construct Wait. 2019-07-11T00:11:44.763Z,1562803904.763 [MissionManager](DEBUG): This mission is requests a DUSBL arming. How long to let the mission run. 5 Transponder Address. 2 How long to wait between acoustic queries 4 Number of pings requested each time. 1 Automatically set to true if the DUSBL is enabled. Set to false to disable reading from the DUSBL. 0 2019-07-11T00:11:44.765Z,1562803904.765 [CommandLine](IMPORTANT): Running ./Missions/DUSBL_Tracking.xml 2019-07-11T00:11:44.871Z,1562803904.871 [Default] Stopped 2019-07-11T00:11:44.871Z,1562803904.871 [Default](DEBUG): Aggregate::uninitialize Default 2019-07-11T00:11:44.871Z,1562803904.871 [Default:A.Wait] Stopped 2019-07-11T00:11:44.871Z,1562803904.871 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-07-11T00:11:44.871Z,1562803904.871 [Default:B.GoToSurface] Stopped 2019-07-11T00:11:44.871Z,1562803904.871 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-11T00:11:44.871Z,1562803904.871 [MissionManager](IMPORTANT): Started mission DUSBL 2019-07-11T00:11:44.872Z,1562803904.872 [DUSBL] Running Loop=1 2019-07-11T00:11:44.872Z,1562803904.872 [DUSBL](DEBUG): Aggregate::initialize DUSBL 2019-07-11T00:11:44.872Z,1562803904.872 [DUSBL:A.Pitch] Running Loop=1 2019-07-11T00:11:44.872Z,1562803904.872 [DUSBL:A.Pitch](DEBUG): Initialize. 2019-07-11T00:11:44.872Z,1562803904.872 [DUSBL:B.SetSpeed] Running Loop=1 2019-07-11T00:11:44.872Z,1562803904.872 [DUSBL:B.SetSpeed](DEBUG): Initialize. 2019-07-11T00:11:44.872Z,1562803904.872 [DUSBL:C.] Running Loop=1 2019-07-11T00:11:44.873Z,1562803904.873 [DUSBL:C.](INFO): Initializing TrackAcousticContact. 2019-07-11T00:11:44.873Z,1562803904.873 [DUSBL:RequestRepeater] Running Loop=1 2019-07-11T00:11:44.873Z,1562803904.873 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater 2019-07-11T00:11:44.873Z,1562803904.873 [DUSBL:RequestRepeater:A.Wait] Running Loop=1 2019-07-11T00:11:44.873Z,1562803904.873 [DUSBL:RequestRepeater:A.Wait](DEBUG): Initialize Wait Component. 2019-07-11T00:11:44.874Z,1562803904.874 [DUSBL:C.] Running Loop=1 2019-07-11T00:11:44.878Z,1562803904.878 [DUSBL:B.SetSpeed] Running Loop=1 2019-07-11T00:11:44.879Z,1562803904.879 [DUSBL:A.Pitch] Running Loop=1 2019-07-11T00:11:48.937Z,1562803908.937 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:11:49.291Z,1562803909.291 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:11:49.292Z,1562803909.292 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:11:49.292Z,1562803909.292 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:11:49.293Z,1562803909.293 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:11:49.700Z,1562803909.700 [DUSBL_Hydroid](INFO): USBL response received:!U1,P O 2019-07-11T00:11:49.700Z,1562803909.700 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:11:49.700Z,1562803909.700 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:11:49.702Z,1562803909.702 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:11:50.097Z,1562803910.097 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:11:52.936Z,1562803912.936 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61 2019-07-11T00:11:52.936Z,1562803912.936 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61 2019-07-11T00:11:52.936Z,1562803912.936 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:11:52.971Z,1562803912.971 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:11:53.335Z,1562803913.335 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:11:53.336Z,1562803913.336 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:11:53.336Z,1562803913.336 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:11:53.336Z,1562803913.336 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:11:53.732Z,1562803913.732 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61 2019-07-11T00:11:53.732Z,1562803913.732 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:11:53.732Z,1562803913.732 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:11:53.733Z,1562803913.733 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:11:54.142Z,1562803914.142 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:11:56.968Z,1562803916.968 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61 2019-07-11T00:11:56.968Z,1562803916.968 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61 2019-07-11T00:11:56.968Z,1562803916.968 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:11:57.104Z,1562803917.104 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:11:57.368Z,1562803917.368 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:11:57.368Z,1562803917.368 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:11:57.368Z,1562803917.368 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:11:57.369Z,1562803917.369 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:11:57.772Z,1562803917.772 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61 2019-07-11T00:11:57.772Z,1562803917.772 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:11:57.772Z,1562803917.772 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:11:57.774Z,1562803917.774 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:11:58.178Z,1562803918.178 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:01.012Z,1562803921.012 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E 2019-07-11T00:12:01.012Z,1562803921.012 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E 2019-07-11T00:12:01.012Z,1562803921.012 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:01.456Z,1562803921.456 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:01.815Z,1562803921.815 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:01.816Z,1562803921.816 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:01.816Z,1562803921.816 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:01.816Z,1562803921.816 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:02.216Z,1562803922.216 [DUSBL_Hydroid](INFO): USBL response received:4 !U1,P ,80,61,E 2019-07-11T00:12:02.216Z,1562803922.216 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:02.216Z,1562803922.216 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:02.217Z,1562803922.217 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:02.626Z,1562803922.626 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:05.456Z,1562803925.456 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:05.456Z,1562803925.456 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:05.456Z,1562803925.456 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:05.500Z,1562803925.500 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:05.851Z,1562803925.851 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:05.852Z,1562803925.852 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:05.852Z,1562803925.852 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:05.852Z,1562803925.852 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:06.256Z,1562803926.256 [DUSBL_Hydroid](INFO): USBL response received: !U1,P 0,80,61,E4 2019-07-11T00:12:06.256Z,1562803926.256 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:06.256Z,1562803926.256 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:06.258Z,1562803926.258 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:06.662Z,1562803926.662 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:09.492Z,1562803929.492 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:09.492Z,1562803929.492 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:09.492Z,1562803929.492 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:09.548Z,1562803929.548 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:09.910Z,1562803929.910 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:09.910Z,1562803929.910 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:09.911Z,1562803929.911 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:09.912Z,1562803929.912 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:10.296Z,1562803930.296 [DUSBL_Hydroid](INFO): USBL response received:E4 !U1,P 80,61,E4 2019-07-11T00:12:10.296Z,1562803930.296 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:10.296Z,1562803930.296 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:10.297Z,1562803930.297 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:10.702Z,1562803930.702 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:13.536Z,1562803933.536 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:13.536Z,1562803933.536 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:13.536Z,1562803933.536 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:13.560Z,1562803933.560 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:13.931Z,1562803933.931 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:13.931Z,1562803933.931 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:13.932Z,1562803933.932 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:13.932Z,1562803933.932 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:14.344Z,1562803934.344 [DUSBL_Hydroid](INFO): USBL response received:E4 !U1,P 80,61,E4 2019-07-11T00:12:14.344Z,1562803934.344 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:14.344Z,1562803934.344 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:14.345Z,1562803934.345 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:14.746Z,1562803934.746 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:17.585Z,1562803937.585 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:17.586Z,1562803937.586 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:17.586Z,1562803937.586 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:17.620Z,1562803937.620 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:17.971Z,1562803937.971 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:17.971Z,1562803937.971 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:17.972Z,1562803937.972 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:17.972Z,1562803937.972 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:18.383Z,1562803938.383 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:12:18.383Z,1562803938.383 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:18.383Z,1562803938.383 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:18.385Z,1562803938.385 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:18.790Z,1562803938.790 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:21.616Z,1562803941.616 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:21.616Z,1562803941.616 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:21.616Z,1562803941.616 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:21.676Z,1562803941.676 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:22.019Z,1562803942.019 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:22.019Z,1562803942.019 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:22.020Z,1562803942.020 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:22.020Z,1562803942.020 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:22.426Z,1562803942.426 [DUSBL_Hydroid](INFO): USBL response received:,61,E4 !U1,P 1,E4 2019-07-11T00:12:22.426Z,1562803942.426 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:22.426Z,1562803942.426 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:22.427Z,1562803942.427 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:22.838Z,1562803942.838 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:25.652Z,1562803945.652 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80U1,P 1,E4 2019-07-11T00:12:25.652Z,1562803945.652 [DUSBL_Hydroid](INFO): No reply:!U1,N,80U1,P 1,E4 2019-07-11T00:12:25.652Z,1562803945.652 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:25.692Z,1562803945.692 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:26.065Z,1562803946.065 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:26.065Z,1562803946.065 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:26.066Z,1562803946.066 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:26.067Z,1562803946.067 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:26.460Z,1562803946.460 [DUSBL_Hydroid](INFO): USBL response received:,80,61,E4 !U1,P 4 2019-07-11T00:12:26.460Z,1562803946.460 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:26.460Z,1562803946.460 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:26.461Z,1562803946.461 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:26.870Z,1562803946.870 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:29.692Z,1562803949.692 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80U1,P 4 2019-07-11T00:12:29.692Z,1562803949.692 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80U1,P 4 2019-07-11T00:12:29.692Z,1562803949.692 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:29.776Z,1562803949.776 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:30.095Z,1562803950.095 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:30.095Z,1562803950.095 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:30.096Z,1562803950.096 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:30.096Z,1562803950.096 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:30.500Z,1562803950.500 [DUSBL_Hydroid](INFO): USBL response received:,61,E4 !U1,P ,P 4 2019-07-11T00:12:30.500Z,1562803950.500 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:30.500Z,1562803950.500 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:30.501Z,1562803950.501 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:30.930Z,1562803950.930 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:33.732Z,1562803953.732 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61P 4 2019-07-11T00:12:33.732Z,1562803953.732 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61P 4 2019-07-11T00:12:33.732Z,1562803953.732 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:33.983Z,1562803953.983 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:34.135Z,1562803954.135 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:34.136Z,1562803954.136 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:34.136Z,1562803954.136 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:34.136Z,1562803954.136 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:34.540Z,1562803954.540 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61P 4 2019-07-11T00:12:34.540Z,1562803954.540 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:34.540Z,1562803954.540 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:34.541Z,1562803954.541 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:34.945Z,1562803954.945 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:37.776Z,1562803957.776 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61, 4 2019-07-11T00:12:37.776Z,1562803957.776 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61, 4 2019-07-11T00:12:37.776Z,1562803957.776 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:38.209Z,1562803958.209 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:38.579Z,1562803958.579 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:38.579Z,1562803958.579 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:38.580Z,1562803958.580 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:38.580Z,1562803958.580 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:38.992Z,1562803958.992 [DUSBL_Hydroid](INFO): USBL response received:E4 !U1,P 80,61, 4 2019-07-11T00:12:38.992Z,1562803958.992 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:38.992Z,1562803958.992 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:38.994Z,1562803958.994 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:39.390Z,1562803959.390 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:42.220Z,1562803962.220 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61, 4 2019-07-11T00:12:42.220Z,1562803962.220 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61, 4 2019-07-11T00:12:42.220Z,1562803962.220 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:42.273Z,1562803962.273 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:42.628Z,1562803962.628 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:42.628Z,1562803962.628 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:42.628Z,1562803962.628 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:42.629Z,1562803962.629 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:43.020Z,1562803963.020 [DUSBL_Hydroid](INFO): USBL response received:,61,E4 !U1,P 1, 4 2019-07-11T00:12:43.020Z,1562803963.020 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:43.021Z,1562803963.021 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:43.022Z,1562803963.022 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:43.442Z,1562803963.442 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:46.260Z,1562803966.260 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:46.260Z,1562803966.260 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:46.260Z,1562803966.260 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:46.348Z,1562803966.348 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:46.659Z,1562803966.659 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:46.660Z,1562803966.660 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:46.660Z,1562803966.660 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:46.661Z,1562803966.661 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:47.064Z,1562803967.064 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:12:47.064Z,1562803967.064 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:47.064Z,1562803967.064 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:47.065Z,1562803967.065 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:47.469Z,1562803967.469 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:50.312Z,1562803970.312 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:50.312Z,1562803970.312 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:50.312Z,1562803970.312 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:50.380Z,1562803970.380 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:50.699Z,1562803970.699 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:50.699Z,1562803970.699 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:50.700Z,1562803970.700 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:50.700Z,1562803970.700 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:51.108Z,1562803971.108 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:12:51.108Z,1562803971.108 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:51.108Z,1562803971.108 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:51.110Z,1562803971.110 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:51.522Z,1562803971.522 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:54.340Z,1562803974.340 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:54.340Z,1562803974.340 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:54.340Z,1562803974.340 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:12:54.768Z,1562803974.768 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:55.143Z,1562803975.143 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:12:55.143Z,1562803975.143 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:12:55.144Z,1562803975.144 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:12:55.144Z,1562803975.144 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:12:55.579Z,1562803975.579 [DUSBL_Hydroid](INFO): USBL response received:,61,E4 !U1,P 1,E4 2019-07-11T00:12:55.579Z,1562803975.579 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:12:55.579Z,1562803975.579 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:12:55.580Z,1562803975.580 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:12:55.971Z,1562803975.971 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:12:58.809Z,1562803978.809 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:12:59.180Z,1562803979.180 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:12:59.180Z,1562803979.180 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:12:59.180Z,1562803979.180 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:02.875Z,1562803982.875 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:03.224Z,1562803983.224 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:03.224Z,1562803983.224 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:03.224Z,1562803983.224 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:03.225Z,1562803983.225 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:03.628Z,1562803983.628 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:13:03.628Z,1562803983.628 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:03.628Z,1562803983.628 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:03.630Z,1562803983.630 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:04.034Z,1562803984.034 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:04.768Z,1562803984.768 [CommandLine](IMPORTANT): got command configSet DUSBL_Hydroid.verbosity 1.000000 count 2019-07-11T00:13:06.866Z,1562803986.866 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:06.866Z,1562803986.866 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:06.866Z,1562803986.866 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:06.921Z,1562803986.921 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:07.259Z,1562803987.259 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:07.259Z,1562803987.259 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:07.260Z,1562803987.260 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:07.260Z,1562803987.260 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:07.664Z,1562803987.664 [DUSBL_Hydroid](INFO): USBL response received:4 !U1,P ,80,61,E4 2019-07-11T00:13:07.665Z,1562803987.665 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:07.665Z,1562803987.665 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:07.666Z,1562803987.666 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:08.078Z,1562803988.078 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:10.915Z,1562803990.915 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:10.915Z,1562803990.915 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:10.916Z,1562803990.916 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:10.951Z,1562803990.951 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:11.303Z,1562803991.303 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:11.303Z,1562803991.303 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:11.304Z,1562803991.304 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:11.304Z,1562803991.304 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:11.712Z,1562803991.712 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:13:11.712Z,1562803991.712 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:11.712Z,1562803991.712 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:11.714Z,1562803991.714 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:12.110Z,1562803992.110 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:14.940Z,1562803994.940 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:14.940Z,1562803994.940 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:14.941Z,1562803994.941 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:14.992Z,1562803994.992 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:15.351Z,1562803995.351 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:15.352Z,1562803995.352 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:15.352Z,1562803995.352 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:15.352Z,1562803995.352 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:15.744Z,1562803995.744 [DUSBL_Hydroid](INFO): USBL response received:80,61,E4 !U1,P E4 2019-07-11T00:13:15.744Z,1562803995.744 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:15.745Z,1562803995.745 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:15.746Z,1562803995.746 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:16.154Z,1562803996.154 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:18.984Z,1562803998.984 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:18.984Z,1562803998.984 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:18.984Z,1562803998.984 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:19.057Z,1562803999.057 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:19.379Z,1562803999.379 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:19.379Z,1562803999.379 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:19.380Z,1562803999.380 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:19.380Z,1562803999.380 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:19.784Z,1562803999.784 [DUSBL_Hydroid](INFO): USBL response received:E4 !U1,P 80,61,E4 2019-07-11T00:13:19.784Z,1562803999.784 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:19.784Z,1562803999.784 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:19.785Z,1562803999.785 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:20.193Z,1562804000.193 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:23.024Z,1562804003.024 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:23.024Z,1562804003.024 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:23.024Z,1562804003.024 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:23.113Z,1562804003.113 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:23.420Z,1562804003.420 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:23.420Z,1562804003.420 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:23.420Z,1562804003.420 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:23.421Z,1562804003.421 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:23.824Z,1562804003.824 [DUSBL_Hydroid](INFO): USBL response received: !U1,P 0,80,61,E4 2019-07-11T00:13:23.824Z,1562804003.824 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:23.824Z,1562804003.824 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:23.826Z,1562804003.826 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:24.230Z,1562804004.230 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:27.064Z,1562804007.064 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:27.064Z,1562804007.064 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:27.064Z,1562804007.064 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:27.148Z,1562804007.148 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:27.475Z,1562804007.475 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:27.475Z,1562804007.475 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:27.476Z,1562804007.476 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:27.476Z,1562804007.476 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:27.868Z,1562804007.868 [DUSBL_Hydroid](INFO): USBL response received:E4 !U1,P 80,61,E4 2019-07-11T00:13:27.868Z,1562804007.868 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:27.868Z,1562804007.868 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:27.870Z,1562804007.870 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:28.282Z,1562804008.282 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:28.313Z,1562804008.313 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-07-11T00:13:28.313Z,1562804008.313 [RDI_Pathfinder](ERROR): Failed to parse: :TS,19071017222111,35.0, -0.1, 0.0, 0 2019-07-11T00:13:31.100Z,1562804011.100 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:31.100Z,1562804011.100 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:31.100Z,1562804011.100 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:31.204Z,1562804011.204 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:31.499Z,1562804011.499 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:31.499Z,1562804011.499 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:31.500Z,1562804011.500 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:31.500Z,1562804011.500 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:31.924Z,1562804011.924 [DUSBL_Hydroid](INFO): USBL response received:80,61,E4 !U1,P E4 2019-07-11T00:13:31.924Z,1562804011.924 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:31.924Z,1562804011.924 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:31.925Z,1562804011.925 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:32.314Z,1562804012.314 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:35.540Z,1562804015.540 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:35.540Z,1562804015.540 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:35.540Z,1562804015.540 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:35.584Z,1562804015.584 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:35.952Z,1562804015.952 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:35.952Z,1562804015.952 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:35.952Z,1562804015.952 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:35.952Z,1562804015.952 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:36.348Z,1562804016.348 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:13:36.348Z,1562804016.348 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:36.348Z,1562804016.348 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:36.349Z,1562804016.349 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:36.754Z,1562804016.754 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:39.588Z,1562804019.588 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:39.588Z,1562804019.588 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:39.588Z,1562804019.588 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:39.628Z,1562804019.628 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:39.983Z,1562804019.983 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:39.984Z,1562804019.984 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:39.984Z,1562804019.984 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:39.985Z,1562804019.985 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:40.388Z,1562804020.388 [DUSBL_Hydroid](INFO): USBL response received: !U1,P 0,80,61,E4 2019-07-11T00:13:40.388Z,1562804020.388 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:40.388Z,1562804020.388 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:40.389Z,1562804020.389 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:40.794Z,1562804020.794 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:43.624Z,1562804023.624 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:43.624Z,1562804023.624 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:43.624Z,1562804023.624 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:43.755Z,1562804023.755 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:44.023Z,1562804024.023 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:44.024Z,1562804024.024 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:44.024Z,1562804024.024 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:44.024Z,1562804024.024 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:44.432Z,1562804024.432 [DUSBL_Hydroid](INFO): USBL response received:4 !U1,P ,80,61,E4 2019-07-11T00:13:44.432Z,1562804024.432 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:44.432Z,1562804024.432 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:44.434Z,1562804024.434 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:44.834Z,1562804024.834 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:47.668Z,1562804027.668 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:47.668Z,1562804027.668 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:47.668Z,1562804027.668 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:48.100Z,1562804028.100 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:48.467Z,1562804028.467 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:48.468Z,1562804028.468 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:48.468Z,1562804028.468 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:48.469Z,1562804028.469 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:48.876Z,1562804028.876 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61,E4 2019-07-11T00:13:48.876Z,1562804028.876 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:48.876Z,1562804028.876 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:48.877Z,1562804028.877 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:48.920Z,1562804028.920 [RDI_Pathfinder](ERROR): Failed to parse: 00, 94.92, 94.42, 92.93, 0.00 2019-07-11T00:13:49.285Z,1562804029.285 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:52.108Z,1562804032.108 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:13:52.109Z,1562804032.109 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:13:52.109Z,1562804032.109 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:52.142Z,1562804032.142 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:52.512Z,1562804032.512 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:52.512Z,1562804032.512 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:52.512Z,1562804032.512 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:52.513Z,1562804032.513 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:52.924Z,1562804032.924 [DUSBL_Hydroid](INFO): USBL response received:,61,E4 !U1,P 1,E4 2019-07-11T00:13:52.924Z,1562804032.924 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:52.924Z,1562804032.924 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:52.926Z,1562804032.926 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:53.326Z,1562804033.326 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:13:56.152Z,1562804036.152 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,8,P 1,E4 2019-07-11T00:13:56.152Z,1562804036.152 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,8,P 1,E4 2019-07-11T00:13:56.152Z,1562804036.152 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:13:56.192Z,1562804036.192 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:13:56.560Z,1562804036.560 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:13:56.560Z,1562804036.560 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:13:56.560Z,1562804036.560 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:13:56.561Z,1562804036.561 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:13:56.952Z,1562804036.952 [DUSBL_Hydroid](INFO): USBL response received:0,61,E4 !U1,P ,E4 2019-07-11T00:13:56.952Z,1562804036.952 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:13:56.952Z,1562804036.952 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:13:56.953Z,1562804036.953 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:13:57.358Z,1562804037.358 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:00.192Z,1562804040.192 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:00.192Z,1562804040.192 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:00.192Z,1562804040.192 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:00.265Z,1562804040.265 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:00.603Z,1562804040.603 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:00.603Z,1562804040.603 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:00.604Z,1562804040.604 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:00.604Z,1562804040.604 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:00.992Z,1562804040.992 [DUSBL_Hydroid](INFO): USBL response received:4 !U1,P ,80,61,E4 2019-07-11T00:14:00.992Z,1562804040.992 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:00.992Z,1562804040.992 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:00.993Z,1562804040.993 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:01.398Z,1562804041.398 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:01.411Z,1562804041.411 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-07-11T00:14:02.222Z,1562804042.222 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:14:02.615Z,1562804042.615 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001248.00,A,3648.16601,N,12147.28196,W,0.194,169.10,110719,,,A*73 2019-07-11T00:14:02.617Z,1562804042.617 [NAL9602](INFO): GPS fix at 20190711T001248: (36.802767, -121.788033) 2019-07-11T00:14:04.243Z,1562804044.243 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:04.244Z,1562804044.244 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:04.244Z,1562804044.244 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:04.321Z,1562804044.321 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:04.638Z,1562804044.638 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:04.638Z,1562804044.638 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:04.639Z,1562804044.639 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:04.640Z,1562804044.640 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:05.043Z,1562804045.043 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:14:05.043Z,1562804045.043 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:05.044Z,1562804045.044 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:05.045Z,1562804045.045 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:05.450Z,1562804045.450 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:08.272Z,1562804048.272 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:08.272Z,1562804048.272 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:08.272Z,1562804048.272 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:08.294Z,1562804048.294 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2019-07-11T00:14:08.294Z,1562804048.294 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 93.93, 94.42, 92.93, 0.00 2019-07-11T00:14:08.717Z,1562804048.717 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:09.079Z,1562804049.079 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:09.079Z,1562804049.079 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:09.079Z,1562804049.079 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:09.080Z,1562804049.080 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:09.492Z,1562804049.492 [DUSBL_Hydroid](INFO): USBL response received:,80,61,E4 !U1,P 4 2019-07-11T00:14:09.492Z,1562804049.492 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:09.492Z,1562804049.492 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:09.493Z,1562804049.493 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:09.925Z,1562804049.925 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:12.722Z,1562804052.722 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,8!U1,P 4 2019-07-11T00:14:12.723Z,1562804052.723 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,8!U1,P 4 2019-07-11T00:14:12.723Z,1562804052.723 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:12.753Z,1562804052.753 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:13.119Z,1562804053.119 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:13.119Z,1562804053.119 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:13.120Z,1562804053.120 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:13.120Z,1562804053.120 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:13.527Z,1562804053.527 [DUSBL_Hydroid](INFO): USBL response received:0,61,E4 !U1,P P 4 2019-07-11T00:14:13.527Z,1562804053.527 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:13.527Z,1562804053.527 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:13.529Z,1562804053.529 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:13.934Z,1562804053.934 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:16.756Z,1562804056.756 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,U1,P P 4 2019-07-11T00:14:16.756Z,1562804056.756 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,U1,P P 4 2019-07-11T00:14:16.756Z,1562804056.756 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:16.831Z,1562804056.831 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:17.159Z,1562804057.159 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:17.159Z,1562804057.159 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:17.159Z,1562804057.159 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:17.160Z,1562804057.160 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:17.563Z,1562804057.563 [DUSBL_Hydroid](INFO): USBL response received:80,61,E4 !U1,P 4 2019-07-11T00:14:17.564Z,1562804057.564 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:17.564Z,1562804057.564 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:17.565Z,1562804057.565 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:17.969Z,1562804057.969 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:20.799Z,1562804060.799 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61 4 2019-07-11T00:14:20.800Z,1562804060.800 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61 4 2019-07-11T00:14:20.800Z,1562804060.800 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:20.834Z,1562804060.834 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:21.199Z,1562804061.199 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:21.199Z,1562804061.199 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:21.199Z,1562804061.199 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:21.200Z,1562804061.200 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:21.605Z,1562804061.605 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61 4 2019-07-11T00:14:21.605Z,1562804061.605 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:21.605Z,1562804061.605 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:21.611Z,1562804061.611 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:22.009Z,1562804062.009 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:24.836Z,1562804064.836 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80, 0,61 4 2019-07-11T00:14:24.836Z,1562804064.836 [DUSBL_Hydroid](INFO): No reply:!U1,N,80, 0,61 4 2019-07-11T00:14:24.836Z,1562804064.836 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:24.887Z,1562804064.887 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:25.239Z,1562804065.239 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:25.239Z,1562804065.239 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:25.239Z,1562804065.239 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:25.240Z,1562804065.240 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:25.651Z,1562804065.651 [DUSBL_Hydroid](INFO): USBL response received:80,61,E4 !U1,P 4 2019-07-11T00:14:25.651Z,1562804065.651 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:25.651Z,1562804065.651 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:25.653Z,1562804065.653 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:26.050Z,1562804066.050 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:28.881Z,1562804068.881 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,!U1,P 4 2019-07-11T00:14:28.881Z,1562804068.881 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,!U1,P 4 2019-07-11T00:14:28.882Z,1562804068.882 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:28.926Z,1562804068.926 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:29.279Z,1562804069.279 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:29.279Z,1562804069.279 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:29.280Z,1562804069.280 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:29.280Z,1562804069.280 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:29.687Z,1562804069.687 [DUSBL_Hydroid](INFO): USBL response received:80,61,E4 !U1,P 4 2019-07-11T00:14:29.688Z,1562804069.688 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:29.688Z,1562804069.688 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:29.689Z,1562804069.689 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:30.089Z,1562804070.089 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:32.932Z,1562804072.932 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:32.932Z,1562804072.932 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:32.932Z,1562804072.932 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:32.966Z,1562804072.966 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:33.319Z,1562804073.319 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:33.319Z,1562804073.319 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:33.320Z,1562804073.320 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:33.320Z,1562804073.320 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:33.727Z,1562804073.727 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:14:33.727Z,1562804073.727 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:33.728Z,1562804073.728 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:33.729Z,1562804073.729 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:34.133Z,1562804074.133 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:35.340Z,1562804075.340 [NAL9602](INFO): Powering down 2019-07-11T00:14:36.956Z,1562804076.956 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:36.956Z,1562804076.956 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:36.956Z,1562804076.956 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:37.044Z,1562804077.044 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:37.363Z,1562804077.363 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:37.363Z,1562804077.363 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:37.363Z,1562804077.363 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:37.364Z,1562804077.364 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:37.763Z,1562804077.763 [DUSBL_Hydroid](INFO): USBL response received:80,61,E4 !U1,P E4 2019-07-11T00:14:37.763Z,1562804077.763 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:37.764Z,1562804077.764 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:37.765Z,1562804077.765 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:38.170Z,1562804078.170 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:40.999Z,1562804080.999 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,6P E4 2019-07-11T00:14:40.000Z,1562804081.000 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,6P E4 2019-07-11T00:14:40.000Z,1562804081.000 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:41.430Z,1562804081.430 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:41.803Z,1562804081.803 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:41.803Z,1562804081.803 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:41.803Z,1562804081.803 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:41.804Z,1562804081.804 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:42.211Z,1562804082.211 [DUSBL_Hydroid](INFO): USBL response received:1,E4 !U1,P ,6P E4 2019-07-11T00:14:42.212Z,1562804082.212 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:42.212Z,1562804082.212 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:42.213Z,1562804082.213 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:42.613Z,1562804082.613 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:45.450Z,1562804085.450 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:45.451Z,1562804085.451 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:45.451Z,1562804085.451 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:45.482Z,1562804085.482 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:45.844Z,1562804085.844 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:45.844Z,1562804085.844 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:45.844Z,1562804085.844 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:45.845Z,1562804085.845 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:46.252Z,1562804086.252 [DUSBL_Hydroid](INFO): USBL response received:4 !U1,P ,80,61,E4 2019-07-11T00:14:46.252Z,1562804086.252 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:46.252Z,1562804086.252 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:46.254Z,1562804086.254 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:46.654Z,1562804086.654 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:49.483Z,1562804089.483 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:49.484Z,1562804089.484 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:49.484Z,1562804089.484 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:49.549Z,1562804089.549 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:49.892Z,1562804089.892 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:49.893Z,1562804089.893 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:49.894Z,1562804089.894 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:49.895Z,1562804089.895 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:50.285Z,1562804090.285 [DUSBL_Hydroid](INFO): USBL response received:61,E4 !U1,P 61,E4 2019-07-11T00:14:50.285Z,1562804090.285 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:50.285Z,1562804090.285 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:50.287Z,1562804090.287 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:50.697Z,1562804090.697 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:53.519Z,1562804093.519 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:53.519Z,1562804093.519 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:53.519Z,1562804093.519 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:53.549Z,1562804093.549 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:53.935Z,1562804093.935 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:53.935Z,1562804093.935 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:53.935Z,1562804093.935 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:53.936Z,1562804093.936 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:54.327Z,1562804094.327 [DUSBL_Hydroid](INFO): USBL response received:61,E4 !U1,P 61,E4 2019-07-11T00:14:54.328Z,1562804094.328 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:54.328Z,1562804094.328 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:54.329Z,1562804094.329 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:54.733Z,1562804094.733 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:14:57.564Z,1562804097.564 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:14:57.564Z,1562804097.564 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:14:57.564Z,1562804097.564 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:14:57.594Z,1562804097.594 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:14:57.963Z,1562804097.963 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:14:57.963Z,1562804097.963 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:14:57.964Z,1562804097.964 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:14:57.964Z,1562804097.964 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:14:58.371Z,1562804098.371 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61,E4 2019-07-11T00:14:58.371Z,1562804098.371 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:14:58.372Z,1562804098.372 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:14:58.373Z,1562804098.373 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:14:58.774Z,1562804098.774 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:01.622Z,1562804101.622 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:15:01.622Z,1562804101.622 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:15:01.622Z,1562804101.622 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:01.656Z,1562804101.656 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:02.027Z,1562804102.027 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:02.027Z,1562804102.027 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:02.027Z,1562804102.027 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:02.028Z,1562804102.028 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:02.436Z,1562804102.436 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:15:02.436Z,1562804102.436 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:02.436Z,1562804102.436 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:02.437Z,1562804102.437 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:02.837Z,1562804102.837 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:05.672Z,1562804105.672 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:15:05.672Z,1562804105.672 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:15:05.672Z,1562804105.672 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:05.717Z,1562804105.717 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:06.067Z,1562804106.067 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:06.067Z,1562804106.067 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:06.067Z,1562804106.067 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:06.068Z,1562804106.068 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:06.475Z,1562804106.475 [DUSBL_Hydroid](INFO): USBL response received:E4 !U1,P 80,61,E4 2019-07-11T00:15:06.475Z,1562804106.475 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:06.476Z,1562804106.476 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:06.477Z,1562804106.477 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:06.879Z,1562804106.879 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:09.704Z,1562804109.704 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:15:09.704Z,1562804109.704 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:15:09.704Z,1562804109.704 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:09.776Z,1562804109.776 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:10.111Z,1562804110.111 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:10.111Z,1562804110.111 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:10.112Z,1562804110.112 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:10.112Z,1562804110.112 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:10.515Z,1562804110.515 [DUSBL_Hydroid](INFO): USBL response received:0,61,E4 !U1,P ,E4 2019-07-11T00:15:10.515Z,1562804110.515 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:10.515Z,1562804110.515 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:10.517Z,1562804110.517 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:10.931Z,1562804110.931 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:13.747Z,1562804113.747 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,81,P ,E4 2019-07-11T00:15:13.748Z,1562804113.748 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,81,P ,E4 2019-07-11T00:15:13.748Z,1562804113.748 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:13.787Z,1562804113.787 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:14.151Z,1562804114.151 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:14.151Z,1562804114.151 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:14.152Z,1562804114.152 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:14.152Z,1562804114.152 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:14.559Z,1562804114.559 [DUSBL_Hydroid](INFO): USBL response received:0,61,E4 !U1,P ,E4 2019-07-11T00:15:14.560Z,1562804114.560 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:14.560Z,1562804114.560 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:14.561Z,1562804114.561 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:14.991Z,1562804114.991 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:17.787Z,1562804117.787 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,U1,P ,E4 2019-07-11T00:15:17.788Z,1562804117.788 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,U1,P ,E4 2019-07-11T00:15:17.788Z,1562804117.788 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:17.814Z,1562804117.814 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:18.187Z,1562804118.187 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:18.187Z,1562804118.187 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:18.187Z,1562804118.187 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:18.188Z,1562804118.188 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:18.591Z,1562804118.591 [DUSBL_Hydroid](INFO): USBL response received:80,61,E4 !U1,P E4 2019-07-11T00:15:18.591Z,1562804118.591 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:18.592Z,1562804118.592 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:18.593Z,1562804118.593 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:18.997Z,1562804118.997 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:21.828Z,1562804121.828 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61 E4 2019-07-11T00:15:21.828Z,1562804121.828 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61 E4 2019-07-11T00:15:21.828Z,1562804121.828 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:21.857Z,1562804121.857 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:22.231Z,1562804122.231 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:22.231Z,1562804122.231 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:22.231Z,1562804122.231 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:22.232Z,1562804122.232 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:22.635Z,1562804122.635 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61 E4 2019-07-11T00:15:22.635Z,1562804122.635 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:22.635Z,1562804122.635 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:22.637Z,1562804122.637 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:23.038Z,1562804123.038 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:25.868Z,1562804125.868 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61 E4 2019-07-11T00:15:25.868Z,1562804125.868 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61 E4 2019-07-11T00:15:25.868Z,1562804125.868 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:25.965Z,1562804125.965 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:26.271Z,1562804126.271 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:26.271Z,1562804126.271 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:26.271Z,1562804126.271 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:26.272Z,1562804126.272 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:26.669Z,1562804126.669 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61 E4 2019-07-11T00:15:26.669Z,1562804126.669 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:26.669Z,1562804126.669 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:26.671Z,1562804126.671 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:27.077Z,1562804127.077 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:29.925Z,1562804129.925 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:15:29.925Z,1562804129.925 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:15:29.925Z,1562804129.925 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:30.002Z,1562804130.002 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:30.307Z,1562804130.307 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:30.307Z,1562804130.307 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:30.308Z,1562804130.308 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:30.308Z,1562804130.308 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:30.715Z,1562804130.715 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:15:30.715Z,1562804130.715 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:30.716Z,1562804130.716 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:30.717Z,1562804130.717 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:31.121Z,1562804131.121 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:33.943Z,1562804133.943 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:15:33.943Z,1562804133.943 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:15:33.943Z,1562804133.943 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:34.376Z,1562804134.376 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:34.749Z,1562804134.749 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:34.749Z,1562804134.749 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:34.749Z,1562804134.749 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:34.750Z,1562804134.750 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:35.156Z,1562804135.156 [DUSBL_Hydroid](INFO): USBL response received:80,61,E4 !U1,P E4 2019-07-11T00:15:35.156Z,1562804135.156 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:35.156Z,1562804135.156 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:35.157Z,1562804135.157 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:35.561Z,1562804135.561 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:38.391Z,1562804138.391 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,6P E4 2019-07-11T00:15:38.392Z,1562804138.392 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,6P E4 2019-07-11T00:15:38.392Z,1562804138.392 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:38.433Z,1562804138.433 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:38.797Z,1562804138.797 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:38.797Z,1562804138.797 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:38.797Z,1562804138.797 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:38.798Z,1562804138.798 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:39.196Z,1562804139.196 [DUSBL_Hydroid](INFO): USBL response received:1,E4 !U1,P ,6P E4 2019-07-11T00:15:39.196Z,1562804139.196 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:39.196Z,1562804139.196 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:39.197Z,1562804139.197 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:39.605Z,1562804139.605 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:42.432Z,1562804142.432 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61 E4 2019-07-11T00:15:42.432Z,1562804142.432 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61 E4 2019-07-11T00:15:42.432Z,1562804142.432 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:42.514Z,1562804142.514 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:42.835Z,1562804142.835 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:42.835Z,1562804142.835 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:42.835Z,1562804142.835 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:42.836Z,1562804142.836 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:43.233Z,1562804143.233 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61 E4 2019-07-11T00:15:43.233Z,1562804143.233 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:43.233Z,1562804143.233 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:43.235Z,1562804143.235 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:43.646Z,1562804143.646 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:46.471Z,1562804146.471 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61 E4 2019-07-11T00:15:46.472Z,1562804146.472 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61 E4 2019-07-11T00:15:46.472Z,1562804146.472 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:46.544Z,1562804146.544 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:46.873Z,1562804146.873 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:46.873Z,1562804146.873 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:46.873Z,1562804146.873 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:46.874Z,1562804146.874 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:47.291Z,1562804147.291 [DUSBL_Hydroid](INFO): USBL response received:1,E4 !U1,P ,61 E4 2019-07-11T00:15:47.292Z,1562804147.292 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:47.292Z,1562804147.292 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:47.293Z,1562804147.293 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:47.420Z,1562804147.420 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2019-07-11T00:15:47.432Z,1562804147.432 [BPC1](INFO): Received data from all battery sticks. 2019-07-11T00:15:47.682Z,1562804147.682 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:50.933Z,1562804150.933 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:15:50.934Z,1562804150.934 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:15:50.934Z,1562804150.934 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:51.023Z,1562804151.023 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:51.315Z,1562804151.315 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:51.315Z,1562804151.315 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:51.316Z,1562804151.316 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:51.316Z,1562804151.316 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:51.719Z,1562804151.719 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:15:51.719Z,1562804151.719 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:51.720Z,1562804151.720 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:51.721Z,1562804151.721 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:52.126Z,1562804152.126 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:54.955Z,1562804154.955 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:15:54.956Z,1562804154.956 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:15:54.956Z,1562804154.956 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:55.382Z,1562804155.382 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:55.767Z,1562804155.767 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:55.767Z,1562804155.767 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:55.767Z,1562804155.767 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:55.768Z,1562804155.768 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:15:56.163Z,1562804156.163 [DUSBL_Hydroid](INFO): USBL response received:1,E4 !U1,P ,61,E4 2019-07-11T00:15:56.163Z,1562804156.163 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:15:56.164Z,1562804156.164 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:15:56.165Z,1562804156.165 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:15:56.569Z,1562804156.569 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:15:59.406Z,1562804159.406 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:15:59.406Z,1562804159.406 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:15:59.406Z,1562804159.406 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:15:59.431Z,1562804159.431 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:15:59.800Z,1562804159.800 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:15:59.800Z,1562804159.800 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:15:59.800Z,1562804159.800 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:15:59.801Z,1562804159.801 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:00.204Z,1562804160.204 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:16:00.204Z,1562804160.204 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:00.204Z,1562804160.204 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:00.206Z,1562804160.206 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:00.610Z,1562804160.610 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:03.435Z,1562804163.435 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:16:03.435Z,1562804163.435 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:16:03.435Z,1562804163.435 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:03.465Z,1562804163.465 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:03.843Z,1562804163.843 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:03.843Z,1562804163.843 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:03.843Z,1562804163.843 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:03.844Z,1562804163.844 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:04.241Z,1562804164.241 [DUSBL_Hydroid](INFO): USBL response received:,61,E4 !U1,P 1,E4 2019-07-11T00:16:04.241Z,1562804164.241 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:04.241Z,1562804164.241 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:04.243Z,1562804164.243 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:04.649Z,1562804164.649 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:07.475Z,1562804167.475 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80, 1,E4 2019-07-11T00:16:07.475Z,1562804167.475 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80, 1,E4 2019-07-11T00:16:07.475Z,1562804167.475 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:07.501Z,1562804167.501 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:07.893Z,1562804167.893 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:07.893Z,1562804167.893 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:07.895Z,1562804167.895 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:07.896Z,1562804167.896 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:08.287Z,1562804168.287 [DUSBL_Hydroid](INFO): USBL response received:61,E4 !U1,P 1,E4 2019-07-11T00:16:08.287Z,1562804168.287 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:08.288Z,1562804168.288 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:08.289Z,1562804168.289 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:08.689Z,1562804168.689 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:11.520Z,1562804171.520 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80, 1,E4 2019-07-11T00:16:11.520Z,1562804171.520 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80, 1,E4 2019-07-11T00:16:11.520Z,1562804171.520 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:11.586Z,1562804171.586 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:11.927Z,1562804171.927 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:11.927Z,1562804171.927 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:11.928Z,1562804171.928 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:11.928Z,1562804171.928 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:12.321Z,1562804172.321 [DUSBL_Hydroid](INFO): USBL response received:61,E4 !U1,P 1,E4 2019-07-11T00:16:12.321Z,1562804172.321 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:12.321Z,1562804172.321 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:12.323Z,1562804172.323 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:12.730Z,1562804172.730 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:15.559Z,1562804175.559 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:16:15.560Z,1562804175.560 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:16:15.560Z,1562804175.560 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:15.997Z,1562804175.997 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:16.367Z,1562804176.367 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:16.367Z,1562804176.367 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:16.367Z,1562804176.367 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:16.368Z,1562804176.368 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:16.770Z,1562804176.770 [DUSBL_Hydroid](INFO): USBL response received:,E4 !U1,P 0,61,E4 2019-07-11T00:16:16.770Z,1562804176.770 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:16.770Z,1562804176.770 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:16.772Z,1562804176.772 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:17.173Z,1562804177.173 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:19.000Z,1562804180.000 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:16:19.000Z,1562804180.000 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:16:20.000Z,1562804180.000 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:20.038Z,1562804180.038 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:20.407Z,1562804180.407 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:20.407Z,1562804180.407 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:20.407Z,1562804180.407 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:20.408Z,1562804180.408 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:20.807Z,1562804180.807 [DUSBL_Hydroid](INFO): USBL response received:0,61,E4 !U1,P ,E4 2019-07-11T00:16:20.807Z,1562804180.807 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:20.808Z,1562804180.808 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:20.809Z,1562804180.809 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:21.219Z,1562804181.219 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:24.051Z,1562804184.051 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:16:24.052Z,1562804184.052 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:16:24.052Z,1562804184.052 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:24.098Z,1562804184.098 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:24.449Z,1562804184.449 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:24.449Z,1562804184.449 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:24.450Z,1562804184.450 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:24.450Z,1562804184.450 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:24.866Z,1562804184.866 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:16:24.866Z,1562804184.866 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:24.867Z,1562804184.867 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:24.868Z,1562804184.868 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:25.257Z,1562804185.257 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:25.302Z,1562804185.302 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-07-11T00:16:25.303Z,1562804185.303 [RDI_Pathfinder](ERROR): Failed to parse: :TS,19071017251, -0.1, 0.0,1448.9, 0 2019-07-11T00:16:28.087Z,1562804188.087 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:16:28.088Z,1562804188.088 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:16:28.088Z,1562804188.088 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:28.164Z,1562804188.164 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:28.493Z,1562804188.493 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:28.493Z,1562804188.493 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:28.493Z,1562804188.493 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:28.494Z,1562804188.494 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:28.915Z,1562804188.915 [DUSBL_Hydroid](INFO): USBL response received:80,80,61,E4 !U1,P 2019-07-11T00:16:28.915Z,1562804188.915 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:28.916Z,1562804188.916 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:28.923Z,1562804188.923 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:29.297Z,1562804189.297 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:32.168Z,1562804192.168 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:32.527Z,1562804192.527 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:16:32.528Z,1562804192.528 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:16:32.528Z,1562804192.528 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:36.194Z,1562804196.194 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:36.568Z,1562804196.568 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:36.568Z,1562804196.568 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:36.568Z,1562804196.568 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:36.569Z,1562804196.569 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:36.968Z,1562804196.968 [DUSBL_Hydroid](INFO): USBL response received:!U1,P 80,80,61,E4 2019-07-11T00:16:36.968Z,1562804196.968 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:36.968Z,1562804196.968 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:36.969Z,1562804196.969 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:37.377Z,1562804197.377 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:40.208Z,1562804200.208 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:16:40.208Z,1562804200.208 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:16:40.208Z,1562804200.208 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:40.242Z,1562804200.242 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:40.603Z,1562804200.603 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:40.603Z,1562804200.603 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:40.603Z,1562804200.603 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:40.604Z,1562804200.604 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:41.011Z,1562804201.011 [DUSBL_Hydroid](INFO): USBL response received: !U1,P 0,80,61,E4 2019-07-11T00:16:41.011Z,1562804201.011 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:41.012Z,1562804201.012 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:41.013Z,1562804201.013 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:41.417Z,1562804201.417 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:44.244Z,1562804204.244 [DUSBL_Hydroid](INFO): USBL response received:!U1,N,80,80,61,E4 2019-07-11T00:16:44.244Z,1562804204.244 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,61,E4 2019-07-11T00:16:44.244Z,1562804204.244 [DUSBL_Hydroid](ERROR): No response from remote modem. 2019-07-11T00:16:44.318Z,1562804204.318 [DUSBL:C.](INFO): *** querying acoustic contact *** 2019-07-11T00:16:44.647Z,1562804204.647 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2019-07-11T00:16:44.647Z,1562804204.647 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2019-07-11T00:16:44.647Z,1562804204.647 [DUSBL_Hydroid](INFO): Arming DUSBL. rangeReq: #U1,P,02,014,800,20,00,00,5DC 2019-07-11T00:16:44.648Z,1562804204.648 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2019-07-11T00:16:45.051Z,1562804205.051 [DUSBL_Hydroid](INFO): USBL response received:61,E4 !U1,P 61,E4 2019-07-11T00:16:45.051Z,1562804205.051 [DUSBL_Hydroid](INFO): Command Ack 2019-07-11T00:16:45.051Z,1562804205.051 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2019-07-11T00:16:45.053Z,1562804205.053 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*51 2019-07-11T00:16:45.172Z,1562804205.172 [DUSBL](INFO): Timed out from 2019-07-11T00:11:44.9Z 2019-07-11T00:16:45.172Z,1562804205.172 [MissionManager](INFO): DUSBL is completed. 2019-07-11T00:16:45.172Z,1562804205.172 [MissionManager](INFO): Uninitializing Mission DUSBL 2019-07-11T00:16:45.172Z,1562804205.172 [DUSBL] Stopped 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL](DEBUG): Aggregate::uninitialize DUSBL 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL:A.Pitch] Stopped 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL:B.SetSpeed] Stopped 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL:B.SetSpeed](DEBUG): Uninitialize. 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL:C.] Stopped 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL:RequestRepeater] Stopped 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL:RequestRepeater:A.Wait] Stopped 2019-07-11T00:16:45.173Z,1562804205.173 [DUSBL:RequestRepeater:A.Wait](DEBUG): Uninitialize Wait Component. 2019-07-11T00:16:45.453Z,1562804205.453 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,1000,24000,0,0,0,0,4000,0*4C 2019-07-11T00:16:45.493Z,1562804205.493 [MissionManager](IMPORTANT): Started mission Default 2019-07-11T00:16:45.494Z,1562804205.494 [Default] Running Loop=1 2019-07-11T00:16:45.494Z,1562804205.494 [Default](DEBUG): Aggregate::initialize Default 2019-07-11T00:16:45.494Z,1562804205.494 [Default:B.GoToSurface] Running Loop=1 2019-07-11T00:16:45.494Z,1562804205.494 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-11T00:16:45.494Z,1562804205.494 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-07-11T00:16:45.495Z,1562804205.495 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-07-11T00:16:45.495Z,1562804205.495 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-07-11T00:16:45.495Z,1562804205.495 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-11T00:16:45.496Z,1562804205.496 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-11T00:16:45.496Z,1562804205.496 [Default:A.Wait] Running Loop=1 2019-07-11T00:16:45.496Z,1562804205.496 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-07-11T00:16:58.822Z,1562804218.822 [Default:A.Wait](INFO): Done Waiting. 2019-07-11T00:16:58.822Z,1562804218.822 [Default:A.Wait] Stopped 2019-07-11T00:16:58.822Z,1562804218.822 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-07-11T00:16:59.248Z,1562804219.248 [Default:CheckIn] Running Loop=1 2019-07-11T00:16:59.248Z,1562804219.248 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-07-11T00:16:59.248Z,1562804219.248 [Default:CheckIn:Read_GPS] Running Loop=1 2019-07-11T00:16:59.618Z,1562804219.618 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-07-11T00:17:00.008Z,1562804220.008 [NAL9602](INFO): Powering up 2019-07-11T00:17:10.923Z,1562804230.923 [NAL9602](INFO): NAL9602 initialized 2019-07-11T00:17:11.722Z,1562804231.722 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:17:37.973Z,1562804257.973 [NAL9602](INFO): SBD MO Status=0, MOMSN=8107, MT Status=0, MTMSN=0 2019-07-11T00:17:37.974Z,1562804257.974 [NAL9602](INFO): No messages in MT queue 2019-07-11T00:17:38.795Z,1562804258.795 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:17:41.219Z,1562804261.219 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:17:44.450Z,1562804264.450 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:17:47.286Z,1562804267.286 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:17:50.511Z,1562804270.511 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:17:53.342Z,1562804273.342 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:17:56.570Z,1562804276.570 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:17:59.405Z,1562804279.405 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:02.626Z,1562804282.626 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:05.470Z,1562804285.470 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:06.300Z,1562804286.300 [RDI_Pathfinder](ERROR): Failed to parse:.00, 93.93, 94.42, 93.43, 0.00 2019-07-11T00:18:08.698Z,1562804288.698 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:11.526Z,1562804291.526 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:14.346Z,1562804294.346 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:17.574Z,1562804297.574 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:20.406Z,1562804300.406 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:23.242Z,1562804303.242 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:26.466Z,1562804306.466 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:29.294Z,1562804309.294 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:32.526Z,1562804312.526 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:35.358Z,1562804315.358 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:38.586Z,1562804318.586 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:41.418Z,1562804321.418 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:44.646Z,1562804324.646 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:47.478Z,1562804327.478 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:50.314Z,1562804330.314 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:53.538Z,1562804333.538 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:56.362Z,1562804336.362 [NAL9602](DEBUG): Fix Requested 2019-07-11T00:18:56.757Z,1562804336.757 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001742.00,A,3648.17848,N,12147.28937,W,0.194,0.00,110719,,,A*72 2019-07-11T00:18:56.760Z,1562804336.760 [NAL9602](INFO): GPS fix at 20190711T001742: (36.802975, -121.788156) 2019-07-11T00:18:56.800Z,1562804336.800 [Default:CheckIn:Read_GPS] Stopped 2019-07-11T00:18:56.801Z,1562804336.801 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-07-11T00:18:57.223Z,1562804337.223 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-07-11T00:18:57.630Z,1562804337.630 [Micromodem](ERROR): Buffer fill timout failure. 2019-07-11T00:18:59.415Z,1562804339.415 [Micromodem](INFO): Outgoing frame #1, 64 bytes: EA7D265D040001005D00000400270300000000000000151D80030C5669BF3148E2FA22188B6A3173E6960F887FF8A99E669AC91D474B0DB47F940EC581E0D567 2019-07-11T00:18:59.415Z,1562804339.415 [Micromodem](INFO): Outgoing frame #2, 64 bytes: 266CC0E6F1A517638CB0C0B8BE3619E02B8F4A169EC22D30546A87042BC836DF836B942BC3C4A9EFC1B6C4BDD91F97B2782B4B03CB56EA92D77C6909485B9FDE 2019-07-11T00:18:59.416Z,1562804339.416 [Micromodem](INFO): Outgoing frame #3, 64 bytes: C9BA76D6E11C7243AB9F1CB76D4E14F7CBE1C6B0B40F2F0A19DC25B10B3C6279A2D80F52F03F1275F5BE973EA20943C61E76D185D02D3A531DAE1C60CC9420D9 2019-07-11T00:18:59.416Z,1562804339.416 [Micromodem](INFO): Nmea out: $CCCYC,0,1,9,1,0,3*53 2019-07-11T00:18:59.623Z,1562804339.623 [Micromodem](INFO): Nmea in: $CACYC,0,1,9,1,0,3*51 2019-07-11T00:18:59.964Z,1562804339.964 [Micromodem](INFO): Nmea in: $CADRQ,001900,1,9,0,64,1*46 2019-07-11T00:18:59.964Z,1562804339.964 [Micromodem](INFO): Nmea out: $CCTXD,1,9,1,EA7D265D040001005D00000400270300000000000000151D80030C5669BF3148E2FA22188B6A3173E6960F887FF8A99E669AC91D474B0DB47F940EC581E0D567*0A 2019-07-11T00:19:00.368Z,1562804340.368 [Micromodem](INFO): Nmea in: $CATXD,1,9,1,64*71 2019-07-11T00:19:00.768Z,1562804340.768 [Micromodem](INFO): Nmea in: $CADRQ,001900,1,9,0,64,2*45 2019-07-11T00:19:00.768Z,1562804340.768 [Micromodem](INFO): Nmea out: $CCTXD,1,9,1,266CC0E6F1A517638CB0C0B8BE3619E02B8F4A169EC22D30546A87042BC836DF836B942BC3C4A9EFC1B6C4BDD91F97B2782B4B03CB56EA92D77C6909485B9FDE*74 2019-07-11T00:19:01.172Z,1562804341.172 [Micromodem](INFO): Nmea in: $CATXD,1,9,1,64*71 2019-07-11T00:19:01.576Z,1562804341.576 [Micromodem](INFO): Nmea in: $CADRQ,001901,1,9,0,64,3*45 2019-07-11T00:19:01.577Z,1562804341.577 [Micromodem](INFO): Nmea out: $CCTXD,1,9,1,C9BA76D6E11C7243AB9F1CB76D4E14F7CBE1C6B0B40F2F0A19DC25B10B3C6279A2D80F52F03F1275F5BE973EA20943C61E76D185D02D3A531DAE1C60CC9420D9*03 2019-07-11T00:19:01.984Z,1562804341.984 [Micromodem](INFO): Nmea in: $CATXD,1,9,1,64*71 2019-07-11T00:19:02.384Z,1562804342.384 [Micromodem](INFO): Nmea in: $CATXP,192*48 2019-07-11T00:19:03.938Z,1562804343.938 [DataOverHttps](INFO): Sending 301 bytes from file Logs/20190711T000810/Courier0004.lzma 2019-07-11T00:19:04.744Z,1562804344.744 [DataOverHttps](INFO): Moved sent file to Logs/20190711T000810/Courier0004.lzma.bak 2019-07-11T00:19:04.744Z,1562804344.744 [DataOverHttps](INFO): SBD MOMSN=11438495 2019-07-11T00:19:06.021Z,1562804346.021 [Micromodem](INFO): Nmea in: $CATXF,192*5E 2019-07-11T00:19:06.425Z,1562804346.425 [Micromodem](INFO): Nmea in: $CAXST,6,20190711,001902.407512,3,0,200,4000,10000,1,1,9,1,3,3,3,192*42 2019-07-11T00:19:18.259Z,1562804358.259 [DataOverHttps](INFO): Sending 436 bytes from file Logs/20190711T000810/Express0005.lzma 2019-07-11T00:19:19.064Z,1562804359.064 [DataOverHttps](INFO): Moved sent file to Logs/20190711T000810/Express0005.lzma.bak 2019-07-11T00:19:19.064Z,1562804359.064 [DataOverHttps](INFO): SBD MOMSN=11438499 2019-07-11T00:19:21.824Z,1562804361.824 [Default:CheckIn:Read_Iridium] Stopped 2019-07-11T00:19:21.824Z,1562804361.824 [Default:CheckIn:C.Wait] Running Loop=1 2019-07-11T00:19:21.824Z,1562804361.824 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-07-11T00:19:29.915Z,1562804369.915 [NAL9602](INFO): Powering down 2019-07-11T00:20:58.116Z,1562804458.116 [CommandLine](IMPORTANT): got command restart application 2019-07-11T00:20:59.122Z,1562804459.122 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2019-07-11T00:20:59.123Z,1562804459.123 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-11T00:20:59.123Z,1562804459.123 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.314Z,1562804459.314 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-07-11T00:20:59.314Z,1562804459.314 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.315Z,1562804459.315 [CommandLine](INFO): Join timeout helper Thread ID is 2982 2019-07-11T00:20:59.316Z,1562804459.316 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-07-11T00:20:59.316Z,1562804459.316 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.316Z,1562804459.316 [NavChartDb](INFO): Join timeout helper Thread ID is 2983 2019-07-11T00:20:59.426Z,1562804459.426 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-11T00:20:59.427Z,1562804459.427 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.434Z,1562804459.434 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2019-07-11T00:20:59.434Z,1562804459.434 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.435Z,1562804459.435 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 2984 2019-07-11T00:20:59.770Z,1562804459.770 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-11T00:20:59.771Z,1562804459.771 [WetLabsSeaOWL_UV_A](INFO): Powering down 2019-07-11T00:20:59.771Z,1562804459.771 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.786Z,1562804459.786 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2019-07-11T00:20:59.786Z,1562804459.786 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.787Z,1562804459.787 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 2985 2019-07-11T00:20:59.810Z,1562804459.810 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-11T00:20:59.811Z,1562804459.811 [CTD_NeilBrown](INFO): Powering down 2019-07-11T00:20:59.822Z,1562804459.822 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.826Z,1562804459.826 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-07-11T00:20:59.826Z,1562804459.826 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:20:59.827Z,1562804459.827 [Radio_Surface](INFO): Join timeout helper Thread ID is 2986 2019-07-11T00:21:00.146Z,1562804460.146 [Radio_Surface](INFO): Powering down 2019-07-11T00:21:00.147Z,1562804460.147 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-11T00:21:00.148Z,1562804460.148 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:00.151Z,1562804460.151 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-07-11T00:21:00.151Z,1562804460.151 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:00.152Z,1562804460.152 [DataOverHttps](INFO): Join timeout helper Thread ID is 2987 2019-07-11T00:21:00.518Z,1562804460.518 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-11T00:21:00.519Z,1562804460.519 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:00.535Z,1562804460.535 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-07-11T00:21:00.535Z,1562804460.535 [logger ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:00.535Z,1562804460.535 [logger](INFO): Join timeout helper Thread ID is 2988 2019-07-11T00:21:00.594Z,1562804460.594 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-11T00:21:00.595Z,1562804460.595 [logger ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:00.615Z,1562804460.615 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-07-11T00:21:00.615Z,1562804460.615 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:00.615Z,1562804460.615 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-07-11T00:21:00.615Z,1562804460.615 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:00.616Z,1562804460.616 [controlThread](INFO): Join timeout helper Thread ID is 2989 2019-07-11T00:21:00.734Z,1562804460.734 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-11T00:21:00.735Z,1562804460.735 [controlThread](DEBUG): Uninitializing ControlThread 2019-07-11T00:21:00.735Z,1562804460.735 [AHRS_M2](INFO): Powering down 2019-07-11T00:21:00.807Z,1562804460.807 [DUSBL_Hydroid](INFO): Powering down 2019-07-11T00:21:00.879Z,1562804460.879 [Micromodem](INFO): Powering down 2019-07-11T00:21:00.975Z,1562804460.975 [NAL9602](INFO): Powering down 2019-07-11T00:21:01.046Z,1562804461.046 [RDI_Pathfinder](INFO): Powering down 2019-07-11T00:21:01.048Z,1562804461.048 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-07-11T00:21:01.049Z,1562804461.049 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-07-11T00:21:01.049Z,1562804461.049 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-07-11T00:21:01.049Z,1562804461.049 [MissionManager](INFO): Uninitializing Mission Default 2019-07-11T00:21:01.050Z,1562804461.050 [Default] Stopped 2019-07-11T00:21:01.050Z,1562804461.050 [Default](DEBUG): Aggregate::uninitialize Default 2019-07-11T00:21:01.050Z,1562804461.050 [Default:B.GoToSurface] Stopped 2019-07-11T00:21:01.050Z,1562804461.050 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-11T00:21:01.050Z,1562804461.050 [Default:CheckIn] Stopped 2019-07-11T00:21:01.050Z,1562804461.050 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-07-11T00:21:01.050Z,1562804461.050 [Default:CheckIn:C.Wait] Stopped 2019-07-11T00:21:01.050Z,1562804461.050 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-07-11T00:21:01.053Z,1562804461.053 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-07-11T00:21:01.053Z,1562804461.053 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-07-11T00:21:01.053Z,1562804461.053 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-07-11T00:21:01.053Z,1562804461.053 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-07-11T00:21:01.054Z,1562804461.054 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-07-11T00:21:01.054Z,1562804461.054 [BuoyancyServo](INFO): Powering down 2019-07-11T00:21:01.066Z,1562804461.066 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-07-11T00:21:01.067Z,1562804461.067 [ElevatorServo](INFO): Powering down 2019-07-11T00:21:01.067Z,1562804461.067 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-07-11T00:21:01.067Z,1562804461.067 [MassServo](INFO): Powering down 2019-07-11T00:21:01.068Z,1562804461.068 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-07-11T00:21:01.068Z,1562804461.068 [RudderServo](INFO): Powering down 2019-07-11T00:21:01.069Z,1562804461.069 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-07-11T00:21:01.069Z,1562804461.069 [ThrusterServo](INFO): Powering down 2019-07-11T00:21:01.070Z,1562804461.070 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-07-11T00:21:01.070Z,1562804461.070 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-07-11T00:21:01.071Z,1562804461.071 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-07-11T00:21:01.071Z,1562804461.071 [CBIT](DEBUG): Powering off loads. 2019-07-11T00:21:01.082Z,1562804461.082 [CBIT](DEBUG): Disabling WDT. 2019-07-11T00:21:01.094Z,1562804461.094 [CBIT](DEBUG): Opening all GF detection circuits. 2019-07-11T00:21:01.095Z,1562804461.095 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:01.154Z,1562804461.154 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:01.163Z,1562804461.163 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:01.212Z,1562804461.212 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:01.215Z,1562804461.215 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:01.289Z,1562804461.289 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-11T00:21:01.361Z,1562804461.361 [logger ThreadHandler](INFO): Thread cancelled.