2019-03-08T21:28:51.976Z,1552080531.976 [Supervisor](DEBUG): Initializing supervisor.
2019-03-08T21:28:51.980Z,1552080531.980 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-03-08T21:28:51.980Z,1552080531.980 [SyncHandler](INFO): Protected caller Thread ID is 6305
2019-03-08T21:28:51.981Z,1552080531.981 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-03-08T21:28:51.982Z,1552080531.982 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-03-08T21:28:51.982Z,1552080531.982 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6306
2019-03-08T21:28:51.986Z,1552080531.986 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-03-08T21:28:51.998Z,1552080531.998 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-03-08T21:28:51.999Z,1552080531.999 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-03-08T21:28:51.999Z,1552080531.999 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6307
2019-03-08T21:28:52.000Z,1552080532.000 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-03-08T21:28:52.001Z,1552080532.001 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-03-08T21:28:52.001Z,1552080532.001 [logger ThreadHandler](INFO): Protected caller Thread ID is 6308
2019-03-08T21:28:52.003Z,1552080532.003 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-03-08T21:28:52.004Z,1552080532.004 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-03-08T21:28:52.006Z,1552080532.006 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-03-08T21:28:52.448Z,1552080532.448 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-03-08T21:28:52.449Z,1552080532.449 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-03-08T21:28:52.559Z,1552080532.559 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-03-08T21:28:52.560Z,1552080532.560 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-03-08T21:28:52.979Z,1552080532.979 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-03-08T21:28:52.980Z,1552080532.980 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-03-08T21:28:53.127Z,1552080533.127 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-03-08T21:28:53.128Z,1552080533.128 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-03-08T21:28:53.327Z,1552080533.327 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-03-08T21:28:53.328Z,1552080533.328 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-03-08T21:28:53.807Z,1552080533.807 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-03-08T21:28:53.808Z,1552080533.808 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-03-08T21:28:54.027Z,1552080534.027 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-03-08T21:28:54.028Z,1552080534.028 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-03-08T21:28:54.178Z,1552080534.178 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-03-08T21:28:54.179Z,1552080534.179 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-03-08T21:28:54.385Z,1552080534.385 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-03-08T21:28:54.386Z,1552080534.386 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-03-08T21:28:54.482Z,1552080534.482 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-03-08T21:28:54.483Z,1552080534.483 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-03-08T21:28:54.807Z,1552080534.807 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-03-08T21:28:54.807Z,1552080534.807 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-03-08T21:28:54.887Z,1552080534.887 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-03-08T21:28:54.991Z,1552080534.991 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-03-08T21:28:54.992Z,1552080534.992 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-03-08T21:28:55.510Z,1552080535.510 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-03-08T21:28:55.510Z,1552080535.510 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-03-08T21:28:55.919Z,1552080535.919 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-03-08T21:28:55.921Z,1552080535.921 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2019-03-08T21:28:55.922Z,1552080535.922 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2019-03-08T21:28:56.141Z,1552080536.141 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2019-03-08T21:28:56.243Z,1552080536.243 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2019-03-08T21:28:56.343Z,1552080536.343 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2019-03-08T21:28:56.575Z,1552080536.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-03-08T21:28:56.575Z,1552080536.575 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2019-03-08T21:28:56.661Z,1552080536.661 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2019-03-08T21:28:56.756Z,1552080536.756 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2019-03-08T21:28:56.855Z,1552080536.855 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2019-03-08T21:28:56.937Z,1552080536.937 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2019-03-08T21:28:57.048Z,1552080537.048 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2019-03-08T21:28:57.230Z,1552080537.230 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2019-03-08T21:28:57.367Z,1552080537.367 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2019-03-08T21:28:57.367Z,1552080537.367 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-03-08T21:28:57.372Z,1552080537.372 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-03-08T21:28:57.739Z,1552080537.739 [DataOverHttps] Loaded
2019-03-08T21:28:57.739Z,1552080537.739 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-03-08T21:28:57.741Z,1552080537.741 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4074D4E0
2019-03-08T21:28:57.741Z,1552080537.741 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6387
2019-03-08T21:28:57.781Z,1552080537.781 [Depth_Keller] Loaded
2019-03-08T21:28:57.781Z,1552080537.781 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-03-08T21:28:57.786Z,1552080537.786 [DropWeight] Loaded
2019-03-08T21:28:57.786Z,1552080537.786 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-03-08T21:28:57.836Z,1552080537.836 [DUSBL_Hydroid] Loaded
2019-03-08T21:28:57.837Z,1552080537.837 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2019-03-08T21:28:57.878Z,1552080537.878 [Micromodem] Loaded
2019-03-08T21:28:57.879Z,1552080537.879 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2019-03-08T21:28:58.116Z,1552080538.116 [NAL9602] Loaded
2019-03-08T21:28:58.116Z,1552080538.116 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-03-08T21:28:58.154Z,1552080538.154 [Onboard] Loaded
2019-03-08T21:28:58.155Z,1552080538.155 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-03-08T21:28:58.162Z,1552080538.162 [Radio_Surface] Loaded
2019-03-08T21:28:58.162Z,1552080538.162 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-03-08T21:28:58.185Z,1552080538.185 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4077D4E0
2019-03-08T21:28:58.185Z,1552080538.185 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6388
2019-03-08T21:28:58.460Z,1552080538.460 [RDI_Pathfinder] Loaded
2019-03-08T21:28:58.460Z,1552080538.460 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2019-03-08T21:28:58.634Z,1552080538.634 [RDI_PathfinderUp] Loaded
2019-03-08T21:28:58.634Z,1552080538.634 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2019-03-08T21:29:00.543Z,1552080540.543 [BPC1] Loaded
2019-03-08T21:29:00.543Z,1552080540.543 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-03-08T21:29:00.543Z,1552080540.543 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-03-08T21:29:00.544Z,1552080540.544 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-03-08T21:29:00.557Z,1552080540.557 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-03-08T21:29:00.557Z,1552080540.557 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-03-08T21:29:00.665Z,1552080540.665 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-03-08T21:29:00.666Z,1552080540.666 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-03-08T21:29:00.725Z,1552080540.725 [DeadReckonUsingSpeedCalculator] Loaded
2019-03-08T21:29:00.725Z,1552080540.725 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-03-08T21:29:00.785Z,1552080540.785 [DeadReckonWithRespectToSeafloor] Loaded
2019-03-08T21:29:00.785Z,1552080540.785 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-03-08T21:29:00.806Z,1552080540.806 [NavChart] Loaded
2019-03-08T21:29:00.806Z,1552080540.806 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-03-08T21:29:00.811Z,1552080540.811 [UniversalFixResidualReporter] Loaded
2019-03-08T21:29:00.811Z,1552080540.811 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-03-08T21:29:00.811Z,1552080540.811 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-03-08T21:29:00.812Z,1552080540.812 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-03-08T21:29:00.913Z,1552080540.913 [BuoyancyServo] Loaded
2019-03-08T21:29:00.914Z,1552080540.914 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-03-08T21:29:00.929Z,1552080540.929 [ElevatorServo] Loaded
2019-03-08T21:29:00.930Z,1552080540.930 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-03-08T21:29:00.945Z,1552080540.945 [MassServo] Loaded
2019-03-08T21:29:00.945Z,1552080540.945 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-03-08T21:29:00.960Z,1552080540.960 [RudderServo] Loaded
2019-03-08T21:29:00.961Z,1552080540.961 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-03-08T21:29:00.976Z,1552080540.976 [ThrusterServo] Loaded
2019-03-08T21:29:00.976Z,1552080540.976 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-03-08T21:29:00.976Z,1552080540.976 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-03-08T21:29:00.977Z,1552080540.977 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-03-08T21:29:01.156Z,1552080541.156 [Aanderaa_O2] Loaded
2019-03-08T21:29:01.156Z,1552080541.156 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-03-08T21:29:01.243Z,1552080541.243 [CTD_NeilBrown] Loaded
2019-03-08T21:29:01.243Z,1552080541.243 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-03-08T21:29:01.244Z,1552080541.244 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408C24E0
2019-03-08T21:29:01.244Z,1552080541.244 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 6389
2019-03-08T21:29:01.290Z,1552080541.290 [WetLabsSeaOWL_UV_A] Loaded
2019-03-08T21:29:01.290Z,1552080541.290 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2019-03-08T21:29:01.291Z,1552080541.291 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408F24E0
2019-03-08T21:29:01.291Z,1552080541.291 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 6390
2019-03-08T21:29:01.292Z,1552080541.292 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-03-08T21:29:01.293Z,1552080541.293 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-03-08T21:29:01.529Z,1552080541.529 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-03-08T21:29:01.529Z,1552080541.529 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-03-08T21:29:01.570Z,1552080541.570 [DepthRateCalculator] Loaded
2019-03-08T21:29:01.570Z,1552080541.570 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-03-08T21:29:01.576Z,1552080541.576 [PitchRateCalculator] Loaded
2019-03-08T21:29:01.576Z,1552080541.576 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-03-08T21:29:01.589Z,1552080541.589 [SpeedCalculator] Loaded
2019-03-08T21:29:01.589Z,1552080541.589 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-03-08T21:29:01.611Z,1552080541.611 [TempGradientCalculator] Loaded
2019-03-08T21:29:01.611Z,1552080541.611 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-03-08T21:29:01.617Z,1552080541.617 [YawRateCalculator] Loaded
2019-03-08T21:29:01.617Z,1552080541.617 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-03-08T21:29:01.659Z,1552080541.659 [ElevatorOffsetCalculator] Loaded
2019-03-08T21:29:01.659Z,1552080541.659 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-03-08T21:29:01.660Z,1552080541.660 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-03-08T21:29:01.660Z,1552080541.660 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-03-08T21:29:01.793Z,1552080541.793 [SBIT](DEBUG): Construct Startup Built In Test.
2019-03-08T21:29:01.816Z,1552080541.816 [SBIT] Loaded
2019-03-08T21:29:01.817Z,1552080541.817 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-03-08T21:29:01.818Z,1552080541.818 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-03-08T21:29:01.830Z,1552080541.830 [IBIT] Loaded
2019-03-08T21:29:01.830Z,1552080541.830 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-03-08T21:29:01.833Z,1552080541.833 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-03-08T21:29:01.975Z,1552080541.975 [CBIT] Loaded
2019-03-08T21:29:01.975Z,1552080541.975 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-03-08T21:29:01.976Z,1552080541.976 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-03-08T21:29:01.976Z,1552080541.976 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-03-08T21:29:02.038Z,1552080542.038 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-03-08T21:29:02.039Z,1552080542.039 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-03-08T21:29:02.136Z,1552080542.136 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-03-08T21:29:02.137Z,1552080542.137 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-03-08T21:29:02.202Z,1552080542.202 [VerticalControl](DEBUG): Construct VerticalControl.
2019-03-08T21:29:02.289Z,1552080542.289 [VerticalControl] Loaded
2019-03-08T21:29:02.289Z,1552080542.289 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-03-08T21:29:02.290Z,1552080542.290 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-03-08T21:29:02.348Z,1552080542.348 [HorizontalControl] Loaded
2019-03-08T21:29:02.349Z,1552080542.349 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-03-08T21:29:02.349Z,1552080542.349 [SpeedControl](DEBUG): Construct SpeedControl.
2019-03-08T21:29:02.351Z,1552080542.351 [SpeedControl] Loaded
2019-03-08T21:29:02.351Z,1552080542.351 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-03-08T21:29:02.352Z,1552080542.352 [LoopControl](DEBUG): Construct LoopControl.
2019-03-08T21:29:02.353Z,1552080542.353 [LoopControl] Loaded
2019-03-08T21:29:02.353Z,1552080542.353 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-03-08T21:29:02.353Z,1552080542.353 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-03-08T21:29:02.354Z,1552080542.354 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-03-08T21:29:02.382Z,1552080542.382 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-03-08T21:29:02.385Z,1552080542.385 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-03-08T21:29:02.386Z,1552080542.386 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-03-08T21:29:02.393Z,1552080542.393 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-03-08T21:29:02.394Z,1552080542.394 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AB04E0
2019-03-08T21:29:02.395Z,1552080542.395 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6391
2019-03-08T21:29:02.399Z,1552080542.399 [Supervisor](INFO): Main Thread ID is 5883
2019-03-08T21:29:02.400Z,1552080542.400 [Supervisor](DEBUG): Running supervisor.
2019-03-08T21:29:02.400Z,1552080542.400 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6392
2019-03-08T21:29:02.403Z,1552080542.403 [controlThread ThreadHandler](INFO): Handler Thread ID is 6393
2019-03-08T21:29:02.403Z,1552080542.403 [controlThread](DEBUG): Initializing ControlThread
2019-03-08T21:29:02.408Z,1552080542.408 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-08T21:29:02.409Z,1552080542.409 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-03-08T21:29:02.409Z,1552080542.409 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-03-08T21:29:02.410Z,1552080542.410 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-03-08T21:29:02.411Z,1552080542.411 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-03-08T21:29:02.411Z,1552080542.411 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-03-08T21:29:02.411Z,1552080542.411 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-03-08T21:29:02.412Z,1552080542.412 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-03-08T21:29:02.412Z,1552080542.412 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-03-08T21:29:02.413Z,1552080542.413 [SBIT](INFO): Initialize SBIT Component.
2019-03-08T21:29:02.414Z,1552080542.414 [SBIT](IMPORTANT): git: 2019-03-04-36-g743def3
2019-03-08T21:29:02.414Z,1552080542.414 [SBIT](INFO): git hash: 743def31acf12ef8e20e672f0fefb031590b97fa
2019-03-08T21:29:02.414Z,1552080542.414 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-03-08T21:29:02.414Z,1552080542.414 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2019-03-08T21:29:02.415Z,1552080542.415 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-03-08T21:29:02.416Z,1552080542.416 [IBIT](INFO): Initialize IBIT Component.
2019-03-08T21:29:02.417Z,1552080542.417 [CBIT](DEBUG): Initialize CBIT Component.
2019-03-08T21:29:02.418Z,1552080542.418 [logger ThreadHandler](INFO): Handler Thread ID is 6394
2019-03-08T21:29:02.429Z,1552080542.429 [CBIT](DEBUG): Initialized mux pins.
2019-03-08T21:29:02.429Z,1552080542.429 [CBIT](DEBUG): Initializing the watchdog timer.
2019-03-08T21:29:02.437Z,1552080542.437 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6395
2019-03-08T21:29:02.438Z,1552080542.438 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-03-08T21:29:02.449Z,1552080542.449 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6396
2019-03-08T21:29:02.453Z,1552080542.453 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-03-08T21:29:02.453Z,1552080542.453 [CBIT](DEBUG): Initializing heartbeat.
2019-03-08T21:29:02.461Z,1552080542.461 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 6397
2019-03-08T21:29:02.462Z,1552080542.462 [CTD_NeilBrown](INFO): Powering down
2019-03-08T21:29:02.489Z,1552080542.489 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 6398
2019-03-08T21:29:02.490Z,1552080542.490 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-03-08T21:29:02.525Z,1552080542.525 [CBIT](DEBUG): Deactivating GF circuits.
2019-03-08T21:29:02.525Z,1552080542.525 [CBIT](DEBUG): Deactivating emergency mode.
2019-03-08T21:29:02.526Z,1552080542.526 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6399
2019-03-08T21:29:02.529Z,1552080542.529 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-03-08T21:29:02.529Z,1552080542.529 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-03-08T21:29:02.529Z,1552080542.529 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-03-08T21:29:02.530Z,1552080542.530 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-03-08T21:29:02.530Z,1552080542.530 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-03-08T21:29:02.530Z,1552080542.530 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-03-08T21:29:02.530Z,1552080542.530 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-03-08T21:29:02.530Z,1552080542.530 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-03-08T21:29:02.530Z,1552080542.530 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-03-08T21:29:02.531Z,1552080542.531 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-03-08T21:29:02.531Z,1552080542.531 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-03-08T21:29:02.531Z,1552080542.531 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-03-08T21:29:02.531Z,1552080542.531 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-03-08T21:29:02.531Z,1552080542.531 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-03-08T21:29:02.531Z,1552080542.531 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-03-08T21:29:02.532Z,1552080542.532 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-03-08T21:29:02.561Z,1552080542.561 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-03-08T21:29:02.563Z,1552080542.563 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-03-08T21:29:02.563Z,1552080542.563 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-03-08T21:29:02.564Z,1552080542.564 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-03-08T21:29:02.565Z,1552080542.565 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-03-08T21:29:02.575Z,1552080542.575 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-08T21:29:02.609Z,1552080542.609 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2019-03-08T21:29:02.610Z,1552080542.610 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-03-08T21:29:02.681Z,1552080542.681 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-03-08T21:29:02.682Z,1552080542.682 [Default:A.Wait](DEBUG): Construct Wait.
2019-03-08T21:29:02.684Z,1552080542.684 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-08T21:29:02.706Z,1552080542.706 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-03-08T21:29:02.738Z,1552080542.738 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-03-08T21:29:02.757Z,1552080542.757 [Default:E.Execute](DEBUG): Construct Execute.
2019-03-08T21:29:02.760Z,1552080542.760 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2019-03-08T21:29:02.781Z,1552080542.781 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,RDI_Pathfinder,RDI_PathfinderUp,BPC1,Aanderaa_O2,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-03-08T21:29:02.825Z,1552080542.825 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2019-03-08T21:29:02.833Z,1552080542.833 [DUSBL_Hydroid](INFO): Powering up
2019-03-08T21:29:02.834Z,1552080542.834 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-03-08T21:29:02.853Z,1552080542.853 [Radio_Surface](INFO): Powering up
2019-03-08T21:29:02.862Z,1552080542.862 [Micromodem](INFO): Start
2019-03-08T21:29:02.933Z,1552080542.933 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-08T21:29:02.970Z,1552080542.970 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-08T21:29:02.977Z,1552080542.977 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-08T21:29:02.978Z,1552080542.978 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-08T21:29:02.985Z,1552080542.985 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-08T21:29:02.986Z,1552080542.986 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-08T21:29:02.993Z,1552080542.993 [MassServo](DEBUG): Initializing MassServo.
2019-03-08T21:29:02.994Z,1552080542.994 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-08T21:29:03.001Z,1552080543.001 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-08T21:29:03.002Z,1552080543.002 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-03-08T21:29:03.009Z,1552080543.009 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-03-08T21:29:03.206Z,1552080543.206 [Micromodem](INFO): Starting
2019-03-08T21:29:03.207Z,1552080543.207 [Micromodem](INFO): Powering up
2019-03-08T21:29:03.207Z,1552080543.207 [Micromodem](DEBUG): Initializing Micromodem.
2019-03-08T21:29:03.305Z,1552080543.305 [RDI_PathfinderUp](INFO): Powering down
2019-03-08T21:29:03.365Z,1552080543.365 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-08T21:29:03.683Z,1552080543.683 [Micromodem](INFO): Starting
2019-03-08T21:29:04.003Z,1552080544.003 [Micromodem](INFO): Starting
2019-03-08T21:29:04.406Z,1552080544.406 [Micromodem](INFO): Starting
2019-03-08T21:29:04.810Z,1552080544.810 [Micromodem](INFO): Starting
2019-03-08T21:29:05.214Z,1552080545.214 [Micromodem](INFO): Starting
2019-03-08T21:29:05.618Z,1552080545.618 [Micromodem](INFO): Starting
2019-03-08T21:29:06.022Z,1552080546.022 [Micromodem](INFO): Starting
2019-03-08T21:29:06.157Z,1552080546.157 [Aanderaa_O2](INFO): Powering down
2019-03-08T21:29:06.426Z,1552080546.426 [Micromodem](INFO): Starting
2019-03-08T21:29:06.830Z,1552080546.830 [Micromodem](INFO): Starting
2019-03-08T21:29:07.234Z,1552080547.234 [Micromodem](INFO): Starting
2019-03-08T21:29:07.638Z,1552080547.638 [Micromodem](INFO): Starting
2019-03-08T21:29:08.042Z,1552080548.042 [Micromodem](INFO): Starting
2019-03-08T21:29:08.043Z,1552080548.043 [Micromodem](INFO): Starting
2019-03-08T21:29:08.044Z,1552080548.044 [Micromodem](DEBUG): Nmea buf: $CCCFG,CST,1*37

