2019-03-06T21:40:38.701Z,1551908438.701 [Supervisor](DEBUG): Initializing supervisor.
2019-03-06T21:40:38.704Z,1551908438.704 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-03-06T21:40:38.704Z,1551908438.704 [SyncHandler](INFO): Protected caller Thread ID is 3097
2019-03-06T21:40:38.705Z,1551908438.705 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-03-06T21:40:38.706Z,1551908438.706 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-03-06T21:40:38.707Z,1551908438.707 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3098
2019-03-06T21:40:38.710Z,1551908438.710 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-03-06T21:40:38.721Z,1551908438.721 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-03-06T21:40:38.722Z,1551908438.722 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-03-06T21:40:38.723Z,1551908438.723 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3099
2019-03-06T21:40:38.724Z,1551908438.724 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-03-06T21:40:38.724Z,1551908438.724 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-03-06T21:40:38.725Z,1551908438.725 [logger ThreadHandler](INFO): Protected caller Thread ID is 3100
2019-03-06T21:40:38.727Z,1551908438.727 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-03-06T21:40:38.727Z,1551908438.727 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-03-06T21:40:38.729Z,1551908438.729 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-03-06T21:40:39.157Z,1551908439.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-03-06T21:40:39.158Z,1551908439.158 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-03-06T21:40:39.255Z,1551908439.255 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-03-06T21:40:39.255Z,1551908439.255 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-03-06T21:40:39.588Z,1551908439.588 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-03-06T21:40:39.588Z,1551908439.588 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-03-06T21:40:39.731Z,1551908439.731 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-03-06T21:40:39.732Z,1551908439.732 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-03-06T21:40:39.927Z,1551908439.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-03-06T21:40:39.927Z,1551908439.927 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-03-06T21:40:40.754Z,1551908440.754 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-03-06T21:40:40.754Z,1551908440.754 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-03-06T21:40:40.968Z,1551908440.968 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-03-06T21:40:40.969Z,1551908440.969 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-03-06T21:40:41.116Z,1551908441.116 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-03-06T21:40:41.116Z,1551908441.116 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-03-06T21:40:41.315Z,1551908441.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-03-06T21:40:41.316Z,1551908441.316 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-03-06T21:40:41.411Z,1551908441.411 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-03-06T21:40:41.411Z,1551908441.411 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-03-06T21:40:41.727Z,1551908441.727 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-03-06T21:40:41.727Z,1551908441.727 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-03-06T21:40:41.807Z,1551908441.807 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-03-06T21:40:41.909Z,1551908441.909 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-03-06T21:40:41.910Z,1551908441.910 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-03-06T21:40:42.413Z,1551908442.413 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-03-06T21:40:42.414Z,1551908442.414 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-03-06T21:40:42.813Z,1551908442.813 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-03-06T21:40:42.815Z,1551908442.815 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2019-03-06T21:40:42.816Z,1551908442.816 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2019-03-06T21:40:43.028Z,1551908443.028 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2019-03-06T21:40:43.129Z,1551908443.129 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2019-03-06T21:40:43.227Z,1551908443.227 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2019-03-06T21:40:43.455Z,1551908443.455 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-03-06T21:40:43.455Z,1551908443.455 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2019-03-06T21:40:43.539Z,1551908443.539 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2019-03-06T21:40:43.632Z,1551908443.632 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2019-03-06T21:40:43.730Z,1551908443.730 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2019-03-06T21:40:43.811Z,1551908443.811 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2019-03-06T21:40:43.920Z,1551908443.920 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2019-03-06T21:40:44.096Z,1551908444.096 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2019-03-06T21:40:44.230Z,1551908444.230 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2019-03-06T21:40:44.230Z,1551908444.230 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-03-06T21:40:44.233Z,1551908444.233 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-03-06T21:40:44.538Z,1551908444.538 [DataOverHttps] Loaded
2019-03-06T21:40:44.538Z,1551908444.538 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-03-06T21:40:44.539Z,1551908444.539 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4074D4E0
2019-03-06T21:40:44.539Z,1551908444.539 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3179
2019-03-06T21:40:44.577Z,1551908444.577 [Depth_Keller] Loaded
2019-03-06T21:40:44.577Z,1551908444.577 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-03-06T21:40:44.582Z,1551908444.582 [DropWeight] Loaded
2019-03-06T21:40:44.582Z,1551908444.582 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-03-06T21:40:44.629Z,1551908444.629 [DUSBL_Hydroid] Loaded
2019-03-06T21:40:44.629Z,1551908444.629 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2019-03-06T21:40:44.670Z,1551908444.670 [Micromodem] Loaded
2019-03-06T21:40:44.670Z,1551908444.670 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2019-03-06T21:40:44.764Z,1551908444.764 [NAL9602] Loaded
2019-03-06T21:40:44.764Z,1551908444.764 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-03-06T21:40:44.779Z,1551908444.779 [Onboard] Loaded
2019-03-06T21:40:44.780Z,1551908444.780 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-03-06T21:40:44.786Z,1551908444.786 [Radio_Surface] Loaded
2019-03-06T21:40:44.786Z,1551908444.786 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-03-06T21:40:44.787Z,1551908444.787 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4077D4E0
2019-03-06T21:40:44.788Z,1551908444.788 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3180
2019-03-06T21:40:44.832Z,1551908444.832 [RDI_Pathfinder] Loaded
2019-03-06T21:40:44.832Z,1551908444.832 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2019-03-06T21:40:44.853Z,1551908444.853 [RDI_PathfinderUp] Loaded
2019-03-06T21:40:44.853Z,1551908444.853 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2019-03-06T21:40:46.600Z,1551908446.600 [BPC1] Loaded
2019-03-06T21:40:46.600Z,1551908446.600 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-03-06T21:40:46.601Z,1551908446.601 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-03-06T21:40:46.601Z,1551908446.601 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-03-06T21:40:46.669Z,1551908446.669 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-03-06T21:40:46.670Z,1551908446.670 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-03-06T21:40:47.173Z,1551908447.173 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-03-06T21:40:47.173Z,1551908447.173 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-03-06T21:40:47.446Z,1551908447.446 [DeadReckonUsingSpeedCalculator] Loaded
2019-03-06T21:40:47.446Z,1551908447.446 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-03-06T21:40:47.676Z,1551908447.676 [DeadReckonWithRespectToSeafloor] Loaded
2019-03-06T21:40:47.676Z,1551908447.676 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-03-06T21:40:47.696Z,1551908447.696 [NavChart] Loaded
2019-03-06T21:40:47.696Z,1551908447.696 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-03-06T21:40:47.700Z,1551908447.700 [UniversalFixResidualReporter] Loaded
2019-03-06T21:40:47.700Z,1551908447.700 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-03-06T21:40:47.701Z,1551908447.701 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-03-06T21:40:47.701Z,1551908447.701 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-03-06T21:40:47.874Z,1551908447.874 [BuoyancyServo] Loaded
2019-03-06T21:40:47.874Z,1551908447.874 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-03-06T21:40:47.890Z,1551908447.890 [ElevatorServo] Loaded
2019-03-06T21:40:47.890Z,1551908447.890 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-03-06T21:40:47.904Z,1551908447.904 [MassServo] Loaded
2019-03-06T21:40:47.904Z,1551908447.904 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-03-06T21:40:47.919Z,1551908447.919 [RudderServo] Loaded
2019-03-06T21:40:47.920Z,1551908447.920 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-03-06T21:40:47.934Z,1551908447.934 [ThrusterServo] Loaded
2019-03-06T21:40:47.934Z,1551908447.934 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-03-06T21:40:47.935Z,1551908447.935 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-03-06T21:40:47.935Z,1551908447.935 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-03-06T21:40:48.112Z,1551908448.112 [Aanderaa_O2] Loaded
2019-03-06T21:40:48.112Z,1551908448.112 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-03-06T21:40:48.196Z,1551908448.196 [CTD_NeilBrown] Loaded
2019-03-06T21:40:48.196Z,1551908448.196 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-03-06T21:40:48.197Z,1551908448.197 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408C24E0
2019-03-06T21:40:48.198Z,1551908448.198 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 3181
2019-03-06T21:40:48.241Z,1551908448.241 [WetLabsSeaOWL_UV_A] Loaded
2019-03-06T21:40:48.242Z,1551908448.242 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2019-03-06T21:40:48.243Z,1551908448.243 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408F24E0
2019-03-06T21:40:48.243Z,1551908448.243 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 3182
2019-03-06T21:40:48.244Z,1551908448.244 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-03-06T21:40:48.244Z,1551908448.244 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-03-06T21:40:48.476Z,1551908448.476 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-03-06T21:40:48.476Z,1551908448.476 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-03-06T21:40:48.516Z,1551908448.516 [DepthRateCalculator] Loaded
2019-03-06T21:40:48.516Z,1551908448.516 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-03-06T21:40:48.522Z,1551908448.522 [PitchRateCalculator] Loaded
2019-03-06T21:40:48.522Z,1551908448.522 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-03-06T21:40:48.534Z,1551908448.534 [SpeedCalculator] Loaded
2019-03-06T21:40:48.535Z,1551908448.535 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-03-06T21:40:48.555Z,1551908448.555 [TempGradientCalculator] Loaded
2019-03-06T21:40:48.555Z,1551908448.555 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-03-06T21:40:48.561Z,1551908448.561 [YawRateCalculator] Loaded
2019-03-06T21:40:48.562Z,1551908448.562 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-03-06T21:40:48.601Z,1551908448.601 [ElevatorOffsetCalculator] Loaded
2019-03-06T21:40:48.602Z,1551908448.602 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-03-06T21:40:48.602Z,1551908448.602 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-03-06T21:40:48.603Z,1551908448.603 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-03-06T21:40:48.733Z,1551908448.733 [SBIT](DEBUG): Construct Startup Built In Test.
2019-03-06T21:40:48.755Z,1551908448.755 [SBIT] Loaded
2019-03-06T21:40:48.756Z,1551908448.756 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-03-06T21:40:48.756Z,1551908448.756 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-03-06T21:40:48.768Z,1551908448.768 [IBIT] Loaded
2019-03-06T21:40:48.768Z,1551908448.768 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-03-06T21:40:48.771Z,1551908448.771 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-03-06T21:40:48.907Z,1551908448.907 [CBIT] Loaded
2019-03-06T21:40:48.907Z,1551908448.907 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-03-06T21:40:48.908Z,1551908448.908 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-03-06T21:40:48.908Z,1551908448.908 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-03-06T21:40:48.970Z,1551908448.970 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-03-06T21:40:48.970Z,1551908448.970 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-03-06T21:40:49.066Z,1551908449.066 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-03-06T21:40:49.066Z,1551908449.066 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-03-06T21:40:49.130Z,1551908449.130 [VerticalControl](DEBUG): Construct VerticalControl.
2019-03-06T21:40:49.213Z,1551908449.213 [VerticalControl] Loaded
2019-03-06T21:40:49.213Z,1551908449.213 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-03-06T21:40:49.214Z,1551908449.214 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-03-06T21:40:49.270Z,1551908449.270 [HorizontalControl] Loaded
2019-03-06T21:40:49.270Z,1551908449.270 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-03-06T21:40:49.271Z,1551908449.271 [SpeedControl](DEBUG): Construct SpeedControl.
2019-03-06T21:40:49.273Z,1551908449.273 [SpeedControl] Loaded
2019-03-06T21:40:49.273Z,1551908449.273 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-03-06T21:40:49.274Z,1551908449.274 [LoopControl](DEBUG): Construct LoopControl.
2019-03-06T21:40:49.274Z,1551908449.274 [LoopControl] Loaded
2019-03-06T21:40:49.275Z,1551908449.275 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-03-06T21:40:49.275Z,1551908449.275 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-03-06T21:40:49.276Z,1551908449.276 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-03-06T21:40:49.302Z,1551908449.302 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-03-06T21:40:49.306Z,1551908449.306 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-03-06T21:40:49.306Z,1551908449.306 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-03-06T21:40:49.313Z,1551908449.313 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-03-06T21:40:49.314Z,1551908449.314 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AB04E0
2019-03-06T21:40:49.315Z,1551908449.315 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3183
2019-03-06T21:40:49.319Z,1551908449.319 [Supervisor](INFO): Main Thread ID is 2972
2019-03-06T21:40:49.319Z,1551908449.319 [Supervisor](DEBUG): Running supervisor.
2019-03-06T21:40:49.320Z,1551908449.320 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3184
2019-03-06T21:40:49.322Z,1551908449.322 [controlThread ThreadHandler](INFO): Handler Thread ID is 3185
2019-03-06T21:40:49.323Z,1551908449.323 [controlThread](DEBUG): Initializing ControlThread
2019-03-06T21:40:49.328Z,1551908449.328 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:40:49.329Z,1551908449.329 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-03-06T21:40:49.329Z,1551908449.329 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-03-06T21:40:49.331Z,1551908449.331 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-03-06T21:40:49.331Z,1551908449.331 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-03-06T21:40:49.331Z,1551908449.331 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-03-06T21:40:49.331Z,1551908449.331 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-03-06T21:40:49.332Z,1551908449.332 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-03-06T21:40:49.332Z,1551908449.332 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-03-06T21:40:49.333Z,1551908449.333 [SBIT](INFO): Initialize SBIT Component.
2019-03-06T21:40:49.334Z,1551908449.334 [SBIT](IMPORTANT): git: 2019-03-04-36-g743def3
2019-03-06T21:40:49.334Z,1551908449.334 [SBIT](INFO): git hash: 743def31acf12ef8e20e672f0fefb031590b97fa
2019-03-06T21:40:49.334Z,1551908449.334 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-03-06T21:40:49.334Z,1551908449.334 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2019-03-06T21:40:49.335Z,1551908449.335 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-03-06T21:40:49.336Z,1551908449.336 [IBIT](INFO): Initialize IBIT Component.
2019-03-06T21:40:49.337Z,1551908449.337 [CBIT](DEBUG): Initialize CBIT Component.
2019-03-06T21:40:49.338Z,1551908449.338 [logger ThreadHandler](INFO): Handler Thread ID is 3186
2019-03-06T21:40:49.349Z,1551908449.349 [CBIT](DEBUG): Initialized mux pins.
2019-03-06T21:40:49.349Z,1551908449.349 [CBIT](DEBUG): Initializing the watchdog timer.
2019-03-06T21:40:49.357Z,1551908449.357 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3187
2019-03-06T21:40:49.358Z,1551908449.358 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-03-06T21:40:49.369Z,1551908449.369 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3188
2019-03-06T21:40:49.373Z,1551908449.373 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-03-06T21:40:49.373Z,1551908449.373 [CBIT](DEBUG): Initializing heartbeat.
2019-03-06T21:40:49.381Z,1551908449.381 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 3189
2019-03-06T21:40:49.382Z,1551908449.382 [CTD_NeilBrown](INFO): Powering down
2019-03-06T21:40:49.409Z,1551908449.409 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 3190
2019-03-06T21:40:49.410Z,1551908449.410 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-03-06T21:40:49.445Z,1551908449.445 [CBIT](DEBUG): Deactivating GF circuits.
2019-03-06T21:40:49.445Z,1551908449.445 [CBIT](DEBUG): Deactivating emergency mode.
2019-03-06T21:40:49.446Z,1551908449.446 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3191
2019-03-06T21:40:49.449Z,1551908449.449 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-03-06T21:40:49.449Z,1551908449.449 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-03-06T21:40:49.449Z,1551908449.449 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-03-06T21:40:49.449Z,1551908449.449 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-03-06T21:40:49.450Z,1551908449.450 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-03-06T21:40:49.450Z,1551908449.450 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-03-06T21:40:49.450Z,1551908449.450 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-03-06T21:40:49.450Z,1551908449.450 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-03-06T21:40:49.450Z,1551908449.450 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-03-06T21:40:49.450Z,1551908449.450 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-03-06T21:40:49.451Z,1551908449.451 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-03-06T21:40:49.451Z,1551908449.451 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-03-06T21:40:49.451Z,1551908449.451 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-03-06T21:40:49.451Z,1551908449.451 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-03-06T21:40:49.451Z,1551908449.451 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-03-06T21:40:49.452Z,1551908449.452 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-03-06T21:40:49.481Z,1551908449.481 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-03-06T21:40:49.483Z,1551908449.483 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-03-06T21:40:49.483Z,1551908449.483 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-03-06T21:40:49.484Z,1551908449.484 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-03-06T21:40:49.485Z,1551908449.485 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-03-06T21:40:49.494Z,1551908449.494 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-06T21:40:49.521Z,1551908449.521 [MissionManager](DEBUG):
2019-03-06T21:40:49.522Z,1551908449.522 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-03-06T21:40:49.593Z,1551908449.593 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-03-06T21:40:49.594Z,1551908449.594 [Default:A.Wait](DEBUG): Construct Wait.
2019-03-06T21:40:49.596Z,1551908449.596 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-06T21:40:49.630Z,1551908449.630 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-03-06T21:40:49.632Z,1551908449.632 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-03-06T21:40:49.654Z,1551908449.654 [Default:E.Execute](DEBUG): Construct Execute.
2019-03-06T21:40:49.657Z,1551908449.657 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2019-03-06T21:40:49.682Z,1551908449.682 [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-06T21:40:49.696Z,1551908449.696 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2019-03-06T21:40:49.713Z,1551908449.713 [DUSBL_Hydroid](INFO): Powering up
2019-03-06T21:40:49.714Z,1551908449.714 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-03-06T21:40:49.773Z,1551908449.773 [Radio_Surface](INFO): Powering up
2019-03-06T21:40:49.793Z,1551908449.793 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-06T21:40:49.834Z,1551908449.834 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-06T21:40:49.837Z,1551908449.837 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-06T21:40:49.838Z,1551908449.838 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-06T21:40:49.861Z,1551908449.861 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-06T21:40:49.862Z,1551908449.862 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-06T21:40:49.893Z,1551908449.893 [MassServo](DEBUG): Initializing MassServo.
2019-03-06T21:40:49.894Z,1551908449.894 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-06T21:40:49.953Z,1551908449.953 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-06T21:40:49.954Z,1551908449.954 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-03-06T21:40:49.958Z,1551908449.958 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-03-06T21:40:50.107Z,1551908450.107 [Micromodem](INFO): Powering up
2019-03-06T21:40:50.107Z,1551908450.107 [Micromodem](DEBUG): Initializing Micromodem.
2019-03-06T21:40:50.205Z,1551908450.205 [RDI_PathfinderUp](INFO): Powering down
2019-03-06T21:40:50.257Z,1551908450.257 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-06T21:40:50.517Z,1551908450.517 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-06T21:40:50.849Z,1551908450.849 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2019-03-06T21:40:50.849Z,1551908450.849 [RudderServo](FAULT): Rudder failed to initialize
2019-03-06T21:40:50.849Z,1551908450.849 [RudderServo] Communications Fault, FailCount= 1
2019-03-06T21:40:50.849Z,1551908450.849 [RudderServo](ERROR): Communications Fault
2019-03-06T21:40:50.960Z,1551908450.960 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-03-06T21:40:51.138Z,1551908451.138 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-06T21:40:51.138Z,1551908451.138 [RudderServo](INFO): Powering down
2019-03-06T21:40:51.806Z,1551908451.806 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-06T21:40:51.926Z,1551908451.926 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-06T21:40:51.930Z,1551908451.930 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-06T21:40:51.930Z,1551908451.930 [RudderServo] No Fault, FailCount= 1
2019-03-06T21:40:53.129Z,1551908453.129 [Aanderaa_O2](INFO): Powering down
2019-03-06T21:40:54.204Z,1551908454.204 [Micromodem](INFO): Nmea in: $CAREV,214054,INIT,2.0.27690*4B
2019-03-06T21:40:54.607Z,1551908454.607 [Micromodem](INFO): Nmea in: $CAREV,214054,SLOT1,2.0.27690*64
2019-03-06T21:40:55.011Z,1551908455.011 [Micromodem](INFO): Nmea in: $CAREV,214054,AUV,2.0.27690*13
2019-03-06T21:40:55.012Z,1551908455.012 [Micromodem](INFO): Nmea in: $CAREV,214054,COPROC,0.10.0.46*46
2019-03-06T21:40:55.013Z,1551908455.013 [Micromodem](DEBUG): Nmea buf: $CCCFG,CST,1*37
2019-03-06T21:40:55.014Z,1551908455.014 [Micromodem](INFO): Nmea out: $CCCFG,CST,1*37
2019-03-06T21:40:55.015Z,1551908455.015 [Micromodem](DEBUG): Nmea buf: $CCCFG,SRC,1*31
2019-03-06T21:40:55.016Z,1551908455.016 [Micromodem](DEBUG): Nmea buf: $CCCFG,REV,1*32
2019-03-06T21:40:55.018Z,1551908455.018 [Micromodem](DEBUG): Nmea buf: $CCCFG,RXP,1*29
2019-03-06T21:40:55.415Z,1551908455.415 [Micromodem](INFO): Nmea in: $CATMG,2019-03-06T21:40:54Z,RTC,RTC*77
2019-03-06T21:41:03.117Z,1551908463.117 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2019-03-06T21:41:04.303Z,1551908464.303 [Micromodem](INFO): Nmea in: $CACFG,CST,1*35
2019-03-06T21:41:04.303Z,1551908464.303 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31
2019-03-06T21:41:04.707Z,1551908464.707 [Micromodem](INFO): Nmea in: $CAREV,214104,AUV,2.0.27690*17
2019-03-06T21:41:05.111Z,1551908465.111 [Micromodem](INFO): Nmea in: $CAREV,214104,COPROC,0.10.0.46*42
2019-03-06T21:41:07.534Z,1551908467.534 [DUSBL_Hydroid](INFO): DUSBL Version:O
2019-03-06T21:41:13.998Z,1551908473.998 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33
2019-03-06T21:41:13.998Z,1551908473.998 [Micromodem](INFO): Nmea out: $CCCFG,REV,1*32
2019-03-06T21:41:14.403Z,1551908474.403 [Micromodem](INFO): Nmea in: $CAREV,214114,AUV,2.0.27690*16
2019-03-06T21:41:14.807Z,1551908474.807 [NAL9602](INFO): Powering up NAL9602
2019-03-06T21:41:18.103Z,1551908478.103 [SBIT](IMPORTANT): Beginning Startup BIT
2019-03-06T21:41:18.108Z,1551908478.108 [CBIT](IMPORTANT): Beginning ground fault scan
2019-03-06T21:41:24.284Z,1551908484.284 [Micromodem](INFO): Nmea in: $CAREV,214114,COPROC,010.0.4643
$CACFG,REV,1*30
2019-03-06T21:41:24.284Z,1551908484.284 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,214114,COPROC,010.0.4643
$CACFG,REV,1*30
2019-03-06T21:41:24.687Z,1551908484.687 [Micromodem](INFO): Nmea in: $CAREV,214124,AUV,2.0.27690*15
2019-03-06T21:41:25.090Z,1551908485.090 [Micromodem](ERROR): Nmea resend: $CCCFG,REV,1*32
2019-03-06T21:41:25.495Z,1551908485.495 [Micromodem](INFO): Nmea in: $CAREV,214124,COPROC,0.10.0.46*40
2019-03-06T21:41:25.911Z,1551908485.911 [NAL9602](INFO): NAL9602 initialized
2019-03-06T21:41:26.721Z,1551908486.721 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:41:29.245Z,1551908489.245 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.023007
CHAN A1 (24V): -0.025953
CHAN A2 (12V): -0.007380
CHAN A3 (5V): -0.003514
CHAN B0 (3.3V): -0.000842
CHAN B1 (3.15aV): -0.000611
CHAN B2 (3.15bV): -0.000248
CHAN B3 (GND): 0.000286
OPEN: 0.009481
Full Scale Calc: 4.765 mA, -1.589 mA
2019-03-06T21:41:34.067Z,1551908494.067 [Micromodem](INFO): Nmea in: $CACFG,REV,1*30
2019-03-06T21:41:34.067Z,1551908494.067 [Micromodem](INFO): Nmea out: $CCCFG,RXP,1*29
2019-03-06T21:41:34.467Z,1551908494.467 [Micromodem](INFO): Nmea in: $CAREV,214134,AUV,2.0.27690*14
2019-03-06T21:41:34.871Z,1551908494.871 [Micromodem](INFO): Nmea in: $CAREV,214134,COPROC,0.10.0.46*41
2019-03-06T21:41:44.163Z,1551908504.163 [Micromodem](INFO): Nmea in: $CACFG,RXP,1*2B
2019-03-06T21:41:44.163Z,1551908504.163 [Micromodem](DEBUG): Nmea buf: $CCTMS,2019-03-06T21:41:45Z,0*7C
2019-03-06T21:41:44.164Z,1551908504.164 [Micromodem](INFO): Nmea out: $CCTMS,2019-03-06T21:41:45Z,0*7C
2019-03-06T21:41:44.571Z,1551908504.571 [Micromodem](INFO): Nmea in: $CAREV,214144,AUV,2.0.27690*13
2019-03-06T21:41:44.975Z,1551908504.975 [Micromodem](INFO): Nmea in: $CAREV,214144,COPROC,0.10.0.46*46
2019-03-06T21:41:45.375Z,1551908505.375 [Micromodem](INFO): Nmea in: $CATMS,0,2019-03-06T21:41:45Z*7E
2019-03-06T21:41:45.375Z,1551908505.375 [Micromodem](DEBUG): Nmea buf: $CCCFQ,TOP*33
2019-03-06T21:41:45.376Z,1551908505.376 [Micromodem](INFO): Nmea out: $CCCFQ,TOP*33
2019-03-06T21:41:45.784Z,1551908505.784 [Micromodem](INFO): Nmea in: $CATMG,2019-03-06T21:41:45Z,USER_CMD,RTC*37
2019-03-06T21:41:46.186Z,1551908506.186 [Micromodem](INFO): Nmea in: $CACFG,AGC,1*34
2019-03-06T21:41:46.190Z,1551908506.190 [Micromodem](INFO): Nmea in: $CACFG,AGN,250*3F
2019-03-06T21:41:46.194Z,1551908506.194 [Micromodem](INFO): Nmea in: $CACFG,AGX,1*2F
2019-03-06T21:41:46.600Z,1551908506.600 [Micromodem](INFO): Nmea in: $CACFG,ASD,0*26
2019-03-06T21:41:46.605Z,1551908506.605 [Micromodem](INFO): Nmea in: $CACFG,BBD,0*34
2019-03-06T21:41:47.001Z,1551908507.001 [Micromodem](INFO): Nmea in: $CACFG,BND,3*3B
2019-03-06T21:41:47.054Z,1551908507.054 [Micromodem](INFO): Nmea in: $CACFG,BR1,3*52
2019-03-06T21:41:47.402Z,1551908507.402 [Micromodem](INFO): Nmea in: $CACFG,BR2,3*51
2019-03-06T21:41:47.410Z,1551908507.410 [Micromodem](INFO): Nmea in: $CACFG,BR3,3*50
2019-03-06T21:41:47.811Z,1551908507.811 [Micromodem](INFO): Nmea in: $CACFG,BR4,3*57
2019-03-06T21:41:47.819Z,1551908507.819 [Micromodem](INFO): Nmea in: $CACFG,BRN,0*2E
2019-03-06T21:41:48.215Z,1551908508.215 [Micromodem](INFO): Nmea in: $CACFG,BSP,1*30
2019-03-06T21:41:48.239Z,1551908508.239 [Micromodem](INFO): Nmea in: $CACFG,BW0,5000*60
2019-03-06T21:41:48.619Z,1551908508.619 [Micromodem](INFO): Nmea in: $CACFG,CPR,1*30
2019-03-06T21:41:48.628Z,1551908508.628 [Micromodem](INFO): Nmea in: $CACFG,CRL,50*18
2019-03-06T21:41:49.017Z,1551908509.017 [Micromodem](INFO): Nmea in: $CACFG,CST,1*35
2019-03-06T21:41:49.024Z,1551908509.024 [Micromodem](INFO): Nmea in: $CACFG,CTO,10*19
2019-03-06T21:41:49.426Z,1551908509.426 [Micromodem](INFO): Nmea in: $CACFG,DBG,0*31
2019-03-06T21:41:49.435Z,1551908509.435 [Micromodem](INFO): Nmea in: $CACFG,DGM,0*3E
2019-03-06T21:41:49.826Z,1551908509.826 [Micromodem](INFO): Nmea in: $CACFG,DOP,0*2B
2019-03-06T21:41:49.847Z,1551908509.847 [Micromodem](INFO): Nmea in: $CACFG,DQF,1*22
2019-03-06T21:41:50.235Z,1551908510.235 [Micromodem](INFO): Nmea in: $CACFG,DTH,90*11
2019-03-06T21:41:50.242Z,1551908510.242 [Micromodem](INFO): Nmea in: $CACFG,DTO,2*2D
2019-03-06T21:41:50.633Z,1551908510.633 [Micromodem](INFO): Nmea in: $CACFG,DTP,90*09
2019-03-06T21:41:50.640Z,1551908510.640 [Micromodem](INFO): Nmea in: $CACFG,ECD,50*07
2019-03-06T21:41:51.037Z,1551908511.037 [Micromodem](INFO): Nmea in: $CACFG,EFB,10*00
2019-03-06T21:41:51.043Z,1551908511.043 [Micromodem](INFO): Nmea in: $CACFG,EFF,20*07
2019-03-06T21:41:51.442Z,1551908511.442 [Micromodem](INFO): Nmea in: $CACFG,FC0,25000*42
2019-03-06T21:41:51.448Z,1551908511.448 [Micromodem](INFO): Nmea in: $CACFG,FMD,1*3E
2019-03-06T21:41:51.849Z,1551908511.849 [Micromodem](INFO): Nmea in: $CACFG,FML,200*35
2019-03-06T21:41:51.859Z,1551908511.859 [Micromodem](INFO): Nmea in: $CACFG,GPS,0*34
2019-03-06T21:41:52.248Z,1551908512.248 [Micromodem](INFO): Nmea in: $CACFG,HFC,0*3D
2019-03-06T21:41:52.255Z,1551908512.255 [Micromodem](INFO): Nmea in: $CACFG,IRE,0*2E
2019-03-06T21:41:52.657Z,1551908512.657 [Micromodem](INFO): Nmea in: $CACFG,MCM,1*32
2019-03-06T21:41:52.663Z,1551908512.663 [Micromodem](INFO): Nmea in: $CACFG,MFD,1*3E
2019-03-06T21:41:53.062Z,1551908513.062 [Micromodem](INFO): Nmea in: $CACFG,MOD,0*36
2019-03-06T21:41:53.069Z,1551908513.069 [Micromodem](INFO): Nmea in: $CACFG,MPR,0*3F
2019-03-06T21:41:53.460Z,1551908513.460 [Micromodem](INFO): Nmea in: $CACFG,MSE,0*2B
2019-03-06T21:41:53.467Z,1551908513.467 [Micromodem](INFO): Nmea in: $CACFG,MVM,0*26
2019-03-06T21:41:53.866Z,1551908513.866 [Micromodem](INFO): Nmea in: $CACFG,NDT,120*2D
2019-03-06T21:41:53.876Z,1551908513.876 [Micromodem](INFO): Nmea in: $CACFG,NRL,25*17
2019-03-06T21:41:54.268Z,1551908514.268 [Micromodem](INFO): Nmea in: $CACFG,NRV,0*3A
2019-03-06T21:41:54.275Z,1551908514.275 [Micromodem](INFO): Nmea in: $CACFG,PAD,0*25
2019-03-06T21:41:54.672Z,1551908514.672 [Micromodem](INFO): Nmea in: $CACFG,PCM,0*2E
2019-03-06T21:41:54.680Z,1551908514.680 [Micromodem](INFO): Nmea in: $CACFG,POW,-20*27
2019-03-06T21:41:55.081Z,1551908515.081 [Micromodem](INFO): Nmea in: $CACFG,PRL,50*0B
2019-03-06T21:41:55.088Z,1551908515.088 [Micromodem](INFO): Nmea in: $CACFG,PTH,50*09
2019-03-06T21:41:55.481Z,1551908515.481 [Micromodem](INFO): Nmea in: $CACFG,PTO,14*0E
2019-03-06T21:41:55.488Z,1551908515.488 [Micromodem](INFO): Nmea in: $CACFG,REV,1*30
2019-03-06T21:41:55.898Z,1551908515.898 [Micromodem](INFO): Nmea in: $CACFG,RXA,0*3B
2019-03-06T21:41:55.908Z,1551908515.908 [Micromodem](INFO): Nmea in: $CACFG,RXD,1*3F
2019-03-06T21:41:56.294Z,1551908516.294 [Micromodem](INFO): Nmea in: $CACFG,RXP,1*2B
2019-03-06T21:41:56.301Z,1551908516.301 [Micromodem](INFO): Nmea in: $CACFG,SCG,0*27
2019-03-06T21:41:56.696Z,1551908516.696 [Micromodem](INFO): Nmea in: $CACFG,SGP,0*34
2019-03-06T21:41:56.720Z,1551908516.720 [Micromodem](INFO): Nmea in: $CACFG,SHF,0*2D
2019-03-06T21:41:57.100Z,1551908517.100 [Micromodem](INFO): Nmea in: $CACFG,SNR,0*3F
2019-03-06T21:41:57.107Z,1551908517.107 [Micromodem](INFO): Nmea in: $CACFG,SNV,0*3B
2019-03-06T21:41:57.509Z,1551908517.509 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33
2019-03-06T21:41:57.515Z,1551908517.515 [Micromodem](INFO): Nmea in: $CACFG,TAT,50*04
2019-03-06T21:41:57.916Z,1551908517.916 [Micromodem](INFO): Nmea in: $CACFG,TOA,0*2A
2019-03-06T21:41:57.924Z,1551908517.924 [Micromodem](INFO): Nmea in: $CACFG,TXD,600*3E
2019-03-06T21:41:58.312Z,1551908518.312 [Micromodem](INFO): Nmea in: $CACFG,TXP,1*2D
2019-03-06T21:41:58.319Z,1551908518.319 [Micromodem](INFO): Nmea in: $CACFG,TXF,1*3B
2019-03-06T21:41:58.716Z,1551908518.716 [Micromodem](INFO): Nmea in: $CACFG,XST,1*2E
2019-03-06T21:41:58.728Z,1551908518.728 [Micromodem](INFO): Nmea in: $CACFG,uart1.bitrate,19200*0A
2019-03-06T21:41:59.130Z,1551908519.130 [Micromodem](INFO): Nmea in: $CACFG,uart2.bitrate,19200*09
2019-03-06T21:41:59.141Z,1551908519.141 [Micromodem](INFO): Nmea in: $CACFG,uart3.bitrate,19200*08
2019-03-06T21:41:59.528Z,1551908519.528 [Micromodem](INFO): Nmea in: $CACFG,uart4.bitrate,19200*0F
2019-03-06T21:41:59.537Z,1551908519.537 [Micromodem](INFO): Nmea in: $CACFG,uart1.task,1*71
2019-03-06T21:41:59.933Z,1551908519.933 [Micromodem](INFO): Nmea in: $CACFG,uart2.task,1*72
2019-03-06T21:41:59.957Z,1551908519.957 [Micromodem](INFO): Nmea in: $CACFG,uart3.task,1*73
2019-03-06T21:42:00.451Z,1551908520.451 [Micromodem](INFO): Nmea in: $CACFG,uart4.task,1*74
2019-03-06T21:42:00.490Z,1551908520.490 [Micromodem](INFO): Nmea in: $CACFG,uart1.parse_gps,0*33
2019-03-06T21:42:00.855Z,1551908520.855 [Micromodem](INFO): Nmea in: $CACFG,uart2.parse_gps,0*30
2019-03-06T21:42:00.867Z,1551908520.867 [Micromodem](INFO): Nmea in: $CACFG,uart3.parse_gps,0*31
2019-03-06T21:42:01.261Z,1551908521.261 [Micromodem](INFO): Nmea in: $CACFG,uart4.parse_gps,0*36
2019-03-06T21:42:01.271Z,1551908521.271 [Micromodem](INFO): Nmea in: $CACFG,uart1.show_gps,0*45
2019-03-06T21:42:01.660Z,1551908521.660 [Micromodem](INFO): Nmea in: $CACFG,uart2.show_gps,0*46
2019-03-06T21:42:01.672Z,1551908521.672 [Micromodem](INFO): Nmea in: $CACFG,uart3.show_gps,0*47
2019-03-06T21:42:02.069Z,1551908522.069 [Micromodem](INFO): Nmea in: $CACFG,uart4.show_gps,0*40
2019-03-06T21:42:02.080Z,1551908522.080 [Micromodem](INFO): Nmea in: $CACFG,uart1.set_clk_GPS,0*3F
2019-03-06T21:42:02.474Z,1551908522.474 [Micromodem](INFO): Nmea in: $CACFG,uart2.set_clk_GPS,0*3C
2019-03-06T21:42:02.486Z,1551908522.486 [Micromodem](INFO): Nmea in: $CACFG,uart3.set_clk_GPS,0*3D
2019-03-06T21:42:02.888Z,1551908522.888 [Micromodem](INFO): Nmea in: $CACFG,uart4.set_clk_GPS,0*3A
2019-03-06T21:42:02.915Z,1551908522.915 [Micromodem](INFO): Nmea in: $CACFG,uart1.flowcontrol,0*08
2019-03-06T21:42:03.298Z,1551908523.298 [Micromodem](INFO): Nmea in: $CACFG,uart2.flowcontrol,0*0B
2019-03-06T21:42:03.309Z,1551908523.309 [Micromodem](INFO): Nmea in: $CACFG,uart3.flowcontrol,0*0A
2019-03-06T21:42:03.703Z,1551908523.703 [Micromodem](INFO): Nmea in: $CACFG,uart4.flowcontrol,0*0D
2019-03-06T21:42:03.712Z,1551908523.712 [Micromodem](INFO): Nmea in: $CACFG,uart4.rs485,0*40
2019-03-06T21:42:04.099Z,1551908524.099 [Micromodem](INFO): Nmea in: $CACFG,uart1.crc32,0*0E
2019-03-06T21:42:04.128Z,1551908524.128 [Micromodem](INFO): Nmea in: $CACFG,uart2.crc32,0*0D
2019-03-06T21:42:04.503Z,1551908524.503 [Micromodem](INFO): Nmea in: $CACFG,uart3.crc32,0*0C
2019-03-06T21:42:04.513Z,1551908524.513 [Micromodem](INFO): Nmea in: $CACFG,uart4.crc32,0*0B
2019-03-06T21:42:04.926Z,1551908524.926 [Micromodem](INFO): Nmea in: $CACFG,uart1.iridium_hangup_minutes,0*62
2019-03-06T21:42:04.954Z,1551908524.954 [Micromodem](INFO): Nmea in: $CACFG,sport3.bitrate,19200*70
2019-03-06T21:42:05.312Z,1551908525.312 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.level,0*65
2019-03-06T21:42:05.325Z,1551908525.325 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.location,1*0F
2019-03-06T21:42:05.723Z,1551908525.723 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.lastretrieval,0*7F
2019-03-06T21:42:05.737Z,1551908525.737 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.currentdbSize,0*59
2019-03-06T21:42:06.123Z,1551908526.123 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.output_rate,0*51
2019-03-06T21:42:06.132Z,1551908526.132 [Micromodem](INFO): Nmea in: $CACFG,rec.state,0*5D
2019-03-06T21:42:06.525Z,1551908526.525 [Micromodem](INFO): Nmea in: $CACFG,rec.start_time,-1*2C
2019-03-06T21:42:06.536Z,1551908526.536 [Micromodem](INFO): Nmea in: $CACFG,rec.end_time,-1*23
2019-03-06T21:42:06.939Z,1551908526.939 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.modulation,0*04
2019-03-06T21:42:06.955Z,1551908526.955 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.bandwidth_Hz,4000*30
2019-03-06T21:42:07.340Z,1551908527.340 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.carrier_Hz,25120*13
2019-03-06T21:42:07.354Z,1551908527.354 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.nulltime_ms,200*4B
2019-03-06T21:42:07.742Z,1551908527.742 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.legacy_addressing,0*5A
2019-03-06T21:42:07.774Z,1551908527.774 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.mod_hdr_version,0*72
2019-03-06T21:42:08.143Z,1551908528.143 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.modulation,0*12
2019-03-06T21:42:08.158Z,1551908528.158 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.bandwidth_Hz,5000*27
2019-03-06T21:42:08.549Z,1551908528.549 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.carrier_Hz,25000*06
2019-03-06T21:42:08.564Z,1551908528.564 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.bandwidth0_Hz,5000*17
2019-03-06T21:42:08.953Z,1551908528.953 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.carrier0_Hz,25000*36
2019-03-06T21:42:08.967Z,1551908528.967 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.nulltime_ms,250*58
2019-03-06T21:42:09.356Z,1551908529.356 [Micromodem](INFO): Nmea in: $CACFG,detector.power_thresh,-20*6B
2019-03-06T21:42:09.369Z,1551908529.369 [Micromodem](INFO): Nmea in: $CACFG,detector.noise_thresh,50*40
2019-03-06T21:42:09.761Z,1551908529.761 [Micromodem](INFO): Nmea in: $CACFG,detector1.recv,0*77
2019-03-06T21:42:09.774Z,1551908529.774 [Micromodem](INFO): Nmea in: $CACFG,detector1.channel_mask,1*5C
2019-03-06T21:42:10.169Z,1551908530.169 [Micromodem](INFO): Nmea in: $CACFG,detector1.type,0*6D
2019-03-06T21:42:10.180Z,1551908530.180 [Micromodem](INFO): Nmea in: $CACFG,detector1.fm_dir,0*5E
2019-03-06T21:42:10.572Z,1551908530.572 [Micromodem](INFO): Nmea in: $CACFG,detector1.length_sym,40*65
2019-03-06T21:42:10.585Z,1551908530.585 [Micromodem](INFO): Nmea in: $CACFG,detector1.fm_bw_Hz,4000*6D
2019-03-06T21:42:10.983Z,1551908530.983 [Micromodem](INFO): Nmea in: $CACFG,detector1.carrier_Hz,25120*60
2019-03-06T21:42:10.995Z,1551908530.995 [Micromodem](INFO): Nmea in: $CACFG,detector1.thresh,90*5C
2019-03-06T21:42:11.372Z,1551908531.372 [Micromodem](INFO): Nmea in: $CACFG,detector2.recv,1*75
2019-03-06T21:42:11.404Z,1551908531.404 [Micromodem](INFO): Nmea in: $CACFG,detector2.channel_mask,1*5F
2019-03-06T21:42:11.479Z,1551908531.479 [SBIT](IMPORTANT): SBIT PASSED
2019-03-06T21:42:11.569Z,1551908531.569 [CommandLine](IMPORTANT): got command configSet list
2019-03-06T21:42:11.569Z,1551908531.569 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-03-06T21:42:11.570Z,1551908531.570 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;
2019-03-06T21:42:11.776Z,1551908531.776 [Micromodem](INFO): Nmea in: $CACFG,detector2.type,0*6E
2019-03-06T21:42:11.788Z,1551908531.788 [Micromodem](INFO): Nmea in: $CACFG,detector2.fm_dir,1*5C
2019-03-06T21:42:11.839Z,1551908531.839 [MissionManager](IMPORTANT): Started mission Startup
2019-03-06T21:42:11.839Z,1551908531.839 [Startup] Running Loop=1
2019-03-06T21:42:11.839Z,1551908531.839 [Startup](DEBUG): Aggregate::initialize Startup
2019-03-06T21:42:11.839Z,1551908531.839 [Startup:A.GoToSurface] Running Loop=1
2019-03-06T21:42:11.839Z,1551908531.839 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-06T21:42:11.840Z,1551908531.840 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-06T21:42:11.841Z,1551908531.841 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-06T21:42:11.841Z,1551908531.841 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-06T21:42:11.842Z,1551908531.842 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-06T21:42:11.842Z,1551908531.842 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-06T21:42:11.845Z,1551908531.845 [Startup:StartupSatComms] Running Loop=1
2019-03-06T21:42:11.845Z,1551908531.845 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-03-06T21:42:11.845Z,1551908531.845 [Startup:StartupSatComms:A] Running Loop=1
2019-03-06T21:42:12.192Z,1551908532.192 [Micromodem](INFO): Nmea in: $CACFG,detector2.length_sym,200*50
2019-03-06T21:42:12.205Z,1551908532.205 [Micromodem](INFO): Nmea in: $CACFG,detector2.fm_bw_Hz,4000*6E
2019-03-06T21:42:12.277Z,1551908532.277 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-03-06T21:42:12.588Z,1551908532.588 [Micromodem](INFO): Nmea in: $CACFG,detector2.carrier_Hz,25120*63
2019-03-06T21:42:12.600Z,1551908532.600 [Micromodem](INFO): Nmea in: $CACFG,detector2.thresh,90*5F
2019-03-06T21:42:12.988Z,1551908532.988 [Micromodem](INFO): Nmea in: $CACFG,detector3.recv,2*77
2019-03-06T21:42:13.002Z,1551908533.002 [Micromodem](INFO): Nmea in: $CACFG,detector3.channel_mask,1*5E
2019-03-06T21:42:13.397Z,1551908533.397 [Micromodem](INFO): Nmea in: $CACFG,detector3.type,1*6E
2019-03-06T21:42:13.408Z,1551908533.408 [Micromodem](INFO): Nmea in: $CACFG,detector3.fm_dir,0*5C
2019-03-06T21:42:13.799Z,1551908533.799 [Micromodem](INFO): Nmea in: $CACFG,detector3.length_sym,200*51
2019-03-06T21:42:13.812Z,1551908533.812 [Micromodem](INFO): Nmea in: $CACFG,detector3.fm_bw_Hz,4000*6F
2019-03-06T21:42:14.207Z,1551908534.207 [Micromodem](INFO): Nmea in: $CACFG,detector3.carrier_Hz,25120*62
2019-03-06T21:42:14.219Z,1551908534.219 [Micromodem](INFO): Nmea in: $CACFG,detector3.thresh,120*64
2019-03-06T21:42:14.605Z,1551908534.605 [Micromodem](INFO): Nmea in: $CACFG,recv.mca.gain,250*1B
2019-03-06T21:42:14.634Z,1551908534.634 [Micromodem](INFO): Nmea in: $CACFG,recv.onboard_gain,250*7E
2019-03-06T21:42:15.011Z,1551908535.011 [Micromodem](INFO): Nmea in: $CACFG,recv.onboard_gain_dB,32*31
2019-03-06T21:42:15.024Z,1551908535.024 [Micromodem](INFO): Nmea in: $CACFG,recv.onboard_equalizer,0*10
2019-03-06T21:42:15.412Z,1551908535.412 [Micromodem](INFO): Nmea in: $CACFG,recv.agn_legacy,1*7F
2019-03-06T21:42:15.424Z,1551908535.424 [Micromodem](INFO): Nmea in: $CACFG,recv.p2b_chmask,1*3D
2019-03-06T21:42:15.819Z,1551908535.819 [Micromodem](INFO): Nmea in: $CACFG,recv.agc_length_ms,100*3A
2019-03-06T21:42:15.830Z,1551908535.830 [Micromodem](INFO): Nmea in: $CACFG,recv.agc_legacy,1*72
2019-03-06T21:42:16.222Z,1551908536.222 [Micromodem](INFO): Nmea in: $CACFG,recv.digital_rcvr,0*6C
2019-03-06T21:42:16.232Z,1551908536.232 [Micromodem](INFO): Nmea in: $CACFG,recv.base64data,0*5B
2019-03-06T21:42:16.627Z,1551908536.627 [Micromodem](INFO): Nmea in: $CACFG,xmit.poweramp_gating,0*18
2019-03-06T21:42:16.637Z,1551908536.637 [Micromodem](INFO): Nmea in: $CACFG,xmit.txinhibit,0*23
2019-03-06T21:42:17.032Z,1551908537.032 [Micromodem](INFO): Nmea in: $CACFG,xmit.uart_disable_mask,15*10
2019-03-06T21:42:17.044Z,1551908537.044 [Micromodem](INFO): Nmea in: $CACFG,timing.clock_source,2*66
2019-03-06T21:42:17.437Z,1551908537.437 [Micromodem](INFO): Nmea in: $CACFG,timing.PPS_source,1*5E
2019-03-06T21:42:17.447Z,1551908537.447 [Micromodem](INFO): Nmea in: $CACFG,timing.syncnav,0*30
2019-03-06T21:42:17.838Z,1551908537.838 [Micromodem](INFO): Nmea in: $CACFG,timing.scg_timeout,0*1D
2019-03-06T21:42:17.865Z,1551908537.865 [Micromodem](INFO): Nmea in: $CACFG,timing.pps_timeout,3*1A
2019-03-06T21:42:18.243Z,1551908538.243 [Micromodem](INFO): Nmea in: $CACFG,timing.extpps_enable,1*0B
2019-03-06T21:42:18.257Z,1551908538.257 [Micromodem](INFO): Nmea in: $CACFG,timing.extpps_en_after_n,0*0A
2019-03-06T21:42:18.651Z,1551908538.651 [Micromodem](INFO): Nmea in: $CACFG,timing.setclk_after_n,0*42
2019-03-06T21:42:18.667Z,1551908538.667 [Micromodem](INFO): Nmea in: $CACFG,timing.extpps_disable_after_n,0*75
2019-03-06T21:42:19.052Z,1551908539.052 [Micromodem](INFO): Nmea in: $CACFG,timing.debug,0*3F
2019-03-06T21:42:19.066Z,1551908539.066 [Micromodem](INFO): Nmea in: $CACFG,hibernate.wake_interval,0*6C
2019-03-06T21:42:19.460Z,1551908539.460 [Micromodem](INFO): Nmea in: $CACFG,hibernate.wake_reference,0*18
2019-03-06T21:42:19.474Z,1551908539.474 [Micromodem](INFO): Nmea in: $CACFG,hibernate.hibernate_after,0*65
2019-03-06T21:42:19.862Z,1551908539.862 [Micromodem](INFO): Nmea in: $CACFG,nav.soundspeed_mps,1430*24
2019-03-06T21:42:19.870Z,1551908539.870 [Micromodem](INFO): Nmea in: $CACFG,nav.nst,0*4E
2019-03-06T21:42:20.259Z,1551908540.259 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.mode,0*02
2019-03-06T21:42:20.269Z,1551908540.269 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.dbg,0*60
2019-03-06T21:42:20.672Z,1551908540.672 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_type,0*3F
2019-03-06T21:42:20.685Z,1551908540.685 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs1_x_mm,-15*64
2019-03-06T21:42:21.071Z,1551908541.071 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs1_y_mm,15*48
2019-03-06T21:42:21.102Z,1551908541.102 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs1_z_mm,0*7F
2019-03-06T21:42:21.475Z,1551908541.475 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs2_x_mm,15*4A
2019-03-06T21:42:21.488Z,1551908541.488 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs2_y_mm,15*4B
2019-03-06T21:42:21.897Z,1551908541.897 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs2_z_mm,0*7C
2019-03-06T21:42:21.939Z,1551908541.939 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs3_x_mm,15*4B
2019-03-06T21:42:22.283Z,1551908542.283 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs3_y_mm,-15*67
2019-03-06T21:42:22.295Z,1551908542.295 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs3_z_mm,0*7D
2019-03-06T21:42:22.687Z,1551908542.687 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs4_x_mm,-15*61
2019-03-06T21:42:22.699Z,1551908542.699 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs4_y_mm,-15*60
2019-03-06T21:42:23.094Z,1551908543.094 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs4_z_mm,0*7A
2019-03-06T21:42:23.105Z,1551908543.105 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.channel_mask,30*1A
2019-03-06T21:42:23.496Z,1551908543.496 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.mode,0*75
2019-03-06T21:42:23.508Z,1551908543.508 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.carrier_Hz,13500*60
2019-03-06T21:42:23.918Z,1551908543.918 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.cycles_per_sym,7*72
2019-03-06T21:42:23.928Z,1551908543.928 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.data,0*66
2019-03-06T21:42:24.309Z,1551908544.309 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.sequence_len,47*62
2019-03-06T21:42:24.320Z,1551908544.320 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.timing_mode,0*3A
2019-03-06T21:42:24.712Z,1551908544.712 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.period,1*72
2019-03-06T21:42:24.747Z,1551908544.747 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.reference_time,2015-12-04T00:00:00Z*68
2019-03-06T21:42:25.110Z,1551908545.110 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.bandwidth_Hz,4000*40
2019-03-06T21:42:25.121Z,1551908545.121 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.duration_msx10,35*66
2019-03-06T21:42:25.509Z,1551908545.509 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.mode,0*1A
2019-03-06T21:42:25.516Z,1551908545.516 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.type,1*00
2019-03-06T21:42:25.923Z,1551908545.923 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66
2019-03-06T21:42:25.932Z,1551908545.932 [Micromodem](INFO): Nmea in: $CACFG,info.part_number,201005*2D
2019-03-06T21:42:26.318Z,1551908546.318 [Micromodem](INFO): Nmea in: $CACFG,info.serial_number,673*0E
2019-03-06T21:42:26.326Z,1551908546.326 [Micromodem](INFO): Nmea in: $CACFG,info.board_rev,D*60
2019-03-06T21:42:26.722Z,1551908546.722 [Micromodem](INFO): Nmea in: $CACFG,info.bom_variant,M*65
2019-03-06T21:42:26.729Z,1551908546.729 [Micromodem](INFO): Nmea in: $CACFG,info.bom_rev,1*0F
2019-03-06T21:42:27.131Z,1551908547.131 [Micromodem](INFO): Nmea in: $CACFG,info.fpga_version,2.0.18017*68
2019-03-06T21:42:27.139Z,1551908547.139 [Micromodem](INFO): Nmea in: $CACFG,info.fpga_api_level,3*4D
2019-03-06T21:42:27.531Z,1551908547.531 [Micromodem](INFO): Nmea in: $CACFG,info.fpga_flashrom_version,2*38
2019-03-06T21:42:27.539Z,1551908547.539 [Micromodem](INFO): Nmea in: $CACFG,info.build_oem,A*6F
2019-03-06T21:42:27.938Z,1551908547.938 [Micromodem](INFO): Nmea in: $CACFG,info.build_year,2016*43
2019-03-06T21:42:27.945Z,1551908547.945 [Micromodem](INFO): Nmea in: $CACFG,info.build_month,5*0C
2019-03-06T21:42:28.337Z,1551908548.337 [Micromodem](INFO): Nmea in: $CACFG,info.build_options,0*09
2019-03-06T21:42:28.348Z,1551908548.348 [Micromodem](INFO): Nmea in: $CACFG,info.coproc_version,0.10.0.46.0 *54
2019-03-06T21:42:28.743Z,1551908548.743 [Micromodem](INFO): Nmea in: $CACFG,info.firmware_version,2.0.27690*6C
2019-03-06T21:42:28.752Z,1551908548.752 [Micromodem](INFO): Nmea in: $CACFG,info.loader_version,17175*61
2019-03-06T21:42:29.144Z,1551908549.144 [Micromodem](INFO): Nmea in: $CACFG,info.booted_slot,1*1D
2019-03-06T21:42:29.151Z,1551908549.151 [Micromodem](INFO): Nmea in: $CACFG,info.debugio,6*21
2019-03-06T21:42:29.549Z,1551908549.549 [Micromodem](INFO): Nmea in: $CACFG,hwd.batt_v,23.628000*1C
2019-03-06T21:42:29.557Z,1551908549.557 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux_adc_v,0.086000*79
2019-03-06T21:42:29.952Z,1551908549.952 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux_adc_gain,1*2F
2019-03-06T21:42:29.959Z,1551908549.959 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux_adc_res,12*78
2019-03-06T21:42:30.361Z,1551908550.361 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux33V_on,1*40
2019-03-06T21:42:30.367Z,1551908550.367 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux33V_fault,0*2A
2019-03-06T21:42:30.760Z,1551908550.760 [Micromodem](INFO): Nmea in: $CACFG,hwd.stack33V_on,1*42
2019-03-06T21:42:30.767Z,1551908550.767 [Micromodem](INFO): Nmea in: $CACFG,hwd.stack33V_fault,0*28
2019-03-06T21:42:31.163Z,1551908551.163 [Micromodem](INFO): Nmea in: $CACFG,hwd.Vpwramp_on,1*25
2019-03-06T21:42:31.170Z,1551908551.170 [Micromodem](INFO): Nmea in: $CACFG,hwd.Vpwramp_fault,0*4F
2019-03-06T21:42:31.571Z,1551908551.571 [Micromodem](INFO): Nmea in: $CACFG,hwd.Vpreamp_on,1*37
2019-03-06T21:42:31.578Z,1551908551.578 [Micromodem](INFO): Nmea in: $CACFG,hwd.Vpreamp_fault,0*5D
2019-03-06T21:42:31.975Z,1551908551.975 [Micromodem](INFO): Nmea in: $CACFG,hwd.VSDcard_on,0*2E
2019-03-06T21:42:31.982Z,1551908551.982 [Micromodem](INFO): Nmea in: $CACFG,hwd.VSDcard_fault,0*45
2019-03-06T21:42:32.374Z,1551908552.374 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio1,0*05
2019-03-06T21:42:32.379Z,1551908552.379 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio2,0*06
2019-03-06T21:42:32.779Z,1551908552.779 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio3,0*07
2019-03-06T21:42:32.783Z,1551908552.783 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio4,1*01
2019-03-06T21:42:33.182Z,1551908553.182 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio5,0*01
2019-03-06T21:42:33.187Z,1551908553.187 [Micromodem](INFO): Nmea in: $CACFG,hwd.txinhibit,0*50
2019-03-06T21:42:33.587Z,1551908553.587 [Micromodem](INFO): Nmea in: $CACFG,hwd.temp,22.312500*32
2019-03-06T21:42:33.598Z,1551908553.598 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.mm_rom_valid,0*35
2019-03-06T21:42:33.998Z,1551908553.998 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.mm_rom,0*1C
2019-03-06T21:42:34.023Z,1551908554.023 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.pa_rom_valid,0*24
2019-03-06T21:42:34.395Z,1551908554.395 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.pa_rom,0*0D
2019-03-06T21:42:34.403Z,1551908554.403 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.pa_rom_boot_search,0*15
2019-03-06T21:42:34.800Z,1551908554.800 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux1_rom_valid,0*68
2019-03-06T21:42:34.806Z,1551908554.806 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux1_rom,0*41
2019-03-06T21:42:35.204Z,1551908555.204 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux1_rom_boot_search,0*59
2019-03-06T21:42:35.211Z,1551908555.211 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux2_rom_valid,0*6B
2019-03-06T21:42:35.607Z,1551908555.607 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux2_rom,0*42
2019-03-06T21:42:35.614Z,1551908555.614 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux2_rom_boot_search,0*5A
2019-03-06T21:42:36.011Z,1551908556.011 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux3_rom_valid,0*6A
2019-03-06T21:42:36.016Z,1551908556.016 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux3_rom,0*43
2019-03-06T21:42:36.416Z,1551908556.416 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux3_rom_boot_search,0*5B
2019-03-06T21:42:36.420Z,1551908556.420 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux4_rom_valid,0*6D
2019-03-06T21:42:36.824Z,1551908556.824 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux4_rom,0*44
2019-03-06T21:42:36.830Z,1551908556.830 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux4_rom_boot_search,0*5C
2019-03-06T21:42:37.223Z,1551908557.223 [Micromodem](INFO): Nmea in: $CACFG,pwramp.temperature_degC,19.937500*5F
2019-03-06T21:42:37.227Z,1551908557.227 [Micromodem](INFO): Nmea in: $CACFG,pwramp.vbat,24.136003*49
2019-03-06T21:42:37.630Z,1551908557.630 [Micromodem](INFO): Nmea in: $CACFG,pwramp.vtransmit,0.000000*05
2019-03-06T21:42:37.635Z,1551908557.635 [Micromodem](INFO): Nmea in: $CACFG,pwramp.iout_sense_amps,0.000000*1F
2019-03-06T21:42:38.029Z,1551908558.029 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,3*2E
2019-03-06T21:42:38.033Z,1551908558.033 [Micromodem](INFO): Nmea in: $CACFG,pwramp.stackpower_conf,1*1C
2019-03-06T21:42:38.433Z,1551908558.433 [Micromodem](INFO): Nmea in: $CACFG,pwramp.VPS_on,1*5D
2019-03-06T21:42:38.435Z,1551908558.435 [Micromodem](INFO): Nmea in: $CACFG,pwramp.gpio5,3*70
2019-03-06T21:42:38.837Z,1551908558.837 [Micromodem](INFO): Nmea in: $CACFG,pwramp.gpio6,3*73
2019-03-06T21:42:38.839Z,1551908558.839 [Micromodem](INFO): Nmea in: $CACFG,pwramp.fault,0*3D
2019-03-06T21:42:39.244Z,1551908559.244 [Micromodem](INFO): Nmea in: $CACFG,script.active,0*5D
2019-03-06T21:42:39.247Z,1551908559.247 [Micromodem](INFO): Nmea in: $CACFG,script.comports,15*6E
2019-03-06T21:42:39.644Z,1551908559.644 [Micromodem](INFO): Nmea in: $CACFG,script.v0,0*17
2019-03-06T21:42:39.646Z,1551908559.646 [Micromodem](INFO): Nmea in: $CACFG,script.v1,0*16
2019-03-06T21:42:40.050Z,1551908560.050 [Micromodem](INFO): Nmea in: $CACFG,script.v2,0*15
2019-03-06T21:42:40.051Z,1551908560.051 [Micromodem](INFO): Nmea in: $CACFG,script.v3,0*14
2019-03-06T21:42:40.452Z,1551908560.452 [Micromodem](INFO): Nmea in: $CACFG,script.v4,0*13
2019-03-06T21:42:40.454Z,1551908560.454 [Micromodem](INFO): Nmea in: $CACFG,script.v5,0*12
2019-03-06T21:42:40.860Z,1551908560.860 [Micromodem](INFO): Nmea in: $CACFG,script.v6,0*11
2019-03-06T21:42:40.862Z,1551908560.862 [Micromodem](INFO): Nmea in: $CACFG,script.v7,0*10
2019-03-06T21:42:41.260Z,1551908561.260 [Micromodem](INFO): Nmea in: $CACFG,script.v8,0*1F
2019-03-06T21:42:41.261Z,1551908561.261 [Micromodem](INFO): Nmea in: $CACFG,script.v9,0*1E
2019-03-06T21:42:41.664Z,1551908561.664 [Micromodem](INFO): Nmea in: $CACFG,script.vA,0*66
2019-03-06T21:42:41.666Z,1551908561.666 [Micromodem](INFO): Nmea in: $CACFG,script.vB,0*65
2019-03-06T21:42:42.067Z,1551908562.067 [Micromodem](INFO): Nmea in: $CACFG,script.vC,0*64
2019-03-06T21:42:42.069Z,1551908562.069 [Micromodem](INFO): Nmea in: $CACFG,script.vD,0*63
2019-03-06T21:42:42.471Z,1551908562.471 [Micromodem](INFO): Nmea in: $CACFG,script.vE,0*62
2019-03-06T21:42:42.473Z,1551908562.473 [Micromodem](INFO): Nmea in: $CACFG,script.vF,0*61
2019-03-06T21:42:42.881Z,1551908562.881 [Micromodem](INFO): Nmea in: $CAREV,214154,AUV,2.0.27690*12
2019-03-06T21:42:42.888Z,1551908562.888 [Micromodem](INFO): Nmea in: $CAREV,214154,COPROC,0.10.0.46*47
2019-03-06T21:42:43.285Z,1551908563.285 [Micromodem](INFO): Nmea in: $CAREV,214204,AUV,2.0.27690*14
2019-03-06T21:42:43.287Z,1551908563.287 [Micromodem](INFO): Nmea in: $CAREV,214204,COPROC,0.10.0.46*41
2019-03-06T21:42:43.688Z,1551908563.688 [Micromodem](INFO): Nmea in: $CAREV,214214,AUV,2.0.27690*15
2019-03-06T21:42:43.689Z,1551908563.689 [Micromodem](INFO): Nmea in: $CAREV,214214,COPROC,0.10.0.46*40
2019-03-06T21:42:44.091Z,1551908564.091 [Micromodem](INFO): Nmea in: $CAREV,214224,AUV,2.0.27690*16
2019-03-06T21:42:44.093Z,1551908564.093 [Micromodem](INFO): Nmea in: $CAREV,214224,COPROC,0.10.0.46*43
2019-03-06T21:42:44.495Z,1551908564.495 [Micromodem](INFO): Nmea in: $CAREV,214234,AUV,2.0.27690*17
2019-03-06T21:42:44.497Z,1551908564.497 [Micromodem](INFO): Nmea in: $CAREV,214234,COPROC,0.10.0.46*42
2019-03-06T21:42:44.908Z,1551908564.908 [Micromodem](INFO): Nmea in: $CAREV,214244,AUV,2.0.27690*10
2019-03-06T21:42:49.377Z,1551908569.377 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:42:49.377Z,1551908569.377 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-06T21:42:49.377Z,1551908569.377 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:42:49.379Z,1551908569.379 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:42:49.379Z,1551908569.379 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-06T21:42:49.379Z,1551908569.379 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:42:49.380Z,1551908569.380 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:42:49.380Z,1551908569.380 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-03-06T21:42:49.380Z,1551908569.380 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:42:49.391Z,1551908569.391 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:42:49.391Z,1551908569.391 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:42:49.392Z,1551908569.392 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:42:49.790Z,1551908569.790 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:42:49.790Z,1551908569.790 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-06T21:42:49.790Z,1551908569.790 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:42:49.790Z,1551908569.790 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-06T21:42:49.791Z,1551908569.791 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:42:49.791Z,1551908569.791 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-03-06T21:42:50.191Z,1551908570.191 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:42:54.187Z,1551908574.187 [Micromodem](INFO): Nmea in: $CAREV,214244,COPROC,0.10.0.46*45
2019-03-06T21:42:54.188Z,1551908574.188 [Micromodem](INFO): Nmea in: $CAREV,214254,AUV,2.0.27690*11
2019-03-06T21:43:04.291Z,1551908584.291 [Micromodem](INFO): Nmea in: $CAREV,214254,COPROC,0.10.0.46*44
2019-03-06T21:43:04.292Z,1551908584.292 [Micromodem](INFO): Nmea in: $CAREV,214304,AUV,2.0.27690*15
2019-03-06T21:43:11.000Z,1551908592.000 [Startup:StartupSatComms:A](INFO): Timed out from 2019-03-06T21:42:11.8Z
2019-03-06T21:43:11.000Z,1551908592.000 [Startup:StartupSatComms:A] Stopped
2019-03-06T21:43:11.000Z,1551908592.000 [Startup:StartupSatComms:B] Running Loop=1
2019-03-06T21:43:12.391Z,1551908592.391 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-06T21:43:14.395Z,1551908594.395 [Micromodem](INFO): Nmea in: $CAREV,214304,COPROC,0.10.0.46*40
2019-03-06T21:43:14.397Z,1551908594.397 [Micromodem](INFO): Nmea in: $CAREV,214314,AUV,2.0.27690*14
2019-03-06T21:43:15.518Z,1551908595.518 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004641
2019-03-06T21:43:20.686Z,1551908600.686 [DataOverHttps](INFO): Sending 247 bytes from file Logs/20190306T211357/Courier0007.lzma
2019-03-06T21:43:21.490Z,1551908601.490 [DataOverHttps](INFO): Moved sent file to Logs/20190306T211357/Courier0007.lzma.bak
2019-03-06T21:43:21.491Z,1551908601.491 [DataOverHttps](INFO): SBD MOMSN=10089402
2019-03-06T21:43:24.083Z,1551908604.083 [Micromodem](INFO): Nmea in: $CAREV,214314,COPROC,0.10.0.46*41
2019-03-06T21:43:24.085Z,1551908604.085 [Micromodem](INFO): Nmea in: $CAREV,214324,AUV,2.0.27690*17
2019-03-06T21:43:32.412Z,1551908612.412 [DataOverHttps](INFO): Sending 1521 bytes from file Logs/20190306T211357/Express0008.lzma
2019-03-06T21:43:33.214Z,1551908613.214 [DataOverHttps](INFO): Moved sent file to Logs/20190306T211357/Express0008.lzma.bak
2019-03-06T21:43:33.214Z,1551908613.214 [DataOverHttps](INFO): SBD MOMSN=10089406
2019-03-06T21:43:34.183Z,1551908614.183 [Micromodem](INFO): Nmea in: $CAREV,214324,COPROC,0.10.0.46*42
2019-03-06T21:43:34.185Z,1551908614.185 [Micromodem](INFO): Nmea in: $CAREV,214334,AUV,2.0.27690*16
2019-03-06T21:43:43.845Z,1551908623.845 [DataOverHttps](INFO): Sending 712 bytes from file Logs/20190306T213929/Express0001.lzma
2019-03-06T21:43:44.284Z,1551908624.284 [Micromodem](INFO): Nmea in: $CAREV,214334,COPROC,0.10.0.46*43
2019-03-06T21:43:44.284Z,1551908624.284 [Micromodem](INFO): Nmea in: $CAREV,214344,AUV,2.0.27690*11
2019-03-06T21:43:44.651Z,1551908624.651 [DataOverHttps](INFO): Moved sent file to Logs/20190306T213929/Express0001.lzma.bak
2019-03-06T21:43:44.651Z,1551908624.651 [DataOverHttps](INFO): SBD MOMSN=10089524
2019-03-06T21:43:54.392Z,1551908634.392 [Micromodem](INFO): Nmea in: $CAREV,214344,COPROC,0.10.0.46*44
2019-03-06T21:43:54.393Z,1551908634.393 [Micromodem](INFO): Nmea in: $CAREV,214354,AUV,2.0.27690*10
2019-03-06T21:43:55.386Z,1551908635.386 [DataOverHttps](INFO): Sending 824 bytes from file Logs/20190306T214038/Express0001.lzma
2019-03-06T21:43:56.190Z,1551908636.190 [DataOverHttps](INFO): Moved sent file to Logs/20190306T214038/Express0001.lzma.bak
2019-03-06T21:43:56.190Z,1551908636.190 [DataOverHttps](INFO): SBD MOMSN=10089541
2019-03-06T21:43:56.843Z,1551908636.843 [Startup:StartupSatComms:B] Stopped
2019-03-06T21:43:56.843Z,1551908636.843 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-03-06T21:43:56.843Z,1551908636.843 [Startup:StartupSatComms] Stopped
2019-03-06T21:43:56.843Z,1551908636.843 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-03-06T21:43:56.844Z,1551908636.844 [Startup](INFO): Completed Startup
2019-03-06T21:43:56.844Z,1551908636.844 [MissionManager](INFO): Startup is completed.
2019-03-06T21:43:56.844Z,1551908636.844 [MissionManager](INFO): Uninitializing Mission Startup
2019-03-06T21:43:56.844Z,1551908636.844 [Startup] Stopped
2019-03-06T21:43:56.844Z,1551908636.844 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-03-06T21:43:56.844Z,1551908636.844 [Startup:A.GoToSurface] Stopped
2019-03-06T21:43:56.844Z,1551908636.844 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-06T21:43:57.256Z,1551908637.256 [MissionManager](IMPORTANT): Started mission Default
2019-03-06T21:43:57.256Z,1551908637.256 [Default] Running Loop=1
2019-03-06T21:43:57.256Z,1551908637.256 [Default](DEBUG): Aggregate::initialize Default
2019-03-06T21:43:57.256Z,1551908637.256 [Default:B.GoToSurface] Running Loop=1
2019-03-06T21:43:57.256Z,1551908637.256 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-06T21:43:57.257Z,1551908637.257 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-06T21:43:57.257Z,1551908637.257 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-06T21:43:57.258Z,1551908637.258 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-06T21:43:57.258Z,1551908637.258 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-06T21:43:57.258Z,1551908637.258 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-06T21:43:57.258Z,1551908637.258 [Default:A.Wait] Running Loop=1
2019-03-06T21:43:57.259Z,1551908637.259 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-06T21:44:04.080Z,1551908644.080 [Micromodem](INFO): Nmea in: $CAREV,214354,COPROC,0.10.0.46*45
2019-03-06T21:44:04.081Z,1551908644.081 [Micromodem](INFO): Nmea in: $CAREV,214404,AUV,2.0.27690*12
2019-03-06T21:44:10.569Z,1551908650.569 [Default:A.Wait](INFO): Done Waiting.
2019-03-06T21:44:10.569Z,1551908650.569 [Default:A.Wait] Stopped
2019-03-06T21:44:10.569Z,1551908650.569 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T21:44:11.052Z,1551908651.052 [Default:CheckIn] Running Loop=1
2019-03-06T21:44:11.053Z,1551908651.053 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-06T21:44:11.053Z,1551908651.053 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-06T21:44:11.471Z,1551908651.471 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-03-06T21:44:14.183Z,1551908654.183 [Micromodem](INFO): Nmea in: $CAREV,214404,COPROC,0.10.0.46*47
2019-03-06T21:44:14.184Z,1551908654.184 [Micromodem](INFO): Nmea in: $CAREV,214414,AUV,2.0.27690*13
2019-03-06T21:44:24.280Z,1551908664.280 [Micromodem](INFO): Nmea in: $CAREV,214414,COPROC,0.10.0.46*46
2019-03-06T21:44:24.280Z,1551908664.280 [Micromodem](INFO): Nmea in: $CAREV,214424,AUV,2.0.27690*10
2019-03-06T21:44:25.130Z,1551908665.130 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2019-03-06T21:44:34.387Z,1551908674.387 [Micromodem](INFO): Nmea in: $CAREV,214424,COPROC,0.10.0.46*45
2019-03-06T21:44:34.389Z,1551908674.389 [Micromodem](INFO): Nmea in: $CAREV,214434,AUV,2.0.27690*11
2019-03-06T21:44:44.075Z,1551908684.075 [Micromodem](INFO): Nmea in: $CAREV,214434,COPROC,0.10.0.46*44
2019-03-06T21:44:44.077Z,1551908684.077 [Micromodem](INFO): Nmea in: $CAREV,214444,AUV,2.0.27690*16
2019-03-06T21:44:50.576Z,1551908690.576 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:44:50.576Z,1551908690.576 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-06T21:44:50.576Z,1551908690.576 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:44:50.578Z,1551908690.578 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:44:50.578Z,1551908690.578 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-06T21:44:50.578Z,1551908690.578 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:44:50.579Z,1551908690.579 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:44:50.579Z,1551908690.579 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-03-06T21:44:50.579Z,1551908690.579 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:44:50.590Z,1551908690.590 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:44:50.590Z,1551908690.590 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:44:50.591Z,1551908690.591 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:44:50.993Z,1551908690.993 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:44:50.993Z,1551908690.993 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-06T21:44:50.994Z,1551908690.994 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:44:50.994Z,1551908690.994 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-06T21:44:50.994Z,1551908690.994 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:44:50.994Z,1551908690.994 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-03-06T21:44:51.499Z,1551908691.499 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:44:54.179Z,1551908694.179 [Micromodem](INFO): Nmea in: $CAREV,214444,COPROC,0.10.0.46*43
2019-03-06T21:44:54.180Z,1551908694.180 [Micromodem](INFO): Nmea in: $CAREV,214454,AUV,2.0.27690*17
2019-03-06T21:45:04.275Z,1551908704.275 [Micromodem](INFO): Nmea in: $CAREV,214454,COPROC,0.10.0.46*42
2019-03-06T21:45:04.276Z,1551908704.276 [Micromodem](INFO): Nmea in: $CAREV,214504,AUV,2.0.27690*13
2019-03-06T21:45:14.375Z,1551908714.375 [Micromodem](INFO): Nmea in: $CAREV,214504,COPROC,0.10.0.46*46
2019-03-06T21:45:14.377Z,1551908714.377 [Micromodem](INFO): Nmea in: $CAREV,214514,AUV,2.0.27690*12
2019-03-06T21:45:24.071Z,1551908724.071 [Micromodem](INFO): Nmea in: $CAREV,214514,COPROC,0.10.0.46*47
2019-03-06T21:45:24.073Z,1551908724.073 [Micromodem](INFO): Nmea in: $CAREV,214524,AUV,2.0.27690*11
2019-03-06T21:45:34.171Z,1551908734.171 [Micromodem](INFO): Nmea in: $CAREV,214524,COPROC,0.10.0.46*44
2019-03-06T21:45:34.173Z,1551908734.173 [Micromodem](INFO): Nmea in: $CAREV,214534,AUV,2.0.27690*10
2019-03-06T21:45:44.279Z,1551908744.279 [Micromodem](INFO): Nmea in: $CAREV,214534,COPROC,0.10.0.46*45
2019-03-06T21:45:44.280Z,1551908744.280 [Micromodem](INFO): Nmea in: $CAREV,214544,AUV,2.0.27690*17
2019-03-06T21:45:54.375Z,1551908754.375 [Micromodem](INFO): Nmea in: $CAREV,214544,COPROC,0.10.0.46*42
2019-03-06T21:45:54.377Z,1551908754.377 [Micromodem](INFO): Nmea in: $CAREV,214554,AUV,2.0.27690*16
2019-03-06T21:46:04.067Z,1551908764.067 [Micromodem](INFO): Nmea in: $CAREV,214554,COPROC,0.10.0.46*43
2019-03-06T21:46:04.069Z,1551908764.069 [Micromodem](INFO): Nmea in: $CAREV,214604,AUV,2.0.27690*10
2019-03-06T21:46:14.167Z,1551908774.167 [Micromodem](INFO): Nmea in: $CAREV,214604,COPROC,0.10.0.46*45
2019-03-06T21:46:14.169Z,1551908774.169 [Micromodem](INFO): Nmea in: $CAREV,214614,AUV,2.0.27690*11
2019-03-06T21:46:24.268Z,1551908784.268 [Micromodem](INFO): Nmea in: $CAREV,214614,COPROC,0.10.0.46*44
2019-03-06T21:46:24.268Z,1551908784.268 [Micromodem](INFO): Nmea in: $CAREV,214624,AUV,2.0.27690*12
2019-03-06T21:46:29.521Z,1551908789.521 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-03-06T21:46:30.341Z,1551908790.341 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:34.367Z,1551908794.367 [Micromodem](INFO): Nmea in: $CAREV,214624,COPROC,0.10.0.46*47
2019-03-06T21:46:34.369Z,1551908794.369 [Micromodem](INFO): Nmea in: $CAREV,214634,AUV,2.0.27690*13
2019-03-06T21:46:34.789Z,1551908794.789 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:37.613Z,1551908797.613 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:40.441Z,1551908800.441 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:43.673Z,1551908803.673 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:44.064Z,1551908804.064 [Micromodem](INFO): Nmea in: $CAREV,214634,COPROC,0.10.0.46*46
2019-03-06T21:46:44.066Z,1551908804.066 [Micromodem](INFO): Nmea in: $CAREV,214644,AUV,2.0.27690*14
2019-03-06T21:46:46.501Z,1551908806.501 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:49.733Z,1551908809.733 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:51.831Z,1551908811.831 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:46:51.831Z,1551908811.831 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-03-06T21:46:51.832Z,1551908811.832 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:46:51.834Z,1551908811.834 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:46:51.834Z,1551908811.834 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-03-06T21:46:51.834Z,1551908811.834 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:46:51.835Z,1551908811.835 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:46:51.835Z,1551908811.835 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2019-03-06T21:46:51.835Z,1551908811.835 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:46:51.846Z,1551908811.846 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:46:51.846Z,1551908811.846 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:46:51.847Z,1551908811.847 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:46:52.199Z,1551908812.199 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:46:52.199Z,1551908812.199 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-03-06T21:46:52.199Z,1551908812.199 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:46:52.199Z,1551908812.199 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-03-06T21:46:52.200Z,1551908812.200 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:46:52.200Z,1551908812.200 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2019-03-06T21:46:52.569Z,1551908812.569 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:52.680Z,1551908812.680 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:46:54.163Z,1551908814.163 [Micromodem](INFO): Nmea in: $CAREV,214644,COPROC,0.10.0.46*41
2019-03-06T21:46:54.165Z,1551908814.165 [Micromodem](INFO): Nmea in: $CAREV,214654,AUV,2.0.27690*15
2019-03-06T21:46:55.801Z,1551908815.801 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:46:58.621Z,1551908818.621 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:47:01.449Z,1551908821.449 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:47:04.264Z,1551908824.263 [Micromodem](INFO): Nmea in: $CAREV,214654,COPROC,0.10.0.46*40
2019-03-06T21:47:04.264Z,1551908824.264 [Micromodem](INFO): Nmea in: $CAREV,214704,AUV,2.0.27690*11
2019-03-06T21:47:04.681Z,1551908824.681 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:47:05.928Z,1551908825.928 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2019-03-06T21:47:07.512Z,1551908827.512 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:47:10.743Z,1551908830.743 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:47:13.569Z,1551908833.569 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:47:14.363Z,1551908834.363 [Micromodem](INFO): Nmea in: $CAREV,214704,COPROC,0.10.0.46*44
2019-03-06T21:47:14.365Z,1551908834.365 [Micromodem](INFO): Nmea in: $CAREV,214714,AUV,2.0.27690*10
2019-03-06T21:47:16.801Z,1551908836.801 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:47:19.633Z,1551908839.633 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:47:20.021Z,1551908840.021 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214439.00,A,3648.16319,N,12147.28737,W,0.739,0.00,060319,,,A*78
2019-03-06T21:47:20.024Z,1551908840.024 [NAL9602](INFO): GPS fix at 20190306T214439: (36.802720, -121.788123)
2019-03-06T21:47:20.062Z,1551908840.062 [Default:CheckIn:Read_GPS] Stopped
2019-03-06T21:47:20.062Z,1551908840.062 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-03-06T21:47:20.496Z,1551908840.496 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-06T21:47:24.059Z,1551908844.059 [Micromodem](INFO): Nmea in: $CAREV,214714,COPROC,0.10.0.46*45
2019-03-06T21:47:24.463Z,1551908844.463 [Micromodem](INFO): Nmea in: $CAREV,214724,AUV,2.0.27690*13
2019-03-06T21:47:27.197Z,1551908847.197 [DataOverHttps](INFO): Sending 305 bytes from file Logs/20190306T214038/Courier0004.lzma
2019-03-06T21:47:28.002Z,1551908848.002 [DataOverHttps](INFO): Moved sent file to Logs/20190306T214038/Courier0004.lzma.bak
2019-03-06T21:47:28.002Z,1551908848.002 [DataOverHttps](INFO): SBD MOMSN=10089560
2019-03-06T21:47:34.159Z,1551908854.159 [Micromodem](INFO): Nmea in: $CAREV,214724,COPROC,0.10.0.46*46
2019-03-06T21:47:34.160Z,1551908854.160 [Micromodem](INFO): Nmea in: $CAREV,214734,AUV,2.0.27690*12
2019-03-06T21:47:39.517Z,1551908859.517 [DataOverHttps](INFO): Sending 399 bytes from file Logs/20190306T214038/Express0005.lzma
2019-03-06T21:47:40.334Z,1551908860.334 [DataOverHttps](INFO): Moved sent file to Logs/20190306T214038/Express0005.lzma.bak
2019-03-06T21:47:40.335Z,1551908860.335 [DataOverHttps](INFO): SBD MOMSN=10089563
2019-03-06T21:47:41.071Z,1551908861.071 [Default:CheckIn:Read_Iridium] Stopped
2019-03-06T21:47:41.071Z,1551908861.071 [Default:CheckIn:C.Wait] Running Loop=1
2019-03-06T21:47:41.071Z,1551908861.071 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-03-06T21:47:44.259Z,1551908864.259 [Micromodem](INFO): Nmea in: $CAREV,214734,COPROC,0.10.0.46*47
2019-03-06T21:47:44.260Z,1551908864.260 [Micromodem](INFO): Nmea in: $CAREV,214744,AUV,2.0.27690*15
2019-03-06T21:47:44.310Z,1551908864.310 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-03-06T21:47:44.310Z,1551908864.310 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19030614531, -0.1, 0.0,1448.9, 0
2019-03-06T21:47:52.339Z,1551908872.339 [NAL9602](INFO): Powering down
2019-03-06T21:47:54.359Z,1551908874.359 [Micromodem](INFO): Nmea in: $CAREV,214744,COPROC,0.10.0.46*40
2019-03-06T21:47:54.360Z,1551908874.360 [Micromodem](INFO): Nmea in: $CAREV,214754,AUV,2.0.27690*14
2019-03-06T21:48:04.059Z,1551908884.059 [Micromodem](INFO): Nmea in: $CAREV,214754,COPROC,0.10.0.46*41
2019-03-06T21:48:04.459Z,1551908884.459 [Micromodem](INFO): Nmea in: $CAREV,214804,AUV,2.0.27690*1E
2019-03-06T21:48:14.163Z,1551908894.163 [Micromodem](INFO): Nmea in: $CAREV,214804,COPROC,0.10.0.46*4B
2019-03-06T21:48:14.164Z,1551908894.164 [Micromodem](INFO): Nmea in: $CAREV,214814,AUV,2.0.27690*1F
2019-03-06T21:48:24.263Z,1551908904.263 [Micromodem](INFO): Nmea in: $CAREV,214814,COPROC,0.10.0.46*4A
2019-03-06T21:48:24.264Z,1551908904.264 [Micromodem](INFO): Nmea in: $CAREV,214824,AUV,2.0.27690*1C
2019-03-06T21:48:34.363Z,1551908914.363 [Micromodem](INFO): Nmea in: $CAREV,214824,COPROC,0.10.0.46*49
2019-03-06T21:48:34.364Z,1551908914.364 [Micromodem](INFO): Nmea in: $CAREV,214834,AUV,2.0.27690*1D
2019-03-06T21:48:44.463Z,1551908924.463 [Micromodem](INFO): Nmea in: $CAREV,214834,COPROC,0.10.0.46*48
2019-03-06T21:48:44.464Z,1551908924.464 [Micromodem](INFO): Nmea in: $CAREV,214844,AUV,2.0.27690*1A
2019-03-06T21:48:52.979Z,1551908932.979 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:48:52.979Z,1551908932.979 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-06T21:48:52.979Z,1551908932.979 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:48:52.986Z,1551908932.986 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:48:52.986Z,1551908932.986 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-06T21:48:52.986Z,1551908932.986 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:48:52.988Z,1551908932.988 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:48:52.988Z,1551908932.988 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-03-06T21:48:52.988Z,1551908932.988 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:48:53.011Z,1551908933.011 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:48:53.011Z,1551908933.011 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:48:53.012Z,1551908933.012 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:48:53.401Z,1551908933.401 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:48:53.401Z,1551908933.401 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-06T21:48:53.402Z,1551908933.402 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:48:53.402Z,1551908933.402 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-06T21:48:53.402Z,1551908933.402 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:48:53.403Z,1551908933.403 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-03-06T21:48:53.780Z,1551908933.780 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:48:54.159Z,1551908934.159 [Micromodem](INFO): Nmea in: $CAREV,214844,COPROC,0.10.0.46*4F
2019-03-06T21:48:54.160Z,1551908934.160 [Micromodem](INFO): Nmea in: $CAREV,214854,AUV,2.0.27690*1B
2019-03-06T21:49:04.263Z,1551908944.263 [Micromodem](INFO): Nmea in: $CAREV,214854,COPROC,0.10.0.46*4E
2019-03-06T21:49:04.264Z,1551908944.264 [Micromodem](INFO): Nmea in: $CAREV,214904,AUV,2.0.27690*1F
2019-03-06T21:49:14.359Z,1551908954.359 [Micromodem](INFO): Nmea in: $CAREV,214904,COPROC,0.10.0.46*4A
2019-03-06T21:49:14.360Z,1551908954.360 [Micromodem](INFO): Nmea in: $CAREV,214914,AUV,2.0.27690*1E
2019-03-06T21:49:24.459Z,1551908964.459 [Micromodem](INFO): Nmea in: $CAREV,214914,COPROC,0.10.0.46*4B
2019-03-06T21:49:24.460Z,1551908964.460 [Micromodem](INFO): Nmea in: $CAREV,214924,AUV,2.0.27690*1D
2019-03-06T21:49:34.155Z,1551908974.155 [Micromodem](INFO): Nmea in: $CAREV,214924,COPROC,0.10.0.46*48
2019-03-06T21:49:34.156Z,1551908974.156 [Micromodem](INFO): Nmea in: $CAREV,214934,AUV,2.0.27690*1C
2019-03-06T21:49:44.255Z,1551908984.255 [Micromodem](INFO): Nmea in: $CAREV,214934,COPROC,0.10.0.46*49
2019-03-06T21:49:44.256Z,1551908984.256 [Micromodem](INFO): Nmea in: $CAREV,214944,AUV,2.0.27690*1B
2019-03-06T21:49:54.355Z,1551908994.355 [Micromodem](INFO): Nmea in: $CAREV,214944,COPROC,0.10.0.46*4E
2019-03-06T21:49:54.356Z,1551908994.356 [Micromodem](INFO): Nmea in: $CAREV,214954,AUV,2.0.27690*1A
2019-03-06T21:50:04.455Z,1551909004.455 [Micromodem](INFO): Nmea in: $CAREV,214954,COPROC,0.10.0.46*4F
2019-03-06T21:50:04.456Z,1551909004.456 [Micromodem](INFO): Nmea in: $CAREV,215004,AUV,2.0.27690*17
2019-03-06T21:50:14.151Z,1551909014.151 [Micromodem](INFO): Nmea in: $CAREV,215004,COPROC,0.10.0.46*42
2019-03-06T21:50:14.152Z,1551909014.152 [Micromodem](INFO): Nmea in: $CAREV,215014,AUV,2.0.27690*16
2019-03-06T21:50:24.255Z,1551909024.255 [Micromodem](INFO): Nmea in: $CAREV,215014,COPROC,0.10.0.46*43
2019-03-06T21:50:24.256Z,1551909024.256 [Micromodem](INFO): Nmea in: $CAREV,215024,AUV,2.0.27690*15
2019-03-06T21:50:34.351Z,1551909034.351 [Micromodem](INFO): Nmea in: $CAREV,215024,COPROC,0.10.0.46*40
2019-03-06T21:50:34.352Z,1551909034.352 [Micromodem](INFO): Nmea in: $CAREV,215034,AUV,2.0.27690*14
2019-03-06T21:50:44.451Z,1551909044.451 [Micromodem](INFO): Nmea in: $CAREV,215034,COPROC,0.10.0.46*41
2019-03-06T21:50:44.452Z,1551909044.452 [Micromodem](INFO): Nmea in: $CAREV,215044,AUV,2.0.27690*13
2019-03-06T21:50:54.147Z,1551909054.147 [Micromodem](INFO): Nmea in: $CAREV,215044,COPROC,0.10.0.46*46
2019-03-06T21:50:54.148Z,1551909054.148 [Micromodem](INFO): Nmea in: $CAREV,215054,AUV,2.0.27690*12
2019-03-06T21:50:54.214Z,1551909054.214 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:50:54.215Z,1551909054.215 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-06T21:50:54.215Z,1551909054.215 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:50:54.221Z,1551909054.221 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:50:54.221Z,1551909054.221 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-06T21:50:54.221Z,1551909054.221 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:50:54.223Z,1551909054.223 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:50:54.223Z,1551909054.223 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-03-06T21:50:54.223Z,1551909054.223 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:50:54.244Z,1551909054.244 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:50:54.244Z,1551909054.244 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:50:54.244Z,1551909054.244 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:50:54.599Z,1551909054.599 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:50:54.599Z,1551909054.599 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-06T21:50:54.600Z,1551909054.600 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:50:54.600Z,1551909054.600 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-06T21:50:54.601Z,1551909054.601 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:50:54.601Z,1551909054.601 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-03-06T21:50:54.983Z,1551909054.983 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:51:04.247Z,1551909064.247 [Micromodem](INFO): Nmea in: $CAREV,215054,COPROC,0.10.0.46*47
2019-03-06T21:51:04.248Z,1551909064.248 [Micromodem](INFO): Nmea in: $CAREV,215104,AUV,2.0.27690*16
2019-03-06T21:51:14.347Z,1551909074.347 [Micromodem](INFO): Nmea in: $CAREV,215104,COPROC,0.10.0.46*43
2019-03-06T21:51:14.349Z,1551909074.349 [Micromodem](INFO): Nmea in: $CAREV,215114,AUV,2.0.27690*17
2019-03-06T21:51:24.447Z,1551909084.447 [Micromodem](INFO): Nmea in: $CAREV,215114,COPROC,0.10.0.46*42
2019-03-06T21:51:24.448Z,1551909084.448 [Micromodem](INFO): Nmea in: $CAREV,215124,AUV,2.0.27690*14
2019-03-06T21:51:25.766Z,1551909085.766 [CommandLine](IMPORTANT): got command failComponent
2019-03-06T21:51:25.767Z,1551909085.767 [CommandLine](IMPORTANT): Failed components:
2019-03-06T21:51:25.767Z,1551909085.767 [CommandLine](IMPORTANT): No failed Components.
2019-03-06T21:51:30.234Z,1551909090.234 [CommandLine](IMPORTANT): got command failComponent
2019-03-06T21:51:30.234Z,1551909090.234 [CommandLine](IMPORTANT): Failed components:
2019-03-06T21:51:30.234Z,1551909090.234 [CommandLine](IMPORTANT): No failed Components.
2019-03-06T21:51:34.147Z,1551909094.147 [Micromodem](INFO): Nmea in: $CAREV,215124,COPROC,0.10.0.46*41
2019-03-06T21:51:34.148Z,1551909094.148 [Micromodem](INFO): Nmea in: $CAREV,215134,AUV,2.0.27690*15
2019-03-06T21:51:44.243Z,1551909104.243 [Micromodem](INFO): Nmea in: $CAREV,215134,COPROC,0.10.0.46*40
2019-03-06T21:51:44.244Z,1551909104.244 [Micromodem](INFO): Nmea in: $CAREV,215144,AUV,2.0.27690*12
2019-03-06T21:51:54.343Z,1551909114.343 [Micromodem](INFO): Nmea in: $CAREV,215144,COPROC,0.10.0.46*47
2019-03-06T21:51:54.344Z,1551909114.344 [Micromodem](INFO): Nmea in: $CAREV,215154,AUV,2.0.27690*13
2019-03-06T21:52:04.443Z,1551909124.443 [Micromodem](INFO): Nmea in: $CAREV,215154,COPROC,0.10.0.46*46
2019-03-06T21:52:04.444Z,1551909124.444 [Micromodem](INFO): Nmea in: $CAREV,215204,AUV,2.0.27690*15
2019-03-06T21:52:14.139Z,1551909134.139 [Micromodem](INFO): Nmea in: $CAREV,215204,COPROC,0.10.0.46*40
2019-03-06T21:52:14.140Z,1551909134.140 [Micromodem](INFO): Nmea in: $CAREV,215214,AUV,2.0.27690*14
2019-03-06T21:52:24.239Z,1551909144.239 [Micromodem](INFO): Nmea in: $CAREV,215214,COPROC,0.10.0.46*41
2019-03-06T21:52:24.240Z,1551909144.240 [Micromodem](INFO): Nmea in: $CAREV,215224,AUV,2.0.27690*17
2019-03-06T21:52:34.343Z,1551909154.343 [Micromodem](INFO): Nmea in: $CAREV,215224,COPROC,0.10.0.46*42
2019-03-06T21:52:34.345Z,1551909154.345 [Micromodem](INFO): Nmea in: $CAREV,215234,AUV,2.0.27690*16
2019-03-06T21:52:41.640Z,1551909161.640 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-03-06T21:52:41.640Z,1551909161.640 [Default:CheckIn:C.Wait] Stopped
2019-03-06T21:52:41.640Z,1551909161.640 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T21:52:41.640Z,1551909161.640 [Default:CheckIn:D] Running Loop=1
2019-03-06T21:52:42.047Z,1551909162.047 [Default:CheckIn:D] Stopped
2019-03-06T21:52:42.047Z,1551909162.047 [Default:CheckIn:E] Running Loop=1
2019-03-06T21:52:42.452Z,1551909162.452 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.746519 min
2019-03-06T21:52:42.452Z,1551909162.452 [Default:CheckIn:E] Stopped
2019-03-06T21:52:42.452Z,1551909162.452 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-03-06T21:52:42.452Z,1551909162.452 [Default:CheckIn] Stopped
2019-03-06T21:52:42.452Z,1551909162.452 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-06T21:52:42.453Z,1551909162.453 [Default:CheckIn](INFO): Running loop #2
2019-03-06T21:52:42.453Z,1551909162.453 [Default:CheckIn] Running Loop=2
2019-03-06T21:52:42.453Z,1551909162.453 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-06T21:52:42.453Z,1551909162.453 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-06T21:52:43.227Z,1551909163.227 [NAL9602](INFO): Powering up
2019-03-06T21:52:44.439Z,1551909164.439 [Micromodem](INFO): Nmea in: $CAREV,215234,COPROC,0.10.0.46*43
2019-03-06T21:52:44.440Z,1551909164.440 [Micromodem](INFO): Nmea in: $CAREV,215244,AUV,2.0.27690*11
2019-03-06T21:52:54.140Z,1551909174.140 [Micromodem](INFO): Nmea in: $CAREV,215244,COPROC,0.10.0.46*44
2019-03-06T21:52:54.141Z,1551909174.141 [Micromodem](INFO): Nmea in: $CAREV,215254,AUV,2.0.27690*10
2019-03-06T21:52:54.142Z,1551909174.142 [NAL9602](INFO): NAL9602 initialized
2019-03-06T21:52:54.957Z,1551909174.957 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:52:54.993Z,1551909174.993 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:52:54.993Z,1551909174.993 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-03-06T21:52:54.994Z,1551909174.994 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:52:54.995Z,1551909174.995 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:52:54.996Z,1551909174.996 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-03-06T21:52:54.996Z,1551909174.996 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:52:54.998Z,1551909174.998 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:52:54.998Z,1551909174.998 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2019-03-06T21:52:54.998Z,1551909174.998 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:52:55.009Z,1551909175.009 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:52:55.009Z,1551909175.009 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:52:55.009Z,1551909175.009 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:52:55.394Z,1551909175.394 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:52:55.394Z,1551909175.394 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-03-06T21:52:55.395Z,1551909175.395 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:52:55.395Z,1551909175.395 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-03-06T21:52:55.395Z,1551909175.395 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:52:55.395Z,1551909175.395 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2019-03-06T21:52:55.788Z,1551909175.788 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:53:00.407Z,1551909180.407 [CommandLine](IMPORTANT): got command show variable DUSBL
2019-03-06T21:53:00.488Z,1551909180.488 [CommandLine](IMPORTANT): DUSBL_Hydroid.loadAtStartup (bool)
2019-03-06T21:53:00.493Z,1551909180.493 [CommandLine](IMPORTANT): DUSBL_Hydroid.simulateHardware (bool)
2019-03-06T21:53:00.493Z,1551909180.493 [CommandLine](IMPORTANT): DUSBL_Hydroid.defaultTurnAroundTime (meter_per_second)
2019-03-06T21:53:00.494Z,1551909180.494 [CommandLine](IMPORTANT): DUSBL_Hydroid.defaultSoundSpeed (meter_per_second)
2019-03-06T21:53:00.494Z,1551909180.494 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold (count)
2019-03-06T21:53:00.495Z,1551909180.495 [CommandLine](IMPORTANT): DUSBL_Hydroid.recieveTimeout (millisecond)
2019-03-06T21:53:00.495Z,1551909180.495 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout (millisecond)
2019-03-06T21:53:00.496Z,1551909180.496 [CommandLine](IMPORTANT): DUSBL_Hydroid.transponderCode (enum)
2019-03-06T21:53:00.496Z,1551909180.496 [CommandLine](IMPORTANT): DUSBL_Hydroid.numberOfPingsRequested (count)
2019-03-06T21:53:00.496Z,1551909180.496 [CommandLine](IMPORTANT): DUSBL_Hydroid.verbosity (enum)
2019-03-06T21:53:00.497Z,1551909180.497 [CommandLine](IMPORTANT): DUSBL_Hydroid.xCenter (angular_degree)
2019-03-06T21:53:00.501Z,1551909180.501 [CommandLine](IMPORTANT): DUSBL_Hydroid.yCenter (angular_degree)
2019-03-06T21:53:00.549Z,1551909180.549 [CommandLine](IMPORTANT): DUSBL_Hydroid.loadControl (none)
2019-03-06T21:53:00.550Z,1551909180.550 [CommandLine](IMPORTANT): DUSBL_Hydroid.uart (none)
2019-03-06T21:53:00.550Z,1551909180.550 [CommandLine](IMPORTANT): DUSBL_Hydroid.baud (bit_per_second)
2019-03-06T21:53:00.565Z,1551909180.565 [CommandLine](IMPORTANT): Micromodem.dusblPingCode (enum)
2019-03-06T21:53:00.566Z,1551909180.566 [CommandLine](IMPORTANT): DUSBL_Hydroid.xAngle (angular_degree)
2019-03-06T21:53:00.566Z,1551909180.566 [CommandLine](IMPORTANT): DUSBL_Hydroid.yAngle (angular_degree)
2019-03-06T21:53:00.566Z,1551909180.566 [CommandLine](IMPORTANT): DUSBL_Hydroid.travelTime (microsecond)
2019-03-06T21:53:00.567Z,1551909180.567 [CommandLine](IMPORTANT): DUSBL_Hydroid.latency (microsecond)
2019-03-06T21:53:00.567Z,1551909180.567 [CommandLine](IMPORTANT): DUSBL_Hydroid.gain (ratio)
2019-03-06T21:53:00.568Z,1551909180.568 [CommandLine](IMPORTANT): DUSBL_Hydroid.inBandSignalToNoise (ratio)
2019-03-06T21:53:00.568Z,1551909180.568 [CommandLine](IMPORTANT): DUSBL_Hydroid.outBandSignalToNoise (ratio)
2019-03-06T21:53:00.568Z,1551909180.568 [CommandLine](IMPORTANT): DUSBL_Hydroid.range (meter)
2019-03-06T21:53:00.577Z,1551909180.577 [CommandLine](IMPORTANT): DUSBL_Hydroid.direction (none)
2019-03-06T21:53:04.235Z,1551909184.235 [Micromodem](INFO): Nmea in: $CAREV,215254,COPROC,0.10.0.46*45
2019-03-06T21:53:04.236Z,1551909184.236 [Micromodem](INFO): Nmea in: $CAREV,215304,AUV,2.0.27690*14
2019-03-06T21:53:10.374Z,1551909190.374 [CommandLine](IMPORTANT): got command report touch DUSBL_Hydroid.range
2019-03-06T21:53:14.335Z,1551909194.335 [Micromodem](INFO): Nmea in: $CAREV,215304,COPROC,0.10.0.46*41
2019-03-06T21:53:14.336Z,1551909194.336 [Micromodem](INFO): Nmea in: $CAREV,215314,AUV,2.0.27690*15
2019-03-06T21:53:17.407Z,1551909197.407 [CommandLine](IMPORTANT): got command report touch DUSBL_Hydroid.direction
2019-03-06T21:53:24.231Z,1551909204.231 [CommandLine](IMPORTANT): got command run ./Missions/Maintenance/DUSBL.xml
2019-03-06T21:53:24.231Z,1551909204.231 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/DUSBL.xml
2019-03-06T21:53:24.261Z,1551909204.261 [MissionManager](INFO): DefineArg DUSBL.MissionTimeout = 90.000000 min
2019-03-06T21:53:24.265Z,1551909204.265 [MissionManager](INFO): DefineArg DUSBL.NumberOfRequests = 10.000000 count
2019-03-06T21:53:24.268Z,1551909204.268 [MissionManager](INFO): DefineArg DUSBL.TransponderCode = 2.000000 count
2019-03-06T21:53:24.272Z,1551909204.272 [MissionManager](INFO): DefineArg DUSBL.NumberOfPings = 1.000000 count
2019-03-06T21:53:24.276Z,1551909204.276 [MissionManager](INFO): DefineArg DUSBL.EnabledDUSBL = 1.000000 bool
2019-03-06T21:53:24.277Z,1551909204.277 [DUSBL:A.Pitch](DEBUG): Construct.
2019-03-06T21:53:24.308Z,1551909204.308 [DUSBL:B.SetSpeed](DEBUG): Construct.
2019-03-06T21:53:24.316Z,1551909204.316 [DUSBL:RequestRepeater:C.Wait](DEBUG): Construct Wait.
2019-03-06T21:53:24.349Z,1551909204.349 [MissionManager](DEBUG):
This mission is requests a DUSBL arming.
How long to let the mission run.
90
Number of pings to requst.
10
Transponder Address.
2
Number of pings requested each time.
1
Automatically set to true if the DUSBL is enabled. Set to false to disable
reading from the DUSBL.
0
10
2019-03-06T21:53:24.351Z,1551909204.351 [CommandLine](IMPORTANT): Running ./Missions/Maintenance/DUSBL.xml
2019-03-06T21:53:24.435Z,1551909204.435 [Micromodem](INFO): Nmea in: $CAREV,215314,COPROC,0.10.0.46*40
2019-03-06T21:53:24.436Z,1551909204.436 [Micromodem](INFO): Nmea in: $CAREV,215324,AUV,2.0.27690*16
2019-03-06T21:53:24.477Z,1551909204.477 [Default] Stopped
2019-03-06T21:53:24.478Z,1551909204.478 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-06T21:53:24.478Z,1551909204.478 [Default:B.GoToSurface] Stopped
2019-03-06T21:53:24.478Z,1551909204.478 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-06T21:53:24.478Z,1551909204.478 [Default:CheckIn] Stopped
2019-03-06T21:53:24.478Z,1551909204.478 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-06T21:53:24.478Z,1551909204.478 [Default:CheckIn:Read_GPS] Stopped
2019-03-06T21:53:24.478Z,1551909204.478 [MissionManager](IMPORTANT): Started mission DUSBL
2019-03-06T21:53:24.478Z,1551909204.478 [DUSBL] Running Loop=1
2019-03-06T21:53:24.479Z,1551909204.479 [DUSBL](DEBUG): Aggregate::initialize DUSBL
2019-03-06T21:53:24.479Z,1551909204.479 [DUSBL:A.Pitch] Running Loop=1
2019-03-06T21:53:24.479Z,1551909204.479 [DUSBL:A.Pitch](DEBUG): Initialize.
2019-03-06T21:53:24.479Z,1551909204.479 [DUSBL:B.SetSpeed] Running Loop=1
2019-03-06T21:53:24.479Z,1551909204.479 [DUSBL:B.SetSpeed](DEBUG): Initialize.
2019-03-06T21:53:24.479Z,1551909204.479 [DUSBL:C] Running Loop=1
2019-03-06T21:53:24.479Z,1551909204.479 [DUSBL:RequestRepeater] Running Loop=1
2019-03-06T21:53:24.480Z,1551909204.480 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-06T21:53:24.480Z,1551909204.480 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-06T21:53:24.480Z,1551909204.480 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-06T21:53:24.480Z,1551909204.480 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-06T21:53:24.480Z,1551909204.480 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-06T21:53:24.481Z,1551909204.481 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-06T21:53:24.493Z,1551909204.493 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-06T21:53:24.493Z,1551909204.493 [DUSBL:C] Running Loop=1
2019-03-06T21:53:24.494Z,1551909204.494 [DUSBL:C](DEBUG): Initialize ReadDataComponent to sense DUSBL_Hydroid.range
2019-03-06T21:53:24.495Z,1551909204.495 [DUSBL:C](DEBUG): Initialize ReadDataComponent to sense DUSBL_Hydroid.direction
2019-03-06T21:53:24.495Z,1551909204.495 [DUSBL:B.SetSpeed] Running Loop=1
2019-03-06T21:53:24.495Z,1551909204.495 [DUSBL:A.Pitch] Running Loop=1
2019-03-06T21:53:26.055Z,1551909206.055 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-06T21:53:26.060Z,1551909206.060 [Micromodem](DEBUG): Nmea buf: $CCPGT,26000,28,4A1C0370,54,24000,4A1C0370,0,0,0,1000,0*67
2019-03-06T21:53:26.060Z,1551909206.060 [Micromodem](INFO): Nmea out: $CCPGT,26000,28,4A1C0370,54,24000,4A1C0370,0,0,0,1000,0*67
2019-03-06T21:53:26.063Z,1551909206.063 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-03-06T21:53:26.137Z,1551909206.137 [NAL9602](FAULT): received:
+CSQ:0
OK
2019-03-06T21:53:26.137Z,1551909206.137 [NAL9602] Data Fault, FailCount= 1
2019-03-06T21:53:26.137Z,1551909206.137 [NAL9602](ERROR): Data Fault
2019-03-06T21:53:26.197Z,1551909206.197 [CBIT](ERROR): Data Fault in component: NAL9602
2019-03-06T21:53:26.455Z,1551909206.455 [Micromodem](INFO): Nmea in: $CAREV,215324,COPROC,0.10.0.46*43
2019-03-06T21:53:26.458Z,1551909206.458 [Micromodem](INFO): Nmea in: $SNPGT,26000,28,4A1C0370,54,24000,4A1C0370,0,0,0,1000,0*7A
2019-03-06T21:53:26.458Z,1551909206.458 [NAL9602](INFO): Powering down
2019-03-06T21:53:26.875Z,1551909206.875 [Micromodem](INFO): Nmea in: $CATXP,280*48
2019-03-06T21:53:26.877Z,1551909206.877 [Micromodem](INFO): Nmea in: $CATXF,280*5E
2019-03-06T21:53:27.263Z,1551909207.263 [Micromodem](INFO): Nmea in: $SNTTA,,,,,215326.47*5C
2019-03-06T21:53:27.264Z,1551909207.264 [Micromodem](INFO): Nmea in: $CAREV,215326,AUV,2.0.27690*14
2019-03-06T21:53:27.301Z,1551909207.301 [CBIT](INFO): Clearing failed state for component NAL9602
2019-03-06T21:53:27.301Z,1551909207.301 [NAL9602] No Fault, FailCount= 1
2019-03-06T21:53:29.283Z,1551909209.283 [DUSBL_Hydroid](FAULT): unknown deviceResponse_: !U1,P
2019-03-06T21:53:29.283Z,1551909209.283 [DUSBL_Hydroid] Communications Fault, FailCount= 1
2019-03-06T21:53:29.283Z,1551909209.283 [DUSBL_Hydroid](ERROR): Communications Fault
2019-03-06T21:53:29.359Z,1551909209.359 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-03-06T21:53:29.686Z,1551909209.686 [DUSBL_Hydroid](INFO): Powering down
2019-03-06T21:53:30.533Z,1551909210.533 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-03-06T21:53:30.533Z,1551909210.533 [DUSBL_Hydroid] No Fault, FailCount= 1
2019-03-06T21:53:32.922Z,1551909212.922 [DUSBL_Hydroid](INFO): Powering up
2019-03-06T21:53:32.922Z,1551909212.922 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-03-06T21:53:34.560Z,1551909214.560 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-06T21:53:34.560Z,1551909214.560 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-06T21:53:34.560Z,1551909214.560 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T21:53:34.565Z,1551909214.565 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-06T21:53:34.565Z,1551909214.565 [DUSBL:RequestRepeater] Stopped
2019-03-06T21:53:34.565Z,1551909214.565 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater:A] Stopped
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater:B] Stopped
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater](INFO): Running loop #2
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater] Running Loop=2
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-06T21:53:34.566Z,1551909214.566 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-06T21:53:36.555Z,1551909216.555 [Micromodem](INFO): Nmea in: $CAREV,215326,COPROC,0.10.0.46*41
2019-03-06T21:53:36.556Z,1551909216.556 [Micromodem](INFO): Nmea in: $CAREV,215336,AUV,2.0.27690*15
2019-03-06T21:53:45.071Z,1551909225.071 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-06T21:53:45.071Z,1551909225.071 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-06T21:53:45.071Z,1551909225.071 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater] Stopped
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater:A] Stopped
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater:B] Stopped
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater](INFO): Running loop #3
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater] Running Loop=3
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-06T21:53:45.072Z,1551909225.072 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-06T21:53:45.073Z,1551909225.073 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-06T21:53:45.073Z,1551909225.073 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-06T21:53:46.251Z,1551909226.251 [Micromodem](INFO): Nmea in: $CAREV,215336,COPROC,0.10.0.46*40
2019-03-06T21:53:46.252Z,1551909226.252 [Micromodem](INFO): Nmea in: $CAREV,215346,AUV,2.0.27690*12
2019-03-06T21:53:50.950Z,1551909230.950 [CommandLine](IMPORTANT): got command failComponent
2019-03-06T21:53:50.951Z,1551909230.951 [CommandLine](IMPORTANT): Failed components:
2019-03-06T21:53:50.951Z,1551909230.951 [CommandLine](IMPORTANT): No failed Components.
2019-03-06T21:53:51.099Z,1551909231.099 [DUSBL_Hydroid](INFO): DUSBL Version:O
2019-03-06T21:53:51.507Z,1551909231.507 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-06T21:53:55.544Z,1551909235.544 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-06T21:53:55.576Z,1551909235.576 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-06T21:53:55.576Z,1551909235.576 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-06T21:53:55.576Z,1551909235.576 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T21:53:55.577Z,1551909235.577 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-06T21:53:55.577Z,1551909235.577 [DUSBL:RequestRepeater] Stopped
2019-03-06T21:53:55.577Z,1551909235.577 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater:A] Stopped
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater:B] Stopped
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater](INFO): Running loop #4
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater] Running Loop=4
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-06T21:53:55.578Z,1551909235.578 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-06T21:53:56.355Z,1551909236.355 [Micromodem](INFO): Nmea in: $CAREV,215346,COPROC,0.10.0.46*47
2019-03-06T21:53:56.356Z,1551909236.356 [Micromodem](INFO): Nmea in: $CAREV,215356,AUV,2.0.27690*13
2019-03-06T21:53:56.755Z,1551909236.755 [NAL9602](INFO): Powering up NAL9602
2019-03-06T21:53:59.583Z,1551909239.583 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-06T21:53:59.990Z,1551909239.990 [DUSBL_Hydroid](FAULT): unknown deviceResponse_: !U1,P
2019-03-06T21:53:59.990Z,1551909239.990 [DUSBL_Hydroid] Communications Fault, FailCount= 2
2019-03-06T21:53:59.990Z,1551909239.990 [DUSBL_Hydroid](ERROR): Communications Fault
2019-03-06T21:54:00.060Z,1551909240.060 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-03-06T21:54:00.394Z,1551909240.394 [DUSBL_Hydroid](INFO): Powering down
2019-03-06T21:54:01.240Z,1551909241.240 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-03-06T21:54:01.240Z,1551909241.240 [DUSBL_Hydroid] No Fault, FailCount= 2
2019-03-06T21:54:03.622Z,1551909243.622 [DUSBL_Hydroid](INFO): Powering up
2019-03-06T21:54:03.622Z,1551909243.622 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-03-06T21:54:03.678Z,1551909243.678 [CommandLine](IMPORTANT): got command stop
2019-03-06T21:54:03.678Z,1551909243.678 [CommandLine](IMPORTANT): Scheduling is paused
2019-03-06T21:54:03.678Z,1551909243.678 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2019-03-06T21:54:03.698Z,1551909243.698 [MissionManager](INFO): MissionManager is completed.
2019-03-06T21:54:03.698Z,1551909243.698 [MissionManager](INFO): Uninitializing Mission DUSBL
2019-03-06T21:54:03.698Z,1551909243.698 [DUSBL] Stopped
2019-03-06T21:54:03.698Z,1551909243.698 [DUSBL](DEBUG): Aggregate::uninitialize DUSBL
2019-03-06T21:54:03.698Z,1551909243.698 [DUSBL:A.Pitch] Stopped
2019-03-06T21:54:03.698Z,1551909243.698 [DUSBL:B.SetSpeed] Stopped
2019-03-06T21:54:03.698Z,1551909243.698 [DUSBL:B.SetSpeed](DEBUG): Uninitialize.
2019-03-06T21:54:03.698Z,1551909243.698 [DUSBL:C] Stopped
2019-03-06T21:54:03.698Z,1551909243.698 [DUSBL:RequestRepeater] Stopped
2019-03-06T21:54:03.698Z,1551909243.698 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-06T21:54:03.699Z,1551909243.699 [DUSBL:RequestRepeater:A] Stopped
2019-03-06T21:54:03.699Z,1551909243.699 [DUSBL:RequestRepeater:B] Stopped
2019-03-06T21:54:03.699Z,1551909243.699 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-06T21:54:03.699Z,1551909243.699 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T21:54:04.064Z,1551909244.064 [MissionManager](IMPORTANT): Started mission Default
2019-03-06T21:54:04.064Z,1551909244.064 [Default] Running Loop=1
2019-03-06T21:54:04.064Z,1551909244.064 [Default](DEBUG): Aggregate::initialize Default
2019-03-06T21:54:04.064Z,1551909244.064 [Default:B.GoToSurface] Running Loop=1
2019-03-06T21:54:04.064Z,1551909244.064 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-06T21:54:04.065Z,1551909244.065 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-06T21:54:04.065Z,1551909244.065 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-06T21:54:04.066Z,1551909244.066 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-06T21:54:04.066Z,1551909244.066 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-06T21:54:04.066Z,1551909244.066 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-06T21:54:04.066Z,1551909244.066 [Default:A.Wait] Running Loop=1
2019-03-06T21:54:04.067Z,1551909244.067 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-06T21:54:06.451Z,1551909246.451 [Micromodem](INFO): Nmea in: $CAREV,215356,COPROC,0.10.0.46*46
2019-03-06T21:54:06.452Z,1551909246.452 [Micromodem](INFO): Nmea in: $CAREV,215406,AUV,2.0.27690*11
2019-03-06T21:54:07.664Z,1551909247.664 [NAL9602](INFO): NAL9602 initialized
2019-03-06T21:54:16.551Z,1551909256.551 [Micromodem](INFO): Nmea in: $CAREV,215406,COPROC,0.10.0.46*44
2019-03-06T21:54:16.552Z,1551909256.552 [Micromodem](INFO): Nmea in: $CAREV,215416,AUV,2.0.27690*10
2019-03-06T21:54:17.388Z,1551909257.388 [Default:A.Wait](INFO): Done Waiting.
2019-03-06T21:54:17.388Z,1551909257.388 [Default:A.Wait] Stopped
2019-03-06T21:54:17.389Z,1551909257.389 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T21:54:17.792Z,1551909257.792 [Default:CheckIn] Running Loop=1
2019-03-06T21:54:17.792Z,1551909257.792 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-06T21:54:17.793Z,1551909257.793 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-06T21:54:19.393Z,1551909259.393 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:54:21.802Z,1551909261.802 [DUSBL_Hydroid](INFO): DUSBL Version:O
2019-03-06T21:54:26.248Z,1551909266.248 [Micromodem](INFO): Nmea in: $CAREV,215416,COPROC,0.10.0.46*45
2019-03-06T21:54:26.249Z,1551909266.249 [Micromodem](INFO): Nmea in: $CAREV,215426,AUV,2.0.27690*13
2019-03-06T21:54:36.348Z,1551909276.348 [Micromodem](INFO): Nmea in: $CAREV,215426,COPROC,0.10.0.46*46
2019-03-06T21:54:36.349Z,1551909276.349 [Micromodem](INFO): Nmea in: $CAREV,215436,AUV,2.0.27690*12
2019-03-06T21:54:46.447Z,1551909286.447 [Micromodem](INFO): Nmea in: $CAREV,215436,COPROC,0.10.0.46*47
2019-03-06T21:54:46.448Z,1551909286.448 [Micromodem](INFO): Nmea in: $CAREV,215446,AUV,2.0.27690*15
2019-03-06T21:54:56.192Z,1551909296.192 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:54:56.192Z,1551909296.192 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-03-06T21:54:56.192Z,1551909296.192 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:54:56.194Z,1551909296.194 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:54:56.194Z,1551909296.194 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-03-06T21:54:56.194Z,1551909296.194 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:54:56.196Z,1551909296.196 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:54:56.196Z,1551909296.196 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2019-03-06T21:54:56.196Z,1551909296.196 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:54:56.208Z,1551909296.208 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:54:56.208Z,1551909296.208 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:54:56.208Z,1551909296.208 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:54:56.547Z,1551909296.547 [Micromodem](INFO): Nmea in: $CAREV,215446,COPROC,0.10.0.46*40
2019-03-06T21:54:56.548Z,1551909296.548 [Micromodem](INFO): Nmea in: $CAREV,215456,AUV,2.0.27690*14
2019-03-06T21:54:56.582Z,1551909296.582 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:54:56.582Z,1551909296.582 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-03-06T21:54:56.583Z,1551909296.583 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:54:56.583Z,1551909296.583 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-03-06T21:54:56.583Z,1551909296.583 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:54:56.583Z,1551909296.583 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2019-03-06T21:54:56.982Z,1551909296.982 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:55:06.247Z,1551909306.247 [Micromodem](INFO): Nmea in: $CAREV,215456,COPROC,0.10.0.46*41
2019-03-06T21:55:06.250Z,1551909306.250 [Micromodem](INFO): Nmea in: $CAREV,215506,AUV,2.0.27690*10
2019-03-06T21:55:16.347Z,1551909316.347 [Micromodem](INFO): Nmea in: $CAREV,215506,COPROC,0.10.0.46*45
2019-03-06T21:55:16.348Z,1551909316.348 [Micromodem](INFO): Nmea in: $CAREV,215516,AUV,2.0.27690*11
2019-03-06T21:55:26.443Z,1551909326.443 [Micromodem](INFO): Nmea in: $CAREV,215516,COPROC,0.10.0.46*44
2019-03-06T21:55:26.444Z,1551909326.444 [Micromodem](INFO): Nmea in: $CAREV,215526,AUV,2.0.27690*12
2019-03-06T21:55:36.543Z,1551909336.543 [Micromodem](INFO): Nmea in: $CAREV,215526,COPROC,0.10.0.46*47
2019-03-06T21:55:36.544Z,1551909336.544 [Micromodem](INFO): Nmea in: $CAREV,215536,AUV,2.0.27690*13
2019-03-06T21:55:46.239Z,1551909346.239 [Micromodem](INFO): Nmea in: $CAREV,215536,COPROC,0.10.0.46*46
2019-03-06T21:55:46.643Z,1551909346.643 [Micromodem](INFO): Nmea in: $CAREV,215546,AUV,2.0.27690*14
2019-03-06T21:55:56.339Z,1551909356.339 [Micromodem](INFO): Nmea in: $CAREV,215546,COPROC,0.10.0.46*41
2019-03-06T21:55:56.340Z,1551909356.340 [Micromodem](INFO): Nmea in: $CAREV,215556,AUV,2.0.27690*15
2019-03-06T21:56:06.439Z,1551909366.439 [Micromodem](INFO): Nmea in: $CAREV,215556,COPROC,0.10.0.46*40
2019-03-06T21:56:06.440Z,1551909366.440 [Micromodem](INFO): Nmea in: $CAREV,215606,AUV,2.0.27690*13
2019-03-06T21:56:16.539Z,1551909376.539 [Micromodem](INFO): Nmea in: $CAREV,215606,COPROC,0.10.0.46*46
2019-03-06T21:56:16.540Z,1551909376.540 [Micromodem](INFO): Nmea in: $CAREV,215616,AUV,2.0.27690*12
2019-03-06T21:56:26.639Z,1551909386.639 [Micromodem](INFO): Nmea in: $CAREV,215616,COPROC,0.10.0.46*47
2019-03-06T21:56:26.640Z,1551909386.640 [Micromodem](INFO): Nmea in: $CAREV,215626,AUV,2.0.27690*11
2019-03-06T21:56:36.339Z,1551909396.339 [Micromodem](INFO): Nmea in: $CAREV,215626,COPROC,0.10.0.46*44
2019-03-06T21:56:36.340Z,1551909396.340 [Micromodem](INFO): Nmea in: $CAREV,215636,AUV,2.0.27690*10
2019-03-06T21:56:46.435Z,1551909406.435 [Micromodem](INFO): Nmea in: $CAREV,215636,COPROC,0.10.0.46*45
2019-03-06T21:56:46.436Z,1551909406.436 [Micromodem](INFO): Nmea in: $CAREV,215646,AUV,2.0.27690*17
2019-03-06T21:56:56.535Z,1551909416.535 [Micromodem](INFO): Nmea in: $CAREV,215646,COPROC,0.10.0.46*42
2019-03-06T21:56:56.536Z,1551909416.536 [Micromodem](INFO): Nmea in: $CAREV,215656,AUV,2.0.27690*16
2019-03-06T21:56:57.368Z,1551909417.368 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:56:57.368Z,1551909417.368 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-03-06T21:56:57.368Z,1551909417.368 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:56:57.371Z,1551909417.371 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:56:57.371Z,1551909417.371 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2019-03-06T21:56:57.371Z,1551909417.371 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:56:57.372Z,1551909417.372 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:56:57.373Z,1551909417.373 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2019-03-06T21:56:57.373Z,1551909417.373 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:56:57.384Z,1551909417.384 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:56:57.384Z,1551909417.384 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:56:57.384Z,1551909417.384 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:56:57.794Z,1551909417.794 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:56:57.794Z,1551909417.794 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-03-06T21:56:57.795Z,1551909417.795 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:56:57.795Z,1551909417.795 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2019-03-06T21:56:57.795Z,1551909417.795 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:56:57.795Z,1551909417.795 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2019-03-06T21:56:58.202Z,1551909418.202 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:57:06.635Z,1551909426.635 [Micromodem](INFO): Nmea in: $CAREV,215656,COPROC,0.10.0.46*43
2019-03-06T21:57:06.636Z,1551909426.636 [Micromodem](INFO): Nmea in: $CAREV,215706,AUV,2.0.27690*12
2019-03-06T21:57:08.282Z,1551909428.282 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-03-06T21:57:08.283Z,1551909428.283 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19030615024081,.1, 0.0,1448.9, 0
2019-03-06T21:57:16.331Z,1551909436.331 [Micromodem](INFO): Nmea in: $CAREV,215706,COPROC,0.10.0.46*47
2019-03-06T21:57:16.332Z,1551909436.332 [Micromodem](INFO): Nmea in: $CAREV,215716,AUV,2.0.27690*13
2019-03-06T21:57:26.431Z,1551909446.431 [Micromodem](INFO): Nmea in: $CAREV,215716,COPROC,0.10.0.46*46
2019-03-06T21:57:26.432Z,1551909446.432 [Micromodem](INFO): Nmea in: $CAREV,215726,AUV,2.0.27690*10
2019-03-06T21:57:36.531Z,1551909456.531 [Micromodem](INFO): Nmea in: $CAREV,215726,COPROC,0.10.0.46*45
2019-03-06T21:57:36.532Z,1551909456.532 [Micromodem](INFO): Nmea in: $CAREV,215736,AUV,2.0.27690*11
2019-03-06T21:57:46.631Z,1551909466.631 [Micromodem](INFO): Nmea in: $CAREV,215736,COPROC,0.10.0.46*44
2019-03-06T21:57:46.632Z,1551909466.632 [Micromodem](INFO): Nmea in: $CAREV,215746,AUV,2.0.27690*16
2019-03-06T21:57:56.331Z,1551909476.331 [Micromodem](INFO): Nmea in: $CAREV,215746,COPROC,0.10.0.46*43
2019-03-06T21:57:56.332Z,1551909476.332 [Micromodem](INFO): Nmea in: $CAREV,215756,AUV,2.0.27690*17
2019-03-06T21:57:57.943Z,1551909477.943 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-03-06T21:57:58.765Z,1551909478.765 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:03.613Z,1551909483.613 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:06.427Z,1551909486.427 [Micromodem](INFO): Nmea in: $CAREV,215756,COPROC,0.10.0.46*42
2019-03-06T21:58:06.428Z,1551909486.428 [Micromodem](INFO): Nmea in: $CAREV,215806,AUV,2.0.27690*1D
2019-03-06T21:58:06.441Z,1551909486.441 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:09.269Z,1551909489.269 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:11.693Z,1551909491.693 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:14.517Z,1551909494.517 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:16.523Z,1551909496.523 [Micromodem](INFO): Nmea in: $CAREV,215806,COPROC,0.10.0.46*48
2019-03-06T21:58:16.524Z,1551909496.524 [Micromodem](INFO): Nmea in: $CAREV,215816,AUV,2.0.27690*1C
2019-03-06T21:58:17.753Z,1551909497.753 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:20.581Z,1551909500.581 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:23.817Z,1551909503.817 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:26.627Z,1551909506.627 [Micromodem](INFO): Nmea in: $CAREV,215816,COPROC,0.10.0.46*49
2019-03-06T21:58:26.628Z,1551909506.628 [Micromodem](INFO): Nmea in: $CAREV,215826,AUV,2.0.27690*1F
2019-03-06T21:58:26.641Z,1551909506.641 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:29.473Z,1551909509.473 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:32.297Z,1551909512.297 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:35.529Z,1551909515.529 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:36.323Z,1551909516.323 [Micromodem](INFO): Nmea in: $CAREV,215826,COPROC,0.10.0.46*4A
2019-03-06T21:58:36.324Z,1551909516.324 [Micromodem](INFO): Nmea in: $CAREV,215836,AUV,2.0.27690*1E
2019-03-06T21:58:38.357Z,1551909518.357 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:41.589Z,1551909521.589 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:44.417Z,1551909524.417 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:46.423Z,1551909526.423 [Micromodem](INFO): Nmea in: $CAREV,215836,COPROC,0.10.0.46*4B
2019-03-06T21:58:46.424Z,1551909526.424 [Micromodem](INFO): Nmea in: $CAREV,215846,AUV,2.0.27690*19
2019-03-06T21:58:47.649Z,1551909527.649 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:50.481Z,1551909530.481 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:53.709Z,1551909533.709 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:56.523Z,1551909536.523 [Micromodem](INFO): Nmea in: $CAREV,215846,COPROC,0.10.0.46*4C
2019-03-06T21:58:56.524Z,1551909536.524 [Micromodem](INFO): Nmea in: $CAREV,215856,AUV,2.0.27690*18
2019-03-06T21:58:56.537Z,1551909536.537 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:58:58.572Z,1551909538.572 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:58:58.572Z,1551909538.572 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-03-06T21:58:58.572Z,1551909538.572 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T21:58:58.574Z,1551909538.574 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:58:58.575Z,1551909538.575 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2019-03-06T21:58:58.575Z,1551909538.575 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T21:58:58.576Z,1551909538.576 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T21:58:58.576Z,1551909538.576 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6
2019-03-06T21:58:58.576Z,1551909538.576 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T21:58:58.588Z,1551909538.588 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T21:58:58.588Z,1551909538.588 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T21:58:58.588Z,1551909538.588 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T21:58:58.992Z,1551909538.992 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T21:58:58.992Z,1551909538.992 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-03-06T21:58:58.993Z,1551909538.993 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T21:58:58.993Z,1551909538.993 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2019-03-06T21:58:58.993Z,1551909538.993 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T21:58:58.993Z,1551909538.993 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6
2019-03-06T21:58:59.380Z,1551909539.380 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T21:58:59.769Z,1551909539.769 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:59:02.597Z,1551909542.597 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:59:05.425Z,1551909545.425 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:59:06.623Z,1551909546.623 [Micromodem](INFO): Nmea in: $CAREV,215856,COPROC,0.10.0.46*4D
2019-03-06T21:59:06.624Z,1551909546.624 [Micromodem](INFO): Nmea in: $CAREV,215906,AUV,2.0.27690*1C
2019-03-06T21:59:08.661Z,1551909548.661 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:59:11.485Z,1551909551.485 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:59:14.313Z,1551909554.313 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:59:16.323Z,1551909556.323 [Micromodem](INFO): Nmea in: $CAREV,215906,COPROC,0.10.0.46*49
2019-03-06T21:59:16.324Z,1551909556.324 [Micromodem](INFO): Nmea in: $CAREV,215916,AUV,2.0.27690*1D
2019-03-06T21:59:17.545Z,1551909557.545 [NAL9602](DEBUG): Fix Requested
2019-03-06T21:59:17.982Z,1551909557.982 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-03-06T21:54:17.8Z
2019-03-06T21:59:17.982Z,1551909557.982 [Default:CheckIn:Read_GPS] Stopped
2019-03-06T21:59:17.982Z,1551909557.982 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-03-06T21:59:23.100Z,1551909563.100 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190306T214038/Courier0007.lzma
2019-03-06T21:59:23.906Z,1551909563.906 [DataOverHttps](INFO): Moved sent file to Logs/20190306T214038/Courier0007.lzma.bak
2019-03-06T21:59:23.906Z,1551909563.906 [DataOverHttps](INFO): SBD MOMSN=10089615
2019-03-06T21:59:26.419Z,1551909566.419 [Micromodem](INFO): Nmea in: $CAREV,215916,COPROC,0.10.0.46*48
2019-03-06T21:59:26.420Z,1551909566.420 [Micromodem](INFO): Nmea in: $CAREV,215926,AUV,2.0.27690*1E
2019-03-06T21:59:34.746Z,1551909574.746 [DataOverHttps](INFO): Sending 1038 bytes from file Logs/20190306T214038/Express0008.lzma
2019-03-06T21:59:35.550Z,1551909575.550 [DataOverHttps](INFO): Moved sent file to Logs/20190306T214038/Express0008.lzma.bak
2019-03-06T21:59:35.551Z,1551909575.551 [DataOverHttps](INFO): SBD MOMSN=10089617
2019-03-06T21:59:36.152Z,1551909576.152 [Default:CheckIn:Read_Iridium] Stopped
2019-03-06T21:59:36.152Z,1551909576.152 [Default:CheckIn:C.Wait] Running Loop=1
2019-03-06T21:59:36.152Z,1551909576.152 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-03-06T21:59:36.519Z,1551909576.519 [Micromodem](INFO): Nmea in: $CAREV,215926,COPROC,0.10.0.46*4B
2019-03-06T21:59:36.520Z,1551909576.520 [Micromodem](INFO): Nmea in: $CAREV,215936,AUV,2.0.27690*1F
2019-03-06T21:59:46.619Z,1551909586.619 [Micromodem](INFO): Nmea in: $CAREV,215936,COPROC,0.10.0.46*4A
2019-03-06T21:59:46.620Z,1551909586.620 [Micromodem](INFO): Nmea in: $CAREV,215946,AUV,2.0.27690*18
2019-03-06T21:59:50.258Z,1551909590.258 [NAL9602](INFO): Powering down
2019-03-06T21:59:56.316Z,1551909596.316 [Micromodem](INFO): Nmea in: $CAREV,215946,COPROC,0.10.0.46*4D
2019-03-06T21:59:56.317Z,1551909596.317 [Micromodem](INFO): Nmea in: $CAREV,215956,AUV,2.0.27690*19
2019-03-06T22:00:06.419Z,1551909606.419 [Micromodem](INFO): Nmea in: $CAREV,215956,COPROC,0.10.0.46*4C
2019-03-06T22:00:06.420Z,1551909606.420 [Micromodem](INFO): Nmea in: $CAREV,220006,AUV,2.0.27690*13
2019-03-06T22:00:16.515Z,1551909616.515 [Micromodem](INFO): Nmea in: $CAREV,220006,COPROC,0.10.0.46*46
2019-03-06T22:00:16.516Z,1551909616.516 [Micromodem](INFO): Nmea in: $CAREV,220016,AUV,2.0.27690*12
2019-03-06T22:00:26.615Z,1551909626.615 [Micromodem](INFO): Nmea in: $CAREV,220016,COPROC,0.10.0.46*47
2019-03-06T22:00:26.616Z,1551909626.616 [Micromodem](INFO): Nmea in: $CAREV,220026,AUV,2.0.27690*11
2019-03-06T22:00:36.311Z,1551909636.311 [Micromodem](INFO): Nmea in: $CAREV,220026,COPROC,0.10.0.46*44
2019-03-06T22:00:36.312Z,1551909636.312 [Micromodem](INFO): Nmea in: $CAREV,220036,AUV,2.0.27690*10
2019-03-06T22:00:46.411Z,1551909646.411 [Micromodem](INFO): Nmea in: $CAREV,220036,COPROC,0.10.0.46*45
2019-03-06T22:00:46.412Z,1551909646.412 [Micromodem](INFO): Nmea in: $CAREV,220046,AUV,2.0.27690*17
2019-03-06T22:00:56.511Z,1551909656.511 [Micromodem](INFO): Nmea in: $CAREV,220046,COPROC,0.10.0.46*42
2019-03-06T22:00:56.512Z,1551909656.512 [Micromodem](INFO): Nmea in: $CAREV,220056,AUV,2.0.27690*16
2019-03-06T22:00:59.765Z,1551909659.765 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:00:59.765Z,1551909659.765 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-03-06T22:00:59.765Z,1551909659.765 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T22:00:59.767Z,1551909659.767 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:00:59.767Z,1551909659.767 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2019-03-06T22:00:59.767Z,1551909659.767 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T22:00:59.769Z,1551909659.769 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:00:59.769Z,1551909659.769 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 7
2019-03-06T22:00:59.770Z,1551909659.770 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T22:00:59.809Z,1551909659.809 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T22:00:59.809Z,1551909659.809 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T22:00:59.809Z,1551909659.809 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T22:01:00.186Z,1551909660.186 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T22:01:00.186Z,1551909660.186 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-03-06T22:01:00.186Z,1551909660.186 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T22:01:00.186Z,1551909660.186 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2019-03-06T22:01:00.187Z,1551909660.187 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T22:01:00.187Z,1551909660.187 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 7
2019-03-06T22:01:00.580Z,1551909660.580 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T22:01:06.611Z,1551909666.611 [Micromodem](INFO): Nmea in: $CAREV,220056,COPROC,0.10.0.46*43
2019-03-06T22:01:06.612Z,1551909666.612 [Micromodem](INFO): Nmea in: $CAREV,220106,AUV,2.0.27690*12
2019-03-06T22:01:16.307Z,1551909676.307 [Micromodem](INFO): Nmea in: $CAREV,220106,COPROC,0.10.0.46*47
2019-03-06T22:01:16.711Z,1551909676.711 [Micromodem](INFO): Nmea in: $CAREV,220116,AUV,2.0.27690*13
2019-03-06T22:01:26.407Z,1551909686.407 [Micromodem](INFO): Nmea in: $CAREV,220116,COPROC,0.10.0.46*46
2019-03-06T22:01:26.408Z,1551909686.408 [Micromodem](INFO): Nmea in: $CAREV,220126,AUV,2.0.27690*10
2019-03-06T22:01:36.507Z,1551909696.507 [Micromodem](INFO): Nmea in: $CAREV,220126,COPROC,0.10.0.46*45
2019-03-06T22:01:36.508Z,1551909696.508 [Micromodem](INFO): Nmea in: $CAREV,220136,AUV,2.0.27690*11
2019-03-06T22:01:46.611Z,1551909706.611 [Micromodem](INFO): Nmea in: $CAREV,220136,COPROC,0.10.0.46*44
2019-03-06T22:01:46.612Z,1551909706.612 [Micromodem](INFO): Nmea in: $CAREV,220146,AUV,2.0.27690*16
2019-03-06T22:01:56.707Z,1551909716.707 [Micromodem](INFO): Nmea in: $CAREV,220146,COPROC,0.10.0.46*43
2019-03-06T22:01:56.708Z,1551909716.708 [Micromodem](INFO): Nmea in: $CAREV,220156,AUV,2.0.27690*17
2019-03-06T22:02:06.403Z,1551909726.403 [Micromodem](INFO): Nmea in: $CAREV,220156,COPROC,0.10.0.46*42
2019-03-06T22:02:06.404Z,1551909726.404 [Micromodem](INFO): Nmea in: $CAREV,220206,AUV,2.0.27690*11
2019-03-06T22:02:16.503Z,1551909736.503 [Micromodem](INFO): Nmea in: $CAREV,220206,COPROC,0.10.0.46*44
2019-03-06T22:02:16.504Z,1551909736.504 [Micromodem](INFO): Nmea in: $CAREV,220216,AUV,2.0.27690*10
2019-03-06T22:02:26.603Z,1551909746.603 [Micromodem](INFO): Nmea in: $CAREV,220216,COPROC,0.10.0.46*45
2019-03-06T22:02:26.604Z,1551909746.604 [Micromodem](INFO): Nmea in: $CAREV,220226,AUV,2.0.27690*13
2019-03-06T22:02:36.703Z,1551909756.703 [Micromodem](INFO): Nmea in: $CAREV,220226,COPROC,0.10.0.46*46
2019-03-06T22:02:36.704Z,1551909756.704 [Micromodem](INFO): Nmea in: $CAREV,220236,AUV,2.0.27690*12
2019-03-06T22:02:46.399Z,1551909766.399 [Micromodem](INFO): Nmea in: $CAREV,220236,COPROC,0.10.0.46*47
2019-03-06T22:02:46.400Z,1551909766.400 [Micromodem](INFO): Nmea in: $CAREV,220246,AUV,2.0.27690*15
2019-03-06T22:02:56.499Z,1551909776.499 [Micromodem](INFO): Nmea in: $CAREV,220246,COPROC,0.10.0.46*40
2019-03-06T22:02:56.500Z,1551909776.500 [Micromodem](INFO): Nmea in: $CAREV,220256,AUV,2.0.27690*14
2019-03-06T22:03:00.971Z,1551909780.971 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:03:00.971Z,1551909780.971 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-03-06T22:03:00.971Z,1551909780.971 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T22:03:00.973Z,1551909780.973 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:03:00.973Z,1551909780.973 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2019-03-06T22:03:00.973Z,1551909780.973 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T22:03:00.975Z,1551909780.975 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:03:00.975Z,1551909780.975 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 8
2019-03-06T22:03:00.975Z,1551909780.975 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T22:03:00.987Z,1551909780.987 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T22:03:00.987Z,1551909780.987 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T22:03:00.987Z,1551909780.987 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T22:03:01.391Z,1551909781.391 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T22:03:01.391Z,1551909781.391 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-03-06T22:03:01.391Z,1551909781.391 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T22:03:01.391Z,1551909781.391 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2019-03-06T22:03:01.392Z,1551909781.392 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T22:03:01.392Z,1551909781.392 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 8
2019-03-06T22:03:01.780Z,1551909781.780 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T22:03:06.599Z,1551909786.599 [Micromodem](INFO): Nmea in: $CAREV,220256,COPROC,0.10.0.46*41
2019-03-06T22:03:06.600Z,1551909786.600 [Micromodem](INFO): Nmea in: $CAREV,220306,AUV,2.0.27690*10
2019-03-06T22:03:14.111Z,1551909794.111 [CommandLine](IMPORTANT): got command run ./Missions/Maintenance/DUSBL.xml
2019-03-06T22:03:14.111Z,1551909794.111 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/DUSBL.xml
2019-03-06T22:03:14.208Z,1551909794.208 [MissionManager](INFO): DefineArg DUSBL.MissionTimeout = 90.000000 min
2019-03-06T22:03:14.210Z,1551909794.210 [MissionManager](INFO): DefineArg DUSBL.NumberOfRequests = 10.000000 count
2019-03-06T22:03:14.212Z,1551909794.212 [MissionManager](INFO): DefineArg DUSBL.TransponderCode = 2.000000 count
2019-03-06T22:03:14.214Z,1551909794.214 [MissionManager](INFO): DefineArg DUSBL.NumberOfPings = 1.000000 count
2019-03-06T22:03:14.217Z,1551909794.217 [MissionManager](INFO): DefineArg DUSBL.EnabledDUSBL = 1.000000 bool
2019-03-06T22:03:14.218Z,1551909794.218 [DUSBL:A.Pitch](DEBUG): Construct.
2019-03-06T22:03:14.222Z,1551909794.222 [DUSBL:B.SetSpeed](DEBUG): Construct.
2019-03-06T22:03:14.229Z,1551909794.229 [DUSBL:RequestRepeater:C.Wait](DEBUG): Construct Wait.
2019-03-06T22:03:14.233Z,1551909794.233 [MissionManager](DEBUG):
This mission is requests a DUSBL arming.
How long to let the mission run.
90
Number of pings to requst.
10
Transponder Address.
2
Number of pings requested each time.
1
Automatically set to true if the DUSBL is enabled. Set to false to disable
reading from the DUSBL.
0
10
2019-03-06T22:03:14.235Z,1551909794.235 [CommandLine](IMPORTANT): Running ./Missions/Maintenance/DUSBL.xml
2019-03-06T22:03:14.317Z,1551909794.317 [Default] Stopped
2019-03-06T22:03:14.317Z,1551909794.317 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-06T22:03:14.317Z,1551909794.317 [Default:B.GoToSurface] Stopped
2019-03-06T22:03:14.318Z,1551909794.318 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-06T22:03:14.318Z,1551909794.318 [Default:CheckIn] Stopped
2019-03-06T22:03:14.318Z,1551909794.318 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-06T22:03:14.318Z,1551909794.318 [Default:CheckIn:C.Wait] Stopped
2019-03-06T22:03:14.318Z,1551909794.318 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T22:03:14.318Z,1551909794.318 [MissionManager](IMPORTANT): Started mission DUSBL
2019-03-06T22:03:14.318Z,1551909794.318 [DUSBL] Running Loop=1
2019-03-06T22:03:14.318Z,1551909794.318 [DUSBL](DEBUG): Aggregate::initialize DUSBL
2019-03-06T22:03:14.319Z,1551909794.319 [DUSBL:A.Pitch] Running Loop=1
2019-03-06T22:03:14.319Z,1551909794.319 [DUSBL:A.Pitch](DEBUG): Initialize.
2019-03-06T22:03:14.319Z,1551909794.319 [DUSBL:B.SetSpeed] Running Loop=1
2019-03-06T22:03:14.319Z,1551909794.319 [DUSBL:B.SetSpeed](DEBUG): Initialize.
2019-03-06T22:03:14.319Z,1551909794.319 [DUSBL:C] Running Loop=1
2019-03-06T22:03:14.319Z,1551909794.319 [DUSBL:RequestRepeater] Running Loop=1
2019-03-06T22:03:14.319Z,1551909794.319 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-06T22:03:14.320Z,1551909794.320 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-06T22:03:14.320Z,1551909794.320 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-06T22:03:14.320Z,1551909794.320 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-06T22:03:14.320Z,1551909794.320 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-06T22:03:14.320Z,1551909794.320 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-06T22:03:14.320Z,1551909794.320 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-06T22:03:14.321Z,1551909794.321 [DUSBL:C] Running Loop=1
2019-03-06T22:03:14.321Z,1551909794.321 [DUSBL:C](DEBUG): Initialize ReadDataComponent to sense DUSBL_Hydroid.range
2019-03-06T22:03:14.322Z,1551909794.322 [DUSBL:C](DEBUG): Initialize ReadDataComponent to sense DUSBL_Hydroid.direction
2019-03-06T22:03:14.322Z,1551909794.322 [DUSBL:B.SetSpeed] Running Loop=1
2019-03-06T22:03:14.322Z,1551909794.322 [DUSBL:A.Pitch] Running Loop=1
2019-03-06T22:03:15.901Z,1551909795.901 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-06T22:03:16.699Z,1551909796.699 [Micromodem](INFO): Nmea in: $CAREV,220306,COPROC,0.10.0.46*45
2019-03-06T22:03:16.700Z,1551909796.700 [Micromodem](INFO): Nmea in: $CAREV,220316,AUV,2.0.27690*11
2019-03-06T22:03:19.931Z,1551909799.931 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-06T22:03:23.971Z,1551909803.971 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-03-06T22:03:24.374Z,1551909804.374 [DUSBL_Hydroid](FAULT): unknown deviceResponse_: !U1,P
2019-03-06T22:03:24.374Z,1551909804.374 [DUSBL_Hydroid] Communications Fault, FailCount= 3
2019-03-06T22:03:24.374Z,1551909804.374 [DUSBL_Hydroid](ERROR): Communications Fault
2019-03-06T22:03:24.415Z,1551909804.415 [DUSBL:RequestRepeater:C.Wait](INFO): Done Waiting.
2019-03-06T22:03:24.415Z,1551909804.415 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-06T22:03:24.415Z,1551909804.415 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T22:03:24.415Z,1551909804.415 [DUSBL:RequestRepeater](INFO): Completed DUSBL:RequestRepeater
2019-03-06T22:03:24.415Z,1551909804.415 [DUSBL:RequestRepeater] Stopped
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater:A] Stopped
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater:B] Stopped
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater](INFO): Running loop #2
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater] Running Loop=2
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater:A] Running Loop=1
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater:B] Running Loop=1
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater:C.Wait] Running Loop=1
2019-03-06T22:03:24.416Z,1551909804.416 [DUSBL:RequestRepeater:C.Wait](DEBUG): Initialize Wait Component.
2019-03-06T22:03:24.442Z,1551909804.442 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-03-06T22:03:24.786Z,1551909804.786 [DUSBL_Hydroid](INFO): Powering down
2019-03-06T22:03:25.643Z,1551909805.643 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-03-06T22:03:25.643Z,1551909805.643 [DUSBL_Hydroid] No Fault, FailCount= 3
2019-03-06T22:03:26.395Z,1551909806.395 [Micromodem](INFO): Nmea in: $CAREV,220316,COPROC,0.10.0.46*44
2019-03-06T22:03:26.396Z,1551909806.396 [Micromodem](INFO): Nmea in: $CAREV,220326,AUV,2.0.27690*12
2019-03-06T22:03:28.010Z,1551909808.010 [DUSBL_Hydroid](INFO): Powering up
2019-03-06T22:03:28.011Z,1551909808.011 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-03-06T22:03:28.726Z,1551909808.726 [CommandLine](IMPORTANT): got command stop
2019-03-06T22:03:28.727Z,1551909808.727 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2019-03-06T22:03:28.850Z,1551909808.850 [MissionManager](INFO): MissionManager is completed.
2019-03-06T22:03:28.850Z,1551909808.850 [MissionManager](INFO): Uninitializing Mission DUSBL
2019-03-06T22:03:28.850Z,1551909808.850 [DUSBL] Stopped
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL](DEBUG): Aggregate::uninitialize DUSBL
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:A.Pitch] Stopped
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:B.SetSpeed] Stopped
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:B.SetSpeed](DEBUG): Uninitialize.
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:C] Stopped
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:RequestRepeater] Stopped
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:RequestRepeater:A] Stopped
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:RequestRepeater:B] Stopped
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:RequestRepeater:C.Wait] Stopped
2019-03-06T22:03:28.851Z,1551909808.851 [DUSBL:RequestRepeater:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-06T22:03:29.255Z,1551909809.255 [MissionManager](IMPORTANT): Started mission Default
2019-03-06T22:03:29.255Z,155