2019-03-06T22:13:27.181Z,1551910407.181 [Supervisor](DEBUG): Initializing supervisor.
2019-03-06T22:13:27.184Z,1551910407.184 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-03-06T22:13:27.185Z,1551910407.185 [SyncHandler](INFO): Protected caller Thread ID is 804
2019-03-06T22:13:27.185Z,1551910407.185 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-03-06T22:13:27.186Z,1551910407.186 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-03-06T22:13:27.186Z,1551910407.186 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 805
2019-03-06T22:13:27.189Z,1551910407.189 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-03-06T22:13:27.200Z,1551910407.200 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-03-06T22:13:27.201Z,1551910407.201 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-03-06T22:13:27.202Z,1551910407.202 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 806
2019-03-06T22:13:27.203Z,1551910407.203 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-03-06T22:13:27.203Z,1551910407.203 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-03-06T22:13:27.204Z,1551910407.204 [logger ThreadHandler](INFO): Protected caller Thread ID is 807
2019-03-06T22:13:27.206Z,1551910407.206 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-03-06T22:13:27.206Z,1551910407.206 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-03-06T22:13:27.209Z,1551910407.209 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-03-06T22:13:27.662Z,1551910407.662 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-03-06T22:13:27.664Z,1551910407.664 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-03-06T22:13:27.765Z,1551910407.765 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-03-06T22:13:27.767Z,1551910407.767 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-03-06T22:13:28.122Z,1551910408.122 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-03-06T22:13:28.123Z,1551910408.123 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-03-06T22:13:28.273Z,1551910408.273 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-03-06T22:13:28.275Z,1551910408.275 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-03-06T22:13:28.479Z,1551910408.479 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-03-06T22:13:28.481Z,1551910408.481 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-03-06T22:13:28.974Z,1551910408.974 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-03-06T22:13:28.975Z,1551910408.975 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-03-06T22:13:29.199Z,1551910409.199 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-03-06T22:13:29.200Z,1551910409.200 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-03-06T22:13:29.354Z,1551910409.354 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-03-06T22:13:29.354Z,1551910409.354 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-03-06T22:13:29.566Z,1551910409.566 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-03-06T22:13:29.566Z,1551910409.566 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-03-06T22:13:29.666Z,1551910409.666 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-03-06T22:13:29.666Z,1551910409.666 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-03-06T22:13:29.998Z,1551910409.998 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-03-06T22:13:29.999Z,1551910409.999 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-03-06T22:13:30.080Z,1551910410.080 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-03-06T22:13:30.187Z,1551910410.187 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-03-06T22:13:30.188Z,1551910410.188 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-03-06T22:13:30.723Z,1551910410.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-03-06T22:13:30.723Z,1551910410.723 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-03-06T22:13:31.885Z,1551910411.885 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-03-06T22:13:31.887Z,1551910411.887 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2019-03-06T22:13:31.891Z,1551910411.891 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2019-03-06T22:13:32.116Z,1551910412.116 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2019-03-06T22:13:32.221Z,1551910412.221 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2019-03-06T22:13:32.325Z,1551910412.325 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2019-03-06T22:13:32.560Z,1551910412.560 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-03-06T22:13:32.561Z,1551910412.561 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2019-03-06T22:13:32.647Z,1551910412.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2019-03-06T22:13:32.744Z,1551910412.744 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2019-03-06T22:13:32.846Z,1551910412.846 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2019-03-06T22:13:32.930Z,1551910412.930 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2019-03-06T22:13:33.043Z,1551910413.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2019-03-06T22:13:33.228Z,1551910413.228 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2019-03-06T22:13:33.366Z,1551910413.366 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2019-03-06T22:13:33.369Z,1551910413.369 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-03-06T22:13:34.065Z,1551910414.065 [AHRS_M2] Loaded
2019-03-06T22:13:34.065Z,1551910414.065 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-03-06T22:13:34.206Z,1551910414.206 [DataOverHttps] Loaded
2019-03-06T22:13:34.207Z,1551910414.207 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-03-06T22:13:34.208Z,1551910414.208 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4074D4E0
2019-03-06T22:13:34.208Z,1551910414.208 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 887
2019-03-06T22:13:34.222Z,1551910414.222 [Depth_Keller] Loaded
2019-03-06T22:13:34.222Z,1551910414.222 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-03-06T22:13:34.227Z,1551910414.227 [DropWeight] Loaded
2019-03-06T22:13:34.227Z,1551910414.227 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-03-06T22:13:34.276Z,1551910414.276 [DUSBL_Hydroid] Loaded
2019-03-06T22:13:34.276Z,1551910414.276 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2019-03-06T22:13:34.316Z,1551910414.316 [Micromodem] Loaded
2019-03-06T22:13:34.316Z,1551910414.316 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2019-03-06T22:13:34.416Z,1551910414.416 [NAL9602] Loaded
2019-03-06T22:13:34.416Z,1551910414.416 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-03-06T22:13:34.433Z,1551910414.433 [Onboard] Loaded
2019-03-06T22:13:34.433Z,1551910414.433 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-03-06T22:13:34.440Z,1551910414.440 [Radio_Surface] Loaded
2019-03-06T22:13:34.440Z,1551910414.440 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-03-06T22:13:34.441Z,1551910414.441 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4077D4E0
2019-03-06T22:13:34.441Z,1551910414.441 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 888
2019-03-06T22:13:34.486Z,1551910414.486 [RDI_Pathfinder] Loaded
2019-03-06T22:13:34.486Z,1551910414.486 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2019-03-06T22:13:34.508Z,1551910414.508 [RDI_PathfinderUp] Loaded
2019-03-06T22:13:34.508Z,1551910414.508 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2019-03-06T22:13:36.319Z,1551910416.319 [BPC1] Loaded
2019-03-06T22:13:36.319Z,1551910416.319 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-03-06T22:13:36.320Z,1551910416.320 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-03-06T22:13:36.320Z,1551910416.320 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-03-06T22:13:36.365Z,1551910416.365 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-03-06T22:13:36.365Z,1551910416.365 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-03-06T22:13:36.990Z,1551910416.990 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-03-06T22:13:36.990Z,1551910416.990 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-03-06T22:13:37.051Z,1551910417.051 [DeadReckonUsingSpeedCalculator] Loaded
2019-03-06T22:13:37.051Z,1551910417.051 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-03-06T22:13:37.112Z,1551910417.112 [DeadReckonWithRespectToSeafloor] Loaded
2019-03-06T22:13:37.112Z,1551910417.112 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-03-06T22:13:37.133Z,1551910417.133 [NavChart] Loaded
2019-03-06T22:13:37.133Z,1551910417.133 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-03-06T22:13:37.137Z,1551910417.137 [UniversalFixResidualReporter] Loaded
2019-03-06T22:13:37.137Z,1551910417.137 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-03-06T22:13:37.138Z,1551910417.138 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-03-06T22:13:37.139Z,1551910417.139 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-03-06T22:13:37.263Z,1551910417.263 [BuoyancyServo] Loaded
2019-03-06T22:13:37.263Z,1551910417.263 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-03-06T22:13:37.278Z,1551910417.278 [ElevatorServo] Loaded
2019-03-06T22:13:37.279Z,1551910417.279 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-03-06T22:13:37.294Z,1551910417.294 [MassServo] Loaded
2019-03-06T22:13:37.294Z,1551910417.294 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-03-06T22:13:37.310Z,1551910417.310 [RudderServo] Loaded
2019-03-06T22:13:37.310Z,1551910417.310 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-03-06T22:13:37.325Z,1551910417.325 [ThrusterServo] Loaded
2019-03-06T22:13:37.325Z,1551910417.325 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-03-06T22:13:37.326Z,1551910417.326 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-03-06T22:13:37.326Z,1551910417.326 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-03-06T22:13:37.584Z,1551910417.584 [Aanderaa_O2] Loaded
2019-03-06T22:13:37.585Z,1551910417.585 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-03-06T22:13:37.670Z,1551910417.670 [CTD_NeilBrown] Loaded
2019-03-06T22:13:37.670Z,1551910417.670 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-03-06T22:13:37.671Z,1551910417.671 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408C24E0
2019-03-06T22:13:37.672Z,1551910417.672 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 889
2019-03-06T22:13:37.717Z,1551910417.717 [WetLabsSeaOWL_UV_A] Loaded
2019-03-06T22:13:37.718Z,1551910417.718 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2019-03-06T22:13:37.719Z,1551910417.719 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408F24E0
2019-03-06T22:13:37.719Z,1551910417.719 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 890
2019-03-06T22:13:37.720Z,1551910417.720 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-03-06T22:13:37.720Z,1551910417.720 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-03-06T22:13:38.221Z,1551910418.221 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-03-06T22:13:38.222Z,1551910418.222 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-03-06T22:13:38.280Z,1551910418.280 [DepthRateCalculator] Loaded
2019-03-06T22:13:38.280Z,1551910418.280 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-03-06T22:13:38.286Z,1551910418.286 [PitchRateCalculator] Loaded
2019-03-06T22:13:38.286Z,1551910418.286 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-03-06T22:13:38.299Z,1551910418.299 [SpeedCalculator] Loaded
2019-03-06T22:13:38.300Z,1551910418.300 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-03-06T22:13:38.321Z,1551910418.321 [TempGradientCalculator] Loaded
2019-03-06T22:13:38.321Z,1551910418.321 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-03-06T22:13:38.327Z,1551910418.327 [YawRateCalculator] Loaded
2019-03-06T22:13:38.327Z,1551910418.327 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-03-06T22:13:38.368Z,1551910418.368 [ElevatorOffsetCalculator] Loaded
2019-03-06T22:13:38.368Z,1551910418.368 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-03-06T22:13:38.369Z,1551910418.369 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-03-06T22:13:38.371Z,1551910418.371 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-03-06T22:13:38.532Z,1551910418.532 [SBIT](DEBUG): Construct Startup Built In Test.
2019-03-06T22:13:38.555Z,1551910418.555 [SBIT] Loaded
2019-03-06T22:13:38.555Z,1551910418.555 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-03-06T22:13:38.556Z,1551910418.556 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-03-06T22:13:38.567Z,1551910418.567 [IBIT] Loaded
2019-03-06T22:13:38.568Z,1551910418.568 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-03-06T22:13:38.571Z,1551910418.571 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-03-06T22:13:38.714Z,1551910418.714 [CBIT] Loaded
2019-03-06T22:13:38.715Z,1551910418.715 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-03-06T22:13:38.715Z,1551910418.715 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-03-06T22:13:38.716Z,1551910418.716 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-03-06T22:13:38.818Z,1551910418.818 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-03-06T22:13:38.819Z,1551910418.819 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-03-06T22:13:38.944Z,1551910418.944 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-03-06T22:13:38.944Z,1551910418.944 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-03-06T22:13:39.032Z,1551910419.032 [VerticalControl](DEBUG): Construct VerticalControl.
2019-03-06T22:13:39.119Z,1551910419.119 [VerticalControl] Loaded
2019-03-06T22:13:39.119Z,1551910419.119 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-03-06T22:13:39.120Z,1551910419.120 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-03-06T22:13:39.179Z,1551910419.179 [HorizontalControl] Loaded
2019-03-06T22:13:39.179Z,1551910419.179 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-03-06T22:13:39.180Z,1551910419.180 [SpeedControl](DEBUG): Construct SpeedControl.
2019-03-06T22:13:39.181Z,1551910419.181 [SpeedControl] Loaded
2019-03-06T22:13:39.182Z,1551910419.182 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-03-06T22:13:39.182Z,1551910419.182 [LoopControl](DEBUG): Construct LoopControl.
2019-03-06T22:13:39.183Z,1551910419.183 [LoopControl] Loaded
2019-03-06T22:13:39.183Z,1551910419.183 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-03-06T22:13:39.184Z,1551910419.184 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-03-06T22:13:39.184Z,1551910419.184 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-03-06T22:13:39.226Z,1551910419.226 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-03-06T22:13:39.229Z,1551910419.229 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-03-06T22:13:39.230Z,1551910419.230 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-03-06T22:13:39.237Z,1551910419.237 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-03-06T22:13:39.238Z,1551910419.238 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AB04E0
2019-03-06T22:13:39.238Z,1551910419.238 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 891
2019-03-06T22:13:39.243Z,1551910419.243 [Supervisor](INFO): Main Thread ID is 800
2019-03-06T22:13:39.243Z,1551910419.243 [Supervisor](DEBUG): Running supervisor.
2019-03-06T22:13:39.244Z,1551910419.244 [CommandLine ThreadHandler](INFO): Handler Thread ID is 892
2019-03-06T22:13:39.246Z,1551910419.246 [controlThread ThreadHandler](INFO): Handler Thread ID is 893
2019-03-06T22:13:39.247Z,1551910419.247 [controlThread](DEBUG): Initializing ControlThread
2019-03-06T22:13:39.252Z,1551910419.252 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T22:13:39.253Z,1551910419.253 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-03-06T22:13:39.253Z,1551910419.253 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-03-06T22:13:39.255Z,1551910419.255 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-03-06T22:13:39.255Z,1551910419.255 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-03-06T22:13:39.255Z,1551910419.255 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-03-06T22:13:39.256Z,1551910419.256 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-03-06T22:13:39.256Z,1551910419.256 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-03-06T22:13:39.256Z,1551910419.256 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-03-06T22:13:39.257Z,1551910419.257 [SBIT](INFO): Initialize SBIT Component.
2019-03-06T22:13:39.258Z,1551910419.258 [SBIT](IMPORTANT): git: 2019-03-04-36-g743def3
2019-03-06T22:13:39.258Z,1551910419.258 [SBIT](INFO): git hash: 743def31acf12ef8e20e672f0fefb031590b97fa
2019-03-06T22:13:39.258Z,1551910419.258 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-03-06T22:13:39.258Z,1551910419.258 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2019-03-06T22:13:39.259Z,1551910419.259 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-03-06T22:13:39.260Z,1551910419.260 [IBIT](INFO): Initialize IBIT Component.
2019-03-06T22:13:39.261Z,1551910419.261 [CBIT](DEBUG): Initialize CBIT Component.
2019-03-06T22:13:39.262Z,1551910419.262 [logger ThreadHandler](INFO): Handler Thread ID is 894
2019-03-06T22:13:39.273Z,1551910419.273 [CBIT](DEBUG): Initialized mux pins.
2019-03-06T22:13:39.273Z,1551910419.273 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2019-03-06T22:13:39.273Z,1551910419.273 [CBIT](DEBUG): Initializing the watchdog timer.
2019-03-06T22:13:39.281Z,1551910419.281 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 895
2019-03-06T22:13:39.282Z,1551910419.282 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-03-06T22:13:39.293Z,1551910419.293 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 896
2019-03-06T22:13:39.297Z,1551910419.297 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-03-06T22:13:39.297Z,1551910419.297 [CBIT](DEBUG): Initializing heartbeat.
2019-03-06T22:13:39.305Z,1551910419.305 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 897
2019-03-06T22:13:39.306Z,1551910419.306 [CTD_NeilBrown](INFO): Powering down
2019-03-06T22:13:39.333Z,1551910419.333 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 898
2019-03-06T22:13:39.334Z,1551910419.334 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-03-06T22:13:39.369Z,1551910419.369 [CBIT](DEBUG): Deactivating GF circuits.
2019-03-06T22:13:39.369Z,1551910419.369 [CBIT](DEBUG): Deactivating emergency mode.
2019-03-06T22:13:39.370Z,1551910419.370 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 899
2019-03-06T22:13:39.378Z,1551910419.378 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-03-06T22:13:39.378Z,1551910419.378 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-03-06T22:13:39.378Z,1551910419.378 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-03-06T22:13:39.378Z,1551910419.378 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-03-06T22:13:39.378Z,1551910419.378 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-03-06T22:13:39.379Z,1551910419.379 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-03-06T22:13:39.379Z,1551910419.379 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-03-06T22:13:39.379Z,1551910419.379 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-03-06T22:13:39.379Z,1551910419.379 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-03-06T22:13:39.379Z,1551910419.379 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-03-06T22:13:39.379Z,1551910419.379 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-03-06T22:13:39.380Z,1551910419.380 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-03-06T22:13:39.380Z,1551910419.380 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-03-06T22:13:39.380Z,1551910419.380 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-03-06T22:13:39.380Z,1551910419.380 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-03-06T22:13:39.380Z,1551910419.380 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-03-06T22:13:39.405Z,1551910419.405 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-03-06T22:13:39.407Z,1551910419.407 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-03-06T22:13:39.408Z,1551910419.408 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-03-06T22:13:39.408Z,1551910419.408 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-03-06T22:13:39.409Z,1551910419.409 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-03-06T22:13:39.438Z,1551910419.438 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-06T22:13:39.448Z,1551910419.448 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2019-03-06T22:13:39.449Z,1551910419.449 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-03-06T22:13:39.522Z,1551910419.522 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-03-06T22:13:39.523Z,1551910419.523 [Default:A.Wait](DEBUG): Construct Wait.
2019-03-06T22:13:39.524Z,1551910419.524 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-06T22:13:39.552Z,1551910419.552 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-03-06T22:13:39.593Z,1551910419.593 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-03-06T22:13:39.598Z,1551910419.598 [Default:E.Execute](DEBUG): Construct Execute.
2019-03-06T22:13:39.627Z,1551910419.627 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2019-03-06T22:13:39.632Z,1551910419.632 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,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-06T22:13:39.653Z,1551910419.653 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-06T22:13:39.697Z,1551910419.697 [Radio_Surface](INFO): Powering up
2019-03-06T22:13:39.762Z,1551910419.762 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2019-03-06T22:13:39.763Z,1551910419.763 [DUSBL_Hydroid](INFO): Powering up
2019-03-06T22:13:39.763Z,1551910419.763 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-03-06T22:13:39.845Z,1551910419.845 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-06T22:13:39.918Z,1551910419.918 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-06T22:13:39.925Z,1551910419.925 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-06T22:13:39.926Z,1551910419.926 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-06T22:13:39.933Z,1551910419.933 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-06T22:13:39.934Z,1551910419.934 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-06T22:13:39.941Z,1551910419.941 [MassServo](DEBUG): Initializing MassServo.
2019-03-06T22:13:39.942Z,1551910419.942 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-06T22:13:39.949Z,1551910419.949 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-06T22:13:39.950Z,1551910419.950 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-03-06T22:13:39.957Z,1551910419.957 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-03-06T22:13:40.059Z,1551910420.059 [Micromodem](INFO): Powering up
2019-03-06T22:13:40.059Z,1551910420.059 [Micromodem](DEBUG): Initializing Micromodem.
2019-03-06T22:13:40.165Z,1551910420.165 [RDI_PathfinderUp](INFO): Powering down
2019-03-06T22:13:40.233Z,1551910420.233 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-06T22:13:40.469Z,1551910420.469 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-03-06T22:13:40.785Z,1551910420.785 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2019-03-06T22:13:40.785Z,1551910420.785 [RudderServo](FAULT): Rudder failed to initialize
2019-03-06T22:13:40.785Z,1551910420.785 [RudderServo] Communications Fault, FailCount= 1
2019-03-06T22:13:40.785Z,1551910420.785 [RudderServo](ERROR): Communications Fault
2019-03-06T22:13:40.956Z,1551910420.956 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-03-06T22:13:41.135Z,1551910421.135 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-06T22:13:41.135Z,1551910421.135 [RudderServo](INFO): Powering down
2019-03-06T22:13:41.819Z,1551910421.819 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-06T22:13:41.938Z,1551910421.938 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-06T22:13:41.942Z,1551910421.942 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-06T22:13:41.942Z,1551910421.942 [RudderServo] No Fault, FailCount= 1
2019-03-06T22:13:43.305Z,1551910423.305 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:43.445Z,1551910423.445 [Aanderaa_O2](INFO): Powering down
2019-03-06T22:13:43.845Z,1551910423.845 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:44.349Z,1551910424.349 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:44.356Z,1551910424.356 [Micromodem](INFO): Nmea in: $CAREV,221200,INIT,2.0.27690*4E