2019-03-08T21:29:08.045Z,1552080548.045 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,CST,1*37

2019-03-08T21:29:08.045Z,1552080548.045 [Micromodem](INFO): Nmea out: $CCCFG,CST,1*37

2019-03-08T21:29:08.046Z,1552080548.046 [Micromodem](DEBUG): Nmea buf: $CCCFG,SRC,1*31

2019-03-08T21:29:08.047Z,1552080548.047 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,SRC,1*31

2019-03-08T21:29:08.048Z,1552080548.048 [Micromodem](DEBUG): Nmea buf: $CCCFG,REV,1*32

2019-03-08T21:29:08.050Z,1552080548.050 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,REV,1*32

2019-03-08T21:29:08.051Z,1552080548.051 [Micromodem](DEBUG): Nmea buf: $CCCFG,RXP,1*29

2019-03-08T21:29:08.051Z,1552080548.051 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,RXP,1*29

2019-03-08T21:29:08.446Z,1552080548.446 [Micromodem](INFO): Starting
2019-03-08T21:29:08.851Z,1552080548.851 [Micromodem](INFO): Starting
2019-03-08T21:29:09.254Z,1552080549.254 [Micromodem](INFO): Starting
2019-03-08T21:29:09.658Z,1552080549.658 [Micromodem](INFO): Starting
2019-03-08T21:29:10.063Z,1552080550.063 [Micromodem](INFO): Starting
2019-03-08T21:29:10.466Z,1552080550.466 [Micromodem](INFO): Starting
2019-03-08T21:29:10.870Z,1552080550.870 [Micromodem](INFO): Starting
2019-03-08T21:29:11.274Z,1552080551.274 [Micromodem](INFO): Starting
2019-03-08T21:29:11.678Z,1552080551.678 [Micromodem](INFO): Starting
2019-03-08T21:29:12.082Z,1552080552.082 [Micromodem](INFO): Starting
2019-03-08T21:29:12.486Z,1552080552.486 [Micromodem](INFO): Starting
2019-03-08T21:29:12.890Z,1552080552.890 [Micromodem](INFO): Starting
2019-03-08T21:29:13.294Z,1552080553.294 [Micromodem](INFO): Starting
2019-03-08T21:29:13.698Z,1552080553.698 [Micromodem](INFO): Starting
2019-03-08T21:29:14.103Z,1552080554.103 [Micromodem](INFO): Starting
2019-03-08T21:29:14.506Z,1552080554.506 [Micromodem](INFO): Starting
2019-03-08T21:29:14.910Z,1552080554.910 [Micromodem](INFO): Starting
2019-03-08T21:29:15.314Z,1552080555.314 [Micromodem](INFO): Starting
2019-03-08T21:29:15.718Z,1552080555.718 [Micromodem](INFO): Starting
2019-03-08T21:29:16.122Z,1552080556.122 [Micromodem](INFO): Starting
2019-03-08T21:29:16.148Z,1552080556.148 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2019-03-08T21:29:16.526Z,1552080556.526 [Micromodem](INFO): Starting
2019-03-08T21:29:16.937Z,1552080556.937 [Micromodem](INFO): Starting
2019-03-08T21:29:17.334Z,1552080557.334 [Micromodem](INFO): Starting
2019-03-08T21:29:17.335Z,1552080557.335 [Micromodem](IMPORTANT): CACFG stsring$CACFG,CST,1*35

2019-03-08T21:29:17.335Z,1552080557.335 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2019-03-08T21:29:17.739Z,1552080557.739 [Micromodem](INFO): Starting
2019-03-08T21:29:18.142Z,1552080558.142 [Micromodem](INFO): Starting
2019-03-08T21:29:18.546Z,1552080558.546 [Micromodem](INFO): Starting
2019-03-08T21:29:18.953Z,1552080558.953 [Micromodem](INFO): Starting
2019-03-08T21:29:19.354Z,1552080559.354 [Micromodem](INFO): Starting
2019-03-08T21:29:19.758Z,1552080559.758 [Micromodem](INFO): Starting
2019-03-08T21:29:20.163Z,1552080560.163 [Micromodem](INFO): Starting
2019-03-08T21:29:20.566Z,1552080560.566 [Micromodem](INFO): Starting
2019-03-08T21:29:20.970Z,1552080560.970 [DUSBL_Hydroid](INFO): DUSBL Version:O
2019-03-08T21:29:20.986Z,1552080560.986 [Micromodem](INFO): Starting
2019-03-08T21:29:21.374Z,1552080561.374 [Micromodem](INFO): Starting
2019-03-08T21:29:21.778Z,1552080561.778 [Micromodem](INFO): Starting
2019-03-08T21:29:22.182Z,1552080562.182 [Micromodem](INFO): Starting
2019-03-08T21:29:22.586Z,1552080562.586 [Micromodem](INFO): Starting
2019-03-08T21:29:22.994Z,1552080562.994 [Micromodem](INFO): Starting
2019-03-08T21:29:23.394Z,1552080563.394 [Micromodem](INFO): Starting
2019-03-08T21:29:23.798Z,1552080563.798 [Micromodem](INFO): Starting
2019-03-08T21:29:24.202Z,1552080564.202 [Micromodem](INFO): Starting
2019-03-08T21:29:24.606Z,1552080564.606 [Micromodem](INFO): Starting
2019-03-08T21:29:25.021Z,1552080565.021 [Micromodem](INFO): Starting
2019-03-08T21:29:25.414Z,1552080565.414 [Micromodem](INFO): Starting
2019-03-08T21:29:25.818Z,1552080565.818 [Micromodem](INFO): Starting
2019-03-08T21:29:26.222Z,1552080566.222 [Micromodem](INFO): Starting
2019-03-08T21:29:26.626Z,1552080566.626 [Micromodem](INFO): Starting
2019-03-08T21:29:27.042Z,1552080567.042 [Micromodem](INFO): Starting
2019-03-08T21:29:27.434Z,1552080567.434 [Micromodem](INFO): Starting
2019-03-08T21:29:27.435Z,1552080567.435 [Micromodem](IMPORTANT): CACFG stsring$CACFG,SRC,1*33

2019-03-08T21:29:27.435Z,1552080567.435 [Micromodem](INFO): Nmea out: $CCCFG,REV,1*32

2019-03-08T21:29:27.838Z,1552080567.838 [Micromodem](INFO): Starting
2019-03-08T21:29:28.242Z,1552080568.242 [Micromodem](INFO): Starting
2019-03-08T21:29:28.244Z,1552080568.244 [NAL9602](INFO): Powering up NAL9602
2019-03-08T21:29:28.646Z,1552080568.646 [Micromodem](INFO): Starting
2019-03-08T21:29:29.050Z,1552080569.050 [Micromodem](INFO): Starting
2019-03-08T21:29:29.454Z,1552080569.454 [Micromodem](INFO): Starting
2019-03-08T21:29:29.858Z,1552080569.858 [Micromodem](INFO): Starting
2019-03-08T21:29:30.260Z,1552080570.260 [Micromodem](INFO): Starting
2019-03-08T21:29:30.666Z,1552080570.666 [Micromodem](INFO): Starting
2019-03-08T21:29:31.070Z,1552080571.070 [Micromodem](INFO): Starting
2019-03-08T21:29:31.133Z,1552080571.133 [SBIT](IMPORTANT): Beginning Startup BIT
2019-03-08T21:29:31.141Z,1552080571.141 [CBIT](IMPORTANT): Beginning ground fault scan
2019-03-08T21:29:31.474Z,1552080571.474 [Micromodem](INFO): Starting
2019-03-08T21:29:31.878Z,1552080571.878 [Micromodem](INFO): Starting
2019-03-08T21:29:32.282Z,1552080572.282 [Micromodem](INFO): Starting
2019-03-08T21:29:32.683Z,1552080572.683 [Micromodem](INFO): Starting
2019-03-08T21:29:33.090Z,1552080573.090 [Micromodem](INFO): Starting
2019-03-08T21:29:33.494Z,1552080573.494 [Micromodem](INFO): Starting
2019-03-08T21:29:34.088Z,1552080574.088 [Micromodem](INFO): Starting
2019-03-08T21:29:34.490Z,1552080574.490 [Micromodem](INFO): Starting
2019-03-08T21:29:34.894Z,1552080574.894 [Micromodem](INFO): Starting
2019-03-08T21:29:35.298Z,1552080575.298 [Micromodem](INFO): Starting
2019-03-08T21:29:35.702Z,1552080575.702 [Micromodem](INFO): Starting
2019-03-08T21:29:36.106Z,1552080576.106 [Micromodem](INFO): Starting
2019-03-08T21:29:36.510Z,1552080576.510 [Micromodem](INFO): Starting
2019-03-08T21:29:36.916Z,1552080576.916 [Micromodem](INFO): Starting
2019-03-08T21:29:37.318Z,1552080577.318 [Micromodem](INFO): Starting
2019-03-08T21:29:37.319Z,1552080577.319 [Micromodem](IMPORTANT): CACFG stsring$CACFG,REV,1*30

2019-03-08T21:29:37.319Z,1552080577.319 [Micromodem](INFO): Nmea out: $CCCFG,RXP,1*29

2019-03-08T21:29:37.722Z,1552080577.722 [Micromodem](INFO): Starting
2019-03-08T21:29:38.126Z,1552080578.126 [Micromodem](INFO): Starting
2019-03-08T21:29:38.530Z,1552080578.530 [Micromodem](INFO): Starting
2019-03-08T21:29:38.934Z,1552080578.934 [Micromodem](INFO): Starting
2019-03-08T21:29:39.338Z,1552080579.338 [Micromodem](INFO): Starting
2019-03-08T21:29:39.339Z,1552080579.339 [NAL9602](INFO): NAL9602 initialized
2019-03-08T21:29:39.742Z,1552080579.742 [Micromodem](INFO): Starting
2019-03-08T21:29:40.146Z,1552080580.146 [Micromodem](INFO): Starting
2019-03-08T21:29:40.161Z,1552080580.161 [NAL9602](DEBUG): Fix Requested
2019-03-08T21:29:40.550Z,1552080580.550 [Micromodem](INFO): Starting
2019-03-08T21:29:40.954Z,1552080580.954 [Micromodem](INFO): Starting
2019-03-08T21:29:41.358Z,1552080581.358 [Micromodem](INFO): Starting
2019-03-08T21:29:41.762Z,1552080581.762 [Micromodem](INFO): Starting
2019-03-08T21:29:41.846Z,1552080581.846 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.011907
CHAN A1 (24V): -0.026027
CHAN A2 (12V): -0.006794
CHAN A3 (5V): -0.001110
CHAN B0 (3.3V): -0.000640
CHAN B1 (3.15aV): -0.000111
CHAN B2 (3.15bV): -0.000334
CHAN B3 (GND): 0.000977
OPEN: 0.009163
Full Scale Calc: 4.765 mA, -1.589 mA
2019-03-08T21:29:42.166Z,1552080582.166 [Micromodem](INFO): Starting
2019-03-08T21:29:42.570Z,1552080582.570 [Micromodem](INFO): Starting
2019-03-08T21:29:42.974Z,1552080582.974 [Micromodem](INFO): Starting
2019-03-08T21:29:43.378Z,1552080583.378 [Micromodem](INFO): Starting
2019-03-08T21:29:43.782Z,1552080583.782 [Micromodem](INFO): Starting
2019-03-08T21:29:44.186Z,1552080584.186 [Micromodem](INFO): Starting
2019-03-08T21:29:44.587Z,1552080584.587 [Micromodem](INFO): Starting
2019-03-08T21:29:44.994Z,1552080584.994 [Micromodem](INFO): Starting
2019-03-08T21:29:45.398Z,1552080585.398 [Micromodem](INFO): Starting
2019-03-08T21:29:45.802Z,1552080585.802 [Micromodem](INFO): Starting
2019-03-08T21:29:46.206Z,1552080586.206 [Micromodem](INFO): Starting
2019-03-08T21:29:46.610Z,1552080586.610 [Micromodem](INFO): Starting
2019-03-08T21:29:47.084Z,1552080587.084 [Micromodem](INFO): Starting
2019-03-08T21:29:47.089Z,1552080587.089 [Micromodem](IMPORTANT): CACFG stsring$CACFG,RXP,1*2B

2019-03-08T21:29:47.090Z,1552080587.090 [Micromodem](DEBUG): Nmea buf: $CCTMS,2019-03-08T21:29:48Z,0*71

2019-03-08T21:29:47.090Z,1552080587.090 [Micromodem](IMPORTANT): Nmea buf: $CCTMS,2019-03-08T21:29:48Z,0*71

2019-03-08T21:29:47.091Z,1552080587.091 [Micromodem](INFO): Nmea out: $CCTMS,2019-03-08T21:29:48Z,0*71

2019-03-08T21:29:47.494Z,1552080587.494 [Micromodem](INFO): Starting
2019-03-08T21:29:47.890Z,1552080587.890 [Micromodem](INFO): Starting
2019-03-08T21:29:48.294Z,1552080588.294 [Micromodem](INFO): Starting
2019-03-08T21:29:48.698Z,1552080588.698 [Micromodem](INFO): Starting
2019-03-08T21:29:49.102Z,1552080589.102 [Micromodem](INFO): Starting
2019-03-08T21:30:16.664Z,1552080616.664 [Micromodem](FAULT): LCB 2 fault: 
2019-03-08T21:30:16.664Z,1552080616.664 [Micromodem] Hardware Fault, FailCount= 1
2019-03-08T21:30:16.664Z,1552080616.664 [Micromodem](ERROR): Hardware Fault
2019-03-08T21:30:16.664Z,1552080616.664 [Micromodem](INFO): Stop
2019-03-08T21:30:16.664Z,1552080616.664 [Micromodem](INFO): uninitialize
2019-03-08T21:30:16.664Z,1552080616.664 [Micromodem](INFO): Powering down
2019-03-08T21:30:16.878Z,1552080616.878 [CBIT](ERROR): Hardware Fault in component: Micromodem
2019-03-08T21:30:17.062Z,1552080617.062 [Micromodem](INFO): Stop
2019-03-08T21:30:17.062Z,1552080617.062 [Micromodem](INFO): uninitialize
2019-03-08T21:30:17.062Z,1552080617.062 [Micromodem](INFO): Powering down
2019-03-08T21:30:17.462Z,1552080617.462 [Micromodem](INFO): Stopping
2019-03-08T21:30:17.462Z,1552080617.462 [Micromodem](FAULT): LCB 2 fault:  Software Overcurrent.
2019-03-08T21:30:17.866Z,1552080617.866 [Micromodem](INFO): Stopped
2019-03-08T21:30:17.954Z,1552080617.954 [CBIT](INFO): Clearing failed state for component Micromodem
2019-03-08T21:30:17.954Z,1552080617.954 [Micromodem] No Fault, FailCount= 1
2019-03-08T21:30:18.274Z,1552080618.274 [Micromodem](INFO): Start
2019-03-08T21:30:18.678Z,1552080618.678 [Micromodem](INFO): Start
2019-03-08T21:30:19.082Z,1552080619.082 [Micromodem](INFO): Start
2019-03-08T21:30:19.486Z,1552080619.486 [Micromodem](INFO): Start
2019-03-08T21:30:19.888Z,1552080619.888 [Micromodem](INFO): Start
2019-03-08T21:30:20.294Z,1552080620.294 [Micromodem](INFO): Start
2019-03-08T21:30:20.698Z,1552080620.698 [Micromodem](INFO): Starting
2019-03-08T21:30:20.698Z,1552080620.698 [Micromodem](INFO): Powering up
2019-03-08T21:30:20.699Z,1552080620.699 [Micromodem](DEBUG): Initializing Micromodem.
2019-03-08T21:30:21.102Z,1552080621.102 [Micromodem](INFO): Starting
2019-03-08T21:30:21.506Z,1552080621.506 [Micromodem](INFO): Starting
2019-03-08T21:30:21.906Z,1552080621.906 [Micromodem](INFO): Starting
2019-03-08T21:30:22.314Z,1552080622.314 [Micromodem](INFO): Starting
2019-03-08T21:30:22.714Z,1552080622.714 [Micromodem](INFO): Starting
2019-03-08T21:30:23.122Z,1552080623.122 [Micromodem](INFO): Starting
2019-03-08T21:30:23.519Z,1552080623.519 [Micromodem](INFO): Starting
2019-03-08T21:30:23.927Z,1552080623.927 [Micromodem](INFO): Starting
2019-03-08T21:30:24.335Z,1552080624.335 [Micromodem](INFO): Starting
2019-03-08T21:30:24.738Z,1552080624.738 [Micromodem](INFO): Starting
2019-03-08T21:30:24.766Z,1552080624.766 [SBIT](IMPORTANT): SBIT PASSED
2019-03-08T21:30:24.818Z,1552080624.818 [CommandLine](IMPORTANT): got command configSet list
2019-03-08T21:30:24.818Z,1552080624.818 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-03-08T21:30:24.819Z,1552080624.819 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2019-03-08T21:30:24.819Z,1552080624.819 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold=9 count;

