2014-05-08T12:34:53.493Z,1399552493.493 [Supervisor](DEBUG): Initializing supervisor.
2014-05-08T12:34:53.496Z,1399552493.496 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2014-05-08T12:34:53.496Z,1399552493.496 [SyncHandler](INFO): Protected caller Thread ID is 776
2014-05-08T12:34:53.497Z,1399552493.497 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2014-05-08T12:34:53.500Z,1399552493.500 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2014-05-08T12:34:53.500Z,1399552493.500 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 777
2014-05-08T12:34:53.503Z,1399552493.503 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2014-05-08T12:34:53.516Z,1399552493.516 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2014-05-08T12:34:53.520Z,1399552493.520 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2014-05-08T12:34:53.520Z,1399552493.520 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 778
2014-05-08T12:34:53.521Z,1399552493.521 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2014-05-08T12:34:53.524Z,1399552493.524 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2014-05-08T12:34:53.524Z,1399552493.524 [logger ThreadHandler](INFO): Protected caller Thread ID is 779
2014-05-08T12:34:53.527Z,1399552493.527 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2014-05-08T12:34:53.527Z,1399552493.527 [Supervisor](INFO): Looking for Config files in directory: Config/
2014-05-08T12:34:53.532Z,1399552493.532 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2014-05-08T12:34:53.956Z,1399552493.956 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2014-05-08T12:34:53.957Z,1399552493.957 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2014-05-08T12:34:54.276Z,1399552494.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2014-05-08T12:34:54.277Z,1399552494.277 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2014-05-08T12:34:54.372Z,1399552494.372 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2014-05-08T12:34:54.373Z,1399552494.373 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2014-05-08T12:34:54.595Z,1399552494.595 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2014-05-08T12:34:54.595Z,1399552494.595 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2014-05-08T12:34:54.774Z,1399552494.774 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2014-05-08T12:34:54.776Z,1399552494.776 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2014-05-08T12:34:55.123Z,1399552495.123 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2014-05-08T12:34:55.124Z,1399552495.124 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2014-05-08T12:34:55.324Z,1399552495.324 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2014-05-08T12:34:55.326Z,1399552495.326 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2014-05-08T12:34:55.721Z,1399552495.721 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2014-05-08T12:34:55.723Z,1399552495.723 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2014-05-08T12:34:55.848Z,1399552495.848 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2014-05-08T12:34:55.850Z,1399552495.850 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2014-05-08T12:34:56.425Z,1399552496.425 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2014-05-08T12:34:56.426Z,1399552496.426 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2014-05-08T12:34:56.648Z,1399552496.648 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2014-05-08T12:34:56.652Z,1399552496.652 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2014-05-08T12:34:56.749Z,1399552496.749 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2014-05-08T12:34:56.868Z,1399552496.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2014-05-08T12:34:56.869Z,1399552496.869 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2014-05-08T12:34:56.982Z,1399552496.982 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2014-05-08T12:34:56.983Z,1399552496.983 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2014-05-08T12:34:57.139Z,1399552497.139 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2014-05-08T12:34:57.141Z,1399552497.141 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2014-05-08T12:34:57.145Z,1399552497.145 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2014-05-08T12:34:57.269Z,1399552497.269 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2014-05-08T12:34:57.414Z,1399552497.414 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2014-05-08T12:34:57.519Z,1399552497.519 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2014-05-08T12:34:57.624Z,1399552497.624 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2014-05-08T12:34:57.796Z,1399552497.796 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2014-05-08T12:34:57.928Z,1399552497.928 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2014-05-08T12:34:58.023Z,1399552498.023 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2014-05-08T12:34:58.137Z,1399552498.137 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2014-05-08T12:34:58.249Z,1399552498.249 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2014-05-08T12:34:58.357Z,1399552498.357 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2014-05-08T12:34:58.457Z,1399552498.457 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Estimation.cfg
2014-05-08T12:34:58.565Z,1399552498.565 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2014-05-08T12:34:58.570Z,1399552498.570 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2014-05-08T12:34:59.236Z,1399552499.236 [AHRS_sp3003D] Loaded
2014-05-08T12:34:59.236Z,1399552499.236 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2014-05-08T12:34:59.607Z,1399552499.607 [Batt_Ocean_Server] Loaded
2014-05-08T12:34:59.607Z,1399552499.607 [ComponentRegistry](DEBUG): SyncComponent "Batt_Ocean_Server" handled in the control thread.
2014-05-08T12:34:59.791Z,1399552499.791 [DataOverHttps] Loaded
2014-05-08T12:34:59.791Z,1399552499.791 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2014-05-08T12:34:59.806Z,1399552499.806 [Depth_Keller] Loaded
2014-05-08T12:34:59.806Z,1399552499.806 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2014-05-08T12:34:59.816Z,1399552499.816 [DropWeight] Loaded
2014-05-08T12:34:59.816Z,1399552499.816 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2014-05-08T12:34:59.938Z,1399552499.938 [NAL9602] Loaded
2014-05-08T12:34:59.938Z,1399552499.938 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2014-05-08T12:35:00.005Z,1399552500.005 [Onboard] Loaded
2014-05-08T12:35:00.005Z,1399552500.005 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2014-05-08T12:35:00.013Z,1399552500.013 [Radio_Freewave] Loaded
2014-05-08T12:35:00.013Z,1399552500.013 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2014-05-08T12:35:00.014Z,1399552500.014 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2014-05-08T12:35:00.015Z,1399552500.015 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2014-05-08T12:35:00.397Z,1399552500.397 [ExternalSim] Loaded
2014-05-08T12:35:00.398Z,1399552500.398 [ComponentRegistry](DEBUG): SyncComponent "ExternalSim" handled in the control thread.
2014-05-08T12:35:00.467Z,1399552500.467 [InternalSim] Loaded
2014-05-08T12:35:00.467Z,1399552500.467 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2014-05-08T12:35:00.468Z,1399552500.468 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2014-05-08T12:35:00.470Z,1399552500.470 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2014-05-08T12:35:00.839Z,1399552500.839 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2014-05-08T12:35:00.843Z,1399552500.843 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2014-05-08T12:35:00.852Z,1399552500.852 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2014-05-08T12:35:00.858Z,1399552500.858 [AsyncPiEstimator] Loaded
2014-05-08T12:35:00.858Z,1399552500.858 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2014-05-08T12:35:00.863Z,1399552500.863 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406B34E0
2014-05-08T12:35:00.864Z,1399552500.864 [AsyncPiEstimator ThreadHandler](INFO): Protected caller Thread ID is 861
2014-05-08T12:35:00.864Z,1399552500.864 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2014-05-08T12:35:00.866Z,1399552500.866 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2014-05-08T12:35:00.990Z,1399552500.990 [DeadReckonUsingMultipleVelocitySources] Loaded
2014-05-08T12:35:00.990Z,1399552500.990 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2014-05-08T12:35:01.009Z,1399552501.009 [NavChart] Loaded
2014-05-08T12:35:01.010Z,1399552501.010 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2014-05-08T12:35:01.014Z,1399552501.014 [UniversalFixResidualReporter] Loaded
2014-05-08T12:35:01.014Z,1399552501.014 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2014-05-08T12:35:01.015Z,1399552501.015 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2014-05-08T12:35:01.017Z,1399552501.017 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2014-05-08T12:35:01.100Z,1399552501.100 [VerticalControl](DEBUG): Construct VerticalControl.
2014-05-08T12:35:01.235Z,1399552501.235 [VerticalControl] Loaded
2014-05-08T12:35:01.235Z,1399552501.235 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2014-05-08T12:35:01.236Z,1399552501.236 [HorizontalControl](DEBUG): Construct HorizontalControl.
2014-05-08T12:35:01.325Z,1399552501.325 [HorizontalControl] Loaded
2014-05-08T12:35:01.325Z,1399552501.325 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2014-05-08T12:35:01.326Z,1399552501.326 [SpeedControl](DEBUG): Construct SpeedControl.
2014-05-08T12:35:01.328Z,1399552501.328 [SpeedControl] Loaded
2014-05-08T12:35:01.328Z,1399552501.328 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2014-05-08T12:35:01.329Z,1399552501.329 [LoopControl](DEBUG): Construct LoopControl.
2014-05-08T12:35:01.330Z,1399552501.330 [LoopControl] Loaded
2014-05-08T12:35:01.330Z,1399552501.330 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2014-05-08T12:35:01.330Z,1399552501.330 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2014-05-08T12:35:01.333Z,1399552501.333 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2014-05-08T12:35:01.371Z,1399552501.371 [DepthRateCalculator] Loaded
2014-05-08T12:35:01.371Z,1399552501.371 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2014-05-08T12:35:01.377Z,1399552501.377 [PitchRateCalculator] Loaded
2014-05-08T12:35:01.377Z,1399552501.377 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2014-05-08T12:35:01.385Z,1399552501.385 [SpeedCalculator] Loaded
2014-05-08T12:35:01.386Z,1399552501.386 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2014-05-08T12:35:01.404Z,1399552501.404 [TempGradientCalculator] Loaded
2014-05-08T12:35:01.404Z,1399552501.404 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2014-05-08T12:35:01.411Z,1399552501.411 [YawRateCalculator] Loaded
2014-05-08T12:35:01.411Z,1399552501.411 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2014-05-08T12:35:01.411Z,1399552501.411 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2014-05-08T12:35:01.412Z,1399552501.412 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2014-05-08T12:35:01.579Z,1399552501.579 [CTD_NeilBrown] Loaded
2014-05-08T12:35:01.579Z,1399552501.579 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2014-05-08T12:35:01.581Z,1399552501.581 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 407554E0
2014-05-08T12:35:01.581Z,1399552501.581 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 862
2014-05-08T12:35:01.600Z,1399552501.600 [ISUS] Loaded
2014-05-08T12:35:01.600Z,1399552501.600 [ComponentRegistry](DEBUG): SyncComponent "ISUS" handled in the control thread.
2014-05-08T12:35:01.617Z,1399552501.617 [PAR_Licor] Loaded
2014-05-08T12:35:01.618Z,1399552501.618 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2014-05-08T12:35:01.663Z,1399552501.663 [WetLabsBB2FL] Loaded
2014-05-08T12:35:01.663Z,1399552501.663 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2014-05-08T12:35:01.665Z,1399552501.665 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407854E0
2014-05-08T12:35:01.665Z,1399552501.665 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 863
2014-05-08T12:35:01.665Z,1399552501.665 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2014-05-08T12:35:01.674Z,1399552501.674 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2014-05-08T12:35:01.831Z,1399552501.831 [SBIT](DEBUG): Construct Startup Built In Test.
2014-05-08T12:35:01.848Z,1399552501.848 [SBIT] Loaded
2014-05-08T12:35:01.848Z,1399552501.848 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2014-05-08T12:35:01.849Z,1399552501.849 [IBIT](DEBUG): Construct Initiated Built In Test.
2014-05-08T12:35:01.862Z,1399552501.862 [IBIT] Loaded
2014-05-08T12:35:01.862Z,1399552501.862 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2014-05-08T12:35:01.865Z,1399552501.865 [CBIT](DEBUG): Construct CBIT Built In Test.
2014-05-08T12:35:01.950Z,1399552501.950 [CBIT] Loaded
2014-05-08T12:35:01.950Z,1399552501.950 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2014-05-08T12:35:01.951Z,1399552501.951 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2014-05-08T12:35:01.952Z,1399552501.952 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2014-05-08T12:35:02.031Z,1399552502.031 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2014-05-08T12:35:02.032Z,1399552502.032 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2014-05-08T12:35:02.179Z,1399552502.179 [BuoyancyServo] Loaded
2014-05-08T12:35:02.179Z,1399552502.179 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2014-05-08T12:35:02.188Z,1399552502.188 [ElevatorServo] Loaded
2014-05-08T12:35:02.189Z,1399552502.189 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2014-05-08T12:35:02.197Z,1399552502.197 [MassServo] Loaded
2014-05-08T12:35:02.198Z,1399552502.198 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2014-05-08T12:35:02.207Z,1399552502.207 [RudderServo] Loaded
2014-05-08T12:35:02.207Z,1399552502.207 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2014-05-08T12:35:02.220Z,1399552502.220 [ThrusterServo] Loaded
2014-05-08T12:35:02.220Z,1399552502.220 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2014-05-08T12:35:02.220Z,1399552502.220 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2014-05-08T12:35:02.221Z,1399552502.221 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2014-05-08T12:35:02.267Z,1399552502.267 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2014-05-08T12:35:02.269Z,1399552502.269 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2014-05-08T12:35:02.270Z,1399552502.270 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2014-05-08T12:35:02.277Z,1399552502.277 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2014-05-08T12:35:02.281Z,1399552502.281 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408544E0
2014-05-08T12:35:02.282Z,1399552502.282 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 864
2014-05-08T12:35:02.287Z,1399552502.287 [Supervisor](INFO): Main Thread ID is 766
2014-05-08T12:35:02.287Z,1399552502.287 [Supervisor](DEBUG): Running supervisor.
2014-05-08T12:35:02.288Z,1399552502.288 [CommandLine ThreadHandler](INFO): Handler Thread ID is 865
2014-05-08T12:35:02.294Z,1399552502.294 [controlThread ThreadHandler](INFO): Handler Thread ID is 866
2014-05-08T12:35:02.294Z,1399552502.294 [controlThread](DEBUG): Initializing ControlThread
2014-05-08T12:35:02.298Z,1399552502.298 [logger ThreadHandler](INFO): Handler Thread ID is 867
2014-05-08T12:35:02.334Z,1399552502.334 [AsyncPiEstimator ThreadHandler](INFO): Handler Thread ID is 868
2014-05-08T12:35:02.334Z,1399552502.334 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2014-05-08T12:35:02.358Z,1399552502.358 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 869
2014-05-08T12:35:02.359Z,1399552502.359 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2014-05-08T12:35:02.386Z,1399552502.386 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 870
2014-05-08T12:35:02.398Z,1399552502.398 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 871
2014-05-08T12:35:02.409Z,1399552502.409 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2014-05-08T12:35:02.412Z,1399552502.412 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2014-05-08T12:35:02.412Z,1399552502.412 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2014-05-08T12:35:02.412Z,1399552502.412 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2014-05-08T12:35:02.412Z,1399552502.412 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2014-05-08T12:35:02.413Z,1399552502.413 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2014-05-08T12:35:02.413Z,1399552502.413 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2014-05-08T12:35:02.413Z,1399552502.413 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2014-05-08T12:35:02.414Z,1399552502.414 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2014-05-08T12:35:02.767Z,1399552502.767 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.000000 psu
2014-05-08T12:35:03.829Z,1399552503.829 [Batt_Ocean_Server](INFO): Ocean Server Batteries initialized
2014-05-08T12:35:03.856Z,1399552503.856 [ExternalSim](INFO): ExternalSim initializing...
2014-05-08T12:35:04.124Z,1399552504.124 [ExternalSim](DEBUG): beaconLat = 36.81340
2014-05-08T12:35:04.124Z,1399552504.124 [ExternalSim](DEBUG): beaconLon = -121.82240
2014-05-08T12:35:04.144Z,1399552504.144 [ExternalSim](DEBUG): beaconDepth = 25.00
2014-05-08T12:35:04.297Z,1399552504.297 [ExternalSim](DEBUG): Simulator initialized
2014-05-08T12:35:04.549Z,1399552504.549 [InternalSim](DEBUG):  InternalSim initializing...
2014-05-08T12:35:04.644Z,1399552504.644 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-05-08T12:35:04.645Z,1399552504.645 [NavChart](DEBUG): Initialize NavChart Navigation.
2014-05-08T12:35:04.645Z,1399552504.645 [UniversalFixResidualReporter](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2014-05-08T12:35:04.645Z,1399552504.645 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2014-05-08T12:35:04.647Z,1399552504.647 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2014-05-08T12:35:04.648Z,1399552504.648 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2014-05-08T12:35:04.648Z,1399552504.648 [LoopControl](DEBUG): Initialize LoopControlComponent.
2014-05-08T12:35:04.649Z,1399552504.649 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-05-08T12:35:04.649Z,1399552504.649 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2014-05-08T12:35:04.650Z,1399552504.650 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2014-05-08T12:35:04.650Z,1399552504.650 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2014-05-08T12:35:04.651Z,1399552504.651 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2014-05-08T12:35:04.652Z,1399552504.652 [SBIT](INFO): Initialize SBIT Component.
2014-05-08T12:35:04.652Z,1399552504.652 [SBIT](IMPORTANT): Tethys CM Info: 
$Rev:11272
2014-05-08T12:35:04.653Z,1399552504.653 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2014-05-08T12:35:04.653Z,1399552504.653 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2014-05-08T12:35:04.673Z,1399552504.673 [IBIT](INFO): Initialize IBIT Component.
2014-05-08T12:35:04.674Z,1399552504.674 [CBIT](DEBUG): Initialize CBIT Component.
2014-05-08T12:35:04.674Z,1399552504.674 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2014-05-08T12:35:04.674Z,1399552504.674 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2014-05-08T12:35:04.699Z,1399552504.699 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2014-05-08T12:35:04.724Z,1399552504.724 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2014-05-08T12:35:04.748Z,1399552504.748 [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-05-08T12:35:04.749Z,1399552504.749 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2014-05-08T12:35:04.831Z,1399552504.831 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2014-05-08T12:35:04.849Z,1399552504.849 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2014-05-08T12:35:04.853Z,1399552504.853 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-05-08T12:35:04.877Z,1399552504.877 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2014-05-08T12:35:04.880Z,1399552504.880 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-05-08T12:35:04.915Z,1399552504.915 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2014-05-08T12:35:04.945Z,1399552504.945 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed](DEBUG): Construct.
2014-05-08T12:35:04.948Z,1399552504.948 [Default:WaitAtTheSurface:B.GoToSurface](DEBUG): Construct GoToSurface.
2014-05-08T12:35:04.975Z,1399552504.975 [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-05-08T12:35:04.986Z,1399552504.986 [controlThread](DEBUG): Component order: CycleStarter,ExternalSim,InternalSim,AHRS_sp3003D,Batt_Ocean_Server,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,Radio_Freewave,ISUS,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2014-05-08T12:35:05.411Z,1399552505.411 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-05-08T12:35:05.419Z,1399552505.419 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-05-08T12:35:05.433Z,1399552505.433 [ElevatorServo](DEBUG): Initializing EZServoServo.
2014-05-08T12:35:05.439Z,1399552505.439 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2014-05-08T12:35:05.459Z,1399552505.459 [MassServo](DEBUG): Initializing EZServoServo.
2014-05-08T12:35:05.471Z,1399552505.471 [MassServo](DEBUG): Initializing MassServo.
2014-05-08T12:35:05.476Z,1399552505.476 [RudderServo](DEBUG): Initializing EZServoServo.
2014-05-08T12:35:05.483Z,1399552505.483 [RudderServo](DEBUG): Initializing RudderServo.
2014-05-08T12:35:05.496Z,1399552505.496 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2014-05-08T12:35:05.524Z,1399552505.524 [CommandLine](FAULT): Scheduling is paused
2014-05-08T12:35:06.054Z,1399552506.054 [Radio_Freewave](INFO): Powering up
2014-05-08T12:35:06.404Z,1399552506.404 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2014-05-08T12:35:06.404Z,1399552506.404 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2014-05-08T12:35:06.404Z,1399552506.404 [BuoyancyServo] Communications Fault, FailCount= 1
2014-05-08T12:35:06.404Z,1399552506.404 [BuoyancyServo](ERROR): Communications Fault
2014-05-08T12:35:06.507Z,1399552506.507 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2014-05-08T12:35:08.090Z,1399552508.090 [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-05-08T12:35:09.643Z,1399552509.643 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2014-05-08T12:35:09.643Z,1399552509.643 [BuoyancyServo](INFO): Powering down
2014-05-08T12:35:10.889Z,1399552510.889 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003406
2014-05-08T12:35:11.820Z,1399552511.820 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2014-05-08T12:35:11.820Z,1399552511.820 [BuoyancyServo] No Fault, FailCount= 1
2014-05-08T12:35:12.193Z,1399552512.193 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2014-05-08T12:35:12.193Z,1399552512.193 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2014-05-08T12:35:13.335Z,1399552513.335 [NAL9602](IMPORTANT): GPS fix at: 1399552513.33
2014-05-08T12:35:14.525Z,1399552514.525 [NAL9602](INFO): No messages in MT queue
2014-05-08T12:35:20.167Z,1399552520.167 [NAL9602](INFO): Powering down
2014-05-08T12:35:20.365Z,1399552520.365 [SBIT](IMPORTANT): Beginning Startup BIT
2014-05-08T12:35:20.367Z,1399552520.367 [CBIT](IMPORTANT): Beginning GF scan
2014-05-08T12:35:46.675Z,1399552546.675 [CBIT](IMPORTANT): No ground fault detected
2014-05-08T12:36:14.147Z,1399552574.147 [SBIT](IMPORTANT): SBIT PASSED
2014-05-08T12:36:14.507Z,1399552574.507 [MissionManager](IMPORTANT): Started mission Startup
2014-05-08T12:36:14.507Z,1399552574.507 [Startup] Running Loop=1
2014-05-08T12:36:14.507Z,1399552574.507 [Startup](INFO): Aggregate::initialize Startup
2014-05-08T12:36:14.507Z,1399552574.507 [Startup:A.GoToSurface] Running Loop=1
2014-05-08T12:36:14.507Z,1399552574.507 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:36:14.514Z,1399552574.514 [Startup:StartupSatComms] Running Loop=1
2014-05-08T12:36:14.514Z,1399552574.514 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2014-05-08T12:36:14.515Z,1399552574.515 [Startup:StartupSatComms:A] Running Loop=1
2014-05-08T12:36:14.907Z,1399552574.907 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-05-08T12:36:15.280Z,1399552575.280 [NAL9602](INFO): Powering up
2014-05-08T12:36:20.551Z,1399552580.551 [NAL9602](IMPORTANT): GPS fix at: 1399552580.55
2014-05-08T12:36:20.566Z,1399552580.566 [Startup:StartupSatComms:A] Stopped
2014-05-08T12:36:20.566Z,1399552580.566 [Startup:StartupSatComms:B] Running Loop=1
2014-05-08T12:36:20.914Z,1399552580.914 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2014-05-08T12:36:21.684Z,1399552581.684 [NAL9602](INFO): No messages in MT queue
2014-05-08T12:36:22.951Z,1399552582.951 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20140507T153512/Courier0168.lzma
2014-05-08T12:36:23.657Z,1399552583.657 [DataOverHttps](INFO): Moved sent file to Logs/20140507T153512/Courier0168.lzma.bak
2014-05-08T12:36:23.657Z,1399552583.657 [DataOverHttps](INFO): SBD MOMSN=811660
2014-05-08T12:36:28.171Z,1399552588.171 [NAL9602](INFO): Powering down
2014-05-08T12:36:36.372Z,1399552596.372 [DataOverHttps](INFO): Sending 357 bytes from file Logs/20140508T123453/Courier0000.lzma
2014-05-08T12:36:37.094Z,1399552597.094 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0000.lzma.bak
2014-05-08T12:36:37.094Z,1399552597.094 [DataOverHttps](INFO): SBD MOMSN=811662
2014-05-08T12:36:41.532Z,1399552601.532 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20140507T153512/Express0169.lzma
2014-05-08T12:36:42.375Z,1399552602.375 [DataOverHttps](INFO): Moved sent file to Logs/20140507T153512/Express0169.lzma.bak
2014-05-08T12:36:42.376Z,1399552602.376 [DataOverHttps](INFO): SBD MOMSN=811666
2014-05-08T12:36:54.564Z,1399552614.564 [DataOverHttps](INFO): Sending 849 bytes from file Logs/20140508T123453/Express0001.lzma
2014-05-08T12:36:55.415Z,1399552615.415 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0001.lzma.bak
2014-05-08T12:36:55.415Z,1399552615.415 [DataOverHttps](INFO): SBD MOMSN=811668
2014-05-08T12:36:55.803Z,1399552615.803 [Startup:StartupSatComms:B] Stopped
2014-05-08T12:36:55.803Z,1399552615.803 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2014-05-08T12:36:55.803Z,1399552615.803 [Startup:StartupSatComms] Stopped
2014-05-08T12:36:55.804Z,1399552615.804 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2014-05-08T12:36:55.804Z,1399552615.804 [Startup](INFO): Completed Startup
2014-05-08T12:36:55.804Z,1399552615.804 [Startup] Stopped
2014-05-08T12:36:55.805Z,1399552615.805 [Startup](INFO): Aggregate::uninitialize Startup
2014-05-08T12:36:55.805Z,1399552615.805 [Startup:A.GoToSurface] Stopped
2014-05-08T12:36:55.805Z,1399552615.805 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:36:56.251Z,1399552616.251 [MissionManager](IMPORTANT): Started mission Default
2014-05-08T12:36:56.251Z,1399552616.251 [Default] Running Loop=1
2014-05-08T12:36:56.251Z,1399552616.251 [Default](INFO): Aggregate::initialize Default
2014-05-08T12:36:56.251Z,1399552616.251 [Default:Iridium] Running Loop=1
2014-05-08T12:36:56.252Z,1399552616.252 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T12:36:56.252Z,1399552616.252 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T12:36:56.252Z,1399552616.252 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:36:56.252Z,1399552616.252 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T12:36:56.252Z,1399552616.252 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:36:56.258Z,1399552616.258 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T12:36:56.258Z,1399552616.258 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:36:56.258Z,1399552616.258 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T12:36:56.258Z,1399552616.258 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T12:36:56.264Z,1399552616.264 [Default:GPS] Running Loop=1
2014-05-08T12:36:56.264Z,1399552616.264 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T12:36:56.264Z,1399552616.264 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T12:36:56.264Z,1399552616.264 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:36:56.264Z,1399552616.264 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T12:36:56.264Z,1399552616.264 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:36:56.270Z,1399552616.270 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T12:36:56.270Z,1399552616.270 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:36:56.310Z,1399552616.310 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T12:36:56.310Z,1399552616.310 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T12:36:57.056Z,1399552617.056 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2014-05-08T12:36:57.059Z,1399552617.059 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2014-05-08T12:36:57.375Z,1399552617.375 [NAL9602](INFO): Powering up
2014-05-08T12:36:59.961Z,1399552619.961 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20140508T123453/Courier0004.lzma
2014-05-08T12:37:00.755Z,1399552620.755 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0004.lzma.bak
2014-05-08T12:37:00.755Z,1399552620.755 [DataOverHttps](INFO): SBD MOMSN=811685
2014-05-08T12:37:02.991Z,1399552622.991 [NAL9602](IMPORTANT): GPS fix at: 1399552622.99
2014-05-08T12:37:03.010Z,1399552623.010 [Default:GPS:Read_GPS] Stopped
2014-05-08T12:37:03.011Z,1399552623.011 [Default:GPS:D] Running Loop=1
2014-05-08T12:37:03.411Z,1399552623.411 [Default:GPS:D] Stopped
2014-05-08T12:37:03.411Z,1399552623.411 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T12:37:03.412Z,1399552623.412 [Default:GPS] Stopped
2014-05-08T12:37:03.412Z,1399552623.412 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T12:37:03.412Z,1399552623.412 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T12:37:03.412Z,1399552623.412 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:37:04.191Z,1399552624.191 [NAL9602](INFO): No messages in MT queue
2014-05-08T12:37:05.241Z,1399552625.241 [DataOverHttps](INFO): Sending 103 bytes from file Logs/20140508T123453/Express0005.lzma
2014-05-08T12:37:05.975Z,1399552625.975 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0005.lzma.bak
2014-05-08T12:37:05.975Z,1399552625.975 [DataOverHttps](INFO): SBD MOMSN=811687
2014-05-08T12:37:06.494Z,1399552626.494 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T12:37:06.494Z,1399552626.494 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T12:37:06.494Z,1399552626.494 [Default:Iridium] Stopped
2014-05-08T12:37:06.494Z,1399552626.494 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T12:37:06.495Z,1399552626.495 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T12:37:06.495Z,1399552626.495 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:37:06.495Z,1399552626.495 [Default:WaitAtTheSurface] Running Loop=1
2014-05-08T12:37:06.495Z,1399552626.495 [Default:WaitAtTheSurface](INFO): Aggregate::initialize Default:WaitAtTheSurface
2014-05-08T12:37:06.495Z,1399552626.495 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed] Running Loop=1
2014-05-08T12:37:06.495Z,1399552626.495 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed](DEBUG): Initialize.
2014-05-08T12:37:06.495Z,1399552626.495 [Default:WaitAtTheSurface:B.GoToSurface] Running Loop=1
2014-05-08T12:37:06.495Z,1399552626.495 [Default:WaitAtTheSurface:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:37:06.817Z,1399552626.817 [Default:WaitAtTheSurface:B.GoToSurface] Running Loop=1
2014-05-08T12:37:06.823Z,1399552626.823 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed] Running Loop=1
2014-05-08T12:37:12.463Z,1399552632.463 [NAL9602](INFO): Powering down
2014-05-08T12:42:06.954Z,1399552926.954 [Default:CallIridium] Running Loop=1
2014-05-08T12:42:06.955Z,1399552926.955 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T12:42:06.955Z,1399552926.955 [Default:CallIridium:A] Running Loop=1
2014-05-08T12:42:06.957Z,1399552926.957 [Default:CallIridium:A] Stopped
2014-05-08T12:42:06.957Z,1399552926.957 [Default:CallIridium:B] Running Loop=1
2014-05-08T12:42:06.957Z,1399552926.957 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T12:42:11.973Z,1399552931.973 [Default:Iridium] Running Loop=1
2014-05-08T12:42:11.973Z,1399552931.973 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T12:42:11.973Z,1399552931.973 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T12:42:11.973Z,1399552931.973 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:42:11.973Z,1399552931.973 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T12:42:11.974Z,1399552931.974 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:42:11.974Z,1399552931.974 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T12:42:11.974Z,1399552931.974 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:42:11.974Z,1399552931.974 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T12:42:11.975Z,1399552931.975 [Default:GPS] Running Loop=1
2014-05-08T12:42:11.975Z,1399552931.975 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T12:42:11.975Z,1399552931.975 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T12:42:11.975Z,1399552931.975 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:42:11.975Z,1399552931.975 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T12:42:11.991Z,1399552931.991 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:42:11.992Z,1399552931.992 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T12:42:11.992Z,1399552931.992 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:42:11.992Z,1399552931.992 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T12:42:12.652Z,1399552932.652 [NAL9602](INFO): Powering up
2014-05-08T12:42:13.929Z,1399552933.929 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0008.lzma
2014-05-08T12:42:14.770Z,1399552934.770 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0008.lzma.bak
2014-05-08T12:42:14.770Z,1399552934.770 [DataOverHttps](INFO): SBD MOMSN=811690
2014-05-08T12:42:18.193Z,1399552938.193 [NAL9602](IMPORTANT): GPS fix at: 1399552938.19
2014-05-08T12:42:18.211Z,1399552938.211 [Default:GPS:Read_GPS] Stopped
2014-05-08T12:42:18.211Z,1399552938.211 [Default:GPS:D] Running Loop=1
2014-05-08T12:42:19.048Z,1399552939.048 [Default:GPS:D] Stopped
2014-05-08T12:42:19.048Z,1399552939.048 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T12:42:19.048Z,1399552939.048 [Default:GPS] Stopped
2014-05-08T12:42:19.049Z,1399552939.049 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T12:42:19.049Z,1399552939.049 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T12:42:19.049Z,1399552939.049 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:42:19.497Z,1399552939.497 [NAL9602](INFO): No messages in MT queue
2014-05-08T12:42:21.699Z,1399552941.699 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20140508T123453/Express0009.lzma
2014-05-08T12:42:22.449Z,1399552942.449 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0009.lzma.bak
2014-05-08T12:42:22.449Z,1399552942.449 [DataOverHttps](INFO): SBD MOMSN=811692
2014-05-08T12:42:22.951Z,1399552942.951 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T12:42:22.951Z,1399552942.951 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T12:42:22.951Z,1399552942.951 [Default:Iridium] Stopped
2014-05-08T12:42:22.951Z,1399552942.951 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T12:42:22.952Z,1399552942.952 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T12:42:22.952Z,1399552942.952 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:42:23.270Z,1399552943.270 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T12:42:23.270Z,1399552943.270 [Default:CallIridium:B] Stopped
2014-05-08T12:42:23.271Z,1399552943.271 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T12:42:23.271Z,1399552943.271 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T12:42:23.271Z,1399552943.271 [Default:CallIridium] Stopped
2014-05-08T12:42:23.271Z,1399552943.271 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T12:42:28.909Z,1399552948.909 [NAL9602](INFO): Powering down
2014-05-08T12:47:23.437Z,1399553243.437 [Default:CallIridium] Running Loop=1
2014-05-08T12:47:23.437Z,1399553243.437 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T12:47:23.438Z,1399553243.438 [Default:CallIridium:A] Running Loop=1
2014-05-08T12:47:23.438Z,1399553243.438 [Default:CallIridium:A] Stopped
2014-05-08T12:47:23.438Z,1399553243.438 [Default:CallIridium:B] Running Loop=1
2014-05-08T12:47:23.438Z,1399553243.438 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T12:47:28.472Z,1399553248.472 [Default:Iridium] Running Loop=1
2014-05-08T12:47:28.472Z,1399553248.472 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T12:47:28.472Z,1399553248.472 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T12:47:28.473Z,1399553248.473 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:47:28.473Z,1399553248.473 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T12:47:28.473Z,1399553248.473 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:47:28.473Z,1399553248.473 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T12:47:28.474Z,1399553248.474 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:47:28.474Z,1399553248.474 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T12:47:28.474Z,1399553248.474 [Default:GPS] Running Loop=1
2014-05-08T12:47:28.474Z,1399553248.474 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T12:47:28.474Z,1399553248.474 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T12:47:28.474Z,1399553248.474 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:47:28.475Z,1399553248.475 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T12:47:28.475Z,1399553248.475 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:47:28.475Z,1399553248.475 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T12:47:28.475Z,1399553248.475 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:47:28.476Z,1399553248.476 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T12:47:29.522Z,1399553249.522 [NAL9602](INFO): Powering up
2014-05-08T12:47:29.613Z,1399553249.613 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0012.lzma
2014-05-08T12:47:30.386Z,1399553250.386 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0012.lzma.bak
2014-05-08T12:47:30.387Z,1399553250.387 [DataOverHttps](INFO): SBD MOMSN=811695
2014-05-08T12:47:34.592Z,1399553254.592 [NAL9602](IMPORTANT): GPS fix at: 1399553254.59
2014-05-08T12:47:34.630Z,1399553254.630 [Default:GPS:Read_GPS] Stopped
2014-05-08T12:47:34.630Z,1399553254.630 [Default:GPS:D] Running Loop=1
2014-05-08T12:47:34.739Z,1399553254.739 [Default:GPS:D] Stopped
2014-05-08T12:47:34.740Z,1399553254.740 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T12:47:34.740Z,1399553254.740 [Default:GPS] Stopped
2014-05-08T12:47:34.740Z,1399553254.740 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T12:47:34.740Z,1399553254.740 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T12:47:34.740Z,1399553254.740 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:47:35.482Z,1399553255.482 [NAL9602](INFO): No messages in MT queue
2014-05-08T12:47:37.269Z,1399553257.269 [DataOverHttps](INFO): Sending 106 bytes from file Logs/20140508T123453/Express0013.lzma
2014-05-08T12:47:38.045Z,1399553258.045 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0013.lzma.bak
2014-05-08T12:47:38.045Z,1399553258.045 [DataOverHttps](INFO): SBD MOMSN=811697
2014-05-08T12:47:38.538Z,1399553258.538 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T12:47:38.539Z,1399553258.539 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T12:47:38.539Z,1399553258.539 [Default:Iridium] Stopped
2014-05-08T12:47:38.539Z,1399553258.539 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T12:47:38.539Z,1399553258.539 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T12:47:38.539Z,1399553258.539 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:47:38.863Z,1399553258.863 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T12:47:38.863Z,1399553258.863 [Default:CallIridium:B] Stopped
2014-05-08T12:47:38.863Z,1399553258.863 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T12:47:38.863Z,1399553258.863 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T12:47:38.863Z,1399553258.863 [Default:CallIridium] Stopped
2014-05-08T12:47:38.864Z,1399553258.864 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T12:47:44.494Z,1399553264.494 [NAL9602](INFO): Powering down
2014-05-08T12:52:38.989Z,1399553558.989 [Default:CallIridium] Running Loop=1
2014-05-08T12:52:38.989Z,1399553558.989 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T12:52:38.989Z,1399553558.989 [Default:CallIridium:A] Running Loop=1
2014-05-08T12:52:38.989Z,1399553558.989 [Default:CallIridium:A] Stopped
2014-05-08T12:52:38.990Z,1399553558.990 [Default:CallIridium:B] Running Loop=1
2014-05-08T12:52:38.990Z,1399553558.990 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T12:52:44.085Z,1399553564.085 [Default:Iridium] Running Loop=1
2014-05-08T12:52:44.086Z,1399553564.086 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T12:52:44.086Z,1399553564.086 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T12:52:44.086Z,1399553564.086 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:52:44.086Z,1399553564.086 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T12:52:44.086Z,1399553564.086 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:52:44.087Z,1399553564.087 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T12:52:44.087Z,1399553564.087 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:52:44.087Z,1399553564.087 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T12:52:44.087Z,1399553564.087 [Default:GPS] Running Loop=1
2014-05-08T12:52:44.087Z,1399553564.087 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T12:52:44.088Z,1399553564.088 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T12:52:44.088Z,1399553564.088 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:52:44.088Z,1399553564.088 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T12:52:44.088Z,1399553564.088 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:52:44.089Z,1399553564.089 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T12:52:44.089Z,1399553564.089 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:52:44.089Z,1399553564.089 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T12:52:44.641Z,1399553564.641 [NAL9602](INFO): Powering up
2014-05-08T12:52:45.988Z,1399553565.988 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0016.lzma
2014-05-08T12:52:46.785Z,1399553566.785 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0016.lzma.bak
2014-05-08T12:52:46.785Z,1399553566.785 [DataOverHttps](INFO): SBD MOMSN=811700
2014-05-08T12:52:50.163Z,1399553570.163 [NAL9602](IMPORTANT): GPS fix at: 1399553570.16
2014-05-08T12:52:50.191Z,1399553570.191 [Default:GPS:Read_GPS] Stopped
2014-05-08T12:52:50.191Z,1399553570.191 [Default:GPS:D] Running Loop=1
2014-05-08T12:52:51.112Z,1399553571.112 [Default:GPS:D] Stopped
2014-05-08T12:52:51.113Z,1399553571.113 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T12:52:51.113Z,1399553571.113 [Default:GPS] Stopped
2014-05-08T12:52:51.113Z,1399553571.113 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T12:52:51.113Z,1399553571.113 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T12:52:51.113Z,1399553571.113 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:52:51.655Z,1399553571.655 [NAL9602](INFO): No messages in MT queue
2014-05-08T12:52:53.765Z,1399553573.765 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0017.lzma
2014-05-08T12:52:54.582Z,1399553574.582 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0017.lzma.bak
2014-05-08T12:52:54.582Z,1399553574.582 [DataOverHttps](INFO): SBD MOMSN=811702
2014-05-08T12:52:54.990Z,1399553574.990 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T12:52:54.991Z,1399553574.991 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T12:52:54.991Z,1399553574.991 [Default:Iridium] Stopped
2014-05-08T12:52:54.991Z,1399553574.991 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T12:52:54.991Z,1399553574.991 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T12:52:54.991Z,1399553574.991 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:52:55.370Z,1399553575.370 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T12:52:55.370Z,1399553575.370 [Default:CallIridium:B] Stopped
2014-05-08T12:52:55.370Z,1399553575.370 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T12:52:55.371Z,1399553575.371 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T12:52:55.371Z,1399553575.371 [Default:CallIridium] Stopped
2014-05-08T12:52:55.371Z,1399553575.371 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T12:53:00.989Z,1399553580.989 [NAL9602](INFO): Powering down
2014-05-08T12:57:55.553Z,1399553875.553 [Default:CallIridium] Running Loop=1
2014-05-08T12:57:55.553Z,1399553875.553 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T12:57:55.554Z,1399553875.554 [Default:CallIridium:A] Running Loop=1
2014-05-08T12:57:55.554Z,1399553875.554 [Default:CallIridium:A] Stopped
2014-05-08T12:57:55.554Z,1399553875.554 [Default:CallIridium:B] Running Loop=1
2014-05-08T12:57:55.554Z,1399553875.554 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T12:58:00.542Z,1399553880.542 [Default:Iridium] Running Loop=1
2014-05-08T12:58:00.543Z,1399553880.543 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T12:58:00.543Z,1399553880.543 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T12:58:00.543Z,1399553880.543 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:58:00.543Z,1399553880.543 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T12:58:00.543Z,1399553880.543 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:58:00.544Z,1399553880.544 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T12:58:00.544Z,1399553880.544 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:58:00.544Z,1399553880.544 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T12:58:00.544Z,1399553880.544 [Default:GPS] Running Loop=1
2014-05-08T12:58:00.544Z,1399553880.544 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T12:58:00.544Z,1399553880.544 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T12:58:00.545Z,1399553880.545 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T12:58:00.545Z,1399553880.545 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T12:58:00.545Z,1399553880.545 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T12:58:00.545Z,1399553880.545 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T12:58:00.546Z,1399553880.546 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T12:58:00.546Z,1399553880.546 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T12:58:01.160Z,1399553881.160 [NAL9602](INFO): Powering up
2014-05-08T12:58:02.137Z,1399553882.137 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0020.lzma
2014-05-08T12:58:02.890Z,1399553882.890 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0020.lzma.bak
2014-05-08T12:58:02.890Z,1399553882.890 [DataOverHttps](INFO): SBD MOMSN=811705
2014-05-08T12:58:07.110Z,1399553887.110 [NAL9602](IMPORTANT): GPS fix at: 1399553887.10
2014-05-08T12:58:07.147Z,1399553887.147 [Default:GPS:Read_GPS] Stopped
2014-05-08T12:58:07.147Z,1399553887.147 [Default:GPS:D] Running Loop=1
2014-05-08T12:58:07.236Z,1399553887.236 [Default:GPS:D] Stopped
2014-05-08T12:58:07.236Z,1399553887.236 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T12:58:07.236Z,1399553887.236 [Default:GPS] Stopped
2014-05-08T12:58:07.236Z,1399553887.236 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T12:58:07.236Z,1399553887.236 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T12:58:07.241Z,1399553887.241 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:58:07.997Z,1399553887.997 [NAL9602](INFO): No messages in MT queue
2014-05-08T12:58:09.792Z,1399553889.792 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20140508T123453/Express0021.lzma
2014-05-08T12:58:10.590Z,1399553890.590 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0021.lzma.bak
2014-05-08T12:58:10.590Z,1399553890.590 [DataOverHttps](INFO): SBD MOMSN=811707
2014-05-08T12:58:11.026Z,1399553891.026 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T12:58:11.026Z,1399553891.026 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T12:58:11.043Z,1399553891.043 [Default:Iridium] Stopped
2014-05-08T12:58:11.043Z,1399553891.043 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T12:58:11.043Z,1399553891.043 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T12:58:11.043Z,1399553891.043 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T12:58:11.448Z,1399553891.448 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T12:58:11.448Z,1399553891.448 [Default:CallIridium:B] Stopped
2014-05-08T12:58:11.448Z,1399553891.448 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T12:58:11.448Z,1399553891.448 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T12:58:11.448Z,1399553891.448 [Default:CallIridium] Stopped
2014-05-08T12:58:11.448Z,1399553891.448 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T12:58:17.041Z,1399553897.041 [NAL9602](INFO): Powering down
2014-05-08T13:03:11.594Z,1399554191.594 [Default:CallIridium] Running Loop=1
2014-05-08T13:03:11.595Z,1399554191.595 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:03:11.595Z,1399554191.595 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:03:11.595Z,1399554191.595 [Default:CallIridium:A] Stopped
2014-05-08T13:03:11.595Z,1399554191.595 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:03:11.595Z,1399554191.595 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:03:16.594Z,1399554196.594 [Default:Iridium] Running Loop=1
2014-05-08T13:03:16.594Z,1399554196.594 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:03:16.594Z,1399554196.594 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:03:16.594Z,1399554196.594 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:03:16.594Z,1399554196.594 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:03:16.594Z,1399554196.594 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:03:16.595Z,1399554196.595 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:03:16.595Z,1399554196.595 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:03:16.595Z,1399554196.595 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:03:16.596Z,1399554196.596 [Default:GPS] Running Loop=1
2014-05-08T13:03:16.596Z,1399554196.596 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:03:16.596Z,1399554196.596 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:03:16.596Z,1399554196.596 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:03:16.596Z,1399554196.596 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:03:16.596Z,1399554196.596 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:03:16.597Z,1399554196.597 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:03:16.597Z,1399554196.597 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:03:16.597Z,1399554196.597 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:03:17.668Z,1399554197.668 [NAL9602](INFO): Powering up
2014-05-08T13:03:17.760Z,1399554197.760 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0024.lzma
2014-05-08T13:03:18.550Z,1399554198.550 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0024.lzma.bak
2014-05-08T13:03:18.551Z,1399554198.551 [DataOverHttps](INFO): SBD MOMSN=811710
2014-05-08T13:03:22.774Z,1399554202.774 [NAL9602](IMPORTANT): GPS fix at: 1399554202.77
2014-05-08T13:03:22.808Z,1399554202.808 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:03:22.808Z,1399554202.808 [Default:GPS:D] Running Loop=1
2014-05-08T13:03:22.906Z,1399554202.906 [Default:GPS:D] Stopped
2014-05-08T13:03:22.907Z,1399554202.907 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:03:22.907Z,1399554202.907 [Default:GPS] Stopped
2014-05-08T13:03:22.907Z,1399554202.907 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:03:22.907Z,1399554202.907 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:03:22.907Z,1399554202.907 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:03:23.685Z,1399554203.685 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:03:25.474Z,1399554205.474 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0025.lzma
2014-05-08T13:03:26.217Z,1399554206.217 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0025.lzma.bak
2014-05-08T13:03:26.217Z,1399554206.217 [DataOverHttps](INFO): SBD MOMSN=811712
2014-05-08T13:03:26.658Z,1399554206.658 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:03:26.659Z,1399554206.659 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:03:26.659Z,1399554206.659 [Default:Iridium] Stopped
2014-05-08T13:03:26.659Z,1399554206.659 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:03:26.659Z,1399554206.659 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:03:26.659Z,1399554206.659 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:03:27.055Z,1399554207.055 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:03:27.055Z,1399554207.055 [Default:CallIridium:B] Stopped
2014-05-08T13:03:27.056Z,1399554207.056 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:03:27.056Z,1399554207.056 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:03:27.056Z,1399554207.056 [Default:CallIridium] Stopped
2014-05-08T13:03:27.056Z,1399554207.056 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:03:32.693Z,1399554212.693 [NAL9602](INFO): Powering down
2014-05-08T13:08:27.216Z,1399554507.216 [Default:CallIridium] Running Loop=1
2014-05-08T13:08:27.216Z,1399554507.216 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:08:27.217Z,1399554507.217 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:08:27.217Z,1399554507.217 [Default:CallIridium:A] Stopped
2014-05-08T13:08:27.217Z,1399554507.217 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:08:27.217Z,1399554507.217 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:08:32.236Z,1399554512.236 [Default:Iridium] Running Loop=1
2014-05-08T13:08:32.236Z,1399554512.236 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:08:32.236Z,1399554512.236 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:08:32.236Z,1399554512.236 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:08:32.236Z,1399554512.236 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:08:32.236Z,1399554512.236 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:08:32.237Z,1399554512.237 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:08:32.237Z,1399554512.237 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:08:32.237Z,1399554512.237 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:08:32.270Z,1399554512.270 [Default:GPS] Running Loop=1
2014-05-08T13:08:32.270Z,1399554512.270 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:08:32.270Z,1399554512.270 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:08:32.270Z,1399554512.270 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:08:32.270Z,1399554512.270 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:08:32.270Z,1399554512.270 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:08:32.271Z,1399554512.271 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:08:32.271Z,1399554512.271 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:08:32.271Z,1399554512.271 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:08:32.829Z,1399554512.829 [NAL9602](INFO): Powering up
2014-05-08T13:08:34.178Z,1399554514.178 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0028.lzma
2014-05-08T13:08:34.951Z,1399554514.951 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0028.lzma.bak
2014-05-08T13:08:34.951Z,1399554514.951 [DataOverHttps](INFO): SBD MOMSN=811715
2014-05-08T13:08:38.370Z,1399554518.370 [NAL9602](IMPORTANT): GPS fix at: 1399554518.36
2014-05-08T13:08:38.388Z,1399554518.388 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:08:38.388Z,1399554518.388 [Default:GPS:D] Running Loop=1
2014-05-08T13:08:39.368Z,1399554519.368 [Default:GPS:D] Stopped
2014-05-08T13:08:39.368Z,1399554519.368 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:08:39.368Z,1399554519.368 [Default:GPS] Stopped
2014-05-08T13:08:39.368Z,1399554519.368 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:08:39.369Z,1399554519.369 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:08:39.369Z,1399554519.369 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:08:39.818Z,1399554519.818 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:08:42.020Z,1399554522.020 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20140508T123453/Express0029.lzma
2014-05-08T13:08:42.760Z,1399554522.760 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0029.lzma.bak
2014-05-08T13:08:42.760Z,1399554522.760 [DataOverHttps](INFO): SBD MOMSN=811717
2014-05-08T13:08:43.196Z,1399554523.196 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:08:43.197Z,1399554523.197 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:08:43.197Z,1399554523.197 [Default:Iridium] Stopped
2014-05-08T13:08:43.197Z,1399554523.197 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:08:43.197Z,1399554523.197 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:08:43.197Z,1399554523.197 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:08:43.583Z,1399554523.583 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:08:43.583Z,1399554523.583 [Default:CallIridium:B] Stopped
2014-05-08T13:08:43.583Z,1399554523.583 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:08:43.584Z,1399554523.584 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:08:43.584Z,1399554523.584 [Default:CallIridium] Stopped
2014-05-08T13:08:43.584Z,1399554523.584 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:08:49.226Z,1399554529.226 [NAL9602](INFO): Powering down
2014-05-08T13:10:23.677Z,1399554623.677 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#3 STATUS: 65535
2014-05-08T13:13:43.777Z,1399554823.777 [Default:CallIridium] Running Loop=1
2014-05-08T13:13:43.777Z,1399554823.777 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:13:43.777Z,1399554823.777 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:13:43.778Z,1399554823.778 [Default:CallIridium:A] Stopped
2014-05-08T13:13:43.778Z,1399554823.778 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:13:43.778Z,1399554823.778 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:13:48.770Z,1399554828.770 [Default:Iridium] Running Loop=1
2014-05-08T13:13:48.771Z,1399554828.771 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:13:48.771Z,1399554828.771 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:13:48.771Z,1399554828.771 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:13:48.771Z,1399554828.771 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:13:48.771Z,1399554828.771 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:13:48.772Z,1399554828.772 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:13:48.772Z,1399554828.772 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:13:48.772Z,1399554828.772 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:13:48.772Z,1399554828.772 [Default:GPS] Running Loop=1
2014-05-08T13:13:48.772Z,1399554828.772 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:13:48.773Z,1399554828.773 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:13:48.773Z,1399554828.773 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:13:48.773Z,1399554828.773 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:13:48.773Z,1399554828.773 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:13:48.774Z,1399554828.774 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:13:48.774Z,1399554828.774 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:13:48.774Z,1399554828.774 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:13:49.411Z,1399554829.411 [NAL9602](INFO): Powering up
2014-05-08T13:13:50.720Z,1399554830.720 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0032.lzma
2014-05-08T13:13:51.571Z,1399554831.571 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0032.lzma.bak
2014-05-08T13:13:51.571Z,1399554831.571 [DataOverHttps](INFO): SBD MOMSN=811720
2014-05-08T13:13:54.895Z,1399554834.895 [NAL9602](IMPORTANT): GPS fix at: 1399554834.89
2014-05-08T13:13:54.930Z,1399554834.930 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:13:54.930Z,1399554834.930 [Default:GPS:D] Running Loop=1
2014-05-08T13:13:55.804Z,1399554835.804 [Default:GPS:D] Stopped
2014-05-08T13:13:55.805Z,1399554835.805 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:13:55.805Z,1399554835.805 [Default:GPS] Stopped
2014-05-08T13:13:55.805Z,1399554835.805 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:13:55.805Z,1399554835.805 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:13:55.805Z,1399554835.805 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:13:56.283Z,1399554836.283 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:13:58.458Z,1399554838.458 [DataOverHttps](INFO): Sending 106 bytes from file Logs/20140508T123453/Express0033.lzma
2014-05-08T13:13:59.233Z,1399554839.233 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0033.lzma.bak
2014-05-08T13:13:59.233Z,1399554839.233 [DataOverHttps](INFO): SBD MOMSN=811722
2014-05-08T13:13:59.686Z,1399554839.686 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:13:59.686Z,1399554839.686 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:13:59.686Z,1399554839.686 [Default:Iridium] Stopped
2014-05-08T13:13:59.686Z,1399554839.686 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:13:59.687Z,1399554839.687 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:13:59.687Z,1399554839.687 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:14:00.054Z,1399554840.054 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:14:00.054Z,1399554840.054 [Default:CallIridium:B] Stopped
2014-05-08T13:14:00.054Z,1399554840.054 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:14:00.054Z,1399554840.054 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:14:00.054Z,1399554840.054 [Default:CallIridium] Stopped
2014-05-08T13:14:00.054Z,1399554840.054 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:14:05.690Z,1399554845.690 [NAL9602](INFO): Powering down
2014-05-08T13:19:00.284Z,1399555140.284 [Default:CallIridium] Running Loop=1
2014-05-08T13:19:00.284Z,1399555140.284 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:19:00.284Z,1399555140.284 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:19:00.285Z,1399555140.285 [Default:CallIridium:A] Stopped
2014-05-08T13:19:00.285Z,1399555140.285 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:19:00.285Z,1399555140.285 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:19:05.232Z,1399555145.232 [Default:Iridium] Running Loop=1
2014-05-08T13:19:05.232Z,1399555145.232 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:19:05.232Z,1399555145.232 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:19:05.232Z,1399555145.232 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:19:05.233Z,1399555145.233 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:19:05.233Z,1399555145.233 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:19:05.233Z,1399555145.233 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:19:05.234Z,1399555145.234 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:19:05.234Z,1399555145.234 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:19:05.234Z,1399555145.234 [Default:GPS] Running Loop=1
2014-05-08T13:19:05.234Z,1399555145.234 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:19:05.234Z,1399555145.234 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:19:05.234Z,1399555145.234 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:19:05.234Z,1399555145.234 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:19:05.235Z,1399555145.235 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:19:05.235Z,1399555145.235 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:19:05.235Z,1399555145.235 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:19:05.235Z,1399555145.235 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:19:05.871Z,1399555145.871 [NAL9602](INFO): Powering up
2014-05-08T13:19:07.259Z,1399555147.259 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0036.lzma
2014-05-08T13:19:07.984Z,1399555147.984 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0036.lzma.bak
2014-05-08T13:19:07.984Z,1399555147.984 [DataOverHttps](INFO): SBD MOMSN=811725
2014-05-08T13:19:11.382Z,1399555151.382 [NAL9602](IMPORTANT): GPS fix at: 1399555151.38
2014-05-08T13:19:11.400Z,1399555151.400 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:19:11.400Z,1399555151.400 [Default:GPS:D] Running Loop=1
2014-05-08T13:19:12.349Z,1399555152.349 [Default:GPS:D] Stopped
2014-05-08T13:19:12.350Z,1399555152.350 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:19:12.350Z,1399555152.350 [Default:GPS] Stopped
2014-05-08T13:19:12.350Z,1399555152.350 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:19:12.350Z,1399555152.350 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:19:12.350Z,1399555152.350 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:19:12.858Z,1399555152.858 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:19:14.970Z,1399555154.970 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20140508T123453/Express0037.lzma
2014-05-08T13:19:15.748Z,1399555155.748 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0037.lzma.bak
2014-05-08T13:19:15.749Z,1399555155.749 [DataOverHttps](INFO): SBD MOMSN=811727
2014-05-08T13:19:16.198Z,1399555156.198 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:19:16.198Z,1399555156.198 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:19:16.198Z,1399555156.198 [Default:Iridium] Stopped
2014-05-08T13:19:16.198Z,1399555156.198 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:19:16.199Z,1399555156.199 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:19:16.199Z,1399555156.199 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:19:16.570Z,1399555156.570 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:19:16.570Z,1399555156.570 [Default:CallIridium:B] Stopped
2014-05-08T13:19:16.570Z,1399555156.570 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:19:16.571Z,1399555156.571 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:19:16.571Z,1399555156.571 [Default:CallIridium] Stopped
2014-05-08T13:19:16.571Z,1399555156.571 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:19:22.235Z,1399555162.235 [NAL9602](INFO): Powering down
2014-05-08T13:24:16.757Z,1399555456.757 [Default:CallIridium] Running Loop=1
2014-05-08T13:24:16.757Z,1399555456.757 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:24:16.757Z,1399555456.757 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:24:16.757Z,1399555456.757 [Default:CallIridium:A] Stopped
2014-05-08T13:24:16.757Z,1399555456.757 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:24:16.758Z,1399555456.758 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:24:21.752Z,1399555461.752 [Default:Iridium] Running Loop=1
2014-05-08T13:24:21.753Z,1399555461.753 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:24:21.753Z,1399555461.753 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:24:21.753Z,1399555461.753 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:24:21.753Z,1399555461.753 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:24:21.753Z,1399555461.753 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:24:21.754Z,1399555461.754 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:24:21.754Z,1399555461.754 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:24:21.754Z,1399555461.754 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:24:21.754Z,1399555461.754 [Default:GPS] Running Loop=1
2014-05-08T13:24:21.754Z,1399555461.754 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:24:21.755Z,1399555461.755 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:24:21.755Z,1399555461.755 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:24:21.755Z,1399555461.755 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:24:21.755Z,1399555461.755 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:24:21.756Z,1399555461.756 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:24:21.756Z,1399555461.756 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:24:21.756Z,1399555461.756 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:24:22.403Z,1399555462.403 [NAL9602](INFO): Powering up
2014-05-08T13:24:23.786Z,1399555463.786 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0040.lzma
2014-05-08T13:24:24.539Z,1399555464.539 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0040.lzma.bak
2014-05-08T13:24:24.540Z,1399555464.540 [DataOverHttps](INFO): SBD MOMSN=811730
2014-05-08T13:24:27.933Z,1399555467.933 [NAL9602](IMPORTANT): GPS fix at: 1399555467.93
2014-05-08T13:24:27.962Z,1399555467.962 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:24:27.963Z,1399555467.963 [Default:GPS:D] Running Loop=1
2014-05-08T13:24:28.960Z,1399555468.960 [Default:GPS:D] Stopped
2014-05-08T13:24:28.960Z,1399555468.960 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:24:28.960Z,1399555468.960 [Default:GPS] Stopped
2014-05-08T13:24:28.960Z,1399555468.960 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:24:28.960Z,1399555468.960 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:24:28.961Z,1399555468.961 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:24:29.411Z,1399555469.411 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:24:31.573Z,1399555471.573 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20140508T123453/Express0041.lzma
2014-05-08T13:24:32.364Z,1399555472.364 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0041.lzma.bak
2014-05-08T13:24:32.364Z,1399555472.364 [DataOverHttps](INFO): SBD MOMSN=811732
2014-05-08T13:24:32.814Z,1399555472.814 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:24:32.814Z,1399555472.814 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:24:32.814Z,1399555472.814 [Default:Iridium] Stopped
2014-05-08T13:24:32.814Z,1399555472.814 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:24:32.814Z,1399555472.814 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:24:32.814Z,1399555472.814 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:24:33.240Z,1399555473.240 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:24:33.241Z,1399555473.241 [Default:CallIridium:B] Stopped
2014-05-08T13:24:33.241Z,1399555473.241 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:24:33.241Z,1399555473.241 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:24:33.241Z,1399555473.241 [Default:CallIridium] Stopped
2014-05-08T13:24:33.241Z,1399555473.241 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:24:38.826Z,1399555478.826 [NAL9602](INFO): Powering down
2014-05-08T13:29:33.366Z,1399555773.366 [Default:CallIridium] Running Loop=1
2014-05-08T13:29:33.366Z,1399555773.366 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:29:33.366Z,1399555773.366 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:29:33.367Z,1399555773.367 [Default:CallIridium:A] Stopped
2014-05-08T13:29:33.367Z,1399555773.367 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:29:33.367Z,1399555773.367 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:29:38.341Z,1399555778.341 [Default:Iridium] Running Loop=1
2014-05-08T13:29:38.341Z,1399555778.341 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:29:38.341Z,1399555778.341 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:29:38.342Z,1399555778.342 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:29:38.342Z,1399555778.342 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:29:38.342Z,1399555778.342 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:29:38.343Z,1399555778.343 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:29:38.343Z,1399555778.343 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:29:38.343Z,1399555778.343 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:29:38.343Z,1399555778.343 [Default:GPS] Running Loop=1
2014-05-08T13:29:38.343Z,1399555778.343 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:29:38.343Z,1399555778.343 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:29:38.343Z,1399555778.343 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:29:38.344Z,1399555778.344 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:29:38.344Z,1399555778.344 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:29:38.365Z,1399555778.365 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:29:38.365Z,1399555778.365 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:29:38.365Z,1399555778.365 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:29:39.014Z,1399555779.014 [NAL9602](INFO): Powering up
2014-05-08T13:29:40.313Z,1399555780.313 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0044.lzma
2014-05-08T13:29:41.099Z,1399555781.099 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0044.lzma.bak
2014-05-08T13:29:41.099Z,1399555781.099 [DataOverHttps](INFO): SBD MOMSN=811735
2014-05-08T13:29:44.469Z,1399555784.469 [NAL9602](IMPORTANT): GPS fix at: 1399555784.46
2014-05-08T13:29:44.488Z,1399555784.488 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:29:44.488Z,1399555784.488 [Default:GPS:D] Running Loop=1
2014-05-08T13:29:45.466Z,1399555785.466 [Default:GPS:D] Stopped
2014-05-08T13:29:45.466Z,1399555785.466 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:29:45.466Z,1399555785.466 [Default:GPS] Stopped
2014-05-08T13:29:45.467Z,1399555785.467 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:29:45.467Z,1399555785.467 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:29:45.467Z,1399555785.467 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:29:45.917Z,1399555785.917 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:29:48.128Z,1399555788.128 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0045.lzma
2014-05-08T13:29:48.874Z,1399555788.874 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0045.lzma.bak
2014-05-08T13:29:48.874Z,1399555788.874 [DataOverHttps](INFO): SBD MOMSN=811737
2014-05-08T13:29:49.377Z,1399555789.377 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:29:49.378Z,1399555789.378 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:29:49.378Z,1399555789.378 [Default:Iridium] Stopped
2014-05-08T13:29:49.378Z,1399555789.378 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:29:49.378Z,1399555789.378 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:29:49.378Z,1399555789.378 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:29:49.700Z,1399555789.700 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:29:49.701Z,1399555789.701 [Default:CallIridium:B] Stopped
2014-05-08T13:29:49.701Z,1399555789.701 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:29:49.701Z,1399555789.701 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:29:49.701Z,1399555789.701 [Default:CallIridium] Stopped
2014-05-08T13:29:49.701Z,1399555789.701 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:29:55.333Z,1399555795.333 [NAL9602](INFO): Powering down
2014-05-08T13:34:49.872Z,1399556089.872 [Default:CallIridium] Running Loop=1
2014-05-08T13:34:49.872Z,1399556089.872 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:34:49.872Z,1399556089.872 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:34:49.873Z,1399556089.873 [Default:CallIridium:A] Stopped
2014-05-08T13:34:49.873Z,1399556089.873 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:34:49.873Z,1399556089.873 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:34:54.895Z,1399556094.895 [Default:Iridium] Running Loop=1
2014-05-08T13:34:54.895Z,1399556094.895 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:34:54.895Z,1399556094.895 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:34:54.895Z,1399556094.895 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:34:54.895Z,1399556094.895 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:34:54.895Z,1399556094.895 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:34:54.896Z,1399556094.896 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:34:54.896Z,1399556094.896 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:34:54.896Z,1399556094.896 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:34:54.897Z,1399556094.897 [Default:GPS] Running Loop=1
2014-05-08T13:34:54.897Z,1399556094.897 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:34:54.897Z,1399556094.897 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:34:54.897Z,1399556094.897 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:34:54.897Z,1399556094.897 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:34:54.897Z,1399556094.897 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:34:54.898Z,1399556094.898 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:34:54.898Z,1399556094.898 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:34:54.898Z,1399556094.898 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:34:55.957Z,1399556095.957 [NAL9602](INFO): Powering up
2014-05-08T13:34:56.048Z,1399556096.048 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0048.lzma
2014-05-08T13:34:56.830Z,1399556096.830 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0048.lzma.bak
2014-05-08T13:34:56.830Z,1399556096.830 [DataOverHttps](INFO): SBD MOMSN=811740
2014-05-08T13:35:01.091Z,1399556101.091 [NAL9602](IMPORTANT): GPS fix at: 1399556101.00
2014-05-08T13:35:01.127Z,1399556101.127 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:35:01.127Z,1399556101.127 [Default:GPS:D] Running Loop=1
2014-05-08T13:35:01.249Z,1399556101.249 [Default:GPS:D] Stopped
2014-05-08T13:35:01.249Z,1399556101.249 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:35:01.249Z,1399556101.249 [Default:GPS] Stopped
2014-05-08T13:35:01.249Z,1399556101.249 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:35:01.249Z,1399556101.249 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:35:01.250Z,1399556101.250 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:35:01.978Z,1399556101.978 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:35:03.770Z,1399556103.770 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20140508T123453/Express0049.lzma
2014-05-08T13:35:04.600Z,1399556104.600 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0049.lzma.bak
2014-05-08T13:35:04.601Z,1399556104.601 [DataOverHttps](INFO): SBD MOMSN=811742
2014-05-08T13:35:04.993Z,1399556104.993 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:35:04.994Z,1399556104.994 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:35:04.994Z,1399556104.994 [Default:Iridium] Stopped
2014-05-08T13:35:04.994Z,1399556104.994 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:35:04.994Z,1399556104.994 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:35:04.994Z,1399556104.994 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:35:05.366Z,1399556105.366 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:35:05.366Z,1399556105.366 [Default:CallIridium:B] Stopped
2014-05-08T13:35:05.366Z,1399556105.366 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:35:05.366Z,1399556105.366 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:35:05.366Z,1399556105.366 [Default:CallIridium] Stopped
2014-05-08T13:35:05.367Z,1399556105.367 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:35:11.005Z,1399556111.005 [NAL9602](INFO): Powering down
2014-05-08T13:40:05.537Z,1399556405.537 [Default:CallIridium] Running Loop=1
2014-05-08T13:40:05.537Z,1399556405.537 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:40:05.537Z,1399556405.537 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:40:05.538Z,1399556405.538 [Default:CallIridium:A] Stopped
2014-05-08T13:40:05.538Z,1399556405.538 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:40:05.538Z,1399556405.538 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:40:10.550Z,1399556410.550 [Default:Iridium] Running Loop=1
2014-05-08T13:40:10.551Z,1399556410.551 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:40:10.551Z,1399556410.551 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:40:10.551Z,1399556410.551 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:40:10.551Z,1399556410.551 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:40:10.551Z,1399556410.551 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:40:10.552Z,1399556410.552 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:40:10.552Z,1399556410.552 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:40:10.552Z,1399556410.552 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:40:10.552Z,1399556410.552 [Default:GPS] Running Loop=1
2014-05-08T13:40:10.552Z,1399556410.552 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:40:10.552Z,1399556410.552 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:40:10.553Z,1399556410.553 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:40:10.553Z,1399556410.553 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:40:10.553Z,1399556410.553 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:40:10.554Z,1399556410.554 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:40:10.554Z,1399556410.554 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:40:10.554Z,1399556410.554 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:40:11.156Z,1399556411.156 [NAL9602](INFO): Powering up
2014-05-08T13:40:12.499Z,1399556412.499 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0052.lzma
2014-05-08T13:40:13.290Z,1399556413.290 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0052.lzma.bak
2014-05-08T13:40:13.291Z,1399556413.291 [DataOverHttps](INFO): SBD MOMSN=811745
2014-05-08T13:40:16.647Z,1399556416.647 [NAL9602](IMPORTANT): GPS fix at: 1399556416.64
2014-05-08T13:40:16.664Z,1399556416.664 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:40:16.664Z,1399556416.664 [Default:GPS:D] Running Loop=1
2014-05-08T13:40:17.597Z,1399556417.597 [Default:GPS:D] Stopped
2014-05-08T13:40:17.598Z,1399556417.598 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:40:17.598Z,1399556417.598 [Default:GPS] Stopped
2014-05-08T13:40:17.598Z,1399556417.598 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:40:17.598Z,1399556417.598 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:40:17.598Z,1399556417.598 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:40:18.069Z,1399556418.069 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:40:20.223Z,1399556420.223 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0053.lzma
2014-05-08T13:40:21.007Z,1399556421.007 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0053.lzma.bak
2014-05-08T13:40:21.007Z,1399556421.007 [DataOverHttps](INFO): SBD MOMSN=811747
2014-05-08T13:40:21.845Z,1399556421.845 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:40:21.846Z,1399556421.846 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:40:21.846Z,1399556421.846 [Default:Iridium] Stopped
2014-05-08T13:40:21.846Z,1399556421.846 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:40:21.846Z,1399556421.846 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:40:21.846Z,1399556421.846 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:40:21.961Z,1399556421.961 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:40:21.961Z,1399556421.961 [Default:CallIridium:B] Stopped
2014-05-08T13:40:21.962Z,1399556421.962 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:40:21.962Z,1399556421.962 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:40:21.962Z,1399556421.962 [Default:CallIridium] Stopped
2014-05-08T13:40:21.962Z,1399556421.962 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:40:27.567Z,1399556427.567 [NAL9602](INFO): Powering down
2014-05-08T13:45:22.160Z,1399556722.160 [Default:CallIridium] Running Loop=1
2014-05-08T13:45:22.160Z,1399556722.160 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:45:22.160Z,1399556722.160 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:45:22.161Z,1399556722.161 [Default:CallIridium:A] Stopped
2014-05-08T13:45:22.161Z,1399556722.161 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:45:22.161Z,1399556722.161 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:45:27.126Z,1399556727.126 [Default:Iridium] Running Loop=1
2014-05-08T13:45:27.126Z,1399556727.126 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:45:27.126Z,1399556727.126 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:45:27.126Z,1399556727.126 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:45:27.126Z,1399556727.126 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:45:27.126Z,1399556727.126 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:45:27.127Z,1399556727.127 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:45:27.127Z,1399556727.127 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:45:27.127Z,1399556727.127 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:45:27.128Z,1399556727.128 [Default:GPS] Running Loop=1
2014-05-08T13:45:27.128Z,1399556727.128 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:45:27.128Z,1399556727.128 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:45:27.128Z,1399556727.128 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:45:27.128Z,1399556727.128 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:45:27.128Z,1399556727.128 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:45:27.129Z,1399556727.129 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:45:27.129Z,1399556727.129 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:45:27.129Z,1399556727.129 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:45:27.720Z,1399556727.720 [NAL9602](INFO): Powering up
2014-05-08T13:45:29.064Z,1399556729.064 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0056.lzma
2014-05-08T13:45:29.861Z,1399556729.861 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0056.lzma.bak
2014-05-08T13:45:29.861Z,1399556729.861 [DataOverHttps](INFO): SBD MOMSN=811750
2014-05-08T13:45:32.869Z,1399556732.869 [NAL9602](IMPORTANT): GPS fix at: 1399556732.86
2014-05-08T13:45:32.886Z,1399556732.886 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:45:32.886Z,1399556732.886 [Default:GPS:D] Running Loop=1
2014-05-08T13:45:33.286Z,1399556733.286 [Default:GPS:D] Stopped
2014-05-08T13:45:33.286Z,1399556733.286 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:45:33.286Z,1399556733.286 [Default:GPS] Stopped
2014-05-08T13:45:33.286Z,1399556733.286 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:45:33.286Z,1399556733.286 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:45:33.286Z,1399556733.286 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:45:34.281Z,1399556734.281 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:45:36.935Z,1399556736.935 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20140508T123453/Express0057.lzma
2014-05-08T13:45:37.676Z,1399556737.676 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0057.lzma.bak
2014-05-08T13:45:37.676Z,1399556737.676 [DataOverHttps](INFO): SBD MOMSN=811752
2014-05-08T13:45:38.119Z,1399556738.119 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:45:38.119Z,1399556738.119 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:45:38.119Z,1399556738.119 [Default:Iridium] Stopped
2014-05-08T13:45:38.119Z,1399556738.119 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:45:38.119Z,1399556738.119 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:45:38.119Z,1399556738.119 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:45:38.493Z,1399556738.493 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:45:38.494Z,1399556738.494 [Default:CallIridium:B] Stopped
2014-05-08T13:45:38.494Z,1399556738.494 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:45:38.494Z,1399556738.494 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:45:38.494Z,1399556738.494 [Default:CallIridium] Stopped
2014-05-08T13:45:38.494Z,1399556738.494 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:45:44.131Z,1399556744.131 [NAL9602](INFO): Powering down
2014-05-08T13:50:38.675Z,1399557038.675 [Default:CallIridium] Running Loop=1
2014-05-08T13:50:38.675Z,1399557038.675 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:50:38.675Z,1399557038.675 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:50:38.676Z,1399557038.676 [Default:CallIridium:A] Stopped
2014-05-08T13:50:38.676Z,1399557038.676 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:50:38.676Z,1399557038.676 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:50:43.681Z,1399557043.681 [Default:Iridium] Running Loop=1
2014-05-08T13:50:43.681Z,1399557043.681 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:50:43.681Z,1399557043.681 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:50:43.681Z,1399557043.681 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:50:43.681Z,1399557043.681 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:50:43.681Z,1399557043.681 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:50:43.682Z,1399557043.682 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:50:43.682Z,1399557043.682 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:50:43.682Z,1399557043.682 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:50:43.682Z,1399557043.682 [Default:GPS] Running Loop=1
2014-05-08T13:50:43.683Z,1399557043.683 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:50:43.683Z,1399557043.683 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:50:43.683Z,1399557043.683 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:50:43.683Z,1399557043.683 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:50:43.683Z,1399557043.683 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:50:43.684Z,1399557043.684 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:50:43.684Z,1399557043.684 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:50:43.684Z,1399557043.684 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:50:44.286Z,1399557044.286 [NAL9602](INFO): Powering up
2014-05-08T13:50:45.634Z,1399557045.634 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20140508T123453/Courier0060.lzma
2014-05-08T13:50:46.412Z,1399557046.412 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0060.lzma.bak
2014-05-08T13:50:46.412Z,1399557046.412 [DataOverHttps](INFO): SBD MOMSN=811755
2014-05-08T13:50:49.786Z,1399557049.786 [NAL9602](IMPORTANT): GPS fix at: 1399557049.78
2014-05-08T13:50:49.804Z,1399557049.804 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:50:49.804Z,1399557049.804 [Default:GPS:D] Running Loop=1
2014-05-08T13:50:50.770Z,1399557050.770 [Default:GPS:D] Stopped
2014-05-08T13:50:50.770Z,1399557050.770 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:50:50.770Z,1399557050.770 [Default:GPS] Stopped
2014-05-08T13:50:50.770Z,1399557050.770 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:50:50.770Z,1399557050.770 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:50:50.771Z,1399557050.771 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:50:51.267Z,1399557051.267 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:50:53.462Z,1399557053.462 [DataOverHttps](INFO): Sending 106 bytes from file Logs/20140508T123453/Express0061.lzma
2014-05-08T13:50:54.217Z,1399557054.217 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0061.lzma.bak
2014-05-08T13:50:54.218Z,1399557054.218 [DataOverHttps](INFO): SBD MOMSN=811757
2014-05-08T13:50:54.686Z,1399557054.686 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:50:54.687Z,1399557054.687 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:50:54.687Z,1399557054.687 [Default:Iridium] Stopped
2014-05-08T13:50:54.687Z,1399557054.687 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:50:54.687Z,1399557054.687 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:50:54.687Z,1399557054.687 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:50:55.052Z,1399557055.052 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:50:55.052Z,1399557055.052 [Default:CallIridium:B] Stopped
2014-05-08T13:50:55.052Z,1399557055.052 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:50:55.053Z,1399557055.053 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:50:55.053Z,1399557055.053 [Default:CallIridium] Stopped
2014-05-08T13:50:55.053Z,1399557055.053 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T13:51:00.696Z,1399557060.696 [NAL9602](INFO): Powering down
2014-05-08T13:55:55.235Z,1399557355.235 [Default:CallIridium] Running Loop=1
2014-05-08T13:55:55.235Z,1399557355.235 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T13:55:55.235Z,1399557355.235 [Default:CallIridium:A] Running Loop=1
2014-05-08T13:55:55.236Z,1399557355.236 [Default:CallIridium:A] Stopped
2014-05-08T13:55:55.236Z,1399557355.236 [Default:CallIridium:B] Running Loop=1
2014-05-08T13:55:55.236Z,1399557355.236 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T13:56:00.244Z,1399557360.244 [Default:Iridium] Running Loop=1
2014-05-08T13:56:00.244Z,1399557360.244 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T13:56:00.244Z,1399557360.244 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T13:56:00.244Z,1399557360.244 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:56:00.244Z,1399557360.244 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T13:56:00.244Z,1399557360.244 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:56:00.245Z,1399557360.245 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T13:56:00.245Z,1399557360.245 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:56:00.245Z,1399557360.245 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T13:56:00.246Z,1399557360.246 [Default:GPS] Running Loop=1
2014-05-08T13:56:00.246Z,1399557360.246 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T13:56:00.246Z,1399557360.246 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T13:56:00.246Z,1399557360.246 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T13:56:00.246Z,1399557360.246 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T13:56:00.246Z,1399557360.246 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T13:56:00.247Z,1399557360.247 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T13:56:00.247Z,1399557360.247 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T13:56:00.247Z,1399557360.247 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T13:56:00.840Z,1399557360.840 [NAL9602](INFO): Powering up
2014-05-08T13:56:02.195Z,1399557362.195 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0064.lzma
2014-05-08T13:56:02.991Z,1399557362.991 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0064.lzma.bak
2014-05-08T13:56:02.991Z,1399557362.991 [DataOverHttps](INFO): SBD MOMSN=811760
2014-05-08T13:56:06.348Z,1399557366.348 [NAL9602](IMPORTANT): GPS fix at: 1399557366.34
2014-05-08T13:56:06.366Z,1399557366.366 [Default:GPS:Read_GPS] Stopped
2014-05-08T13:56:06.366Z,1399557366.366 [Default:GPS:D] Running Loop=1
2014-05-08T13:56:07.345Z,1399557367.345 [Default:GPS:D] Stopped
2014-05-08T13:56:07.345Z,1399557367.345 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T13:56:07.345Z,1399557367.345 [Default:GPS] Stopped
2014-05-08T13:56:07.346Z,1399557367.346 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T13:56:07.346Z,1399557367.346 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T13:56:07.346Z,1399557367.346 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:56:07.795Z,1399557367.795 [NAL9602](INFO): No messages in MT queue
2014-05-08T13:56:12.570Z,1399557372.570 [DataOverHttps](INFO): Sending 116 bytes from file Logs/20140508T123453/Express0065.lzma
2014-05-08T13:56:13.328Z,1399557373.328 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0065.lzma.bak
2014-05-08T13:56:13.328Z,1399557373.328 [DataOverHttps](INFO): SBD MOMSN=811762
2014-05-08T13:56:13.351Z,1399557373.351 [NAL9602](INFO): Powering down
2014-05-08T13:56:13.748Z,1399557373.748 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T13:56:13.748Z,1399557373.748 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T13:56:13.748Z,1399557373.748 [Default:Iridium] Stopped
2014-05-08T13:56:13.748Z,1399557373.748 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T13:56:13.748Z,1399557373.748 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T13:56:13.749Z,1399557373.749 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T13:56:14.115Z,1399557374.115 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T13:56:14.115Z,1399557374.115 [Default:CallIridium:B] Stopped
2014-05-08T13:56:14.115Z,1399557374.115 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T13:56:14.115Z,1399557374.115 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T13:56:14.115Z,1399557374.115 [Default:CallIridium] Stopped
2014-05-08T13:56:14.115Z,1399557374.115 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:01:14.303Z,1399557674.303 [Default:CallIridium] Running Loop=1
2014-05-08T14:01:14.303Z,1399557674.303 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:01:14.303Z,1399557674.303 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:01:14.304Z,1399557674.304 [Default:CallIridium:A] Stopped
2014-05-08T14:01:14.304Z,1399557674.304 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:01:14.304Z,1399557674.304 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:01:19.298Z,1399557679.298 [Default:Iridium] Running Loop=1
2014-05-08T14:01:19.298Z,1399557679.298 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:01:19.298Z,1399557679.298 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:01:19.298Z,1399557679.298 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:01:19.298Z,1399557679.298 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:01:19.299Z,1399557679.299 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:01:19.299Z,1399557679.299 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:01:19.299Z,1399557679.299 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:01:19.299Z,1399557679.299 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:01:19.300Z,1399557679.300 [Default:GPS] Running Loop=1
2014-05-08T14:01:19.300Z,1399557679.300 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:01:19.300Z,1399557679.300 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:01:19.300Z,1399557679.300 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:01:19.300Z,1399557679.300 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:01:19.300Z,1399557679.300 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:01:19.301Z,1399557679.301 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:01:19.301Z,1399557679.301 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:01:19.301Z,1399557679.301 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:01:19.911Z,1399557679.911 [NAL9602](INFO): Powering up
2014-05-08T14:01:20.883Z,1399557680.883 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20140508T123453/Courier0068.lzma
2014-05-08T14:01:21.672Z,1399557681.672 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0068.lzma.bak
2014-05-08T14:01:21.672Z,1399557681.672 [DataOverHttps](INFO): SBD MOMSN=811765
2014-05-08T14:01:25.106Z,1399557685.106 [NAL9602](IMPORTANT): GPS fix at: 1399557685.10
2014-05-08T14:01:25.123Z,1399557685.123 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:01:25.123Z,1399557685.123 [Default:GPS:D] Running Loop=1
2014-05-08T14:01:26.059Z,1399557686.059 [Default:GPS:D] Stopped
2014-05-08T14:01:26.059Z,1399557686.059 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:01:26.059Z,1399557686.059 [Default:GPS] Stopped
2014-05-08T14:01:26.059Z,1399557686.059 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:01:26.059Z,1399557686.059 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:01:26.059Z,1399557686.059 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:01:26.509Z,1399557686.509 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:01:28.727Z,1399557688.727 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0069.lzma
2014-05-08T14:01:29.455Z,1399557689.455 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0069.lzma.bak
2014-05-08T14:01:29.455Z,1399557689.455 [DataOverHttps](INFO): SBD MOMSN=811767
2014-05-08T14:01:29.905Z,1399557689.905 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:01:29.905Z,1399557689.905 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:01:29.905Z,1399557689.905 [Default:Iridium] Stopped
2014-05-08T14:01:29.905Z,1399557689.905 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:01:29.905Z,1399557689.905 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:01:29.905Z,1399557689.905 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:01:30.319Z,1399557690.319 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:01:30.319Z,1399557690.319 [Default:CallIridium:B] Stopped
2014-05-08T14:01:30.320Z,1399557690.320 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:01:30.320Z,1399557690.320 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:01:30.320Z,1399557690.320 [Default:CallIridium] Stopped
2014-05-08T14:01:30.320Z,1399557690.320 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:01:35.899Z,1399557695.899 [NAL9602](INFO): Powering down
2014-05-08T14:06:30.463Z,1399557990.463 [Default:CallIridium] Running Loop=1
2014-05-08T14:06:30.463Z,1399557990.463 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:06:30.463Z,1399557990.463 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:06:30.463Z,1399557990.463 [Default:CallIridium:A] Stopped
2014-05-08T14:06:30.463Z,1399557990.463 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:06:30.463Z,1399557990.463 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:06:35.461Z,1399557995.461 [Default:Iridium] Running Loop=1
2014-05-08T14:06:35.461Z,1399557995.461 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:06:35.462Z,1399557995.462 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:06:35.462Z,1399557995.462 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:06:35.462Z,1399557995.462 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:06:35.462Z,1399557995.462 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:06:35.463Z,1399557995.463 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:06:35.463Z,1399557995.463 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:06:35.463Z,1399557995.463 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:06:35.463Z,1399557995.463 [Default:GPS] Running Loop=1
2014-05-08T14:06:35.463Z,1399557995.463 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:06:35.463Z,1399557995.463 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:06:35.463Z,1399557995.463 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:06:35.464Z,1399557995.464 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:06:35.464Z,1399557995.464 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:06:35.464Z,1399557995.464 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:06:35.464Z,1399557995.464 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:06:35.465Z,1399557995.465 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:06:36.068Z,1399557996.068 [NAL9602](INFO): Powering up
2014-05-08T14:06:37.414Z,1399557997.414 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0072.lzma
2014-05-08T14:06:38.210Z,1399557998.210 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0072.lzma.bak
2014-05-08T14:06:38.210Z,1399557998.210 [DataOverHttps](INFO): SBD MOMSN=811770
2014-05-08T14:06:41.594Z,1399558001.594 [NAL9602](IMPORTANT): GPS fix at: 1399558001.59
2014-05-08T14:06:41.675Z,1399558001.675 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:06:41.675Z,1399558001.675 [Default:GPS:D] Running Loop=1
2014-05-08T14:06:42.512Z,1399558002.512 [Default:GPS:D] Stopped
2014-05-08T14:06:42.512Z,1399558002.512 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:06:42.512Z,1399558002.512 [Default:GPS] Stopped
2014-05-08T14:06:42.513Z,1399558002.513 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:06:42.513Z,1399558002.513 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:06:42.513Z,1399558002.513 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:06:42.993Z,1399558002.993 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:06:45.194Z,1399558005.194 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0073.lzma
2014-05-08T14:06:45.937Z,1399558005.937 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0073.lzma.bak
2014-05-08T14:06:45.937Z,1399558005.937 [DataOverHttps](INFO): SBD MOMSN=811772
2014-05-08T14:06:46.389Z,1399558006.389 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:06:46.389Z,1399558006.389 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:06:46.389Z,1399558006.389 [Default:Iridium] Stopped
2014-05-08T14:06:46.389Z,1399558006.389 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:06:46.389Z,1399558006.389 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:06:46.390Z,1399558006.390 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:06:46.757Z,1399558006.757 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:06:46.757Z,1399558006.757 [Default:CallIridium:B] Stopped
2014-05-08T14:06:46.757Z,1399558006.757 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:06:46.757Z,1399558006.757 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:06:46.757Z,1399558006.757 [Default:CallIridium] Stopped
2014-05-08T14:06:46.758Z,1399558006.758 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:06:52.401Z,1399558012.401 [NAL9602](INFO): Powering down
2014-05-08T14:11:46.933Z,1399558306.933 [Default:CallIridium] Running Loop=1
2014-05-08T14:11:46.933Z,1399558306.933 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:11:46.933Z,1399558306.933 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:11:46.934Z,1399558306.934 [Default:CallIridium:A] Stopped
2014-05-08T14:11:46.934Z,1399558306.934 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:11:46.934Z,1399558306.934 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:11:51.947Z,1399558311.947 [Default:Iridium] Running Loop=1
2014-05-08T14:11:51.947Z,1399558311.947 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:11:51.947Z,1399558311.947 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:11:51.947Z,1399558311.947 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:11:51.948Z,1399558311.948 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:11:51.948Z,1399558311.948 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:11:51.948Z,1399558311.948 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:11:51.948Z,1399558311.948 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:11:51.949Z,1399558311.949 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:11:51.949Z,1399558311.949 [Default:GPS] Running Loop=1
2014-05-08T14:11:51.949Z,1399558311.949 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:11:51.949Z,1399558311.949 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:11:51.950Z,1399558311.950 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:11:51.950Z,1399558311.950 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:11:51.950Z,1399558311.950 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:11:51.950Z,1399558311.950 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:11:51.951Z,1399558311.951 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:11:51.951Z,1399558311.951 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:11:52.548Z,1399558312.548 [NAL9602](INFO): Powering up
2014-05-08T14:11:53.898Z,1399558313.898 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0076.lzma
2014-05-08T14:11:54.688Z,1399558314.688 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0076.lzma.bak
2014-05-08T14:11:54.688Z,1399558314.688 [DataOverHttps](INFO): SBD MOMSN=811775
2014-05-08T14:11:58.072Z,1399558318.072 [NAL9602](IMPORTANT): GPS fix at: 1399558318.00
2014-05-08T14:11:58.105Z,1399558318.105 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:11:58.105Z,1399558318.105 [Default:GPS:D] Running Loop=1
2014-05-08T14:11:59.040Z,1399558319.040 [Default:GPS:D] Stopped
2014-05-08T14:11:59.040Z,1399558319.040 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:11:59.040Z,1399558319.040 [Default:GPS] Stopped
2014-05-08T14:11:59.040Z,1399558319.040 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:11:59.041Z,1399558319.041 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:11:59.041Z,1399558319.041 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:11:59.489Z,1399558319.489 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:12:01.695Z,1399558321.695 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0077.lzma
2014-05-08T14:12:02.452Z,1399558322.452 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0077.lzma.bak
2014-05-08T14:12:02.452Z,1399558322.452 [DataOverHttps](INFO): SBD MOMSN=811777
2014-05-08T14:12:02.899Z,1399558322.899 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:12:02.899Z,1399558322.899 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:12:02.899Z,1399558322.899 [Default:Iridium] Stopped
2014-05-08T14:12:02.899Z,1399558322.899 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:12:02.899Z,1399558322.899 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:12:02.899Z,1399558322.899 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:12:03.268Z,1399558323.268 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:12:03.268Z,1399558323.268 [Default:CallIridium:B] Stopped
2014-05-08T14:12:03.269Z,1399558323.269 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:12:03.269Z,1399558323.269 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:12:03.269Z,1399558323.269 [Default:CallIridium] Stopped
2014-05-08T14:12:03.269Z,1399558323.269 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:12:08.910Z,1399558328.910 [NAL9602](INFO): Powering down
2014-05-08T14:17:03.446Z,1399558623.446 [Default:CallIridium] Running Loop=1
2014-05-08T14:17:03.446Z,1399558623.446 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:17:03.446Z,1399558623.446 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:17:03.446Z,1399558623.446 [Default:CallIridium:A] Stopped
2014-05-08T14:17:03.446Z,1399558623.446 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:17:03.446Z,1399558623.446 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:17:08.462Z,1399558628.462 [Default:Iridium] Running Loop=1
2014-05-08T14:17:08.462Z,1399558628.462 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:17:08.462Z,1399558628.462 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:17:08.462Z,1399558628.462 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:17:08.462Z,1399558628.462 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:17:08.462Z,1399558628.462 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:17:08.464Z,1399558628.464 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:17:08.464Z,1399558628.464 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:17:08.464Z,1399558628.464 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:17:08.465Z,1399558628.465 [Default:GPS] Running Loop=1
2014-05-08T14:17:08.465Z,1399558628.465 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:17:08.465Z,1399558628.465 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:17:08.465Z,1399558628.465 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:17:08.465Z,1399558628.465 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:17:08.465Z,1399558628.465 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:17:08.466Z,1399558628.466 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:17:08.466Z,1399558628.466 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:17:08.466Z,1399558628.466 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:17:09.060Z,1399558629.060 [NAL9602](INFO): Powering up
2014-05-08T14:17:10.415Z,1399558630.415 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0080.lzma
2014-05-08T14:17:11.205Z,1399558631.205 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0080.lzma.bak
2014-05-08T14:17:11.205Z,1399558631.205 [DataOverHttps](INFO): SBD MOMSN=811780
2014-05-08T14:17:14.555Z,1399558634.555 [NAL9602](IMPORTANT): GPS fix at: 1399558634.55
2014-05-08T14:17:14.573Z,1399558634.573 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:17:14.573Z,1399558634.573 [Default:GPS:D] Running Loop=1
2014-05-08T14:17:15.568Z,1399558635.568 [Default:GPS:D] Stopped
2014-05-08T14:17:15.569Z,1399558635.569 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:17:15.569Z,1399558635.569 [Default:GPS] Stopped
2014-05-08T14:17:15.569Z,1399558635.569 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:17:15.569Z,1399558635.569 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:17:15.569Z,1399558635.569 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:17:16.128Z,1399558636.128 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:17:20.758Z,1399558640.758 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0081.lzma
2014-05-08T14:17:21.583Z,1399558641.583 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0081.lzma.bak
2014-05-08T14:17:21.583Z,1399558641.583 [DataOverHttps](INFO): SBD MOMSN=811782
2014-05-08T14:17:21.587Z,1399558641.587 [NAL9602](INFO): Powering down
2014-05-08T14:17:22.004Z,1399558642.004 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:17:22.005Z,1399558642.005 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:17:22.005Z,1399558642.005 [Default:Iridium] Stopped
2014-05-08T14:17:22.005Z,1399558642.005 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:17:22.005Z,1399558642.005 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:17:22.005Z,1399558642.005 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:17:22.373Z,1399558642.373 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:17:22.373Z,1399558642.373 [Default:CallIridium:B] Stopped
2014-05-08T14:17:22.374Z,1399558642.374 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:17:22.374Z,1399558642.374 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:17:22.374Z,1399558642.374 [Default:CallIridium] Stopped
2014-05-08T14:17:22.374Z,1399558642.374 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:22:22.566Z,1399558942.566 [Default:CallIridium] Running Loop=1
2014-05-08T14:22:22.566Z,1399558942.566 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:22:22.566Z,1399558942.566 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:22:22.566Z,1399558942.566 [Default:CallIridium:A] Stopped
2014-05-08T14:22:22.566Z,1399558942.566 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:22:22.567Z,1399558942.567 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:22:27.564Z,1399558947.564 [Default:Iridium] Running Loop=1
2014-05-08T14:22:27.564Z,1399558947.564 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:22:27.564Z,1399558947.564 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:22:27.564Z,1399558947.564 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:22:27.564Z,1399558947.564 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:22:27.564Z,1399558947.564 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:22:27.565Z,1399558947.565 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:22:27.565Z,1399558947.565 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:22:27.565Z,1399558947.565 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:22:27.565Z,1399558947.565 [Default:GPS] Running Loop=1
2014-05-08T14:22:27.566Z,1399558947.566 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:22:27.566Z,1399558947.566 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:22:27.566Z,1399558947.566 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:22:27.566Z,1399558947.566 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:22:27.566Z,1399558947.566 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:22:27.567Z,1399558947.567 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:22:27.567Z,1399558947.567 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:22:27.567Z,1399558947.567 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:22:28.163Z,1399558948.163 [NAL9602](INFO): Powering up
2014-05-08T14:22:29.505Z,1399558949.505 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20140508T123453/Courier0084.lzma
2014-05-08T14:22:30.274Z,1399558950.274 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0084.lzma.bak
2014-05-08T14:22:30.274Z,1399558950.274 [DataOverHttps](INFO): SBD MOMSN=811785
2014-05-08T14:22:33.679Z,1399558953.679 [NAL9602](IMPORTANT): GPS fix at: 1399558953.67
2014-05-08T14:22:33.697Z,1399558953.697 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:22:33.697Z,1399558953.697 [Default:GPS:D] Running Loop=1
2014-05-08T14:22:34.664Z,1399558954.664 [Default:GPS:D] Stopped
2014-05-08T14:22:34.665Z,1399558954.665 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:22:34.665Z,1399558954.665 [Default:GPS] Stopped
2014-05-08T14:22:34.665Z,1399558954.665 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:22:34.668Z,1399558954.668 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:22:34.668Z,1399558954.668 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:22:35.105Z,1399558955.105 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:22:39.831Z,1399558959.831 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0085.lzma
2014-05-08T14:22:40.649Z,1399558960.649 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0085.lzma.bak
2014-05-08T14:22:40.649Z,1399558960.649 [DataOverHttps](INFO): SBD MOMSN=811787
2014-05-08T14:22:40.653Z,1399558960.653 [NAL9602](INFO): Powering down
2014-05-08T14:22:41.072Z,1399558961.072 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:22:41.072Z,1399558961.072 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:22:41.072Z,1399558961.072 [Default:Iridium] Stopped
2014-05-08T14:22:41.072Z,1399558961.072 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:22:41.072Z,1399558961.072 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:22:41.073Z,1399558961.073 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:22:41.441Z,1399558961.441 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:22:41.441Z,1399558961.441 [Default:CallIridium:B] Stopped
2014-05-08T14:22:41.441Z,1399558961.441 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:22:41.442Z,1399558961.442 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:22:41.442Z,1399558961.442 [Default:CallIridium] Stopped
2014-05-08T14:22:41.442Z,1399558961.442 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:27:41.624Z,1399559261.624 [Default:CallIridium] Running Loop=1
2014-05-08T14:27:41.624Z,1399559261.624 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:27:41.625Z,1399559261.625 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:27:41.625Z,1399559261.625 [Default:CallIridium:A] Stopped
2014-05-08T14:27:41.625Z,1399559261.625 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:27:41.625Z,1399559261.625 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:27:46.624Z,1399559266.624 [Default:Iridium] Running Loop=1
2014-05-08T14:27:46.624Z,1399559266.624 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:27:46.624Z,1399559266.624 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:27:46.624Z,1399559266.624 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:27:46.624Z,1399559266.624 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:27:46.624Z,1399559266.624 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:27:46.625Z,1399559266.625 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:27:46.625Z,1399559266.625 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:27:46.625Z,1399559266.625 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:27:46.626Z,1399559266.626 [Default:GPS] Running Loop=1
2014-05-08T14:27:46.626Z,1399559266.626 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:27:46.626Z,1399559266.626 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:27:46.626Z,1399559266.626 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:27:46.626Z,1399559266.626 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:27:46.626Z,1399559266.626 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:27:46.627Z,1399559266.627 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:27:46.627Z,1399559266.627 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:27:46.627Z,1399559266.627 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:27:47.269Z,1399559267.269 [NAL9602](INFO): Powering up
2014-05-08T14:27:48.236Z,1399559268.236 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0088.lzma
2014-05-08T14:27:49.023Z,1399559269.023 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0088.lzma.bak
2014-05-08T14:27:49.023Z,1399559269.023 [DataOverHttps](INFO): SBD MOMSN=811790
2014-05-08T14:27:53.341Z,1399559273.341 [NAL9602](IMPORTANT): GPS fix at: 1399559273.34
2014-05-08T14:27:53.359Z,1399559273.359 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:27:53.359Z,1399559273.359 [Default:GPS:D] Running Loop=1
2014-05-08T14:27:53.497Z,1399559273.497 [Default:GPS:D] Stopped
2014-05-08T14:27:53.497Z,1399559273.497 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:27:53.497Z,1399559273.497 [Default:GPS] Stopped
2014-05-08T14:27:53.498Z,1399559273.498 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:27:53.498Z,1399559273.498 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:27:53.498Z,1399559273.498 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:27:54.240Z,1399559274.240 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:27:58.548Z,1399559278.548 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0089.lzma
2014-05-08T14:27:59.333Z,1399559279.333 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0089.lzma.bak
2014-05-08T14:27:59.333Z,1399559279.333 [DataOverHttps](INFO): SBD MOMSN=811792
2014-05-08T14:27:59.764Z,1399559279.764 [NAL9602](INFO): Powering down
2014-05-08T14:27:59.783Z,1399559279.783 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:27:59.783Z,1399559279.783 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:27:59.783Z,1399559279.783 [Default:Iridium] Stopped
2014-05-08T14:27:59.784Z,1399559279.784 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:27:59.784Z,1399559279.784 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:27:59.784Z,1399559279.784 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:28:00.188Z,1399559280.188 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:28:00.188Z,1399559280.188 [Default:CallIridium:B] Stopped
2014-05-08T14:28:00.188Z,1399559280.188 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:28:00.188Z,1399559280.188 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:28:00.188Z,1399559280.188 [Default:CallIridium] Stopped
2014-05-08T14:28:00.188Z,1399559280.188 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:33:00.344Z,1399559580.344 [Default:CallIridium] Running Loop=1
2014-05-08T14:33:00.345Z,1399559580.345 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:33:00.345Z,1399559580.345 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:33:00.345Z,1399559580.345 [Default:CallIridium:A] Stopped
2014-05-08T14:33:00.345Z,1399559580.345 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:33:00.345Z,1399559580.345 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:33:05.330Z,1399559585.330 [Default:Iridium] Running Loop=1
2014-05-08T14:33:05.330Z,1399559585.330 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:33:05.330Z,1399559585.330 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:33:05.330Z,1399559585.330 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:33:05.330Z,1399559585.330 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:33:05.330Z,1399559585.330 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:33:05.334Z,1399559585.334 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:33:05.334Z,1399559585.334 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:33:05.334Z,1399559585.334 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:33:05.334Z,1399559585.334 [Default:GPS] Running Loop=1
2014-05-08T14:33:05.334Z,1399559585.334 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:33:05.335Z,1399559585.335 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:33:05.335Z,1399559585.335 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:33:05.335Z,1399559585.335 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:33:05.335Z,1399559585.335 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:33:05.336Z,1399559585.336 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:33:05.336Z,1399559585.336 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:33:05.336Z,1399559585.336 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:33:05.945Z,1399559585.945 [NAL9602](INFO): Powering up
2014-05-08T14:33:06.924Z,1399559586.924 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0092.lzma
2014-05-08T14:33:07.685Z,1399559587.685 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0092.lzma.bak
2014-05-08T14:33:07.685Z,1399559587.685 [DataOverHttps](INFO): SBD MOMSN=811795
2014-05-08T14:33:11.902Z,1399559591.902 [NAL9602](IMPORTANT): GPS fix at: 1399559591.90
2014-05-08T14:33:11.940Z,1399559591.940 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:33:11.940Z,1399559591.940 [Default:GPS:D] Running Loop=1
2014-05-08T14:33:12.035Z,1399559592.035 [Default:GPS:D] Stopped
2014-05-08T14:33:12.035Z,1399559592.035 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:33:12.036Z,1399559592.036 [Default:GPS] Stopped
2014-05-08T14:33:12.036Z,1399559592.036 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:33:12.036Z,1399559592.036 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:33:12.036Z,1399559592.036 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:33:12.791Z,1399559592.791 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:33:17.106Z,1399559597.106 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0093.lzma
2014-05-08T14:33:17.894Z,1399559597.894 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0093.lzma.bak
2014-05-08T14:33:17.894Z,1399559597.894 [DataOverHttps](INFO): SBD MOMSN=811797
2014-05-08T14:33:18.397Z,1399559598.397 [NAL9602](INFO): Powering down
2014-05-08T14:33:18.418Z,1399559598.418 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:33:18.419Z,1399559598.419 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:33:18.419Z,1399559598.419 [Default:Iridium] Stopped
2014-05-08T14:33:18.419Z,1399559598.419 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:33:18.419Z,1399559598.419 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:33:18.419Z,1399559598.419 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:33:18.710Z,1399559598.710 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:33:18.711Z,1399559598.711 [Default:CallIridium:B] Stopped
2014-05-08T14:33:18.711Z,1399559598.711 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:33:18.711Z,1399559598.711 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:33:18.711Z,1399559598.711 [Default:CallIridium] Stopped
2014-05-08T14:33:18.711Z,1399559598.711 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:38:18.802Z,1399559898.802 [Default:CallIridium] Running Loop=1
2014-05-08T14:38:18.802Z,1399559898.802 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:38:18.802Z,1399559898.802 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:38:18.803Z,1399559898.803 [Default:CallIridium:A] Stopped
2014-05-08T14:38:18.803Z,1399559898.803 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:38:18.803Z,1399559898.803 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:38:23.946Z,1399559903.946 [Default:Iridium] Running Loop=1
2014-05-08T14:38:23.946Z,1399559903.946 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:38:23.947Z,1399559903.947 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:38:23.947Z,1399559903.947 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:38:23.947Z,1399559903.947 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:38:23.947Z,1399559903.947 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:38:23.948Z,1399559903.948 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:38:23.948Z,1399559903.948 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:38:23.948Z,1399559903.948 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:38:23.948Z,1399559903.948 [Default:GPS] Running Loop=1
2014-05-08T14:38:23.948Z,1399559903.948 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:38:23.948Z,1399559903.948 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:38:23.948Z,1399559903.948 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:38:23.949Z,1399559903.949 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:38:23.949Z,1399559903.949 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:38:23.949Z,1399559903.949 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:38:23.950Z,1399559903.950 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:38:23.950Z,1399559903.950 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:38:24.964Z,1399559904.964 [NAL9602](INFO): Powering up
2014-05-08T14:38:25.056Z,1399559905.056 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0096.lzma
2014-05-08T14:38:25.847Z,1399559905.847 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0096.lzma.bak
2014-05-08T14:38:25.847Z,1399559905.847 [DataOverHttps](INFO): SBD MOMSN=811800
2014-05-08T14:38:29.300Z,1399559909.300 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#6 STATUS: 65535
2014-05-08T14:38:30.121Z,1399559910.121 [NAL9602](IMPORTANT): GPS fix at: 1399559910.11
2014-05-08T14:38:30.151Z,1399559910.151 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:38:30.151Z,1399559910.151 [Default:GPS:D] Running Loop=1
2014-05-08T14:38:30.305Z,1399559910.305 [Default:GPS:D] Stopped
2014-05-08T14:38:30.306Z,1399559910.306 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:38:30.306Z,1399559910.306 [Default:GPS] Stopped
2014-05-08T14:38:30.306Z,1399559910.306 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:38:30.306Z,1399559910.306 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:38:30.306Z,1399559910.306 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:38:31.006Z,1399559911.006 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:38:35.300Z,1399559915.300 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20140508T123453/Express0097.lzma
2014-05-08T14:38:36.093Z,1399559916.093 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0097.lzma.bak
2014-05-08T14:38:36.093Z,1399559916.093 [DataOverHttps](INFO): SBD MOMSN=811802
2014-05-08T14:38:36.515Z,1399559916.515 [NAL9602](INFO): Powering down
2014-05-08T14:38:36.554Z,1399559916.554 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:38:36.554Z,1399559916.554 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:38:36.554Z,1399559916.554 [Default:Iridium] Stopped
2014-05-08T14:38:36.555Z,1399559916.555 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:38:36.555Z,1399559916.555 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:38:36.555Z,1399559916.555 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:38:36.952Z,1399559916.952 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:38:36.952Z,1399559916.952 [Default:CallIridium:B] Stopped
2014-05-08T14:38:36.952Z,1399559916.952 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:38:36.952Z,1399559916.952 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:38:36.952Z,1399559916.952 [Default:CallIridium] Stopped
2014-05-08T14:38:36.953Z,1399559916.953 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:43:37.102Z,1399560217.102 [Default:CallIridium] Running Loop=1
2014-05-08T14:43:37.102Z,1399560217.102 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:43:37.102Z,1399560217.102 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:43:37.103Z,1399560217.103 [Default:CallIridium:A] Stopped
2014-05-08T14:43:37.103Z,1399560217.103 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:43:37.103Z,1399560217.103 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:43:42.098Z,1399560222.098 [Default:Iridium] Running Loop=1
2014-05-08T14:43:42.098Z,1399560222.098 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:43:42.099Z,1399560222.099 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:43:42.099Z,1399560222.099 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:43:42.099Z,1399560222.099 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:43:42.099Z,1399560222.099 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:43:42.100Z,1399560222.100 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:43:42.100Z,1399560222.100 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:43:42.100Z,1399560222.100 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:43:42.100Z,1399560222.100 [Default:GPS] Running Loop=1
2014-05-08T14:43:42.100Z,1399560222.100 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:43:42.100Z,1399560222.100 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:43:42.100Z,1399560222.100 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:43:42.101Z,1399560222.101 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:43:42.101Z,1399560222.101 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:43:42.101Z,1399560222.101 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:43:42.101Z,1399560222.101 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:43:42.102Z,1399560222.102 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:43:42.706Z,1399560222.706 [NAL9602](INFO): Powering up
2014-05-08T14:43:44.108Z,1399560224.108 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20140508T123453/Courier0100.lzma
2014-05-08T14:43:44.942Z,1399560224.942 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0100.lzma.bak
2014-05-08T14:43:44.943Z,1399560224.943 [DataOverHttps](INFO): SBD MOMSN=811805
2014-05-08T14:43:48.245Z,1399560228.245 [NAL9602](IMPORTANT): GPS fix at: 1399560228.24
2014-05-08T14:43:48.262Z,1399560228.262 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:43:48.262Z,1399560228.262 [Default:GPS:D] Running Loop=1
2014-05-08T14:43:49.203Z,1399560229.203 [Default:GPS:D] Stopped
2014-05-08T14:43:49.203Z,1399560229.203 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:43:49.204Z,1399560229.204 [Default:GPS] Stopped
2014-05-08T14:43:49.204Z,1399560229.204 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:43:49.204Z,1399560229.204 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:43:49.204Z,1399560229.204 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:43:49.766Z,1399560229.766 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:43:54.360Z,1399560234.360 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0101.lzma
2014-05-08T14:43:55.143Z,1399560235.143 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0101.lzma.bak
2014-05-08T14:43:55.143Z,1399560235.143 [DataOverHttps](INFO): SBD MOMSN=811807
2014-05-08T14:43:55.148Z,1399560235.148 [NAL9602](INFO): Powering down
2014-05-08T14:43:55.582Z,1399560235.582 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:43:55.582Z,1399560235.582 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:43:55.582Z,1399560235.582 [Default:Iridium] Stopped
2014-05-08T14:43:55.583Z,1399560235.583 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:43:55.583Z,1399560235.583 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:43:55.583Z,1399560235.583 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:43:55.964Z,1399560235.964 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:43:55.964Z,1399560235.964 [Default:CallIridium:B] Stopped
2014-05-08T14:43:55.964Z,1399560235.964 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:43:55.964Z,1399560235.964 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:43:55.964Z,1399560235.964 [Default:CallIridium] Stopped
2014-05-08T14:43:55.964Z,1399560235.964 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:48:56.136Z,1399560536.136 [Default:CallIridium] Running Loop=1
2014-05-08T14:48:56.136Z,1399560536.136 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:48:56.136Z,1399560536.136 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:48:56.136Z,1399560536.136 [Default:CallIridium:A] Stopped
2014-05-08T14:48:56.137Z,1399560536.137 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:48:56.137Z,1399560536.137 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:49:01.161Z,1399560541.161 [Default:Iridium] Running Loop=1
2014-05-08T14:49:01.161Z,1399560541.161 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:49:01.161Z,1399560541.161 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:49:01.161Z,1399560541.161 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:49:01.161Z,1399560541.161 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:49:01.162Z,1399560541.162 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:49:01.162Z,1399560541.162 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:49:01.162Z,1399560541.162 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:49:01.163Z,1399560541.163 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:49:01.163Z,1399560541.163 [Default:GPS] Running Loop=1
2014-05-08T14:49:01.163Z,1399560541.163 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:49:01.163Z,1399560541.163 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:49:01.163Z,1399560541.163 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:49:01.163Z,1399560541.163 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:49:01.163Z,1399560541.163 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:49:01.164Z,1399560541.164 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:49:01.164Z,1399560541.164 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:49:01.164Z,1399560541.164 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:49:01.760Z,1399560541.760 [NAL9602](INFO): Powering up
2014-05-08T14:49:03.145Z,1399560543.145 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0104.lzma
2014-05-08T14:49:03.895Z,1399560543.895 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0104.lzma.bak
2014-05-08T14:49:03.895Z,1399560543.895 [DataOverHttps](INFO): SBD MOMSN=811810
2014-05-08T14:49:07.270Z,1399560547.270 [NAL9602](IMPORTANT): GPS fix at: 1399560547.26
2014-05-08T14:49:07.287Z,1399560547.287 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:49:07.287Z,1399560547.287 [Default:GPS:D] Running Loop=1
2014-05-08T14:49:08.216Z,1399560548.216 [Default:GPS:D] Stopped
2014-05-08T14:49:08.216Z,1399560548.216 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:49:08.216Z,1399560548.216 [Default:GPS] Stopped
2014-05-08T14:49:08.217Z,1399560548.217 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:49:08.217Z,1399560548.217 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:49:08.217Z,1399560548.217 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:49:08.670Z,1399560548.670 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:49:13.413Z,1399560553.413 [DataOverHttps](INFO): Sending 106 bytes from file Logs/20140508T123453/Express0105.lzma
2014-05-08T14:49:14.214Z,1399560554.214 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0105.lzma.bak
2014-05-08T14:49:14.214Z,1399560554.214 [DataOverHttps](INFO): SBD MOMSN=811812
2014-05-08T14:49:14.219Z,1399560554.219 [NAL9602](INFO): Powering down
2014-05-08T14:49:14.667Z,1399560554.667 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:49:14.667Z,1399560554.667 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:49:14.667Z,1399560554.667 [Default:Iridium] Stopped
2014-05-08T14:49:14.668Z,1399560554.668 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:49:14.668Z,1399560554.668 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:49:14.668Z,1399560554.668 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:49:15.035Z,1399560555.035 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:49:15.035Z,1399560555.035 [Default:CallIridium:B] Stopped
2014-05-08T14:49:15.035Z,1399560555.035 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:49:15.036Z,1399560555.036 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:49:15.036Z,1399560555.036 [Default:CallIridium] Stopped
2014-05-08T14:49:15.036Z,1399560555.036 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:54:15.191Z,1399560855.191 [Default:CallIridium] Running Loop=1
2014-05-08T14:54:15.191Z,1399560855.191 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:54:15.191Z,1399560855.191 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:54:15.192Z,1399560855.192 [Default:CallIridium:A] Stopped
2014-05-08T14:54:15.192Z,1399560855.192 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:54:15.192Z,1399560855.192 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:54:20.223Z,1399560860.223 [Default:Iridium] Running Loop=1
2014-05-08T14:54:20.223Z,1399560860.223 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:54:20.223Z,1399560860.223 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:54:20.223Z,1399560860.223 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:54:20.223Z,1399560860.223 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:54:20.223Z,1399560860.223 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:54:20.224Z,1399560860.224 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:54:20.224Z,1399560860.224 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:54:20.224Z,1399560860.224 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:54:20.225Z,1399560860.225 [Default:GPS] Running Loop=1
2014-05-08T14:54:20.225Z,1399560860.225 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:54:20.225Z,1399560860.225 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:54:20.225Z,1399560860.225 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:54:20.225Z,1399560860.225 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:54:20.225Z,1399560860.225 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:54:20.226Z,1399560860.226 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:54:20.226Z,1399560860.226 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:54:20.226Z,1399560860.226 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:54:20.831Z,1399560860.831 [NAL9602](INFO): Powering up
2014-05-08T14:54:22.240Z,1399560862.240 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0108.lzma
2014-05-08T14:54:23.054Z,1399560863.054 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0108.lzma.bak
2014-05-08T14:54:23.054Z,1399560863.054 [DataOverHttps](INFO): SBD MOMSN=811815
2014-05-08T14:54:26.432Z,1399560866.432 [NAL9602](IMPORTANT): GPS fix at: 1399560866.43
2014-05-08T14:54:26.449Z,1399560866.449 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:54:26.450Z,1399560866.450 [Default:GPS:D] Running Loop=1
2014-05-08T14:54:27.369Z,1399560867.369 [Default:GPS:D] Stopped
2014-05-08T14:54:27.370Z,1399560867.370 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:54:27.370Z,1399560867.370 [Default:GPS] Stopped
2014-05-08T14:54:27.370Z,1399560867.370 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:54:27.370Z,1399560867.370 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:54:27.370Z,1399560867.370 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:54:27.820Z,1399560867.820 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:54:32.525Z,1399560872.525 [DataOverHttps](INFO): Sending 106 bytes from file Logs/20140508T123453/Express0109.lzma
2014-05-08T14:54:33.317Z,1399560873.317 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0109.lzma.bak
2014-05-08T14:54:33.318Z,1399560873.318 [DataOverHttps](INFO): SBD MOMSN=811817
2014-05-08T14:54:33.322Z,1399560873.322 [NAL9602](INFO): Powering down
2014-05-08T14:54:33.767Z,1399560873.767 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:54:33.768Z,1399560873.768 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:54:33.768Z,1399560873.768 [Default:Iridium] Stopped
2014-05-08T14:54:33.768Z,1399560873.768 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:54:33.768Z,1399560873.768 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:54:33.768Z,1399560873.768 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:54:34.137Z,1399560874.137 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:54:34.137Z,1399560874.137 [Default:CallIridium:B] Stopped
2014-05-08T14:54:34.137Z,1399560874.137 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:54:34.138Z,1399560874.138 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:54:34.138Z,1399560874.138 [Default:CallIridium] Stopped
2014-05-08T14:54:34.138Z,1399560874.138 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T14:59:34.326Z,1399561174.326 [Default:CallIridium] Running Loop=1
2014-05-08T14:59:34.326Z,1399561174.326 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T14:59:34.326Z,1399561174.326 [Default:CallIridium:A] Running Loop=1
2014-05-08T14:59:34.329Z,1399561174.329 [Default:CallIridium:A] Stopped
2014-05-08T14:59:34.329Z,1399561174.329 [Default:CallIridium:B] Running Loop=1
2014-05-08T14:59:34.329Z,1399561174.329 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T14:59:39.305Z,1399561179.305 [Default:Iridium] Running Loop=1
2014-05-08T14:59:39.305Z,1399561179.305 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T14:59:39.305Z,1399561179.305 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T14:59:39.305Z,1399561179.305 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:59:39.305Z,1399561179.305 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T14:59:39.306Z,1399561179.306 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:59:39.338Z,1399561179.338 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T14:59:39.339Z,1399561179.339 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:59:39.339Z,1399561179.339 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T14:59:39.339Z,1399561179.339 [Default:GPS] Running Loop=1
2014-05-08T14:59:39.339Z,1399561179.339 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T14:59:39.339Z,1399561179.339 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T14:59:39.339Z,1399561179.339 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T14:59:39.339Z,1399561179.339 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T14:59:39.340Z,1399561179.340 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T14:59:39.340Z,1399561179.340 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T14:59:39.340Z,1399561179.340 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T14:59:39.341Z,1399561179.341 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T14:59:39.929Z,1399561179.929 [NAL9602](INFO): Powering up
2014-05-08T14:59:41.322Z,1399561181.322 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20140508T123453/Courier0112.lzma
2014-05-08T14:59:42.169Z,1399561182.169 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0112.lzma.bak
2014-05-08T14:59:42.169Z,1399561182.169 [DataOverHttps](INFO): SBD MOMSN=811820
2014-05-08T14:59:45.474Z,1399561185.474 [NAL9602](IMPORTANT): GPS fix at: 1399561185.47
2014-05-08T14:59:45.491Z,1399561185.491 [Default:GPS:Read_GPS] Stopped
2014-05-08T14:59:45.491Z,1399561185.491 [Default:GPS:D] Running Loop=1
2014-05-08T14:59:46.429Z,1399561186.429 [Default:GPS:D] Stopped
2014-05-08T14:59:46.430Z,1399561186.430 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T14:59:46.430Z,1399561186.430 [Default:GPS] Stopped
2014-05-08T14:59:46.430Z,1399561186.430 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T14:59:46.430Z,1399561186.430 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T14:59:46.430Z,1399561186.430 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:59:46.918Z,1399561186.918 [NAL9602](INFO): No messages in MT queue
2014-05-08T14:59:51.576Z,1399561191.576 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0113.lzma
2014-05-08T14:59:52.433Z,1399561192.433 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0113.lzma.bak
2014-05-08T14:59:52.433Z,1399561192.433 [DataOverHttps](INFO): SBD MOMSN=811822
2014-05-08T14:59:52.438Z,1399561192.438 [NAL9602](INFO): Powering down
2014-05-08T14:59:52.826Z,1399561192.826 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T14:59:52.827Z,1399561192.827 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T14:59:52.827Z,1399561192.827 [Default:Iridium] Stopped
2014-05-08T14:59:52.827Z,1399561192.827 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T14:59:52.827Z,1399561192.827 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T14:59:52.827Z,1399561192.827 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T14:59:53.233Z,1399561193.233 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T14:59:53.233Z,1399561193.233 [Default:CallIridium:B] Stopped
2014-05-08T14:59:53.233Z,1399561193.233 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T14:59:53.234Z,1399561193.234 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T14:59:53.234Z,1399561193.234 [Default:CallIridium] Stopped
2014-05-08T14:59:53.234Z,1399561193.234 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T15:04:53.388Z,1399561493.388 [Default:CallIridium] Running Loop=1
2014-05-08T15:04:53.388Z,1399561493.388 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T15:04:53.388Z,1399561493.388 [Default:CallIridium:A] Running Loop=1
2014-05-08T15:04:53.388Z,1399561493.388 [Default:CallIridium:A] Stopped
2014-05-08T15:04:53.389Z,1399561493.389 [Default:CallIridium:B] Running Loop=1
2014-05-08T15:04:53.389Z,1399561493.389 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T15:04:58.351Z,1399561498.351 [Default:Iridium] Running Loop=1
2014-05-08T15:04:58.351Z,1399561498.351 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T15:04:58.351Z,1399561498.351 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T15:04:58.351Z,1399561498.351 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T15:04:58.351Z,1399561498.351 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T15:04:58.352Z,1399561498.352 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T15:04:58.352Z,1399561498.352 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T15:04:58.352Z,1399561498.352 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T15:04:58.352Z,1399561498.352 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T15:04:58.353Z,1399561498.353 [Default:GPS] Running Loop=1
2014-05-08T15:04:58.353Z,1399561498.353 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T15:04:58.353Z,1399561498.353 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T15:04:58.353Z,1399561498.353 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T15:04:58.353Z,1399561498.353 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T15:04:58.353Z,1399561498.353 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T15:04:58.354Z,1399561498.354 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T15:04:58.354Z,1399561498.354 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T15:04:58.354Z,1399561498.354 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T15:04:58.983Z,1399561498.983 [NAL9602](INFO): Powering up
2014-05-08T15:05:00.412Z,1399561500.412 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0116.lzma
2014-05-08T15:05:01.142Z,1399561501.142 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0116.lzma.bak
2014-05-08T15:05:01.143Z,1399561501.143 [DataOverHttps](INFO): SBD MOMSN=811825
2014-05-08T15:05:04.502Z,1399561504.502 [NAL9602](IMPORTANT): GPS fix at: 1399561504.50
2014-05-08T15:05:04.519Z,1399561504.519 [Default:GPS:Read_GPS] Stopped
2014-05-08T15:05:04.519Z,1399561504.519 [Default:GPS:D] Running Loop=1
2014-05-08T15:05:05.461Z,1399561505.461 [Default:GPS:D] Stopped
2014-05-08T15:05:05.462Z,1399561505.462 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T15:05:05.462Z,1399561505.462 [Default:GPS] Stopped
2014-05-08T15:05:05.462Z,1399561505.462 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T15:05:05.462Z,1399561505.462 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T15:05:05.462Z,1399561505.462 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T15:05:05.944Z,1399561505.944 [NAL9602](INFO): No messages in MT queue
2014-05-08T15:05:10.670Z,1399561510.670 [DataOverHttps](INFO): Sending 106 bytes from file Logs/20140508T123453/Express0117.lzma
2014-05-08T15:05:11.452Z,1399561511.452 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0117.lzma.bak
2014-05-08T15:05:11.452Z,1399561511.452 [DataOverHttps](INFO): SBD MOMSN=811827
2014-05-08T15:05:11.457Z,1399561511.457 [NAL9602](INFO): Powering down
2014-05-08T15:05:11.902Z,1399561511.902 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T15:05:11.902Z,1399561511.902 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T15:05:11.902Z,1399561511.902 [Default:Iridium] Stopped
2014-05-08T15:05:11.902Z,1399561511.902 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T15:05:11.903Z,1399561511.903 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T15:05:11.903Z,1399561511.903 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T15:05:12.272Z,1399561512.272 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T15:05:12.272Z,1399561512.272 [Default:CallIridium:B] Stopped
2014-05-08T15:05:12.273Z,1399561512.273 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T15:05:12.273Z,1399561512.273 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T15:05:12.273Z,1399561512.273 [Default:CallIridium] Stopped
2014-05-08T15:05:12.273Z,1399561512.273 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T15:10:12.447Z,1399561812.447 [Default:CallIridium] Running Loop=1
2014-05-08T15:10:12.448Z,1399561812.448 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T15:10:12.449Z,1399561812.449 [Default:CallIridium:A] Running Loop=1
2014-05-08T15:10:12.449Z,1399561812.449 [Default:CallIridium:A] Stopped
2014-05-08T15:10:12.449Z,1399561812.449 [Default:CallIridium:B] Running Loop=1
2014-05-08T15:10:12.449Z,1399561812.449 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T15:10:17.463Z,1399561817.463 [Default:Iridium] Running Loop=1
2014-05-08T15:10:17.463Z,1399561817.463 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T15:10:17.463Z,1399561817.463 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T15:10:17.463Z,1399561817.463 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T15:10:17.463Z,1399561817.463 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T15:10:17.463Z,1399561817.463 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T15:10:17.464Z,1399561817.464 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T15:10:17.464Z,1399561817.464 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T15:10:17.464Z,1399561817.464 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T15:10:17.465Z,1399561817.465 [Default:GPS] Running Loop=1
2014-05-08T15:10:17.465Z,1399561817.465 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T15:10:17.465Z,1399561817.465 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T15:10:17.465Z,1399561817.465 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T15:10:17.465Z,1399561817.465 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T15:10:17.465Z,1399561817.465 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T15:10:17.466Z,1399561817.466 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T15:10:17.466Z,1399561817.466 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T15:10:17.466Z,1399561817.466 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T15:10:18.113Z,1399561818.113 [NAL9602](INFO): Powering up
2014-05-08T15:10:19.506Z,1399561819.506 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20140508T123453/Courier0120.lzma
2014-05-08T15:10:20.287Z,1399561820.287 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0120.lzma.bak
2014-05-08T15:10:20.287Z,1399561820.287 [DataOverHttps](INFO): SBD MOMSN=811830
2014-05-08T15:10:23.668Z,1399561823.668 [NAL9602](IMPORTANT): GPS fix at: 1399561823.66
2014-05-08T15:10:23.685Z,1399561823.685 [Default:GPS:Read_GPS] Stopped
2014-05-08T15:10:23.685Z,1399561823.685 [Default:GPS:D] Running Loop=1
2014-05-08T15:10:24.710Z,1399561824.710 [Default:GPS:D] Stopped
2014-05-08T15:10:24.710Z,1399561824.710 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T15:10:24.710Z,1399561824.710 [Default:GPS] Stopped
2014-05-08T15:10:24.710Z,1399561824.710 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T15:10:24.710Z,1399561824.710 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T15:10:24.710Z,1399561824.710 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T15:10:25.161Z,1399561825.161 [NAL9602](INFO): No messages in MT queue
2014-05-08T15:10:29.939Z,1399561829.939 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0121.lzma
2014-05-08T15:10:30.717Z,1399561830.717 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0121.lzma.bak
2014-05-08T15:10:30.717Z,1399561830.717 [DataOverHttps](INFO): SBD MOMSN=811832
2014-05-08T15:10:30.721Z,1399561830.721 [NAL9602](INFO): Powering down
2014-05-08T15:10:31.165Z,1399561831.165 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T15:10:31.166Z,1399561831.166 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T15:10:31.166Z,1399561831.166 [Default:Iridium] Stopped
2014-05-08T15:10:31.166Z,1399561831.166 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T15:10:31.166Z,1399561831.166 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T15:10:31.166Z,1399561831.166 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T15:10:31.533Z,1399561831.533 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T15:10:31.533Z,1399561831.533 [Default:CallIridium:B] Stopped
2014-05-08T15:10:31.533Z,1399561831.533 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T15:10:31.534Z,1399561831.534 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T15:10:31.534Z,1399561831.534 [Default:CallIridium] Stopped
2014-05-08T15:10:31.534Z,1399561831.534 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T15:15:31.726Z,1399562131.726 [Default:CallIridium] Running Loop=1
2014-05-08T15:15:31.726Z,1399562131.726 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2014-05-08T15:15:31.726Z,1399562131.726 [Default:CallIridium:A] Running Loop=1
2014-05-08T15:15:31.726Z,1399562131.726 [Default:CallIridium:A] Stopped
2014-05-08T15:15:31.726Z,1399562131.726 [Default:CallIridium:B] Running Loop=1
2014-05-08T15:15:31.727Z,1399562131.727 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2014-05-08T15:15:36.715Z,1399562136.715 [Default:Iridium] Running Loop=1
2014-05-08T15:15:36.715Z,1399562136.715 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2014-05-08T15:15:36.716Z,1399562136.716 [Default:Iridium:A.SetSpeed] Running Loop=1
2014-05-08T15:15:36.716Z,1399562136.716 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2014-05-08T15:15:36.716Z,1399562136.716 [Default:Iridium:B.GoToSurface] Running Loop=1
2014-05-08T15:15:36.716Z,1399562136.716 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T15:15:36.717Z,1399562136.717 [Default:Iridium:B.GoToSurface] Stopped
2014-05-08T15:15:36.717Z,1399562136.717 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T15:15:36.717Z,1399562136.717 [Default:Iridium:Read_Iridium] Running Loop=1
2014-05-08T15:15:36.717Z,1399562136.717 [Default:GPS] Running Loop=1
2014-05-08T15:15:36.717Z,1399562136.717 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2014-05-08T15:15:36.717Z,1399562136.717 [Default:GPS:A.SetSpeed] Running Loop=1
2014-05-08T15:15:36.717Z,1399562136.717 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2014-05-08T15:15:36.718Z,1399562136.718 [Default:GPS:B.GoToSurface] Running Loop=1
2014-05-08T15:15:36.718Z,1399562136.718 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2014-05-08T15:15:36.718Z,1399562136.718 [Default:GPS:B.GoToSurface] Stopped
2014-05-08T15:15:36.718Z,1399562136.718 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T15:15:36.719Z,1399562136.719 [Default:GPS:Read_GPS] Running Loop=1
2014-05-08T15:15:37.365Z,1399562137.365 [NAL9602](INFO): Powering up
2014-05-08T15:15:38.712Z,1399562138.712 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20140508T123453/Courier0124.lzma
2014-05-08T15:15:39.514Z,1399562139.514 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Courier0124.lzma.bak
2014-05-08T15:15:39.515Z,1399562139.515 [DataOverHttps](INFO): SBD MOMSN=811835
2014-05-08T15:15:42.912Z,1399562142.912 [NAL9602](IMPORTANT): GPS fix at: 1399562142.91
2014-05-08T15:15:42.929Z,1399562142.929 [Default:GPS:Read_GPS] Stopped
2014-05-08T15:15:42.929Z,1399562142.929 [Default:GPS:D] Running Loop=1
2014-05-08T15:15:43.863Z,1399562143.863 [Default:GPS:D] Stopped
2014-05-08T15:15:43.864Z,1399562143.864 [Default:GPS](INFO): Completed Default:GPS
2014-05-08T15:15:43.864Z,1399562143.864 [Default:GPS] Stopped
2014-05-08T15:15:43.864Z,1399562143.864 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2014-05-08T15:15:43.864Z,1399562143.864 [Default:GPS:A.SetSpeed] Stopped
2014-05-08T15:15:43.864Z,1399562143.864 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T15:15:44.301Z,1399562144.301 [NAL9602](INFO): No messages in MT queue
2014-05-08T15:15:49.078Z,1399562149.078 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20140508T123453/Express0125.lzma
2014-05-08T15:15:49.865Z,1399562149.865 [DataOverHttps](INFO): Moved sent file to Logs/20140508T123453/Express0125.lzma.bak
2014-05-08T15:15:49.865Z,1399562149.865 [DataOverHttps](INFO): SBD MOMSN=811837
2014-05-08T15:15:49.873Z,1399562149.873 [NAL9602](INFO): Powering down
2014-05-08T15:15:50.346Z,1399562150.346 [Default:Iridium:Read_Iridium] Stopped
2014-05-08T15:15:50.346Z,1399562150.346 [Default:Iridium](INFO): Completed Default:Iridium
2014-05-08T15:15:50.346Z,1399562150.346 [Default:Iridium] Stopped
2014-05-08T15:15:50.347Z,1399562150.347 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2014-05-08T15:15:50.347Z,1399562150.347 [Default:Iridium:A.SetSpeed] Stopped
2014-05-08T15:15:50.347Z,1399562150.347 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2014-05-08T15:15:50.692Z,1399562150.692 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2014-05-08T15:15:50.692Z,1399562150.692 [Default:CallIridium:B] Stopped
2014-05-08T15:15:50.693Z,1399562150.693 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2014-05-08T15:15:50.693Z,1399562150.693 [Default:CallIridium](INFO): Completed Default:CallIridium
2014-05-08T15:15:50.693Z,1399562150.693 [Default:CallIridium] Stopped
2014-05-08T15:15:50.693Z,1399562150.693 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2014-05-08T15:18:35.897Z,1399562315.897 [CommandLine](IMPORTANT): got command quit
2014-05-08T15:18:36.909Z,1399562316.909 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2014-05-08T15:18:36.910Z,1399562316.910 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:36.954Z,1399562316.954 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2014-05-08T15:18:36.954Z,1399562316.954 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:36.955Z,1399562316.955 [CommandLine](INFO): Join timeout helper Thread ID is 1670
2014-05-08T15:18:36.966Z,1399562316.966 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2014-05-08T15:18:36.966Z,1399562316.966 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:36.967Z,1399562316.967 [NavChartDb](INFO): Join timeout helper Thread ID is 1671
2014-05-08T15:18:37.199Z,1399562317.199 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2014-05-08T15:18:37.199Z,1399562317.199 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:37.207Z,1399562317.207 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2014-05-08T15:18:37.207Z,1399562317.207 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:37.207Z,1399562317.207 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1672
2014-05-08T15:18:37.275Z,1399562317.275 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2014-05-08T15:18:37.275Z,1399562317.275 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:37.287Z,1399562317.287 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2014-05-08T15:18:37.287Z,1399562317.287 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:37.287Z,1399562317.287 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1673
2014-05-08T15:18:37.683Z,1399562317.683 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2014-05-08T15:18:37.684Z,1399562317.684 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:37.687Z,1399562317.687 [ComponentRegistry](INFO): Shutting down AsyncPiEstimator ThreadHandler
2014-05-08T15:18:37.687Z,1399562317.687 [AsyncPiEstimator ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:37.688Z,1399562317.688 [AsyncPiEstimator](INFO): Join timeout helper Thread ID is 1674
2014-05-08T15:18:37.992Z,1399562317.992 [AsyncPiEstimator ThreadHandler](INFO): Uninitializing protected caller thread.
2014-05-08T15:18:37.992Z,1399562317.992 [AsyncPiEstimator](DEBUG): Uninitialize AsyncPiEstimator.
2014-05-08T15:18:37.992Z,1399562317.992 [AsyncPiEstimator ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:38.009Z,1399562318.009 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2014-05-08T15:18:38.010Z,1399562318.010 [logger ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:38.010Z,1399562318.010 [logger](INFO): Join timeout helper Thread ID is 1675
2014-05-08T15:18:38.010Z,1399562318.010 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2014-05-08T15:18:38.011Z,1399562318.011 [logger ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:38.013Z,1399562318.013 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2014-05-08T15:18:38.013Z,1399562318.013 [CommandLine ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:38.013Z,1399562318.013 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2014-05-08T15:18:38.013Z,1399562318.013 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:38.013Z,1399562318.013 [controlThread](INFO): Join timeout helper Thread ID is 1676
2014-05-08T15:18:40.628Z,1399562320.628 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2014-05-08T15:18:40.628Z,1399562320.628 [controlThread](DEBUG): Uninitializing ControlThread
2014-05-08T15:18:40.631Z,1399562320.631 [NAL9602](INFO): Powering down
2014-05-08T15:18:40.719Z,1399562320.719 [Radio_Freewave](INFO): Powering down
2014-05-08T15:18:40.721Z,1399562320.721 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2014-05-08T15:18:40.723Z,1399562320.723 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2014-05-08T15:18:40.723Z,1399562320.723 [Default] Stopped
2014-05-08T15:18:40.723Z,1399562320.723 [Default](INFO): Aggregate::uninitialize Default
2014-05-08T15:18:40.724Z,1399562320.724 [Default:WaitAtTheSurface] Stopped
2014-05-08T15:18:40.724Z,1399562320.724 [Default:WaitAtTheSurface](INFO): Aggregate::uninitialize Default:WaitAtTheSurface
2014-05-08T15:18:40.724Z,1399562320.724 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed] Stopped
2014-05-08T15:18:40.724Z,1399562320.724 [Default:WaitAtTheSurface:RunAtLowSpeed.SetSpeed](DEBUG): Uninitialize.
2014-05-08T15:18:40.724Z,1399562320.724 [Default:WaitAtTheSurface:B.GoToSurface] Stopped
2014-05-08T15:18:40.724Z,1399562320.724 [Default:WaitAtTheSurface:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2014-05-08T15:18:40.731Z,1399562320.731 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2014-05-08T15:18:40.732Z,1399562320.732 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2014-05-08T15:18:40.732Z,1399562320.732 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2014-05-08T15:18:40.732Z,1399562320.732 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2014-05-08T15:18:40.733Z,1399562320.733 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2014-05-08T15:18:40.733Z,1399562320.733 [BuoyancyServo](INFO): Powering down
2014-05-08T15:18:40.744Z,1399562320.744 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2014-05-08T15:18:40.744Z,1399562320.744 [ElevatorServo](INFO): Powering down
2014-05-08T15:18:40.745Z,1399562320.745 [MassServo](DEBUG): Uninitialize Mass Servo.
2014-05-08T15:18:40.745Z,1399562320.745 [MassServo](INFO): Powering down
2014-05-08T15:18:40.746Z,1399562320.746 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2014-05-08T15:18:40.747Z,1399562320.747 [RudderServo](INFO): Powering down
2014-05-08T15:18:40.748Z,1399562320.748 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2014-05-08T15:18:40.748Z,1399562320.748 [SBIT](DEBUG): Uninitialize SBIT Component.
2014-05-08T15:18:40.748Z,1399562320.748 [IBIT](DEBUG): Uninitialize IBIT Component.
2014-05-08T15:18:40.749Z,1399562320.749 [CBIT](DEBUG): Uninitialize CBIT Component.
2014-05-08T15:18:40.793Z,1399562320.793 [controlThread ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:40.874Z,1399562320.874 [AsyncPiEstimator ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:40.897Z,1399562320.897 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:40.900Z,1399562320.900 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:40.933Z,1399562320.933 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2014-05-08T15:18:40.991Z,1399562320.991 [logger ThreadHandler](INFO): Thread cancelled.