2019-03-06T22:13:44.917Z,1551910424.917 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:44.923Z,1551910424.923 [Micromodem](INFO): Nmea in: $CAREV,221200,SLOT1,2.0.27690*61

2019-03-06T22:13:44.924Z,1551910424.924 [Micromodem](INFO): Nmea in: $CAREV,221200,AUV,2.0.27690*16

2019-03-06T22:13:44.925Z,1551910424.925 [Micromodem](DEBUG): Nmea buf: $CCCFG,CST,1*37

2019-03-06T22:13:44.925Z,1551910424.925 [Micromodem](INFO): Nmea out: $CCCFG,CST,1*37

2019-03-06T22:13:44.926Z,1551910424.926 [Micromodem](DEBUG): Nmea buf: $CCCFG,SRC,1*31

2019-03-06T22:13:44.926Z,1551910424.926 [Micromodem](DEBUG): Nmea buf: $CCCFG,REV,1*32

2019-03-06T22:13:44.926Z,1551910424.926 [Micromodem](DEBUG): Nmea buf: $CCCFG,RXP,1*29

2019-03-06T22:13:45.341Z,1551910425.341 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:45.348Z,1551910425.348 [Micromodem](INFO): Nmea in: $CAREV,221200,COPROC,0.10.0.46*43

2019-03-06T22:13:45.797Z,1551910425.797 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:45.803Z,1551910425.803 [Micromodem](INFO): Nmea in: $CATMG,2019-03-06T22:12:00Z,RTC,RTC*72

2019-03-06T22:13:46.377Z,1551910426.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:47.009Z,1551910427.009 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:47.405Z,1551910427.405 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:47.821Z,1551910427.821 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:48.245Z,1551910428.245 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:48.677Z,1551910428.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:49.069Z,1551910429.069 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:49.557Z,1551910429.557 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:49.957Z,1551910429.957 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:50.349Z,1551910430.349 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:50.765Z,1551910430.765 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:51.169Z,1551910431.169 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:51.561Z,1551910431.561 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:51.977Z,1551910431.977 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:52.377Z,1551910432.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:52.785Z,1551910432.785 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:52.785Z,1551910432.785 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-06T22:13:52.785Z,1551910432.785 [AHRS_M2] Communications Fault, FailCount= 1
2019-03-06T22:13:52.785Z,1551910432.785 [AHRS_M2](ERROR): Communications Fault
2019-03-06T22:13:52.822Z,1551910432.822 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-06T22:13:52.865Z,1551910432.865 [AHRS_M2](INFO): Powering down
2019-03-06T22:13:53.062Z,1551910433.062 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2019-03-06T22:13:53.710Z,1551910433.710 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-06T22:13:53.710Z,1551910433.710 [AHRS_M2] No Fault, FailCount= 1
2019-03-06T22:13:54.077Z,1551910434.077 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-06T22:13:54.091Z,1551910434.091 [Micromodem](INFO): Nmea in: $CACFG,CST,1*35