2019-03-08T21:30:24.819Z,1552080624.819 [CommandLine](IMPORTANT): DUSBL_Hydroid.verbosity=1 enum;

2019-03-08T21:30:25.138Z,1552080625.138 [Micromodem](INFO): Starting
2019-03-08T21:30:25.174Z,1552080625.174 [MissionManager](IMPORTANT): Started mission Startup
2019-03-08T21:30:25.175Z,1552080625.175 [Startup] Running Loop=1
2019-03-08T21:30:25.175Z,1552080625.175 [Startup](DEBUG): Aggregate::initialize Startup
2019-03-08T21:30:25.175Z,1552080625.175 [Startup:A.GoToSurface] Running Loop=1
2019-03-08T21:30:25.175Z,1552080625.175 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-08T21:30:25.175Z,1552080625.175 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-08T21:30:25.176Z,1552080625.176 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-08T21:30:25.176Z,1552080625.176 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-08T21:30:25.177Z,1552080625.177 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-08T21:30:25.177Z,1552080625.177 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-08T21:30:25.179Z,1552080625.179 [Startup:StartupSatComms] Running Loop=1
2019-03-08T21:30:25.179Z,1552080625.179 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-03-08T21:30:25.179Z,1552080625.179 [Startup:StartupSatComms:A] Running Loop=1
2019-03-08T21:30:25.542Z,1552080625.542 [Micromodem](INFO): Starting
2019-03-08T21:30:25.542Z,1552080625.542 [Micromodem](INFO): Starting
2019-03-08T21:30:25.543Z,1552080625.543 [Micromodem](DEBUG): Nmea buf: $CCCFG,CST,1*37

2019-03-08T21:30:25.543Z,1552080625.543 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,CST,1*37

2019-03-08T21:30:25.543Z,1552080625.543 [Micromodem](INFO): Nmea out: $CCCFG,CST,1*37

2019-03-08T21:30:25.544Z,1552080625.544 [Micromodem](DEBUG): Nmea buf: $CCCFG,SRC,1*31

2019-03-08T21:30:25.545Z,1552080625.545 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,SRC,1*31

2019-03-08T21:30:25.546Z,1552080625.546 [Micromodem](DEBUG): Nmea buf: $CCCFG,REV,1*32

2019-03-08T21:30:25.547Z,1552080625.547 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,REV,1*32

2019-03-08T21:30:25.548Z,1552080625.548 [Micromodem](DEBUG): Nmea buf: $CCCFG,RXP,1*29

2019-03-08T21:30:25.549Z,1552080625.549 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,RXP,1*29

2019-03-08T21:30:25.586Z,1552080625.586 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-03-08T21:30:25.946Z,1552080625.946 [Micromodem](INFO): Starting
2019-03-08T21:30:26.350Z,1552080626.350 [Micromodem](INFO): Starting
2019-03-08T21:30:26.760Z,1552080626.760 [Micromodem](INFO): Starting
2019-03-08T21:30:27.155Z,1552080627.155 [Micromodem](INFO): Starting
2019-03-08T21:30:27.566Z,1552080627.566 [Micromodem](INFO): Starting
2019-03-08T21:30:27.970Z,1552080627.970 [Micromodem](INFO): Starting
2019-03-08T21:30:28.370Z,1552080628.370 [Micromodem](INFO): Starting
2019-03-08T21:30:28.774Z,1552080628.774 [Micromodem](INFO): Starting
2019-03-08T21:30:29.178Z,1552080629.178 [Micromodem](INFO): Starting
2019-03-08T21:30:29.582Z,1552080629.582 [Micromodem](INFO): Starting
2019-03-08T21:30:29.988Z,1552080629.988 [Micromodem](INFO): Starting
2019-03-08T21:30:30.390Z,1552080630.390 [Micromodem](INFO): Starting
2019-03-08T21:30:30.798Z,1552080630.798 [Micromodem](INFO): Starting
2019-03-08T21:30:31.202Z,1552080631.202 [Micromodem](INFO): Starting
2019-03-08T21:30:31.602Z,1552080631.602 [Micromodem](INFO): Starting
2019-03-08T21:30:32.017Z,1552080632.017 [Micromodem](INFO): Starting
2019-03-08T21:30:32.414Z,1552080632.414 [Micromodem](INFO): Starting
2019-03-08T21:30:32.814Z,1552080632.814 [Micromodem](INFO): Starting
2019-03-08T21:30:33.218Z,1552080633.218 [Micromodem](INFO): Starting
2019-03-08T21:30:33.628Z,1552080633.628 [Micromodem](INFO): Starting
2019-03-08T21:30:34.037Z,1552080634.037 [Micromodem](INFO): Starting
2019-03-08T21:30:34.434Z,1552080634.434 [Micromodem](INFO): Starting
2019-03-08T21:30:34.838Z,1552080634.838 [Micromodem](INFO): Starting
2019-03-08T21:30:35.238Z,1552080635.238 [Micromodem](INFO): Starting
2019-03-08T21:30:35.642Z,1552080635.642 [Micromodem](INFO): Starting
2019-03-08T21:30:36.050Z,1552080636.050 [Micromodem](INFO): Starting
2019-03-08T21:30:36.454Z,1552080636.454 [Micromodem](INFO): Starting
2019-03-08T21:30:36.852Z,1552080636.852 [Micromodem](INFO): Starting
2019-03-08T21:30:36.852Z,1552080636.852 [Micromodem](ERROR): Nmea resend: $CCCFG,CST,1*37

2019-03-08T21:30:37.258Z,1552080637.258 [Micromodem](INFO): Starting
2019-03-08T21:30:37.662Z,1552080637.662 [Micromodem](INFO): Starting
2019-03-08T21:30:38.070Z,1552080638.070 [Micromodem](INFO): Starting
2019-03-08T21:30:38.474Z,1552080638.474 [Micromodem](INFO): Starting
2019-03-08T21:30:38.874Z,1552080638.874 [Micromodem](INFO): Starting
2019-03-08T21:30:38.875Z,1552080638.875 [Micromodem](IMPORTANT): CACFG stsring$CACFG,CST,1*35

2019-03-08T21:30:38.875Z,1552080638.875 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2019-03-08T21:30:39.278Z,1552080639.278 [Micromodem](INFO): Starting
2019-03-08T21:30:39.682Z,1552080639.682 [Micromodem](INFO): Starting
2019-03-08T21:30:40.086Z,1552080640.086 [Micromodem](INFO): Starting
2019-03-08T21:30:40.487Z,1552080640.487 [Micromodem](INFO): Starting
2019-03-08T21:30:40.898Z,1552080640.898 [Micromodem](INFO): Starting
2019-03-08T21:30:41.299Z,1552080641.299 [Micromodem](INFO): Starting
2019-03-08T21:30:41.707Z,1552080641.707 [Micromodem](INFO): Starting
2019-03-08T21:30:42.110Z,1552080642.110 [Micromodem](INFO): Starting
2019-03-08T21:30:42.514Z,1552080642.514 [Micromodem](INFO): Starting
2019-03-08T21:30:42.911Z,1552080642.911 [Micromodem](INFO): Starting
2019-03-08T21:30:43.318Z,1552080643.318 [Micromodem](INFO): Starting
2019-03-08T21:30:43.726Z,1552080643.726 [Micromodem](INFO): Starting
2019-03-08T21:30:44.123Z,1552080644.123 [Micromodem](INFO): Starting
2019-03-08T21:30:44.534Z,1552080644.534 [Micromodem](INFO): Starting
2019-03-08T21:30:44.938Z,1552080644.938 [Micromodem](INFO): Starting
2019-03-08T21:30:45.342Z,1552080645.342 [Micromodem](INFO): Starting
2019-03-08T21:30:45.742Z,1552080645.742 [Micromodem](INFO): Starting
2019-03-08T21:30:46.146Z,1552080646.146 [Micromodem](INFO): Starting
2019-03-08T21:30:46.550Z,1552080646.550 [Micromodem](INFO): Starting
2019-03-08T21:30:46.954Z,1552080646.954 [Micromodem](INFO): Starting
2019-03-08T21:30:47.360Z,1552080647.360 [Micromodem](INFO): Starting
2019-03-08T21:30:47.762Z,1552080647.762 [Micromodem](INFO): Starting
2019-03-08T21:30:48.166Z,1552080648.166 [Micromodem](INFO): Starting
2019-03-08T21:30:48.570Z,1552080648.570 [Micromodem](INFO): Starting
2019-03-08T21:30:48.974Z,1552080648.974 [Micromodem](INFO): Starting
2019-03-08T21:30:48.975Z,1552080648.975 [Micromodem](IMPORTANT): CACFG stsring$CACFG,SRC,1*33

2019-03-08T21:30:48.975Z,1552080648.975 [Micromodem](INFO): Nmea out: $CCCFG,REV,1*32

2019-03-08T21:30:49.382Z,1552080649.382 [Micromodem](INFO): Starting
2019-03-08T21:30:49.786Z,1552080649.786 [Micromodem](INFO): Starting
2019-03-08T21:30:50.190Z,1552080650.190 [Micromodem](INFO): Starting
2019-03-08T21:30:50.590Z,1552080650.590 [Micromodem](INFO): Starting
2019-03-08T21:30:51.004Z,1552080651.004 [Micromodem](INFO): Starting
2019-03-08T21:30:51.398Z,1552080651.398 [Micromodem](INFO): Starting
2019-03-08T21:30:51.806Z,1552080651.806 [Micromodem](INFO): Starting
2019-03-08T21:30:52.210Z,1552080652.210 [Micromodem](INFO): Starting
2019-03-08T21:30:52.610Z,1552080652.610 [Micromodem](INFO): Starting
2019-03-08T21:30:53.025Z,1552080653.025 [Micromodem](INFO): Starting
2019-03-08T21:30:53.418Z,1552080653.418 [Micromodem](INFO): Starting
2019-03-08T21:30:53.819Z,1552080653.819 [Micromodem](INFO): Starting
2019-03-08T21:30:54.228Z,1552080654.228 [Micromodem](INFO): Starting
2019-03-08T21:30:54.630Z,1552080654.630 [Micromodem](INFO): Starting
2019-03-08T21:30:55.040Z,1552080655.040 [Micromodem](INFO): Starting
2019-03-08T21:30:55.442Z,1552080655.442 [Micromodem](INFO): Starting
2019-03-08T21:30:55.846Z,1552080655.846 [Micromodem](INFO): Starting
2019-03-08T21:30:56.250Z,1552080656.250 [Micromodem](INFO): Starting
2019-03-08T21:30:56.650Z,1552080656.650 [Micromodem](INFO): Starting
2019-03-08T21:30:57.054Z,1552080657.054 [Micromodem](INFO): Starting
2019-03-08T21:30:57.460Z,1552080657.460 [Micromodem](INFO): Starting
2019-03-08T21:30:57.863Z,1552080657.863 [Micromodem](INFO): Starting
2019-03-08T21:30:58.271Z,1552080658.271 [Micromodem](INFO): Starting
2019-03-08T21:30:58.674Z,1552080658.674 [Micromodem](INFO): Starting
2019-03-08T21:30:59.074Z,1552080659.074 [Micromodem](INFO): Starting
2019-03-08T21:30:59.075Z,1552080659.075 [Micromodem](IMPORTANT): CACFG stsring$CACFG,REV,1*30

2019-03-08T21:30:59.075Z,1552080659.075 [Micromodem](INFO): Nmea out: $CCCFG,RXP,1*29

2019-03-08T21:30:59.482Z,1552080659.482 [Micromodem](INFO): Starting
2019-03-08T21:30:59.886Z,1552080659.886 [Micromodem](INFO): Starting
2019-03-08T21:31:00.286Z,1552080660.286 [Micromodem](INFO): Starting
2019-03-08T21:31:00.694Z,1552080660.694 [Micromodem](INFO): Starting
2019-03-08T21:31:01.094Z,1552080661.094 [Micromodem](INFO): Starting
2019-03-08T21:31:01.502Z,1552080661.502 [Micromodem](INFO): Starting
2019-03-08T21:31:01.906Z,1552080661.906 [Micromodem](INFO): Starting
2019-03-08T21:31:02.310Z,1552080662.310 [Micromodem](INFO): Starting
2019-03-08T21:31:02.714Z,1552080662.714 [Micromodem](INFO): Starting
2019-03-08T21:31:02.735Z,1552080662.735 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:31:02.735Z,1552080662.735 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-08T21:31:02.735Z,1552080662.735 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-08T21:31:02.737Z,1552080662.737 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:31:02.737Z,1552080662.737 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-08T21:31:02.737Z,1552080662.737 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-08T21:31:02.738Z,1552080662.738 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:31:02.738Z,1552080662.738 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-03-08T21:31:02.738Z,1552080662.738 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-08T21:31:02.749Z,1552080662.749 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-08T21:31:02.750Z,1552080662.750 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-08T21:31:02.750Z,1552080662.750 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-08T21:31:03.122Z,1552080663.122 [Micromodem](INFO): Starting
2019-03-08T21:31:03.296Z,1552080663.296 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-08T21:31:03.296Z,1552080663.296 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-08T21:31:03.297Z,1552080663.297 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-08T21:31:03.297Z,1552080663.297 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-08T21:31:03.297Z,1552080663.297 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-08T21:31:03.297Z,1552080663.297 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-03-08T21:31:03.515Z,1552080663.515 [Micromodem](INFO): Starting
2019-03-08T21:31:03.548Z,1552080663.548 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-08T21:31:03.922Z,1552080663.922 [Micromodem](INFO): Starting
2019-03-08T21:31:04.328Z,1552080664.328 [Micromodem](INFO): Starting
2019-03-08T21:31:04.730Z,1552080664.730 [Micromodem](INFO): Starting
2019-03-08T21:31:05.138Z,1552080665.138 [Micromodem](INFO): Starting
2019-03-08T21:31:05.542Z,1552080665.542 [Micromodem](INFO): Starting
2019-03-08T21:31:05.946Z,1552080665.946 [Micromodem](INFO): Starting
2019-03-08T21:31:06.346Z,1552080666.346 [Micromodem](INFO): Starting
2019-03-08T21:31:06.754Z,1552080666.754 [Micromodem](INFO): Starting
2019-03-08T21:31:07.151Z,1552080667.151 [Micromodem](INFO): Starting
2019-03-08T21:31:07.558Z,1552080667.558 [Micromodem](INFO): Starting
2019-03-08T21:31:07.962Z,1552080667.962 [Micromodem](INFO): Starting
2019-03-08T21:31:08.370Z,1552080668.370 [Micromodem](INFO): Starting
2019-03-08T21:31:08.774Z,1552080668.774 [Micromodem](INFO): Starting
2019-03-08T21:31:09.178Z,1552080669.178 [Micromodem](INFO): Starting
2019-03-08T21:31:09.179Z,1552080669.179 [Micromodem](IMPORTANT): CACFG stsring$CACFG,RXP,1*2B

2019-03-08T21:31:09.179Z,1552080669.179 [Micromodem](DEBUG): Nmea buf: $CCTMS,2019-03-08T21:31:10Z,0*75

2019-03-08T21:31:09.179Z,1552080669.179 [Micromodem](IMPORTANT): Nmea buf: $CCTMS,2019-03-08T21:31:10Z,0*75

2019-03-08T21:31:09.180Z,1552080669.180 [Micromodem](INFO): Nmea out: $CCTMS,2019-03-08T21:31:10Z,0*75

