2015-02-13T21:01:17.468Z,1423861277.468 [Supervisor](DEBUG): Initializing supervisor.
2015-02-13T21:01:17.470Z,1423861277.470 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2015-02-13T21:01:17.471Z,1423861277.471 [SyncHandler](INFO): Protected caller Thread ID is 788
2015-02-13T21:01:17.471Z,1423861277.471 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2015-02-13T21:01:17.472Z,1423861277.472 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2015-02-13T21:01:17.473Z,1423861277.473 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 789
2015-02-13T21:01:17.476Z,1423861277.476 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2015-02-13T21:01:17.488Z,1423861277.488 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2015-02-13T21:01:17.489Z,1423861277.489 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2015-02-13T21:01:17.490Z,1423861277.490 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 790
2015-02-13T21:01:17.491Z,1423861277.491 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2015-02-13T21:01:17.492Z,1423861277.492 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2015-02-13T21:01:17.492Z,1423861277.492 [logger ThreadHandler](INFO): Protected caller Thread ID is 791
2015-02-13T21:01:17.494Z,1423861277.494 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2015-02-13T21:01:17.495Z,1423861277.495 [Supervisor](INFO): Looking for Config files in directory: Config/
2015-02-13T21:01:17.500Z,1423861277.500 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2015-02-13T21:01:17.891Z,1423861277.891 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2015-02-13T21:01:17.891Z,1423861277.891 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2015-02-13T21:01:18.076Z,1423861278.076 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2015-02-13T21:01:18.077Z,1423861278.077 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2015-02-13T21:01:18.194Z,1423861278.194 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2015-02-13T21:01:18.195Z,1423861278.195 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2015-02-13T21:01:18.328Z,1423861278.328 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2015-02-13T21:01:18.329Z,1423861278.329 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2015-02-13T21:01:18.420Z,1423861278.420 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2015-02-13T21:01:18.599Z,1423861278.599 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2015-02-13T21:01:18.599Z,1423861278.599 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2015-02-13T21:01:18.691Z,1423861278.691 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2015-02-13T21:01:18.693Z,1423861278.693 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2015-02-13T21:01:18.927Z,1423861278.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2015-02-13T21:01:18.928Z,1423861278.928 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2015-02-13T21:01:19.337Z,1423861279.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2015-02-13T21:01:19.338Z,1423861279.338 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2015-02-13T21:01:19.696Z,1423861279.696 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2015-02-13T21:01:19.697Z,1423861279.697 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2015-02-13T21:01:20.266Z,1423861280.266 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2015-02-13T21:01:20.267Z,1423861280.267 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2015-02-13T21:01:20.558Z,1423861280.558 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2015-02-13T21:01:20.559Z,1423861280.559 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2015-02-13T21:01:20.670Z,1423861280.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2015-02-13T21:01:20.671Z,1423861280.671 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2015-02-13T21:01:21.334Z,1423861281.334 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2015-02-13T21:01:21.335Z,1423861281.335 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2015-02-13T21:01:25.089Z,1423861285.089 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2015-02-13T21:01:25.091Z,1423861285.091 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2015-02-13T21:01:33.073Z,1423861293.073 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2015-02-13T21:01:33.335Z,1423861293.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2015-02-13T21:01:33.336Z,1423861293.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2015-02-13T21:01:35.036Z,1423861295.036 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Estimation.cfg
2015-02-13T21:01:35.141Z,1423861295.141 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2015-02-13T21:01:35.248Z,1423861295.248 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2015-02-13T21:01:35.372Z,1423861295.372 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2015-02-13T21:01:35.536Z,1423861295.536 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2015-02-13T21:01:35.735Z,1423861295.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2015-02-13T21:01:35.844Z,1423861295.844 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2015-02-13T21:01:35.941Z,1423861295.941 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2015-02-13T21:01:36.051Z,1423861296.051 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2015-02-13T21:01:36.160Z,1423861296.160 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2015-02-13T21:01:36.374Z,1423861296.374 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2015-02-13T21:01:36.374Z,1423861296.374 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2015-02-13T21:01:36.381Z,1423861296.381 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2015-02-13T21:01:36.459Z,1423861296.459 [VerticalControl](DEBUG): Construct VerticalControl.
2015-02-13T21:01:36.590Z,1423861296.590 [VerticalControl] Loaded
2015-02-13T21:01:36.591Z,1423861296.591 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2015-02-13T21:01:36.591Z,1423861296.591 [HorizontalControl](DEBUG): Construct HorizontalControl.
2015-02-13T21:01:36.677Z,1423861296.677 [HorizontalControl] Loaded
2015-02-13T21:01:36.677Z,1423861296.677 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2015-02-13T21:01:36.678Z,1423861296.678 [SpeedControl](DEBUG): Construct SpeedControl.
2015-02-13T21:01:36.684Z,1423861296.684 [SpeedControl] Loaded
2015-02-13T21:01:36.685Z,1423861296.685 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2015-02-13T21:01:36.685Z,1423861296.685 [LoopControl](DEBUG): Construct LoopControl.
2015-02-13T21:01:36.686Z,1423861296.686 [LoopControl] Loaded
2015-02-13T21:01:36.686Z,1423861296.686 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2015-02-13T21:01:36.687Z,1423861296.687 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2015-02-13T21:01:36.688Z,1423861296.688 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2015-02-13T21:01:36.847Z,1423861296.847 [SBIT](DEBUG): Construct Startup Built In Test.
2015-02-13T21:01:36.862Z,1423861296.862 [SBIT] Loaded
2015-02-13T21:01:36.862Z,1423861296.862 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2015-02-13T21:01:36.863Z,1423861296.863 [IBIT](DEBUG): Construct Initiated Built In Test.
2015-02-13T21:01:36.895Z,1423861296.895 [IBIT] Loaded
2015-02-13T21:01:36.896Z,1423861296.896 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2015-02-13T21:01:36.898Z,1423861296.898 [CBIT](DEBUG): Construct CBIT Built In Test.
2015-02-13T21:01:37.063Z,1423861297.063 [CBIT] Loaded
2015-02-13T21:01:37.064Z,1423861297.064 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2015-02-13T21:01:37.064Z,1423861297.064 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2015-02-13T21:01:37.065Z,1423861297.065 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2015-02-13T21:01:37.096Z,1423861297.096 [DepthRateCalculator] Loaded
2015-02-13T21:01:37.097Z,1423861297.097 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2015-02-13T21:01:37.103Z,1423861297.103 [PitchRateCalculator] Loaded
2015-02-13T21:01:37.103Z,1423861297.103 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2015-02-13T21:01:37.116Z,1423861297.116 [SpeedCalculator] Loaded
2015-02-13T21:01:37.116Z,1423861297.116 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2015-02-13T21:01:37.134Z,1423861297.134 [TempGradientCalculator] Loaded
2015-02-13T21:01:37.135Z,1423861297.135 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2015-02-13T21:01:37.140Z,1423861297.140 [YawRateCalculator] Loaded
2015-02-13T21:01:37.141Z,1423861297.141 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2015-02-13T21:01:37.141Z,1423861297.141 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2015-02-13T21:01:37.142Z,1423861297.142 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2015-02-13T21:01:48.564Z,1423861308.564 [HFRCMReconstructedInterpolator] Loaded
2015-02-13T21:01:48.564Z,1423861308.564 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread.
2015-02-13T21:01:48.565Z,1423861308.565 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2015-02-13T21:01:48.566Z,1423861308.566 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2015-02-13T21:01:48.975Z,1423861308.975 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2015-02-13T21:01:48.976Z,1423861308.976 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2015-02-13T21:01:49.102Z,1423861309.102 [DeadReckonUsingMultipleVelocitySources] Loaded
2015-02-13T21:01:49.102Z,1423861309.102 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2015-02-13T21:01:49.153Z,1423861309.153 [DeadReckonUsingSpeedCalculator] Loaded
2015-02-13T21:01:49.153Z,1423861309.153 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2015-02-13T21:01:49.207Z,1423861309.207 [DeadReckonWithRespectToWater] Loaded
2015-02-13T21:01:49.207Z,1423861309.207 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread.
2015-02-13T21:01:49.227Z,1423861309.227 [NavChart] Loaded
2015-02-13T21:01:49.227Z,1423861309.227 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2015-02-13T21:01:49.232Z,1423861309.232 [UniversalFixResidualReporter] Loaded
2015-02-13T21:01:49.232Z,1423861309.232 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2015-02-13T21:01:49.233Z,1423861309.233 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2015-02-13T21:01:49.233Z,1423861309.233 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2015-02-13T21:01:49.242Z,1423861309.242 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2015-02-13T21:01:49.243Z,1423861309.243 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2015-02-13T21:01:49.424Z,1423861309.424 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2015-02-13T21:01:49.424Z,1423861309.424 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2015-02-13T21:01:50.227Z,1423861310.227 [DataOverHttps] Loaded
2015-02-13T21:01:50.227Z,1423861310.227 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2015-02-13T21:01:50.310Z,1423861310.310 [Depth_Keller] Loaded
2015-02-13T21:01:50.310Z,1423861310.310 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2015-02-13T21:01:50.669Z,1423861310.669 [DVL_micro] Loaded
2015-02-13T21:01:50.669Z,1423861310.669 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2015-02-13T21:01:50.889Z,1423861310.889 [NAL9602] Loaded
2015-02-13T21:01:50.890Z,1423861310.890 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2015-02-13T21:01:50.945Z,1423861310.945 [Onboard] Loaded
2015-02-13T21:01:50.946Z,1423861310.946 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2015-02-13T21:01:50.953Z,1423861310.953 [Radio_Surface] Loaded
2015-02-13T21:01:50.954Z,1423861310.954 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2015-02-13T21:01:50.955Z,1423861310.955 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408074E0
2015-02-13T21:01:50.955Z,1423861310.955 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 876
2015-02-13T21:01:53.822Z,1423861313.822 [BPC1] Loaded
2015-02-13T21:01:53.822Z,1423861313.822 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2015-02-13T21:01:53.823Z,1423861313.823 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2015-02-13T21:01:53.823Z,1423861313.823 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2015-02-13T21:01:58.356Z,1423861318.356 [BuoyancyServo] Loaded
2015-02-13T21:01:58.357Z,1423861318.357 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2015-02-13T21:01:58.401Z,1423861318.401 [ElevatorServo] Loaded
2015-02-13T21:01:58.402Z,1423861318.402 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2015-02-13T21:01:58.421Z,1423861318.421 [MassServo] Loaded
2015-02-13T21:01:58.424Z,1423861318.424 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2015-02-13T21:01:58.449Z,1423861318.449 [RudderServo] Loaded
2015-02-13T21:01:58.449Z,1423861318.449 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2015-02-13T21:01:58.512Z,1423861318.512 [ThrusterServo] Loaded
2015-02-13T21:01:58.512Z,1423861318.512 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2015-02-13T21:01:58.513Z,1423861318.513 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2015-02-13T21:01:58.514Z,1423861318.514 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2015-02-13T21:01:59.283Z,1423861319.283 [ExternalSim] Loaded
2015-02-13T21:01:59.283Z,1423861319.283 [ComponentRegistry](DEBUG): SyncComponent "ExternalSim" handled in the control thread.
2015-02-13T21:01:59.288Z,1423861319.288 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2015-02-13T21:01:59.289Z,1423861319.289 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2015-02-13T21:01:59.359Z,1423861319.359 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2015-02-13T21:01:59.361Z,1423861319.361 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2015-02-13T21:01:59.362Z,1423861319.362 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2015-02-13T21:01:59.387Z,1423861319.387 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2015-02-13T21:01:59.391Z,1423861319.391 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0
2015-02-13T21:01:59.392Z,1423861319.392 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 881
2015-02-13T21:01:59.415Z,1423861319.415 [Supervisor](INFO): Main Thread ID is 787
2015-02-13T21:01:59.415Z,1423861319.415 [Supervisor](DEBUG): Running supervisor.
2015-02-13T21:01:59.416Z,1423861319.416 [CommandLine ThreadHandler](INFO): Handler Thread ID is 882
2015-02-13T21:01:59.445Z,1423861319.445 [controlThread ThreadHandler](INFO): Handler Thread ID is 883
2015-02-13T21:01:59.445Z,1423861319.445 [controlThread](DEBUG): Initializing ControlThread
2015-02-13T21:01:59.447Z,1423861319.447 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2015-02-13T21:01:59.448Z,1423861319.448 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2015-02-13T21:01:59.449Z,1423861319.449 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2015-02-13T21:01:59.449Z,1423861319.449 [LoopControl](DEBUG): Initialize LoopControlComponent.
2015-02-13T21:01:59.450Z,1423861319.450 [SBIT](INFO): Initialize SBIT Component.
2015-02-13T21:01:59.450Z,1423861319.450 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:12012
2015-02-13T21:01:59.450Z,1423861319.450 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2015-02-13T21:01:59.451Z,1423861319.451 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2015-02-13T21:01:59.451Z,1423861319.451 [IBIT](INFO): Initialize IBIT Component.
2015-02-13T21:01:59.452Z,1423861319.452 [CBIT](DEBUG): Initialize CBIT Component.
2015-02-13T21:01:59.452Z,1423861319.452 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2015-02-13T21:01:59.464Z,1423861319.464 [logger ThreadHandler](INFO): Handler Thread ID is 884
2015-02-13T21:01:59.476Z,1423861319.476 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2015-02-13T21:01:59.476Z,1423861319.476 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2015-02-13T21:01:59.477Z,1423861319.477 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2015-02-13T21:01:59.477Z,1423861319.477 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2015-02-13T21:01:59.478Z,1423861319.478 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2015-02-13T21:01:59.479Z,1423861319.479 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s.
2015-02-13T21:01:59.481Z,1423861319.481 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2015-02-13T21:01:59.481Z,1423861319.481 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2015-02-13T21:01:59.482Z,1423861319.482 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component.
2015-02-13T21:01:59.482Z,1423861319.482 [NavChart](DEBUG): Initialize NavChart Navigation.
2015-02-13T21:01:59.482Z,1423861319.482 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2015-02-13T21:01:59.486Z,1423861319.486 [ExternalSim](INFO): ExternalSim initializing...
2015-02-13T21:01:59.500Z,1423861319.500 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 885
2015-02-13T21:01:59.506Z,1423861319.506 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 886
2015-02-13T21:01:59.534Z,1423861319.534 [Radio_Surface](INFO): Powering up
2015-02-13T21:01:59.534Z,1423861319.534 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2015-02-13T21:01:59.535Z,1423861319.535 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2015-02-13T21:01:59.536Z,1423861319.536 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2015-02-13T21:01:59.536Z,1423861319.536 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2015-02-13T21:01:59.536Z,1423861319.536 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2015-02-13T21:01:59.537Z,1423861319.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2015-02-13T21:01:59.537Z,1423861319.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2015-02-13T21:01:59.537Z,1423861319.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2015-02-13T21:01:59.537Z,1423861319.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2015-02-13T21:01:59.958Z,1423861319.958 [ExternalSim](DEBUG): beaconLat = 36.80340
2015-02-13T21:01:59.958Z,1423861319.958 [ExternalSim](DEBUG): beaconLon = -121.82230
2015-02-13T21:01:59.958Z,1423861319.958 [ExternalSim](DEBUG): beaconDepth = 25.00
2015-02-13T21:02:00.427Z,1423861320.427 [ExternalSim](DEBUG): Simulator initialized
2015-02-13T21:02:00.602Z,1423861320.602 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2015-02-13T21:02:00.641Z,1423861320.641 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2015-02-13T21:02:00.705Z,1423861320.705 [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>


2015-02-13T21:02:00.706Z,1423861320.706 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2015-02-13T21:02:00.815Z,1423861320.815 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h
2015-02-13T21:02:00.838Z,1423861320.838 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h
2015-02-13T21:02:00.843Z,1423861320.843 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2015-02-13T21:02:00.933Z,1423861320.933 [Default:CheckIn:A.SetSpeed](DEBUG): Construct.
2015-02-13T21:02:00.975Z,1423861320.975 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2015-02-13T21:02:00.999Z,1423861320.999 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct.
2015-02-13T21:02:01.005Z,1423861321.005 [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>


2015-02-13T21:02:01.033Z,1423861321.033 [controlThread](DEBUG): Component order: CycleStarter,ExternalSim,DataOverHttps,Depth_Keller,DVL_micro,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRCMReconstructedInterpolator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToWater,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2015-02-13T21:02:01.398Z,1423861321.398 [DVL_micro](INFO): Initializing
2015-02-13T21:02:01.446Z,1423861321.446 [NAL9602](INFO): Powering up NAL9602
2015-02-13T21:02:01.776Z,1423861321.776 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:01.791Z,1423861321.791 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 0 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:02:02.036Z,1423861322.036 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:02:02.044Z,1423861322.044 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2015-02-13T21:02:02.066Z,1423861322.066 [ElevatorServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:02:02.072Z,1423861322.072 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2015-02-13T21:02:02.086Z,1423861322.086 [MassServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:02:02.092Z,1423861322.092 [MassServo](DEBUG): Initializing MassServo.
2015-02-13T21:02:02.122Z,1423861322.122 [RudderServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:02:02.132Z,1423861322.132 [RudderServo](DEBUG): Initializing RudderServo.
2015-02-13T21:02:02.150Z,1423861322.150 [ThrusterServo](DEBUG): Initializing EZServoServo.
2015-02-13T21:02:02.156Z,1423861322.156 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2015-02-13T21:02:02.696Z,1423861322.696 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:02.722Z,1423861322.722 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:02:08.520Z,1423861328.520 [CommandLine](IMPORTANT): got command quit
2015-02-13T21:02:09.526Z,1423861329.526 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-13T21:02:09.526Z,1423861329.526 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:09.575Z,1423861329.575 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2015-02-13T21:02:09.575Z,1423861329.575 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:09.576Z,1423861329.576 [CommandLine](INFO): Join timeout helper Thread ID is 892
2015-02-13T21:02:09.599Z,1423861329.599 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2015-02-13T21:02:09.599Z,1423861329.599 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:09.600Z,1423861329.600 [NavChartDb](INFO): Join timeout helper Thread ID is 893
2015-02-13T21:02:13.379Z,1423861333.379 [BPC1](ERROR): B bank expecting battery number:1 and read number: uart read:X
$S,01,270F,02,00,04,5D%56
$C1,01,7F,02,00,03,7F,04,00,05,00,06,00,07,00%72
$B11,02,000A,01,026C,03,0001,08,0B8D,09,3FEE,0A,FFF3,0B,FFFE%4A
$B11,0C,0001,0D,0060,0E,005B,0F,15DA,10,170E,11,64DA,12,FFFF%41
$B11,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%41
$B11,1A,0031,1B,4357,1C,00AD%31
$B12,02,000A,01,026C,03,0001,08,0B85,09,3DD1,0A,0000,0B,0004%3D
$B12,0C,0001,0D,0051,0E,004C,0F,1234,10,16B8,11,FFFF,12,FFFF%4C
$B12,13,43BC,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%44
$B12,1A,0031,1B,4357,1C,00AB%34
$B13,02,000A,01,026C,03,0001,08,0B80,09,3DF8,0A,0000,0B,0004%32
$B13,0C,0001,0D,005B,0E,004C,0F,1253,10,169D,11,FFFF,12,FFFF%38
$B13,13,4056,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%44
$B13,1A,0031,1B,4357,1C,00B1%45
$B14,02,000A,01,026C,03,0001,08,0B86,09,3F89,0A,0000,0B,0004%4E
$B14,0C,0001,0D,005B,0E,0055,0F,1472,10,1685,11,FFFF,12,FFFF%3D
$B14,13,1F1D,14,0BB8,15,41A0,16,00C0,17,0002,18,1838,19,3840%46
$B14,1A,0031,1B,4357,1C,00A0%40
$B15,02,000A,01,026C,03,0001,08,0B88,09,4019,0A,0000,0B,0000%3D
$B15,0C,0001,0D,0063,0E,005D,0F,1665,10,1716,11,FFFF,12,FFFF%30
$B15,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%46
$B15,1A,0031,1B,4357,1C,008B%4A
$B16,02,000A,01,026C,03,0001,08,0B7D,09,4011,0A,0000,0B,0000%45
$B16,0C,0001,0D,0062,0E,005D,0F,1663,10,1735,11,FFFF,12,FFFF%35
$B16,13,FFFF,14,0BB8,15,41A0,16,00C0,17,0001,18,1838,19,3840%45
$B16,1A,0031,1B,4339,1C,007F%4A
$B17,02,000A,01,026C,03,0001,08,0B79,09,3987,0A,0000,0B,0003%3B
$B17,0C,0001,0D,0062,0E,005B,0F,15DC,10,16E1,11,FFFF,12,FFFF%40
$B17,13,1464,14,0000,15,41A0,16,00E0,17,0001,18,1838,19,3840%4D
$B17,1A,0031,1B,4357,1C,00B4%44
$S,01,270F,02,00,04,5D%56
$C1,01,7F,02,00,03,7F,04,00,05,00,06,00,07,00%72
$B11,0A,FFF3%46
$B12,0A,0000%30
$B13,0A,0000%31
$B14,0A,0000%36
$B15,0A,0000%37
$B16,0A,0000%34
$B17,0A,0000%35

2015-02-13T21:02:13.379Z,1423861333.379 [BPC1](ERROR): Failed to parse bank B battery data
2015-02-13T21:02:13.379Z,1423861333.379 [BPC1] Data Fault, FailCount= 1
2015-02-13T21:02:13.379Z,1423861333.379 [BPC1](ERROR): Data Fault
2015-02-13T21:02:13.384Z,1423861333.384 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:13.410Z,1423861333.410 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:02:13.473Z,1423861333.473 [CBIT](ERROR): Data Fault in component: BPC1
2015-02-13T21:02:13.824Z,1423861333.824 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:13.833Z,1423861333.833 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:02:14.373Z,1423861334.373 [NAL9602](INFO): NAL9602 initialized
2015-02-13T21:02:14.467Z,1423861334.467 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:14.481Z,1423861334.481 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 4 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:02:14.760Z,1423861334.760 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003406
2015-02-13T21:02:14.795Z,1423861334.795 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:14.828Z,1423861334.828 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 5 cycles since last successful read, accepting data for 5 cycles.
2015-02-13T21:02:15.081Z,1423861335.081 [SBIT](IMPORTANT): Beginning Startup BIT
2015-02-13T21:02:15.083Z,1423861335.083 [CBIT](INFO): Clearing failed state for component BPC1
2015-02-13T21:02:15.084Z,1423861335.084 [BPC1] No Fault, FailCount= 1
2015-02-13T21:02:15.085Z,1423861335.085 [CBIT](IMPORTANT): Beginning GF scan
2015-02-13T21:02:15.560Z,1423861335.560 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:16.631Z,1423861336.631 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:17.778Z,1423861337.778 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:18.193Z,1423861338.193 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:18.710Z,1423861338.710 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:19.288Z,1423861339.288 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:19.836Z,1423861339.836 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:20.315Z,1423861340.315 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:20.779Z,1423861340.779 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:21.249Z,1423861341.249 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:21.886Z,1423861341.886 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:22.100Z,1423861342.100 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-13T21:02:22.100Z,1423861342.100 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:22.103Z,1423861342.103 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2015-02-13T21:02:22.103Z,1423861342.103 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:22.103Z,1423861342.103 [Radio_Surface](INFO): Join timeout helper Thread ID is 894
2015-02-13T21:02:22.163Z,1423861342.163 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-13T21:02:22.163Z,1423861342.163 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:22.175Z,1423861342.175 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2015-02-13T21:02:22.175Z,1423861342.175 [logger ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:22.175Z,1423861342.175 [logger](INFO): Join timeout helper Thread ID is 895
2015-02-13T21:02:22.194Z,1423861342.194 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-13T21:02:22.195Z,1423861342.195 [logger ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:22.211Z,1423861342.211 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2015-02-13T21:02:22.211Z,1423861342.211 [CommandLine ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:22.211Z,1423861342.211 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2015-02-13T21:02:22.211Z,1423861342.211 [controlThread ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:22.212Z,1423861342.212 [controlThread](INFO): Join timeout helper Thread ID is 896
2015-02-13T21:02:22.418Z,1423861342.418 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast
2015-02-13T21:02:22.569Z,1423861342.569 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2015-02-13T21:02:22.569Z,1423861342.569 [controlThread](DEBUG): Uninitializing ControlThread
2015-02-13T21:02:22.570Z,1423861342.570 [DVL_micro](INFO): uninitialize:Powering down
2015-02-13T21:02:22.570Z,1423861342.570 [NAL9602](INFO): Powering down
2015-02-13T21:02:22.573Z,1423861342.573 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2015-02-13T21:02:22.574Z,1423861342.574 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2015-02-13T21:02:22.578Z,1423861342.578 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2015-02-13T21:02:22.579Z,1423861342.579 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2015-02-13T21:02:22.579Z,1423861342.579 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2015-02-13T21:02:22.579Z,1423861342.579 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2015-02-13T21:02:22.580Z,1423861342.580 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2015-02-13T21:02:22.580Z,1423861342.580 [BuoyancyServo](INFO): Powering down
2015-02-13T21:02:22.592Z,1423861342.592 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2015-02-13T21:02:22.592Z,1423861342.592 [ElevatorServo](INFO): Powering down
2015-02-13T21:02:22.593Z,1423861342.593 [MassServo](DEBUG): Uninitialize Mass Servo.
2015-02-13T21:02:22.593Z,1423861342.593 [MassServo](INFO): Powering down
2015-02-13T21:02:22.594Z,1423861342.594 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2015-02-13T21:02:22.594Z,1423861342.594 [RudderServo](INFO): Powering down
2015-02-13T21:02:22.595Z,1423861342.595 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2015-02-13T21:02:22.595Z,1423861342.595 [ThrusterServo](INFO): Powering down
2015-02-13T21:02:22.596Z,1423861342.596 [SBIT](DEBUG): Uninitialize SBIT Component.
2015-02-13T21:02:22.596Z,1423861342.596 [IBIT](DEBUG): Uninitialize IBIT Component.
2015-02-13T21:02:22.596Z,1423861342.596 [CBIT](DEBUG): Uninitialize CBIT Component.
2015-02-13T21:02:22.645Z,1423861342.645 [CBIT](CRITICAL): run-time exception #7
2015-02-13T21:02:22.645Z,1423861342.645 [CBIT](CRITICAL): Bad address: 0x40319004
2015-02-13T21:02:22.646Z,1423861342.646 [CBIT](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x16f3dc]
/lib/libc.so.6(__default_rt_sa_restorer+0) [0x40212510]

2015-02-13T21:02:22.646Z,1423861342.646 [CBIT] Software Fault, FailCount= 1
2015-02-13T21:02:22.646Z,1423861342.646 [CBIT](ERROR): Software Fault
2015-02-13T21:02:22.648Z,1423861342.648 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2015-02-13T21:02:22.648Z,1423861342.648 [SyncHandler](INFO): Protected caller Thread ID is 897
2015-02-13T21:02:22.649Z,1423861342.649 [controlThread ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:22.772Z,1423861342.772 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:23.072Z,1423861343.072 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2015-02-13T21:02:23.121Z,1423861343.121 [logger ThreadHandler](INFO): Thread cancelled.