2019-03-06T22:13:54.091Z,1551910434.091 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2019-03-06T22:13:54.487Z,1551910434.487 [Micromodem](INFO): Nmea in: $CAREV,221210,AUV,2.0.27690*17

2019-03-06T22:13:54.891Z,1551910434.891 [Micromodem](INFO): Nmea in: $CAREV,221210,COPROC,0.10.0.46*42

2019-03-06T22:13:57.633Z,1551910437.633 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:58.029Z,1551910438.029 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:58.037Z,1551910438.037 [DUSBL_Hydroid](INFO): DUSBL Version:O
2019-03-06T22:13:58.445Z,1551910438.445 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:58.837Z,1551910438.837 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:59.253Z,1551910439.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:13:59.677Z,1551910439.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:00.093Z,1551910440.093 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:00.521Z,1551910440.521 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:00.901Z,1551910440.901 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:01.329Z,1551910441.329 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:01.745Z,1551910441.745 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:02.137Z,1551910442.137 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:02.541Z,1551910442.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:02.957Z,1551910442.957 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:03.377Z,1551910443.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:03.781Z,1551910443.781 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:04.185Z,1551910444.185 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:04.191Z,1551910444.191 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2019-03-06T22:14:04.191Z,1551910444.191 [Micromodem](INFO): Nmea out: $CCCFG,REV,1*32

2019-03-06T22:14:04.617Z,1551910444.617 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:04.623Z,1551910444.623 [Micromodem](INFO): Nmea in: $CAREV,221220,AUV,2.0.27690*14

2019-03-06T22:14:04.624Z,1551910444.624 [NAL9602](INFO): Powering up NAL9602
2019-03-06T22:14:04.997Z,1551910444.997 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:05.006Z,1551910445.006 [Micromodem](INFO): Nmea in: $CAREV,221220,COPROC,0.10.0.46*41

2019-03-06T22:14:05.409Z,1551910445.409 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:05.813Z,1551910445.813 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:06.217Z,1551910446.217 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:06.621Z,1551910446.621 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:07.025Z,1551910447.025 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:07.026Z,1551910447.026 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-06T22:14:07.026Z,1551910447.026 [AHRS_M2] Communications Fault, FailCount= 2
2019-03-06T22:14:07.026Z,1551910447.026 [AHRS_M2](ERROR): Communications Fault
2019-03-06T22:14:07.106Z,1551910447.106 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-06T22:14:07.122Z,1551910447.122 [AHRS_M2](INFO): Powering down
2019-03-06T22:14:07.963Z,1551910447.963 [SBIT](IMPORTANT): Beginning Startup BIT
2019-03-06T22:14:07.967Z,1551910447.967 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-06T22:14:07.967Z,1551910447.967 [AHRS_M2] No Fault, FailCount= 2
2019-03-06T22:14:07.968Z,1551910447.968 [CBIT](IMPORTANT): Beginning ground fault scan
2019-03-06T22:14:08.333Z,1551910448.333 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-06T22:14:11.981Z,1551910451.981 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:12.649Z,1551910452.649 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:13.149Z,1551910453.149 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:13.813Z,1551910453.813 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:14.253Z,1551910454.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:14.259Z,1551910454.259 [Micromodem](INFO): Nmea in: $CACFG,REV,1*30

2019-03-06T22:14:14.259Z,1551910454.259 [Micromodem](INFO): Nmea out: $CCCFG,RXP,1*29

2019-03-06T22:14:14.693Z,1551910454.693 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:14.699Z,1551910454.699 [Micromodem](INFO): Nmea in: $CAREV,221230,AUV,2.0.27690*15

2019-03-06T22:14:15.117Z,1551910455.117 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:15.123Z,1551910455.123 [Micromodem](INFO): Nmea in: $CAREV,221230,COPROC,0.10.0.46*40

2019-03-06T22:14:15.685Z,1551910455.685 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:15.721Z,1551910455.721 [NAL9602](INFO): NAL9602 initialized
2019-03-06T22:14:16.129Z,1551910456.129 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:16.573Z,1551910456.573 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:16.593Z,1551910456.593 [NAL9602](DEBUG): Fix Requested
2019-03-06T22:14:17.121Z,1551910457.121 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:17.601Z,1551910457.601 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:18.041Z,1551910458.041 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:18.565Z,1551910458.565 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:18.977Z,1551910458.977 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:19.433Z,1551910459.433 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:20.041Z,1551910460.041 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:20.119Z,1551910460.119 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.011816
CHAN A1 (24V): -0.025794
CHAN A2 (12V): -0.007517
CHAN A3 (5V): -0.001428
CHAN B0 (3.3V): -0.000646
CHAN B1 (3.15aV): -0.000528
CHAN B2 (3.15bV): -0.000126
CHAN B3 (GND): 0.003080
OPEN: 0.012627
Full Scale Calc: 4.765 mA, -1.589 mA
2019-03-06T22:14:20.445Z,1551910460.445 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:20.853Z,1551910460.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:21.257Z,1551910461.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:21.257Z,1551910461.257 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-06T22:14:21.257Z,1551910461.257 [AHRS_M2] Communications Fault, FailCount= 3
2019-03-06T22:14:21.257Z,1551910461.257 [AHRS_M2](ERROR): Communications Fault
2019-03-06T22:14:21.369Z,1551910461.369 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-06T22:14:21.379Z,1551910461.379 [AHRS_M2](INFO): Powering down
2019-03-06T22:14:22.254Z,1551910462.254 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-06T22:14:22.254Z,1551910462.254 [AHRS_M2] No Fault, FailCount= 3
2019-03-06T22:14:22.585Z,1551910462.585 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-06T22:14:23.424Z,1551910463.424 [RDI_Pathfinder](ERROR): only read 1 of 5 data items
2019-03-06T22:14:23.424Z,1551910463.424 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,    +3    +2,    +0,A
2019-03-06T22:14:24.307Z,1551910464.307 [Micromodem](INFO): Nmea in: $CACFG,RXP,1*2B

2019-03-06T22:14:24.307Z,1551910464.307 [Micromodem](DEBUG): Nmea buf: $CCTMS,2019-03-06T22:14:25Z,0*79

2019-03-06T22:14:24.308Z,1551910464.308 [Micromodem](INFO): Nmea out: $CCTMS,2019-03-06T22:14:25Z,0*79

2019-03-06T22:14:24.711Z,1551910464.711 [Micromodem](INFO): Nmea in: $CAREV,221240,AUV,2.0.27690*12

2019-03-06T22:14:25.115Z,1551910465.115 [Micromodem](INFO): Nmea in: $CAREV,221240,COPROC,0.10.0.46*47

2019-03-06T22:14:25.519Z,1551910465.519 [Micromodem](INFO): Nmea in: $CATMS,0,2019-03-06T22:14:25Z*7B

2019-03-06T22:14:25.519Z,1551910465.519 [Micromodem](DEBUG): Nmea buf: $CCCFQ,TOP*33

2019-03-06T22:14:25.519Z,1551910465.519 [Micromodem](INFO): Nmea out: $CCCFQ,TOP*33

2019-03-06T22:14:26.033Z,1551910466.033 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:26.048Z,1551910466.048 [Micromodem](INFO): Nmea in: $CATMG,2019-03-06T22:14:25Z,USER_CMD,RTC*32

2019-03-06T22:14:26.437Z,1551910466.437 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:26.448Z,1551910466.448 [Micromodem](INFO): Nmea in: $CACFG,AGC,1*34

2019-03-06T22:14:26.461Z,1551910466.461 [Micromodem](INFO): Nmea in: $CACFG,AGN,250*3F

2019-03-06T22:14:26.471Z,1551910466.471 [Micromodem](INFO): Nmea in: $CACFG,AGX,1*2F

2019-03-06T22:14:26.853Z,1551910466.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:26.870Z,1551910466.870 [Micromodem](INFO): Nmea in: $CACFG,ASD,0*26

2019-03-06T22:14:26.880Z,1551910466.880 [Micromodem](INFO): Nmea in: $CACFG,BBD,0*34

2019-03-06T22:14:27.249Z,1551910467.249 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:27.264Z,1551910467.264 [Micromodem](INFO): Nmea in: $CACFG,BND,3*3B

2019-03-06T22:14:27.317Z,1551910467.317 [Micromodem](INFO): Nmea in: $CACFG,BR1,3*52

2019-03-06T22:14:27.662Z,1551910467.662 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:27.686Z,1551910467.686 [Micromodem](INFO): Nmea in: $CACFG,BR2,3*51

2019-03-06T22:14:27.704Z,1551910467.704 [Micromodem](INFO): Nmea in: $CACFG,BR3,3*50

2019-03-06T22:14:28.065Z,1551910468.065 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:28.099Z,1551910468.099 [Micromodem](INFO): Nmea in: $CACFG,BR4,3*57

2019-03-06T22:14:28.122Z,1551910468.122 [Micromodem](INFO): Nmea in: $CACFG,BRN,0*2E

2019-03-06T22:14:28.545Z,1551910468.545 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:28.570Z,1551910468.570 [Micromodem](INFO): Nmea in: $CACFG,BSP,1*30

2019-03-06T22:14:28.658Z,1551910468.658 [Micromodem](INFO): Nmea in: $CACFG,BW0,5000*60

2019-03-06T22:14:29.133Z,1551910469.133 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-06T22:14:29.144Z,1551910469.144 [Micromodem](INFO): Nmea in: $CACFG,CPR,1*30

2019-03-06T22:14:29.159Z,1551910469.159 [Micromodem](INFO): Nmea in: $CACFG,CRL,50*18

2019-03-06T22:14:29.456Z,1551910469.456 [Micromodem](INFO): Nmea in: $CACFG,CST,1*35

2019-03-06T22:14:29.479Z,1551910469.479 [Micromodem](INFO): Nmea in: $CACFG,CTO,10*19

2019-03-06T22:14:29.872Z,1551910469.872 [Micromodem](INFO): Nmea in: $CACFG,DBG,0*31

2019-03-06T22:14:29.894Z,1551910469.894 [Micromodem](INFO): Nmea in: $CACFG,DGM,0*3E

2019-03-06T22:14:30.270Z,1551910470.270 [Micromodem](INFO): Nmea in: $CACFG,DOP,0*2B

2019-03-06T22:14:30.298Z,1551910470.298 [Micromodem](INFO): Nmea in: $CACFG,DQF,1*22

2019-03-06T22:14:30.702Z,1551910470.702 [Micromodem](INFO): Nmea in: $CACFG,DTH,90*11

2019-03-06T22:14:30.717Z,1551910470.717 [Micromodem](INFO): Nmea in: $CACFG,DTO,2*2D