2019-03-08T21:31:09.578Z,1552080669.578 [Micromodem](INFO): Starting
2019-03-08T21:31:09.985Z,1552080669.985 [Micromodem](INFO): Starting
2019-03-08T21:31:10.386Z,1552080670.386 [Micromodem](INFO): Starting
2019-03-08T21:31:10.790Z,1552080670.790 [Micromodem](INFO): Starting
2019-03-08T21:31:11.198Z,1552080671.198 [Micromodem](INFO): Starting
2019-03-08T21:31:25.383Z,1552080685.383 [Startup:StartupSatComms:A](INFO): Timed out from 2019-03-08T21:30:25.2Z
2019-03-08T21:31:25.383Z,1552080685.383 [Startup:StartupSatComms:A] Stopped
2019-03-08T21:31:25.383Z,1552080685.383 [Startup:StartupSatComms:B] Running Loop=1
2019-03-08T21:31:25.767Z,1552080685.767 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-08T21:31:28.531Z,1552080688.531 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004760
2019-03-08T21:31:33.620Z,1552080693.620 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20190308T175122/Courier0064.lzma
2019-03-08T21:31:34.427Z,1552080694.427 [DataOverHttps](INFO): Moved sent file to Logs/20190308T175122/Courier0064.lzma.bak
2019-03-08T21:31:34.427Z,1552080694.427 [DataOverHttps](INFO): SBD MOMSN=10116619
2019-03-08T21:31:45.201Z,1552080705.201 [DataOverHttps](INFO): Sending 757 bytes from file Logs/20190308T175122/Express0065.lzma
2019-03-08T21:31:46.009Z,1552080706.009 [DataOverHttps](INFO): Moved sent file to Logs/20190308T175122/Express0065.lzma.bak
2019-03-08T21:31:46.010Z,1552080706.010 [DataOverHttps](INFO): SBD MOMSN=10116621
2019-03-08T21:31:56.666Z,1552080716.666 [DataOverHttps](INFO): Sending 1083 bytes from file Logs/20190308T212851/Express0001.lzma
2019-03-08T21:31:57.470Z,1552080717.470 [DataOverHttps](INFO): Moved sent file to Logs/20190308T212851/Express0001.lzma.bak
2019-03-08T21:31:57.470Z,1552080717.470 [DataOverHttps](INFO): SBD MOMSN=10116671
2019-03-08T21:31:58.106Z,1552080718.106 [Startup:StartupSatComms:B] Stopped
2019-03-08T21:31:58.106Z,1552080718.106 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-03-08T21:31:58.107Z,1552080718.107 [Startup:StartupSatComms] Stopped
2019-03-08T21:31:58.107Z,1552080718.107 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-03-08T21:31:58.107Z,1552080718.107 [Startup](INFO): Completed Startup
2019-03-08T21:31:58.108Z,1552080718.108 [MissionManager](INFO): Startup is completed.
2019-03-08T21:31:58.108Z,1552080718.108 [MissionManager](INFO): Uninitializing Mission Startup
2019-03-08T21:31:58.108Z,1552080718.108 [Startup] Stopped
2019-03-08T21:31:58.108Z,1552080718.108 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-03-08T21:31:58.108Z,1552080718.108 [Startup:A.GoToSurface] Stopped
2019-03-08T21:31:58.108Z,1552080718.108 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-08T21:31:58.494Z,1552080718.494 [MissionManager](IMPORTANT): Started mission Default
2019-03-08T21:31:58.494Z,1552080718.494 [Default] Running Loop=1
2019-03-08T21:31:58.495Z,1552080718.495 [Default](DEBUG): Aggregate::initialize Default
2019-03-08T21:31:58.495Z,1552080718.495 [Default:B.GoToSurface] Running Loop=1
2019-03-08T21:31:58.495Z,1552080718.495 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-08T21:31:58.495Z,1552080718.495 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-08T21:31:58.495Z,1552080718.495 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-08T21:31:58.496Z,1552080718.496 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-08T21:31:58.496Z,1552080718.496 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-08T21:31:58.496Z,1552080718.496 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-08T21:31:58.496Z,1552080718.496 [Default:A.Wait] Running Loop=1
2019-03-08T21:31:58.497Z,1552080718.497 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:31:59.272Z,1552080719.272 [Micromodem](FAULT): LCB 2 fault: 
2019-03-08T21:31:59.272Z,1552080719.272 [Micromodem] Hardware Fault, FailCount= 2
2019-03-08T21:31:59.272Z,1552080719.272 [Micromodem](ERROR): Hardware Fault
2019-03-08T21:31:59.273Z,1552080719.273 [Micromodem](INFO): Stop
2019-03-08T21:31:59.273Z,1552080719.273 [Micromodem](INFO): uninitialize
2019-03-08T21:31:59.273Z,1552080719.273 [Micromodem](INFO): Powering down
2019-03-08T21:31:59.476Z,1552080719.476 [CBIT](ERROR): Hardware Fault in component: Micromodem
2019-03-08T21:31:59.674Z,1552080719.674 [Micromodem](INFO): Stop
2019-03-08T21:31:59.674Z,1552080719.674 [Micromodem](INFO): uninitialize
2019-03-08T21:31:59.674Z,1552080719.674 [Micromodem](INFO): Powering down
2019-03-08T21:32:00.078Z,1552080720.078 [Micromodem](INFO): Stopping
2019-03-08T21:32:00.078Z,1552080720.078 [Micromodem](FAULT): LCB 2 fault:  Software Overcurrent.
2019-03-08T21:32:00.482Z,1552080720.482 [Micromodem](INFO): Stopped
2019-03-08T21:32:00.515Z,1552080720.515 [CBIT](INFO): Clearing failed state for component Micromodem
2019-03-08T21:32:00.515Z,1552080720.515 [Micromodem] No Fault, FailCount= 2
2019-03-08T21:32:00.886Z,1552080720.886 [Micromodem](INFO): Start
2019-03-08T21:32:01.290Z,1552080721.290 [Micromodem](INFO): Start
2019-03-08T21:32:01.694Z,1552080721.694 [Micromodem](INFO): Start
2019-03-08T21:32:02.098Z,1552080722.098 [Micromodem](INFO): Start
2019-03-08T21:32:02.502Z,1552080722.502 [Micromodem](INFO): Start
2019-03-08T21:32:02.903Z,1552080722.903 [Micromodem](INFO): Start
2019-03-08T21:32:03.310Z,1552080723.310 [Micromodem](INFO): Starting
2019-03-08T21:32:03.311Z,1552080723.311 [Micromodem](INFO): Powering up
2019-03-08T21:32:03.311Z,1552080723.311 [Micromodem](DEBUG): Initializing Micromodem.
2019-03-08T21:32:03.718Z,1552080723.718 [Micromodem](INFO): Starting
2019-03-08T21:32:04.115Z,1552080724.115 [Micromodem](INFO): Starting
2019-03-08T21:32:04.522Z,1552080724.522 [Micromodem](INFO): Starting
2019-03-08T21:32:04.926Z,1552080724.926 [Micromodem](INFO): Starting
2019-03-08T21:32:05.330Z,1552080725.330 [Micromodem](INFO): Starting
2019-03-08T21:32:05.734Z,1552080725.734 [Micromodem](INFO): Starting
2019-03-08T21:32:06.140Z,1552080726.140 [Micromodem](INFO): Starting
2019-03-08T21:32:06.542Z,1552080726.542 [Micromodem](INFO): Starting
2019-03-08T21:32:06.950Z,1552080726.950 [Micromodem](INFO): Starting
2019-03-08T21:32:07.354Z,1552080727.354 [Micromodem](INFO): Starting
2019-03-08T21:32:07.758Z,1552080727.758 [Micromodem](INFO): Starting
2019-03-08T21:32:08.162Z,1552080728.162 [Micromodem](INFO): Starting
2019-03-08T21:32:08.162Z,1552080728.162 [Micromodem](INFO): Starting
2019-03-08T21:32:08.163Z,1552080728.163 [Micromodem](DEBUG): Nmea buf: $CCCFG,CST,1*37

2019-03-08T21:32:08.163Z,1552080728.163 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,CST,1*37

2019-03-08T21:32:08.163Z,1552080728.163 [Micromodem](INFO): Nmea out: $CCCFG,CST,1*37

2019-03-08T21:32:08.164Z,1552080728.164 [Micromodem](DEBUG): Nmea buf: $CCCFG,SRC,1*31

2019-03-08T21:32:08.165Z,1552080728.165 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,SRC,1*31

2019-03-08T21:32:08.166Z,1552080728.166 [Micromodem](DEBUG): Nmea buf: $CCCFG,REV,1*32

2019-03-08T21:32:08.167Z,1552080728.167 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,REV,1*32

2019-03-08T21:32:08.168Z,1552080728.168 [Micromodem](DEBUG): Nmea buf: $CCCFG,RXP,1*29

2019-03-08T21:32:08.169Z,1552080728.169 [Micromodem](IMPORTANT): Nmea buf: $CCCFG,RXP,1*29

2019-03-08T21:32:08.562Z,1552080728.562 [Micromodem](INFO): Starting
2019-03-08T21:32:08.966Z,1552080728.966 [Micromodem](INFO): Starting
2019-03-08T21:32:09.372Z,1552080729.372 [Micromodem](INFO): Starting
2019-03-08T21:32:09.778Z,1552080729.778 [Micromodem](INFO): Starting
2019-03-08T21:32:10.175Z,1552080730.175 [Micromodem](INFO): Starting
2019-03-08T21:32:10.582Z,1552080730.582 [Micromodem](INFO): Starting
2019-03-08T21:32:10.986Z,1552080730.986 [Micromodem](INFO): Starting
2019-03-08T21:32:11.394Z,1552080731.394 [Micromodem](INFO): Starting
2019-03-08T21:32:11.798Z,1552080731.798 [Micromodem](INFO): Starting
2019-03-08T21:32:11.843Z,1552080731.843 [Default:A.Wait](INFO): Done Waiting.
2019-03-08T21:32:11.843Z,1552080731.843 [Default:A.Wait] Stopped
2019-03-08T21:32:11.843Z,1552080731.843 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:32:12.198Z,1552080732.198 [Micromodem](INFO): Starting
2019-03-08T21:32:12.250Z,1552080732.250 [Default:CheckIn] Running Loop=1
2019-03-08T21:32:12.251Z,1552080732.251 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-08T21:32:12.251Z,1552080732.251 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-08T21:32:12.605Z,1552080732.605 [Micromodem](INFO): Starting
2019-03-08T21:32:12.643Z,1552080732.643 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-03-08T21:32:13.025Z,1552080733.025 [Micromodem](INFO): Starting
2019-03-08T21:32:13.410Z,1552080733.410 [Micromodem](INFO): Starting
2019-03-08T21:32:13.818Z,1552080733.818 [Micromodem](INFO): Starting
2019-03-08T21:32:14.222Z,1552080734.222 [Micromodem](INFO): Starting
2019-03-08T21:32:14.623Z,1552080734.623 [Micromodem](INFO): Starting
2019-03-08T21:32:15.034Z,1552080735.034 [Micromodem](INFO): Starting
2019-03-08T21:32:15.430Z,1552080735.430 [Micromodem](INFO): Starting
2019-03-08T21:32:15.834Z,1552080735.834 [Micromodem](INFO): Starting
2019-03-08T21:32:16.235Z,1552080736.235 [Micromodem](INFO): Starting
2019-03-08T21:32:16.646Z,1552080736.646 [Micromodem](INFO): Starting
2019-03-08T21:32:17.046Z,1552080737.046 [Micromodem](INFO): Starting
2019-03-08T21:32:17.454Z,1552080737.454 [Micromodem](INFO): Starting
2019-03-08T21:32:17.858Z,1552080737.858 [Micromodem](INFO): Starting
2019-03-08T21:32:18.259Z,1552080738.259 [Micromodem](INFO): Starting
2019-03-08T21:32:18.662Z,1552080738.662 [Micromodem](INFO): Starting
2019-03-08T21:32:19.070Z,1552080739.070 [Micromodem](INFO): Starting
2019-03-08T21:32:19.472Z,1552080739.472 [Micromodem](INFO): Starting
2019-03-08T21:32:19.472Z,1552080739.472 [Micromodem](ERROR): Nmea resend: $CCCFG,CST,1*37

2019-03-08T21:32:19.874Z,1552080739.874 [Micromodem](INFO): Starting
2019-03-08T21:32:20.282Z,1552080740.282 [Micromodem](INFO): Starting
2019-03-08T21:32:20.686Z,1552080740.686 [Micromodem](INFO): Starting
2019-03-08T21:32:21.090Z,1552080741.090 [Micromodem](INFO): Starting
2019-03-08T21:32:21.490Z,1552080741.490 [Micromodem](INFO): Starting
2019-03-08T21:32:21.894Z,1552080741.894 [Micromodem](INFO): Starting
2019-03-08T21:32:22.302Z,1552080742.302 [Micromodem](INFO): Starting
2019-03-08T21:32:22.702Z,1552080742.702 [Micromodem](INFO): Starting
2019-03-08T21:32:23.112Z,1552080743.112 [Micromodem](INFO): Starting
2019-03-08T21:32:23.507Z,1552080743.507 [Micromodem](INFO): Starting
2019-03-08T21:32:23.914Z,1552080743.914 [Micromodem](INFO): Starting
2019-03-08T21:32:24.318Z,1552080744.318 [Micromodem](INFO): Starting
2019-03-08T21:32:24.722Z,1552080744.722 [Micromodem](INFO): Starting
2019-03-08T21:32:25.126Z,1552080745.126 [Micromodem](INFO): Starting
2019-03-08T21:32:25.530Z,1552080745.530 [Micromodem](INFO): Starting
2019-03-08T21:32:25.934Z,1552080745.934 [Micromodem](INFO): Starting
2019-03-08T21:32:26.340Z,1552080746.340 [Micromodem](INFO): Starting
2019-03-08T21:32:26.746Z,1552080746.746 [Micromodem](INFO): Starting
2019-03-08T21:32:27.143Z,1552080747.143 [Micromodem](INFO): Starting
2019-03-08T21:32:27.554Z,1552080747.554 [Micromodem](INFO): Starting
2019-03-08T21:32:27.958Z,1552080747.958 [Micromodem](INFO): Starting
2019-03-08T21:32:28.362Z,1552080748.362 [Micromodem](INFO): Starting
2019-03-08T21:32:28.762Z,1552080748.762 [Micromodem](INFO): Starting
2019-03-08T21:32:29.166Z,1552080749.166 [Micromodem](INFO): Starting
2019-03-08T21:32:29.567Z,1552080749.567 [Micromodem](INFO): Starting
2019-03-08T21:32:29.978Z,1552080749.978 [Micromodem](INFO): Starting
2019-03-08T21:32:30.382Z,1552080750.382 [Micromodem](INFO): Starting
2019-03-08T21:32:30.786Z,1552080750.786 [Micromodem](INFO): Starting
2019-03-08T21:32:30.786Z,1552080750.786 [Micromodem](ERROR): Nmea resend: $CCCFG,CST,1*37

2019-03-08T21:32:31.190Z,1552080751.190 [Micromodem](INFO): Starting
2019-03-08T21:32:31.590Z,1552080751.590 [Micromodem](INFO): Starting
2019-03-08T21:32:32.001Z,1552080752.001 [Micromodem](INFO): Starting
2019-03-08T21:32:32.398Z,1552080752.398 [Micromodem](INFO): Starting
2019-03-08T21:32:32.806Z,1552080752.806 [Micromodem](INFO): Starting
2019-03-08T21:32:33.210Z,1552080753.210 [Micromodem](INFO): Starting
2019-03-08T21:32:33.615Z,1552080753.615 [Micromodem](INFO): Starting
2019-03-08T21:32:34.036Z,1552080754.036 [Micromodem](INFO): Starting
2019-03-08T21:32:34.418Z,1552080754.418 [Micromodem](INFO): Starting
2019-03-08T21:32:34.822Z,1552080754.822 [Micromodem](INFO): Starting
2019-03-08T21:32:35.226Z,1552080755.226 [Micromodem](INFO): Starting
2019-03-08T21:32:35.646Z,1552080755.646 [Micromodem](INFO): Starting
2019-03-08T21:32:36.039Z,1552080756.039 [Micromodem](INFO): Starting
2019-03-08T21:32:36.438Z,1552080756.438 [Micromodem](INFO): Starting
2019-03-08T21:32:36.842Z,1552080756.842 [Micromodem](INFO): Starting
2019-03-08T21:32:37.246Z,1552080757.246 [Micromodem](INFO): Starting
2019-03-08T21:32:37.650Z,1552080757.650 [Micromodem](INFO): Starting
2019-03-08T21:32:38.058Z,1552080758.058 [Micromodem](INFO): Starting
2019-03-08T21:32:38.462Z,1552080758.462 [Micromodem](INFO): Starting
2019-03-08T21:32:38.463Z,1552080758.463 [Micromodem](IMPORTANT): CACFG stsring$CACFG,CST,1*35

2019-03-08T21:32:38.463Z,1552080758.463 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2019-03-08T21:32:38.866Z,1552080758.866 [Micromodem](INFO): Starting
2019-03-08T21:32:39.270Z,1552080759.270 [Micromodem](INFO): Starting
2019-03-08T21:32:39.674Z,1552080759.674 [Micromodem](INFO): Starting
2019-03-08T21:32:40.074Z,1552080760.074 [Micromodem](INFO): Starting
2019-03-08T21:32:40.482Z,1552080760.482 [Micromodem](INFO): Starting
2019-03-08T21:32:40.886Z,1552080760.886 [Micromodem](INFO): Starting
2019-03-08T21:32:41.286Z,1552080761.286 [Micromodem](INFO): Starting
2019-03-08T21:32:41.687Z,1552080761.687 [Micromodem](INFO): Starting
2019-03-08T21:32:42.094Z,1552080762.094 [Micromodem](INFO): Starting
2019-03-08T21:32:42.498Z,1552080762.498 [Micromodem](INFO): Starting
2019-03-08T21:32:42.902Z,1552080762.902 [Micromodem](INFO): Starting
2019-03-08T21:32:43.306Z,1552080763.306 [Micromodem](INFO): Starting
2019-03-08T21:32:43.710Z,1552080763.710 [Micromodem](INFO): Starting
2019-03-08T21:32:44.111Z,1552080764.111 [Micromodem](INFO): Starting
2019-03-08T21:32:44.522Z,1552080764.522 [Micromodem](INFO): Starting
2019-03-08T21:32:44.926Z,1552080764.926 [Micromodem](INFO): Starting
2019-03-08T21:32:45.326Z,1552080765.326 [Micromodem](INFO): Starting
2019-03-08T21:32:45.730Z,1552080765.730 [Micromodem](INFO): Starting
2019-03-08T21:32:46.134Z,1552080766.134 [Micromodem](INFO): Starting
2019-03-08T21:32:46.538Z,1552080766.538 [Micromodem](INFO): Starting
2019-03-08T21:32:46.948Z,1552080766.948 [Micromodem](INFO): Starting
2019-03-08T21:32:47.350Z,1552080767.350 [Micromodem](INFO): Starting
2019-03-08T21:32:47.750Z,1552080767.750 [Micromodem](INFO): Starting
2019-03-08T21:32:48.158Z,1552080768.158 [Micromodem](INFO): Starting
2019-03-08T21:32:48.558Z,1552080768.558 [Micromodem](INFO): Starting
2019-03-08T21:32:48.559Z,1552080768.559 [Micromodem](IMPORTANT): CACFG stsring$CACFG,SRC,1*33

2019-03-08T21:32:48.559Z,1552080768.559 [Micromodem](INFO): Nmea out: $CCCFG,REV,1*32

