2014-04-13T19:03:56.021Z,1397415836.021 [Supervisor](DEBUG): Initializing supervisor.
2014-04-13T19:03:56.023Z,1397415836.023 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2014-04-13T19:03:56.024Z,1397415836.024 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2014-04-13T19:03:56.036Z,1397415836.036 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2014-04-13T19:03:56.039Z,1397415836.039 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2014-04-13T19:03:56.085Z,1397415836.085 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2014-04-13T19:03:56.095Z,1397415836.095 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2014-04-13T19:03:56.096Z,1397415836.096 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2014-04-13T19:03:56.099Z,1397415836.099 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0
2014-04-13T19:03:56.101Z,1397415836.101 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2014-04-13T19:03:56.101Z,1397415836.101 [Supervisor](INFO): Looking for Config files in directory: Config/
2014-04-13T19:03:56.117Z,1397415836.117 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2014-04-13T19:03:56.742Z,1397415836.742 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2014-04-13T19:03:56.743Z,1397415836.743 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2014-04-13T19:03:57.208Z,1397415837.208 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2014-04-13T19:03:57.208Z,1397415837.208 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2014-04-13T19:03:57.321Z,1397415837.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2014-04-13T19:03:57.326Z,1397415837.326 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2014-04-13T19:03:57.677Z,1397415837.677 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2014-04-13T19:03:57.678Z,1397415837.678 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2014-04-13T19:03:57.957Z,1397415837.957 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2014-04-13T19:03:57.969Z,1397415837.969 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2014-04-13T19:03:58.472Z,1397415838.472 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2014-04-13T19:03:58.473Z,1397415838.473 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2014-04-13T19:03:58.737Z,1397415838.737 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2014-04-13T19:03:58.742Z,1397415838.742 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2014-04-13T19:03:59.294Z,1397415839.294 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2014-04-13T19:03:59.300Z,1397415839.300 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2014-04-13T19:03:59.511Z,1397415839.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2014-04-13T19:03:59.512Z,1397415839.512 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2014-04-13T19:04:00.429Z,1397415840.429 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2014-04-13T19:04:00.430Z,1397415840.430 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2014-04-13T19:04:00.632Z,1397415840.632 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2014-04-13T19:04:00.632Z,1397415840.632 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2014-04-13T19:04:00.767Z,1397415840.767 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2014-04-13T19:04:00.932Z,1397415840.932 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2014-04-13T19:04:00.936Z,1397415840.936 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2014-04-13T19:04:01.120Z,1397415841.120 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2014-04-13T19:04:01.121Z,1397415841.121 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2014-04-13T19:04:01.329Z,1397415841.329 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2014-04-13T19:04:01.331Z,1397415841.331 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2014-04-13T19:04:01.355Z,1397415841.355 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2014-04-13T19:04:01.528Z,1397415841.528 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2014-04-13T19:04:01.754Z,1397415841.754 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2014-04-13T19:04:01.928Z,1397415841.928 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2014-04-13T19:04:02.079Z,1397415842.079 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2014-04-13T19:04:02.288Z,1397415842.288 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2014-04-13T19:04:02.441Z,1397415842.441 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2014-04-13T19:04:02.584Z,1397415842.584 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2014-04-13T19:04:02.766Z,1397415842.766 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2014-04-13T19:04:02.911Z,1397415842.911 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2014-04-13T19:04:02.919Z,1397415842.919 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2014-04-13T19:04:03.831Z,1397415843.831 [AHRS_sp3003D] Loaded
2014-04-13T19:04:03.832Z,1397415843.832 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2014-04-13T19:04:04.187Z,1397415844.187 [Batt_Ocean_Server] Loaded
2014-04-13T19:04:04.187Z,1397415844.187 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread.
2014-04-13T19:04:04.206Z,1397415844.206 [Depth_Keller] Loaded
2014-04-13T19:04:04.206Z,1397415844.206 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2014-04-13T19:04:04.212Z,1397415844.212 [DropWeight] Loaded
2014-04-13T19:04:04.212Z,1397415844.212 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2014-04-13T19:04:04.378Z,1397415844.378 [DVL_micro] Loaded
2014-04-13T19:04:04.378Z,1397415844.378 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2014-04-13T19:04:04.499Z,1397415844.499 [NAL9602] Loaded
2014-04-13T19:04:04.499Z,1397415844.499 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2014-04-13T19:04:04.558Z,1397415844.558 [Onboard] Loaded
2014-04-13T19:04:04.559Z,1397415844.559 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2014-04-13T19:04:04.566Z,1397415844.566 [Radio_Freewave] Loaded
2014-04-13T19:04:04.567Z,1397415844.567 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2014-04-13T19:04:04.574Z,1397415844.574 [SCPI] Loaded
2014-04-13T19:04:04.574Z,1397415844.574 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2014-04-13T19:04:04.575Z,1397415844.575 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2014-04-13T19:04:04.575Z,1397415844.575 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2014-04-13T19:04:04.808Z,1397415844.808 [InternalSim] Loaded
2014-04-13T19:04:04.809Z,1397415844.809 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2014-04-13T19:04:04.809Z,1397415844.809 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2014-04-13T19:04:04.810Z,1397415844.810 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2014-04-13T19:04:05.141Z,1397415845.141 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2014-04-13T19:04:05.142Z,1397415845.142 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2014-04-13T19:04:05.150Z,1397415845.150 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2014-04-13T19:04:05.156Z,1397415845.156 [AsyncPiEstimator] Loaded
2014-04-13T19:04:05.156Z,1397415845.156 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2014-04-13T19:04:05.159Z,1397415845.159 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 4069E4E0
2014-04-13T19:04:05.159Z,1397415845.159 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2014-04-13T19:04:05.160Z,1397415845.160 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2014-04-13T19:04:05.267Z,1397415845.267 [DeadReckonUsingMultipleVelocitySources] Loaded
2014-04-13T19:04:05.267Z,1397415845.267 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2014-04-13T19:04:05.289Z,1397415845.289 [NavChart] Loaded
2014-04-13T19:04:05.290Z,1397415845.290 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2014-04-13T19:04:05.290Z,1397415845.290 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2014-04-13T19:04:05.291Z,1397415845.291 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2014-04-13T19:04:05.368Z,1397415845.368 [VerticalControl](DEBUG): Construct VerticalControl.
2014-04-13T19:04:05.498Z,1397415845.498 [VerticalControl] Loaded
2014-04-13T19:04:05.498Z,1397415845.498 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2014-04-13T19:04:05.499Z,1397415845.499 [HorizontalControl](DEBUG): Construct HorizontalControl.
2014-04-13T19:04:05.579Z,1397415845.579 [HorizontalControl] Loaded
2014-04-13T19:04:05.580Z,1397415845.580 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2014-04-13T19:04:05.580Z,1397415845.580 [SpeedControl](DEBUG): Construct SpeedControl.
2014-04-13T19:04:05.582Z,1397415845.582 [SpeedControl] Loaded
2014-04-13T19:04:05.582Z,1397415845.582 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2014-04-13T19:04:05.587Z,1397415845.587 [LoopControl](DEBUG): Construct LoopControl.
2014-04-13T19:04:05.588Z,1397415845.588 [LoopControl] Loaded
2014-04-13T19:04:05.588Z,1397415845.588 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2014-04-13T19:04:05.589Z,1397415845.589 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2014-04-13T19:04:05.589Z,1397415845.589 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2014-04-13T19:04:05.620Z,1397415845.620 [DepthRateCalculator] Loaded
2014-04-13T19:04:05.621Z,1397415845.621 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2014-04-13T19:04:05.626Z,1397415845.626 [PitchRateCalculator] Loaded
2014-04-13T19:04:05.627Z,1397415845.627 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2014-04-13T19:04:05.634Z,1397415845.634 [SpeedCalculator] Loaded
2014-04-13T19:04:05.635Z,1397415845.635 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2014-04-13T19:04:05.645Z,1397415845.645 [YawRateCalculator] Loaded
2014-04-13T19:04:05.645Z,1397415845.645 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2014-04-13T19:04:05.645Z,1397415845.645 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2014-04-13T19:04:05.646Z,1397415845.646 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2014-04-13T19:04:05.797Z,1397415845.797 [CTD_NeilBrown] Loaded
2014-04-13T19:04:05.797Z,1397415845.797 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2014-04-13T19:04:05.800Z,1397415845.800 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 407404E0
2014-04-13T19:04:05.815Z,1397415845.815 [PAR_Licor] Loaded
2014-04-13T19:04:05.816Z,1397415845.816 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2014-04-13T19:04:05.857Z,1397415845.857 [WetLabsBB2FL] Loaded
2014-04-13T19:04:05.857Z,1397415845.857 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2014-04-13T19:04:05.860Z,1397415845.860 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407704E0
2014-04-13T19:04:05.860Z,1397415845.860 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2014-04-13T19:04:05.863Z,1397415845.863 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2014-04-13T19:04:06.002Z,1397415846.002 [SBIT](DEBUG): Construct Startup Built In Test.
2014-04-13T19:04:06.019Z,1397415846.019 [SBIT] Loaded
2014-04-13T19:04:06.019Z,1397415846.019 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2014-04-13T19:04:06.020Z,1397415846.020 [IBIT](DEBUG): Construct Initiated Built In Test.
2014-04-13T19:04:06.037Z,1397415846.037 [IBIT] Loaded
2014-04-13T19:04:06.038Z,1397415846.038 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2014-04-13T19:04:06.040Z,1397415846.040 [CBIT](DEBUG): Construct CBIT Built In Test.
2014-04-13T19:04:06.120Z,1397415846.120 [CBIT] Loaded
2014-04-13T19:04:06.121Z,1397415846.121 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2014-04-13T19:04:06.121Z,1397415846.121 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2014-04-13T19:04:06.123Z,1397415846.123 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2014-04-13T19:04:06.201Z,1397415846.201 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2014-04-13T19:04:06.202Z,1397415846.202 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2014-04-13T19:04:06.338Z,1397415846.338 [BuoyancyServo] Loaded
2014-04-13T19:04:06.339Z,1397415846.339 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2014-04-13T19:04:06.355Z,1397415846.355 [ElevatorServo] Loaded
2014-04-13T19:04:06.356Z,1397415846.356 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2014-04-13T19:04:06.368Z,1397415846.368 [MassServo] Loaded
2014-04-13T19:04:06.368Z,1397415846.368 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2014-04-13T19:04:06.384Z,1397415846.384 [RudderServo] Loaded
2014-04-13T19:04:06.385Z,1397415846.385 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2014-04-13T19:04:06.397Z,1397415846.397 [ThrusterServo] Loaded
2014-04-13T19:04:06.397Z,1397415846.397 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2014-04-13T19:04:06.397Z,1397415846.397 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2014-04-13T19:04:06.398Z,1397415846.398 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2014-04-13T19:04:06.443Z,1397415846.443 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2014-04-13T19:04:06.445Z,1397415846.445 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2014-04-13T19:04:06.446Z,1397415846.446 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2014-04-13T19:04:06.453Z,1397415846.453 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2014-04-13T19:04:06.457Z,1397415846.457 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 4083E4E0
2014-04-13T19:04:06.461Z,1397415846.461 [Supervisor](DEBUG): Running supervisor.
2014-04-13T19:04:06.462Z,1397415846.462 [CommandLine](INFO): Thread ID is 771
2014-04-13T19:04:06.469Z,1397415846.469 [controlThread](INFO): Thread ID is 770
2014-04-13T19:04:06.469Z,1397415846.469 [controlThread](DEBUG): Initializing ControlThread
2014-04-13T19:04:06.470Z,1397415846.470 [CycleStarter](INFO): Thread ID is 769
2014-04-13T19:04:06.473Z,1397415846.473 [logger](INFO): Thread ID is 772
2014-04-13T19:04:06.509Z,1397415846.509 [AsyncPiEstimator](INFO): Thread ID is 847
2014-04-13T19:04:06.510Z,1397415846.510 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2014-04-13T19:04:06.528Z,1397415846.528 [CTD_NeilBrown](INFO): Thread ID is 848
2014-04-13T19:04:06.528Z,1397415846.528 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2014-04-13T19:04:06.530Z,1397415846.530 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2014-04-13T19:04:06.543Z,1397415846.543 [WetLabsBB2FL](INFO): Thread ID is 849
2014-04-13T19:04:06.544Z,1397415846.544 [WetLabsBB2FL](INFO): Powering down
2014-04-13T19:04:06.571Z,1397415846.571 [NavChartDb](INFO): Thread ID is 850
2014-04-13T19:04:06.602Z,1397415846.602 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2014-04-13T19:04:06.617Z,1397415846.617 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2014-04-13T19:04:06.618Z,1397415846.618 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2014-04-13T19:04:06.618Z,1397415846.618 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2014-04-13T19:04:06.618Z,1397415846.618 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2014-04-13T19:04:06.618Z,1397415846.618 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2014-04-13T19:04:06.619Z,1397415846.619 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2014-04-13T19:04:06.619Z,1397415846.619 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2014-04-13T19:04:06.619Z,1397415846.619 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2014-04-13T19:04:08.446Z,1397415848.446 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2014-04-13T19:04:08.499Z,1397415848.499 [InternalSim](DEBUG):  InternalSim initializing...
2014-04-13T19:04:08.868Z,1397415848.868 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-04-13T19:04:08.873Z,1397415848.873 [NavChart](DEBUG): Initialize NavChart Navigation.
2014-04-13T19:04:08.873Z,1397415848.873 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2014-04-13T19:04:08.875Z,1397415848.875 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2014-04-13T19:04:08.876Z,1397415848.876 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2014-04-13T19:04:08.901Z,1397415848.901 [LoopControl](DEBUG): Initialize LoopControlComponent.
2014-04-13T19:04:08.901Z,1397415848.901 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-04-13T19:04:08.902Z,1397415848.902 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2014-04-13T19:04:08.902Z,1397415848.902 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2014-04-13T19:04:08.902Z,1397415848.902 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2014-04-13T19:04:08.913Z,1397415848.913 [SBIT](INFO): Initialize SBIT Component.
2014-04-13T19:04:08.914Z,1397415848.914 [SBIT](IMPORTANT): Tethys CM Info: 
 $Rev:11196
