2016-05-11T21:06:36.819Z,1463000796.819 [Supervisor](DEBUG): Initializing supervisor.
2016-05-11T21:06:36.822Z,1463000796.822 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2016-05-11T21:06:36.822Z,1463000796.822 [SyncHandler](INFO): Protected caller Thread ID is 7778
2016-05-11T21:06:36.823Z,1463000796.823 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-05-11T21:06:36.824Z,1463000796.824 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2016-05-11T21:06:36.824Z,1463000796.824 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7779
2016-05-11T21:06:36.827Z,1463000796.827 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-05-11T21:06:36.838Z,1463000796.838 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-05-11T21:06:36.839Z,1463000796.839 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2016-05-11T21:06:36.840Z,1463000796.839 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7780
2016-05-11T21:06:36.840Z,1463000796.840 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-05-11T21:06:36.841Z,1463000796.841 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2016-05-11T21:06:36.842Z,1463000796.842 [logger ThreadHandler](INFO): Protected caller Thread ID is 7781
2016-05-11T21:06:36.844Z,1463000796.843 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-05-11T21:06:36.844Z,1463000796.844 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-05-11T21:06:36.845Z,1463000796.845 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-05-11T21:06:36.929Z,1463000796.929 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-05-11T21:06:37.286Z,1463000797.286 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-05-11T21:06:37.287Z,1463000797.287 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-05-11T21:06:37.412Z,1463000797.412 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-05-11T21:06:37.412Z,1463000797.412 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-05-11T21:06:37.606Z,1463000797.606 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-05-11T21:06:37.606Z,1463000797.606 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-05-11T21:06:37.706Z,1463000797.706 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-05-11T21:06:37.706Z,1463000797.706 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-05-11T21:06:37.906Z,1463000797.906 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-05-11T21:06:37.907Z,1463000797.907 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-05-11T21:06:38.379Z,1463000798.379 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-05-11T21:06:38.380Z,1463000798.379 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-05-11T21:06:38.665Z,1463000798.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-05-11T21:06:38.665Z,1463000798.665 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-05-11T21:06:38.749Z,1463000798.750 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-05-11T21:06:38.750Z,1463000798.750 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-05-11T21:06:38.881Z,1463000798.881 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-05-11T21:06:38.882Z,1463000798.882 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-05-11T21:06:39.086Z,1463000799.086 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-05-11T21:06:39.086Z,1463000799.086 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-05-11T21:06:39.526Z,1463000799.526 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-05-11T21:06:39.526Z,1463000799.526 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-05-11T21:06:39.873Z,1463000799.874 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-05-11T21:06:39.874Z,1463000799.874 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-05-11T21:06:40.186Z,1463000800.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-05-11T21:06:40.186Z,1463000800.186 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-05-11T21:06:40.296Z,1463000800.296 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-05-11T21:06:40.298Z,1463000800.298 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2016-05-11T21:06:40.299Z,1463000800.299 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2016-05-11T21:06:40.395Z,1463000800.395 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2016-05-11T21:06:40.501Z,1463000800.501 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2016-05-11T21:06:40.588Z,1463000800.588 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2016-05-11T21:06:40.689Z,1463000800.689 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2016-05-11T21:06:40.778Z,1463000800.778 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2016-05-11T21:06:40.925Z,1463000800.925 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2016-05-11T21:06:41.024Z,1463000801.024 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2016-05-11T21:06:41.194Z,1463000801.194 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2016-05-11T21:06:41.419Z,1463000801.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-05-11T21:06:41.420Z,1463000801.420 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2016-05-11T21:06:41.591Z,1463000801.591 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2016-05-11T21:06:41.698Z,1463000801.698 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/
2016-05-11T21:06:41.699Z,1463000801.699 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2016-05-11T21:06:41.705Z,1463000801.705 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-05-11T21:06:41.727Z,1463000801.727 [DepthRateCalculator] Loaded
2016-05-11T21:06:41.727Z,1463000801.727 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-05-11T21:06:41.733Z,1463000801.733 [PitchRateCalculator] Loaded
2016-05-11T21:06:41.734Z,1463000801.734 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-05-11T21:06:41.745Z,1463000801.745 [SpeedCalculator] Loaded
2016-05-11T21:06:41.745Z,1463000801.745 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-05-11T21:06:41.760Z,1463000801.760 [TempGradientCalculator] Loaded
2016-05-11T21:06:41.761Z,1463000801.761 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-05-11T21:06:41.776Z,1463000801.776 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-05-11T21:06:41.776Z,1463000801.776 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-05-11T21:06:41.782Z,1463000801.782 [YawRateCalculator] Loaded
2016-05-11T21:06:41.783Z,1463000801.783 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-05-11T21:06:41.783Z,1463000801.783 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-05-11T21:06:41.784Z,1463000801.783 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-05-11T21:06:41.879Z,1463000801.879 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-05-11T21:06:41.879Z,1463000801.879 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-05-11T21:06:41.932Z,1463000801.931 [DeadReckonUsingSpeedCalculator] Loaded
2016-05-11T21:06:41.932Z,1463000801.932 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-05-11T21:06:41.983Z,1463000801.983 [DeadReckonWithRespectToWater] Loaded
2016-05-11T21:06:41.984Z,1463000801.984 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2016-05-11T21:06:42.037Z,1463000802.037 [DeadReckonWithRespectToSeafloor] Loaded
2016-05-11T21:06:42.037Z,1463000802.037 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2016-05-11T21:06:42.094Z,1463000802.094 [DeadReckonUsingDVLWaterTrack] Loaded
2016-05-11T21:06:42.095Z,1463000802.095 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread.
2016-05-11T21:06:42.111Z,1463000802.111 [NavChart] Loaded
2016-05-11T21:06:42.111Z,1463000802.111 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-05-11T21:06:42.115Z,1463000802.115 [UniversalFixResidualReporter] Loaded
2016-05-11T21:06:42.115Z,1463000802.115 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-05-11T21:06:42.116Z,1463000802.116 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-05-11T21:06:42.116Z,1463000802.116 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-05-11T21:06:42.212Z,1463000802.212 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-05-11T21:06:42.213Z,1463000802.213 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-05-11T21:06:42.234Z,1463000802.234 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-05-11T21:06:42.235Z,1463000802.235 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-05-11T21:06:42.241Z,1463000802.241 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-05-11T21:06:42.241Z,1463000802.241 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-05-11T21:06:42.455Z,1463000802.455 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-05-11T21:06:42.456Z,1463000802.456 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-05-11T21:06:42.580Z,1463000802.580 [SBIT](DEBUG): Construct Startup Built In Test.
2016-05-11T21:06:42.610Z,1463000802.610 [SBIT] Loaded
2016-05-11T21:06:42.611Z,1463000802.611 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-05-11T21:06:42.611Z,1463000802.611 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-05-11T21:06:42.638Z,1463000802.638 [IBIT] Loaded
2016-05-11T21:06:42.638Z,1463000802.638 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-05-11T21:06:42.642Z,1463000802.642 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-05-11T21:06:42.791Z,1463000802.791 [CBIT] Loaded
2016-05-11T21:06:42.791Z,1463000802.791 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-05-11T21:06:42.791Z,1463000802.791 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-05-11T21:06:42.792Z,1463000802.792 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-05-11T21:06:43.057Z,1463000803.057 [AHRS_sp3003D] Loaded
2016-05-11T21:06:43.057Z,1463000803.057 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2016-05-11T21:06:43.127Z,1463000803.127 [DataOverHttps] Loaded
2016-05-11T21:06:43.127Z,1463000803.127 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-05-11T21:06:43.141Z,1463000803.141 [Depth_Keller] Loaded
2016-05-11T21:06:43.141Z,1463000803.141 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-05-11T21:06:43.231Z,1463000803.231 [NAL9602] Loaded
2016-05-11T21:06:43.232Z,1463000803.232 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-05-11T21:06:43.235Z,1463000803.234 [Onboard](CRITICAL): Could not find element OnboardSecondaryBatteryCurrent.ad
2016-05-11T21:06:43.235Z,1463000803.235 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardSecondaryBatteryCurrent.ad
2016-05-11T21:06:43.235Z,1463000803.235 [Onboard](CRITICAL): Could not find element OnboardSecondaryBatteryCurrent.adRes
2016-05-11T21:06:43.235Z,1463000803.236 [Onboard](CRITICAL): Could not find element OnboardSecondaryBatteryCurrent.adVref
2016-05-11T21:06:43.236Z,1463000803.236 [Onboard](CRITICAL): Could not find element OnboardEmergencyBatteryCurrent.ad
2016-05-11T21:06:43.236Z,1463000803.236 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardEmergencyBatteryCurrent.ad
2016-05-11T21:06:43.236Z,1463000803.236 [Onboard](CRITICAL): Could not find element OnboardEmergencyBatteryCurrent.adRes
2016-05-11T21:06:43.237Z,1463000803.237 [Onboard](CRITICAL): Could not find element OnboardEmergencyBatteryCurrent.adVref
2016-05-11T21:06:43.237Z,1463000803.237 [Onboard](CRITICAL): Could not find element OnboardMotherboard5VCurrent.ad
2016-05-11T21:06:43.237Z,1463000803.237 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardMotherboard5VCurrent.ad
2016-05-11T21:06:43.237Z,1463000803.237 [Onboard](CRITICAL): Could not find element OnboardMotherboard5VCurrent.adRes
2016-05-11T21:06:43.238Z,1463000803.238 [Onboard](CRITICAL): Could not find element OnboardMotherboard5VCurrent.adVref
2016-05-11T21:06:43.238Z,1463000803.238 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_15VCurrent.ad
2016-05-11T21:06:43.238Z,1463000803.239 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardMotherboard3_15VCurrent.ad
2016-05-11T21:06:43.239Z,1463000803.239 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_15VCurrent.adRes
2016-05-11T21:06:43.239Z,1463000803.239 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_15VCurrent.adVref
2016-05-11T21:06:43.239Z,1463000803.239 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_3VCurrent.ad
2016-05-11T21:06:43.240Z,1463000803.240 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardMotherboard3_3VCurrent.ad
2016-05-11T21:06:43.240Z,1463000803.240 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_3VCurrent.adRes
2016-05-11T21:06:43.240Z,1463000803.240 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_3VCurrent.adVref
2016-05-11T21:06:43.240Z,1463000803.240 [Onboard](CRITICAL): Could not find element OnboardMotherboard1_8VCurrent.ad
2016-05-11T21:06:43.241Z,1463000803.241 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardMotherboard1_8VCurrent.ad
2016-05-11T21:06:43.241Z,1463000803.241 [Onboard](CRITICAL): Could not find element OnboardMotherboard1_8VCurrent.adRes
2016-05-11T21:06:43.241Z,1463000803.241 [Onboard](CRITICAL): Could not find element OnboardMotherboard1_8VCurrent.adVref
2016-05-11T21:06:43.280Z,1463000803.280 [Onboard] Loaded
2016-05-11T21:06:43.281Z,1463000803.281 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-05-11T21:06:43.288Z,1463000803.288 [Radio_Surface] Loaded
2016-05-11T21:06:43.288Z,1463000803.288 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-05-11T21:06:43.289Z,1463000803.289 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4075C4E0
2016-05-11T21:06:43.290Z,1463000803.290 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7860
2016-05-11T21:06:45.124Z,1463000805.124 [BPC1] Loaded
2016-05-11T21:06:45.125Z,1463000805.125 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-05-11T21:06:45.125Z,1463000805.125 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-05-11T21:06:45.125Z,1463000805.125 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-05-11T21:06:45.221Z,1463000805.221 [BuoyancyServo] Loaded
2016-05-11T21:06:45.222Z,1463000805.222 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-05-11T21:06:45.237Z,1463000805.237 [ElevatorServo] Loaded
2016-05-11T21:06:45.237Z,1463000805.237 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-05-11T21:06:45.252Z,1463000805.252 [MassServo] Loaded
2016-05-11T21:06:45.252Z,1463000805.253 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-05-11T21:06:45.268Z,1463000805.268 [RudderServo] Loaded
2016-05-11T21:06:45.268Z,1463000805.268 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-05-11T21:06:45.282Z,1463000805.283 [ThrusterServo] Loaded
2016-05-11T21:06:45.283Z,1463000805.283 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-05-11T21:06:45.283Z,1463000805.283 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-05-11T21:06:45.284Z,1463000805.284 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-05-11T21:06:45.329Z,1463000805.329 [VerticalControl](DEBUG): Construct VerticalControl.
2016-05-11T21:06:45.417Z,1463000805.418 [VerticalControl] Loaded
2016-05-11T21:06:45.418Z,1463000805.418 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-05-11T21:06:45.418Z,1463000805.418 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-05-11T21:06:45.476Z,1463000805.476 [HorizontalControl] Loaded
2016-05-11T21:06:45.476Z,1463000805.476 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-05-11T21:06:45.477Z,1463000805.477 [SpeedControl](DEBUG): Construct SpeedControl.
2016-05-11T21:06:45.479Z,1463000805.479 [SpeedControl] Loaded
2016-05-11T21:06:45.479Z,1463000805.479 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-05-11T21:06:45.480Z,1463000805.480 [LoopControl](DEBUG): Construct LoopControl.
2016-05-11T21:06:45.480Z,1463000805.480 [LoopControl] Loaded
2016-05-11T21:06:45.480Z,1463000805.480 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-05-11T21:06:45.481Z,1463000805.481 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-05-11T21:06:45.481Z,1463000805.481 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-05-11T21:06:45.552Z,1463000805.552 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-05-11T21:06:45.552Z,1463000805.552 [StratificationFrontDetector](DEBUG): (re)initializing
2016-05-11T21:06:45.552Z,1463000805.552 [StratificationFrontDetector] Loaded
2016-05-11T21:06:45.553Z,1463000805.553 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-05-11T21:06:45.553Z,1463000805.553 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-05-11T21:06:45.554Z,1463000805.554 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-05-11T21:06:45.645Z,1463000805.645 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-05-11T21:06:45.649Z,1463000805.649 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-05-11T21:06:45.650Z,1463000805.650 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-05-11T21:06:45.657Z,1463000805.657 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-05-11T21:06:45.658Z,1463000805.658 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408664E0
2016-05-11T21:06:45.658Z,1463000805.658 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7861
2016-05-11T21:06:45.663Z,1463000805.663 [Supervisor](INFO): Main Thread ID is 7777
2016-05-11T21:06:45.664Z,1463000805.664 [Supervisor](DEBUG): Running supervisor.
2016-05-11T21:06:45.664Z,1463000805.664 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7862
2016-05-11T21:06:45.667Z,1463000805.667 [controlThread ThreadHandler](INFO): Handler Thread ID is 7863
2016-05-11T21:06:45.668Z,1463000805.668 [controlThread](DEBUG): Initializing ControlThread
2016-05-11T21:06:45.669Z,1463000805.668 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-11T21:06:45.669Z,1463000805.669 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-05-11T21:06:45.669Z,1463000805.669 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-05-11T21:06:45.669Z,1463000805.670 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-05-11T21:06:45.670Z,1463000805.670 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-05-11T21:06:45.671Z,1463000805.671 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-05-11T21:06:45.671Z,1463000805.671 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-05-11T21:06:45.672Z,1463000805.672 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T21:06:45.672Z,1463000805.672 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T21:06:45.673Z,1463000805.673 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-05-11T21:06:45.673Z,1463000805.673 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T21:06:45.674Z,1463000805.674 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T21:06:45.674Z,1463000805.674 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2016-05-11T21:06:45.674Z,1463000805.674 [DeadReckonWithRespectToWater](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T21:06:45.675Z,1463000805.675 [DeadReckonWithRespectToWater](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T21:06:45.675Z,1463000805.675 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2016-05-11T21:06:45.676Z,1463000805.676 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T21:06:45.676Z,1463000805.676 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T21:06:45.676Z,1463000805.676 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component.
2016-05-11T21:06:45.677Z,1463000805.677 [DeadReckonUsingDVLWaterTrack](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T21:06:45.677Z,1463000805.677 [DeadReckonUsingDVLWaterTrack](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T21:06:45.678Z,1463000805.678 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-05-11T21:06:45.678Z,1463000805.678 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-05-11T21:06:45.678Z,1463000805.678 [SBIT](INFO): Initialize SBIT Component.
2016-05-11T21:06:45.679Z,1463000805.679 [SBIT](IMPORTANT): git: 2015-12-17-10-gfeb4075
2016-05-11T21:06:45.679Z,1463000805.679 [SBIT](INFO): git hash: feb4075d7f18c835d2291dda5f82e8447878ad38
2016-05-11T21:06:45.680Z,1463000805.681 [SBIT](INFO): Kernel Reporting Different Release From Configuration.
Kernel Expected: 2.6.27.8
Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty
2016-05-11T21:06:45.681Z,1463000805.681 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #646 PREEMPT Thu Feb 11 17:01:12 PST 2016
2016-05-11T21:06:45.682Z,1463000805.682 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2016-05-11T21:06:45.682Z,1463000805.682 [IBIT](INFO): Initialize IBIT Component.
2016-05-11T21:06:45.683Z,1463000805.683 [CBIT](DEBUG): Initialize CBIT Component.
2016-05-11T21:06:45.683Z,1463000805.683 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2016-05-11T21:06:45.684Z,1463000805.684 [logger ThreadHandler](INFO): Handler Thread ID is 7864
2016-05-11T21:06:45.712Z,1463000805.712 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7865
2016-05-11T21:06:45.718Z,1463000805.718 [Radio_Surface](INFO): Powering up
2016-05-11T21:06:45.736Z,1463000805.736 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7866
2016-05-11T21:06:45.774Z,1463000805.774 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-05-11T21:06:45.776Z,1463000805.776 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-05-11T21:06:45.776Z,1463000805.776 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-05-11T21:06:45.777Z,1463000805.777 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-05-11T21:06:45.778Z,1463000805.778 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-05-11T21:06:45.789Z,1463000805.789 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-11T21:06:45.812Z,1463000805.812 [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>


2016-05-11T21:06:45.812Z,1463000805.812 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-05-11T21:06:45.849Z,1463000805.849 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-05-11T21:06:45.850Z,1463000805.850 [Default:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-11T21:06:45.880Z,1463000805.880 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-05-11T21:06:45.882Z,1463000805.882 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-05-11T21:06:45.901Z,1463000805.901 [Default:D.Execute](DEBUG): Construct Execute.
2016-05-11T21:06:45.905Z,1463000805.905 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
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/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="Default">

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

        <ReadDatum Id="Read_Iridium">
            <Sequence/>
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn 300</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>


2016-05-11T21:06:45.911Z,1463000805.911 [controlThread](DEBUG): Component order: CycleStarter,AHRS_sp3003D,DataOverHttps,Depth_Keller,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToWater,DeadReckonWithRespectToSeafloor,DeadReckonUsingDVLWaterTrack,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2016-05-11T21:06:46.129Z,1463000806.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.130Z,1463000806.130 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:46.133Z,1463000806.133 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:46.148Z,1463000806.148 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.159Z,1463000806.159 [DeadReckonWithRespectToWater](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.167Z,1463000806.167 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.186Z,1463000806.186 [DeadReckonUsingDVLWaterTrack](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.273Z,1463000806.273 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-11T21:06:46.280Z,1463000806.280 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-11T21:06:46.285Z,1463000806.286 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-05-11T21:06:46.292Z,1463000806.292 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-05-11T21:06:46.297Z,1463000806.297 [MassServo](DEBUG): Initializing EZServoServo.
2016-05-11T21:06:46.303Z,1463000806.303 [MassServo](DEBUG): Initializing MassServo.
2016-05-11T21:06:46.309Z,1463000806.309 [RudderServo](DEBUG): Initializing EZServoServo.
2016-05-11T21:06:46.315Z,1463000806.316 [RudderServo](DEBUG): Initializing RudderServo.
2016-05-11T21:06:46.332Z,1463000806.332 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-05-11T21:06:46.339Z,1463000806.339 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-05-11T21:06:46.364Z,1463000806.364 [CommandLine](FAULT): Scheduling is paused
2016-05-11T21:06:46.612Z,1463000806.612 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.612Z,1463000806.612 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:46.613Z,1463000806.614 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:46.614Z,1463000806.614 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.615Z,1463000806.615 [DeadReckonWithRespectToWater](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.616Z,1463000806.616 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:46.617Z,1463000806.617 [DeadReckonUsingDVLWaterTrack](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T21:06:52.431Z,1463000812.431 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-05-11T21:06:52.432Z,1463000812.432 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-05-11T21:06:52.432Z,1463000812.432 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2016-05-11T21:06:52.432Z,1463000812.432 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI80M.000
2016-05-11T21:06:52.433Z,1463000812.433 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-05-11T21:06:52.433Z,1463000812.433 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-05-11T21:06:52.433Z,1463000812.433 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-05-11T21:06:52.433Z,1463000812.433 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4IN01M.000
2016-05-11T21:06:52.434Z,1463000812.434 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI56M.000
2016-05-11T21:06:52.434Z,1463000812.434 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI57M.000
2016-05-11T21:06:52.434Z,1463000812.434 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI59M.000
2016-05-11T21:06:52.434Z,1463000812.434 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2016-05-11T21:06:52.435Z,1463000812.435 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI90M.000
2016-05-11T21:06:52.435Z,1463000812.435 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI03M.000
2016-05-11T21:06:52.435Z,1463000812.435 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI06M.000
2016-05-11T21:06:52.435Z,1463000812.435 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI33M.000
2016-05-11T21:06:52.436Z,1463000812.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI34M.000
2016-05-11T21:06:52.436Z,1463000812.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-05-11T21:06:52.436Z,1463000812.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-05-11T21:06:52.436Z,1463000812.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-05-11T21:06:52.437Z,1463000812.437 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-05-11T21:06:52.660Z,1463000812.660 [NAL9602](INFO): Powering up NAL9602
2016-05-11T21:06:52.691Z,1463000812.691 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:52.692Z,1463000812.692 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:53.039Z,1463000813.039 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:53.040Z,1463000813.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:53.427Z,1463000813.427 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:53.428Z,1463000813.428 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:53.813Z,1463000813.813 [DataOverHttps](DEBUG): dataRead() @791 received: vehicle=ahi&busy=false, 1
2016-05-11T21:06:53.814Z,1463000813.814 [DataOverHttps](DEBUG): ParseDataRead( data = busy=false, key = 6, value = ahi
2016-05-11T21:06:53.814Z,1463000813.814 [DataOverHttps](DEBUG): ParseDataRead( data = , key = 0, value = false
2016-05-11T21:06:53.818Z,1463000813.818 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005200
2016-05-11T21:06:53.835Z,1463000813.835 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:53.837Z,1463000813.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:54.227Z,1463000814.227 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:54.228Z,1463000814.228 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:54.631Z,1463000814.631 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:54.632Z,1463000814.632 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:55.056Z,1463000815.056 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:55.057Z,1463000815.057 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:55.427Z,1463000815.427 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:55.428Z,1463000815.428 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:55.827Z,1463000815.827 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T21:06:55.828Z,1463000815.828 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:56.229Z,1463000816.229 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:56.628Z,1463000816.628 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:57.032Z,1463000817.032 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:57.435Z,1463000817.435 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:57.837Z,1463000817.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:58.228Z,1463000818.228 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:58.682Z,1463000818.682 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:59.028Z,1463000819.028 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:59.428Z,1463000819.428 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:06:59.856Z,1463000819.856 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:00.228Z,1463000820.228 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:00.656Z,1463000820.656 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:01.056Z,1463000821.056 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:01.428Z,1463000821.428 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:01.828Z,1463000821.828 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:02.228Z,1463000822.228 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:02.628Z,1463000822.628 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:03.028Z,1463000823.028 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:03.440Z,1463000823.440 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:03.840Z,1463000823.840 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:04.236Z,1463000824.236 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:04.628Z,1463000824.628 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:05.028Z,1463000825.028 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:05.436Z,1463000825.436 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:05.828Z,1463000825.828 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:06.237Z,1463000826.237 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:06.249Z,1463000826.249 [SBIT](IMPORTANT): Beginning Startup BIT
2016-05-11T21:07:06.252Z,1463000826.252 [CBIT](IMPORTANT): Beginning GF scan
2016-05-11T21:07:06.648Z,1463000826.648 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:06.947Z,1463000826.947 [CBIT](IMPORTANT): Open Volts:2.500782
Open Current:-0.000065
2016-05-11T21:07:07.032Z,1463000827.032 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:07.438Z,1463000827.438 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:07.840Z,1463000827.840 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:08.171Z,1463000828.171 [CBIT](IMPORTANT): A0 Volts:2.666869
A0 Current:0.106807
2016-05-11T21:07:08.250Z,1463000828.250 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:08.764Z,1463000828.764 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:09.168Z,1463000829.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:09.460Z,1463000829.460 [CBIT](IMPORTANT): A1 Volts:2.266176
A1 Current:-0.149137
2016-05-11T21:07:09.564Z,1463000829.564 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:09.968Z,1463000829.968 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:10.368Z,1463000830.368 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:10.668Z,1463000830.668 [CBIT](IMPORTANT): A2 Volts:2.667723
A2 Current:0.106576
2016-05-11T21:07:10.768Z,1463000830.768 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:11.168Z,1463000831.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:11.568Z,1463000831.568 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:11.967Z,1463000831.967 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:12.271Z,1463000832.272 [CBIT](IMPORTANT): A3 Volts:2.618454
A3 Current:0.075412
2016-05-11T21:07:12.376Z,1463000832.376 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:12.804Z,1463000832.804 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:13.172Z,1463000833.172 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:13.547Z,1463000833.547 [NAL9602](ERROR): NAL9602 initialization error.
2016-05-11T21:07:13.547Z,1463000833.547 [NAL9602] Communications Fault, FailCount= 1
2016-05-11T21:07:13.547Z,1463000833.547 [NAL9602](ERROR): Communications Fault
2016-05-11T21:07:13.560Z,1463000833.560 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:13.645Z,1463000833.645 [CBIT](ERROR): Communications Fault in component: NAL9602
2016-05-11T21:07:13.823Z,1463000833.823 [CBIT](IMPORTANT): B0 Volts:2.389481
B0 Current:-0.069800
2016-05-11T21:07:13.947Z,1463000833.947 [NAL9602](INFO): Powering down
2016-05-11T21:07:13.984Z,1463000833.984 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:14.372Z,1463000834.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:14.784Z,1463000834.784 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:14.880Z,1463000834.880 [CBIT](INFO): Clearing failed state for component NAL9602
2016-05-11T21:07:14.880Z,1463000834.880 [NAL9602] No Fault, FailCount= 1
2016-05-11T21:07:15.047Z,1463000835.047 [CBIT](IMPORTANT): B1 Volts:2.284234
B1 Current:-0.136877
2016-05-11T21:07:15.160Z,1463000835.160 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:15.584Z,1463000835.584 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:15.960Z,1463000835.960 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:16.360Z,1463000836.360 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:16.645Z,1463000836.645 [CBIT](IMPORTANT): B2 Volts:2.281101
B2 Current:-0.138898
2016-05-11T21:07:16.766Z,1463000836.766 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:17.160Z,1463000837.160 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:17.562Z,1463000837.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:17.962Z,1463000837.962 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:18.201Z,1463000838.201 [CBIT](IMPORTANT): B3 Volts:1.771514
B3 Current:-0.462541
2016-05-11T21:07:18.362Z,1463000838.362 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:18.444Z,1463000838.444 [CBIT](FAULT): Low side GF detected
mA:
CHAN A0 (Batt): 0.106807
CHAN A1 (24V): -0.149137
CHAN A2 (12V): 0.106576
CHAN A3 (5V): 0.075412
CHAN B0 (3.3V): -0.069800
CHAN B1 (3.15aV): -0.136877
CHAN B2 (3.15bV): -0.138898
CHAN B3 (GND): -0.462541
OPEN: -0.000065
Full Scale Calc: 4.765 mA, -1.589 mA
2016-05-11T21:07:18.752Z,1463000838.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:19.140Z,1463000839.141 [NAL9602](INFO): Powering up NAL9602
2016-05-11T21:07:19.152Z,1463000839.152 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:19.552Z,1463000839.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:19.630Z,1463000839.630 [SBIT](FAULT): Mass: EXPECTED:0.012000 ACTUAL:0.008559
2016-05-11T21:07:19.952Z,1463000839.952 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:20.352Z,1463000840.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:20.752Z,1463000840.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:21.152Z,1463000841.152 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:21.552Z,1463000841.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:21.972Z,1463000841.972 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:22.352Z,1463000842.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:22.752Z,1463000842.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:23.152Z,1463000843.152 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:23.553Z,1463000843.553 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:23.952Z,1463000843.952 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:24.352Z,1463000844.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:24.752Z,1463000844.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:25.163Z,1463000845.163 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:25.562Z,1463000845.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:25.962Z,1463000845.962 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:26.362Z,1463000846.362 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:26.762Z,1463000846.762 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:27.064Z,1463000847.064 [CommandLine](IMPORTANT): got command quit
2016-05-11T21:07:27.162Z,1463000847.162 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:27.620Z,1463000847.620 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:27.968Z,1463000847.968 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:28.070Z,1463000848.070 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T21:07:28.071Z,1463000848.070 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:28.215Z,1463000848.215 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2016-05-11T21:07:28.215Z,1463000848.215 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:28.216Z,1463000848.216 [CommandLine](INFO): Join timeout helper Thread ID is 7876
2016-05-11T21:07:28.227Z,1463000848.227 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2016-05-11T21:07:28.227Z,1463000848.227 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:28.228Z,1463000848.228 [NavChartDb](INFO): Join timeout helper Thread ID is 7877
2016-05-11T21:07:28.384Z,1463000848.384 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:28.768Z,1463000848.768 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:29.192Z,1463000849.192 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:29.596Z,1463000849.596 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:29.968Z,1463000849.968 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T21:07:30.093Z,1463000850.093 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T21:07:30.093Z,1463000850.093 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.111Z,1463000850.111 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2016-05-11T21:07:30.111Z,1463000850.111 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.112Z,1463000850.112 [Radio_Surface](INFO): Join timeout helper Thread ID is 7878
2016-05-11T21:07:30.215Z,1463000850.215 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T21:07:30.216Z,1463000850.216 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.231Z,1463000850.231 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2016-05-11T21:07:30.231Z,1463000850.231 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.232Z,1463000850.232 [logger](INFO): Join timeout helper Thread ID is 7879
2016-05-11T21:07:30.251Z,1463000850.251 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T21:07:30.252Z,1463000850.252 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.271Z,1463000850.271 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2016-05-11T21:07:30.271Z,1463000850.271 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.271Z,1463000850.271 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2016-05-11T21:07:30.271Z,1463000850.271 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.272Z,1463000850.272 [controlThread](INFO): Join timeout helper Thread ID is 7880
2016-05-11T21:07:30.331Z,1463000850.331 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T21:07:30.331Z,1463000850.332 [controlThread](DEBUG): Uninitializing ControlThread
2016-05-11T21:07:30.333Z,1463000850.332 [NAL9602](INFO): Powering down
2016-05-11T21:07:30.335Z,1463000850.335 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-11T21:07:30.336Z,1463000850.336 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2016-05-11T21:07:30.339Z,1463000850.339 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2016-05-11T21:07:30.340Z,1463000850.340 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2016-05-11T21:07:30.340Z,1463000850.340 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2016-05-11T21:07:30.340Z,1463000850.340 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2016-05-11T21:07:30.340Z,1463000850.340 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-11T21:07:30.341Z,1463000850.341 [BuoyancyServo](INFO): Powering down
2016-05-11T21:07:30.355Z,1463000850.355 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2016-05-11T21:07:30.355Z,1463000850.355 [ElevatorServo](INFO): Powering down
2016-05-11T21:07:30.356Z,1463000850.356 [MassServo](DEBUG): Uninitialize Mass Servo.
2016-05-11T21:07:30.356Z,1463000850.356 [MassServo](INFO): Powering down
2016-05-11T21:07:30.357Z,1463000850.357 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2016-05-11T21:07:30.357Z,1463000850.357 [RudderServo](INFO): Powering down
2016-05-11T21:07:30.358Z,1463000850.358 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2016-05-11T21:07:30.358Z,1463000850.358 [ThrusterServo](INFO): Powering down
2016-05-11T21:07:30.359Z,1463000850.359 [SBIT](DEBUG): Uninitialize SBIT Component.
2016-05-11T21:07:30.359Z,1463000850.359 [IBIT](DEBUG): Uninitialize IBIT Component.
2016-05-11T21:07:30.360Z,1463000850.360 [CBIT](DEBUG): Uninitialize CBIT Component.
2016-05-11T21:07:30.360Z,1463000850.360 [CBIT](CRITICAL): Backplane failed to power down
2016-05-11T21:07:30.361Z,1463000850.361 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.467Z,1463000850.467 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.638Z,1463000850.638 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-11T21:07:30.688Z,1463000850.688 [logger ThreadHandler](INFO): Thread cancelled.