2019-03-08T21:32:48.962Z,1552080768.962 [Micromodem](INFO): Starting
2019-03-08T21:32:49.370Z,1552080769.370 [Micromodem](INFO): Starting
2019-03-08T21:32:49.774Z,1552080769.774 [Micromodem](INFO): Starting
2019-03-08T21:32:50.176Z,1552080770.176 [Micromodem](INFO): Starting
2019-03-08T21:32:50.578Z,1552080770.578 [Micromodem](INFO): Starting
2019-03-08T21:32:50.986Z,1552080770.986 [Micromodem](INFO): Starting
2019-03-08T21:32:51.390Z,1552080771.390 [Micromodem](INFO): Starting
2019-03-08T21:32:51.794Z,1552080771.794 [Micromodem](INFO): Starting
2019-03-08T21:32:52.198Z,1552080772.198 [Micromodem](INFO): Starting
2019-03-08T21:32:52.598Z,1552080772.598 [Micromodem](INFO): Starting
2019-03-08T21:32:53.009Z,1552080773.009 [Micromodem](INFO): Starting
2019-03-08T21:32:53.406Z,1552080773.406 [Micromodem](INFO): Starting
2019-03-08T21:32:53.807Z,1552080773.807 [Micromodem](INFO): Starting
2019-03-08T21:32:54.218Z,1552080774.218 [Micromodem](INFO): Starting
2019-03-08T21:32:54.619Z,1552080774.619 [Micromodem](INFO): Starting
2019-03-08T21:32:55.030Z,1552080775.030 [Micromodem](INFO): Starting
2019-03-08T21:32:55.430Z,1552080775.430 [Micromodem](INFO): Starting
2019-03-08T21:32:55.830Z,1552080775.830 [Micromodem](INFO): Starting
2019-03-08T21:32:56.231Z,1552080776.231 [Micromodem](INFO): Starting
2019-03-08T21:32:56.638Z,1552080776.638 [Micromodem](INFO): Starting
2019-03-08T21:32:57.044Z,1552080777.044 [Micromodem](INFO): Starting
2019-03-08T21:32:57.446Z,1552080777.446 [Micromodem](INFO): Starting
2019-03-08T21:32:57.854Z,1552080777.854 [Micromodem](INFO): Starting
2019-03-08T21:32:58.259Z,1552080778.259 [Micromodem](INFO): Starting
2019-03-08T21:32:58.260Z,1552080778.260 [Micromodem](IMPORTANT): CACFG stsring$CACFG,REV,1*30

2019-03-08T21:32:58.260Z,1552080778.260 [Micromodem](INFO): Nmea out: $CCCFG,RXP,1*29

2019-03-08T21:32:58.658Z,1552080778.658 [Micromodem](INFO): Starting
2019-03-08T21:32:59.062Z,1552080779.062 [Micromodem](INFO): Starting
2019-03-08T21:32:59.063Z,1552080779.063 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,213258,CROC,0.10.0.46*4F

2019-03-08T21:32:59.466Z,1552080779.466 [Micromodem](INFO): Starting
2019-03-08T21:32:59.874Z,1552080779.874 [Micromodem](INFO): Starting
2019-03-08T21:33:00.278Z,1552080780.278 [Micromodem](INFO): Starting
2019-03-08T21:33:00.678Z,1552080780.678 [Micromodem](INFO): Starting
2019-03-08T21:33:01.086Z,1552080781.086 [Micromodem](INFO): Starting
2019-03-08T21:33:01.490Z,1552080781.490 [Micromodem](INFO): Starting
2019-03-08T21:33:01.894Z,1552080781.894 [Micromodem](INFO): Starting
2019-03-08T21:33:02.294Z,1552080782.294 [Micromodem](INFO): Starting
2019-03-08T21:33:02.702Z,1552080782.702 [Micromodem](INFO): Starting
2019-03-08T21:33:03.102Z,1552080783.102 [Micromodem](INFO): Starting
2019-03-08T21:33:03.503Z,1552080783.503 [Micromodem](INFO): Starting
2019-03-08T21:33:03.586Z,1552080783.586 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:33:03.586Z,1552080783.586 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-08T21:33:03.587Z,1552080783.587 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-08T21:33:03.588Z,1552080783.588 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:33:03.588Z,1552080783.588 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-08T21:33:03.588Z,1552080783.588 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-08T21:33:03.590Z,1552080783.590 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:33:03.590Z,1552080783.590 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-03-08T21:33:03.590Z,1552080783.590 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-08T21:33:03.633Z,1552080783.633 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-08T21:33:03.633Z,1552080783.633 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-08T21:33:03.633Z,1552080783.633 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-08T21:33:03.910Z,1552080783.910 [Micromodem](INFO): Starting
2019-03-08T21:33:03.984Z,1552080783.984 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-08T21:33:03.989Z,1552080783.989 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-08T21:33:03.989Z,1552080783.989 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-08T21:33:03.989Z,1552080783.989 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-08T21:33:03.990Z,1552080783.990 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-08T21:33:03.990Z,1552080783.990 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-03-08T21:33:04.314Z,1552080784.314 [Micromodem](INFO): Starting
2019-03-08T21:33:04.393Z,1552080784.393 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-08T21:33:04.722Z,1552080784.722 [Micromodem](INFO): Starting
2019-03-08T21:33:05.126Z,1552080785.126 [Micromodem](INFO): Starting
2019-03-08T21:33:05.530Z,1552080785.530 [Micromodem](INFO): Starting
2019-03-08T21:33:05.934Z,1552080785.934 [Micromodem](INFO): Starting
2019-03-08T21:33:06.334Z,1552080786.334 [Micromodem](INFO): Starting
2019-03-08T21:33:06.740Z,1552080786.740 [Micromodem](INFO): Starting
2019-03-08T21:33:07.139Z,1552080787.139 [Micromodem](INFO): Starting
2019-03-08T21:33:07.546Z,1552080787.546 [Micromodem](INFO): Starting
2019-03-08T21:33:07.954Z,1552080787.954 [Micromodem](INFO): Starting
2019-03-08T21:33:08.358Z,1552080788.358 [Micromodem](INFO): Starting
2019-03-08T21:33:08.359Z,1552080788.359 [Micromodem](IMPORTANT): CACFG stsring$CACFG,RXP,1*2B

2019-03-08T21:33:08.359Z,1552080788.359 [Micromodem](DEBUG): Nmea buf: $CCTMS,2019-03-08T21:33:09Z,0*7F

2019-03-08T21:33:08.359Z,1552080788.359 [Micromodem](IMPORTANT): Nmea buf: $CCTMS,2019-03-08T21:33:09Z,0*7F

2019-03-08T21:33:08.360Z,1552080788.360 [Micromodem](INFO): Nmea out: $CCTMS,2019-03-08T21:33:09Z,0*7F

2019-03-08T21:33:08.758Z,1552080788.758 [Micromodem](INFO): Starting
2019-03-08T21:33:09.166Z,1552080789.166 [Micromodem](INFO): Starting
2019-03-08T21:33:09.566Z,1552080789.566 [Micromodem](INFO): Starting
2019-03-08T21:33:09.970Z,1552080789.970 [Micromodem](INFO): Starting
2019-03-08T21:34:42.893Z,1552080882.893 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-03-08T21:34:43.713Z,1552080883.713 [NAL9602](DEBUG): Fix Requested
2019-03-08T21:34:47.753Z,1552080887.753 [NAL9602](DEBUG): Fix Requested
2019-03-08T21:34:48.145Z,1552080888.145 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213022.00,A,3648.16449,N,12147.27713,W,0.272,0.00,080319,,,A*7E
2019-03-08T21:34:48.148Z,1552080888.148 [NAL9602](INFO): GPS fix at 20190308T213022: (36.802742, -121.787952)
2019-03-08T21:34:48.200Z,1552080888.200 [Default:CheckIn:Read_GPS] Stopped
2019-03-08T21:34:48.200Z,1552080888.200 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-03-08T21:34:48.588Z,1552080888.588 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-08T21:34:57.800Z,1552080897.800 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20190308T212851/Courier0004.lzma
2019-03-08T21:34:58.606Z,1552080898.606 [DataOverHttps](INFO): Moved sent file to Logs/20190308T212851/Courier0004.lzma.bak
2019-03-08T21:34:58.606Z,1552080898.606 [DataOverHttps](INFO): SBD MOMSN=10116718
2019-03-08T21:35:04.796Z,1552080904.796 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:35:04.796Z,1552080904.796 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-08T21:35:04.796Z,1552080904.796 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-08T21:35:04.798Z,1552080904.798 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:35:04.798Z,1552080904.798 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-08T21:35:04.798Z,1552080904.798 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-08T21:35:04.800Z,1552080904.800 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:35:04.800Z,1552080904.800 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-03-08T21:35:04.800Z,1552080904.800 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-08T21:35:04.812Z,1552080904.812 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-08T21:35:04.812Z,1552080904.812 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-08T21:35:04.812Z,1552080904.812 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-08T21:35:05.209Z,1552080905.209 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-08T21:35:05.209Z,1552080905.209 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-08T21:35:05.210Z,1552080905.210 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-08T21:35:05.210Z,1552080905.210 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-08T21:35:05.211Z,1552080905.211 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-08T21:35:05.211Z,1552080905.211 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-03-08T21:35:05.591Z,1552080905.591 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-08T21:35:10.333Z,1552080910.333 [DataOverHttps](INFO): Sending 566 bytes from file Logs/20190308T212851/Express0005.lzma
2019-03-08T21:35:11.138Z,1552080911.138 [DataOverHttps](INFO): Moved sent file to Logs/20190308T212851/Express0005.lzma.bak
2019-03-08T21:35:11.138Z,1552080911.138 [DataOverHttps](INFO): SBD MOMSN=10116721
2019-03-08T21:35:12.074Z,1552080912.074 [Default:CheckIn:Read_Iridium] Stopped
2019-03-08T21:35:12.074Z,1552080912.074 [Default:CheckIn:C.Wait] Running Loop=1
2019-03-08T21:35:12.075Z,1552080912.075 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:35:20.903Z,1552080920.903 [NAL9602](INFO): Powering down
2019-03-08T21:36:24.380Z,1552080984.380 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 6.
2019-03-08T21:36:28.046Z,1552080988.046 [CommandLine](IMPORTANT): got command failComponent
2019-03-08T21:36:28.047Z,1552080988.047 [CommandLine](IMPORTANT): Failed components:
2019-03-08T21:36:28.047Z,1552080988.047 [CommandLine](IMPORTANT): No failed Components.
2019-03-08T21:36:32.858Z,1552080992.858 [CommandLine](IMPORTANT): got command show variable DUSBL
2019-03-08T21:36:32.924Z,1552080992.924 [CommandLine](IMPORTANT): DUSBL_Hydroid.loadAtStartup (bool)
2019-03-08T21:36:32.924Z,1552080992.924 [CommandLine](IMPORTANT): DUSBL_Hydroid.simulateHardware (bool)
2019-03-08T21:36:32.925Z,1552080992.925 [CommandLine](IMPORTANT): DUSBL_Hydroid.defaultTurnAroundTime (meter_per_second)
2019-03-08T21:36:32.925Z,1552080992.925 [CommandLine](IMPORTANT): DUSBL_Hydroid.defaultSoundSpeed (meter_per_second)
2019-03-08T21:36:32.926Z,1552080992.926 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold (count)
2019-03-08T21:36:32.926Z,1552080992.926 [CommandLine](IMPORTANT): DUSBL_Hydroid.recieveTimeout (millisecond)
2019-03-08T21:36:32.926Z,1552080992.926 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout (millisecond)
2019-03-08T21:36:32.927Z,1552080992.927 [CommandLine](IMPORTANT): DUSBL_Hydroid.transponderCode (enum)
2019-03-08T21:36:32.927Z,1552080992.927 [CommandLine](IMPORTANT): DUSBL_Hydroid.numberOfPingsRequested (count)
2019-03-08T21:36:32.927Z,1552080992.927 [CommandLine](IMPORTANT): DUSBL_Hydroid.verbosity (enum)
2019-03-08T21:36:32.928Z,1552080992.928 [CommandLine](IMPORTANT): DUSBL_Hydroid.xCenter (angular_degree)
2019-03-08T21:36:32.928Z,1552080992.928 [CommandLine](IMPORTANT): DUSBL_Hydroid.yCenter (angular_degree)
2019-03-08T21:36:32.940Z,1552080992.940 [CommandLine](IMPORTANT): DUSBL_Hydroid.loadControl (none)
2019-03-08T21:36:32.940Z,1552080992.940 [CommandLine](IMPORTANT): DUSBL_Hydroid.uart (none)
2019-03-08T21:36:32.940Z,1552080992.940 [CommandLine](IMPORTANT): DUSBL_Hydroid.baud (bit_per_second)
2019-03-08T21:36:32.944Z,1552080992.944 [CommandLine](IMPORTANT): Micromodem.dusblPingCode (enum)
2019-03-08T21:36:32.944Z,1552080992.944 [CommandLine](IMPORTANT): DUSBL_Hydroid.xAngle (angular_degree)
2019-03-08T21:36:32.945Z,1552080992.945 [CommandLine](IMPORTANT): DUSBL_Hydroid.yAngle (angular_degree)
2019-03-08T21:36:32.945Z,1552080992.945 [CommandLine](IMPORTANT): DUSBL_Hydroid.travelTime (microsecond)
2019-03-08T21:36:32.945Z,1552080992.945 [CommandLine](IMPORTANT): DUSBL_Hydroid.latency (microsecond)
2019-03-08T21:36:32.946Z,1552080992.946 [CommandLine](IMPORTANT): DUSBL_Hydroid.gain (ratio)
2019-03-08T21:36:32.946Z,1552080992.946 [CommandLine](IMPORTANT): DUSBL_Hydroid.inBandSignalToNoise (ratio)
2019-03-08T21:36:32.946Z,1552080992.946 [CommandLine](IMPORTANT): DUSBL_Hydroid.outBandSignalToNoise (ratio)
2019-03-08T21:36:32.947Z,1552080992.947 [CommandLine](IMPORTANT): DUSBL_Hydroid.range (meter)
2019-03-08T21:36:32.947Z,1552080992.947 [CommandLine](IMPORTANT): DUSBL_Hydroid.direction (none)
2019-03-08T21:36:38.991Z,1552080998.991 [CommandLine](IMPORTANT): got command show variable detectionTresh
2019-03-08T21:36:44.890Z,1552081004.890 [CommandLine](IMPORTANT): got command show variable detectionThr
2019-03-08T21:36:44.991Z,1552081004.991 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold (count)
2019-03-08T21:36:49.590Z,1552081009.590 [CommandLine](IMPORTANT): got command get DUSBL_Hydroid.detectionThreshold
2019-03-08T21:36:49.590Z,1552081009.590 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold 9 count
2019-03-08T21:36:55.867Z,1552081015.867 [CommandLine](IMPORTANT): got command report touch DUSBL_Hydroid.range
2019-03-08T21:37:03.037Z,1552081023.037 [CommandLine](IMPORTANT): got command report touch DUSBL_Hydroid.xAngle
2019-03-08T21:37:05.972Z,1552081025.972 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:37:05.972Z,1552081025.972 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-08T21:37:05.972Z,1552081025.972 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-08T21:37:05.974Z,1552081025.974 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:37:05.974Z,1552081025.974 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-08T21:37:05.975Z,1552081025.975 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-08T21:37:05.976Z,1552081025.976 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:37:05.977Z,1552081025.977 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-03-08T21:37:05.977Z,1552081025.977 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-08T21:37:05.000Z,1552081026.000 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-08T21:37:06.000Z,1552081026.000 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-08T21:37:06.005Z,1552081026.005 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-08T21:37:06.405Z,1552081026.405 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-08T21:37:06.405Z,1552081026.405 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-08T21:37:06.406Z,1552081026.406 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-08T21:37:06.406Z,1552081026.406 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-08T21:37:06.406Z,1552081026.406 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-08T21:37:06.406Z,1552081026.406 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-03-08T21:37:06.772Z,1552081026.772 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-08T21:37:07.923Z,1552081027.923 [CommandLine](IMPORTANT): got command run ./Missions/Maintenance/DUSBL.xml
2019-03-08T21:37:07.923Z,1552081027.923 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/DUSBL.xml
2019-03-08T21:37:08.046Z,1552081028.046 [MissionManager](INFO): DefineArg DUSBL.MissionTimeout = 90.000000 min
2019-03-08T21:37:08.057Z,1552081028.057 [MissionManager](INFO): DefineArg DUSBL.NumberOfRequests = 10.000000 count
2019-03-08T21:37:08.065Z,1552081028.065 [MissionManager](INFO): DefineArg DUSBL.TransponderCode = 2.000000 count
2019-03-08T21:37:08.073Z,1552081028.073 [MissionManager](INFO): DefineArg DUSBL.NumberOfPings = 1.000000 count
2019-03-08T21:37:08.081Z,1552081028.081 [MissionManager](INFO): DefineArg DUSBL.EnabledDUSBL = 1.000000 bool
2019-03-08T21:37:08.082Z,1552081028.082 [DUSBL:A.Pitch](DEBUG): Construct.
2019-03-08T21:37:08.102Z,1552081028.102 [DUSBL:B.SetSpeed](DEBUG): Construct.
2019-03-08T21:37:08.123Z,1552081028.123 [DUSBL:RequestRepeater:C.Wait](DEBUG): Construct Wait.
2019-03-08T21:37:08.147Z,1552081028.147 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Control="Tethys/Control"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd"
       Id="DUSBL">

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

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

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

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

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

    <Timeout Duration="MissionTimeout"/>

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

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

    <ReadData>
        <While>
            <Arg Name="EnabledDUSBL"/>
        </While>
        <Sensor:DUSBL_Hydroid.range/>
        <Sensor:DUSBL_Hydroid.direction/>
    </ReadData>
    
      <Aggregate Id="RequestRepeater">

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