2014-04-13T19:04:08.914Z,1397415848.914 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2014-04-13T19:04:08.914Z,1397415848.914 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2014-04-13T19:04:08.915Z,1397415848.915 [IBIT](INFO): Initialize IBIT Component.
2014-04-13T19:04:08.916Z,1397415848.916 [CBIT](DEBUG): Initialize CBIT Component.
2014-04-13T19:04:08.916Z,1397415848.916 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2014-04-13T19:04:08.951Z,1397415848.951 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2014-04-13T19:04:09.041Z,1397415849.041 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-04-13T19:04:09.051Z,1397415849.051 [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-04-13T19:04:09.052Z,1397415849.052 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2014-04-13T19:04:09.144Z,1397415849.144 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2014-04-13T19:04:09.146Z,1397415849.146 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2014-04-13T19:04:09.150Z,1397415849.150 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-04-13T19:04:09.170Z,1397415849.170 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2014-04-13T19:04:09.173Z,1397415849.173 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-04-13T19:04:09.212Z,1397415849.212 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2014-04-13T19:04:09.231Z,1397415849.231 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed](DEBUG): Construct.
2014-04-13T19:04:09.250Z,1397415849.250 [Default:WaitAtTheSurface:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-04-13T19:04:09.257Z,1397415849.257 [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="NeedGPS"><True/></DefineArg>

    <Aggregate Id="GPS">

        <When>
            <Arg Name="NeedGPS"/>
        </When>

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface>
            <Sequence/>
        </Guidance:GoToSurface>

<!-- Get GPS fix -->

        <ReadDatum Id="Read_GPS">
            <Universal:latitude_fix/>
        </ReadDatum>

        <Assign><Sequence/><Arg Name="NeedGPS"/><False/></Assign>

    </Aggregate>

    <Aggregate Id="Iridium">

        <Sequence/>

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface>
            <Sequence/>
        </Guidance:GoToSurface>

<!-- 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="CallIridium">

        <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>

        <Assign><Sequence/><Arg Name="NeedGPS"/><True/></Assign>

        <Call RefId="Iridium"/>

    </Aggregate>

    <Aggregate Id="WaitAtTheSurface">

        <Sequence/>

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

        <Guidance:GoToSurface>
            <Parallel/>
        </Guidance:GoToSurface>

    </Aggregate>

</Mission>


2014-04-13T19:04:09.262Z,1397415849.262 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Batt_Ocean_Server,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,Radio_Freewave,SCPI,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2014-04-13T19:04:09.373Z,1397415849.373 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2014-04-13T19:04:09.565Z,1397415849.565 [DVL_micro](INFO): Initializing
2014-04-13T19:04:09.612Z,1397415849.612 [NAL9602](INFO): Powering up NAL9602
2014-04-13T19:04:09.734Z,1397415849.734 [Radio_Freewave](INFO): Powering up
2014-04-13T19:04:09.949Z,1397415849.949 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:10.065Z,1397415850.065 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-04-13T19:04:10.087Z,1397415850.087 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-04-13T19:04:10.094Z,1397415850.094 [ElevatorServo](DEBUG): Initializing EZServoServo.
2014-04-13T19:04:10.099Z,1397415850.099 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2014-04-13T19:04:10.123Z,1397415850.123 [MassServo](DEBUG): Initializing EZServoServo.
2014-04-13T19:04:10.139Z,1397415850.139 [MassServo](DEBUG): Initializing MassServo.
2014-04-13T19:04:10.145Z,1397415850.145 [RudderServo](DEBUG): Initializing EZServoServo.
2014-04-13T19:04:10.151Z,1397415850.151 [RudderServo](DEBUG): Initializing RudderServo.
2014-04-13T19:04:10.156Z,1397415850.156 [ThrusterServo](DEBUG): Initializing EZServoServo.
2014-04-13T19:04:10.163Z,1397415850.163 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2014-04-13T19:04:10.544Z,1397415850.544 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:11.020Z,1397415851.020 [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-04-13T19:04:11.071Z,1397415851.071 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:12.013Z,1397415852.013 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:12.607Z,1397415852.607 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:13.097Z,1397415853.097 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:13.664Z,1397415853.664 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:14.316Z,1397415854.316 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:15.043Z,1397415855.043 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:15.769Z,1397415855.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:16.360Z,1397415856.360 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:16.824Z,1397415856.824 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:17.345Z,1397415857.345 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:17.865Z,1397415857.865 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:18.476Z,1397415858.476 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:19.133Z,1397415859.133 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:19.695Z,1397415859.695 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:20.150Z,1397415860.150 [NAL9602](INFO): NAL9602 initialized
2014-04-13T19:04:20.220Z,1397415860.220 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:20.752Z,1397415860.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:21.298Z,1397415861.298 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:21.995Z,1397415861.995 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:22.608Z,1397415862.608 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:23.164Z,1397415863.164 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:23.653Z,1397415863.653 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:24.142Z,1397415864.142 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:24.776Z,1397415864.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:24.839Z,1397415864.839 [SBIT](IMPORTANT): Beginning Startup BIT
2014-04-13T19:04:24.842Z,1397415864.842 [CBIT](IMPORTANT): Beginning GF scan
2014-04-13T19:04:25.443Z,1397415865.443 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:26.014Z,1397415866.014 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:26.607Z,1397415866.607 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:27.150Z,1397415867.150 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:27.745Z,1397415867.745 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:28.353Z,1397415868.353 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:28.950Z,1397415868.950 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:29.446Z,1397415869.446 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:30.100Z,1397415870.100 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:30.824Z,1397415870.824 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:31.270Z,1397415871.270 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:31.938Z,1397415871.938 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:32.502Z,1397415872.502 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:33.029Z,1397415873.029 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:33.564Z,1397415873.564 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:34.034Z,1397415874.034 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:34.509Z,1397415874.509 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:35.159Z,1397415875.159 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:35.640Z,1397415875.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:36.116Z,1397415876.116 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:36.610Z,1397415876.610 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:37.042Z,1397415877.042 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:37.517Z,1397415877.517 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:37.939Z,1397415877.939 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:38.453Z,1397415878.453 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:38.912Z,1397415878.912 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:39.341Z,1397415879.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:39.823Z,1397415879.823 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:40.435Z,1397415880.435 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:41.520Z,1397415881.520 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:42.027Z,1397415882.027 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:42.526Z,1397415882.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:43.065Z,1397415883.065 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:43.576Z,1397415883.576 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:44.093Z,1397415884.093 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:44.618Z,1397415884.618 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:45.344Z,1397415885.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:45.868Z,1397415885.868 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:46.533Z,1397415886.533 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:47.018Z,1397415887.018 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:47.466Z,1397415887.466 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:48.006Z,1397415888.006 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:48.516Z,1397415888.516 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:48.969Z,1397415888.969 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:49.443Z,1397415889.443 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:49.946Z,1397415889.946 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:50.538Z,1397415890.538 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:50.972Z,1397415890.972 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:51.510Z,1397415891.510 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:51.998Z,1397415891.998 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:52.064Z,1397415892.064 [CBIT](IMPORTANT): No ground fault detected
2014-04-13T19:04:52.453Z,1397415892.453 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:52.922Z,1397415892.922 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:53.398Z,1397415893.398 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:53.835Z,1397415893.835 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:54.271Z,1397415894.271 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:54.798Z,1397415894.798 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:55.238Z,1397415895.238 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:55.818Z,1397415895.818 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:56.234Z,1397415896.234 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:56.712Z,1397415896.712 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:57.139Z,1397415897.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:57.550Z,1397415897.550 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:58.054Z,1397415898.054 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:58.541Z,1397415898.541 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:58.000Z,1397415899.000 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:04:59.441Z,1397415899.441 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:00.017Z,1397415900.017 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:00.435Z,1397415900.435 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:01.066Z,1397415901.066 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:01.598Z,1397415901.598 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:02.033Z,1397415902.033 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:02.473Z,1397415902.473 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:02.956Z,1397415902.956 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:03.427Z,1397415903.427 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:03.858Z,1397415903.858 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:04.255Z,1397415904.255 [NAL9602](INFO): SBD MO Status=0, MOMSN=25486, MT Status=0, MTMSN=0
2014-04-13T19:05:04.255Z,1397415904.255 [NAL9602](INFO): No messages in MT queue
2014-04-13T19:05:04.276Z,1397415904.276 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:04.762Z,1397415904.762 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:05.239Z,1397415905.239 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2014-04-13T19:05:05.632Z,1397415905.632 [NAL9602](IMPORTANT): GPS fix at: 1397415865.00
2014-04-13T19:05:05.665Z,1397415905.665 [DeadReckonUsingMultipleVelocitySources](DEBUG): Got GPS fix: latitudeAccuracy_ = 1.74533e-07, longitudeAccuracy = 1.74533e-07
2014-04-13T19:05:13.754Z,1397415913.754 [NAL9602](INFO): Powering down
2014-04-13T19:05:18.916Z,1397415918.916 [SBIT](IMPORTANT): SBIT PASSED
2014-04-13T19:05:19.333Z,1397415919.333 [MissionManager](IMPORTANT): Started mission Startup
2014-04-13T19:05:19.333Z,1397415919.333 [Startup] Running Loop=1
2014-04-13T19:05:19.334Z,1397415919.334 [Startup](INFO): Aggregate::initialize Startup
2014-04-13T19:05:19.334Z,1397415919.334 [Startup:A.GoToSurface] Running Loop=1
2014-04-13T19:05:19.334Z,1397415919.334 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-04-13T19:05:19.340Z,1397415919.340 [Startup:StartupSatComms] Running Loop=1
2014-04-13T19:05:19.340Z,1397415919.340 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2014-04-13T19:05:19.340Z,1397415919.340 [Startup:StartupSatComms:A] Running Loop=1
2014-04-13T19:05:19.744Z,1397415919.744 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-04-13T19:05:20.134Z,1397415920.134 [NAL9602](INFO): Powering up
2014-04-13T19:05:30.960Z,1397415930.960 [NAL9602](INFO): NAL9602 initialized
2014-04-13T19:06:19.770Z,1397415979.770 [Startup:StartupSatComms:A](INFO): Timed out from 2014-04-13T19:05:19.3Z
2014-04-13T19:06:19.770Z,1397415979.770 [Startup:StartupSatComms:A] Stopped
2014-04-13T19:06:19.770Z,1397415979.770 [Startup:StartupSatComms:B] Running Loop=1
2014-04-13T19:06:20.193Z,1397415980.193 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2014-04-13T19:07:14.414Z,1397416034.414 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout.
2014-04-13T19:07:14.414Z,1397416034.414 [DVL_micro] Data Fault, FailCount= 1
2014-04-13T19:07:14.414Z,1397416034.414 [DVL_micro](ERROR): Data Fault
2014-04-13T19:07:14.451Z,1397416034.451 [CBIT](ERROR): Data Fault in component: DVL_micro
2014-04-13T19:07:14.815Z,1397416034.815 [DVL_micro](INFO): uninitialize:Powering down
2014-04-13T19:07:15.231Z,1397416035.231 [DVL_micro](FAULT): LCB fault:  Software Overcurrent.
2014-04-13T19:07:15.231Z,1397416035.231 [DVL_micro] Hardware Fault, FailCount= 1
2014-04-13T19:07:15.231Z,1397416035.231 [DVL_micro](ERROR): Hardware Fault
2014-04-13T19:07:15.738Z,1397416035.738 [CBIT](INFO): Clearing failed state for component DVL_micro
2014-04-13T19:07:15.738Z,1397416035.738 [DVL_micro] No Fault, FailCount= 1
2014-04-13T19:07:16.094Z,1397416036.094 [DVL_micro](INFO): Initializing
2014-04-13T19:07:19.922Z,1397416039.922 [Startup:StartupSatComms:B](INFO): Timed out from 2014-04-13T19:06:19.8Z
2014-04-13T19:07:19.922Z,1397416039.922 [Startup:StartupSatComms:B] Stopped
2014-04-13T19:07:19.922Z,1397416039.922 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2014-04-13T19:07:19.922Z,1397416039.922 [Startup:StartupSatComms] Stopped
2014-04-13T19:07:19.923Z,1397416039.923 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2014-04-13T19:07:19.923Z,1397416039.923 [Startup](INFO): Completed Startup
2014-04-13T19:07:19.924Z,1397416039.924 [Startup] Stopped
2014-04-13T19:07:19.924Z,1397416039.924 [Startup](INFO): Aggregate::uninitialize Startup
2014-04-13T19:07:19.924Z,1397416039.924 [Startup:A.GoToSurface] Stopped
2014-04-13T19:07:19.924Z,1397416039.924 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-04-13T19:07:20.332Z,1397416040.332 [MissionManager](IMPORTANT): Started mission Default
2014-04-13T19:07:20.332Z,1397416040.332 [Default] Running Loop=1
2014-04-13T19:07:20.332Z,1397416040.332 [Default](INFO): Aggregate::initialize Default
2014-04-13T19:07:20.332Z,1397416040.332 [Default:Iridium] Running Loop=1
2014-04-13T19:07:20.333Z,1397416040.333 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-04-13T19:07:20.333Z,1397416040.333 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-04-13T19:07:20.333Z,1397416040.333 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-04-13T19:07:20.333Z,1397416040.333 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-04-13T19:07:20.333Z,1397416040.333 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-04-13T19:07:20.334Z,1397416040.334 [Default:CallIridium] Running Loop=1
2014-04-13T19:07:20.334Z,1397416040.334 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-04-13T19:07:20.334Z,1397416040.334 [Default:CallIridium:A] Running Loop=1
2014-04-13T19:07:20.336Z,1397416040.336 [Default:CallIridium:A] Stopped
2014-04-13T19:07:20.336Z,1397416040.336 [Default:CallIridium:B] Running Loop=1
2014-04-13T19:07:20.336Z,1397416040.336 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-04-13T19:07:20.342Z,1397416040.342 [Default:Iridium:B.GoToSurface] Stopped
2014-04-13T19:07:20.342Z,1397416040.342 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-04-13T19:07:20.342Z,1397416040.342 [Default:Iridium:Read_Iridium] Running Loop=1
2014-04-13T19:07:20.342Z,1397416040.342 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-04-13T19:07:20.348Z,1397416040.348 [Default:GPS] Running Loop=1
2014-04-13T19:07:20.348Z,1397416040.348 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-04-13T19:07:20.348Z,1397416040.348 [Default:GPS:A.SetSpeed] Running Loop=1
2014-04-13T19:07:20.348Z,1397416040.348 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-04-13T19:07:20.348Z,1397416040.348 [Default:GPS:B.GoToSurface] Running Loop=1
2014-04-13T19:07:20.348Z,1397416040.348 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-04-13T19:07:20.354Z,1397416040.354 [Default:GPS:B.GoToSurface] Stopped
2014-04-13T19:07:20.354Z,1397416040.354 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-04-13T19:07:20.354Z,1397416040.354 [Default:GPS:Read_GPS] Running Loop=1
2014-04-13T19:07:20.354Z,1397416040.354 [Default:GPS:A.SetSpeed] Running Loop=1
2014-04-13T19:07:20.837Z,1397416040.837 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2014-04-13T19:07:20.840Z,1397416040.840 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-04-13T19:07:36.914Z,1397416056.914 [NAL9602](INFO): SBD MO Status=0, MOMSN=25487, MT Status=0, MTMSN=0
2014-04-13T19:07:36.914Z,1397416056.914 [NAL9602](INFO): No messages in MT queue
2014-04-13T19:07:38.328Z,1397416058.328 [NAL9602](IMPORTANT): GPS fix at: 1397416018.00
2014-04-13T19:07:38.345Z,1397416058.345 [DeadReckonUsingMultipleVelocitySources](DEBUG): Got GPS fix: latitudeAccuracy_ = 1.74533e-07, longitudeAccuracy = 1.74533e-07
2014-04-13T19:07:38.348Z,1397416058.348 [Default:GPS:Read_GPS] Stopped
2014-04-13T19:07:38.348Z,1397416058.348 [Default:GPS:D] Running Loop=1
2014-04-13T19:07:38.797Z,1397416058.797 [Default:GPS:D] Stopped
2014-04-13T19:07:38.797Z,1397416058.797 [Default:GPS](INFO): Completed Default:GPS
2014-04-13T19:07:38.797Z,1397416058.797 [Default:GPS] Stopped
2014-04-13T19:07:38.798Z,1397416058.798 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-04-13T19:07:38.798Z,1397416058.798 [Default:GPS:A.SetSpeed] Stopped
2014-04-13T19:07:38.798Z,1397416058.798 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-04-13T19:08:07.858Z,1397416087.858 [NAL9602](INFO): SBD MO Status=1, MOMSN=25488, MT Status=0, MTMSN=0
2014-04-13T19:08:07.903Z,1397416087.903 [NAL9602](INFO): Sent 111 bytes from file Logs/20140413T163946/Courier0068.lzma
2014-04-13T19:08:07.904Z,1397416087.904 [NAL9602](INFO): Packets left to send: 0
2014-04-13T19:08:07.906Z,1397416087.906 [NAL9602](INFO): Stored copy of sent data in Logs/20140413T163946/Courier0068.lzma.parts/0000.sbd
2014-04-13T19:08:07.906Z,1397416087.906 [NAL9602](INFO): Completed sending Logs/20140413T163946/Courier0068.lzma
2014-04-13T19:08:25.093Z,1397416105.093 [NAL9602](INFO): SBD MO Status=1, MOMSN=25489, MT Status=0, MTMSN=0
2014-04-13T19:08:25.142Z,1397416105.142 [NAL9602](INFO): Sent 294 bytes from file Logs/20140413T190355/Courier0000.lzma
2014-04-13T19:08:25.142Z,1397416105.142 [NAL9602](INFO): Packets left to send: 0
2014-04-13T19:08:25.144Z,1397416105.144 [NAL9602](INFO): Stored copy of sent data in Logs/20140413T190355/Courier0000.lzma.parts/0000.sbd
2014-04-13T19:08:25.144Z,1397416105.144 [NAL9602](INFO): Completed sending Logs/20140413T190355/Courier0000.lzma
2014-04-13T19:08:46.302Z,1397416126.302 [NAL9602](INFO): SBD MO Status=1, MOMSN=25490, MT Status=0, MTMSN=0
2014-04-13T19:08:46.351Z,1397416126.351 [NAL9602](INFO): Sent 45 bytes from file Logs/20140413T190355/Courier0004.lzma
2014-04-13T19:08:46.352Z,1397416126.352 [NAL9602](INFO): Packets left to send: 0
2014-04-13T19:08:46.353Z,1397416126.353 [NAL9602](INFO): Stored copy of sent data in Logs/20140413T190355/Courier0004.lzma.parts/0000.sbd
2014-04-13T19:08:46.354Z,1397416126.354 [NAL9602](INFO): Completed sending Logs/20140413T190355/Courier0004.lzma
2014-04-13T19:09:09.907Z,1397416149.907 [NAL9602](INFO): SBD MO Status=2, MOMSN=25491, MT Status=2, MTMSN=0
2014-04-13T19:09:09.908Z,1397416149.908 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2014-04-13T19:09:38.683Z,1397416178.683 [NAL9602](INFO): SBD MO Status=1, MOMSN=25491, MT Status=0, MTMSN=0
2014-04-13T19:09:38.744Z,1397416178.744 [NAL9602](INFO): Sent 207 bytes from file Logs/20140413T163946/Express0065.lzma
2014-04-13T19:09:38.744Z,1397416178.744 [NAL9602](INFO): Packets left to send: 0
2014-04-13T19:09:38.746Z,1397416178.746 [NAL9602](INFO): Stored copy of sent data in Logs/20140413T163946/Express0065.lzma.parts/0000.sbd
2014-04-13T19:09:38.746Z,1397416178.746 [NAL9602](INFO): Completed sending Logs/20140413T163946/Express0065.lzma
2014-04-13T19:09:52.187Z,1397416192.187 [NAL9602](INFO): SBD MO Status=1, MOMSN=25492, MT Status=0, MTMSN=0
2014-04-13T19:09:52.245Z,1397416192.245 [NAL9602](INFO): Sent 332 bytes from file Logs/20140413T163946/Express0069.lzma
2014-04-13T19:09:52.245Z,1397416192.245 [NAL9602](INFO): Packets left to send: 1
2014-04-13T19:09:52.247Z,1397416192.247 [NAL9602](INFO): Stored copy of sent data in Logs/20140413T163946/Express0069.lzma.parts/0001.sbd
2014-04-13T19:10:04.526Z,1397416204.526 [CommandLine](IMPORTANT): got command restart application
2014-04-13T19:10:05.133Z,1397416205.133 [NAL9602](INFO): SBD MO Status=1, MOMSN=25493, MT Status=0, MTMSN=0
2014-04-13T19:10:05.181Z,1397416205.181 [NAL9602](INFO): Sent 123 bytes from file Logs/20140413T163946/Express0069.lzma
2014-04-13T19:10:05.181Z,1397416205.181 [NAL9602](INFO): Packets left to send: 0
2014-04-13T19:10:05.183Z,1397416205.183 [NAL9602](INFO): Stored copy of sent data in Logs/20140413T163946/Express0069.lzma.parts/0000.sbd
2014-04-13T19:10:05.183Z,1397416205.183 [NAL9602](INFO): Completed sending Logs/20140413T163946/Express0069.lzma
2014-04-13T19:10:05.711Z,1397416205.711 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2014-04-13T19:10:05.712Z,1397416205.712 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2014-04-13T19:10:06.126Z,1397416206.126 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2014-04-13T19:10:06.371Z,1397416206.371 [WetLabsBB2FL](INFO): Powering down
2014-04-13T19:10:06.379Z,1397416206.379 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2014-04-13T19:10:06.764Z,1397416206.764 [CTD_NeilBrown](INFO): Powering down
2014-04-13T19:10:06.783Z,1397416206.783 [ComponentRegistry](INFO): Shutting down AsyncPiEstimator ThreadHandler
2014-04-13T19:10:06.844Z,1397416206.844 [AsyncPiEstimator](DEBUG): Uninitialize AsyncPiEstimator.
2014-04-13T19:10:06.847Z,1397416206.847 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2014-04-13T19:10:06.900Z,1397416206.900 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2014-04-13T19:10:06.900Z,1397416206.900 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2014-04-13T19:10:08.955Z,1397416208.955 [controlThread](DEBUG): Uninitializing ControlThread
2014-04-13T19:10:08.955Z,1397416208.955 [AHRS_sp3003D](INFO): Powering down
2014-04-13T19:10:08.956Z,1397416208.956 [DVL_micro](INFO): uninitialize:Powering down
2014-04-13T19:10:08.957Z,1397416208.957 [NAL9602](INFO): Powering down
2014-04-13T19:10:08.971Z,1397416208.971 [Radio_Freewave](INFO): Powering down
2014-04-13T19:10:08.973Z,1397416208.973 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-04-13T19:10:08.975Z,1397416208.975 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2014-04-13T19:10:08.975Z,1397416208.975 [Default] Stopped
2014-04-13T19:10:08.975Z,1397416208.975 [Default](INFO): Aggregate::uninitialize Default
2014-04-13T19:10:08.976Z,1397416208.976 [Default:Iridium] Stopped
2014-04-13T19:10:08.976Z,1397416208.976 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-04-13T19:10:08.976Z,1397416208.976 [Default:Iridium:A.SetSpeed] Stopped
2014-04-13T19:10:08.976Z,1397416208.976 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-04-13T19:10:08.976Z,1397416208.976 [Default:Iridium:Read_Iridium] Stopped
2014-04-13T19:10:08.976Z,1397416208.976 [Default:CallIridium] Stopped
2014-04-13T19:10:08.976Z,1397416208.976 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-04-13T19:10:08.977Z,1397416208.977 [Default:CallIridium:B] Stopped
2014-04-13T19:10:08.977Z,1397416208.977 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-04-13T19:10:08.992Z,1397416208.992 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2014-04-13T19:10:08.992Z,1397416208.992 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2014-04-13T19:10:08.992Z,1397416208.992 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2014-04-13T19:10:08.993Z,1397416208.993 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2014-04-13T19:10:08.993Z,1397416208.993 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2014-04-13T19:10:08.993Z,1397416208.993 [BuoyancyServo](INFO): Powering down
2014-04-13T19:10:09.007Z,1397416209.007 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2014-04-13T19:10:09.007Z,1397416209.007 [ElevatorServo](INFO): Powering down
2014-04-13T19:10:09.008Z,1397416209.008 [MassServo](DEBUG): Uninitialize Mass Servo.
2014-04-13T19:10:09.009Z,1397416209.009 [MassServo](INFO): Powering down
2014-04-13T19:10:09.010Z,1397416209.010 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2014-04-13T19:10:09.010Z,1397416209.010 [RudderServo](INFO): Powering down
2014-04-13T19:10:09.011Z,1397416209.011 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2014-04-13T19:10:09.011Z,1397416209.011 [ThrusterServo](INFO): Powering down
2014-04-13T19:10:09.012Z,1397416209.012 [SBIT](DEBUG): Uninitialize SBIT Component.
2014-04-13T19:10:09.012Z,1397416209.012 [IBIT](DEBUG): Uninitialize IBIT Component.
2014-04-13T19:10:09.013Z,1397416209.013 [CBIT](DEBUG): Uninitialize CBIT Component.