2014-08-21T04:49:50.442Z,1408596590.442 [Supervisor](DEBUG): Initializing supervisor.
2014-08-21T04:49:50.445Z,1408596590.445 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2014-08-21T04:49:50.445Z,1408596590.445 [SyncHandler](INFO): Protected caller Thread ID is 2016
2014-08-21T04:49:50.446Z,1408596590.446 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2014-08-21T04:49:50.447Z,1408596590.447 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2014-08-21T04:49:50.447Z,1408596590.447 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2017
2014-08-21T04:49:50.451Z,1408596590.451 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2014-08-21T04:49:50.463Z,1408596590.463 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2014-08-21T04:49:50.465Z,1408596590.465 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2014-08-21T04:49:50.465Z,1408596590.465 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2018
2014-08-21T04:49:50.466Z,1408596590.466 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2014-08-21T04:49:50.467Z,1408596590.467 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2014-08-21T04:49:50.467Z,1408596590.467 [logger ThreadHandler](INFO): Protected caller Thread ID is 2019
2014-08-21T04:49:50.474Z,1408596590.474 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2014-08-21T04:49:50.474Z,1408596590.474 [Supervisor](INFO): Looking for Config files in directory: Config/
2014-08-21T04:49:50.476Z,1408596590.476 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2014-08-21T04:49:50.817Z,1408596590.817 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2014-08-21T04:49:50.818Z,1408596590.818 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2014-08-21T04:49:50.988Z,1408596590.988 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2014-08-21T04:49:50.988Z,1408596590.988 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2014-08-21T04:49:51.147Z,1408596591.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2014-08-21T04:49:51.148Z,1408596591.148 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2014-08-21T04:49:51.275Z,1408596591.275 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2014-08-21T04:49:51.276Z,1408596591.276 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2014-08-21T04:49:51.364Z,1408596591.364 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2014-08-21T04:49:51.513Z,1408596591.513 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2014-08-21T04:49:51.513Z,1408596591.513 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2014-08-21T04:49:51.602Z,1408596591.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2014-08-21T04:49:51.602Z,1408596591.602 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2014-08-21T04:49:51.788Z,1408596591.788 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2014-08-21T04:49:51.788Z,1408596591.788 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2014-08-21T04:49:52.094Z,1408596592.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2014-08-21T04:49:52.095Z,1408596592.095 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2014-08-21T04:49:52.405Z,1408596592.405 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2014-08-21T04:49:52.406Z,1408596592.406 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2014-08-21T04:49:52.940Z,1408596592.940 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2014-08-21T04:49:52.941Z,1408596592.941 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2014-08-21T04:49:53.148Z,1408596593.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2014-08-21T04:49:53.148Z,1408596593.148 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2014-08-21T04:49:53.256Z,1408596593.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2014-08-21T04:49:53.257Z,1408596593.257 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2014-08-21T04:49:53.665Z,1408596593.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2014-08-21T04:49:53.666Z,1408596593.666 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2014-08-21T04:49:53.779Z,1408596593.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2014-08-21T04:49:53.781Z,1408596593.781 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2014-08-21T04:49:53.782Z,1408596593.782 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2014-08-21T04:49:53.891Z,1408596593.891 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2014-08-21T04:49:54.012Z,1408596594.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2014-08-21T04:49:54.114Z,1408596594.114 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Estimation.cfg
2014-08-21T04:49:54.227Z,1408596594.227 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2014-08-21T04:49:54.327Z,1408596594.327 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2014-08-21T04:49:54.459Z,1408596594.459 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2014-08-21T04:49:54.612Z,1408596594.612 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2014-08-21T04:49:54.716Z,1408596594.716 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2014-08-21T04:49:54.805Z,1408596594.805 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2014-08-21T04:49:54.889Z,1408596594.889 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2014-08-21T04:49:54.989Z,1408596594.989 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2014-08-21T04:49:55.104Z,1408596595.104 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2014-08-21T04:49:55.105Z,1408596595.105 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2014-08-21T04:49:55.109Z,1408596595.109 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2014-08-21T04:49:55.160Z,1408596595.160 [VerticalControl](DEBUG): Construct VerticalControl.
2014-08-21T04:49:55.279Z,1408596595.279 [VerticalControl] Loaded
2014-08-21T04:49:55.279Z,1408596595.279 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2014-08-21T04:49:55.280Z,1408596595.280 [HorizontalControl](DEBUG): Construct HorizontalControl.
2014-08-21T04:49:55.352Z,1408596595.352 [HorizontalControl] Loaded
2014-08-21T04:49:55.352Z,1408596595.352 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2014-08-21T04:49:55.352Z,1408596595.352 [SpeedControl](DEBUG): Construct SpeedControl.
2014-08-21T04:49:55.358Z,1408596595.358 [SpeedControl] Loaded
2014-08-21T04:49:55.358Z,1408596595.358 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2014-08-21T04:49:55.359Z,1408596595.359 [LoopControl](DEBUG): Construct LoopControl.
2014-08-21T04:49:55.360Z,1408596595.360 [LoopControl] Loaded
2014-08-21T04:49:55.360Z,1408596595.360 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2014-08-21T04:49:55.360Z,1408596595.360 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2014-08-21T04:49:55.361Z,1408596595.361 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2014-08-21T04:49:55.461Z,1408596595.461 [SBIT](DEBUG): Construct Startup Built In Test.
2014-08-21T04:49:55.472Z,1408596595.472 [SBIT] Loaded
2014-08-21T04:49:55.473Z,1408596595.473 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2014-08-21T04:49:55.473Z,1408596595.473 [IBIT](DEBUG): Construct Initiated Built In Test.
2014-08-21T04:49:55.503Z,1408596595.503 [IBIT] Loaded
2014-08-21T04:49:55.503Z,1408596595.503 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2014-08-21T04:49:55.505Z,1408596595.505 [CBIT](DEBUG): Construct CBIT Built In Test.
2014-08-21T04:49:55.623Z,1408596595.623 [CBIT] Loaded
2014-08-21T04:49:55.623Z,1408596595.623 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2014-08-21T04:49:55.624Z,1408596595.624 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2014-08-21T04:49:55.624Z,1408596595.624 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2014-08-21T04:49:55.643Z,1408596595.643 [DepthRateCalculator] Loaded
2014-08-21T04:49:55.643Z,1408596595.643 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2014-08-21T04:49:55.649Z,1408596595.649 [PitchRateCalculator] Loaded
2014-08-21T04:49:55.649Z,1408596595.649 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2014-08-21T04:49:55.660Z,1408596595.660 [SpeedCalculator] Loaded
2014-08-21T04:49:55.661Z,1408596595.661 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2014-08-21T04:49:55.677Z,1408596595.677 [TempGradientCalculator] Loaded
2014-08-21T04:49:55.677Z,1408596595.677 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2014-08-21T04:49:55.683Z,1408596595.683 [YawRateCalculator] Loaded
2014-08-21T04:49:55.683Z,1408596595.683 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2014-08-21T04:49:55.683Z,1408596595.683 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2014-08-21T04:49:55.684Z,1408596595.684 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2014-08-21T04:50:00.124Z,1408596600.124 [HFRadarCompactModelForecaster] Loaded
2014-08-21T04:50:00.125Z,1408596600.125 [ComponentRegistry](DEBUG): SyncComponent "HFRadarCompactModelForecaster" handled in the control thread.
2014-08-21T04:50:01.264Z,1408596601.264 [HFRCMSpaceInterpolator] Loaded
2014-08-21T04:50:01.264Z,1408596601.264 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSpaceInterpolator" handled in the control thread.
2014-08-21T04:50:01.266Z,1408596601.266 [HFRCMTimeInterpolator] Loaded
2014-08-21T04:50:01.266Z,1408596601.266 [ComponentRegistry](DEBUG): SyncComponent "HFRCMTimeInterpolator" handled in the control thread.
2014-08-21T04:50:02.343Z,1408596602.343 [HFRCMReconstructedInterpolator] Loaded
2014-08-21T04:50:02.343Z,1408596602.343 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread.
2014-08-21T04:50:02.355Z,1408596602.355 [HFRCMSurfaceCurrentAtVehicleLocation] Loaded
2014-08-21T04:50:02.356Z,1408596602.356 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSurfaceCurrentAtVehicleLocation" handled in the control thread.
2014-08-21T04:50:02.356Z,1408596602.356 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2014-08-21T04:50:02.357Z,1408596602.357 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2014-08-21T04:50:02.586Z,1408596602.586 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2014-08-21T04:50:02.586Z,1408596602.586 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2014-08-21T04:50:02.667Z,1408596602.667 [DeadReckonUsingMultipleVelocitySourcesVector] Loaded
2014-08-21T04:50:02.667Z,1408596602.667 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySourcesVector" handled in the control thread.
2014-08-21T04:50:02.722Z,1408596602.722 [DeadReckonUsingMultipleVelocitySources] Loaded
2014-08-21T04:50:02.723Z,1408596602.723 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2014-08-21T04:50:02.767Z,1408596602.767 [DeadReckonWithRespectToWater] Loaded
2014-08-21T04:50:02.768Z,1408596602.768 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2014-08-21T04:50:02.814Z,1408596602.814 [DeadReckonWithRespectToSeafloor] Loaded
2014-08-21T04:50:02.814Z,1408596602.814 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2014-08-21T04:50:02.873Z,1408596602.873 [DeadReckonUsingDVLWaterTrack] Loaded
2014-08-21T04:50:02.874Z,1408596602.874 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread.
2014-08-21T04:50:02.920Z,1408596602.920 [DeadReckonUsingCompactModelForecast] Loaded
2014-08-21T04:50:02.921Z,1408596602.921 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingCompactModelForecast" handled in the control thread.
2014-08-21T04:50:02.941Z,1408596602.941 [NavChart] Loaded
2014-08-21T04:50:02.941Z,1408596602.941 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2014-08-21T04:50:02.949Z,1408596602.949 [UniversalFixResidualReporter] Loaded
2014-08-21T04:50:02.949Z,1408596602.949 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2014-08-21T04:50:02.950Z,1408596602.950 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2014-08-21T04:50:02.951Z,1408596602.951 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2014-08-21T04:50:02.960Z,1408596602.960 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2014-08-21T04:50:02.961Z,1408596602.961 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2014-08-21T04:50:03.157Z,1408596603.157 [CTD_NeilBrown] Loaded
2014-08-21T04:50:03.158Z,1408596603.158 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2014-08-21T04:50:03.159Z,1408596603.159 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406C64E0
2014-08-21T04:50:03.159Z,1408596603.159 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 2101
2014-08-21T04:50:03.175Z,1408596603.175 [PAR_Licor] Loaded
2014-08-21T04:50:03.175Z,1408596603.175 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2014-08-21T04:50:03.211Z,1408596603.211 [WetLabsBB2FL] Loaded
2014-08-21T04:50:03.211Z,1408596603.211 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2014-08-21T04:50:03.212Z,1408596603.212 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406F64E0
2014-08-21T04:50:03.212Z,1408596603.212 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2102
2014-08-21T04:50:03.213Z,1408596603.213 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2014-08-21T04:50:03.213Z,1408596603.213 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2014-08-21T04:50:03.504Z,1408596603.504 [AHRS_sp3003D] Loaded
2014-08-21T04:50:03.504Z,1408596603.504 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2014-08-21T04:50:03.764Z,1408596603.764 [Batt_Ocean_Server] Loaded
2014-08-21T04:50:03.764Z,1408596603.764 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread.
2014-08-21T04:50:03.849Z,1408596603.849 [DataOverHttps] Loaded
2014-08-21T04:50:03.850Z,1408596603.850 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2014-08-21T04:50:03.863Z,1408596603.863 [Depth_Keller] Loaded
2014-08-21T04:50:03.863Z,1408596603.863 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2014-08-21T04:50:03.997Z,1408596603.997 [DVL_micro] Loaded
2014-08-21T04:50:03.997Z,1408596603.997 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2014-08-21T04:50:04.090Z,1408596604.090 [NAL9602] Loaded
2014-08-21T04:50:04.091Z,1408596604.091 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2014-08-21T04:50:04.133Z,1408596604.133 [Onboard] Loaded
2014-08-21T04:50:04.133Z,1408596604.133 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2014-08-21T04:50:04.140Z,1408596604.140 [Radio_Freewave] Loaded
2014-08-21T04:50:04.141Z,1408596604.141 [ComponentRegistry](DEBUG): Component "Radio_Freewave" handled in its own thread.
2014-08-21T04:50:04.142Z,1408596604.142 [Radio_Freewave ThreadHandler](DEBUG): Created PCaller Thread at 409314E0
2014-08-21T04:50:04.142Z,1408596604.142 [Radio_Freewave ThreadHandler](INFO): Protected caller Thread ID is 2103
2014-08-21T04:50:04.268Z,1408596604.268 [DAT] Loaded
2014-08-21T04:50:04.268Z,1408596604.268 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2014-08-21T04:50:04.275Z,1408596604.275 [SCPI] Loaded
2014-08-21T04:50:04.275Z,1408596604.275 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2014-08-21T04:50:04.276Z,1408596604.276 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2014-08-21T04:50:04.276Z,1408596604.276 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2014-08-21T04:50:04.376Z,1408596604.376 [BuoyancyServo] Loaded
2014-08-21T04:50:04.376Z,1408596604.376 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2014-08-21T04:50:04.389Z,1408596604.389 [ElevatorServo] Loaded
2014-08-21T04:50:04.389Z,1408596604.389 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2014-08-21T04:50:04.400Z,1408596604.400 [MassServo] Loaded
2014-08-21T04:50:04.401Z,1408596604.401 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2014-08-21T04:50:04.413Z,1408596604.413 [RudderServo] Loaded
2014-08-21T04:50:04.413Z,1408596604.413 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2014-08-21T04:50:04.424Z,1408596604.424 [ThrusterServo] Loaded
2014-08-21T04:50:04.425Z,1408596604.425 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2014-08-21T04:50:04.425Z,1408596604.425 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2014-08-21T04:50:04.426Z,1408596604.426 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2014-08-21T04:50:04.586Z,1408596604.586 [InternalSim] Loaded
2014-08-21T04:50:04.586Z,1408596604.586 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2014-08-21T04:50:04.586Z,1408596604.586 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2014-08-21T04:50:04.587Z,1408596604.587 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2014-08-21T04:50:04.611Z,1408596604.611 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2014-08-21T04:50:04.613Z,1408596604.613 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2014-08-21T04:50:04.614Z,1408596604.614 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2014-08-21T04:50:04.621Z,1408596604.621 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2014-08-21T04:50:04.622Z,1408596604.622 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409E24E0
2014-08-21T04:50:04.623Z,1408596604.623 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2104
2014-08-21T04:50:04.628Z,1408596604.628 [Supervisor](INFO): Main Thread ID is 768
2014-08-21T04:50:04.628Z,1408596604.628 [Supervisor](DEBUG): Running supervisor.
2014-08-21T04:50:04.629Z,1408596604.629 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2105
2014-08-21T04:50:04.633Z,1408596604.633 [controlThread ThreadHandler](INFO): Handler Thread ID is 2106
2014-08-21T04:50:04.634Z,1408596604.634 [controlThread](DEBUG): Initializing ControlThread
2014-08-21T04:50:04.634Z,1408596604.634 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2014-08-21T04:50:04.636Z,1408596604.636 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2014-08-21T04:50:04.637Z,1408596604.637 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2014-08-21T04:50:04.637Z,1408596604.637 [LoopControl](DEBUG): Initialize LoopControlComponent.
2014-08-21T04:50:04.638Z,1408596604.638 [SBIT](INFO): Initialize SBIT Component.
2014-08-21T04:50:04.638Z,1408596604.638 [SBIT](IMPORTANT): Tethys CM Info: SVN revision: 11562
2014-08-21T04:50:04.639Z,1408596604.639 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2014-08-21T04:50:04.639Z,1408596604.639 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2014-08-21T04:50:04.640Z,1408596604.640 [IBIT](INFO): Initialize IBIT Component.
2014-08-21T04:50:04.640Z,1408596604.640 [CBIT](DEBUG): Initialize CBIT Component.
2014-08-21T04:50:04.641Z,1408596604.641 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2014-08-21T04:50:04.642Z,1408596604.642 [logger ThreadHandler](INFO): Handler Thread ID is 2107
2014-08-21T04:50:04.662Z,1408596604.662 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 2108
2014-08-21T04:50:04.663Z,1408596604.663 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2014-08-21T04:50:04.666Z,1408596604.666 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-08-21T04:50:04.666Z,1408596604.666 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2014-08-21T04:50:04.667Z,1408596604.667 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2014-08-21T04:50:04.667Z,1408596604.667 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2014-08-21T04:50:04.667Z,1408596604.667 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2014-08-21T04:50:04.675Z,1408596604.675 [HFRadarCompactModelForecaster](DEBUG): Found new ECs!
2014-08-21T04:50:04.686Z,1408596604.686 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2014-08-21T04:50:04.695Z,1408596604.695 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2110
2014-08-21T04:50:04.696Z,1408596604.696 [WetLabsBB2FL](INFO): Powering down
2014-08-21T04:50:04.726Z,1408596604.726 [Radio_Freewave ThreadHandler](INFO): Handler Thread ID is 2111
2014-08-21T04:50:04.767Z,1408596604.767 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2113
2014-08-21T04:50:04.770Z,1408596604.770 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2014-08-21T04:50:04.771Z,1408596604.771 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2014-08-21T04:50:04.771Z,1408596604.771 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2014-08-21T04:50:04.771Z,1408596604.771 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2014-08-21T04:50:04.772Z,1408596604.772 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2014-08-21T04:50:04.772Z,1408596604.772 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2014-08-21T04:50:04.772Z,1408596604.772 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2014-08-21T04:50:04.773Z,1408596604.773 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2014-08-21T04:50:04.773Z,1408596604.773 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2014-08-21T04:50:05.052Z,1408596605.052 [Radio_Freewave](INFO): Powering up
2014-08-21T04:50:05.857Z,1408596605.857 [Radio_Freewave](IMPORTANT): Starting PPPD with command:/sbin/pppd nocrtscts /dev/ttyS1 noauth 115200 10.1.1.2:10.1.1.1 persist maxfail 0
2014-08-21T04:50:14.257Z,1408596614.257 [HFRadarCompactModelForecaster](IMPORTANT): forecast time 201408210100 published
2014-08-21T04:50:14.261Z,1408596614.261 [HFRCMSpaceInterpolator](DEBUG): Initializing HFRCMSpaceInterpolator component with verbosity level 0.
2014-08-21T04:50:14.263Z,1408596614.263 [HFRCMTimeInterpolator](DEBUG): Initializing HFRCMTimeInterpolator component.
2014-08-21T04:50:14.264Z,1408596614.264 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s.
2014-08-21T04:50:14.281Z,1408596614.281 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): Initializing HFRCMSurfaceCurrentAtVehicleLocation component.
2014-08-21T04:50:14.281Z,1408596614.281 [DeadReckonUsingMultipleVelocitySourcesVector](DEBUG): Initializing DeadReckonUsingMultipleVelocitySourcesVector component.
2014-08-21T04:50:14.282Z,1408596614.282 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-08-21T04:50:14.282Z,1408596614.282 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2014-08-21T04:50:14.283Z,1408596614.283 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2014-08-21T04:50:14.283Z,1408596614.283 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component.
2014-08-21T04:50:14.283Z,1408596614.283 [DeadReckonUsingCompactModelForecast](DEBUG): Initializing DeadReckonUsingCompactModelForecast component.
2014-08-21T04:50:14.284Z,1408596614.284 [NavChart](DEBUG): Initialize NavChart Navigation.
2014-08-21T04:50:14.284Z,1408596614.284 [UniversalFixResidualReporter](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-08-21T04:50:15.752Z,1408596615.752 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2014-08-21T04:50:15.782Z,1408596615.782 [InternalSim](DEBUG):  InternalSim initializing...
2014-08-21T04:50:15.898Z,1408596615.898 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2014-08-21T04:50:15.922Z,1408596615.922 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-08-21T04:50:15.963Z,1408596615.963 [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://aosn.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://aosn.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>


2014-08-21T04:50:15.964Z,1408596615.964 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2014-08-21T04:50:16.053Z,1408596616.053 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h
2014-08-21T04:50:16.065Z,1408596616.065 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h
2014-08-21T04:50:16.069Z,1408596616.069 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-08-21T04:50:16.098Z,1408596616.098 [Default:CheckIn:A.SetSpeed](DEBUG): Construct.
2014-08-21T04:50:16.120Z,1408596616.120 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2014-08-21T04:50:16.145Z,1408596616.145 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct.
2014-08-21T04:50:16.167Z,1408596616.167 [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://aosn.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Control http://aosn.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://aosn.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://aosn.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://aosn.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

    <DefineArg Name="TimeMissionWasStarted"><Units:hour/><Value>0</Value></DefineArg>

    <DefineArg Name="ElapsedSinceMissionWasStarted"><Units:hour/><Value>0</Value></DefineArg>

    <Aggregate Id="StartClock">

        <Sequence/>

        <Assign><Arg Name="TimeMissionWasStarted"/><Universal:time/></Assign>

    </Aggregate>

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

    <Aggregate Id="CheckIn">

        <When>
            <Elapsed><Universal:platform_communications/></Elapsed>
            <Gt><Units:minute/><Value>5.0</Value></Gt>
            <And><Universal:platform_conversation/><Eq><True/></Eq></And>
            <Or><Elapsed><Universal:platform_communications/></Elapsed><Gt><Units:hour/><Value>1.0</Value></Gt></Or>
        </When>

<!-- TODO: Do we really want this When operating on platform_communications? or on something else like time_fix? -->

<!-- Run application at high speed -->

        <Guidance:SetSpeed>
            <Parallel/>
            <Setting><Guidance:SetSpeed.period/><Units:millisecond/><Value>400</Value></Setting>
        </Guidance:SetSpeed>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
<!-- NOTE: Original Default.xml didn't have a timeout on the GPS read, so theoretically could have hung indefinitely there... -->
            <Universal:latitude_fix/>
        </ReadDatum>

<!-- Do data comms -->

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

    </Aggregate>

    <Aggregate Id="UpdateAndReportMinutesSinceMissionStarted">

        <When>
            <Elapsed><Arg Name="ElapsedSinceMissionWasStarted"/></Elapsed>
            <Gt><Units:minute/><Value>5.0</Value></Gt>
        </When>

        <Assign><Arg Name="ElapsedSinceMissionWasStarted"/><Universal:time/><Sub><Arg Name="TimeMissionWasStarted"/></Sub></Assign>

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

    </Aggregate>

    <Aggregate Id="WaitAtTheSurface">

        <Sequence/>

        <Guidance:SetSpeed Id="RunApplicationAtLowSpeed">
            <Parallel/>
            <Setting><Guidance:SetSpeed.period/><Units:second/><Value>5</Value></Setting>
        </Guidance:SetSpeed>

    </Aggregate>

</Mission>


2014-08-21T04:50:16.182Z,1408596616.182 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,PAR_Licor,AHRS_sp3003D,Batt_Ocean_Server,DataOverHttps,Depth_Keller,DVL_micro,NAL9602,Onboard,DAT,SCPI,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRadarCompactModelForecaster,HFRCMSpaceInterpolator,HFRCMTimeInterpolator,HFRCMReconstructedInterpolator,HFRCMSurfaceCurrentAtVehicleLocation,DeadReckonUsingMultipleVelocitySourcesVector,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToWater,DeadReckonWithRespectToSeafloor,DeadReckonUsingDVLWaterTrack,DeadReckonUsingCompactModelForecast,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2014-08-21T04:50:16.262Z,1408596616.262 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2014-08-21T04:50:16.321Z,1408596616.321 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2014-08-21T04:50:16.363Z,1408596616.363 [DVL_micro](INFO): Initializing
2014-08-21T04:50:16.382Z,1408596616.382 [NAL9602](INFO): Powering up NAL9602
2014-08-21T04:50:16.459Z,1408596616.459 [DAT](INFO): Powering up
2014-08-21T04:50:16.459Z,1408596616.459 [DAT](DEBUG): Initializing DAT.
2014-08-21T04:50:23.720Z,1408596623.720 [DeadReckonUsingMultipleVelocitySourcesVector](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:23.727Z,1408596623.727 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:23.772Z,1408596623.772 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:23.779Z,1408596623.779 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:23.802Z,1408596623.802 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:23.828Z,1408596623.828 [DeadReckonUsingCompactModelForecast](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:23.940Z,1408596623.940 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-08-21T04:50:23.948Z,1408596623.948 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-08-21T04:50:23.972Z,1408596623.972 [ElevatorServo](DEBUG): Initializing EZServoServo.
2014-08-21T04:50:23.980Z,1408596623.980 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2014-08-21T04:50:23.999Z,1408596623.999 [MassServo](DEBUG): Initializing EZServoServo.
2014-08-21T04:50:24.004Z,1408596624.004 [MassServo](DEBUG): Initializing MassServo.
2014-08-21T04:50:24.010Z,1408596624.010 [RudderServo](DEBUG): Initializing EZServoServo.
2014-08-21T04:50:24.016Z,1408596624.016 [RudderServo](DEBUG): Initializing RudderServo.
2014-08-21T04:50:24.021Z,1408596624.021 [ThrusterServo](DEBUG): Initializing EZServoServo.
2014-08-21T04:50:24.028Z,1408596624.028 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2014-08-21T04:50:24.780Z,1408596624.780 [DeadReckonUsingMultipleVelocitySourcesVector](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:24.785Z,1408596624.785 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:24.787Z,1408596624.787 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:24.787Z,1408596624.787 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:24.788Z,1408596624.788 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:24.793Z,1408596624.793 [DeadReckonUsingCompactModelForecast](DEBUG): Could not determine rotation from vehicle frame to navigation frame.
2014-08-21T04:50:25.094Z,1408596625.094 [SBIT](IMPORTANT): Beginning Startup BIT
2014-08-21T04:50:25.097Z,1408596625.097 [CBIT](IMPORTANT): Beginning GF scan
2014-08-21T04:50:27.334Z,1408596627.334 [NAL9602](INFO): NAL9602 initialized
2014-08-21T04:50:28.382Z,1408596628.382 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003606
2014-08-21T04:50:29.137Z,1408596629.137 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:29.983Z,1408596629.983 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:30.598Z,1408596630.598 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:31.269Z,1408596631.269 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:31.798Z,1408596631.798 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:31.857Z,1408596631.857 [DAT](INFO): entering command mode
2014-08-21T04:50:32.487Z,1408596632.487 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:33.089Z,1408596633.089 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:33.109Z,1408596633.109 [DAT](INFO): entering command mode
2014-08-21T04:50:33.660Z,1408596633.660 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:33.694Z,1408596633.694 [DAT](INFO): entering command mode
2014-08-21T04:50:34.214Z,1408596634.214 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:34.276Z,1408596634.276 [DAT](INFO): entering command mode
2014-08-21T04:50:34.910Z,1408596634.910 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:34.924Z,1408596634.924 [DAT](INFO): entering command mode
2014-08-21T04:50:35.439Z,1408596635.439 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:35.470Z,1408596635.470 [DAT](FAULT): failed to initialize; deviceResponse_:user:1> 00800 bits/sec
2014-08-21T04:50:35.470Z,1408596635.470 [DAT] Communications Fault, FailCount= 1
2014-08-21T04:50:35.470Z,1408596635.470 [DAT](ERROR): Communications Fault
2014-08-21T04:50:35.582Z,1408596635.582 [CBIT](ERROR): Communications Fault in component: DAT
2014-08-21T04:50:35.972Z,1408596635.972 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:35.997Z,1408596635.997 [DAT](INFO): Powering down
2014-08-21T04:50:36.805Z,1408596636.805 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:37.346Z,1408596637.346 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:37.485Z,1408596637.485 [CBIT](INFO): Clearing failed state for component DAT
2014-08-21T04:50:37.485Z,1408596637.485 [DAT] No Fault, FailCount= 1
2014-08-21T04:50:37.835Z,1408596637.835 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:38.365Z,1408596638.365 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:38.824Z,1408596638.824 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:39.366Z,1408596639.366 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:39.394Z,1408596639.394 [DAT](INFO): Powering up
2014-08-21T04:50:39.394Z,1408596639.394 [DAT](DEBUG): Initializing DAT.
2014-08-21T04:50:39.870Z,1408596639.870 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:40.371Z,1408596640.371 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:40.819Z,1408596640.819 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:41.545Z,1408596641.545 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:42.478Z,1408596642.478 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:43.021Z,1408596643.021 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:43.528Z,1408596643.528 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:44.070Z,1408596644.070 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:44.570Z,1408596644.570 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:45.135Z,1408596645.135 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:45.723Z,1408596645.723 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:46.240Z,1408596646.240 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:46.965Z,1408596646.965 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:47.694Z,1408596647.694 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:48.163Z,1408596648.163 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:48.656Z,1408596648.656 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:49.193Z,1408596649.193 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:49.690Z,1408596649.690 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:50.210Z,1408596650.210 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:50.671Z,1408596650.671 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:51.141Z,1408596651.141 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:51.600Z,1408596651.600 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:52.198Z,1408596652.198 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:52.389Z,1408596652.389 [CBIT](IMPORTANT): No ground fault detected
2014-08-21T04:50:52.770Z,1408596652.770 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:53.252Z,1408596653.252 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:53.784Z,1408596653.784 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:53.793Z,1408596653.793 [DAT](INFO): entering command mode
2014-08-21T04:50:54.256Z,1408596654.256 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:54.709Z,1408596654.709 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:54.735Z,1408596654.735 [DAT](INFO): entering command mode
2014-08-21T04:50:55.250Z,1408596655.250 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:55.331Z,1408596655.331 [DAT](INFO): entering command mode
2014-08-21T04:50:55.791Z,1408596655.791 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:55.832Z,1408596655.832 [DAT](INFO): entering command mode
2014-08-21T04:50:56.287Z,1408596656.287 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:56.302Z,1408596656.302 [DAT](INFO): entering command mode
2014-08-21T04:50:56.716Z,1408596656.716 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:56.772Z,1408596656.772 [DAT](INFO): entering command mode
2014-08-21T04:50:57.316Z,1408596657.316 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:57.344Z,1408596657.344 [DAT](INFO): entering command mode
2014-08-21T04:50:57.770Z,1408596657.770 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:57.799Z,1408596657.799 [DAT](INFO): entering command mode
2014-08-21T04:50:58.259Z,1408596658.259 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:58.288Z,1408596658.288 [DAT](INFO): entering command mode
2014-08-21T04:50:58.739Z,1408596658.739 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:58.752Z,1408596658.752 [DAT](FAULT): failed to initialize; deviceResponse_:user:1> 00800 bits/sec
2014-08-21T04:50:58.753Z,1408596658.753 [DAT] Communications Fault, FailCount= 2
2014-08-21T04:50:58.753Z,1408596658.753 [DAT](ERROR): Communications Fault
2014-08-21T04:50:58.871Z,1408596658.871 [CBIT](ERROR): Communications Fault in component: DAT
2014-08-21T04:50:59.232Z,1408596659.232 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:50:59.333Z,1408596659.333 [DAT](INFO): Powering down
2014-08-21T04:50:59.881Z,1408596659.881 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:00.390Z,1408596660.390 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:00.468Z,1408596660.468 [CBIT](INFO): Clearing failed state for component DAT
2014-08-21T04:51:00.468Z,1408596660.468 [DAT] No Fault, FailCount= 2
2014-08-21T04:51:00.847Z,1408596660.847 [Batt_Ocean_Server](ERROR): Battery controller B communication timeout. Re-initializing
2014-08-21T04:51:00.850Z,1408596660.850 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:01.320Z,1408596661.320 [Batt_Ocean_Server] Communications Fault, FailCount= 1
2014-08-21T04:51:01.320Z,1408596661.320 [Batt_Ocean_Server](ERROR): Communications Fault
2014-08-21T04:51:03.337Z,1408596663.337 [Batt_Ocean_Server](ERROR): Batt_Ocean_Server A initialization uart error: serial timeout
2014-08-21T04:51:03.337Z,1408596663.337 [Batt_Ocean_Server](ERROR): Ocean Server Batteries failed to initialize. Re-initializing
2014-08-21T04:51:03.343Z,1408596663.343 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:03.487Z,1408596663.487 [DAT](INFO): Powering up
2014-08-21T04:51:03.487Z,1408596663.487 [DAT](DEBUG): Initializing DAT.
2014-08-21T04:51:03.572Z,1408596663.572 [CBIT](ERROR): Communications Fault in component: Batt_Ocean_Server
2014-08-21T04:51:04.023Z,1408596664.023 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:04.113Z,1408596664.113 [CBIT](INFO): Clearing failed state for component Batt_Ocean_Server
2014-08-21T04:51:04.113Z,1408596664.113 [Batt_Ocean_Server] No Fault, FailCount= 1
2014-08-21T04:51:06.433Z,1408596666.433 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2014-08-21T04:51:06.460Z,1408596666.460 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:06.895Z,1408596666.895 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:07.368Z,1408596667.368 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:07.374Z,1408596667.374 [NAL9602](IMPORTANT): GPS fix at: 1408596666.00
2014-08-21T04:51:07.854Z,1408596667.854 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:07.881Z,1408596667.881 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:07.884Z,1408596667.884 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:08.305Z,1408596668.305 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:08.319Z,1408596668.319 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:08.321Z,1408596668.321 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:08.754Z,1408596668.754 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:08.768Z,1408596668.768 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:08.770Z,1408596668.770 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:09.367Z,1408596669.367 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:09.405Z,1408596669.405 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:09.407Z,1408596669.407 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:10.241Z,1408596670.241 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:10.332Z,1408596670.332 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:10.334Z,1408596670.334 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:10.830Z,1408596670.830 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:10.871Z,1408596670.871 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:10.877Z,1408596670.877 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:11.447Z,1408596671.447 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:11.473Z,1408596671.473 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:11.479Z,1408596671.479 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:12.105Z,1408596672.105 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:12.150Z,1408596672.150 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:12.152Z,1408596672.152 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:12.777Z,1408596672.777 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:12.814Z,1408596672.814 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:12.820Z,1408596672.820 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:13.426Z,1408596673.426 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:13.557Z,1408596673.557 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:13.559Z,1408596673.559 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:13.983Z,1408596673.983 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:14.008Z,1408596674.008 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:14.011Z,1408596674.011 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:14.426Z,1408596674.426 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:14.440Z,1408596674.440 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:14.442Z,1408596674.442 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:14.892Z,1408596674.892 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:14.915Z,1408596674.915 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:14.917Z,1408596674.917 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:15.374Z,1408596675.374 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:15.375Z,1408596675.375 [NAL9602](INFO): Powering down
2014-08-21T04:51:15.390Z,1408596675.390 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:15.393Z,1408596675.393 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:15.834Z,1408596675.834 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:15.851Z,1408596675.851 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:15.853Z,1408596675.853 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:16.411Z,1408596676.411 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:16.467Z,1408596676.467 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:16.469Z,1408596676.469 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:17.107Z,1408596677.107 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:17.185Z,1408596677.185 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:17.208Z,1408596677.208 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:19.175Z,1408596679.175 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:19.200Z,1408596679.200 [DAT](INFO): entering command mode
2014-08-21T04:51:19.272Z,1408596679.272 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:19.274Z,1408596679.274 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:19.888Z,1408596679.888 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:19.925Z,1408596679.925 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:19.973Z,1408596679.973 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:20.569Z,1408596680.569 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:20.640Z,1408596680.640 [DAT](INFO): entering command mode
2014-08-21T04:51:20.664Z,1408596680.664 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:20.666Z,1408596680.666 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:20.769Z,1408596680.769 [SBIT](IMPORTANT): SBIT PASSED
2014-08-21T04:51:21.270Z,1408596681.270 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:21.285Z,1408596681.285 [DAT](INFO): entering command mode
2014-08-21T04:51:21.298Z,1408596681.298 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:21.305Z,1408596681.305 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:21.355Z,1408596681.355 [MissionManager](IMPORTANT): Started mission Startup
2014-08-21T04:51:21.356Z,1408596681.356 [Startup] Running Loop=1
2014-08-21T04:51:21.356Z,1408596681.356 [Startup](INFO): Aggregate::initialize Startup
2014-08-21T04:51:21.356Z,1408596681.356 [Startup:A.GoToSurface] Running Loop=1
2014-08-21T04:51:21.356Z,1408596681.356 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-08-21T04:51:21.361Z,1408596681.361 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2014-08-21T04:51:21.362Z,1408596681.362 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2014-08-21T04:51:21.362Z,1408596681.362 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s.
2014-08-21T04:51:21.424Z,1408596681.424 [Startup:StartupSatComms] Running Loop=1
2014-08-21T04:51:21.437Z,1408596681.437 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2014-08-21T04:51:21.437Z,1408596681.437 [Startup:StartupSatComms:A] Running Loop=1
2014-08-21T04:51:21.920Z,1408596681.920 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:22.004Z,1408596682.004 [DAT](INFO): entering command mode
2014-08-21T04:51:22.095Z,1408596682.095 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:22.097Z,1408596682.097 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:22.155Z,1408596682.155 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-08-21T04:51:22.756Z,1408596682.756 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:22.757Z,1408596682.757 [NAL9602](INFO): Powering up
2014-08-21T04:51:22.791Z,1408596682.791 [DAT](FAULT): failed to initialize; deviceResponse_:user:1> 00800 bits/sec
2014-08-21T04:51:22.791Z,1408596682.791 [DAT] Communications Fault, FailCount= 3
2014-08-21T04:51:22.791Z,1408596682.791 [DAT](ERROR): Communications Fault
2014-08-21T04:51:22.807Z,1408596682.807 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:22.809Z,1408596682.809 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:22.963Z,1408596682.963 [CBIT](ERROR): Communications Fault in component: DAT
2014-08-21T04:51:23.361Z,1408596683.361 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:23.398Z,1408596683.398 [DAT](INFO): Powering down
2014-08-21T04:51:23.551Z,1408596683.551 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:23.553Z,1408596683.553 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:24.511Z,1408596684.511 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:24.529Z,1408596684.529 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:24.586Z,1408596684.586 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:25.196Z,1408596685.196 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:25.260Z,1408596685.260 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:25.262Z,1408596685.262 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:25.431Z,1408596685.431 [CBIT](INFO): Clearing failed state for component DAT
2014-08-21T04:51:25.431Z,1408596685.431 [DAT] No Fault, FailCount= 3
2014-08-21T04:51:25.809Z,1408596685.809 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:25.958Z,1408596685.958 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:25.971Z,1408596685.971 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:26.667Z,1408596686.667 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:26.674Z,1408596686.674 [DAT](INFO): Powering up
2014-08-21T04:51:26.674Z,1408596686.674 [DAT](DEBUG): Initializing DAT.
2014-08-21T04:51:26.759Z,1408596686.759 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:26.774Z,1408596686.774 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:26.889Z,1408596686.889 [CommandLine](IMPORTANT): got command restart application
2014-08-21T04:51:27.409Z,1408596687.409 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:27.439Z,1408596687.439 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:27.441Z,1408596687.441 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:27.864Z,1408596687.864 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:27.894Z,1408596687.894 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-21T04:51:27.894Z,1408596687.894 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:27.902Z,1408596687.902 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:27.908Z,1408596687.908 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:28.031Z,1408596688.031 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2014-08-21T04:51:28.031Z,1408596688.031 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:28.032Z,1408596688.032 [CommandLine](INFO): Join timeout helper Thread ID is 2151
2014-08-21T04:51:28.047Z,1408596688.047 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2014-08-21T04:51:28.047Z,1408596688.047 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:28.048Z,1408596688.048 [NavChartDb](INFO): Join timeout helper Thread ID is 2152
2014-08-21T04:51:28.377Z,1408596688.377 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:28.449Z,1408596688.449 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:28.451Z,1408596688.451 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:28.895Z,1408596688.895 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-21T04:51:28.895Z,1408596688.895 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:28.912Z,1408596688.912 [ComponentRegistry](INFO): Shutting down Radio_Freewave ThreadHandler
2014-08-21T04:51:28.912Z,1408596688.912 [Radio_Freewave ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:28.913Z,1408596688.913 [Radio_Freewave](INFO): Join timeout helper Thread ID is 2153
2014-08-21T04:51:28.922Z,1408596688.922 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:28.955Z,1408596688.955 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:28.957Z,1408596688.957 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:29.097Z,1408596689.097 [Radio_Freewave ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-21T04:51:29.248Z,1408596689.248 [Radio_Freewave](INFO): Powering down
2014-08-21T04:51:29.499Z,1408596689.499 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:29.576Z,1408596689.576 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:29.578Z,1408596689.578 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:29.654Z,1408596689.654 [Radio_Freewave ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.658Z,1408596689.658 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2014-08-21T04:51:29.658Z,1408596689.658 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.658Z,1408596689.658 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2155
2014-08-21T04:51:29.726Z,1408596689.726 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-21T04:51:29.726Z,1408596689.726 [WetLabsBB2FL](INFO): Powering down
2014-08-21T04:51:29.727Z,1408596689.727 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.746Z,1408596689.746 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2014-08-21T04:51:29.746Z,1408596689.746 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.746Z,1408596689.746 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 2156
2014-08-21T04:51:29.790Z,1408596689.790 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-21T04:51:29.790Z,1408596689.790 [CTD_NeilBrown](INFO): Powering down
2014-08-21T04:51:29.791Z,1408596689.791 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.809Z,1408596689.809 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2014-08-21T04:51:29.809Z,1408596689.809 [logger ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.809Z,1408596689.809 [logger](INFO): Join timeout helper Thread ID is 2157
2014-08-21T04:51:29.810Z,1408596689.810 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-21T04:51:29.810Z,1408596689.810 [logger ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.811Z,1408596689.811 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2014-08-21T04:51:29.811Z,1408596689.811 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.812Z,1408596689.812 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2014-08-21T04:51:29.812Z,1408596689.812 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:29.812Z,1408596689.812 [controlThread](INFO): Join timeout helper Thread ID is 2158
2014-08-21T04:51:29.971Z,1408596689.971 [DVL_micro](DEBUG): LCB error: Software Overcurrent.
2014-08-21T04:51:29.985Z,1408596689.985 [HFRCMReconstructedInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:29.987Z,1408596689.987 [HFRCMSpaceInterpolator](DEBUG): requested location (36.802444, -121.786720) is outside the bounding box
2014-08-21T04:51:30.013Z,1408596690.013 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2014-08-21T04:51:30.013Z,1408596690.013 [controlThread](DEBUG): Uninitializing ControlThread
2014-08-21T04:51:30.014Z,1408596690.014 [AHRS_sp3003D](INFO): Powering down
2014-08-21T04:51:30.175Z,1408596690.175 [DVL_micro](INFO): uninitialize:Powering down
2014-08-21T04:51:30.176Z,1408596690.176 [NAL9602](INFO): Powering down
2014-08-21T04:51:30.177Z,1408596690.177 [DAT](INFO): Powering down
2014-08-21T04:51:30.295Z,1408596690.295 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-08-21T04:51:30.298Z,1408596690.298 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2014-08-21T04:51:30.302Z,1408596690.302 [Startup] Stopped
2014-08-21T04:51:30.302Z,1408596690.302 [Startup](INFO): Aggregate::uninitialize Startup
2014-08-21T04:51:30.302Z,1408596690.302 [Startup:A.GoToSurface] Stopped
2014-08-21T04:51:30.302Z,1408596690.302 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-08-21T04:51:30.303Z,1408596690.303 [Startup:StartupSatComms] Stopped
2014-08-21T04:51:30.303Z,1408596690.303 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2014-08-21T04:51:30.303Z,1408596690.303 [Startup:StartupSatComms:A] Stopped
2014-08-21T04:51:30.304Z,1408596690.304 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2014-08-21T04:51:30.305Z,1408596690.305 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2014-08-21T04:51:30.305Z,1408596690.305 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2014-08-21T04:51:30.305Z,1408596690.305 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2014-08-21T04:51:30.305Z,1408596690.305 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2014-08-21T04:51:30.306Z,1408596690.306 [BuoyancyServo](INFO): Powering down
2014-08-21T04:51:30.319Z,1408596690.319 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2014-08-21T04:51:30.319Z,1408596690.319 [ElevatorServo](INFO): Powering down
2014-08-21T04:51:30.320Z,1408596690.320 [MassServo](DEBUG): Uninitialize Mass Servo.
2014-08-21T04:51:30.320Z,1408596690.320 [MassServo](INFO): Powering down
2014-08-21T04:51:30.321Z,1408596690.321 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2014-08-21T04:51:30.321Z,1408596690.321 [RudderServo](INFO): Powering down
2014-08-21T04:51:30.322Z,1408596690.322 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2014-08-21T04:51:30.322Z,1408596690.322 [ThrusterServo](INFO): Powering down
2014-08-21T04:51:30.323Z,1408596690.323 [SBIT](DEBUG): Uninitialize SBIT Component.
2014-08-21T04:51:30.323Z,1408596690.323 [IBIT](DEBUG): Uninitialize IBIT Component.
2014-08-21T04:51:30.323Z,1408596690.323 [CBIT](DEBUG): Uninitialize CBIT Component.
2014-08-21T04:51:30.368Z,1408596690.368 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:30.432Z,1408596690.432 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:30.436Z,1408596690.436 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:30.444Z,1408596690.444 [Radio_Freewave ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:30.508Z,1408596690.508 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-08-21T04:51:30.556Z,1408596690.556 [logger ThreadHandler](INFO): Thread cancelled.