2019-03-08T21:37:08.158Z,1552081028.158 [CommandLine](IMPORTANT): Running ./Missions/Maintenance/DUSBL.xml
2019-03-08T21:37:08.403Z,1552081028.403 [Default] Stopped
2019-03-08T21:37:08.404Z,1552081028.404 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-08T21:37:08.404Z,1552081028.404 [Default:B.GoToSurface] Stopped
2019-03-08T21:37:08.404Z,1552081028.404 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-08T21:37:08.404Z,1552081028.404 [Default:CheckIn] Stopped
2019-03-08T21:37:08.404Z,1552081028.404 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-08T21:37:08.404Z,1552081028.404 [Default:CheckIn:C.Wait] Stopped
2019-03-08T21:37:08.404Z,1552081028.404 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:37:08.404Z,1552081028.404 [MissionManager](IMPORTANT): Started mission DUSBL
2019-03-08T21:37:08.405Z,1552081028.405 [DUSBL] Running Loop=1
2019-03-08T21:37:08.405Z,1552081028.405 [DUSBL](DEBUG): Aggregate::initialize DUSBL
2019-03-08T21:37:08.405Z,1552081028.405 [DUSBL:A.Pitch] Running Loop=1
2019-03-08T21:37:08.405Z,1552081028.405 [DUSBL:A.Pitch](DEBUG): Initialize.
2019-03-08T21:37:08.405Z,1552081028.405 [DUSBL:B.SetSpeed] Running Loop=1
2019-03-08T21:37:08.405Z,1552081028.405 [DUSBL:B.SetSpeed](DEBUG): Initialize.
2019-03-08T21:37:08.405Z,1552081028.405 [DUSBL:C] Running Loop=1
2019-03-08T21:37:08.406Z,1552081028.406 [DUSBL:RequestRepeater] Running Loop=1
2019-03-08T21:37:08.406Z,1552081028.406 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:37:08.406Z,1552081028.406 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:37:08.406Z,1552081028.406 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:37:08.406Z,1552081028.406 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:37:08.406Z,1552081028.406 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:37:08.406Z,1552081028.406 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:37:08.407Z,1552081028.407 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:37:08.407Z,1552081028.407 [DUSBL:C] Running Loop=1
2019-03-08T21:37:08.408Z,1552081028.408 [DUSBL:C](DEBUG): Initialize ReadDataComponent to sense DUSBL_Hydroid.range
2019-03-08T21:37:08.408Z,1552081028.408 [DUSBL:C](DEBUG): Initialize ReadDataComponent to sense DUSBL_Hydroid.direction
2019-03-08T21:37:08.408Z,1552081028.408 [DUSBL:B.SetSpeed] Running Loop=1
2019-03-08T21:37:08.409Z,1552081028.409 [DUSBL:A.Pitch] Running Loop=1
2019-03-08T21:37:09.986Z,1552081029.986 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:09.986Z,1552081029.986 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:09.987Z,1552081029.987 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:09.987Z,1552081029.987 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:09.988Z,1552081029.988 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:09.992Z,1552081029.992 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:09.993Z,1552081029.993 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:09.993Z,1552081029.993 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:09.993Z,1552081029.993 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:14.028Z,1552081034.028 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:14.028Z,1552081034.028 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:14.029Z,1552081034.029 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:14.029Z,1552081034.029 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:14.031Z,1552081034.031 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:14.033Z,1552081034.033 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:14.035Z,1552081034.035 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:14.036Z,1552081034.036 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:14.036Z,1552081034.036 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:14.428Z,1552081034.428 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:14.428Z,1552081034.428 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:14.471Z,1552081034.471 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:37:14.471Z,1552081034.471 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.150000 arcdeg
2019-03-08T21:37:14.830Z,1552081034.830 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:14.830Z,1552081034.830 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:15.234Z,1552081035.234 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:15.234Z,1552081035.234 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:15.638Z,1552081035.638 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:15.638Z,1552081035.638 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:16.042Z,1552081036.042 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:16.042Z,1552081036.042 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:16.446Z,1552081036.446 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:16.446Z,1552081036.446 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:16.850Z,1552081036.850 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:16.850Z,1552081036.850 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:17.254Z,1552081037.254 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:17.254Z,1552081037.254 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:17.658Z,1552081037.658 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:17.658Z,1552081037.658 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:18.066Z,1552081038.066 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:18.066Z,1552081038.066 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:18.066Z,1552081038.066 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:18.067Z,1552081038.067 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:18.067Z,1552081038.067 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:18.070Z,1552081038.070 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:18.072Z,1552081038.072 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:18.072Z,1552081038.072 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:18.072Z,1552081038.072 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:18.468Z,1552081038.468 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:18.468Z,1552081038.468 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:18.500Z,1552081038.500 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:37:18.500Z,1552081038.500 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:37:18.500Z,1552081038.500 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:37:18.501Z,1552081038.501 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:37:18.501Z,1552081038.501 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:37:18.501Z,1552081038.501 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:37:18.501Z,1552081038.501 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:37:18.501Z,1552081038.501 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:37:18.501Z,1552081038.501 [DUSBL:RequestRepeater](INFO): Running loop #2
2019-03-08T21:37:18.502Z,1552081038.502 [DUSBL:RequestRepeater] Running Loop=2
2019-03-08T21:37:18.502Z,1552081038.502 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:37:18.502Z,1552081038.502 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:37:18.502Z,1552081038.502 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:37:18.502Z,1552081038.502 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:37:18.502Z,1552081038.502 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:37:18.512Z,1552081038.512 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:37:18.512Z,1552081038.512 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.500000 arcdeg
2019-03-08T21:37:18.874Z,1552081038.874 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:18.874Z,1552081038.874 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:19.278Z,1552081039.278 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:19.278Z,1552081039.278 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:19.686Z,1552081039.686 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:19.686Z,1552081039.686 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:20.082Z,1552081040.082 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:20.082Z,1552081040.082 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:20.486Z,1552081040.486 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:20.486Z,1552081040.486 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:20.890Z,1552081040.890 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:20.890Z,1552081040.890 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:21.294Z,1552081041.294 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:21.294Z,1552081041.294 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:21.702Z,1552081041.702 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:21.702Z,1552081041.702 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:22.108Z,1552081042.108 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:22.108Z,1552081042.108 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:22.108Z,1552081042.108 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:22.108Z,1552081042.108 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:22.109Z,1552081042.109 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:22.114Z,1552081042.114 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:22.114Z,1552081042.114 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:22.115Z,1552081042.115 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:22.115Z,1552081042.115 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:22.516Z,1552081042.516 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:22.516Z,1552081042.516 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:22.578Z,1552081042.578 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:37:22.579Z,1552081042.579 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.200000 arcdeg
2019-03-08T21:37:22.910Z,1552081042.910 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:22.911Z,1552081042.911 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:23.322Z,1552081043.322 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:23.322Z,1552081043.322 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:23.718Z,1552081043.718 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:23.718Z,1552081043.718 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:24.126Z,1552081044.126 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:24.126Z,1552081044.126 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:24.534Z,1552081044.534 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:24.534Z,1552081044.534 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:24.930Z,1552081044.930 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:24.930Z,1552081044.930 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:25.338Z,1552081045.338 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:25.338Z,1552081045.338 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:25.738Z,1552081045.738 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:25.738Z,1552081045.738 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:26.142Z,1552081046.142 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:26.142Z,1552081046.142 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:26.142Z,1552081046.142 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:26.142Z,1552081046.142 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:26.143Z,1552081046.143 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:26.146Z,1552081046.146 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:26.148Z,1552081046.148 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:26.148Z,1552081046.148 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:26.148Z,1552081046.148 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:26.548Z,1552081046.548 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:26.548Z,1552081046.548 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:26.614Z,1552081046.614 [Reporter](INFO): DUSBL_Hydroid.range -74983.804688 m
2019-03-08T21:37:26.615Z,1552081046.615 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.600000 arcdeg
2019-03-08T21:37:26.954Z,1552081046.954 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:26.954Z,1552081046.954 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:27.354Z,1552081047.354 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:27.354Z,1552081047.354 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:27.758Z,1552081047.758 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:27.758Z,1552081047.758 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:28.162Z,1552081048.162 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:28.162Z,1552081048.162 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:28.566Z,1552081048.566 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:28.566Z,1552081048.566 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:28.972Z,1552081048.972 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:28.972Z,1552081048.972 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:29.016Z,1552081049.016 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:37:29.016Z,1552081049.016 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:37:29.016Z,1552081049.016 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:37:29.018Z,1552081049.018 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:37:29.018Z,1552081049.018 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:37:29.019Z,1552081049.019 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:37:29.019Z,1552081049.019 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:37:29.019Z,1552081049.019 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:37:29.019Z,1552081049.019 [DUSBL:RequestRepeater](INFO): Running loop #3
2019-03-08T21:37:29.020Z,1552081049.020 [DUSBL:RequestRepeater] Running Loop=3
2019-03-08T21:37:29.020Z,1552081049.020 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:37:29.020Z,1552081049.020 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:37:29.020Z,1552081049.020 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:37:29.020Z,1552081049.020 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:37:29.021Z,1552081049.021 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:37:29.374Z,1552081049.374 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:29.374Z,1552081049.374 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:29.778Z,1552081049.778 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:29.778Z,1552081049.778 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:30.182Z,1552081050.182 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:30.182Z,1552081050.182 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:30.183Z,1552081050.183 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:30.183Z,1552081050.183 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:30.184Z,1552081050.184 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:30.186Z,1552081050.186 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:30.188Z,1552081050.188 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:30.188Z,1552081050.188 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:30.188Z,1552081050.188 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:30.596Z,1552081050.596 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:30.596Z,1552081050.596 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:30.663Z,1552081050.663 [Reporter](INFO): DUSBL_Hydroid.range -74982.421875 m
2019-03-08T21:37:30.663Z,1552081050.663 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.950000 arcdeg
2019-03-08T21:37:30.990Z,1552081050.990 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:30.990Z,1552081050.990 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:31.394Z,1552081051.394 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:31.394Z,1552081051.394 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:31.798Z,1552081051.798 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:31.798Z,1552081051.798 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:32.202Z,1552081052.202 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:32.202Z,1552081052.202 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:32.612Z,1552081052.612 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:32.612Z,1552081052.612 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:33.017Z,1552081053.017 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:33.017Z,1552081053.017 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:33.418Z,1552081053.418 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:33.418Z,1552081053.418 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:33.818Z,1552081053.818 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:33.818Z,1552081053.818 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:34.222Z,1552081054.222 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:34.222Z,1552081054.222 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:34.222Z,1552081054.222 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:34.223Z,1552081054.223 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:34.223Z,1552081054.223 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:34.228Z,1552081054.228 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:34.228Z,1552081054.228 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:34.228Z,1552081054.228 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:34.229Z,1552081054.229 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:34.627Z,1552081054.627 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:34.628Z,1552081054.628 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:34.670Z,1552081054.670 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:37:34.671Z,1552081054.671 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.650000 arcdeg
2019-03-08T21:37:35.036Z,1552081055.036 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:35.036Z,1552081055.036 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:35.434Z,1552081055.434 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:35.434Z,1552081055.434 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:35.839Z,1552081055.839 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:35.839Z,1552081055.839 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:36.242Z,1552081056.242 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:36.242Z,1552081056.242 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:36.646Z,1552081056.646 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:36.646Z,1552081056.646 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:37.054Z,1552081057.054 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:37.054Z,1552081057.054 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:37.454Z,1552081057.454 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:37.454Z,1552081057.454 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:37.858Z,1552081057.858 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:37.858Z,1552081057.858 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:38.262Z,1552081058.262 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:38.262Z,1552081058.262 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:38.262Z,1552081058.262 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:38.262Z,1552081058.262 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:38.263Z,1552081058.263 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:38.265Z,1552081058.265 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:38.267Z,1552081058.267 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:38.268Z,1552081058.268 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:38.268Z,1552081058.268 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:38.668Z,1552081058.668 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:38.668Z,1552081058.668 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:38.710Z,1552081058.710 [Reporter](INFO): DUSBL_Hydroid.range -74982.359375 m
2019-03-08T21:37:38.711Z,1552081058.711 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.950000 arcdeg
2019-03-08T21:37:39.070Z,1552081059.070 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:39.070Z,1552081059.070 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:39.474Z,1552081059.474 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:39.474Z,1552081059.474 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:39.524Z,1552081059.524 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:37:39.524Z,1552081059.524 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:37:39.524Z,1552081059.524 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:37:39.530Z,1552081059.530 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:37:39.530Z,1552081059.530 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:37:39.530Z,1552081059.530 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater](INFO): Running loop #4
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater] Running Loop=4
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:37:39.531Z,1552081059.531 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:37:39.878Z,1552081059.878 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:39.878Z,1552081059.878 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:40.282Z,1552081060.282 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:40.282Z,1552081060.282 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:40.686Z,1552081060.686 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:40.686Z,1552081060.686 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:41.090Z,1552081061.090 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:41.090Z,1552081061.090 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:41.494Z,1552081061.494 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:41.494Z,1552081061.494 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:41.898Z,1552081061.898 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:41.898Z,1552081061.898 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:42.302Z,1552081062.302 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:42.302Z,1552081062.302 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:42.302Z,1552081062.302 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:42.303Z,1552081062.303 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:42.303Z,1552081062.303 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:42.303Z,1552081062.303 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:42.304Z,1552081062.304 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:42.304Z,1552081062.304 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:42.304Z,1552081062.304 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:42.709Z,1552081062.709 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:42.709Z,1552081062.709 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:42.774Z,1552081062.774 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:37:42.775Z,1552081062.775 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.550000 arcdeg
2019-03-08T21:37:43.111Z,1552081063.111 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:43.111Z,1552081063.111 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:43.518Z,1552081063.518 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:43.518Z,1552081063.518 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:43.918Z,1552081063.918 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:43.918Z,1552081063.918 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:44.322Z,1552081064.322 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:44.322Z,1552081064.322 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:44.726Z,1552081064.726 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:44.726Z,1552081064.726 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:45.130Z,1552081065.130 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:45.130Z,1552081065.130 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:45.534Z,1552081065.534 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:45.534Z,1552081065.534 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:45.942Z,1552081065.942 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:45.942Z,1552081065.942 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:46.348Z,1552081066.348 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:46.348Z,1552081066.348 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:46.348Z,1552081066.348 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:46.348Z,1552081066.348 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:46.349Z,1552081066.349 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:46.354Z,1552081066.354 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:46.354Z,1552081066.354 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:46.354Z,1552081066.354 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:46.354Z,1552081066.354 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:46.752Z,1552081066.752 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:46.752Z,1552081066.752 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:46.818Z,1552081066.818 [Reporter](INFO): DUSBL_Hydroid.range -74982.421875 m
2019-03-08T21:37:46.819Z,1552081066.819 [Reporter](INFO): DUSBL_Hydroid.xAngle -3.200000 arcdeg
2019-03-08T21:37:47.150Z,1552081067.150 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:47.151Z,1552081067.151 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:47.554Z,1552081067.554 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:47.554Z,1552081067.554 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:47.958Z,1552081067.958 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:47.958Z,1552081067.958 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:48.363Z,1552081068.363 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:48.363Z,1552081068.363 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:48.766Z,1552081068.766 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:48.766Z,1552081068.766 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:49.174Z,1552081069.174 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:49.174Z,1552081069.174 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:49.578Z,1552081069.578 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:49.578Z,1552081069.578 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:49.980Z,1552081069.980 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:49.980Z,1552081069.980 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:50.039Z,1552081070.039 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:37:50.039Z,1552081070.039 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:37:50.039Z,1552081070.039 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:37:50.040Z,1552081070.040 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:37:50.040Z,1552081070.040 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:37:50.040Z,1552081070.040 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:37:50.040Z,1552081070.040 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:37:50.040Z,1552081070.040 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:37:50.040Z,1552081070.040 [DUSBL:RequestRepeater](INFO): Running loop #5
2019-03-08T21:37:50.049Z,1552081070.049 [DUSBL:RequestRepeater] Running Loop=5
2019-03-08T21:37:50.049Z,1552081070.049 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:37:50.049Z,1552081070.049 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:37:50.049Z,1552081070.049 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:37:50.050Z,1552081070.050 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:37:50.050Z,1552081070.050 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:37:50.382Z,1552081070.382 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:50.382Z,1552081070.382 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:50.382Z,1552081070.382 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:50.382Z,1552081070.382 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:50.383Z,1552081070.383 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:50.383Z,1552081070.383 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:50.384Z,1552081070.384 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:50.384Z,1552081070.384 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:50.384Z,1552081070.384 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:50.788Z,1552081070.788 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:50.788Z,1552081070.788 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:50.853Z,1552081070.853 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:37:50.854Z,1552081070.854 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.500000 arcdeg
2019-03-08T21:37:51.190Z,1552081071.190 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:51.190Z,1552081071.190 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:51.594Z,1552081071.594 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:51.594Z,1552081071.594 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:51.000Z,1552081072.000 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:52.000Z,1552081072.000 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:52.402Z,1552081072.402 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:52.402Z,1552081072.402 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:52.806Z,1552081072.806 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:52.806Z,1552081072.806 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:53.212Z,1552081073.212 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:53.212Z,1552081073.212 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:53.614Z,1552081073.614 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:53.614Z,1552081073.614 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:54.024Z,1552081074.024 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:54.024Z,1552081074.024 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:54.426Z,1552081074.426 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:54.426Z,1552081074.426 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:54.426Z,1552081074.426 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:54.427Z,1552081074.427 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:54.427Z,1552081074.427 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:54.430Z,1552081074.430 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:54.431Z,1552081074.431 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:54.432Z,1552081074.432 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:54.432Z,1552081074.432 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:54.828Z,1552081074.828 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:54.828Z,1552081074.828 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:54.898Z,1552081074.898 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:37:54.899Z,1552081074.899 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.650000 arcdeg
2019-03-08T21:37:55.230Z,1552081075.230 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:55.230Z,1552081075.230 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:55.634Z,1552081075.634 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:55.634Z,1552081075.634 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:56.042Z,1552081076.042 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:56.042Z,1552081076.042 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:56.442Z,1552081076.442 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:56.442Z,1552081076.442 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:56.846Z,1552081076.846 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:56.846Z,1552081076.846 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:57.250Z,1552081077.250 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:57.250Z,1552081077.250 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:57.654Z,1552081077.654 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:57.654Z,1552081077.654 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:58.058Z,1552081078.058 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:58.058Z,1552081078.058 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:58.462Z,1552081078.462 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:58.462Z,1552081078.462 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:58.462Z,1552081078.462 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:37:58.462Z,1552081078.462 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:37:58.463Z,1552081078.463 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:37:58.468Z,1552081078.468 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:37:58.468Z,1552081078.468 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:58.468Z,1552081078.468 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:58.468Z,1552081078.468 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:37:58.868Z,1552081078.868 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:58.868Z,1552081078.868 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:58.905Z,1552081078.905 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:37:58.906Z,1552081078.906 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.350000 arcdeg
2019-03-08T21:37:59.270Z,1552081079.270 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:59.270Z,1552081079.270 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:37:59.674Z,1552081079.674 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:37:59.674Z,1552081079.674 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:00.078Z,1552081080.078 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:00.078Z,1552081080.078 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:00.486Z,1552081080.486 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:00.486Z,1552081080.486 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:00.530Z,1552081080.530 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:38:00.530Z,1552081080.530 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:38:00.530Z,1552081080.530 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater](INFO): Running loop #6
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater] Running Loop=6
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:38:00.531Z,1552081080.531 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:38:00.532Z,1552081080.532 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:38:00.532Z,1552081080.532 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:38:00.532Z,1552081080.532 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:38:00.886Z,1552081080.886 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:00.886Z,1552081080.886 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:01.290Z,1552081081.290 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:01.290Z,1552081081.290 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:01.694Z,1552081081.694 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:01.694Z,1552081081.694 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:02.098Z,1552081082.098 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:02.098Z,1552081082.098 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:02.502Z,1552081082.502 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:02.502Z,1552081082.502 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:02.502Z,1552081082.502 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:02.502Z,1552081082.502 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:02.503Z,1552081082.503 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:02.505Z,1552081082.505 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:02.507Z,1552081082.507 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:02.508Z,1552081082.508 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:02.508Z,1552081082.508 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:02.908Z,1552081082.908 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:02.908Z,1552081082.908 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:02.950Z,1552081082.950 [Reporter](INFO): DUSBL_Hydroid.range -74982.421875 m
2019-03-08T21:38:02.951Z,1552081082.951 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.550000 arcdeg
2019-03-08T21:38:03.310Z,1552081083.310 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:03.310Z,1552081083.310 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:03.714Z,1552081083.714 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:03.714Z,1552081083.714 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:04.118Z,1552081084.118 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:04.118Z,1552081084.118 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:04.522Z,1552081084.522 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:04.522Z,1552081084.522 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:04.926Z,1552081084.926 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:04.926Z,1552081084.926 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:05.330Z,1552081085.330 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:05.330Z,1552081085.330 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:05.734Z,1552081085.734 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:05.734Z,1552081085.734 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:06.138Z,1552081086.138 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:06.138Z,1552081086.138 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:06.546Z,1552081086.546 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:06.546Z,1552081086.546 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:06.547Z,1552081086.547 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:06.547Z,1552081086.547 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:06.548Z,1552081086.548 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:06.550Z,1552081086.550 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:06.552Z,1552081086.552 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:06.552Z,1552081086.552 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:06.552Z,1552081086.552 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:06.954Z,1552081086.954 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:06.954Z,1552081086.954 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:07.005Z,1552081087.005 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:38:07.006Z,1552081087.006 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.400000 arcdeg
2019-03-08T21:38:07.358Z,1552081087.358 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:07.358Z,1552081087.358 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:07.754Z,1552081087.754 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:07.754Z,1552081087.754 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:08.166Z,1552081088.166 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:08.166Z,1552081088.166 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:08.562Z,1552081088.562 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:08.562Z,1552081088.562 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:08.971Z,1552081088.971 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:08.971Z,1552081088.971 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:09.370Z,1552081089.370 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:09.370Z,1552081089.370 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:09.774Z,1552081089.774 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:09.774Z,1552081089.774 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:10.180Z,1552081090.180 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:10.180Z,1552081090.180 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:10.582Z,1552081090.582 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:10.582Z,1552081090.582 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:10.582Z,1552081090.582 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:10.582Z,1552081090.582 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:10.583Z,1552081090.583 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:10.588Z,1552081090.588 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:10.588Z,1552081090.588 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:10.588Z,1552081090.588 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:10.588Z,1552081090.588 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:10.987Z,1552081090.987 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:10.988Z,1552081090.988 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:11.042Z,1552081091.042 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:38:11.043Z,1552081091.043 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:38:11.043Z,1552081091.043 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:38:11.043Z,1552081091.043 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:38:11.043Z,1552081091.043 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:38:11.043Z,1552081091.043 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:38:11.043Z,1552081091.043 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:38:11.044Z,1552081091.044 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:38:11.044Z,1552081091.044 [DUSBL:RequestRepeater](INFO): Running loop #7
2019-03-08T21:38:11.044Z,1552081091.044 [DUSBL:RequestRepeater] Running Loop=7
2019-03-08T21:38:11.044Z,1552081091.044 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:38:11.044Z,1552081091.044 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:38:11.044Z,1552081091.044 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:38:11.044Z,1552081091.044 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:38:11.044Z,1552081091.044 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:38:11.070Z,1552081091.070 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:38:11.071Z,1552081091.071 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.650000 arcdeg
2019-03-08T21:38:11.398Z,1552081091.398 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:11.399Z,1552081091.399 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:11.794Z,1552081091.794 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:11.794Z,1552081091.794 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:12.198Z,1552081092.198 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:12.198Z,1552081092.198 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:12.607Z,1552081092.607 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:12.607Z,1552081092.607 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:13.016Z,1552081093.016 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:13.017Z,1552081093.017 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:13.410Z,1552081093.410 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:13.410Z,1552081093.410 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:13.814Z,1552081093.814 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:13.814Z,1552081093.814 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:14.218Z,1552081094.218 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:14.218Z,1552081094.218 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:14.618Z,1552081094.618 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:14.618Z,1552081094.618 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:14.619Z,1552081094.619 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:14.619Z,1552081094.619 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:14.619Z,1552081094.619 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:14.620Z,1552081094.620 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:14.620Z,1552081094.620 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:14.620Z,1552081094.620 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:14.620Z,1552081094.620 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:15.035Z,1552081095.035 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:15.036Z,1552081095.036 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:15.143Z,1552081095.143 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:38:15.143Z,1552081095.143 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.550000 arcdeg
2019-03-08T21:38:15.430Z,1552081095.430 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:15.430Z,1552081095.430 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:15.834Z,1552081095.834 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:15.834Z,1552081095.834 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:16.238Z,1552081096.238 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:16.238Z,1552081096.238 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:16.642Z,1552081096.642 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:16.642Z,1552081096.642 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:17.046Z,1552081097.046 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:17.046Z,1552081097.046 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:17.450Z,1552081097.450 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:17.450Z,1552081097.450 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:17.854Z,1552081097.854 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:17.854Z,1552081097.854 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:18.258Z,1552081098.258 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:18.258Z,1552081098.258 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:18.662Z,1552081098.662 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:18.662Z,1552081098.662 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:18.662Z,1552081098.662 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:18.663Z,1552081098.663 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:18.664Z,1552081098.664 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:18.666Z,1552081098.666 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:18.668Z,1552081098.668 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:18.668Z,1552081098.668 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:18.668Z,1552081098.668 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:19.068Z,1552081099.068 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:19.068Z,1552081099.068 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:19.113Z,1552081099.113 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:38:19.114Z,1552081099.114 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.250000 arcdeg
2019-03-08T21:38:19.470Z,1552081099.470 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:19.470Z,1552081099.470 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:19.878Z,1552081099.878 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:19.878Z,1552081099.878 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:20.278Z,1552081100.278 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:20.278Z,1552081100.278 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:20.686Z,1552081100.686 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:20.686Z,1552081100.686 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:21.086Z,1552081101.086 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:21.086Z,1552081101.086 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:21.490Z,1552081101.490 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:21.490Z,1552081101.490 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:21.520Z,1552081101.520 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:38:21.520Z,1552081101.520 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:38:21.520Z,1552081101.520 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:38:21.521Z,1552081101.521 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:38:21.521Z,1552081101.521 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:38:21.521Z,1552081101.521 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:38:21.521Z,1552081101.521 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:38:21.521Z,1552081101.521 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:38:21.522Z,1552081101.522 [DUSBL:RequestRepeater](INFO): Running loop #8
2019-03-08T21:38:21.522Z,1552081101.522 [DUSBL:RequestRepeater] Running Loop=8
2019-03-08T21:38:21.522Z,1552081101.522 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:38:21.522Z,1552081101.522 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:38:21.522Z,1552081101.522 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:38:21.522Z,1552081101.522 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:38:21.522Z,1552081101.522 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:38:21.894Z,1552081101.894 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:21.894Z,1552081101.894 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:22.302Z,1552081102.302 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:22.302Z,1552081102.302 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:22.702Z,1552081102.702 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:22.702Z,1552081102.702 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:22.702Z,1552081102.702 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:22.702Z,1552081102.702 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:22.703Z,1552081102.703 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:22.707Z,1552081102.707 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:22.708Z,1552081102.708 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:22.708Z,1552081102.708 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:22.709Z,1552081102.709 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:23.112Z,1552081103.112 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:23.112Z,1552081103.112 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:23.158Z,1552081103.158 [Reporter](INFO): DUSBL_Hydroid.range -74983.804688 m
2019-03-08T21:38:23.159Z,1552081103.159 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.650000 arcdeg
2019-03-08T21:38:23.516Z,1552081103.516 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:23.516Z,1552081103.516 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:23.914Z,1552081103.914 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:23.914Z,1552081103.914 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:24.318Z,1552081104.318 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:24.318Z,1552081104.318 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:24.726Z,1552081104.726 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:24.726Z,1552081104.726 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:25.126Z,1552081105.126 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:25.126Z,1552081105.126 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:25.530Z,1552081105.530 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:25.530Z,1552081105.530 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:25.934Z,1552081105.934 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:25.934Z,1552081105.934 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:26.342Z,1552081106.342 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:26.342Z,1552081106.342 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:26.747Z,1552081106.747 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:26.748Z,1552081106.748 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:26.748Z,1552081106.748 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:26.748Z,1552081106.748 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:26.749Z,1552081106.749 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:26.751Z,1552081106.751 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:26.753Z,1552081106.753 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:26.753Z,1552081106.753 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:26.754Z,1552081106.754 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:27.152Z,1552081107.152 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:27.152Z,1552081107.152 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:27.228Z,1552081107.228 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:38:27.237Z,1552081107.237 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.650000 arcdeg
2019-03-08T21:38:27.551Z,1552081107.551 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:27.551Z,1552081107.551 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:27.954Z,1552081107.954 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:27.954Z,1552081107.954 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:28.358Z,1552081108.358 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:28.358Z,1552081108.358 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:28.762Z,1552081108.762 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:28.762Z,1552081108.762 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:29.166Z,1552081109.166 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:29.166Z,1552081109.166 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:29.574Z,1552081109.574 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:29.574Z,1552081109.574 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:29.974Z,1552081109.974 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:29.974Z,1552081109.974 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:30.383Z,1552081110.383 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:30.383Z,1552081110.383 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:30.786Z,1552081110.786 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:30.786Z,1552081110.786 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:30.786Z,1552081110.786 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:30.787Z,1552081110.787 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:30.787Z,1552081110.787 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:30.789Z,1552081110.789 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:30.791Z,1552081110.791 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:30.792Z,1552081110.792 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:30.792Z,1552081110.792 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:31.188Z,1552081111.188 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:31.188Z,1552081111.188 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:31.274Z,1552081111.274 [Reporter](INFO): DUSBL_Hydroid.range -74982.421875 m
2019-03-08T21:38:31.275Z,1552081111.275 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.750000 arcdeg
2019-03-08T21:38:31.590Z,1552081111.590 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:31.590Z,1552081111.590 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:31.996Z,1552081111.996 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:31.996Z,1552081111.996 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:32.039Z,1552081112.039 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:38:32.039Z,1552081112.039 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:38:32.039Z,1552081112.039 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:38:32.040Z,1552081112.040 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:38:32.040Z,1552081112.040 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:38:32.040Z,1552081112.040 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:38:32.040Z,1552081112.040 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:38:32.040Z,1552081112.040 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:38:32.041Z,1552081112.041 [DUSBL:RequestRepeater](INFO): Running loop #9
2019-03-08T21:38:32.041Z,1552081112.041 [DUSBL:RequestRepeater] Running Loop=9
2019-03-08T21:38:32.041Z,1552081112.041 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:38:32.041Z,1552081112.041 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:38:32.041Z,1552081112.041 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:38:32.041Z,1552081112.041 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:38:32.041Z,1552081112.041 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:38:32.398Z,1552081112.398 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:32.398Z,1552081112.398 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:32.802Z,1552081112.802 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:32.802Z,1552081112.802 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:33.210Z,1552081113.210 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:33.210Z,1552081113.210 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:33.610Z,1552081113.610 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:33.610Z,1552081113.610 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:34.020Z,1552081114.020 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:34.021Z,1552081114.021 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:34.422Z,1552081114.422 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:34.422Z,1552081114.422 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:34.822Z,1552081114.822 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:34.822Z,1552081114.822 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:34.822Z,1552081114.822 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:34.823Z,1552081114.823 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:34.823Z,1552081114.823 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:34.828Z,1552081114.828 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:34.828Z,1552081114.828 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:34.828Z,1552081114.828 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:34.829Z,1552081114.829 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:35.227Z,1552081115.227 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:35.228Z,1552081115.228 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:35.297Z,1552081115.297 [Reporter](INFO): DUSBL_Hydroid.range -74983.804688 m
2019-03-08T21:38:35.297Z,1552081115.297 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.600000 arcdeg
2019-03-08T21:38:35.634Z,1552081115.634 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:35.634Z,1552081115.634 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:36.038Z,1552081116.038 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:36.038Z,1552081116.038 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:36.438Z,1552081116.438 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:36.438Z,1552081116.438 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:36.846Z,1552081116.846 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:36.846Z,1552081116.846 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:37.246Z,1552081117.246 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:37.246Z,1552081117.246 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:37.654Z,1552081117.654 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:37.654Z,1552081117.654 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:38.054Z,1552081118.054 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:38.054Z,1552081118.054 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:38.458Z,1552081118.458 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:38.458Z,1552081118.458 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:38.862Z,1552081118.862 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:38.862Z,1552081118.862 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:38.862Z,1552081118.862 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:38.863Z,1552081118.863 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:38.863Z,1552081118.863 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:38.866Z,1552081118.866 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:38.867Z,1552081118.867 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:38.868Z,1552081118.868 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:38.868Z,1552081118.868 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:39.276Z,1552081119.276 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:39.276Z,1552081119.276 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:39.326Z,1552081119.326 [Reporter](INFO): DUSBL_Hydroid.range -74983.804688 m
2019-03-08T21:38:39.327Z,1552081119.327 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.500000 arcdeg
2019-03-08T21:38:39.670Z,1552081119.670 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:39.670Z,1552081119.670 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:40.078Z,1552081120.078 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:40.078Z,1552081120.078 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:40.486Z,1552081120.486 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:40.486Z,1552081120.486 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:40.886Z,1552081120.886 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:40.886Z,1552081120.886 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:41.286Z,1552081121.286 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:41.286Z,1552081121.286 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:41.690Z,1552081121.690 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:41.690Z,1552081121.690 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:42.094Z,1552081122.094 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:42.094Z,1552081122.094 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:42.498Z,1552081122.498 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:42.498Z,1552081122.498 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:42.528Z,1552081122.528 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:38:42.528Z,1552081122.528 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:38:42.528Z,1552081122.528 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:38:42.529Z,1552081122.529 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:38:42.529Z,1552081122.529 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:38:42.529Z,1552081122.529 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:38:42.529Z,1552081122.529 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:38:42.529Z,1552081122.529 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:38:42.529Z,1552081122.529 [DUSBL:RequestRepeater](INFO): Running loop #10
2019-03-08T21:38:42.530Z,1552081122.530 [DUSBL:RequestRepeater] Running Loop=10
2019-03-08T21:38:42.530Z,1552081122.530 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-08T21:38:42.530Z,1552081122.530 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-08T21:38:42.530Z,1552081122.530 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-08T21:38:42.530Z,1552081122.530 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-08T21:38:42.530Z,1552081122.530 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:38:42.902Z,1552081122.902 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:42.902Z,1552081122.902 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:42.902Z,1552081122.902 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:42.903Z,1552081122.903 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:42.903Z,1552081122.903 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:42.903Z,1552081122.903 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:42.904Z,1552081122.904 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:42.904Z,1552081122.904 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:42.904Z,1552081122.904 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:43.312Z,1552081123.312 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:43.312Z,1552081123.312 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:43.362Z,1552081123.362 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:38:43.363Z,1552081123.363 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.550000 arcdeg
2019-03-08T21:38:43.710Z,1552081123.710 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:43.710Z,1552081123.710 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:44.114Z,1552081124.114 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:44.114Z,1552081124.114 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:44.518Z,1552081124.518 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:44.518Z,1552081124.518 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:44.922Z,1552081124.922 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:44.922Z,1552081124.922 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:45.326Z,1552081125.326 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:45.326Z,1552081125.326 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:45.731Z,1552081125.731 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:45.731Z,1552081125.731 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:46.134Z,1552081126.134 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:46.134Z,1552081126.134 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:46.542Z,1552081126.542 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:46.542Z,1552081126.542 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:46.946Z,1552081126.946 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:46.946Z,1552081126.946 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:46.946Z,1552081126.946 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:46.947Z,1552081126.947 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:46.947Z,1552081126.947 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:46.952Z,1552081126.952 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:46.952Z,1552081126.952 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:46.952Z,1552081126.952 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:46.953Z,1552081126.953 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:47.354Z,1552081127.354 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:47.354Z,1552081127.354 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:47.406Z,1552081127.406 [Reporter](INFO): DUSBL_Hydroid.range -74983.734375 m
2019-03-08T21:38:47.407Z,1552081127.407 [Reporter](INFO): DUSBL_Hydroid.xAngle -2.500000 arcdeg
2019-03-08T21:38:47.754Z,1552081127.754 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:47.755Z,1552081127.755 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:48.154Z,1552081128.154 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:48.154Z,1552081128.154 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:48.562Z,1552081128.562 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:48.562Z,1552081128.562 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:48.962Z,1552081128.962 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:48.962Z,1552081128.962 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:49.366Z,1552081129.366 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:49.366Z,1552081129.366 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:49.770Z,1552081129.770 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:49.770Z,1552081129.770 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:50.174Z,1552081130.174 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:50.174Z,1552081130.174 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:50.579Z,1552081130.579 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:50.580Z,1552081130.580 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:50.982Z,1552081130.982 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:50.982Z,1552081130.982 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:50.982Z,1552081130.982 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-03-08T21:38:50.982Z,1552081130.982 [DUSBL_Hydroid](DEBUG): Arming DUSBL
2019-03-08T21:38:50.983Z,1552081130.983 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-08T21:38:50.983Z,1552081130.983 [Micromodem](INFO): **** IS COMMANDED  IN Runnable **** 
2019-03-08T21:38:50.984Z,1552081130.984 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:50.984Z,1552081130.984 [Micromodem](IMPORTANT): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:50.984Z,1552081130.984 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,0,0,0,0,1000,0*54