2019-03-06T22:14:31.077Z,1551910471.077 [Micromodem](INFO): Nmea in: $CACFG,DTP,90*09

2019-03-06T22:14:31.096Z,1551910471.096 [Micromodem](INFO): Nmea in: $CACFG,ECD,50*07

2019-03-06T22:14:31.477Z,1551910471.477 [Micromodem](INFO): Nmea in: $CACFG,EFB,10*00

2019-03-06T22:14:31.488Z,1551910471.488 [Micromodem](INFO): Nmea in: $CACFG,EFF,20*07

2019-03-06T22:14:31.878Z,1551910471.878 [Micromodem](INFO): Nmea in: $CACFG,FC0,25000*42

2019-03-06T22:14:31.888Z,1551910471.888 [Micromodem](INFO): Nmea in: $CACFG,FMD,1*3E

2019-03-06T22:14:32.281Z,1551910472.281 [Micromodem](INFO): Nmea in: $CACFG,FML,200*35

2019-03-06T22:14:32.300Z,1551910472.300 [Micromodem](INFO): Nmea in: $CACFG,GPS,0*34

2019-03-06T22:14:32.684Z,1551910472.684 [Micromodem](INFO): Nmea in: $CACFG,HFC,0*3D

2019-03-06T22:14:32.707Z,1551910472.707 [Micromodem](INFO): Nmea in: $CACFG,IRE,0*2E

2019-03-06T22:14:33.094Z,1551910473.094 [Micromodem](INFO): Nmea in: $CACFG,MCM,1*32

2019-03-06T22:14:33.104Z,1551910473.104 [Micromodem](INFO): Nmea in: $CACFG,MFD,1*3E

2019-03-06T22:14:33.492Z,1551910473.492 [Micromodem](INFO): Nmea in: $CACFG,MOD,0*36

2019-03-06T22:14:33.527Z,1551910473.527 [Micromodem](INFO): Nmea in: $CACFG,MPR,0*3F

2019-03-06T22:14:33.896Z,1551910473.896 [Micromodem](INFO): Nmea in: $CACFG,MSE,0*2B

2019-03-06T22:14:33.911Z,1551910473.911 [Micromodem](INFO): Nmea in: $CACFG,MVM,0*26

2019-03-06T22:14:34.305Z,1551910474.305 [Micromodem](INFO): Nmea in: $CACFG,NDT,120*2D

2019-03-06T22:14:34.316Z,1551910474.316 [Micromodem](INFO): Nmea in: $CACFG,NRL,25*17

2019-03-06T22:14:34.365Z,1551910474.365 [RDI_Pathfinder](ERROR): Failed to parse:
:0,  90.93,  97.92,  90.93,  99.91
2019-03-06T22:14:34.764Z,1551910474.764 [Micromodem](INFO): Nmea in: $CACFG,NRV,0*3A

2019-03-06T22:14:34.779Z,1551910474.779 [Micromodem](INFO): Nmea in: $CACFG,PAD,0*25

2019-03-06T22:14:35.096Z,1551910475.096 [Micromodem](INFO): Nmea in: $CACFG,PCM,0*2E

2019-03-06T22:14:35.111Z,1551910475.111 [Micromodem](INFO): Nmea in: $CACFG,POW,-20*27

2019-03-06T22:14:35.509Z,1551910475.509 [Micromodem](INFO): Nmea in: $CACFG,PRL,50*0B

2019-03-06T22:14:35.519Z,1551910475.519 [Micromodem](INFO): Nmea in: $CACFG,PTH,50*09

2019-03-06T22:14:35.904Z,1551910475.904 [Micromodem](INFO): Nmea in: $CACFG,PTO,14*0E

2019-03-06T22:14:35.920Z,1551910475.920 [Micromodem](INFO): Nmea in: $CACFG,REV,1*30

2019-03-06T22:14:36.308Z,1551910476.308 [Micromodem](INFO): Nmea in: $CACFG,RXA,0*3B

2019-03-06T22:14:36.332Z,1551910476.332 [Micromodem](INFO): Nmea in: $CACFG,RXD,1*3F

2019-03-06T22:14:36.712Z,1551910476.712 [Micromodem](INFO): Nmea in: $CACFG,RXP,1*2B

2019-03-06T22:14:36.727Z,1551910476.727 [Micromodem](INFO): Nmea in: $CACFG,SCG,0*27

2019-03-06T22:14:37.116Z,1551910477.116 [Micromodem](INFO): Nmea in: $CACFG,SGP,0*34

2019-03-06T22:14:37.131Z,1551910477.131 [Micromodem](INFO): Nmea in: $CACFG,SHF,0*2D

2019-03-06T22:14:37.520Z,1551910477.520 [Micromodem](INFO): Nmea in: $CACFG,SNR,0*3F

2019-03-06T22:14:37.535Z,1551910477.535 [Micromodem](INFO): Nmea in: $CACFG,SNV,0*3B

2019-03-06T22:14:37.928Z,1551910477.928 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2019-03-06T22:14:37.935Z,1551910477.935 [Micromodem](INFO): Nmea in: $CACFG,TAT,50*04

2019-03-06T22:14:38.332Z,1551910478.332 [Micromodem](INFO): Nmea in: $CACFG,TOA,0*2A

2019-03-06T22:14:38.340Z,1551910478.340 [Micromodem](INFO): Nmea in: $CACFG,TXD,600*3E

2019-03-06T22:14:38.736Z,1551910478.736 [Micromodem](INFO): Nmea in: $CACFG,TXP,1*2D

2019-03-06T22:14:38.743Z,1551910478.743 [Micromodem](INFO): Nmea in: $CACFG,TXF,1*3B

2019-03-06T22:14:39.143Z,1551910479.143 [Micromodem](INFO): Nmea in: $CACFG,XST,1*2E

2019-03-06T22:14:39.154Z,1551910479.154 [Micromodem](INFO): Nmea in: $CACFG,uart1.bitrate,19200*0A

2019-03-06T22:14:39.553Z,1551910479.553 [Micromodem](INFO): Nmea in: $CACFG,uart2.bitrate,19200*09

2019-03-06T22:14:39.565Z,1551910479.565 [Micromodem](INFO): Nmea in: $CACFG,uart3.bitrate,19200*08

2019-03-06T22:14:39.953Z,1551910479.953 [Micromodem](INFO): Nmea in: $CACFG,uart4.bitrate,19200*0F

2019-03-06T22:14:39.962Z,1551910479.962 [Micromodem](INFO): Nmea in: $CACFG,uart1.task,1*71

2019-03-06T22:14:40.355Z,1551910480.355 [Micromodem](INFO): Nmea in: $CACFG,uart2.task,1*72

2019-03-06T22:14:40.364Z,1551910480.364 [Micromodem](INFO): Nmea in: $CACFG,uart3.task,1*73

2019-03-06T22:14:40.759Z,1551910480.759 [Micromodem](INFO): Nmea in: $CACFG,uart4.task,1*74

2019-03-06T22:14:40.770Z,1551910480.770 [Micromodem](INFO): Nmea in: $CACFG,uart1.parse_gps,0*33

2019-03-06T22:14:41.165Z,1551910481.165 [Micromodem](INFO): Nmea in: $CACFG,uart2.parse_gps,0*30

2019-03-06T22:14:41.175Z,1551910481.175 [Micromodem](INFO): Nmea in: $CACFG,uart3.parse_gps,0*31

2019-03-06T22:14:41.569Z,1551910481.569 [Micromodem](INFO): Nmea in: $CACFG,uart4.parse_gps,0*36

2019-03-06T22:14:41.579Z,1551910481.579 [Micromodem](INFO): Nmea in: $CACFG,uart1.show_gps,0*45

2019-03-06T22:14:41.972Z,1551910481.972 [Micromodem](INFO): Nmea in: $CACFG,uart2.show_gps,0*46

2019-03-06T22:14:41.983Z,1551910481.983 [Micromodem](INFO): Nmea in: $CACFG,uart3.show_gps,0*47

2019-03-06T22:14:42.374Z,1551910482.374 [Micromodem](INFO): Nmea in: $CACFG,uart4.show_gps,0*40

2019-03-06T22:14:42.386Z,1551910482.386 [Micromodem](INFO): Nmea in: $CACFG,uart1.set_clk_GPS,0*3F

2019-03-06T22:14:42.786Z,1551910482.786 [Micromodem](INFO): Nmea in: $CACFG,uart2.set_clk_GPS,0*3C

2019-03-06T22:14:42.797Z,1551910482.797 [Micromodem](INFO): Nmea in: $CACFG,uart3.set_clk_GPS,0*3D

2019-03-06T22:14:43.186Z,1551910483.186 [Micromodem](INFO): Nmea in: $CACFG,uart4.set_clk_GPS,0*3A

2019-03-06T22:14:43.210Z,1551910483.210 [Micromodem](INFO): Nmea in: $CACFG,uart1.flowcontrol,0*08

2019-03-06T22:14:43.590Z,1551910483.590 [Micromodem](INFO): Nmea in: $CACFG,uart2.flowcontrol,0*0B

2019-03-06T22:14:43.601Z,1551910483.601 [Micromodem](INFO): Nmea in: $CACFG,uart3.flowcontrol,0*0A

2019-03-06T22:14:44.004Z,1551910484.004 [Micromodem](INFO): Nmea in: $CACFG,uart4.flowcontrol,0*0D

2019-03-06T22:14:44.042Z,1551910484.042 [Micromodem](INFO): Nmea in: $CACFG,uart4.rs485,0*40

2019-03-06T22:14:44.377Z,1551910484.377 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2019-03-06T22:14:44.377Z,1551910484.377 [AHRS_M2] Data Fault, FailCount= 4
2019-03-06T22:14:44.377Z,1551910484.377 [AHRS_M2](ERROR): Data Fault
2019-03-06T22:14:44.395Z,1551910484.395 [Micromodem](INFO): Nmea in: $CACFG,uart1.crc32,0*0E

2019-03-06T22:14:44.405Z,1551910484.405 [Micromodem](INFO): Nmea in: $CACFG,uart2.crc32,0*0D

2019-03-06T22:14:44.438Z,1551910484.438 [CBIT](ERROR): Data Fault in component: AHRS_M2
2019-03-06T22:14:44.769Z,1551910484.769 [AHRS_M2](INFO): Powering down
2019-03-06T22:14:44.869Z,1551910484.869 [Micromodem](INFO): Nmea in: $CACFG,uart3.crc32,0*0C

2019-03-06T22:14:44.878Z,1551910484.878 [Micromodem](INFO): Nmea in: $CACFG,uart4.crc32,0*0B

2019-03-06T22:14:45.193Z,1551910485.193 [Micromodem](INFO): Nmea in: $CACFG,uart1.iridium_hangup_minutes,0*62

2019-03-06T22:14:45.205Z,1551910485.205 [Micromodem](INFO): Nmea in: $CACFG,sport3.bitrate,19200*70

2019-03-06T22:14:45.599Z,1551910485.599 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.level,0*65

2019-03-06T22:14:45.611Z,1551910485.611 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.location,1*0F

2019-03-06T22:14:45.643Z,1551910485.643 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-06T22:14:45.643Z,1551910485.643 [AHRS_M2] No Fault, FailCount= 4
2019-03-06T22:14:45.982Z,1551910485.982 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-06T22:14:46.043Z,1551910486.043 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.lastretrieval,0*7F

