2016-05-11T20:17:17.104Z,1462997837.104 [Supervisor](DEBUG): Initializing supervisor.
2016-05-11T20:17:17.106Z,1462997837.106 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2016-05-11T20:17:17.106Z,1462997837.106 [SyncHandler](INFO): Protected caller Thread ID is 767
2016-05-11T20:17:17.107Z,1462997837.107 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-05-11T20:17:17.108Z,1462997837.108 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2016-05-11T20:17:17.108Z,1462997837.108 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 768
2016-05-11T20:17:17.111Z,1462997837.111 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-05-11T20:17:17.123Z,1462997837.123 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-05-11T20:17:17.124Z,1462997837.124 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2016-05-11T20:17:17.124Z,1462997837.124 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 769
2016-05-11T20:17:17.125Z,1462997837.125 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-05-11T20:17:17.126Z,1462997837.126 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2016-05-11T20:17:17.126Z,1462997837.126 [logger ThreadHandler](INFO): Protected caller Thread ID is 770
2016-05-11T20:17:17.128Z,1462997837.128 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-05-11T20:17:17.129Z,1462997837.129 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-05-11T20:17:17.134Z,1462997837.134 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-05-11T20:17:17.224Z,1462997837.224 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-05-11T20:17:17.597Z,1462997837.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-05-11T20:17:17.599Z,1462997837.599 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-05-11T20:17:17.731Z,1462997837.731 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-05-11T20:17:17.732Z,1462997837.732 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-05-11T20:17:17.937Z,1462997837.937 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-05-11T20:17:17.937Z,1462997837.937 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-05-11T20:17:18.042Z,1462997838.042 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-05-11T20:17:18.043Z,1462997838.043 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-05-11T20:17:18.236Z,1462997838.236 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-05-11T20:17:18.238Z,1462997838.238 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-05-11T20:17:18.753Z,1462997838.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-05-11T20:17:18.754Z,1462997838.754 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-05-11T20:17:19.061Z,1462997839.061 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-05-11T20:17:19.062Z,1462997839.062 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-05-11T20:17:19.152Z,1462997839.151 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-05-11T20:17:19.152Z,1462997839.152 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-05-11T20:17:19.293Z,1462997839.293 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-05-11T20:17:19.293Z,1462997839.293 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-05-11T20:17:19.597Z,1462997839.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-05-11T20:17:19.598Z,1462997839.598 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-05-11T20:17:20.178Z,1462997840.178 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-05-11T20:17:20.179Z,1462997840.179 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-05-11T20:17:24.631Z,1462997844.631 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-05-11T20:17:24.632Z,1462997844.632 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-05-11T20:17:24.973Z,1462997844.973 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-05-11T20:17:24.973Z,1462997844.973 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-05-11T20:17:25.090Z,1462997845.090 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-05-11T20:17:25.092Z,1462997845.092 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2016-05-11T20:17:25.094Z,1462997845.094 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2016-05-11T20:17:25.201Z,1462997845.201 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2016-05-11T20:17:26.175Z,1462997846.175 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2016-05-11T20:17:26.267Z,1462997846.267 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2016-05-11T20:17:26.375Z,1462997846.375 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2016-05-11T20:17:26.469Z,1462997846.469 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2016-05-11T20:17:26.628Z,1462997846.628 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2016-05-11T20:17:26.735Z,1462997846.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2016-05-11T20:17:26.921Z,1462997846.921 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2016-05-11T20:17:27.157Z,1462997847.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-05-11T20:17:27.157Z,1462997847.157 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2016-05-11T20:17:27.343Z,1462997847.342 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2016-05-11T20:17:27.458Z,1462997847.458 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2016-05-11T20:17:27.467Z,1462997847.467 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-05-11T20:17:27.506Z,1462997847.506 [DepthRateCalculator] Loaded
2016-05-11T20:17:27.506Z,1462997847.506 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-05-11T20:17:27.512Z,1462997847.512 [PitchRateCalculator] Loaded
2016-05-11T20:17:27.512Z,1462997847.513 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-05-11T20:17:27.524Z,1462997847.524 [SpeedCalculator] Loaded
2016-05-11T20:17:27.524Z,1462997847.524 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-05-11T20:17:27.540Z,1462997847.540 [TempGradientCalculator] Loaded
2016-05-11T20:17:27.540Z,1462997847.540 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-05-11T20:17:27.556Z,1462997847.556 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-05-11T20:17:27.556Z,1462997847.556 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-05-11T20:17:27.562Z,1462997847.562 [YawRateCalculator] Loaded
2016-05-11T20:17:27.563Z,1462997847.563 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-05-11T20:17:27.563Z,1462997847.563 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-05-11T20:17:27.564Z,1462997847.564 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-05-11T20:17:27.684Z,1462997847.684 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-05-11T20:17:27.684Z,1462997847.684 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-05-11T20:17:27.738Z,1462997847.738 [DeadReckonUsingSpeedCalculator] Loaded
2016-05-11T20:17:27.738Z,1462997847.738 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-05-11T20:17:27.791Z,1462997847.791 [DeadReckonWithRespectToWater] Loaded
2016-05-11T20:17:27.791Z,1462997847.791 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2016-05-11T20:17:27.845Z,1462997847.845 [DeadReckonWithRespectToSeafloor] Loaded
2016-05-11T20:17:27.845Z,1462997847.845 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2016-05-11T20:17:27.905Z,1462997847.905 [DeadReckonUsingDVLWaterTrack] Loaded
2016-05-11T20:17:27.905Z,1462997847.905 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread.
2016-05-11T20:17:27.922Z,1462997847.922 [NavChart] Loaded
2016-05-11T20:17:27.922Z,1462997847.922 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-05-11T20:17:27.926Z,1462997847.926 [UniversalFixResidualReporter] Loaded
2016-05-11T20:17:27.927Z,1462997847.927 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-05-11T20:17:27.927Z,1462997847.927 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-05-11T20:17:27.928Z,1462997847.928 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-05-11T20:17:28.072Z,1462997848.072 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-05-11T20:17:28.072Z,1462997848.072 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-05-11T20:17:28.110Z,1462997848.110 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-05-11T20:17:28.111Z,1462997848.111 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-05-11T20:17:28.119Z,1462997848.119 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-05-11T20:17:28.120Z,1462997848.120 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-05-11T20:17:28.389Z,1462997848.389 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-05-11T20:17:28.390Z,1462997848.390 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-05-11T20:17:28.540Z,1462997848.540 [SBIT](DEBUG): Construct Startup Built In Test.
2016-05-11T20:17:28.571Z,1462997848.571 [SBIT] Loaded
2016-05-11T20:17:28.572Z,1462997848.572 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-05-11T20:17:28.572Z,1462997848.572 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-05-11T20:17:28.600Z,1462997848.600 [IBIT] Loaded
2016-05-11T20:17:28.600Z,1462997848.600 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-05-11T20:17:28.604Z,1462997848.604 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-05-11T20:17:28.756Z,1462997848.756 [CBIT] Loaded
2016-05-11T20:17:28.756Z,1462997848.756 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-05-11T20:17:28.756Z,1462997848.756 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-05-11T20:17:28.757Z,1462997848.757 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-05-11T20:17:29.435Z,1462997849.435 [AHRS_sp3003D] Loaded
2016-05-11T20:17:29.436Z,1462997849.436 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2016-05-11T20:17:29.595Z,1462997849.595 [DataOverHttps] Loaded
2016-05-11T20:17:29.596Z,1462997849.596 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-05-11T20:17:29.610Z,1462997849.610 [Depth_Keller] Loaded
2016-05-11T20:17:29.610Z,1462997849.610 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-05-11T20:17:29.702Z,1462997849.703 [NAL9602] Loaded
2016-05-11T20:17:29.703Z,1462997849.703 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-05-11T20:17:29.706Z,1462997849.706 [Onboard](CRITICAL): Could not find element OnboardSecondaryBatteryCurrent.ad
2016-05-11T20:17:29.706Z,1462997849.706 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardSecondaryBatteryCurrent.ad
2016-05-11T20:17:29.706Z,1462997849.707 [Onboard](CRITICAL): Could not find element OnboardSecondaryBatteryCurrent.adRes
2016-05-11T20:17:29.707Z,1462997849.707 [Onboard](CRITICAL): Could not find element OnboardSecondaryBatteryCurrent.adVref
2016-05-11T20:17:29.707Z,1462997849.707 [Onboard](CRITICAL): Could not find element OnboardEmergencyBatteryCurrent.ad
2016-05-11T20:17:29.707Z,1462997849.707 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardEmergencyBatteryCurrent.ad
2016-05-11T20:17:29.708Z,1462997849.708 [Onboard](CRITICAL): Could not find element OnboardEmergencyBatteryCurrent.adRes
2016-05-11T20:17:29.708Z,1462997849.708 [Onboard](CRITICAL): Could not find element OnboardEmergencyBatteryCurrent.adVref
2016-05-11T20:17:29.708Z,1462997849.708 [Onboard](CRITICAL): Could not find element OnboardMotherboard5VCurrent.ad
2016-05-11T20:17:29.709Z,1462997849.709 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardMotherboard5VCurrent.ad
2016-05-11T20:17:29.709Z,1462997849.709 [Onboard](CRITICAL): Could not find element OnboardMotherboard5VCurrent.adRes
2016-05-11T20:17:29.709Z,1462997849.709 [Onboard](CRITICAL): Could not find element OnboardMotherboard5VCurrent.adVref
2016-05-11T20:17:29.709Z,1462997849.709 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_15VCurrent.ad
2016-05-11T20:17:29.710Z,1462997849.710 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardMotherboard3_15VCurrent.ad
2016-05-11T20:17:29.710Z,1462997849.710 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_15VCurrent.adRes
2016-05-11T20:17:29.710Z,1462997849.710 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_15VCurrent.adVref
2016-05-11T20:17:29.711Z,1462997849.711 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_3VCurrent.ad
2016-05-11T20:17:29.711Z,1462997849.711 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardMotherboard3_3VCurrent.ad
2016-05-11T20:17:29.711Z,1462997849.711 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_3VCurrent.adRes
2016-05-11T20:17:29.711Z,1462997849.711 [Onboard](CRITICAL): Could not find element OnboardMotherboard3_3VCurrent.adVref
2016-05-11T20:17:29.712Z,1462997849.712 [Onboard](CRITICAL): Could not find element OnboardMotherboard1_8VCurrent.ad
2016-05-11T20:17:29.712Z,1462997849.712 [Onboard](ERROR): Could not open device '/dev/invalid' at OnboardMotherboard1_8VCurrent.ad
2016-05-11T20:17:29.712Z,1462997849.712 [Onboard](CRITICAL): Could not find element OnboardMotherboard1_8VCurrent.adRes
2016-05-11T20:17:29.713Z,1462997849.713 [Onboard](CRITICAL): Could not find element OnboardMotherboard1_8VCurrent.adVref
2016-05-11T20:17:29.753Z,1462997849.753 [Onboard] Loaded
2016-05-11T20:17:29.753Z,1462997849.753 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-05-11T20:17:29.761Z,1462997849.760 [Radio_Surface] Loaded
2016-05-11T20:17:29.761Z,1462997849.761 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-05-11T20:17:29.762Z,1462997849.762 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4075C4E0
2016-05-11T20:17:29.762Z,1462997849.762 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 851
2016-05-11T20:17:31.660Z,1462997851.660 [BPC1] Loaded
2016-05-11T20:17:31.660Z,1462997851.661 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-05-11T20:17:31.661Z,1462997851.661 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-05-11T20:17:31.662Z,1462997851.662 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-05-11T20:17:31.786Z,1462997851.786 [BuoyancyServo] Loaded
2016-05-11T20:17:31.787Z,1462997851.787 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-05-11T20:17:31.803Z,1462997851.803 [ElevatorServo] Loaded
2016-05-11T20:17:31.803Z,1462997851.803 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-05-11T20:17:31.818Z,1462997851.818 [MassServo] Loaded
2016-05-11T20:17:31.818Z,1462997851.819 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-05-11T20:17:31.834Z,1462997851.834 [RudderServo] Loaded
2016-05-11T20:17:31.834Z,1462997851.834 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-05-11T20:17:31.849Z,1462997851.849 [ThrusterServo] Loaded
2016-05-11T20:17:31.850Z,1462997851.850 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-05-11T20:17:31.850Z,1462997851.850 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-05-11T20:17:31.851Z,1462997851.851 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-05-11T20:17:31.918Z,1462997851.918 [VerticalControl](DEBUG): Construct VerticalControl.
2016-05-11T20:17:32.009Z,1462997852.009 [VerticalControl] Loaded
2016-05-11T20:17:32.010Z,1462997852.010 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-05-11T20:17:32.010Z,1462997852.010 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-05-11T20:17:32.069Z,1462997852.069 [HorizontalControl] Loaded
2016-05-11T20:17:32.070Z,1462997852.070 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-05-11T20:17:32.070Z,1462997852.070 [SpeedControl](DEBUG): Construct SpeedControl.
2016-05-11T20:17:32.072Z,1462997852.072 [SpeedControl] Loaded
2016-05-11T20:17:32.073Z,1462997852.073 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-05-11T20:17:32.073Z,1462997852.073 [LoopControl](DEBUG): Construct LoopControl.
2016-05-11T20:17:32.074Z,1462997852.074 [LoopControl] Loaded
2016-05-11T20:17:32.074Z,1462997852.074 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-05-11T20:17:32.075Z,1462997852.075 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-05-11T20:17:32.075Z,1462997852.075 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-05-11T20:17:32.191Z,1462997852.191 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-05-11T20:17:32.191Z,1462997852.191 [StratificationFrontDetector](DEBUG): (re)initializing
2016-05-11T20:17:32.191Z,1462997852.191 [StratificationFrontDetector] Loaded
2016-05-11T20:17:32.192Z,1462997852.192 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-05-11T20:17:32.192Z,1462997852.192 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-05-11T20:17:32.193Z,1462997852.193 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-05-11T20:17:32.319Z,1462997852.319 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-05-11T20:17:32.323Z,1462997852.323 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-05-11T20:17:32.324Z,1462997852.324 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-05-11T20:17:32.331Z,1462997852.330 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-05-11T20:17:32.332Z,1462997852.332 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408664E0
2016-05-11T20:17:32.332Z,1462997852.332 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 852
2016-05-11T20:17:32.337Z,1462997852.337 [Supervisor](INFO): Main Thread ID is 762
2016-05-11T20:17:32.337Z,1462997852.337 [Supervisor](DEBUG): Running supervisor.
2016-05-11T20:17:32.338Z,1462997852.338 [CommandLine ThreadHandler](INFO): Handler Thread ID is 853
2016-05-11T20:17:32.341Z,1462997852.341 [controlThread ThreadHandler](INFO): Handler Thread ID is 854
2016-05-11T20:17:32.341Z,1462997852.341 [controlThread](DEBUG): Initializing ControlThread
2016-05-11T20:17:32.342Z,1462997852.342 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-11T20:17:32.342Z,1462997852.342 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-05-11T20:17:32.343Z,1462997852.343 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-05-11T20:17:32.343Z,1462997852.343 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-05-11T20:17:32.344Z,1462997852.344 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-05-11T20:17:32.344Z,1462997852.344 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-05-11T20:17:32.345Z,1462997852.345 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-05-11T20:17:32.346Z,1462997852.346 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T20:17:32.346Z,1462997852.346 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T20:17:32.346Z,1462997852.346 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-05-11T20:17:32.347Z,1462997852.347 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T20:17:32.347Z,1462997852.347 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T20:17:32.348Z,1462997852.348 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2016-05-11T20:17:32.348Z,1462997852.348 [DeadReckonWithRespectToWater](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T20:17:32.348Z,1462997852.348 [DeadReckonWithRespectToWater](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T20:17:32.349Z,1462997852.349 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2016-05-11T20:17:32.349Z,1462997852.349 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T20:17:32.350Z,1462997852.349 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T20:17:32.350Z,1462997852.350 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component.
2016-05-11T20:17:32.350Z,1462997852.350 [DeadReckonUsingDVLWaterTrack](INFO): Will consider orientation measurement stale after 120s.
2016-05-11T20:17:32.351Z,1462997852.351 [DeadReckonUsingDVLWaterTrack](INFO): Will consider velocity measurement stale after 20s.
2016-05-11T20:17:32.351Z,1462997852.351 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-05-11T20:17:32.352Z,1462997852.352 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-05-11T20:17:32.352Z,1462997852.352 [SBIT](INFO): Initialize SBIT Component.
2016-05-11T20:17:32.352Z,1462997852.352 [SBIT](IMPORTANT): git: 2015-12-17-10-gfeb4075
2016-05-11T20:17:32.352Z,1462997852.352 [SBIT](INFO): git hash: feb4075d7f18c835d2291dda5f82e8447878ad38
2016-05-11T20:17:32.354Z,1462997852.354 [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-11T20:17:32.354Z,1462997852.354 [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-11T20:17:32.355Z,1462997852.355 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2016-05-11T20:17:32.356Z,1462997852.356 [IBIT](INFO): Initialize IBIT Component.
2016-05-11T20:17:32.356Z,1462997852.356 [CBIT](DEBUG): Initialize CBIT Component.
2016-05-11T20:17:32.357Z,1462997852.357 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2016-05-11T20:17:32.358Z,1462997852.358 [logger ThreadHandler](INFO): Handler Thread ID is 855
2016-05-11T20:17:32.384Z,1462997852.384 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 856
2016-05-11T20:17:32.390Z,1462997852.390 [Radio_Surface](INFO): Powering up
2016-05-11T20:17:32.408Z,1462997852.408 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 857
2016-05-11T20:17:32.416Z,1462997852.416 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-05-11T20:17:32.419Z,1462997852.419 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-05-11T20:17:32.420Z,1462997852.420 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2016-05-11T20:17:32.420Z,1462997852.420 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI80M.000
2016-05-11T20:17:32.420Z,1462997852.420 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-05-11T20:17:32.420Z,1462997852.420 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-05-11T20:17:32.421Z,1462997852.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-05-11T20:17:32.421Z,1462997852.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4IN01M.000
2016-05-11T20:17:32.421Z,1462997852.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI56M.000
2016-05-11T20:17:32.421Z,1462997852.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI57M.000
2016-05-11T20:17:32.422Z,1462997852.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI59M.000
2016-05-11T20:17:32.422Z,1462997852.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2016-05-11T20:17:32.422Z,1462997852.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI90M.000
2016-05-11T20:17:32.422Z,1462997852.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI03M.000
2016-05-11T20:17:32.423Z,1462997852.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI06M.000
2016-05-11T20:17:32.423Z,1462997852.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI33M.000
2016-05-11T20:17:32.423Z,1462997852.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI34M.000
2016-05-11T20:17:32.423Z,1462997852.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-05-11T20:17:32.424Z,1462997852.424 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-05-11T20:17:32.424Z,1462997852.424 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-05-11T20:17:32.424Z,1462997852.424 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-05-11T20:17:32.446Z,1462997852.446 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-05-11T20:17:32.448Z,1462997852.448 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-05-11T20:17:32.448Z,1462997852.448 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-05-11T20:17:32.449Z,1462997852.449 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-05-11T20:17:32.450Z,1462997852.450 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-05-11T20:17:32.487Z,1462997852.487 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-11T20:17:32.502Z,1462997852.501 [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-11T20:17:32.502Z,1462997852.502 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-05-11T20:17:32.579Z,1462997852.579 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-05-11T20:17:32.580Z,1462997852.580 [Default:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-11T20:17:32.598Z,1462997852.598 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-05-11T20:17:32.625Z,1462997852.625 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-05-11T20:17:32.631Z,1462997852.631 [Default:D.Execute](DEBUG): Construct Execute.
2016-05-11T20:17:32.657Z,1462997852.657 [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-11T20:17:32.675Z,1462997852.675 [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-11T20:17:32.740Z,1462997852.740 [Depth_Keller](ERROR): Pressure reading out of range: 1895.584351 decibar
2016-05-11T20:17:32.904Z,1462997852.904 [DepthRateCalculator](ERROR): Depth measurement is not active
2016-05-11T20:17:32.995Z,1462997852.995 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:32.995Z,1462997852.995 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:33.194Z,1462997853.194 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:33.227Z,1462997853.227 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.239Z,1462997853.239 [DeadReckonWithRespectToWater](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.251Z,1462997853.251 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.264Z,1462997853.264 [DeadReckonUsingDVLWaterTrack](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.363Z,1462997853.364 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-11T20:17:33.371Z,1462997853.372 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-11T20:17:33.394Z,1462997853.394 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-05-11T20:17:33.400Z,1462997853.399 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-05-11T20:17:33.410Z,1462997853.410 [MassServo](DEBUG): Initializing EZServoServo.
2016-05-11T20:17:33.415Z,1462997853.415 [MassServo](DEBUG): Initializing MassServo.
2016-05-11T20:17:33.421Z,1462997853.421 [RudderServo](DEBUG): Initializing EZServoServo.
2016-05-11T20:17:33.427Z,1462997853.427 [RudderServo](DEBUG): Initializing RudderServo.
2016-05-11T20:17:33.433Z,1462997853.433 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-05-11T20:17:33.440Z,1462997853.440 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-05-11T20:17:33.480Z,1462997853.480 [CommandLine](FAULT): Scheduling is paused
2016-05-11T20:17:33.743Z,1462997853.743 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.743Z,1462997853.743 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:33.744Z,1462997853.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:33.751Z,1462997853.751 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.752Z,1462997853.752 [DeadReckonWithRespectToWater](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.753Z,1462997853.753 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.754Z,1462997853.754 [DeadReckonUsingDVLWaterTrack](DEBUG): Starting up and don't have orientation data yet.
2016-05-11T20:17:33.940Z,1462997853.940 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:33.941Z,1462997853.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:34.295Z,1462997854.295 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2016-05-11T20:17:34.295Z,1462997854.295 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2016-05-11T20:17:34.296Z,1462997854.296 [BuoyancyServo] Communications Fault, FailCount= 1
2016-05-11T20:17:34.296Z,1462997854.296 [BuoyancyServo](ERROR): Communications Fault
2016-05-11T20:17:34.507Z,1462997854.507 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2016-05-11T20:17:34.559Z,1462997854.559 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:34.560Z,1462997854.560 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:34.576Z,1462997854.576 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-11T20:17:34.577Z,1462997854.577 [BuoyancyServo](INFO): Powering down
2016-05-11T20:17:34.921Z,1462997854.921 [NAL9602](INFO): Powering up NAL9602
2016-05-11T20:17:34.935Z,1462997854.935 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:34.936Z,1462997854.936 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:35.331Z,1462997855.331 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:35.332Z,1462997855.332 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:35.731Z,1462997855.731 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:35.732Z,1462997855.732 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:36.131Z,1462997856.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:36.132Z,1462997856.132 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:36.531Z,1462997856.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:36.532Z,1462997856.532 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:36.931Z,1462997856.931 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:36.932Z,1462997856.932 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:37.072Z,1462997857.072 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2016-05-11T20:17:37.073Z,1462997857.073 [BuoyancyServo] No Fault, FailCount= 1
2016-05-11T20:17:37.347Z,1462997857.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid.
2016-05-11T20:17:37.349Z,1462997857.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:37.394Z,1462997857.394 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-11T20:17:37.512Z,1462997857.512 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-11T20:17:37.957Z,1462997857.957 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:38.344Z,1462997858.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:38.744Z,1462997858.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:39.144Z,1462997859.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:39.544Z,1462997859.544 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:39.944Z,1462997859.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:40.344Z,1462997860.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:40.744Z,1462997860.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:41.144Z,1462997861.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:41.577Z,1462997861.577 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:41.945Z,1462997861.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:42.344Z,1462997862.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:42.744Z,1462997862.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:43.145Z,1462997863.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:43.552Z,1462997863.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:43.944Z,1462997863.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:44.357Z,1462997864.357 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:44.761Z,1462997864.761 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:45.145Z,1462997865.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:45.561Z,1462997865.561 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:45.944Z,1462997865.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:46.376Z,1462997866.376 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:46.769Z,1462997866.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:47.145Z,1462997867.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:47.580Z,1462997867.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:47.945Z,1462997867.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:48.372Z,1462997868.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:48.772Z,1462997868.772 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:49.145Z,1462997869.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:49.544Z,1462997869.544 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:49.944Z,1462997869.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:50.345Z,1462997870.345 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:50.744Z,1462997870.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:51.148Z,1462997871.148 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:51.545Z,1462997871.545 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:51.945Z,1462997871.945 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:52.344Z,1462997872.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:52.765Z,1462997872.765 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:52.824Z,1462997872.824 [SBIT](IMPORTANT): Beginning Startup BIT
2016-05-11T20:17:52.836Z,1462997872.836 [CBIT](IMPORTANT): Beginning GF scan
2016-05-11T20:17:53.144Z,1462997873.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:53.324Z,1462997873.324 [CBIT](IMPORTANT): Open Volts:2.499998
Open Current:0.000879
2016-05-11T20:17:53.544Z,1462997873.544 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:53.944Z,1462997873.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:54.344Z,1462997874.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:54.680Z,1462997874.680 [CBIT](IMPORTANT): A0 Volts:2.666960
A0 Current:0.106631
2016-05-11T20:17:54.756Z,1462997874.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:55.272Z,1462997875.272 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:55.629Z,1462997875.629 [NAL9602](ERROR): NAL9602 initialization error.
2016-05-11T20:17:55.629Z,1462997875.629 [NAL9602] Communications Fault, FailCount= 1
2016-05-11T20:17:55.629Z,1462997875.629 [NAL9602](ERROR): Communications Fault
2016-05-11T20:17:55.641Z,1462997875.641 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:55.752Z,1462997875.752 [CBIT](ERROR): Communications Fault in component: NAL9602
2016-05-11T20:17:55.952Z,1462997875.952 [CBIT](IMPORTANT): A1 Volts:1.988533
A1 Current:-0.325961
2016-05-11T20:17:56.040Z,1462997876.040 [NAL9602](INFO): Powering down
2016-05-11T20:17:56.064Z,1462997876.064 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:56.444Z,1462997876.444 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:56.888Z,1462997876.888 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:56.992Z,1462997876.992 [CBIT](INFO): Clearing failed state for component NAL9602
2016-05-11T20:17:56.992Z,1462997876.992 [NAL9602] No Fault, FailCount= 1
2016-05-11T20:17:57.195Z,1462997877.195 [CBIT](IMPORTANT): A2 Volts:2.668219
A2 Current:0.107628
2016-05-11T20:17:57.292Z,1462997877.292 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:57.649Z,1462997877.649 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:58.040Z,1462997878.040 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:58.440Z,1462997878.440 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:58.768Z,1462997878.768 [CBIT](IMPORTANT): A3 Volts:2.619143
A3 Current:0.075858
2016-05-11T20:17:58.851Z,1462997878.851 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:59.248Z,1462997879.248 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:17:59.640Z,1462997879.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:00.044Z,1462997880.044 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:00.340Z,1462997880.340 [CommandLine](IMPORTANT): got command get depth
2016-05-11T20:18:00.340Z,1462997880.341 [CommandLine](IMPORTANT): depth -0.239126 m
2016-05-11T20:18:00.419Z,1462997880.419 [CBIT](IMPORTANT): B0 Volts:2.389288
B0 Current:-0.070176
2016-05-11T20:18:00.480Z,1462997880.480 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:00.864Z,1462997880.864 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:01.237Z,1462997881.237 [NAL9602](INFO): Powering up NAL9602
2016-05-11T20:18:01.308Z,1462997881.308 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:01.671Z,1462997881.671 [CBIT](IMPORTANT): B1 Volts:2.283449
B1 Current:-0.137203
2016-05-11T20:18:01.724Z,1462997881.724 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:02.096Z,1462997882.096 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:02.524Z,1462997882.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:02.905Z,1462997882.905 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:03.240Z,1462997883.240 [CBIT](IMPORTANT): B2 Volts:2.281270
B2 Current:-0.139449
2016-05-11T20:18:03.352Z,1462997883.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:03.718Z,1462997883.718 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:04.129Z,1462997884.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:04.451Z,1462997884.451 [CBIT](IMPORTANT): B3 Volts:1.771793
B3 Current:-0.462526
2016-05-11T20:18:04.516Z,1462997884.516 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:04.686Z,1462997884.686 [CBIT](FAULT): Low side GF detected
mA:
CHAN A0 (Batt): 0.106631
CHAN A1 (24V): -0.325961
CHAN A2 (12V): 0.107628
CHAN A3 (5V): 0.075858
CHAN B0 (3.3V): -0.070176
CHAN B1 (3.15aV): -0.137203
CHAN B2 (3.15bV): -0.139449
CHAN B3 (GND): -0.462526
OPEN: 0.000879
Full Scale Calc: 4.765 mA, -1.589 mA
2016-05-11T20:18:04.908Z,1462997884.908 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:05.306Z,1462997885.306 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:05.704Z,1462997885.704 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:05.870Z,1462997885.870 [SBIT](FAULT): Mass: EXPECTED:0.012000 ACTUAL:0.008317
2016-05-11T20:18:06.108Z,1462997886.108 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:06.504Z,1462997886.504 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:06.904Z,1462997886.904 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:07.304Z,1462997887.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:07.704Z,1462997887.704 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:08.104Z,1462997888.104 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:08.504Z,1462997888.504 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:08.904Z,1462997888.904 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:09.304Z,1462997889.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:09.706Z,1462997889.706 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:10.107Z,1462997890.107 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:10.524Z,1462997890.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:10.904Z,1462997890.904 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:11.307Z,1462997891.307 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:11.736Z,1462997891.736 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:11.798Z,1462997891.798 [CommandLine](IMPORTANT): got command quit
2016-05-11T20:18:12.107Z,1462997892.107 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:12.507Z,1462997892.507 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:12.806Z,1462997892.806 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T20:18:12.807Z,1462997892.807 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:12.904Z,1462997892.904 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:12.932Z,1462997892.932 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2016-05-11T20:18:12.932Z,1462997892.932 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:12.934Z,1462997892.934 [CommandLine](INFO): Join timeout helper Thread ID is 1036
2016-05-11T20:18:12.943Z,1462997892.943 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2016-05-11T20:18:12.943Z,1462997892.944 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:12.944Z,1462997892.944 [NavChartDb](INFO): Join timeout helper Thread ID is 1037
2016-05-11T20:18:13.307Z,1462997893.307 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:13.749Z,1462997893.750 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:14.096Z,1462997894.096 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:14.496Z,1462997894.496 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:14.831Z,1462997894.831 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T20:18:14.831Z,1462997894.832 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:14.851Z,1462997894.851 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2016-05-11T20:18:14.851Z,1462997894.851 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:14.852Z,1462997894.852 [Radio_Surface](INFO): Join timeout helper Thread ID is 1046
2016-05-11T20:18:14.900Z,1462997894.900 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2016-05-11T20:18:15.251Z,1462997895.251 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T20:18:15.252Z,1462997895.252 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:15.255Z,1462997895.255 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2016-05-11T20:18:15.255Z,1462997895.255 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:15.256Z,1462997895.256 [logger](INFO): Join timeout helper Thread ID is 1049
2016-05-11T20:18:15.256Z,1462997895.256 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T20:18:15.257Z,1462997895.257 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:15.257Z,1462997895.257 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2016-05-11T20:18:15.257Z,1462997895.257 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:15.257Z,1462997895.257 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2016-05-11T20:18:15.257Z,1462997895.257 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:15.258Z,1462997895.258 [controlThread](INFO): Join timeout helper Thread ID is 1050
2016-05-11T20:18:15.275Z,1462997895.275 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-11T20:18:15.276Z,1462997895.276 [controlThread](DEBUG): Uninitializing ControlThread
2016-05-11T20:18:15.277Z,1462997895.277 [NAL9602](INFO): Powering down
2016-05-11T20:18:15.279Z,1462997895.279 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-11T20:18:15.280Z,1462997895.280 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2016-05-11T20:18:15.284Z,1462997895.284 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2016-05-11T20:18:15.284Z,1462997895.284 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2016-05-11T20:18:15.284Z,1462997895.284 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2016-05-11T20:18:15.284Z,1462997895.284 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2016-05-11T20:18:15.285Z,1462997895.285 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-11T20:18:15.285Z,1462997895.285 [BuoyancyServo](INFO): Powering down
2016-05-11T20:18:15.299Z,1462997895.299 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2016-05-11T20:18:15.299Z,1462997895.299 [ElevatorServo](INFO): Powering down
2016-05-11T20:18:15.300Z,1462997895.300 [MassServo](DEBUG): Uninitialize Mass Servo.
2016-05-11T20:18:15.300Z,1462997895.300 [MassServo](INFO): Powering down
2016-05-11T20:18:15.301Z,1462997895.301 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2016-05-11T20:18:15.301Z,1462997895.301 [RudderServo](INFO): Powering down
2016-05-11T20:18:15.302Z,1462997895.302 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2016-05-11T20:18:15.302Z,1462997895.302 [ThrusterServo](INFO): Powering down
2016-05-11T20:18:15.303Z,1462997895.303 [SBIT](DEBUG): Uninitialize SBIT Component.
2016-05-11T20:18:15.303Z,1462997895.303 [IBIT](DEBUG): Uninitialize IBIT Component.
2016-05-11T20:18:15.304Z,1462997895.304 [CBIT](DEBUG): Uninitialize CBIT Component.
2016-05-11T20:18:15.304Z,1462997895.304 [CBIT](CRITICAL): Backplane failed to power down
2016-05-11T20:18:15.305Z,1462997895.305 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:15.479Z,1462997895.479 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:15.651Z,1462997895.651 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-11T20:18:15.702Z,1462997895.702 [logger ThreadHandler](INFO): Thread cancelled.