2019-03-08T21:38:51.388Z,1552081131.388 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:51.388Z,1552081131.388 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:51.459Z,1552081131.459 [Reporter](INFO): DUSBL_Hydroid.range -74982.421875 m
2019-03-08T21:38:51.460Z,1552081131.460 [Reporter](INFO): DUSBL_Hydroid.xAngle -1.850000 arcdeg
2019-03-08T21:38:51.790Z,1552081131.790 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:51.790Z,1552081131.790 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:52.194Z,1552081132.194 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:52.194Z,1552081132.194 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:52.598Z,1552081132.598 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:52.598Z,1552081132.598 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:53.008Z,1552081133.008 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-03-08T21:38:53.008Z,1552081133.008 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-03-08T21:38:53.062Z,1552081133.062 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-08T21:38:53.062Z,1552081133.062 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-08T21:38:53.062Z,1552081133.062 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:38:53.062Z,1552081133.062 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-08T21:38:53.063Z,1552081133.063 [DUSBL:RequestRepeater] Stopped
2019-03-08T21:38:53.063Z,1552081133.063 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-08T21:38:53.063Z,1552081133.063 [DUSBL:RequestRepeater:A] Stopped
2019-03-08T21:38:53.063Z,1552081133.063 [DUSBL:RequestRepeater:B] Stopped
2019-03-08T21:38:53.063Z,1552081133.063 [DUSBL](INFO): Completed DUSBL
2019-03-08T21:38:53.064Z,1552081133.064 [MissionManager](INFO): DUSBL is completed.
2019-03-08T21:38:53.064Z,1552081133.064 [MissionManager](INFO): Uninitializing Mission DUSBL
2019-03-08T21:38:53.064Z,1552081133.064 [DUSBL] Stopped
2019-03-08T21:38:53.064Z,1552081133.064 [DUSBL](DEBUG): Aggregate::uninitialize DUSBL
2019-03-08T21:38:53.064Z,1552081133.064 [DUSBL:A.Pitch] Stopped
2019-03-08T21:38:53.064Z,1552081133.064 [DUSBL:B.SetSpeed] Stopped
2019-03-08T21:38:53.064Z,1552081133.064 [DUSBL:B.SetSpeed](DEBUG): Uninitialize.
2019-03-08T21:38:53.064Z,1552081133.064 [DUSBL:C] Stopped
2019-03-08T21:38:53.436Z,1552081133.436 [MissionManager](IMPORTANT): Started mission Default
2019-03-08T21:38:53.436Z,1552081133.436 [Default] Running Loop=1
2019-03-08T21:38:53.436Z,1552081133.436 [Default](DEBUG): Aggregate::initialize Default
2019-03-08T21:38:53.436Z,1552081133.436 [Default:B.GoToSurface] Running Loop=1
2019-03-08T21:38:53.436Z,1552081133.436 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-08T21:38:53.437Z,1552081133.437 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-08T21:38:53.437Z,1552081133.437 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-08T21:38:53.437Z,1552081133.437 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-08T21:38:53.438Z,1552081133.438 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-08T21:38:53.438Z,1552081133.438 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-08T21:38:53.438Z,1552081133.438 [Default:A.Wait] Running Loop=1
2019-03-08T21:38:53.438Z,1552081133.438 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-08T21:39:06.763Z,1552081146.763 [Default:A.Wait](INFO): Done Waiting.
2019-03-08T21:39:06.763Z,1552081146.763 [Default:A.Wait] Stopped
2019-03-08T21:39:06.763Z,1552081146.763 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-08T21:39:07.175Z,1552081147.175 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:39:07.175Z,1552081147.175 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-03-08T21:39:07.175Z,1552081147.175 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-08T21:39:07.177Z,1552081147.177 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:39:07.177Z,1552081147.177 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-03-08T21:39:07.177Z,1552081147.177 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-08T21:39:07.179Z,1552081147.179 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-08T21:39:07.179Z,1552081147.179 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2019-03-08T21:39:07.179Z,1552081147.179 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-08T21:39:07.182Z,1552081147.182 [Default:CheckIn] Running Loop=1
2019-03-08T21:39:07.182Z,1552081147.182 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-08T21:39:07.182Z,1552081147.182 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-08T21:39:07.191Z,1552081147.191 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-08T21:39:07.191Z,1552081147.191 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-08T21:39:07.191Z,1552081147.191 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-08T21:39:07.581Z,1552081147.581 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-08T21:39:07.581Z,1552081147.581 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-03-08T21:39:07.582Z,1552081147.582 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-08T21:39:07.582Z,1552081147.582 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-03-08T21:39:07.582Z,1552081147.582 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-08T21:39:07.583Z,1552081147.583 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2019-03-08T21:39:07.947Z,1552081147.947 [NAL9602](INFO): Powering up
2019-03-08T21:39:07.981Z,1552081147.981 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-08T21:39:13.831Z,1552081153.831 [CommandLine](IMPORTANT): got command show variable DUSBL
2019-03-08T21:39:13.867Z,1552081153.867 [CommandLine](IMPORTANT): DUSBL_Hydroid.loadAtStartup (bool)
2019-03-08T21:39:13.867Z,1552081153.867 [CommandLine](IMPORTANT): DUSBL_Hydroid.simulateHardware (bool)
2019-03-08T21:39:13.868Z,1552081153.868 [CommandLine](IMPORTANT): DUSBL_Hydroid.defaultTurnAroundTime (meter_per_second)
2019-03-08T21:39:13.868Z,1552081153.868 [CommandLine](IMPORTANT): DUSBL_Hydroid.defaultSoundSpeed (meter_per_second)
2019-03-08T21:39:13.868Z,1552081153.868 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold (count)
2019-03-08T21:39:13.869Z,1552081153.869 [CommandLine](IMPORTANT): DUSBL_Hydroid.recieveTimeout (millisecond)
2019-03-08T21:39:13.869Z,1552081153.869 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout (millisecond)
2019-03-08T21:39:13.869Z,1552081153.869 [CommandLine](IMPORTANT): DUSBL_Hydroid.transponderCode (enum)
2019-03-08T21:39:13.870Z,1552081153.870 [CommandLine](IMPORTANT): DUSBL_Hydroid.numberOfPingsRequested (count)
2019-03-08T21:39:13.870Z,1552081153.870 [CommandLine](IMPORTANT): DUSBL_Hydroid.verbosity (enum)
2019-03-08T21:39:13.871Z,1552081153.871 [CommandLine](IMPORTANT): DUSBL_Hydroid.xCenter (angular_degree)
2019-03-08T21:39:13.871Z,1552081153.871 [CommandLine](IMPORTANT): DUSBL_Hydroid.yCenter (angular_degree)
2019-03-08T21:39:13.882Z,1552081153.882 [CommandLine](IMPORTANT): DUSBL_Hydroid.loadControl (none)
2019-03-08T21:39:13.882Z,1552081153.882 [CommandLine](IMPORTANT): DUSBL_Hydroid.uart (none)
2019-03-08T21:39:13.883Z,1552081153.883 [CommandLine](IMPORTANT): DUSBL_Hydroid.baud (bit_per_second)
2019-03-08T21:39:13.918Z,1552081153.918 [CommandLine](IMPORTANT): Micromodem.dusblPingCode (enum)
2019-03-08T21:39:13.919Z,1552081153.919 [CommandLine](IMPORTANT): DUSBL_Hydroid.xAngle (angular_degree)
2019-03-08T21:39:13.919Z,1552081153.919 [CommandLine](IMPORTANT): DUSBL_Hydroid.yAngle (angular_degree)
2019-03-08T21:39:13.919Z,1552081153.919 [CommandLine](IMPORTANT): DUSBL_Hydroid.travelTime (microsecond)
2019-03-08T21:39:13.920Z,1552081153.920 [CommandLine](IMPORTANT): DUSBL_Hydroid.latency (microsecond)
2019-03-08T21:39:13.920Z,1552081153.920 [CommandLine](IMPORTANT): DUSBL_Hydroid.gain (ratio)
2019-03-08T21:39:13.920Z,1552081153.920 [CommandLine](IMPORTANT): DUSBL_Hydroid.inBandSignalToNoise (ratio)
2019-03-08T21:39:13.921Z,1552081153.921 [CommandLine](IMPORTANT): DUSBL_Hydroid.outBandSignalToNoise (ratio)
2019-03-08T21:39:13.921Z,1552081153.921 [CommandLine](IMPORTANT): DUSBL_Hydroid.range (meter)
2019-03-08T21:39:13.922Z,1552081153.922 [CommandLine](IMPORTANT): DUSBL_Hydroid.direction (none)
2019-03-08T21:39:13.972Z,1552081153.972 [CommandLine](IMPORTANT): DUSBL_Hydroid.component_voltage (volt)
2019-03-08T21:39:13.973Z,1552081153.973 [CommandLine](IMPORTANT): DUSBL_Hydroid.component_avgVoltage (volt)
2019-03-08T21:39:13.973Z,1552081153.973 [CommandLine](IMPORTANT): DUSBL_Hydroid.component_current (milliampere)
2019-03-08T21:39:13.974Z,1552081153.974 [CommandLine](IMPORTANT): DUSBL_Hydroid.component_avgCurrent (milliampere)
2019-03-08T21:39:18.863Z,1552081158.863 [NAL9602](INFO): NAL9602 initialized
2019-03-08T21:39:19.685Z,1552081159.685 [NAL9602](DEBUG): Fix Requested
2019-03-08T21:39:31.973Z,1552081171.973 [CommandLine](IMPORTANT): got command get DUSBL_Hydroid.transmitLockout
2019-03-08T21:39:31.974Z,1552081171.974 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout 20.000000 ms
2019-03-08T21:39:50.775Z,1552081190.775 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-03-08T21:39:50.861Z,1552081190.861 [NAL9602](FAULT): received: 
+CSQ:0