2019-03-06T22:14:46.056Z,1551910486.056 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.currentdbSize,0*59

2019-03-06T22:14:46.406Z,1551910486.406 [Micromodem](INFO): Nmea in: $CACFG,log.nmea.output_rate,0*51

2019-03-06T22:14:46.415Z,1551910486.415 [Micromodem](INFO): Nmea in: $CACFG,rec.state,0*5D

2019-03-06T22:14:46.808Z,1551910486.808 [Micromodem](INFO): Nmea in: $CACFG,rec.start_time,-1*2C

2019-03-06T22:14:46.819Z,1551910486.819 [Micromodem](INFO): Nmea in: $CACFG,rec.end_time,-1*23

2019-03-06T22:14:47.211Z,1551910487.211 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.modulation,0*04

2019-03-06T22:14:47.226Z,1551910487.226 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.bandwidth_Hz,4000*30

2019-03-06T22:14:47.624Z,1551910487.624 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.carrier_Hz,25120*13

2019-03-06T22:14:47.638Z,1551910487.638 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.nulltime_ms,200*4B

2019-03-06T22:14:48.047Z,1551910488.047 [Micromodem](INFO): Nmea in: $CACFG,fsk.packet.legacy_addressing,0*5A

2019-03-06T22:14:48.061Z,1551910488.061 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.mod_hdr_version,0*72

2019-03-06T22:14:48.423Z,1551910488.423 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.modulation,0*12

2019-03-06T22:14:48.437Z,1551910488.437 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.bandwidth_Hz,5000*27

2019-03-06T22:14:48.834Z,1551910488.834 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.carrier_Hz,25000*06

2019-03-06T22:14:48.848Z,1551910488.848 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.bandwidth0_Hz,5000*17

2019-03-06T22:14:49.260Z,1551910489.260 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.carrier0_Hz,25000*36

2019-03-06T22:14:49.274Z,1551910489.274 [Micromodem](INFO): Nmea in: $CACFG,psk.packet.nulltime_ms,250*58

2019-03-06T22:14:49.723Z,1551910489.723 [Micromodem](INFO): Nmea in: $CACFG,detector.power_thresh,-20*6B

2019-03-06T22:14:49.736Z,1551910489.736 [Micromodem](INFO): Nmea in: $CACFG,detector.noise_thresh,50*40

2019-03-06T22:14:50.060Z,1551910490.060 [Micromodem](INFO): Nmea in: $CACFG,detector1.recv,0*77

2019-03-06T22:14:50.096Z,1551910490.096 [Micromodem](INFO): Nmea in: $CACFG,detector1.channel_mask,1*5C

2019-03-06T22:14:50.608Z,1551910490.608 [Micromodem](INFO): Nmea in: $CACFG,detector1.type,0*6D

2019-03-06T22:14:50.610Z,1551910490.610 [CommandLine](IMPORTANT): got command failComponent
2019-03-06T22:14:50.610Z,1551910490.610 [CommandLine](IMPORTANT): Failed components:
2019-03-06T22:14:50.610Z,1551910490.610 [CommandLine](IMPORTANT): No failed Components.
2019-03-06T22:14:50.625Z,1551910490.625 [Micromodem](INFO): Nmea in: $CACFG,detector1.fm_dir,0*5E

2019-03-06T22:14:51.037Z,1551910491.037 [Micromodem](INFO): Nmea in: $CACFG,detector1.length_sym,40*65

2019-03-06T22:14:51.050Z,1551910491.050 [Micromodem](INFO): Nmea in: $CACFG,detector1.fm_bw_Hz,4000*6D

2019-03-06T22:14:51.412Z,1551910491.412 [Micromodem](INFO): Nmea in: $CACFG,detector1.carrier_Hz,25120*60

2019-03-06T22:14:51.447Z,1551910491.447 [Micromodem](INFO): Nmea in: $CACFG,detector1.thresh,90*5C

2019-03-06T22:14:51.812Z,1551910491.812 [Micromodem](INFO): Nmea in: $CACFG,detector2.recv,1*75

2019-03-06T22:14:51.826Z,1551910491.826 [Micromodem](INFO): Nmea in: $CACFG,detector2.channel_mask,1*5F

2019-03-06T22:14:52.220Z,1551910492.220 [Micromodem](INFO): Nmea in: $CACFG,detector2.type,0*6E

2019-03-06T22:14:52.231Z,1551910492.231 [Micromodem](INFO): Nmea in: $CACFG,detector2.fm_dir,1*5C

2019-03-06T22:14:52.623Z,1551910492.623 [Micromodem](INFO): Nmea in: $CACFG,detector2.length_sym,200*50

2019-03-06T22:14:52.636Z,1551910492.636 [Micromodem](INFO): Nmea in: $CACFG,detector2.fm_bw_Hz,4000*6E

2019-03-06T22:14:52.772Z,1551910492.772 [CommandLine](IMPORTANT): got command show stack
2019-03-06T22:14:52.772Z,1551910492.772 [CommandLine](IMPORTANT): Behavior Stack:

2019-03-06T22:14:52.772Z,1551910492.772 [MissionManager](IMPORTANT): Mission loaded, but not running.
2019-03-06T22:14:53.043Z,1551910493.043 [Micromodem](INFO): Nmea in: $CACFG,detector2.carrier_Hz,25120*63

2019-03-06T22:14:53.055Z,1551910493.055 [Micromodem](INFO): Nmea in: $CACFG,detector2.thresh,90*5F

2019-03-06T22:14:53.448Z,1551910493.448 [Micromodem](INFO): Nmea in: $CACFG,detector3.recv,2*77

2019-03-06T22:14:53.462Z,1551910493.462 [Micromodem](INFO): Nmea in: $CACFG,detector3.channel_mask,1*5E

2019-03-06T22:14:53.848Z,1551910493.848 [Micromodem](INFO): Nmea in: $CACFG,detector3.type,1*6E

2019-03-06T22:14:53.859Z,1551910493.859 [Micromodem](INFO): Nmea in: $CACFG,detector3.fm_dir,0*5C

2019-03-06T22:14:54.255Z,1551910494.255 [Micromodem](INFO): Nmea in: $CACFG,detector3.length_sym,200*51

2019-03-06T22:14:54.268Z,1551910494.268 [Micromodem](INFO): Nmea in: $CACFG,detector3.fm_bw_Hz,4000*6F

2019-03-06T22:14:54.661Z,1551910494.661 [Micromodem](INFO): Nmea in: $CACFG,detector3.carrier_Hz,25120*62

2019-03-06T22:14:54.673Z,1551910494.673 [Micromodem](INFO): Nmea in: $CACFG,detector3.thresh,120*64

2019-03-06T22:14:55.072Z,1551910495.072 [Micromodem](INFO): Nmea in: $CACFG,recv.mca.gain,250*1B

2019-03-06T22:14:55.084Z,1551910495.084 [Micromodem](INFO): Nmea in: $CACFG,recv.onboard_gain,250*7E

2019-03-06T22:14:55.467Z,1551910495.467 [Micromodem](INFO): Nmea in: $CACFG,recv.onboard_gain_dB,32*31

2019-03-06T22:14:55.498Z,1551910495.498 [Micromodem](INFO): Nmea in: $CACFG,recv.onboard_equalizer,0*10

2019-03-06T22:14:55.868Z,1551910495.868 [Micromodem](INFO): Nmea in: $CACFG,recv.agn_legacy,1*7F

2019-03-06T22:14:55.879Z,1551910495.879 [Micromodem](INFO): Nmea in: $CACFG,recv.p2b_chmask,1*3D

2019-03-06T22:14:56.275Z,1551910496.275 [Micromodem](INFO): Nmea in: $CACFG,recv.agc_length_ms,100*3A

2019-03-06T22:14:56.285Z,1551910496.285 [Micromodem](INFO): Nmea in: $CACFG,recv.agc_legacy,1*72

2019-03-06T22:14:56.678Z,1551910496.678 [Micromodem](INFO): Nmea in: $CACFG,recv.digital_rcvr,0*6C

2019-03-06T22:14:56.688Z,1551910496.688 [Micromodem](INFO): Nmea in: $CACFG,recv.base64data,0*5B

2019-03-06T22:14:57.083Z,1551910497.083 [Micromodem](INFO): Nmea in: $CACFG,xmit.poweramp_gating,0*18

2019-03-06T22:14:57.093Z,1551910497.093 [Micromodem](INFO): Nmea in: $CACFG,xmit.txinhibit,0*23

2019-03-06T22:14:57.487Z,1551910497.487 [Micromodem](INFO): Nmea in: $CACFG,xmit.uart_disable_mask,15*10

2019-03-06T22:14:57.499Z,1551910497.499 [Micromodem](INFO): Nmea in: $CACFG,timing.clock_source,2*66

2019-03-06T22:14:57.892Z,1551910497.892 [Micromodem](INFO): Nmea in: $CACFG,timing.PPS_source,1*5E

2019-03-06T22:14:57.903Z,1551910497.903 [Micromodem](INFO): Nmea in: $CACFG,timing.syncnav,0*30

2019-03-06T22:14:58.297Z,1551910498.297 [Micromodem](INFO): Nmea in: $CACFG,timing.scg_timeout,0*1D

2019-03-06T22:14:58.308Z,1551910498.308 [Micromodem](INFO): Nmea in: $CACFG,timing.pps_timeout,3*1A

2019-03-06T22:14:58.694Z,1551910498.694 [Micromodem](INFO): Nmea in: $CACFG,timing.extpps_enable,1*0B

2019-03-06T22:14:58.708Z,1551910498.708 [Micromodem](INFO): Nmea in: $CACFG,timing.extpps_en_after_n,0*0A

2019-03-06T22:14:59.102Z,1551910499.102 [Micromodem](INFO): Nmea in: $CACFG,timing.setclk_after_n,0*42

2019-03-06T22:14:59.117Z,1551910499.117 [Micromodem](INFO): Nmea in: $CACFG,timing.extpps_disable_after_n,0*75

2019-03-06T22:14:59.485Z,1551910499.485 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2019-03-06T22:14:59.485Z,1551910499.485 [AHRS_M2] Data Fault, FailCount= 5
2019-03-06T22:14:59.485Z,1551910499.485 [AHRS_M2](ERROR): Data Fault
2019-03-06T22:14:59.503Z,1551910499.503 [Micromodem](INFO): Nmea in: $CACFG,timing.debug,0*3F

2019-03-06T22:14:59.517Z,1551910499.517 [Micromodem](INFO): Nmea in: $CACFG,hibernate.wake_interval,0*6C

2019-03-06T22:14:59.590Z,1551910499.590 [CBIT](ERROR): Data Fault in component: AHRS_M2
2019-03-06T22:14:59.590Z,1551910499.590 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2019-03-06T22:14:59.877Z,1551910499.877 [AHRS_M2](INFO): Powering down
2019-03-06T22:14:59.985Z,1551910499.985 [Micromodem](INFO): Nmea in: $CACFG,hibernate.wake_reference,0*18

2019-03-06T22:15:00.003Z,1551910500.003 [Micromodem](INFO): Nmea in: $CACFG,hibernate.hibernate_after,0*65

2019-03-06T22:15:00.140Z,1551910500.140 [CommandLine](FAULT): Scheduling is paused
2019-03-06T22:15:00.140Z,1551910500.140 [CBIT](INFO): Critical error at 20190306T221459
2019-03-06T22:15:00.140Z,1551910500.140 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-03-06T22:15:00.299Z,1551910500.299 [Micromodem](INFO): Nmea in: $CACFG,nav.soundspeed_mps,1430*24

2019-03-06T22:15:00.307Z,1551910500.307 [Micromodem](INFO): Nmea in: $CACFG,nav.nst,0*4E

2019-03-06T22:15:00.701Z,1551910500.701 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.mode,0*02

2019-03-06T22:15:00.710Z,1551910500.710 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.dbg,0*60

2019-03-06T22:15:01.116Z,1551910501.116 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_type,0*3F

2019-03-06T22:15:01.130Z,1551910501.130 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs1_x_mm,-15*64

2019-03-06T22:15:01.511Z,1551910501.511 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs1_y_mm,15*48

2019-03-06T22:15:01.536Z,1551910501.536 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs1_z_mm,0*7F

2019-03-06T22:15:01.588Z,1551910501.588 [SBIT](IMPORTANT): SBIT PASSED
2019-03-06T22:15:01.681Z,1551910501.681 [CommandLine](IMPORTANT): got command configSet list
2019-03-06T22:15:01.681Z,1551910501.681 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-03-06T22:15:01.683Z,1551910501.683 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2019-03-06T22:15:01.915Z,1551910501.915 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs2_x_mm,15*4A

2019-03-06T22:15:01.927Z,1551910501.927 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs2_y_mm,15*4B

2019-03-06T22:15:01.984Z,1551910501.984 [MissionManager](IMPORTANT): Started mission Startup
2019-03-06T22:15:01.984Z,1551910501.984 [Startup] Running Loop=1
2019-03-06T22:15:01.984Z,1551910501.984 [Startup](DEBUG): Aggregate::initialize Startup
2019-03-06T22:15:01.984Z,1551910501.984 [Startup:A.GoToSurface] Running Loop=1
2019-03-06T22:15:01.984Z,1551910501.984 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-06T22:15:01.989Z,1551910501.989 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-06T22:15:01.990Z,1551910501.990 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-06T22:15:01.990Z,1551910501.990 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-06T22:15:01.990Z,1551910501.990 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-06T22:15:01.991Z,1551910501.991 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-06T22:15:01.992Z,1551910501.992 [Startup:StartupSatComms] Running Loop=1
2019-03-06T22:15:01.997Z,1551910501.997 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-03-06T22:15:01.998Z,1551910501.998 [Startup:StartupSatComms:A] Running Loop=1
2019-03-06T22:15:02.326Z,1551910502.326 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs2_z_mm,0*7C

2019-03-06T22:15:02.339Z,1551910502.339 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs3_x_mm,15*4B

2019-03-06T22:15:02.399Z,1551910502.399 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-03-06T22:15:02.727Z,1551910502.727 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs3_y_mm,-15*67

2019-03-06T22:15:02.739Z,1551910502.739 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs3_z_mm,0*7D

2019-03-06T22:15:03.130Z,1551910503.130 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs4_x_mm,-15*61

2019-03-06T22:15:03.142Z,1551910503.142 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs4_y_mm,-15*60

2019-03-06T22:15:03.530Z,1551910503.530 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.array_locs4_z_mm,0*7A

2019-03-06T22:15:03.540Z,1551910503.540 [Micromodem](INFO): Nmea in: $CACFG,nav.usbl.channel_mask,30*1A

2019-03-06T22:15:03.931Z,1551910503.931 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.mode,0*75

2019-03-06T22:15:03.943Z,1551910503.943 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.carrier_Hz,13500*60

2019-03-06T22:15:04.344Z,1551910504.344 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.cycles_per_sym,7*72

2019-03-06T22:15:04.353Z,1551910504.353 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.data,0*66

2019-03-06T22:15:04.754Z,1551910504.754 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.sequence_len,47*62

2019-03-06T22:15:04.765Z,1551910504.765 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.timing_mode,0*3A

2019-03-06T22:15:04.907Z,1551910504.907 [CommandLine](IMPORTANT): got command show stack
2019-03-06T22:15:04.908Z,1551910504.908 [CommandLine](IMPORTANT): Behavior Stack:

2019-03-06T22:15:04.908Z,1551910504.908 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2019-03-06T22:15:04.908Z,1551910504.908 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A
2019-03-06T22:15:05.143Z,1551910505.143 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.period,1*72

2019-03-06T22:15:05.159Z,1551910505.159 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.reference_time,2015-12-04T00:00:00Z*68

2019-03-06T22:15:05.553Z,1551910505.553 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.bandwidth_Hz,4000*40

2019-03-06T22:15:05.564Z,1551910505.564 [Micromodem](INFO): Nmea in: $CACFG,nav.trackping.duration_msx10,35*66

2019-03-06T22:15:05.953Z,1551910505.953 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.mode,0*1A

2019-03-06T22:15:05.959Z,1551910505.959 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.type,1*00

2019-03-06T22:15:06.354Z,1551910506.354 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66

2019-03-06T22:15:06.363Z,1551910506.363 [Micromodem](INFO): Nmea in: $CACFG,info.part_number,201005*2D

2019-03-06T22:15:06.763Z,1551910506.763 [Micromodem](INFO): Nmea in: $CACFG,info.serial_number,673*0E

2019-03-06T22:15:06.770Z,1551910506.770 [Micromodem](INFO): Nmea in: $CACFG,info.board_rev,D*60

2019-03-06T22:15:07.166Z,1551910507.166 [Micromodem](INFO): Nmea in: $CACFG,info.bom_variant,M*65

2019-03-06T22:15:07.172Z,1551910507.172 [Micromodem](INFO): Nmea in: $CACFG,info.bom_rev,1*0F

2019-03-06T22:15:07.575Z,1551910507.575 [Micromodem](INFO): Nmea in: $CACFG,info.fpga_version,2.0.18017*68

2019-03-06T22:15:07.583Z,1551910507.583 [Micromodem](INFO): Nmea in: $CACFG,info.fpga_api_level,3*4D

2019-03-06T22:15:07.971Z,1551910507.971 [Micromodem](INFO): Nmea in: $CACFG,info.fpga_flashrom_version,2*38

2019-03-06T22:15:07.992Z,1551910507.992 [Micromodem](INFO): Nmea in: $CACFG,info.build_oem,A*6F

2019-03-06T22:15:08.373Z,1551910508.373 [Micromodem](INFO): Nmea in: $CACFG,info.build_year,2016*43

2019-03-06T22:15:08.380Z,1551910508.380 [Micromodem](INFO): Nmea in: $CACFG,info.build_month,5*0C

2019-03-06T22:15:08.781Z,1551910508.781 [Micromodem](INFO): Nmea in: $CACFG,info.build_options,0*09

2019-03-06T22:15:08.790Z,1551910508.790 [Micromodem](INFO): Nmea in: $CACFG,info.coproc_version,0.10.0.46.0 *54

2019-03-06T22:15:09.187Z,1551910509.187 [Micromodem](INFO): Nmea in: $CACFG,info.firmware_version,2.0.27690*6C

2019-03-06T22:15:09.195Z,1551910509.195 [Micromodem](INFO): Nmea in: $CACFG,info.loader_version,17175*61

2019-03-06T22:15:09.589Z,1551910509.589 [Micromodem](INFO): Nmea in: $CACFG,info.booted_slot,1*1D

2019-03-06T22:15:09.594Z,1551910509.594 [Micromodem](INFO): Nmea in: $CACFG,info.debugio,6*21

2019-03-06T22:15:09.991Z,1551910509.991 [Micromodem](INFO): Nmea in: $CACFG,hwd.batt_v,23.628000*1C

2019-03-06T22:15:10.002Z,1551910510.002 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux_adc_v,0.086000*79

2019-03-06T22:15:10.394Z,1551910510.394 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux_adc_gain,1*2F

2019-03-06T22:15:10.400Z,1551910510.400 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux_adc_res,12*78

2019-03-06T22:15:10.797Z,1551910510.797 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux33V_on,1*40

2019-03-06T22:15:10.803Z,1551910510.803 [Micromodem](INFO): Nmea in: $CACFG,hwd.aux33V_fault,0*2A

2019-03-06T22:15:11.204Z,1551910511.204 [Micromodem](INFO): Nmea in: $CACFG,hwd.stack33V_on,1*42

2019-03-06T22:15:11.223Z,1551910511.223 [Micromodem](INFO): Nmea in: $CACFG,hwd.stack33V_fault,0*28

2019-03-06T22:15:11.605Z,1551910511.605 [Micromodem](INFO): Nmea in: $CACFG,hwd.Vpwramp_on,1*25

2019-03-06T22:15:11.611Z,1551910511.611 [Micromodem](INFO): Nmea in: $CACFG,hwd.Vpwramp_fault,0*4F

2019-03-06T22:15:12.016Z,1551910512.016 [Micromodem](INFO): Nmea in: $CACFG,hwd.Vpreamp_on,1*37

2019-03-06T22:15:12.029Z,1551910512.029 [Micromodem](INFO): Nmea in: $CACFG,hwd.Vpreamp_fault,0*5D

2019-03-06T22:15:12.415Z,1551910512.415 [Micromodem](INFO): Nmea in: $CACFG,hwd.VSDcard_on,0*2E

2019-03-06T22:15:12.422Z,1551910512.422 [Micromodem](INFO): Nmea in: $CACFG,hwd.VSDcard_fault,0*45

2019-03-06T22:15:12.818Z,1551910512.818 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio1,0*05

2019-03-06T22:15:12.823Z,1551910512.823 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio2,0*06

2019-03-06T22:15:13.218Z,1551910513.218 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio3,0*07

2019-03-06T22:15:13.222Z,1551910513.222 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio4,1*01

2019-03-06T22:15:13.626Z,1551910513.626 [Micromodem](INFO): Nmea in: $CACFG,hwd.gpio5,0*01

2019-03-06T22:15:13.631Z,1551910513.631 [Micromodem](INFO): Nmea in: $CACFG,hwd.txinhibit,0*50

2019-03-06T22:15:14.039Z,1551910514.039 [Micromodem](INFO): Nmea in: $CACFG,hwd.temp,26.125000*35

2019-03-06T22:15:14.046Z,1551910514.046 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.mm_rom_valid,0*35

2019-03-06T22:15:14.437Z,1551910514.437 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.mm_rom,0*1C

2019-03-06T22:15:14.443Z,1551910514.443 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.pa_rom_valid,0*24

2019-03-06T22:15:14.835Z,1551910514.835 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.pa_rom,0*0D

2019-03-06T22:15:14.842Z,1551910514.842 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.pa_rom_boot_search,0*15

2019-03-06T22:15:15.244Z,1551910515.244 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux1_rom_valid,0*68

2019-03-06T22:15:15.249Z,1551910515.249 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux1_rom,0*41

2019-03-06T22:15:15.644Z,1551910515.644 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux1_rom_boot_search,0*59

2019-03-06T22:15:15.650Z,1551910515.650 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux2_rom_valid,0*6B

2019-03-06T22:15:16.046Z,1551910516.046 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux2_rom,0*42