OK
2019-03-08T21:39:50.861Z,1552081190.861 [NAL9602] Data Fault, FailCount= 1
2019-03-08T21:39:50.861Z,1552081190.861 [NAL9602](ERROR): Data Fault
2019-03-08T21:39:50.910Z,1552081190.910 [CBIT](ERROR): Data Fault in component: NAL9602
2019-03-08T21:39:51.180Z,1552081191.180 [NAL9602](INFO): Powering down
2019-03-08T21:39:52.045Z,1552081192.045 [CBIT](INFO): Clearing failed state for component NAL9602
2019-03-08T21:39:52.045Z,1552081192.045 [NAL9602] No Fault, FailCount= 1
2019-03-08T21:40:21.480Z,1552081221.480 [NAL9602](INFO): Powering up NAL9602
2019-03-08T21:40:32.387Z,1552081232.387 [NAL9602](INFO): NAL9602 initialized
2019-03-08T21:40:33.213Z,1552081233.213 [NAL9602](DEBUG): Fix Requested
2019-03-08T21:40:40.020Z,1552081240.020 [CommandLine](IMPORTANT): got command configSet DUSBL_Hydroid.transmitLockout 45.000000 millisecond persist
2019-03-08T21:40:42.770Z,1552081242.770 [CommandLine](IMPORTANT): got command restart application
2019-03-08T21:40:43.777Z,1552081243.777 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2019-03-08T21:40:43.777Z,1552081243.777 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-08T21:40:43.777Z,1552081243.777 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:43.877Z,1552081243.877 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-03-08T21:40:43.877Z,1552081243.877 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:43.878Z,1552081243.878 [CommandLine](INFO): Join timeout helper Thread ID is 6430
2019-03-08T21:40:43.878Z,1552081243.878 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-03-08T21:40:43.878Z,1552081243.878 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:43.879Z,1552081243.879 [NavChartDb](INFO): Join timeout helper Thread ID is 6431
2019-03-08T21:40:44.269Z,1552081244.269 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-08T21:40:44.269Z,1552081244.269 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.285Z,1552081244.285 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2019-03-08T21:40:44.285Z,1552081244.285 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.285Z,1552081244.285 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 6432
2019-03-08T21:40:44.309Z,1552081244.309 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-08T21:40:44.309Z,1552081244.309 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-03-08T21:40:44.310Z,1552081244.310 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.325Z,1552081244.325 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-03-08T21:40:44.325Z,1552081244.325 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.325Z,1552081244.325 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 6433
2019-03-08T21:40:44.369Z,1552081244.369 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-08T21:40:44.369Z,1552081244.369 [CTD_NeilBrown](INFO): Powering down
2019-03-08T21:40:44.381Z,1552081244.381 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.385Z,1552081244.385 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-03-08T21:40:44.385Z,1552081244.385 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.385Z,1552081244.385 [Radio_Surface](INFO): Join timeout helper Thread ID is 6434
2019-03-08T21:40:44.681Z,1552081244.681 [Radio_Surface](INFO): Powering down
2019-03-08T21:40:44.682Z,1552081244.682 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-08T21:40:44.682Z,1552081244.682 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.694Z,1552081244.694 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-03-08T21:40:44.694Z,1552081244.694 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.694Z,1552081244.694 [DataOverHttps](INFO): Join timeout helper Thread ID is 6435
2019-03-08T21:40:44.701Z,1552081244.701 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-08T21:40:44.701Z,1552081244.701 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.714Z,1552081244.714 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-03-08T21:40:44.714Z,1552081244.714 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.714Z,1552081244.714 [logger](INFO): Join timeout helper Thread ID is 6436
2019-03-08T21:40:44.761Z,1552081244.761 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-08T21:40:44.761Z,1552081244.761 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.774Z,1552081244.774 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-03-08T21:40:44.774Z,1552081244.774 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.774Z,1552081244.774 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-03-08T21:40:44.774Z,1552081244.774 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:44.774Z,1552081244.774 [controlThread](INFO): Join timeout helper Thread ID is 6437
2019-03-08T21:40:44.901Z,1552081244.901 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-08T21:40:44.901Z,1552081244.901 [controlThread](DEBUG): Uninitializing ControlThread
2019-03-08T21:40:44.902Z,1552081244.902 [DUSBL_Hydroid](INFO): Powering down
2019-03-08T21:40:44.973Z,1552081244.973 [Micromodem](INFO): uninitialize
2019-03-08T21:40:44.973Z,1552081244.973 [Micromodem](INFO): Powering down
2019-03-08T21:40:45.069Z,1552081245.069 [NAL9602](INFO): Powering down
2019-03-08T21:40:45.141Z,1552081245.141 [RDI_Pathfinder](INFO): Powering down
2019-03-08T21:40:45.142Z,1552081245.142 [RDI_PathfinderUp](INFO): Powering down
2019-03-08T21:40:45.143Z,1552081245.143 [Aanderaa_O2](INFO): Powering down
2019-03-08T21:40:45.144Z,1552081245.144 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-03-08T21:40:45.145Z,1552081245.145 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-03-08T21:40:45.146Z,1552081245.146 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-03-08T21:40:45.146Z,1552081245.146 [MissionManager](INFO): Uninitializing Mission Default
2019-03-08T21:40:45.146Z,1552081245.146 [Default] Stopped
2019-03-08T21:40:45.146Z,1552081245.146 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-08T21:40:45.146Z,1552081245.146 [Default:B.GoToSurface] Stopped
2019-03-08T21:40:45.147Z,1552081245.147 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-08T21:40:45.147Z,1552081245.147 [Default:CheckIn] Stopped
2019-03-08T21:40:45.147Z,1552081245.147 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-08T21:40:45.147Z,1552081245.147 [Default:CheckIn:Read_GPS] Stopped
2019-03-08T21:40:45.149Z,1552081245.149 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-03-08T21:40:45.149Z,1552081245.149 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-03-08T21:40:45.150Z,1552081245.150 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-03-08T21:40:45.150Z,1552081245.150 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-03-08T21:40:45.150Z,1552081245.150 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-08T21:40:45.150Z,1552081245.150 [BuoyancyServo](INFO): Powering down
2019-03-08T21:40:45.165Z,1552081245.165 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-08T21:40:45.165Z,1552081245.165 [ElevatorServo](INFO): Powering down
2019-03-08T21:40:45.166Z,1552081245.166 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-08T21:40:45.166Z,1552081245.166 [MassServo](INFO): Powering down
2019-03-08T21:40:45.167Z,1552081245.167 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-08T21:40:45.167Z,1552081245.167 [RudderServo](INFO): Powering down
2019-03-08T21:40:45.168Z,1552081245.168 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-03-08T21:40:45.168Z,1552081245.168 [ThrusterServo](INFO): Powering down
2019-03-08T21:40:45.169Z,1552081245.169 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-03-08T21:40:45.169Z,1552081245.169 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-03-08T21:40:45.169Z,1552081245.169 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-03-08T21:40:45.169Z,1552081245.169 [CBIT](DEBUG): Powering off loads.
2019-03-08T21:40:45.181Z,1552081245.181 [CBIT](DEBUG): Disabling WDT.
2019-03-08T21:40:45.193Z,1552081245.193 [CBIT](DEBUG): Opening all GF detection circuits.
2019-03-08T21:40:45.194Z,1552081245.194 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:45.263Z,1552081245.263 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:45.272Z,1552081245.272 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:45.311Z,1552081245.311 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:45.313Z,1552081245.313 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:45.367Z,1552081245.367 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-08T21:40:45.435Z,1552081245.435 [logger ThreadHandler](INFO): Thread cancelled.