2019-03-06T22:15:16.053Z,1551910516.053 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux2_rom_boot_search,0*5A

2019-03-06T22:15:16.455Z,1551910516.455 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux3_rom_valid,0*6A

2019-03-06T22:15:16.460Z,1551910516.460 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux3_rom,0*43

2019-03-06T22:15:16.855Z,1551910516.855 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux3_rom_boot_search,0*5B

2019-03-06T22:15:16.860Z,1551910516.860 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux4_rom_valid,0*6D

2019-03-06T22:15:17.258Z,1551910517.258 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux4_rom,0*44

2019-03-06T22:15:17.263Z,1551910517.263 [Micromodem](INFO): Nmea in: $CACFG,hwd.1wire.aux4_rom_boot_search,0*5C

2019-03-06T22:15:17.669Z,1551910517.669 [Micromodem](INFO): Nmea in: $CACFG,pwramp.temperature_degC,21.875000*56

2019-03-06T22:15:17.672Z,1551910517.672 [Micromodem](INFO): Nmea in: $CACFG,pwramp.vbat,24.136003*49

2019-03-06T22:15:18.066Z,1551910518.066 [Micromodem](INFO): Nmea in: $CACFG,pwramp.vtransmit,0.000000*05

2019-03-06T22:15:18.071Z,1551910518.071 [Micromodem](INFO): Nmea in: $CACFG,pwramp.iout_sense_amps,0.000000*1F

2019-03-06T22:15:18.469Z,1551910518.469 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,3*2E

2019-03-06T22:15:18.473Z,1551910518.473 [Micromodem](INFO): Nmea in: $CACFG,pwramp.stackpower_conf,1*1C

2019-03-06T22:15:18.877Z,1551910518.877 [Micromodem](INFO): Nmea in: $CACFG,pwramp.VPS_on,1*5D

2019-03-06T22:15:18.879Z,1551910518.879 [Micromodem](INFO): Nmea in: $CACFG,pwramp.gpio5,3*70

2019-03-06T22:15:19.284Z,1551910519.284 [Micromodem](INFO): Nmea in: $CACFG,pwramp.gpio6,3*73

2019-03-06T22:15:19.287Z,1551910519.287 [Micromodem](INFO): Nmea in: $CACFG,pwramp.fault,0*3D

2019-03-06T22:15:19.680Z,1551910519.680 [Micromodem](INFO): Nmea in: $CACFG,script.active,0*5D

2019-03-06T22:15:19.683Z,1551910519.683 [Micromodem](INFO): Nmea in: $CACFG,script.comports,15*6E

2019-03-06T22:15:20.088Z,1551910520.088 [Micromodem](INFO): Nmea in: $CACFG,script.v0,0*17

2019-03-06T22:15:20.090Z,1551910520.090 [Micromodem](INFO): Nmea in: $CACFG,script.v1,0*16

2019-03-06T22:15:20.488Z,1551910520.488 [Micromodem](INFO): Nmea in: $CACFG,script.v2,0*15

2019-03-06T22:15:20.490Z,1551910520.490 [Micromodem](INFO): Nmea in: $CACFG,script.v3,0*14

2019-03-06T22:15:20.892Z,1551910520.892 [Micromodem](INFO): Nmea in: $CACFG,script.v4,0*13

2019-03-06T22:15:20.894Z,1551910520.894 [Micromodem](INFO): Nmea in: $CACFG,script.v5,0*12

2019-03-06T22:15:21.296Z,1551910521.296 [Micromodem](INFO): Nmea in: $CACFG,script.v6,0*11

2019-03-06T22:15:21.297Z,1551910521.297 [Micromodem](INFO): Nmea in: $CACFG,script.v7,0*10

2019-03-06T22:15:21.700Z,1551910521.700 [Micromodem](INFO): Nmea in: $CACFG,script.v8,0*1F

2019-03-06T22:15:21.701Z,1551910521.701 [Micromodem](INFO): Nmea in: $CACFG,script.v9,0*1E

2019-03-06T22:15:22.112Z,1551910522.112 [Micromodem](INFO): Nmea in: $CACFG,script.vA,0*66

2019-03-06T22:15:22.115Z,1551910522.115 [Micromodem](INFO): Nmea in: $CACFG,script.vB,0*65

2019-03-06T22:15:22.511Z,1551910522.511 [Micromodem](INFO): Nmea in: $CACFG,script.vC,0*64

2019-03-06T22:15:22.513Z,1551910522.513 [Micromodem](INFO): Nmea in: $CACFG,script.vD,0*63

2019-03-06T22:15:22.915Z,1551910522.915 [Micromodem](INFO): Nmea in: $CACFG,script.vE,0*62

2019-03-06T22:15:22.917Z,1551910522.917 [Micromodem](INFO): Nmea in: $CACFG,script.vF,0*61

2019-03-06T22:15:23.315Z,1551910523.315 [Micromodem](INFO): Nmea in: $CAREV,221434,AUV,2.0.27690*17

2019-03-06T22:15:23.318Z,1551910523.318 [Micromodem](INFO): Nmea in: $CAREV,221434,COPROC,0.10.0.46*42

2019-03-06T22:15:23.719Z,1551910523.719 [Micromodem](INFO): Nmea in: $CAREV,221444,AUV,2.0.27690*10

2019-03-06T22:15:23.721Z,1551910523.721 [Micromodem](INFO): Nmea in: $CAREV,221444,COPROC,0.10.0.46*45

2019-03-06T22:15:24.124Z,1551910524.124 [Micromodem](INFO): Nmea in: $CAREV,221454,AUV,2.0.27690*11

2019-03-06T22:15:24.125Z,1551910524.125 [Micromodem](INFO): Nmea in: $CAREV,221454,COPROC,0.10.0.46*44

2019-03-06T22:15:24.527Z,1551910524.527 [Micromodem](INFO): Nmea in: $CAREV,221504,AUV,2.0.27690*15

2019-03-06T22:15:24.529Z,1551910524.529 [Micromodem](INFO): Nmea in: $CAREV,221504,COPROC,0.10.0.46*40

2019-03-06T22:15:24.935Z,1551910524.935 [Micromodem](INFO): Nmea in: $CAREV,221514,AUV,2.0.27690*14

2019-03-06T22:15:24.936Z,1551910524.936 [Micromodem](INFO): Nmea in: $CAREV,221514,COPROC,0.10.0.46*41

2019-03-06T22:15:25.335Z,1551910525.335 [Micromodem](INFO): Nmea in: $CAREV,221524,AUV,2.0.27690*17

2019-03-06T22:15:34.223Z,1551910534.223 [Micromodem](INFO): Nmea in: $CAREV,221524,COPROC,0.10.0.46*42

2019-03-06T22:15:34.224Z,1551910534.224 [Micromodem](INFO): Nmea in: $CAREV,221534,AUV,2.0.27690*16

2019-03-06T22:15:39.499Z,1551910539.499 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:15:39.499Z,1551910539.499 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-06T22:15:39.499Z,1551910539.499 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-06T22:15:39.500Z,1551910539.500 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:15:39.500Z,1551910539.500 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-06T22:15:39.500Z,1551910539.500 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-06T22:15:39.502Z,1551910539.502 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-06T22:15:39.502Z,1551910539.502 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-03-06T22:15:39.502Z,1551910539.502 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-06T22:15:39.513Z,1551910539.513 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-06T22:15:39.514Z,1551910539.514 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-06T22:15:39.514Z,1551910539.514 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-06T22:15:39.914Z,1551910539.914 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-06T22:15:39.914Z,1551910539.914 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-06T22:15:39.914Z,1551910539.914 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-06T22:15:39.914Z,1551910539.914 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-06T22:15:39.915Z,1551910539.915 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-06T22:15:39.915Z,1551910539.915 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-03-06T22:15:40.316Z,1551910540.316 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-06T22:15:44.323Z,1551910544.323 [Micromodem](INFO): Nmea in: $CAREV,221534,COPROC,0.10.0.46*43

2019-03-06T22:15:44.324Z,1551910544.324 [Micromodem](INFO): Nmea in: $CAREV,221544,AUV,2.0.27690*11

2019-03-06T22:15:54.028Z,1551910554.028 [Micromodem](INFO): Nmea in: $CAREV,221544,COPROC,0.10.0.46*44

2019-03-06T22:15:54.031Z,1551910554.031 [Micromodem](INFO): Nmea in: $CAREV,221554,AUV,2.0.27690*10

2019-03-06T22:15:56.459Z,1551910556.459 [CommandLine](IMPORTANT): got command show variable DUSBL
2019-03-06T22:15:56.534Z,1551910556.534 [CommandLine](IMPORTANT): DUSBL_Hydroid.loadAtStartup (bool)
2019-03-06T22:15:56.535Z,1551910556.535 [CommandLine](IMPORTANT): DUSBL_Hydroid.simulateHardware (bool)
2019-03-06T22:15:56.535Z,1551910556.535 [CommandLine](IMPORTANT): DUSBL_Hydroid.defaultTurnAroundTime (meter_per_second)
2019-03-06T22:15:56.535Z,1551910556.535 [CommandLine](IMPORTANT): DUSBL_Hydroid.defaultSoundSpeed (meter_per_second)
2019-03-06T22:15:56.536Z,1551910556.536 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold (count)
2019-03-06T22:15:56.536Z,1551910556.536 [CommandLine](IMPORTANT): DUSBL_Hydroid.recieveTimeout (millisecond)
2019-03-06T22:15:56.536Z,1551910556.536 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout (millisecond)
2019-03-06T22:15:56.537Z,1551910556.537 [CommandLine](IMPORTANT): DUSBL_Hydroid.transponderCode (enum)
2019-03-06T22:15:56.537Z,1551910556.537 [CommandLine](IMPORTANT): DUSBL_Hydroid.numberOfPingsRequested (count)
2019-03-06T22:15:56.538Z,1551910556.538 [CommandLine](IMPORTANT): DUSBL_Hydroid.verbosity (enum)
2019-03-06T22:15:56.538Z,1551910556.538 [CommandLine](IMPORTANT): DUSBL_Hydroid.xCenter (angular_degree)
2019-03-06T22:15:56.538Z,1551910556.538 [CommandLine](IMPORTANT): DUSBL_Hydroid.yCenter (angular_degree)
2019-03-06T22:15:56.550Z,1551910556.550 [CommandLine](IMPORTANT): DUSBL_Hydroid.loadControl (none)
2019-03-06T22:15:56.550Z,1551910556.550 [CommandLine](IMPORTANT): DUSBL_Hydroid.uart (none)
2019-03-06T22:15:56.550Z,1551910556.550 [CommandLine](IMPORTANT): DUSBL_Hydroid.baud (bit_per_second)
2019-03-06T22:15:56.554Z,1551910556.554 [CommandLine](IMPORTANT): Micromodem.dusblPingCode (enum)
2019-03-06T22:15:56.555Z,1551910556.555 [CommandLine](IMPORTANT): DUSBL_Hydroid.xAngle (angular_degree)
2019-03-06T22:15:56.555Z,1551910556.555 [CommandLine](IMPORTANT): DUSBL_Hydroid.yAngle (angular_degree)
2019-03-06T22:15:56.555Z,1551910556.555 [CommandLine](IMPORTANT): DUSBL_Hydroid.travelTime (microsecond)
2019-03-06T22:15:56.556Z,1551910556.556 [CommandLine](IMPORTANT): DUSBL_Hydroid.latency (microsecond)
2019-03-06T22:15:56.556Z,1551910556.556 [CommandLine](IMPORTANT): DUSBL_Hydroid.gain (ratio)
2019-03-06T22:15:56.556Z,1551910556.556 [CommandLine](IMPORTANT): DUSBL_Hydroid.inBandSignalToNoise (ratio)
2019-03-06T22:15:56.557Z,1551910556.557 [CommandLine](IMPORTANT): DUSBL_Hydroid.outBandSignalToNoise (ratio)
2019-03-06T22:15:56.557Z,1551910556.557 [CommandLine](IMPORTANT): DUSBL_Hydroid.range (meter)
2019-03-06T22:15:56.558Z,1551910556.558 [CommandLine](IMPORTANT): DUSBL_Hydroid.direction (none)
2019-03-06T22:16:02.147Z,1551910562.147 [Startup:StartupSatComms:A](INFO): Timed out from 2019-03-06T22:15:01.0Z
2019-03-06T22:16:02.147Z,1551910562.147 [Startup:StartupSatComms:A] Stopped
2019-03-06T22:16:02.147Z,1551910562.147 [Startup:StartupSatComms:B] Running Loop=1
2019-03-06T22:16:02.551Z,1551910562.551 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-06T22:16:04.123Z,1551910564.123 [Micromodem](INFO): Nmea in: $CAREV,221554,COPROC,0.10.0.46*45

2019-03-06T22:16:04.124Z,1551910564.124 [Micromodem](INFO): Nmea in: $CAREV,221604,AUV,2.0.27690*16

2019-03-06T22:16:08.011Z,1551910568.011 [CommandLine](IMPORTANT): got command report touch DUSBL_Hydroid.direction
2019-03-06T22:16:12.426Z,1551910572.426 [CommandLine](IMPORTANT): got command report touch DUSBL_Hydroid.range
2019-03-06T22:16:14.223Z,1551910574.223 [Micromodem](INFO): Nmea in: $CAREV,221604,COPROC,0.10.0.46*43

2019-03-06T22:16:14.225Z,1551910574.225 [Micromodem](INFO): Nmea in: $CAREV,221614,AUV,2.0.27690*17

2019-03-06T22:16:14.377Z,1551910574.377 [CommandLine](IMPORTANT): got command show stack
2019-03-06T22:16:14.377Z,1551910574.377 [CommandLine](IMPORTANT): Behavior Stack:

2019-03-06T22:16:14.378Z,1551910574.378 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2019-03-06T22:16:14.378Z,1551910574.378 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B
2019-03-06T22:16:22.759Z,1551910582.759 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005054
2019-03-06T22:16:24.319Z,1551910584.319 [Micromodem](INFO): Nmea in: $CAREV,221614,COPROC,0.10.0.46*42

2019-03-06T22:16:24.320Z,1551910584.320 [Micromodem](INFO): Nmea in: $CAREV,221624,AUV,2.0.27690*14

2019-03-06T22:16:27.728Z,1551910587.728 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190306T214038/Courier0013.lzma
2019-03-06T22:16:28.534Z,1551910588.534 [DataOverHttps](INFO): Moved sent file to Logs/20190306T214038/Courier0013.lzma.bak
2019-03-06T22:16:28.535Z,1551910588.535 [DataOverHttps](INFO): SBD MOMSN=10089714
2019-03-06T22:16:34.023Z,1551910594.023 [Micromodem](INFO): Nmea in: $CAREV,221624,COPROC,0.10.0.46*41

2019-03-06T22:16:34.423Z,1551910594.423 [Micromodem](INFO): Nmea in: $CAREV,221634,AUV,2.0.27690*15

2019-03-06T22:16:39.516Z,1551910599.516 [DataOverHttps](INFO): Sending 92 bytes from file Logs/20190306T221327/Courier0000.lzma
2019-03-06T22:16:40.322Z,1551910600.322 [DataOverHttps](INFO): Moved sent file to Logs/20190306T221327/Courier0000.lzma.bak
2019-03-06T22:16:40.322Z,1551910600.322 [DataOverHttps](INFO): SBD MOMSN=10089716
2019-03-06T22:16:42.107Z,1551910602.107 [CommandLine](IMPORTANT): got command failComponent
2019-03-06T22:16:42.107Z,1551910602.107 [CommandLine](IMPORTANT): Failed components:
2019-03-06T22:16:42.108Z,1551910602.108 [CommandLine](IMPORTANT): AHRS_M2: Data Fault
2019-03-06T22:16:44.115Z,1551910604.115 [Micromodem](INFO): Nmea in: $CAREV,221634,COPROC,0.10.0.46*40

2019-03-06T22:16:44.116Z,1551910604.116 [Micromodem](INFO): Nmea in: $CAREV,221644,AUV,2.0.27690*12

2019-03-06T22:16:45.187Z,1551910605.187 [CommandLine](IMPORTANT): got command restart application
2019-03-06T22:16:46.193Z,1551910606.193 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-06T22:16:46.193Z,1551910606.193 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:46.365Z,1551910606.365 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-03-06T22:16:46.365Z,1551910606.365 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:46.366Z,1551910606.366 [CommandLine](INFO): Join timeout helper Thread ID is 936
2019-03-06T22:16:46.367Z,1551910606.367 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-03-06T22:16:46.367Z,1551910606.367 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:46.367Z,1551910606.367 [NavChartDb](INFO): Join timeout helper Thread ID is 937
2019-03-06T22:16:46.705Z,1551910606.705 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-06T22:16:46.705Z,1551910606.705 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:46.725Z,1551910606.725 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2019-03-06T22:16:46.725Z,1551910606.725 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:46.725Z,1551910606.725 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 938
2019-03-06T22:16:46.845Z,1551910606.845 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-06T22:16:46.845Z,1551910606.845 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-03-06T22:16:46.846Z,1551910606.846 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:46.865Z,1551910606.865 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-03-06T22:16:46.865Z,1551910606.865 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:46.865Z,1551910606.865 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 939
2019-03-06T22:16:46.981Z,1551910606.981 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-06T22:16:46.982Z,1551910606.982 [CTD_NeilBrown](INFO): Powering down
2019-03-06T22:16:46.993Z,1551910606.993 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.009Z,1551910607.009 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-03-06T22:16:47.010Z,1551910607.010 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.011Z,1551910607.011 [Radio_Surface](INFO): Join timeout helper Thread ID is 940
2019-03-06T22:16:47.173Z,1551910607.173 [Radio_Surface](INFO): Powering down
2019-03-06T22:16:47.174Z,1551910607.174 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-06T22:16:47.174Z,1551910607.174 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.193Z,1551910607.193 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-03-06T22:16:47.193Z,1551910607.193 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.194Z,1551910607.194 [DataOverHttps](INFO): Join timeout helper Thread ID is 941
2019-03-06T22:16:47.405Z,1551910607.405 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-06T22:16:47.406Z,1551910607.406 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.414Z,1551910607.414 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-03-06T22:16:47.414Z,1551910607.414 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.414Z,1551910607.414 [logger](INFO): Join timeout helper Thread ID is 942
2019-03-06T22:16:47.424Z,1551910607.424 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-06T22:16:47.424Z,1551910607.424 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.434Z,1551910607.434 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-03-06T22:16:47.434Z,1551910607.434 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.434Z,1551910607.434 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-03-06T22:16:47.434Z,1551910607.434 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:47.434Z,1551910607.434 [controlThread](INFO): Join timeout helper Thread ID is 943
2019-03-06T22:16:47.741Z,1551910607.741 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-06T22:16:47.741Z,1551910607.741 [controlThread](DEBUG): Uninitializing ControlThread
2019-03-06T22:16:47.742Z,1551910607.742 [AHRS_M2](INFO): Powering down
2019-03-06T22:16:47.743Z,1551910607.743 [DUSBL_Hydroid](INFO): Powering down
2019-03-06T22:16:47.833Z,1551910607.833 [Micromodem](INFO): Powering down
2019-03-06T22:16:47.929Z,1551910607.929 [NAL9602](INFO): Powering down
2019-03-06T22:16:48.001Z,1551910608.001 [RDI_Pathfinder](INFO): Powering down
2019-03-06T22:16:48.002Z,1551910608.002 [RDI_PathfinderUp](INFO): Powering down
2019-03-06T22:16:48.003Z,1551910608.003 [Aanderaa_O2](INFO): Powering down
2019-03-06T22:16:48.004Z,1551910608.004 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-03-06T22:16:48.005Z,1551910608.005 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-03-06T22:16:48.006Z,1551910608.006 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-03-06T22:16:48.007Z,1551910608.007 [MissionManager](INFO): Uninitializing Mission Default
2019-03-06T22:16:48.009Z,1551910608.009 [MissionManager](INFO): Uninitializing Mission Startup
2019-03-06T22:16:48.009Z,1551910608.009 [Startup] Stopped
2019-03-06T22:16:48.009Z,1551910608.009 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-03-06T22:16:48.009Z,1551910608.009 [Startup:A.GoToSurface] Stopped
2019-03-06T22:16:48.009Z,1551910608.009 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-06T22:16:48.009Z,1551910608.009 [Startup:StartupSatComms] Stopped
2019-03-06T22:16:48.009Z,1551910608.009 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-03-06T22:16:48.010Z,1551910608.010 [Startup:StartupSatComms:B] Stopped
2019-03-06T22:16:48.011Z,1551910608.011 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-03-06T22:16:48.011Z,1551910608.011 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-03-06T22:16:48.011Z,1551910608.011 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-03-06T22:16:48.012Z,1551910608.012 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-03-06T22:16:48.012Z,1551910608.012 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-06T22:16:48.012Z,1551910608.012 [BuoyancyServo](INFO): Powering down
2019-03-06T22:16:48.025Z,1551910608.025 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-06T22:16:48.025Z,1551910608.025 [ElevatorServo](INFO): Powering down
2019-03-06T22:16:48.026Z,1551910608.026 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-06T22:16:48.026Z,1551910608.026 [MassServo](INFO): Powering down
2019-03-06T22:16:48.027Z,1551910608.027 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-06T22:16:48.027Z,1551910608.027 [RudderServo](INFO): Powering down
2019-03-06T22:16:48.028Z,1551910608.028 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-03-06T22:16:48.028Z,1551910608.028 [ThrusterServo](INFO): Powering down
2019-03-06T22:16:48.028Z,1551910608.028 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-03-06T22:16:48.029Z,1551910608.029 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-03-06T22:16:48.029Z,1551910608.029 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-03-06T22:16:48.029Z,1551910608.029 [CBIT](DEBUG): Powering off loads.
2019-03-06T22:16:48.041Z,1551910608.041 [CBIT](DEBUG): Disabling WDT.
2019-03-06T22:16:48.053Z,1551910608.053 [CBIT](DEBUG): Opening all GF detection circuits.
2019-03-06T22:16:48.054Z,1551910608.054 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:48.107Z,1551910608.107 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:48.115Z,1551910608.115 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:48.157Z,1551910608.157 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:48.159Z,1551910608.159 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:48.213Z,1551910608.213 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-06T22:16:48.269Z,1551910608.269 [logger ThreadHandler](INFO): Thread cancelled.