2013-11-06T21:13:39.376Z,1383772419.376 [Supervisor](DEBUG): Initializing supervisor.
2013-11-06T21:13:39.379Z,1383772419.379 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2013-11-06T21:13:39.380Z,1383772419.380 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2013-11-06T21:13:39.381Z,1383772419.381 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2013-11-06T21:13:39.385Z,1383772419.385 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2013-11-06T21:13:39.397Z,1383772419.397 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2013-11-06T21:13:39.398Z,1383772419.398 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2013-11-06T21:13:39.399Z,1383772419.399 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2013-11-06T21:13:39.400Z,1383772419.400 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403CB4E0
2013-11-06T21:13:39.402Z,1383772419.402 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2013-11-06T21:13:39.403Z,1383772419.403 [Supervisor](INFO): Looking for Config files in directory: Config/
2013-11-06T21:13:39.404Z,1383772419.404 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2013-11-06T21:13:39.852Z,1383772419.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2013-11-06T21:13:39.852Z,1383772419.852 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2013-11-06T21:13:40.058Z,1383772420.058 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2013-11-06T21:13:40.058Z,1383772420.058 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2013-11-06T21:13:40.164Z,1383772420.164 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2013-11-06T21:13:40.165Z,1383772420.165 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2013-11-06T21:13:40.283Z,1383772420.283 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2013-11-06T21:13:40.284Z,1383772420.284 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2013-11-06T21:13:40.429Z,1383772420.429 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2013-11-06T21:13:40.430Z,1383772420.430 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2013-11-06T21:13:40.680Z,1383772420.680 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2013-11-06T21:13:40.681Z,1383772420.681 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2013-11-06T21:13:40.852Z,1383772420.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2013-11-06T21:13:40.853Z,1383772420.853 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2013-11-06T21:13:41.131Z,1383772421.131 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2013-11-06T21:13:41.132Z,1383772421.132 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2013-11-06T21:13:41.234Z,1383772421.234 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2013-11-06T21:13:41.235Z,1383772421.235 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2013-11-06T21:13:41.680Z,1383772421.680 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2013-11-06T21:13:41.680Z,1383772421.680 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2013-11-06T21:13:41.792Z,1383772421.792 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2013-11-06T21:13:41.793Z,1383772421.793 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2013-11-06T21:13:41.879Z,1383772421.879 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2013-11-06T21:13:41.980Z,1383772421.980 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2013-11-06T21:13:41.983Z,1383772421.983 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2013-11-06T21:13:41.984Z,1383772421.984 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2013-11-06T21:13:42.080Z,1383772422.080 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2013-11-06T21:13:42.210Z,1383772422.210 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2013-11-06T21:13:42.312Z,1383772422.312 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2013-11-06T21:13:42.417Z,1383772422.417 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2013-11-06T21:13:42.513Z,1383772422.513 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2013-11-06T21:13:42.628Z,1383772422.628 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2013-11-06T21:13:42.724Z,1383772422.724 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2013-11-06T21:13:42.810Z,1383772422.810 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2013-11-06T21:13:42.904Z,1383772422.904 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/LOGIN/
2013-11-06T21:13:42.904Z,1383772422.904 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2013-11-06T21:13:42.906Z,1383772422.906 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2013-11-06T21:13:43.077Z,1383772423.077 [InternalSim] Loaded
2013-11-06T21:13:43.077Z,1383772423.077 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2013-11-06T21:13:43.078Z,1383772423.078 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2013-11-06T21:13:43.078Z,1383772423.078 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2013-11-06T21:13:43.171Z,1383772423.171 [SBIT](DEBUG): Construct Startup Built In Test.
2013-11-06T21:13:43.201Z,1383772423.201 [SBIT] Loaded
2013-11-06T21:13:43.201Z,1383772423.201 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2013-11-06T21:13:43.202Z,1383772423.202 [IBIT](DEBUG): Construct Initiated Built In Test.
2013-11-06T21:13:43.231Z,1383772423.231 [IBIT] Loaded
2013-11-06T21:13:43.231Z,1383772423.231 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2013-11-06T21:13:43.233Z,1383772423.233 [CBIT](DEBUG): Construct CBIT Built In Test.
2013-11-06T21:13:43.350Z,1383772423.350 [CBIT] Loaded
2013-11-06T21:13:43.350Z,1383772423.350 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2013-11-06T21:13:43.350Z,1383772423.350 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2013-11-06T21:13:43.351Z,1383772423.351 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2013-11-06T21:13:43.522Z,1383772423.522 [BuoyancyServo] Loaded
2013-11-06T21:13:43.522Z,1383772423.522 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2013-11-06T21:13:43.534Z,1383772423.534 [ElevatorServo] Loaded
2013-11-06T21:13:43.534Z,1383772423.534 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2013-11-06T21:13:43.545Z,1383772423.545 [MassServo] Loaded
2013-11-06T21:13:43.546Z,1383772423.546 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2013-11-06T21:13:43.557Z,1383772423.557 [RudderServo] Loaded
2013-11-06T21:13:43.558Z,1383772423.558 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2013-11-06T21:13:43.569Z,1383772423.569 [ThrusterServo] Loaded
2013-11-06T21:13:43.569Z,1383772423.569 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2013-11-06T21:13:43.569Z,1383772423.569 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2013-11-06T21:13:43.570Z,1383772423.570 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2013-11-06T21:13:43.610Z,1383772423.610 [DepthRateCalculator] Loaded
2013-11-06T21:13:43.610Z,1383772423.610 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2013-11-06T21:13:46.307Z,1383772426.307 [HFRadarModelCalc] Loaded
2013-11-06T21:13:46.308Z,1383772426.308 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2013-11-06T21:13:46.324Z,1383772426.324 [NavChart] Loaded
2013-11-06T21:13:46.324Z,1383772426.324 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2013-11-06T21:13:46.330Z,1383772426.330 [PitchRateCalculator] Loaded
2013-11-06T21:13:46.330Z,1383772426.330 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2013-11-06T21:13:46.341Z,1383772426.341 [SpeedCalculator] Loaded
2013-11-06T21:13:46.341Z,1383772426.341 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2013-11-06T21:13:46.358Z,1383772426.358 [TempGradientCalculator] Loaded
2013-11-06T21:13:46.358Z,1383772426.358 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2013-11-06T21:13:46.364Z,1383772426.364 [YawRateCalculator] Loaded
2013-11-06T21:13:46.364Z,1383772426.364 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2013-11-06T21:13:46.411Z,1383772426.411 [Navigation] Loaded
2013-11-06T21:13:46.411Z,1383772426.411 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread.
2013-11-06T21:13:46.411Z,1383772426.411 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2013-11-06T21:13:46.412Z,1383772426.412 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2013-11-06T21:13:46.665Z,1383772426.665 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2013-11-06T21:13:46.665Z,1383772426.665 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2013-11-06T21:13:46.690Z,1383772426.690 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2013-11-06T21:13:46.691Z,1383772426.691 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2013-11-06T21:13:46.741Z,1383772426.741 [VerticalControl](DEBUG): Construct VerticalControl.
2013-11-06T21:13:46.836Z,1383772426.836 [VerticalControl] Loaded
2013-11-06T21:13:46.836Z,1383772426.836 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2013-11-06T21:13:46.837Z,1383772426.837 [HorizontalControl](DEBUG): Construct HorizontalControl.
2013-11-06T21:13:46.895Z,1383772426.895 [HorizontalControl] Loaded
2013-11-06T21:13:46.896Z,1383772426.896 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2013-11-06T21:13:46.896Z,1383772426.896 [SpeedControl](DEBUG): Construct SpeedControl.
2013-11-06T21:13:46.898Z,1383772426.898 [SpeedControl] Loaded
2013-11-06T21:13:46.898Z,1383772426.898 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2013-11-06T21:13:46.899Z,1383772426.899 [LoopControl](DEBUG): Construct LoopControl.
2013-11-06T21:13:46.900Z,1383772426.900 [LoopControl] Loaded
2013-11-06T21:13:46.900Z,1383772426.900 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2013-11-06T21:13:46.900Z,1383772426.900 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2013-11-06T21:13:46.901Z,1383772426.901 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2013-11-06T21:13:46.907Z,1383772426.907 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2013-11-06T21:13:46.912Z,1383772426.912 [AsyncPiEstimator] Loaded
2013-11-06T21:13:46.912Z,1383772426.912 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2013-11-06T21:13:46.913Z,1383772426.913 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 406474E0
2013-11-06T21:13:46.914Z,1383772426.914 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2013-11-06T21:13:46.915Z,1383772426.915 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2013-11-06T21:13:47.309Z,1383772427.309 [AHRS_sp3003D] Loaded
2013-11-06T21:13:47.310Z,1383772427.310 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2013-11-06T21:13:47.423Z,1383772427.423 [DataOverHttps] Loaded
2013-11-06T21:13:47.423Z,1383772427.423 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2013-11-06T21:13:47.437Z,1383772427.437 [Depth_Keller] Loaded
2013-11-06T21:13:47.437Z,1383772427.437 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2013-11-06T21:13:47.622Z,1383772427.622 [DVL_micro] Loaded
2013-11-06T21:13:47.623Z,1383772427.623 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread.
2013-11-06T21:13:47.624Z,1383772427.624 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 408554E0
2013-11-06T21:13:47.714Z,1383772427.714 [NAL9602] Loaded
2013-11-06T21:13:47.715Z,1383772427.715 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2013-11-06T21:13:47.760Z,1383772427.760 [Onboard] Loaded
2013-11-06T21:13:47.760Z,1383772427.760 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2013-11-06T21:13:47.767Z,1383772427.767 [Radio_Freewave] Loaded
2013-11-06T21:13:47.767Z,1383772427.767 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2013-11-06T21:13:47.914Z,1383772427.914 [DAT] Loaded
2013-11-06T21:13:47.914Z,1383772427.914 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2013-11-06T21:13:47.915Z,1383772427.915 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2013-11-06T21:13:47.915Z,1383772427.915 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2013-11-06T21:13:48.018Z,1383772428.018 [CTD_NeilBrown] Loaded
2013-11-06T21:13:48.019Z,1383772428.019 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2013-11-06T21:13:48.020Z,1383772428.020 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408B24E0
2013-11-06T21:13:48.053Z,1383772428.053 [WetLabsBB2FL] Loaded
2013-11-06T21:13:48.053Z,1383772428.053 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2013-11-06T21:13:48.054Z,1383772428.054 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408E24E0
2013-11-06T21:13:48.055Z,1383772428.055 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2013-11-06T21:13:48.057Z,1383772428.057 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2013-11-06T21:13:48.058Z,1383772428.058 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2013-11-06T21:13:48.069Z,1383772428.069 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2013-11-06T21:13:48.072Z,1383772428.072 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409124E0
2013-11-06T21:13:48.077Z,1383772428.077 [Supervisor](DEBUG): Running supervisor.
2013-11-06T21:13:48.079Z,1383772428.079 [CommandLine](INFO): Thread ID is 1029
2013-11-06T21:13:48.081Z,1383772428.081 [controlThread](INFO): Thread ID is 1028
2013-11-06T21:13:48.081Z,1383772428.081 [controlThread](DEBUG): Initializing ControlThread
2013-11-06T21:13:48.082Z,1383772428.082 [CycleStarter](INFO): Thread ID is 1027
2013-11-06T21:13:48.082Z,1383772428.082 [InternalSim](DEBUG):  InternalSim initializing...
2013-11-06T21:13:48.182Z,1383772428.182 [logger](INFO): Thread ID is 1030
2013-11-06T21:13:48.269Z,1383772428.269 [AsyncPiEstimator](INFO): Thread ID is 1097
2013-11-06T21:13:48.269Z,1383772428.269 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2013-11-06T21:13:48.440Z,1383772428.440 [DVL_micro](INFO): Thread ID is 1098
2013-11-06T21:13:48.525Z,1383772428.525 [CTD_NeilBrown](INFO): Thread ID is 1099
2013-11-06T21:13:48.525Z,1383772428.525 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2013-11-06T21:13:48.527Z,1383772428.527 [WetLabsBB2FL](INFO): Thread ID is 1100
2013-11-06T21:13:48.528Z,1383772428.528 [WetLabsBB2FL](INFO): Powering down
2013-11-06T21:13:48.551Z,1383772428.551 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2013-11-06T21:13:48.562Z,1383772428.562 [SBIT](INFO): Initialize SBIT Component.
2013-11-06T21:13:48.563Z,1383772428.563 [SBIT](IMPORTANT): Tethys CM Info: 
 $Rev:10713
2013-11-06T21:13:48.563Z,1383772428.563 [SBIT](IMPORTANT): Kernel Release:2.6.27.8
2013-11-06T21:13:48.563Z,1383772428.563 [SBIT](IMPORTANT): Kernel Version:#634 PREEMPT Wed Feb 13 10:21:48 PST 2013
2013-11-06T21:13:48.564Z,1383772428.564 [IBIT](INFO): Initialize IBIT Component.
2013-11-06T21:13:48.565Z,1383772428.565 [CBIT](DEBUG): Initialize CBIT Component.
2013-11-06T21:13:48.565Z,1383772428.565 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2013-11-06T21:13:48.594Z,1383772428.594 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-11-06T21:13:48.594Z,1383772428.594 [NavChart](DEBUG): Initialize NavChart Derivation.
2013-11-06T21:13:48.595Z,1383772428.595 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2013-11-06T21:13:48.595Z,1383772428.595 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2013-11-06T21:13:48.595Z,1383772428.595 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2013-11-06T21:13:48.596Z,1383772428.596 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2013-11-06T21:13:48.596Z,1383772428.596 [Navigation](DEBUG): Initializing Navigation.
2013-11-06T21:13:48.597Z,1383772428.597 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2013-11-06T21:13:48.598Z,1383772428.598 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2013-11-06T21:13:48.599Z,1383772428.599 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2013-11-06T21:13:48.599Z,1383772428.599 [LoopControl](DEBUG): Initialize LoopControlComponent.
2013-11-06T21:13:48.649Z,1383772428.649 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2013-11-06T21:13:48.661Z,1383772428.661 [NavChartDb](INFO): Thread ID is 1101
2013-11-06T21:13:48.674Z,1383772428.674 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2013-11-06T21:13:48.675Z,1383772428.675 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2013-11-06T21:13:48.675Z,1383772428.675 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2013-11-06T21:13:48.676Z,1383772428.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2013-11-06T21:13:48.676Z,1383772428.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2013-11-06T21:13:48.676Z,1383772428.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2013-11-06T21:13:48.677Z,1383772428.677 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2013-11-06T21:13:48.677Z,1383772428.677 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2013-11-06T21:13:48.677Z,1383772428.677 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2013-11-06T21:13:48.704Z,1383772428.704 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2013-11-06T21:13:48.711Z,1383772428.711 [DVL_micro](INFO): Initializing
2013-11-06T21:13:48.711Z,1383772428.711 [DVL_micro](INFO): start:Powering up
2013-11-06T21:13:48.720Z,1383772428.720 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-11-06T21:13:48.721Z,1383772428.721 [DVL_micro](INFO): Cycling power to configure device.
2013-11-06T21:13:48.742Z,1383772428.742 [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 RunIn="Progression"/>

    <Aggregate Id="StartupSatComms" >

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2013-11-06T21:13:48.743Z,1383772428.743 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2013-11-06T21:13:48.847Z,1383772428.847 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2013-11-06T21:13:48.851Z,1383772428.851 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2013-11-06T21:13:48.854Z,1383772428.854 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-11-06T21:13:48.874Z,1383772428.874 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2013-11-06T21:13:48.877Z,1383772428.877 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2013-11-06T21:13:48.919Z,1383772428.919 [Default:Iridium:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2013-11-06T21:13:48.928Z,1383772428.928 [Default:D.SetSpeed](DEBUG): Construct.
2013-11-06T21:13:48.942Z,1383772428.942 [Default:E.GoToSurface](DEBUG): Construct GoToSurface.
2013-11-06T21:13:48.974Z,1383772428.974 [Default:F.Wait](DEBUG): Construct Wait.
2013-11-06T21:13:48.977Z,1383772428.977 [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 RunIn="Parallel">
            <Setting><Guidance:SetSpeed.period/><Units:millisecond/><Value>400</Value></Setting>
        </Guidance:SetSpeed>

<!-- Get to the surface -->

        <Guidance:GoToSurface RunIn="Sequence"/>

<!-- Get GPS fix -->

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

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

    </Aggregate>

    <Aggregate Id="Iridium" >

<!-- Run at high speed -->

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

<!-- Get to the surface -->

        <Guidance:GoToSurface RunIn="Sequence"/>

<!-- Do data comms -->

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute RunIn="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><Arg Name="NeedGPS"/><True/></Assign>

        <Call RefId="Iridium"/>

    </Aggregate>

<!-- Wait forever at the surface-->

<!-- Run at low speed -->

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

    <Guidance:GoToSurface RunIn="Parallel"/>

    <Guidance:Wait RunIn="Sequence"></Guidance:Wait>

</Mission>


2013-11-06T21:13:48.982Z,1383772428.982 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,DataOverHttps,Depth_Keller,NAL9602,Onboard,Radio_Freewave,DAT,Depth_Keller,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2013-11-06T21:13:49.053Z,1383772429.053 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2013-11-06T21:13:49.072Z,1383772429.072 [DataOverHttps](INFO): run, dataState=0
2013-11-06T21:13:49.073Z,1383772429.073 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:13:49.262Z,1383772429.262 [Radio_Freewave](INFO): Powering up
2013-11-06T21:13:49.267Z,1383772429.267 [DAT](INFO): Powering up
2013-11-06T21:13:49.267Z,1383772429.267 [DAT](DEBUG): Initializing DAT.
2013-11-06T21:13:49.568Z,1383772429.568 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2013-11-06T21:13:49.574Z,1383772429.574 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2013-11-06T21:13:49.580Z,1383772429.580 [ElevatorServo](DEBUG): Initializing EZServoServo.
2013-11-06T21:13:49.610Z,1383772429.610 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2013-11-06T21:13:49.624Z,1383772429.624 [MassServo](DEBUG): Initializing EZServoServo.
2013-11-06T21:13:49.626Z,1383772429.626 [MassServo](DEBUG): Initializing MassServo.
2013-11-06T21:13:49.644Z,1383772429.644 [RudderServo](DEBUG): Initializing EZServoServo.
2013-11-06T21:13:49.650Z,1383772429.650 [RudderServo](DEBUG): Initializing RudderServo.
2013-11-06T21:13:49.656Z,1383772429.656 [ThrusterServo](DEBUG): Initializing EZServoServo.
2013-11-06T21:13:49.662Z,1383772429.662 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2013-11-06T21:13:49.887Z,1383772429.887 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:13:49.887Z,1383772429.887 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:13:49.888Z,1383772429.888 [DataOverHttps](INFO): sslConnect
2013-11-06T21:13:49.891Z,1383772429.891 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:13:50.473Z,1383772430.473 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:13:50.474Z,1383772430.474 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:13:50.812Z,1383772430.812 [DVL_micro](INFO): Opening uart, block timeout 10ths=20
2013-11-06T21:13:50.812Z,1383772430.812 [DVL_micro](INFO): Querying output modes
2013-11-06T21:13:50.813Z,1383772430.813 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606

2013-11-06T21:13:50.824Z,1383772430.824 [DVL_micro](DEBUG): cmdResponse: 01
2013-11-06T21:13:50.824Z,1383772430.824 [DVL_micro](INFO): NQ1 output enabled
2013-11-06T21:13:50.824Z,1383772430.824 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525

2013-11-06T21:13:50.836Z,1383772430.836 [DVL_micro](DEBUG): cmdResponse: AUTO_VEL_ON 
2013-11-06T21:13:50.841Z,1383772430.841 [DVL_micro](INFO): pause:Powering down
2013-11-06T21:13:52.660Z,1383772432.660 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:13:52.660Z,1383772432.660 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:13:52.663Z,1383772432.663 [DataOverHttps](INFO): dataWrite
2013-11-06T21:13:52.663Z,1383772432.663 [DataOverHttps](INFO): dataWriting
2013-11-06T21:13:52.664Z,1383772432.664 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:13:53.045Z,1383772433.045 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:13:53.045Z,1383772433.045 [DataOverHttps](INFO): dataRead
2013-11-06T21:13:53.054Z,1383772433.054 [NAL9602](INFO): Powering up NAL9602
2013-11-06T21:13:53.473Z,1383772433.473 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:13:53.474Z,1383772433.474 [DataOverHttps](INFO): dataRead
2013-11-06T21:13:53.475Z,1383772433.475 [DataOverHttps](INFO): disconnect
2013-11-06T21:13:53.478Z,1383772433.478 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003806
2013-11-06T21:13:54.038Z,1383772434.038 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:54.495Z,1383772434.495 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:55.044Z,1383772435.044 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:55.753Z,1383772435.753 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:56.494Z,1383772436.494 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:56.967Z,1383772436.967 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:57.444Z,1383772437.444 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:57.868Z,1383772437.868 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:58.353Z,1383772438.353 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:58.806Z,1383772438.806 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:59.242Z,1383772439.242 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:13:59.679Z,1383772439.679 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:00.132Z,1383772440.132 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:00.580Z,1383772440.580 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:01.065Z,1383772441.065 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:01.506Z,1383772441.506 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:01.967Z,1383772441.967 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:02.407Z,1383772442.407 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:02.844Z,1383772442.844 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:03.264Z,1383772443.264 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:03.718Z,1383772443.718 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:03.756Z,1383772443.756 [NAL9602](INFO): NAL9602 initialized
2013-11-06T21:14:04.178Z,1383772444.178 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:04.294Z,1383772444.294 [SBIT](IMPORTANT): Beginning Startup BIT
2013-11-06T21:14:04.297Z,1383772444.297 [CBIT](IMPORTANT): Beginning GF scan
2013-11-06T21:14:04.667Z,1383772444.667 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:05.248Z,1383772445.248 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:05.796Z,1383772445.796 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:06.269Z,1383772446.269 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:06.815Z,1383772446.815 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:07.335Z,1383772447.335 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:07.808Z,1383772447.808 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:08.336Z,1383772448.336 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:08.755Z,1383772448.755 [DAT](INFO): Init failed - response: 

2013-11-06T21:14:08.756Z,1383772448.756 [DAT](FAULT): DAT failed to initialize
2013-11-06T21:14:08.756Z,1383772448.756 [DAT] Communications Fault, FailCount= 1
2013-11-06T21:14:08.756Z,1383772448.756 [DAT](ERROR): Communications Fault
2013-11-06T21:14:08.949Z,1383772448.949 [CBIT](ERROR): Communications Fault in component: DAT
2013-11-06T21:14:09.318Z,1383772449.318 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:09.356Z,1383772449.356 [DAT](INFO): Powering down
2013-11-06T21:14:10.027Z,1383772450.027 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:10.636Z,1383772450.636 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:10.727Z,1383772450.727 [CBIT](INFO): Clearing failed state for component DAT
2013-11-06T21:14:10.727Z,1383772450.727 [DAT] No Fault, FailCount= 1
2013-11-06T21:14:11.065Z,1383772451.065 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:11.573Z,1383772451.573 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:11.982Z,1383772451.982 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:12.419Z,1383772452.419 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:12.448Z,1383772452.448 [DAT](INFO): Powering up
2013-11-06T21:14:12.448Z,1383772452.448 [DAT](DEBUG): Initializing DAT.
2013-11-06T21:14:12.883Z,1383772452.883 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:13.312Z,1383772453.312 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:13.741Z,1383772453.741 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:14.168Z,1383772454.168 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:14.582Z,1383772454.582 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:14.983Z,1383772454.983 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:15.427Z,1383772455.427 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:15.868Z,1383772455.868 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:16.275Z,1383772456.275 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:16.713Z,1383772456.713 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:17.146Z,1383772457.146 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:17.563Z,1383772457.563 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:17.979Z,1383772457.979 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:18.448Z,1383772458.448 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:18.893Z,1383772458.893 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:19.325Z,1383772459.325 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:19.326Z,1383772459.326 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:14:19.766Z,1383772459.766 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:14:19.766Z,1383772459.766 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:14:19.766Z,1383772459.766 [DataOverHttps](INFO): sslConnect
2013-11-06T21:14:19.767Z,1383772459.767 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:14:20.948Z,1383772460.948 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:14:20.948Z,1383772460.948 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:14:22.403Z,1383772462.403 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:14:22.403Z,1383772462.403 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:14:22.405Z,1383772462.405 [DataOverHttps](INFO): dataWrite
2013-11-06T21:14:22.406Z,1383772462.406 [DataOverHttps](INFO): dataWriting
2013-11-06T21:14:22.407Z,1383772462.407 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:14:22.887Z,1383772462.887 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:14:22.887Z,1383772462.887 [DataOverHttps](INFO): dataRead
2013-11-06T21:14:23.372Z,1383772463.372 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:14:23.372Z,1383772463.372 [DataOverHttps](INFO): dataRead
2013-11-06T21:14:23.373Z,1383772463.373 [DataOverHttps](INFO): disconnect
2013-11-06T21:14:23.872Z,1383772463.872 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:24.361Z,1383772464.361 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:24.862Z,1383772464.862 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:25.359Z,1383772465.359 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:25.000Z,1383772466.000 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:26.553Z,1383772466.553 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:27.026Z,1383772467.026 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:27.470Z,1383772467.470 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:27.959Z,1383772467.959 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:28.387Z,1383772468.387 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:28.828Z,1383772468.828 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:29.257Z,1383772469.257 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:29.693Z,1383772469.693 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:30.122Z,1383772470.122 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:30.555Z,1383772470.555 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:30.955Z,1383772470.955 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:31.376Z,1383772471.376 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:31.455Z,1383772471.455 [CBIT](IMPORTANT): No ground fault detected
2013-11-06T21:14:31.789Z,1383772471.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:32.462Z,1383772472.462 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:32.866Z,1383772472.866 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:32.904Z,1383772472.904 [DAT](INFO): Powering down
2013-11-06T21:14:33.389Z,1383772473.389 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:33.800Z,1383772473.800 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:34.188Z,1383772474.188 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:34.601Z,1383772474.601 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:34.994Z,1383772474.994 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:35.391Z,1383772475.391 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:35.823Z,1383772475.823 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:36.200Z,1383772476.200 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:36.592Z,1383772476.592 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:36.989Z,1383772476.989 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:37.393Z,1383772477.393 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:37.798Z,1383772477.798 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:38.207Z,1383772478.207 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:38.589Z,1383772478.589 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:39.004Z,1383772479.004 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:39.409Z,1383772479.409 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:39.905Z,1383772479.905 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:40.289Z,1383772480.289 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:40.698Z,1383772480.698 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:41.088Z,1383772481.088 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:41.492Z,1383772481.492 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:41.892Z,1383772481.892 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:42.289Z,1383772482.289 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:42.688Z,1383772482.688 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:43.098Z,1383772483.098 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:43.488Z,1383772483.488 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:43.888Z,1383772483.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:44.300Z,1383772484.300 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:44.691Z,1383772484.691 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:45.089Z,1383772485.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:45.494Z,1383772485.494 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:45.888Z,1383772485.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:46.289Z,1383772486.289 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:46.844Z,1383772486.844 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:47.850Z,1383772487.850 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:48.338Z,1383772488.338 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:48.824Z,1383772488.824 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:49.304Z,1383772489.304 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:49.833Z,1383772489.833 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:49.833Z,1383772489.833 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:14:50.470Z,1383772490.470 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:14:50.470Z,1383772490.470 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:14:50.470Z,1383772490.470 [DataOverHttps](INFO): sslConnect
2013-11-06T21:14:50.471Z,1383772490.471 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:14:50.910Z,1383772490.910 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:14:50.911Z,1383772490.911 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:14:51.789Z,1383772491.789 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:14:51.789Z,1383772491.789 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:14:51.791Z,1383772491.791 [DataOverHttps](INFO): dataWrite
2013-11-06T21:14:51.791Z,1383772491.791 [DataOverHttps](INFO): dataWriting
2013-11-06T21:14:51.792Z,1383772491.792 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:14:52.232Z,1383772492.232 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:14:52.233Z,1383772492.233 [DataOverHttps](INFO): dataRead
2013-11-06T21:14:52.657Z,1383772492.657 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:14:52.657Z,1383772492.657 [DataOverHttps](INFO): dataRead
2013-11-06T21:14:52.658Z,1383772492.658 [DataOverHttps](INFO): disconnect
2013-11-06T21:14:53.106Z,1383772493.106 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:53.494Z,1383772493.494 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:53.971Z,1383772493.971 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:54.389Z,1383772494.389 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:54.776Z,1383772494.776 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:55.191Z,1383772495.191 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:55.582Z,1383772495.582 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:55.978Z,1383772495.978 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:56.375Z,1383772496.375 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:56.789Z,1383772496.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:57.172Z,1383772497.172 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:57.581Z,1383772497.581 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:57.997Z,1383772497.997 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:58.394Z,1383772498.394 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:58.442Z,1383772498.442 [SBIT](IMPORTANT): SBIT PASSED
2013-11-06T21:14:58.791Z,1383772498.791 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:58.826Z,1383772498.826 [MissionManager](IMPORTANT): Started mission Startup
2013-11-06T21:14:58.826Z,1383772498.826 [Startup] Running Loop=1
2013-11-06T21:14:58.826Z,1383772498.826 [Startup](INFO): Aggregate::initialize Startup
2013-11-06T21:14:58.826Z,1383772498.826 [Startup:A.GoToSurface] Running Loop=1
2013-11-06T21:14:58.826Z,1383772498.826 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-11-06T21:14:58.832Z,1383772498.832 [Startup:StartupSatComms] Running Loop=1
2013-11-06T21:14:58.832Z,1383772498.832 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2013-11-06T21:14:58.832Z,1383772498.832 [Startup:StartupSatComms:A] Running Loop=1
2013-11-06T21:14:59.189Z,1383772499.189 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:59.204Z,1383772499.204 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-11-06T21:14:59.589Z,1383772499.589 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:14:59.977Z,1383772499.977 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:00.397Z,1383772500.397 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:01.351Z,1383772501.351 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:01.788Z,1383772501.788 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:02.224Z,1383772502.224 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:02.649Z,1383772502.649 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:03.057Z,1383772503.057 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:03.478Z,1383772503.478 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:03.890Z,1383772503.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:04.291Z,1383772504.291 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:04.732Z,1383772504.732 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:05.168Z,1383772505.168 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:05.593Z,1383772505.593 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:05.998Z,1383772505.998 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:06.402Z,1383772506.402 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:06.791Z,1383772506.791 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:07.224Z,1383772507.224 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:07.649Z,1383772507.649 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:08.097Z,1383772508.097 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:08.494Z,1383772508.494 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:08.954Z,1383772508.954 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:09.423Z,1383772509.423 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:09.840Z,1383772509.840 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:10.260Z,1383772510.260 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:10.692Z,1383772510.692 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:11.130Z,1383772511.130 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:11.555Z,1383772511.555 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:11.959Z,1383772511.959 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:12.376Z,1383772512.376 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:12.890Z,1383772512.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:13.281Z,1383772513.281 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:13.682Z,1383772513.682 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:14.090Z,1383772514.090 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:14.495Z,1383772514.495 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:14.888Z,1383772514.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:15.290Z,1383772515.290 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:15.693Z,1383772515.693 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:16.081Z,1383772516.081 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:16.494Z,1383772516.494 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:16.891Z,1383772516.891 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:17.289Z,1383772517.289 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:17.690Z,1383772517.690 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:18.092Z,1383772518.092 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:18.481Z,1383772518.481 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:18.891Z,1383772518.891 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:19.290Z,1383772519.290 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:19.689Z,1383772519.689 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:20.089Z,1383772520.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:20.089Z,1383772520.089 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:15:20.496Z,1383772520.496 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:15:20.496Z,1383772520.496 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:15:20.497Z,1383772520.497 [DataOverHttps](INFO): sslConnect
2013-11-06T21:15:20.498Z,1383772520.498 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:15:20.893Z,1383772520.893 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:15:20.893Z,1383772520.893 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:15:21.755Z,1383772521.755 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:15:21.755Z,1383772521.755 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:15:21.757Z,1383772521.757 [DataOverHttps](INFO): dataWrite
2013-11-06T21:15:21.757Z,1383772521.757 [DataOverHttps](INFO): dataWriting
2013-11-06T21:15:21.758Z,1383772521.758 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:15:22.159Z,1383772522.159 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:15:22.159Z,1383772522.159 [DataOverHttps](INFO): dataRead
2013-11-06T21:15:22.563Z,1383772522.563 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:15:22.564Z,1383772522.564 [DataOverHttps](INFO): dataRead
2013-11-06T21:15:22.564Z,1383772522.564 [DataOverHttps](INFO): disconnect
2013-11-06T21:15:22.964Z,1383772522.964 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:23.365Z,1383772523.365 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:23.765Z,1383772523.765 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:24.170Z,1383772524.170 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:24.567Z,1383772524.567 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:24.967Z,1383772524.967 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:25.364Z,1383772525.364 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:25.764Z,1383772525.764 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:26.169Z,1383772526.169 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:26.566Z,1383772526.566 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:26.966Z,1383772526.966 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:27.363Z,1383772527.363 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:27.767Z,1383772527.767 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:28.172Z,1383772528.172 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:28.569Z,1383772528.569 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:28.969Z,1383772528.969 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:29.366Z,1383772529.366 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:29.775Z,1383772529.775 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:30.171Z,1383772530.171 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:30.564Z,1383772530.564 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:30.972Z,1383772530.972 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:31.373Z,1383772531.373 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:31.770Z,1383772531.770 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:32.182Z,1383772532.182 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:32.567Z,1383772532.567 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:32.968Z,1383772532.968 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:33.364Z,1383772533.364 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:33.769Z,1383772533.769 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:34.181Z,1383772534.181 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:34.588Z,1383772534.588 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:34.967Z,1383772534.967 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:35.371Z,1383772535.371 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:35.772Z,1383772535.772 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:36.164Z,1383772536.164 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:36.565Z,1383772536.565 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:36.990Z,1383772536.990 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:37.374Z,1383772537.374 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:37.767Z,1383772537.767 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:38.164Z,1383772538.164 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:38.568Z,1383772538.568 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:38.969Z,1383772538.969 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:39.381Z,1383772539.381 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:39.767Z,1383772539.767 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:40.183Z,1383772540.183 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:40.571Z,1383772540.571 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:40.968Z,1383772540.968 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:41.373Z,1383772541.373 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:41.777Z,1383772541.777 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:42.170Z,1383772542.170 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:42.567Z,1383772542.567 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:42.979Z,1383772542.979 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:43.364Z,1383772543.364 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:43.768Z,1383772543.768 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:44.181Z,1383772544.181 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:44.569Z,1383772544.569 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:44.966Z,1383772544.966 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:45.363Z,1383772545.363 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:45.767Z,1383772545.767 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:46.172Z,1383772546.172 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:46.573Z,1383772546.573 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:46.978Z,1383772546.978 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:47.374Z,1383772547.374 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:47.791Z,1383772547.791 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:48.163Z,1383772548.163 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:48.568Z,1383772548.568 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:48.972Z,1383772548.972 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:49.377Z,1383772549.377 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:49.778Z,1383772549.778 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:50.188Z,1383772550.188 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:50.188Z,1383772550.188 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:15:50.563Z,1383772550.563 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:15:50.563Z,1383772550.563 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:15:50.563Z,1383772550.563 [DataOverHttps](INFO): sslConnect
2013-11-06T21:15:50.564Z,1383772550.564 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:15:50.967Z,1383772550.967 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:15:50.968Z,1383772550.968 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:15:51.813Z,1383772551.813 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:15:51.813Z,1383772551.813 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:15:51.815Z,1383772551.815 [DataOverHttps](INFO): dataWrite
2013-11-06T21:15:51.815Z,1383772551.815 [DataOverHttps](INFO): dataWriting
2013-11-06T21:15:51.816Z,1383772551.816 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:15:52.188Z,1383772552.188 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:15:52.188Z,1383772552.188 [DataOverHttps](INFO): dataRead
2013-11-06T21:15:52.602Z,1383772552.602 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:15:52.602Z,1383772552.602 [DataOverHttps](INFO): dataRead
2013-11-06T21:15:52.603Z,1383772552.603 [DataOverHttps](INFO): disconnect
2013-11-06T21:15:53.007Z,1383772553.007 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:53.399Z,1383772553.399 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:53.790Z,1383772553.790 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:54.209Z,1383772554.209 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:54.621Z,1383772554.621 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:54.990Z,1383772554.990 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:55.402Z,1383772555.402 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:55.803Z,1383772555.803 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:56.196Z,1383772556.196 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:56.604Z,1383772556.604 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:57.017Z,1383772557.017 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:57.405Z,1383772557.405 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:57.806Z,1383772557.806 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:58.207Z,1383772558.207 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:58.610Z,1383772558.610 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:59.008Z,1383772559.008 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:59.029Z,1383772559.029 [Startup:StartupSatComms:A](INFO): Timed out from 2013-11-06T21:14:58.8Z
2013-11-06T21:15:59.029Z,1383772559.029 [Startup:StartupSatComms:A:A_Timeout] Running Loop=1
2013-11-06T21:15:59.029Z,1383772559.029 [Startup:StartupSatComms:A:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:A:A_Timeout
2013-11-06T21:15:59.030Z,1383772559.030 [Startup:StartupSatComms:A:A_Timeout](INFO): Completed Startup:StartupSatComms:A:A_Timeout
2013-11-06T21:15:59.030Z,1383772559.030 [Startup:StartupSatComms:A] Stopped
2013-11-06T21:15:59.030Z,1383772559.030 [Startup:StartupSatComms:B] Running Loop=1
2013-11-06T21:15:59.397Z,1383772559.397 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:15:59.418Z,1383772559.418 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-11-06T21:16:00.234Z,1383772560.234 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:00.529Z,1383772560.529 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:00.911Z,1383772560.911 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:00.911Z,1383772560.911 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:00.911Z,1383772560.911 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:00.912Z,1383772560.912 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:01.290Z,1383772561.290 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:01.290Z,1383772561.290 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:02.157Z,1383772562.157 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:02.157Z,1383772562.157 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:02.159Z,1383772562.159 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:02.162Z,1383772562.162 [DataOverHttps](INFO): Sending 60 bytes from file Logs/20131106T173110/Courier0012.lzma
2013-11-06T21:16:02.163Z,1383772562.163 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:02.164Z,1383772562.164 [DataOverHttps](INFO): Wrote 420 bytes.
2013-11-06T21:16:02.570Z,1383772562.570 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:02.570Z,1383772562.570 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:02.978Z,1383772562.978 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:02.978Z,1383772562.978 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:03.388Z,1383772563.388 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:03.388Z,1383772563.388 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:03.775Z,1383772563.775 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:03.776Z,1383772563.776 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:03.777Z,1383772563.777 [DataOverHttps](INFO): Moved sent file to Logs/20131106T173110/Courier0012.lzma.bak
2013-11-06T21:16:03.777Z,1383772563.777 [DataOverHttps](INFO): SBD MOMSN=222120
2013-11-06T21:16:03.778Z,1383772563.778 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:04.172Z,1383772564.172 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:04.657Z,1383772564.657 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:05.045Z,1383772565.045 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:05.045Z,1383772565.045 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:05.046Z,1383772565.046 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:05.047Z,1383772565.047 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:05.446Z,1383772565.446 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:05.446Z,1383772565.446 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:06.311Z,1383772566.311 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:06.311Z,1383772566.311 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:06.313Z,1383772566.313 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:06.331Z,1383772566.331 [DataOverHttps](INFO): Sending 8865 bytes from file Logs/20131104T165741/Express0005.lzma
2013-11-06T21:16:06.331Z,1383772566.331 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:06.768Z,1383772566.768 [DataOverHttps](INFO): run, dataState=5
2013-11-06T21:16:06.768Z,1383772566.768 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:06.776Z,1383772566.776 [DataOverHttps](INFO): Wrote 22243 bytes.
2013-11-06T21:16:07.169Z,1383772567.169 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:07.169Z,1383772567.169 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:07.577Z,1383772567.577 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:07.578Z,1383772567.578 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:07.978Z,1383772567.978 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:07.978Z,1383772567.978 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:08.374Z,1383772568.374 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:08.375Z,1383772568.375 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:08.789Z,1383772568.789 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:08.789Z,1383772568.789 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:08.791Z,1383772568.791 [DataOverHttps](INFO): Moved sent file to Logs/20131104T165741/Express0005.lzma.bak
2013-11-06T21:16:08.795Z,1383772568.795 [DataOverHttps](INFO): SBD MOMSN=222122
2013-11-06T21:16:08.795Z,1383772568.795 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:09.176Z,1383772569.176 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:09.669Z,1383772569.669 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:10.057Z,1383772570.057 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:10.057Z,1383772570.057 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:10.057Z,1383772570.057 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:10.058Z,1383772570.058 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:10.458Z,1383772570.458 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:10.458Z,1383772570.458 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:11.331Z,1383772571.331 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:11.331Z,1383772571.331 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:11.333Z,1383772571.333 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:11.341Z,1383772571.341 [DataOverHttps](INFO): Sending 2011 bytes from file Logs/20131105T182403/Express0001.lzma
2013-11-06T21:16:11.341Z,1383772571.341 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:11.347Z,1383772571.347 [DataOverHttps](INFO): Wrote 5306 bytes.
2013-11-06T21:16:11.764Z,1383772571.764 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:11.764Z,1383772571.764 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:12.164Z,1383772572.164 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:12.164Z,1383772572.164 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:12.557Z,1383772572.557 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:12.557Z,1383772572.557 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:12.559Z,1383772572.559 [DataOverHttps](INFO): Moved sent file to Logs/20131105T182403/Express0001.lzma.bak
2013-11-06T21:16:12.559Z,1383772572.559 [DataOverHttps](INFO): SBD MOMSN=222124
2013-11-06T21:16:12.559Z,1383772572.559 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:12.958Z,1383772572.958 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:13.451Z,1383772573.451 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:13.847Z,1383772573.847 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:13.847Z,1383772573.847 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:13.847Z,1383772573.847 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:13.848Z,1383772573.848 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:14.232Z,1383772574.232 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:14.232Z,1383772574.232 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:15.153Z,1383772575.153 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:15.154Z,1383772575.154 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:15.156Z,1383772575.156 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:15.163Z,1383772575.163 [DataOverHttps](INFO): Sending 893 bytes from file Logs/20131105T182403/Express0005.lzma
2013-11-06T21:16:15.163Z,1383772575.163 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:15.167Z,1383772575.167 [DataOverHttps](INFO): Wrote 2471 bytes.
2013-11-06T21:16:15.570Z,1383772575.570 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:15.570Z,1383772575.570 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:15.978Z,1383772575.978 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:15.979Z,1383772575.979 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:16.389Z,1383772576.389 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:16.389Z,1383772576.389 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:16.390Z,1383772576.390 [DataOverHttps](INFO): Moved sent file to Logs/20131105T182403/Express0005.lzma.bak
2013-11-06T21:16:16.391Z,1383772576.391 [DataOverHttps](INFO): SBD MOMSN=222126
2013-11-06T21:16:16.391Z,1383772576.391 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:16.776Z,1383772576.776 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:17.266Z,1383772577.266 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:17.669Z,1383772577.669 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:17.669Z,1383772577.669 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:17.669Z,1383772577.669 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:17.670Z,1383772577.670 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:18.054Z,1383772578.054 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:18.054Z,1383772578.054 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:18.927Z,1383772578.927 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:18.927Z,1383772578.927 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:18.929Z,1383772578.929 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:18.945Z,1383772578.945 [DataOverHttps](INFO): Sending 4629 bytes from file Logs/20131105T182403/Express0009.lzma
2013-11-06T21:16:18.945Z,1383772578.945 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:18.958Z,1383772578.958 [DataOverHttps](INFO): Wrote 11725 bytes.
2013-11-06T21:16:19.364Z,1383772579.364 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:19.364Z,1383772579.364 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:19.764Z,1383772579.764 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:19.764Z,1383772579.764 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:20.165Z,1383772580.165 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:20.165Z,1383772580.165 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:20.557Z,1383772580.557 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:20.558Z,1383772580.558 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:20.958Z,1383772580.958 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:20.958Z,1383772580.958 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:21.363Z,1383772581.363 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:21.363Z,1383772581.363 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:21.364Z,1383772581.364 [DataOverHttps](INFO): Moved sent file to Logs/20131105T182403/Express0009.lzma.bak
2013-11-06T21:16:21.364Z,1383772581.364 [DataOverHttps](INFO): SBD MOMSN=222128
2013-11-06T21:16:21.365Z,1383772581.365 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:21.763Z,1383772581.763 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:22.254Z,1383772582.254 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:22.657Z,1383772582.657 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:22.657Z,1383772582.657 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:22.657Z,1383772582.657 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:22.658Z,1383772582.658 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:23.061Z,1383772583.061 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:23.061Z,1383772583.061 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:23.955Z,1383772583.955 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:23.955Z,1383772583.955 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:23.957Z,1383772583.957 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:23.964Z,1383772583.964 [DataOverHttps](INFO): Sending 1987 bytes from file Logs/20131105T183547/Express0001.lzma
2013-11-06T21:16:23.965Z,1383772583.965 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:23.971Z,1383772583.971 [DataOverHttps](INFO): Wrote 5242 bytes.
2013-11-06T21:16:24.364Z,1383772584.364 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:24.364Z,1383772584.364 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:24.764Z,1383772584.764 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:24.765Z,1383772584.765 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:24.766Z,1383772584.766 [DataOverHttps](INFO): Moved sent file to Logs/20131105T183547/Express0001.lzma.bak
2013-11-06T21:16:24.766Z,1383772584.766 [DataOverHttps](INFO): SBD MOMSN=222130
2013-11-06T21:16:24.766Z,1383772584.766 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:25.165Z,1383772585.165 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:25.654Z,1383772585.654 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:26.042Z,1383772586.042 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:26.042Z,1383772586.042 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:26.042Z,1383772586.042 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:26.043Z,1383772586.043 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:26.458Z,1383772586.458 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:26.459Z,1383772586.459 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:27.316Z,1383772587.316 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:27.316Z,1383772587.316 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:27.318Z,1383772587.318 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:27.323Z,1383772587.323 [DataOverHttps](INFO): Sending 926 bytes from file Logs/20131105T183547/Express0005.lzma
2013-11-06T21:16:27.324Z,1383772587.324 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:27.328Z,1383772587.328 [DataOverHttps](INFO): Wrote 2598 bytes.
2013-11-06T21:16:27.689Z,1383772587.689 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:27.689Z,1383772587.689 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:28.125Z,1383772588.125 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:28.125Z,1383772588.125 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:28.127Z,1383772588.127 [DataOverHttps](INFO): Moved sent file to Logs/20131105T183547/Express0005.lzma.bak
2013-11-06T21:16:28.127Z,1383772588.127 [DataOverHttps](INFO): SBD MOMSN=222132
2013-11-06T21:16:28.127Z,1383772588.127 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:28.510Z,1383772588.510 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:28.998Z,1383772588.998 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:29.363Z,1383772589.363 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:29.363Z,1383772589.363 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:29.363Z,1383772589.363 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:29.364Z,1383772589.364 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:29.764Z,1383772589.764 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:29.764Z,1383772589.764 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:30.645Z,1383772590.645 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:30.645Z,1383772590.645 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:30.647Z,1383772590.647 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:30.655Z,1383772590.655 [DataOverHttps](INFO): Sending 2557 bytes from file Logs/20131105T183547/Express0009.lzma
2013-11-06T21:16:30.655Z,1383772590.655 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:30.663Z,1383772590.663 [DataOverHttps](INFO): Wrote 6606 bytes.
2013-11-06T21:16:31.078Z,1383772591.078 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:31.078Z,1383772591.078 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:31.474Z,1383772591.474 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:31.474Z,1383772591.474 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:31.476Z,1383772591.476 [DataOverHttps](INFO): Moved sent file to Logs/20131105T183547/Express0009.lzma.bak
2013-11-06T21:16:31.476Z,1383772591.476 [DataOverHttps](INFO): SBD MOMSN=222134
2013-11-06T21:16:31.476Z,1383772591.476 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:31.879Z,1383772591.879 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:32.370Z,1383772592.370 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:32.760Z,1383772592.760 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:32.761Z,1383772592.761 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:32.761Z,1383772592.761 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:32.762Z,1383772592.762 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:33.157Z,1383772593.157 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:33.157Z,1383772593.157 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:34.042Z,1383772594.042 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:34.043Z,1383772594.043 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:34.045Z,1383772594.045 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:34.052Z,1383772594.052 [DataOverHttps](INFO): Sending 1687 bytes from file Logs/20131105T184332/Express0001.lzma
2013-11-06T21:16:34.053Z,1383772594.053 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:34.058Z,1383772594.058 [DataOverHttps](INFO): Wrote 4424 bytes.
2013-11-06T21:16:34.471Z,1383772594.471 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:34.471Z,1383772594.471 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:34.876Z,1383772594.876 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:34.876Z,1383772594.876 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:35.280Z,1383772595.280 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:35.280Z,1383772595.280 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:35.673Z,1383772595.673 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:35.673Z,1383772595.673 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:36.073Z,1383772596.073 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:36.074Z,1383772596.074 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:36.075Z,1383772596.075 [DataOverHttps](INFO): Moved sent file to Logs/20131105T184332/Express0001.lzma.bak
2013-11-06T21:16:36.077Z,1383772596.077 [DataOverHttps](INFO): Received command:ibit
2013-11-06T21:16:36.078Z,1383772596.078 [DataOverHttps](IMPORTANT): SBD MOMSN=222137, MTMSN=20131106T211658
2013-11-06T21:16:36.078Z,1383772596.078 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:36.128Z,1383772596.128 [CommandLine](IMPORTANT): got command ibit
2013-11-06T21:16:36.136Z,1383772596.136 [IBIT](IMPORTANT): Beginning Initiated BIT
2013-11-06T21:16:36.136Z,1383772596.136 [IBIT](IMPORTANT): Beginning control surface checks.

2013-11-06T21:16:36.137Z,1383772596.137 [CBIT](IMPORTANT): Beginning GF scan
2013-11-06T21:16:36.482Z,1383772596.482 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:36.989Z,1383772596.989 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:37.351Z,1383772597.351 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:37.352Z,1383772597.352 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:37.352Z,1383772597.352 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:37.353Z,1383772597.353 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:37.385Z,1383772597.385 [Radio_Freewave](INFO): Powering down
2013-11-06T21:16:37.768Z,1383772597.768 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:37.768Z,1383772597.768 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:38.649Z,1383772598.649 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:38.650Z,1383772598.650 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:38.652Z,1383772598.652 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:38.653Z,1383772598.653 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20131106T211339/Courier0004.lzma
2013-11-06T21:16:38.654Z,1383772598.654 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:38.655Z,1383772598.655 [DataOverHttps](INFO): Wrote 365 bytes.
2013-11-06T21:16:38.683Z,1383772598.683 [Radio_Freewave](INFO): Powering up
2013-11-06T21:16:39.074Z,1383772599.074 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:39.074Z,1383772599.074 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:39.571Z,1383772599.571 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:39.571Z,1383772599.571 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:39.572Z,1383772599.572 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Courier0004.lzma.bak
2013-11-06T21:16:39.573Z,1383772599.573 [DataOverHttps](INFO): SBD MOMSN=222140
2013-11-06T21:16:39.573Z,1383772599.573 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:40.040Z,1383772600.040 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:40.529Z,1383772600.529 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:40.957Z,1383772600.957 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:40.957Z,1383772600.957 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:40.957Z,1383772600.957 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:40.958Z,1383772600.958 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:41.422Z,1383772601.422 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:41.422Z,1383772601.422 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:42.411Z,1383772602.411 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:42.411Z,1383772602.411 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:42.413Z,1383772602.413 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:42.420Z,1383772602.420 [DataOverHttps](INFO): Sending 1958 bytes from file Logs/20131105T184709/Express0001.lzma
2013-11-06T21:16:42.421Z,1383772602.421 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:42.428Z,1383772602.428 [DataOverHttps](INFO): Wrote 5127 bytes.
2013-11-06T21:16:43.056Z,1383772603.056 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:43.056Z,1383772603.056 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:43.457Z,1383772603.457 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:43.457Z,1383772603.457 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:43.459Z,1383772603.459 [DataOverHttps](INFO): Moved sent file to Logs/20131105T184709/Express0001.lzma.bak
2013-11-06T21:16:43.459Z,1383772603.459 [DataOverHttps](INFO): SBD MOMSN=222144
2013-11-06T21:16:43.459Z,1383772603.459 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:43.862Z,1383772603.862 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:44.388Z,1383772604.388 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:44.751Z,1383772604.751 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:44.752Z,1383772604.752 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:44.752Z,1383772604.752 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:44.753Z,1383772604.753 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:45.148Z,1383772605.148 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:45.148Z,1383772605.148 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:46.009Z,1383772606.009 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:46.009Z,1383772606.009 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:46.011Z,1383772606.011 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:46.016Z,1383772606.016 [DataOverHttps](INFO): Sending 881 bytes from file Logs/20131105T184709/Express0005.lzma
2013-11-06T21:16:46.017Z,1383772606.017 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:46.020Z,1383772606.020 [DataOverHttps](INFO): Wrote 2481 bytes.
2013-11-06T21:16:46.422Z,1383772606.422 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:46.422Z,1383772606.422 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:46.810Z,1383772606.810 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:46.810Z,1383772606.810 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:46.812Z,1383772606.812 [DataOverHttps](INFO): Moved sent file to Logs/20131105T184709/Express0005.lzma.bak
2013-11-06T21:16:46.812Z,1383772606.812 [DataOverHttps](INFO): SBD MOMSN=222146
2013-11-06T21:16:46.812Z,1383772606.812 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:47.211Z,1383772607.211 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:47.703Z,1383772607.703 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:48.068Z,1383772608.068 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:48.068Z,1383772608.068 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:48.068Z,1383772608.068 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:48.069Z,1383772608.069 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:48.469Z,1383772608.469 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:48.469Z,1383772608.469 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:49.331Z,1383772609.331 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:49.331Z,1383772609.331 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:49.333Z,1383772609.333 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:49.340Z,1383772609.340 [DataOverHttps](INFO): Sending 1706 bytes from file Logs/20131105T184709/Express0009.lzma
2013-11-06T21:16:49.340Z,1383772609.340 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:49.346Z,1383772609.346 [DataOverHttps](INFO): Wrote 4517 bytes.
2013-11-06T21:16:49.755Z,1383772609.755 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:49.756Z,1383772609.756 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:50.159Z,1383772610.159 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:50.160Z,1383772610.160 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:50.161Z,1383772610.161 [DataOverHttps](INFO): Moved sent file to Logs/20131105T184709/Express0009.lzma.bak
2013-11-06T21:16:50.161Z,1383772610.161 [DataOverHttps](INFO): SBD MOMSN=222148
2013-11-06T21:16:50.161Z,1383772610.161 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:50.568Z,1383772610.568 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:51.063Z,1383772611.063 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:51.457Z,1383772611.457 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:51.458Z,1383772611.458 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:51.458Z,1383772611.458 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:51.459Z,1383772611.459 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:51.858Z,1383772611.858 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:51.858Z,1383772611.858 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:52.735Z,1383772612.735 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:52.735Z,1383772612.735 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:52.737Z,1383772612.737 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:52.745Z,1383772612.745 [DataOverHttps](INFO): Sending 1938 bytes from file Logs/20131105T190737/Express0001.lzma
2013-11-06T21:16:52.745Z,1383772612.745 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:52.752Z,1383772612.752 [DataOverHttps](INFO): Wrote 5053 bytes.
2013-11-06T21:16:53.160Z,1383772613.160 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:53.160Z,1383772613.160 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:53.564Z,1383772613.564 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:53.565Z,1383772613.565 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:53.566Z,1383772613.566 [DataOverHttps](INFO): Moved sent file to Logs/20131105T190737/Express0001.lzma.bak
2013-11-06T21:16:53.566Z,1383772613.566 [DataOverHttps](INFO): SBD MOMSN=222150
2013-11-06T21:16:53.566Z,1383772613.566 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:53.973Z,1383772613.973 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:54.478Z,1383772614.478 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:54.991Z,1383772614.991 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:54.991Z,1383772614.991 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:54.991Z,1383772614.991 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:54.992Z,1383772614.992 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:55.423Z,1383772615.423 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:55.424Z,1383772615.424 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:56.361Z,1383772616.361 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:56.361Z,1383772616.361 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:56.363Z,1383772616.363 [DataOverHttps](INFO): dataWrite
2013-11-06T21:16:56.368Z,1383772616.368 [DataOverHttps](INFO): Sending 567 bytes from file Logs/20131105T190737/Express0005.lzma
2013-11-06T21:16:56.368Z,1383772616.368 [DataOverHttps](INFO): dataWriting
2013-11-06T21:16:56.371Z,1383772616.371 [DataOverHttps](INFO): Wrote 1679 bytes.
2013-11-06T21:16:56.838Z,1383772616.838 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:56.838Z,1383772616.838 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:57.277Z,1383772617.277 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:16:57.277Z,1383772617.277 [DataOverHttps](INFO): dataRead
2013-11-06T21:16:57.278Z,1383772617.278 [DataOverHttps](INFO): Moved sent file to Logs/20131105T190737/Express0005.lzma.bak
2013-11-06T21:16:57.279Z,1383772617.279 [DataOverHttps](INFO): SBD MOMSN=222152
2013-11-06T21:16:57.279Z,1383772617.279 [DataOverHttps](INFO): disconnect
2013-11-06T21:16:57.731Z,1383772617.731 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:16:58.227Z,1383772618.227 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:16:58.660Z,1383772618.660 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:16:58.661Z,1383772618.661 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:16:58.661Z,1383772618.661 [DataOverHttps](INFO): sslConnect
2013-11-06T21:16:58.662Z,1383772618.662 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:16:59.113Z,1383772619.113 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:16:59.113Z,1383772619.113 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:00.111Z,1383772620.111 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:00.111Z,1383772620.111 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:00.113Z,1383772620.113 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:00.119Z,1383772620.119 [DataOverHttps](INFO): Sending 1839 bytes from file Logs/20131105T190737/Express0009.lzma
2013-11-06T21:17:00.120Z,1383772620.120 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:00.126Z,1383772620.126 [DataOverHttps](INFO): Wrote 4802 bytes.
2013-11-06T21:17:00.740Z,1383772620.740 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:00.740Z,1383772620.740 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:01.148Z,1383772621.148 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:01.148Z,1383772621.148 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:01.150Z,1383772621.150 [DataOverHttps](INFO): Moved sent file to Logs/20131105T190737/Express0009.lzma.bak
2013-11-06T21:17:01.150Z,1383772621.150 [DataOverHttps](INFO): SBD MOMSN=222154
2013-11-06T21:17:01.150Z,1383772621.150 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:01.545Z,1383772621.545 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:02.486Z,1383772622.486 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:02.855Z,1383772622.855 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:02.855Z,1383772622.855 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:02.855Z,1383772622.855 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:02.856Z,1383772622.856 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:03.260Z,1383772623.260 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:03.260Z,1383772623.260 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:04.145Z,1383772624.145 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:04.145Z,1383772624.145 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:04.147Z,1383772624.147 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:04.158Z,1383772624.158 [DataOverHttps](INFO): Sending 3411 bytes from file Logs/20131105T191451/Express0001.lzma
2013-11-06T21:17:04.158Z,1383772624.158 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:04.169Z,1383772624.169 [DataOverHttps](INFO): Wrote 8780 bytes.
2013-11-06T21:17:04.244Z,1383772624.244 [CBIT](IMPORTANT): No ground fault detected
2013-11-06T21:17:04.582Z,1383772624.582 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:04.582Z,1383772624.582 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:04.990Z,1383772624.990 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:04.990Z,1383772624.990 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:04.992Z,1383772624.992 [DataOverHttps](INFO): Moved sent file to Logs/20131105T191451/Express0001.lzma.bak
2013-11-06T21:17:04.993Z,1383772624.993 [DataOverHttps](INFO): Received command:failc
2013-11-06T21:17:04.994Z,1383772624.994 [DataOverHttps](IMPORTANT): SBD MOMSN=222157, MTMSN=20131106T211728
2013-11-06T21:17:04.994Z,1383772624.994 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:05.077Z,1383772625.077 [CommandLine](IMPORTANT): got command failComponent
2013-11-06T21:17:05.077Z,1383772625.077 [CommandLine](IMPORTANT): Failed components:
2013-11-06T21:17:05.078Z,1383772625.078 [CommandLine](IMPORTANT): No failed Components.
2013-11-06T21:17:05.388Z,1383772625.388 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:05.853Z,1383772625.853 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:06.244Z,1383772626.244 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:06.244Z,1383772626.244 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:06.245Z,1383772626.245 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:06.246Z,1383772626.246 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:06.633Z,1383772626.633 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:06.633Z,1383772626.633 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:07.478Z,1383772627.478 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:07.478Z,1383772627.478 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:07.480Z,1383772627.480 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:07.482Z,1383772627.482 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20131106T211339/Courier0008.lzma
2013-11-06T21:17:07.482Z,1383772627.482 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:07.484Z,1383772627.484 [DataOverHttps](INFO): Wrote 365 bytes.
2013-11-06T21:17:07.891Z,1383772627.891 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:07.891Z,1383772627.891 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:08.294Z,1383772628.294 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:08.294Z,1383772628.294 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:08.295Z,1383772628.295 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Courier0008.lzma.bak
2013-11-06T21:17:08.296Z,1383772628.296 [DataOverHttps](INFO): SBD MOMSN=222159
2013-11-06T21:17:08.296Z,1383772628.296 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:08.696Z,1383772628.696 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:09.189Z,1383772629.189 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:09.569Z,1383772629.569 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:09.570Z,1383772629.570 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:09.570Z,1383772629.570 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:09.571Z,1383772629.571 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:10.089Z,1383772630.089 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:10.089Z,1383772630.089 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:11.028Z,1383772631.028 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:11.028Z,1383772631.028 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:11.030Z,1383772631.030 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:11.034Z,1383772631.034 [DataOverHttps](INFO): Sending 80 bytes from file Logs/20131105T191451/Express0005.lzma
2013-11-06T21:17:11.034Z,1383772631.034 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:11.036Z,1383772631.036 [DataOverHttps](INFO): Wrote 462 bytes.
2013-11-06T21:17:11.472Z,1383772631.472 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:11.473Z,1383772631.473 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:11.921Z,1383772631.921 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:11.921Z,1383772631.921 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:11.923Z,1383772631.923 [DataOverHttps](INFO): Moved sent file to Logs/20131105T191451/Express0005.lzma.bak
2013-11-06T21:17:11.923Z,1383772631.923 [DataOverHttps](INFO): SBD MOMSN=222162
2013-11-06T21:17:11.923Z,1383772631.923 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:12.354Z,1383772632.354 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:13.259Z,1383772633.259 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:13.764Z,1383772633.764 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:13.764Z,1383772633.764 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:13.764Z,1383772633.764 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:13.765Z,1383772633.765 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:14.397Z,1383772634.397 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:14.397Z,1383772634.397 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:15.266Z,1383772635.266 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:15.266Z,1383772635.266 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:15.268Z,1383772635.268 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:15.275Z,1383772635.275 [DataOverHttps](INFO): Sending 191 bytes from file Logs/20131105T191451/Express0009.lzma
2013-11-06T21:17:15.276Z,1383772635.276 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:15.278Z,1383772635.278 [DataOverHttps](INFO): Wrote 760 bytes.
2013-11-06T21:17:15.671Z,1383772635.671 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:15.671Z,1383772635.671 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:16.089Z,1383772636.089 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:16.089Z,1383772636.089 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:16.091Z,1383772636.091 [DataOverHttps](INFO): Moved sent file to Logs/20131105T191451/Express0009.lzma.bak
2013-11-06T21:17:16.091Z,1383772636.091 [DataOverHttps](INFO): SBD MOMSN=222164
2013-11-06T21:17:16.091Z,1383772636.091 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:16.472Z,1383772636.472 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:16.963Z,1383772636.963 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:17.345Z,1383772637.345 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:17.346Z,1383772637.346 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:17.346Z,1383772637.346 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:17.347Z,1383772637.347 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:17.746Z,1383772637.746 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:17.746Z,1383772637.746 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:18.595Z,1383772638.595 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:18.595Z,1383772638.595 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:18.597Z,1383772638.597 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:18.605Z,1383772638.605 [DataOverHttps](INFO): Sending 1936 bytes from file Logs/20131105T191451/Express0013.lzma
2013-11-06T21:17:18.605Z,1383772638.605 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:18.614Z,1383772638.614 [DataOverHttps](INFO): Wrote 5073 bytes.
2013-11-06T21:17:19.004Z,1383772639.004 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:19.004Z,1383772639.004 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:19.401Z,1383772639.401 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:19.401Z,1383772639.401 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:19.402Z,1383772639.402 [DataOverHttps](INFO): Moved sent file to Logs/20131105T191451/Express0013.lzma.bak
2013-11-06T21:17:19.402Z,1383772639.402 [DataOverHttps](INFO): SBD MOMSN=222166
2013-11-06T21:17:19.403Z,1383772639.403 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:19.809Z,1383772639.809 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:20.304Z,1383772640.304 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:20.679Z,1383772640.679 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:20.679Z,1383772640.679 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:20.679Z,1383772640.679 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:20.680Z,1383772640.680 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:21.064Z,1383772641.064 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:21.064Z,1383772641.064 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:21.936Z,1383772641.936 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:21.937Z,1383772641.937 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:21.941Z,1383772641.941 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:21.947Z,1383772641.947 [DataOverHttps](INFO): Sending 802 bytes from file Logs/20131105T191451/Express0017.lzma
2013-11-06T21:17:21.948Z,1383772641.948 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:21.952Z,1383772641.952 [DataOverHttps](INFO): Wrote 2254 bytes.
2013-11-06T21:17:22.357Z,1383772642.357 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:22.358Z,1383772642.358 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:22.766Z,1383772642.766 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:22.766Z,1383772642.766 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:22.768Z,1383772642.768 [DataOverHttps](INFO): Moved sent file to Logs/20131105T191451/Express0017.lzma.bak
2013-11-06T21:17:22.768Z,1383772642.768 [DataOverHttps](INFO): SBD MOMSN=222168
2013-11-06T21:17:22.768Z,1383772642.768 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:23.170Z,1383772643.170 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:23.665Z,1383772643.665 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:24.052Z,1383772644.052 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:24.053Z,1383772644.053 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:24.053Z,1383772644.053 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:24.054Z,1383772644.054 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:24.460Z,1383772644.460 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:24.461Z,1383772644.461 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:25.346Z,1383772645.346 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:25.346Z,1383772645.346 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:25.348Z,1383772645.348 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:25.355Z,1383772645.355 [DataOverHttps](INFO): Sending 2072 bytes from file Logs/20131105T192247/Express0001.lzma
2013-11-06T21:17:25.355Z,1383772645.355 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:25.363Z,1383772645.363 [DataOverHttps](INFO): Wrote 5419 bytes.
2013-11-06T21:17:25.767Z,1383772645.767 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:25.767Z,1383772645.767 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:26.171Z,1383772646.171 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:26.171Z,1383772646.171 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:26.173Z,1383772646.173 [DataOverHttps](INFO): Moved sent file to Logs/20131105T192247/Express0001.lzma.bak
2013-11-06T21:17:26.173Z,1383772646.173 [DataOverHttps](INFO): SBD MOMSN=222170
2013-11-06T21:17:26.173Z,1383772646.173 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:26.576Z,1383772646.576 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:27.073Z,1383772647.073 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:27.449Z,1383772647.449 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:27.449Z,1383772647.449 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:27.450Z,1383772647.450 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:27.451Z,1383772647.451 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:27.862Z,1383772647.862 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:27.862Z,1383772647.862 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:28.731Z,1383772648.731 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:28.731Z,1383772648.731 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:28.734Z,1383772648.734 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:28.737Z,1383772648.737 [DataOverHttps](INFO): Sending 57 bytes from file Logs/20131105T192247/Express0005.lzma
2013-11-06T21:17:28.737Z,1383772648.737 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:28.738Z,1383772648.738 [DataOverHttps](INFO): Wrote 415 bytes.
2013-11-06T21:17:29.124Z,1383772649.124 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:29.124Z,1383772649.124 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:29.508Z,1383772649.508 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:29.508Z,1383772649.508 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:29.510Z,1383772649.510 [DataOverHttps](INFO): Moved sent file to Logs/20131105T192247/Express0005.lzma.bak
2013-11-06T21:17:29.510Z,1383772649.510 [DataOverHttps](INFO): SBD MOMSN=222172
2013-11-06T21:17:29.510Z,1383772649.510 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:29.933Z,1383772649.933 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:30.428Z,1383772650.428 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:30.822Z,1383772650.822 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:30.823Z,1383772650.823 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:30.823Z,1383772650.823 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:30.824Z,1383772650.824 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:31.199Z,1383772651.199 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:31.199Z,1383772651.199 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:32.056Z,1383772652.056 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:32.056Z,1383772652.056 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:32.058Z,1383772652.058 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:32.062Z,1383772652.062 [DataOverHttps](INFO): Sending 396 bytes from file Logs/20131105T192247/Express0009.lzma
2013-11-06T21:17:32.063Z,1383772652.063 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:32.066Z,1383772652.066 [DataOverHttps](INFO): Wrote 1262 bytes.
2013-11-06T21:17:32.457Z,1383772652.457 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:32.457Z,1383772652.457 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:32.857Z,1383772652.857 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:32.858Z,1383772652.858 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:33.254Z,1383772653.254 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:33.254Z,1383772653.254 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:33.256Z,1383772653.256 [DataOverHttps](INFO): Moved sent file to Logs/20131105T192247/Express0009.lzma.bak
2013-11-06T21:17:33.256Z,1383772653.256 [DataOverHttps](INFO): SBD MOMSN=222174
2013-11-06T21:17:33.256Z,1383772653.256 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:33.659Z,1383772653.659 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:34.161Z,1383772654.161 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:34.560Z,1383772654.560 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:34.560Z,1383772654.560 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:34.560Z,1383772654.560 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:34.562Z,1383772654.562 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:34.957Z,1383772654.957 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:34.957Z,1383772654.957 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:35.802Z,1383772655.802 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:35.802Z,1383772655.802 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:35.805Z,1383772655.805 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:35.809Z,1383772655.809 [DataOverHttps](INFO): Sending 589 bytes from file Logs/20131105T192247/Express0013.lzma
2013-11-06T21:17:35.809Z,1383772655.809 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:35.812Z,1383772655.812 [DataOverHttps](INFO): Wrote 1749 bytes.
2013-11-06T21:17:36.199Z,1383772656.199 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:36.199Z,1383772656.199 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:36.588Z,1383772656.588 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:36.588Z,1383772656.588 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:36.590Z,1383772656.590 [DataOverHttps](INFO): Moved sent file to Logs/20131105T192247/Express0013.lzma.bak
2013-11-06T21:17:36.590Z,1383772656.590 [DataOverHttps](INFO): SBD MOMSN=222176
2013-11-06T21:17:36.590Z,1383772656.590 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:36.992Z,1383772656.992 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:37.517Z,1383772657.517 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:37.898Z,1383772657.898 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:37.898Z,1383772657.898 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:37.898Z,1383772657.898 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:37.899Z,1383772657.899 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:38.302Z,1383772658.302 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:38.302Z,1383772658.302 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:39.159Z,1383772659.159 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:39.159Z,1383772659.159 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:39.161Z,1383772659.161 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:39.169Z,1383772659.169 [DataOverHttps](INFO): Sending 2118 bytes from file Logs/20131105T192247/Express0017.lzma
2013-11-06T21:17:39.169Z,1383772659.169 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:39.176Z,1383772659.176 [DataOverHttps](INFO): Wrote 5539 bytes.
2013-11-06T21:17:39.568Z,1383772659.568 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:39.568Z,1383772659.568 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:39.960Z,1383772659.960 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:39.961Z,1383772659.961 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:39.962Z,1383772659.962 [DataOverHttps](INFO): Moved sent file to Logs/20131105T192247/Express0017.lzma.bak
2013-11-06T21:17:39.962Z,1383772659.962 [DataOverHttps](INFO): SBD MOMSN=222178
2013-11-06T21:17:39.962Z,1383772659.962 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:40.391Z,1383772660.391 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:40.877Z,1383772660.877 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:41.247Z,1383772661.247 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:41.247Z,1383772661.247 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:41.247Z,1383772661.247 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:41.248Z,1383772661.248 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:41.659Z,1383772661.659 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:41.659Z,1383772661.659 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:42.497Z,1383772662.497 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:42.497Z,1383772662.497 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:42.499Z,1383772662.499 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:42.507Z,1383772662.507 [DataOverHttps](INFO): Sending 1908 bytes from file Logs/20131106T173110/Express0001.lzma
2013-11-06T21:17:42.507Z,1383772662.507 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:42.514Z,1383772662.514 [DataOverHttps](INFO): Wrote 4991 bytes.
2013-11-06T21:17:42.905Z,1383772662.905 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:42.905Z,1383772662.905 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:43.306Z,1383772663.306 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:43.306Z,1383772663.306 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:43.307Z,1383772663.307 [DataOverHttps](INFO): Moved sent file to Logs/20131106T173110/Express0001.lzma.bak
2013-11-06T21:17:43.307Z,1383772663.307 [DataOverHttps](INFO): SBD MOMSN=222180
2013-11-06T21:17:43.308Z,1383772663.308 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:43.718Z,1383772663.718 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:44.216Z,1383772664.216 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:44.592Z,1383772664.592 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:44.592Z,1383772664.592 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:44.592Z,1383772664.592 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:44.593Z,1383772664.593 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:44.992Z,1383772664.992 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:44.993Z,1383772664.993 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:45.850Z,1383772665.850 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:45.850Z,1383772665.850 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:45.852Z,1383772665.852 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:45.857Z,1383772665.857 [DataOverHttps](INFO): Sending 781 bytes from file Logs/20131106T173110/Express0005.lzma
2013-11-06T21:17:45.857Z,1383772665.857 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:45.860Z,1383772665.860 [DataOverHttps](INFO): Wrote 2219 bytes.
2013-11-06T21:17:46.247Z,1383772666.247 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:46.247Z,1383772666.247 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:46.647Z,1383772666.647 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:46.648Z,1383772666.648 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:46.649Z,1383772666.649 [DataOverHttps](INFO): Moved sent file to Logs/20131106T173110/Express0005.lzma.bak
2013-11-06T21:17:46.649Z,1383772666.649 [DataOverHttps](INFO): SBD MOMSN=222182
2013-11-06T21:17:46.649Z,1383772666.649 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:47.063Z,1383772667.063 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:47.552Z,1383772667.552 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:47.965Z,1383772667.965 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:47.965Z,1383772667.965 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:47.965Z,1383772667.965 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:47.966Z,1383772667.966 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:48.365Z,1383772668.365 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:48.366Z,1383772668.366 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:49.255Z,1383772669.255 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:49.255Z,1383772669.255 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:49.257Z,1383772669.257 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:49.264Z,1383772669.264 [DataOverHttps](INFO): Sending 615 bytes from file Logs/20131106T173110/Express0009.lzma
2013-11-06T21:17:49.264Z,1383772669.264 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:49.267Z,1383772669.267 [DataOverHttps](INFO): Wrote 1801 bytes.
2013-11-06T21:17:49.660Z,1383772669.660 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:49.660Z,1383772669.660 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:50.064Z,1383772670.064 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:50.064Z,1383772670.064 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:50.066Z,1383772670.066 [DataOverHttps](INFO): Moved sent file to Logs/20131106T173110/Express0009.lzma.bak
2013-11-06T21:17:50.066Z,1383772670.066 [DataOverHttps](INFO): SBD MOMSN=222184
2013-11-06T21:17:50.066Z,1383772670.066 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:50.490Z,1383772670.490 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:50.977Z,1383772670.977 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:51.350Z,1383772671.350 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:51.350Z,1383772671.350 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:51.351Z,1383772671.351 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:51.352Z,1383772671.352 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:51.755Z,1383772671.755 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:51.755Z,1383772671.755 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:52.592Z,1383772672.592 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:52.592Z,1383772672.592 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:52.594Z,1383772672.594 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:52.609Z,1383772672.609 [DataOverHttps](INFO): Sending 4753 bytes from file Logs/20131106T173110/Express0013.lzma
2013-11-06T21:17:52.609Z,1383772672.609 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:52.623Z,1383772672.623 [DataOverHttps](INFO): Wrote 11973 bytes.
2013-11-06T21:17:52.977Z,1383772672.977 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:52.977Z,1383772672.977 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:53.389Z,1383772673.389 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:53.390Z,1383772673.390 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:53.391Z,1383772673.391 [DataOverHttps](INFO): Moved sent file to Logs/20131106T173110/Express0013.lzma.bak
2013-11-06T21:17:53.391Z,1383772673.391 [DataOverHttps](INFO): SBD MOMSN=222186
2013-11-06T21:17:53.391Z,1383772673.391 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:53.790Z,1383772673.790 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:54.323Z,1383772674.323 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:54.719Z,1383772674.719 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:54.720Z,1383772674.720 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:54.720Z,1383772674.720 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:54.721Z,1383772674.721 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:55.100Z,1383772675.100 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:55.100Z,1383772675.100 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:55.954Z,1383772675.954 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:55.954Z,1383772675.954 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:55.956Z,1383772675.956 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:55.961Z,1383772675.961 [DataOverHttps](INFO): Sending 1948 bytes from file Logs/20131106T211339/Express0001.lzma
2013-11-06T21:17:55.961Z,1383772675.961 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:55.968Z,1383772675.968 [DataOverHttps](INFO): Wrote 5091 bytes.
2013-11-06T21:17:56.354Z,1383772676.354 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:56.354Z,1383772676.354 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:56.762Z,1383772676.762 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:56.763Z,1383772676.763 [DataOverHttps](INFO): dataRead
2013-11-06T21:17:56.764Z,1383772676.764 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Express0001.lzma.bak
2013-11-06T21:17:56.764Z,1383772676.764 [DataOverHttps](INFO): SBD MOMSN=222188
2013-11-06T21:17:56.764Z,1383772676.764 [DataOverHttps](INFO): disconnect
2013-11-06T21:17:57.171Z,1383772677.171 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:17:57.665Z,1383772677.665 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:17:58.053Z,1383772678.053 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:17:58.053Z,1383772678.053 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:17:58.053Z,1383772678.053 [DataOverHttps](INFO): sslConnect
2013-11-06T21:17:58.054Z,1383772678.054 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:58.453Z,1383772678.453 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:58.453Z,1383772678.453 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:59.290Z,1383772679.290 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:17:59.291Z,1383772679.291 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:17:59.293Z,1383772679.293 [DataOverHttps](INFO): dataWrite
2013-11-06T21:17:59.300Z,1383772679.300 [DataOverHttps](INFO): Sending 614 bytes from file Logs/20131106T211339/Express0005.lzma
2013-11-06T21:17:59.301Z,1383772679.301 [DataOverHttps](INFO): dataWriting
2013-11-06T21:17:59.304Z,1383772679.304 [DataOverHttps](INFO): Wrote 1792 bytes.
2013-11-06T21:17:59.689Z,1383772679.689 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:17:59.689Z,1383772679.689 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:00.076Z,1383772680.076 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:00.076Z,1383772680.076 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:00.077Z,1383772680.077 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Express0005.lzma.bak
2013-11-06T21:18:00.077Z,1383772680.077 [DataOverHttps](INFO): SBD MOMSN=222190
2013-11-06T21:18:00.078Z,1383772680.078 [DataOverHttps](INFO): disconnect
2013-11-06T21:18:00.496Z,1383772680.496 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:18:00.994Z,1383772680.994 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:18:01.374Z,1383772681.374 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:18:01.374Z,1383772681.374 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:18:01.374Z,1383772681.374 [DataOverHttps](INFO): sslConnect
2013-11-06T21:18:01.375Z,1383772681.375 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:01.770Z,1383772681.770 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:01.770Z,1383772681.770 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:02.610Z,1383772682.610 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:02.610Z,1383772682.610 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:02.612Z,1383772682.612 [DataOverHttps](INFO): dataWrite
2013-11-06T21:18:02.615Z,1383772682.615 [DataOverHttps](INFO): Sending 447 bytes from file Logs/20131106T211339/Express0009.lzma
2013-11-06T21:18:02.615Z,1383772682.615 [DataOverHttps](INFO): dataWriting
2013-11-06T21:18:02.618Z,1383772682.618 [DataOverHttps](INFO): Wrote 1393 bytes.
2013-11-06T21:18:03.008Z,1383772683.008 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:03.008Z,1383772683.008 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:03.401Z,1383772683.401 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:03.401Z,1383772683.401 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:03.402Z,1383772683.402 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Express0009.lzma.bak
2013-11-06T21:18:03.403Z,1383772683.403 [DataOverHttps](INFO): SBD MOMSN=222192
2013-11-06T21:18:03.403Z,1383772683.403 [DataOverHttps](INFO): disconnect
2013-11-06T21:18:03.801Z,1383772683.801 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:18:04.295Z,1383772684.295 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:18:08.348Z,1383772688.348 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:18:08.842Z,1383772688.842 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:18:08.842Z,1383772688.842 [DataOverHttps](INFO): sslConnect
2013-11-06T21:18:08.843Z,1383772688.843 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:12.794Z,1383772692.794 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:13.286Z,1383772693.286 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:17.659Z,1383772697.659 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:18.152Z,1383772698.152 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:18.154Z,1383772698.154 [DataOverHttps](INFO): dataWrite
2013-11-06T21:18:18.155Z,1383772698.155 [DataOverHttps](INFO): dataWriting
2013-11-06T21:18:18.156Z,1383772698.156 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:18:22.102Z,1383772702.102 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:22.592Z,1383772702.592 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:22.593Z,1383772702.593 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2013-11-06T21:18:22.593Z,1383772702.593 [DataOverHttps](INFO): disconnect
2013-11-06T21:18:26.589Z,1383772706.589 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:18:27.083Z,1383772707.083 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:18:30.598Z,1383772710.598 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2013-11-06T21:18:31.004Z,1383772711.004 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:18:31.528Z,1383772711.528 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:18:31.528Z,1383772711.528 [DataOverHttps](INFO): sslConnect
2013-11-06T21:18:31.529Z,1383772711.529 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:35.065Z,1383772715.065 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2013-11-06T21:18:35.482Z,1383772715.483 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:35.980Z,1383772715.980 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:36.445Z,1383772716.445 [Depth_Keller](ERROR): Pressure reading out of range: 1830.631348 decibar
2013-11-06T21:18:39.971Z,1383772719.971 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2013-11-06T21:18:39.971Z,1383772719.971 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2013-11-06T21:18:39.971Z,1383772719.971 [IBIT](IMPORTANT): Pressure:9.672107 PSI
2013-11-06T21:18:39.972Z,1383772719.972 [IBIT](IMPORTANT): Humidity:18.907022 %
2013-11-06T21:18:40.406Z,1383772720.406 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:40.898Z,1383772720.898 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:40.900Z,1383772720.900 [DataOverHttps](INFO): dataWrite
2013-11-06T21:18:40.900Z,1383772720.900 [DataOverHttps](INFO): dataWriting
2013-11-06T21:18:40.901Z,1383772720.901 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:18:44.458Z,1383772724.458 [IBIT](IMPORTANT): surfaceThreshold: 0.500000 m
2013-11-06T21:18:44.458Z,1383772724.458 [IBIT](IMPORTANT): buoyancyNeutral: 300.000000 cc
2013-11-06T21:18:44.458Z,1383772724.458 [IBIT](IMPORTANT): massDefault: 0.800000 cm
2013-11-06T21:18:44.459Z,1383772724.459 [IBIT](IMPORTANT): stopDepth: 112.000000 m
2013-11-06T21:18:44.459Z,1383772724.459 [IBIT](IMPORTANT): abortDepth: 130.000000 m
2013-11-06T21:18:44.459Z,1383772724.459 [IBIT](IMPORTANT): IBIT FAILED
2013-11-06T21:18:44.889Z,1383772724.889 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:45.382Z,1383772725.382 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:45.383Z,1383772725.383 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2013-11-06T21:18:45.383Z,1383772725.383 [DataOverHttps](INFO): disconnect
2013-11-06T21:18:48.917Z,1383772728.917 [Startup:StartupSatComms:B](INFO): Timed out from 2013-11-06T21:15:59.0Z
2013-11-06T21:18:48.917Z,1383772728.917 [Startup:StartupSatComms:B:A_Timeout] Running Loop=1
2013-11-06T21:18:48.917Z,1383772728.917 [Startup:StartupSatComms:B:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:B:A_Timeout
2013-11-06T21:18:48.917Z,1383772728.917 [Startup:StartupSatComms:B:A_Timeout](INFO): Completed Startup:StartupSatComms:B:A_Timeout
2013-11-06T21:18:48.918Z,1383772728.918 [Startup:StartupSatComms:B] Stopped
2013-11-06T21:18:48.918Z,1383772728.918 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2013-11-06T21:18:48.918Z,1383772728.918 [Startup:StartupSatComms] Stopped
2013-11-06T21:18:48.918Z,1383772728.918 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2013-11-06T21:18:48.919Z,1383772728.919 [Startup](INFO): Completed Startup
2013-11-06T21:18:48.919Z,1383772728.919 [Startup] Stopped
2013-11-06T21:18:48.919Z,1383772728.919 [Startup](INFO): Aggregate::uninitialize Startup
2013-11-06T21:18:48.919Z,1383772728.919 [Startup:A.GoToSurface] Stopped
2013-11-06T21:18:48.919Z,1383772728.919 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-11-06T21:18:49.364Z,1383772729.364 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:18:49.364Z,1383772729.364 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:18:49.413Z,1383772729.413 [MissionManager](IMPORTANT): Started mission Default
2013-11-06T21:18:49.413Z,1383772729.413 [Default] Running Loop=1
2013-11-06T21:18:49.413Z,1383772729.413 [Default](INFO): Aggregate::initialize Default
2013-11-06T21:18:49.413Z,1383772729.413 [Default:D.SetSpeed] Running Loop=1
2013-11-06T21:18:49.413Z,1383772729.413 [Default:D.SetSpeed](DEBUG): Initialize.
2013-11-06T21:18:49.414Z,1383772729.414 [Default:E.GoToSurface] Running Loop=1
2013-11-06T21:18:49.414Z,1383772729.414 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-11-06T21:18:49.414Z,1383772729.414 [Default:Iridium] Running Loop=1
2013-11-06T21:18:49.414Z,1383772729.414 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-11-06T21:18:49.414Z,1383772729.414 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-11-06T21:18:49.414Z,1383772729.414 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-11-06T21:18:49.414Z,1383772729.414 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-11-06T21:18:49.415Z,1383772729.415 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-11-06T21:18:49.415Z,1383772729.415 [Default:E.GoToSurface] Running Loop=1
2013-11-06T21:18:49.420Z,1383772729.420 [Default:D.SetSpeed] Running Loop=1
2013-11-06T21:18:49.431Z,1383772729.431 [Default:Iridium:B.GoToSurface] Stopped
2013-11-06T21:18:49.431Z,1383772729.431 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-11-06T21:18:49.431Z,1383772729.431 [Default:Iridium:Read_Iridium] Running Loop=1
2013-11-06T21:18:49.431Z,1383772729.431 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-11-06T21:18:49.437Z,1383772729.437 [Default:GPS] Running Loop=1
2013-11-06T21:18:49.437Z,1383772729.437 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-11-06T21:18:49.437Z,1383772729.437 [Default:GPS:A.SetSpeed] Running Loop=1
2013-11-06T21:18:49.438Z,1383772729.438 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-11-06T21:18:49.438Z,1383772729.438 [Default:GPS:B.GoToSurface] Running Loop=1
2013-11-06T21:18:49.438Z,1383772729.438 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-11-06T21:18:49.444Z,1383772729.444 [Default:GPS:B.GoToSurface] Stopped
2013-11-06T21:18:49.444Z,1383772729.444 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-11-06T21:18:49.444Z,1383772729.444 [Default:GPS:Read_GPS] Running Loop=1
2013-11-06T21:18:49.444Z,1383772729.444 [Default:GPS:A.SetSpeed] Running Loop=1
2013-11-06T21:18:49.797Z,1383772729.797 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:18:49.797Z,1383772729.797 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:18:49.797Z,1383772729.797 [DataOverHttps](INFO): sslConnect
2013-11-06T21:18:49.798Z,1383772729.798 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:49.824Z,1383772729.824 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2013-11-06T21:18:49.827Z,1383772729.827 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2013-11-06T21:18:50.609Z,1383772730.609 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:50.862Z,1383772730.862 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:51.704Z,1383772731.704 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:51.704Z,1383772731.704 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:51.706Z,1383772731.706 [DataOverHttps](INFO): dataWrite
2013-11-06T21:18:51.708Z,1383772731.708 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20131106T211339/Courier0012.lzma
2013-11-06T21:18:51.708Z,1383772731.708 [DataOverHttps](INFO): dataWriting
2013-11-06T21:18:51.709Z,1383772731.709 [DataOverHttps](INFO): Wrote 343 bytes.
2013-11-06T21:18:52.100Z,1383772732.100 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:52.101Z,1383772732.101 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:52.505Z,1383772732.505 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:52.505Z,1383772732.505 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:52.506Z,1383772732.506 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Courier0012.lzma.bak
2013-11-06T21:18:52.507Z,1383772732.507 [DataOverHttps](INFO): SBD MOMSN=222194
2013-11-06T21:18:52.507Z,1383772732.507 [DataOverHttps](INFO): disconnect
2013-11-06T21:18:52.898Z,1383772732.898 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:18:53.393Z,1383772733.393 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:18:53.779Z,1383772733.779 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:18:53.779Z,1383772733.779 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:18:53.779Z,1383772733.779 [DataOverHttps](INFO): sslConnect
2013-11-06T21:18:53.780Z,1383772733.780 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:54.175Z,1383772734.175 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:54.176Z,1383772734.176 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:55.053Z,1383772735.053 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:18:55.053Z,1383772735.053 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:18:55.056Z,1383772735.056 [DataOverHttps](INFO): dataWrite
2013-11-06T21:18:55.059Z,1383772735.059 [DataOverHttps](INFO): Sending 943 bytes from file Logs/20131106T211339/Express0013.lzma
2013-11-06T21:18:55.060Z,1383772735.060 [DataOverHttps](INFO): dataWriting
2013-11-06T21:18:55.063Z,1383772735.063 [DataOverHttps](INFO): Wrote 2627 bytes.
2013-11-06T21:18:55.458Z,1383772735.458 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:55.458Z,1383772735.458 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:55.862Z,1383772735.862 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:18:55.862Z,1383772735.862 [DataOverHttps](INFO): dataRead
2013-11-06T21:18:55.864Z,1383772735.864 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Express0013.lzma.bak
2013-11-06T21:18:55.864Z,1383772735.864 [DataOverHttps](INFO): SBD MOMSN=222196
2013-11-06T21:18:55.864Z,1383772735.864 [DataOverHttps](INFO): disconnect
2013-11-06T21:18:56.267Z,1383772736.267 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:18:56.762Z,1383772736.762 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:19:00.294Z,1383772740.294 [Default:Iridium:Read_Iridium] Stopped
2013-11-06T21:19:00.295Z,1383772740.295 [Default:Iridium](INFO): Completed Default:Iridium
2013-11-06T21:19:00.295Z,1383772740.295 [Default:Iridium] Stopped
2013-11-06T21:19:00.295Z,1383772740.295 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-11-06T21:19:00.295Z,1383772740.295 [Default:Iridium:A.SetSpeed] Stopped
2013-11-06T21:19:00.295Z,1383772740.295 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-11-06T21:19:00.296Z,1383772740.296 [Default:F.Wait] Running Loop=1
2013-11-06T21:19:00.296Z,1383772740.296 [Default:F.Wait](DEBUG): Initialize Wait Component.
2013-11-06T21:19:00.698Z,1383772740.698 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:19:00.698Z,1383772740.698 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:19:00.698Z,1383772740.698 [DataOverHttps](INFO): sslConnect
2013-11-06T21:19:00.699Z,1383772740.699 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:19:01.078Z,1383772741.078 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:19:01.078Z,1383772741.078 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:19:01.932Z,1383772741.932 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:19:01.932Z,1383772741.932 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:19:01.934Z,1383772741.934 [DataOverHttps](INFO): dataWrite
2013-11-06T21:19:01.934Z,1383772741.934 [DataOverHttps](INFO): dataWriting
2013-11-06T21:19:01.935Z,1383772741.935 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:19:02.340Z,1383772742.340 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:19:02.340Z,1383772742.340 [DataOverHttps](INFO): dataRead
2013-11-06T21:19:02.749Z,1383772742.749 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:19:02.749Z,1383772742.749 [DataOverHttps](INFO): dataRead
2013-11-06T21:19:02.750Z,1383772742.750 [DataOverHttps](INFO): disconnect
2013-11-06T21:19:03.157Z,1383772743.157 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:03.558Z,1383772743.558 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:03.959Z,1383772743.959 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:04.363Z,1383772744.363 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:04.764Z,1383772744.764 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:05.169Z,1383772745.169 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:05.561Z,1383772745.561 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:05.966Z,1383772745.966 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:06.362Z,1383772746.362 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:06.763Z,1383772746.763 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:07.160Z,1383772747.160 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:07.564Z,1383772747.564 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:07.957Z,1383772747.957 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:08.361Z,1383772748.361 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:08.770Z,1383772748.770 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:09.163Z,1383772749.163 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:09.567Z,1383772749.567 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:09.960Z,1383772749.960 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:10.361Z,1383772750.361 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:10.765Z,1383772750.765 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:11.170Z,1383772751.170 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:11.176Z,1383772751.176 [NAL9602](IMPORTANT): GPS fix at: 1383772774.00
2013-11-06T21:19:11.201Z,1383772751.201 [Default:GPS:Read_GPS] Stopped
2013-11-06T21:19:11.201Z,1383772751.201 [Default:GPS:D] Running Loop=1
2013-11-06T21:19:11.571Z,1383772751.571 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:11.621Z,1383772751.621 [Default:GPS:D] Stopped
2013-11-06T21:19:11.622Z,1383772751.622 [Default:GPS](INFO): Completed Default:GPS
2013-11-06T21:19:11.622Z,1383772751.622 [Default:GPS] Stopped
2013-11-06T21:19:11.622Z,1383772751.622 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-11-06T21:19:11.622Z,1383772751.622 [Default:GPS:A.SetSpeed] Stopped
2013-11-06T21:19:11.622Z,1383772751.622 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-11-06T21:19:11.967Z,1383772751.967 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:17.039Z,1383772757.039 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:22.039Z,1383772762.039 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:27.038Z,1383772767.038 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:27.039Z,1383772767.039 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:19:32.050Z,1383772772.050 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:19:32.051Z,1383772772.051 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:19:32.051Z,1383772772.051 [DataOverHttps](INFO): sslConnect
2013-11-06T21:19:32.052Z,1383772772.052 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:19:32.062Z,1383772772.062 [NAL9602](INFO): Powering down
2013-11-06T21:19:37.050Z,1383772777.050 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:19:37.050Z,1383772777.050 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:19:37.518Z,1383772777.518 [DataOverHttps](INFO): disconnect
2013-11-06T21:19:42.042Z,1383772782.042 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:47.045Z,1383772787.045 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:52.045Z,1383772792.045 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:57.045Z,1383772797.045 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:19:57.045Z,1383772797.045 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:20:02.045Z,1383772802.045 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:20:02.045Z,1383772802.045 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:20:02.045Z,1383772802.045 [DataOverHttps](INFO): sslConnect
2013-11-06T21:20:02.047Z,1383772802.047 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:20:07.037Z,1383772807.037 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:20:07.037Z,1383772807.037 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:20:07.511Z,1383772807.511 [DataOverHttps](INFO): disconnect
2013-11-06T21:20:12.036Z,1383772812.036 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:17.036Z,1383772817.036 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:22.036Z,1383772822.036 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:27.039Z,1383772827.039 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:32.039Z,1383772832.039 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:32.040Z,1383772832.040 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:20:35.884Z,1383772835.884 [CommandLine](IMPORTANT): got command get latitude
2013-11-06T21:20:35.885Z,1383772835.885 [CommandLine](IMPORTANT): latitude 36.802645 arcdeg
2013-11-06T21:20:37.039Z,1383772837.039 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:20:37.039Z,1383772837.039 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:20:37.039Z,1383772837.039 [DataOverHttps](INFO): sslConnect
2013-11-06T21:20:37.041Z,1383772837.041 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:20:37.042Z,1383772837.042 [DataOverHttps](INFO): disconnect
2013-11-06T21:20:37.043Z,1383772837.043 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=94.293396
2013-11-06T21:20:37.067Z,1383772837.067 [Default:CallIridium] Running Loop=1
2013-11-06T21:20:37.067Z,1383772837.067 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-11-06T21:20:37.067Z,1383772837.067 [Default:CallIridium:A] Running Loop=1
2013-11-06T21:20:37.069Z,1383772837.069 [Default:CallIridium:A] Stopped
2013-11-06T21:20:37.069Z,1383772837.069 [Default:CallIridium:B] Running Loop=1
2013-11-06T21:20:37.070Z,1383772837.070 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-11-06T21:20:42.039Z,1383772842.039 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:42.060Z,1383772842.060 [Default:Iridium] Running Loop=1
2013-11-06T21:20:42.060Z,1383772842.060 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-11-06T21:20:42.060Z,1383772842.060 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-11-06T21:20:42.061Z,1383772842.061 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-11-06T21:20:42.061Z,1383772842.061 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-11-06T21:20:42.061Z,1383772842.061 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-11-06T21:20:42.062Z,1383772842.062 [Default:Iridium:B.GoToSurface] Stopped
2013-11-06T21:20:42.062Z,1383772842.062 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-11-06T21:20:42.062Z,1383772842.062 [Default:Iridium:Read_Iridium] Running Loop=1
2013-11-06T21:20:42.062Z,1383772842.062 [Default:GPS] Running Loop=1
2013-11-06T21:20:42.062Z,1383772842.062 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-11-06T21:20:42.062Z,1383772842.062 [Default:GPS:A.SetSpeed] Running Loop=1
2013-11-06T21:20:42.062Z,1383772842.062 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-11-06T21:20:42.063Z,1383772842.063 [Default:GPS:B.GoToSurface] Running Loop=1
2013-11-06T21:20:42.063Z,1383772842.063 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-11-06T21:20:42.063Z,1383772842.063 [Default:GPS:B.GoToSurface] Stopped
2013-11-06T21:20:42.063Z,1383772842.063 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-11-06T21:20:42.064Z,1383772842.064 [Default:GPS:Read_GPS] Running Loop=1
2013-11-06T21:20:42.435Z,1383772842.435 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:43.060Z,1383772843.060 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:43.062Z,1383772843.062 [NAL9602](INFO): Powering up
2013-11-06T21:20:43.457Z,1383772843.457 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:43.862Z,1383772843.862 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:44.266Z,1383772844.266 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:44.663Z,1383772844.663 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:45.067Z,1383772845.067 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:45.472Z,1383772845.472 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:45.877Z,1383772845.877 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:46.289Z,1383772846.289 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:46.682Z,1383772846.682 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:47.079Z,1383772847.079 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:47.483Z,1383772847.483 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:47.880Z,1383772847.880 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:48.276Z,1383772848.276 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:48.673Z,1383772848.673 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:49.091Z,1383772849.091 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:49.470Z,1383772849.470 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:49.879Z,1383772849.879 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:50.279Z,1383772850.279 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:50.672Z,1383772850.672 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:51.081Z,1383772851.081 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:51.481Z,1383772851.481 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:51.874Z,1383772851.874 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:52.279Z,1383772852.279 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:52.683Z,1383772852.683 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:53.076Z,1383772853.076 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:53.490Z,1383772853.490 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:53.532Z,1383772853.532 [NAL9602](INFO): NAL9602 initialized
2013-11-06T21:20:53.905Z,1383772853.905 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:54.294Z,1383772854.294 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:54.690Z,1383772854.690 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:55.111Z,1383772855.111 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:55.492Z,1383772855.492 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:55.904Z,1383772855.904 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:56.337Z,1383772856.337 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:56.717Z,1383772856.717 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:57.122Z,1383772857.122 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:58.044Z,1383772858.044 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:58.693Z,1383772858.693 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:59.109Z,1383772859.109 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:59.498Z,1383772859.498 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:20:59.888Z,1383772859.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:00.311Z,1383772860.311 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:00.689Z,1383772860.689 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:01.101Z,1383772861.101 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:01.505Z,1383772861.505 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:01.898Z,1383772861.898 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:02.791Z,1383772862.791 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:02.791Z,1383772862.791 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:21:03.184Z,1383772863.184 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:21:03.184Z,1383772863.184 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:21:03.184Z,1383772863.184 [DataOverHttps](INFO): sslConnect
2013-11-06T21:21:03.185Z,1383772863.185 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:03.585Z,1383772863.585 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:03.585Z,1383772863.585 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:04.465Z,1383772864.465 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:04.466Z,1383772864.466 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:04.468Z,1383772864.468 [DataOverHttps](INFO): dataWrite
2013-11-06T21:21:04.468Z,1383772864.468 [DataOverHttps](INFO): dataWriting
2013-11-06T21:21:04.469Z,1383772864.469 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:21:04.874Z,1383772864.874 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:04.874Z,1383772864.874 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:05.288Z,1383772865.288 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:05.289Z,1383772865.289 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:05.290Z,1383772865.290 [DataOverHttps](INFO): Received command:get notAvar
2013-11-06T21:21:05.456Z,1383772865.456 [CommandLine](IMPORTANT): got command get 
2013-11-06T21:21:05.456Z,1383772865.456 [CommandLine](FAULT): Incomplete syntax. Try: help get
2013-11-06T21:21:05.457Z,1383772865.457 [DataOverHttps](IMPORTANT): SBD MTMSN=20131106T212128
2013-11-06T21:21:05.457Z,1383772865.457 [DataOverHttps](INFO): disconnect
2013-11-06T21:21:05.460Z,1383772865.460 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.169761
2013-11-06T21:21:05.856Z,1383772865.856 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:06.287Z,1383772866.287 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:21:06.661Z,1383772866.661 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:21:06.661Z,1383772866.661 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:21:06.661Z,1383772866.661 [DataOverHttps](INFO): sslConnect
2013-11-06T21:21:06.662Z,1383772866.662 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:07.070Z,1383772867.070 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:07.070Z,1383772867.070 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:07.959Z,1383772867.959 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:07.959Z,1383772867.959 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:07.961Z,1383772867.961 [DataOverHttps](INFO): dataWrite
2013-11-06T21:21:07.963Z,1383772867.963 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20131106T211339/Courier0016.lzma
2013-11-06T21:21:07.964Z,1383772867.964 [DataOverHttps](INFO): dataWriting
2013-11-06T21:21:07.966Z,1383772867.966 [DataOverHttps](INFO): Wrote 816 bytes.
2013-11-06T21:21:08.384Z,1383772868.384 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:08.384Z,1383772868.384 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:08.780Z,1383772868.780 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:08.780Z,1383772868.780 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:08.782Z,1383772868.782 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Courier0016.lzma.bak
2013-11-06T21:21:08.782Z,1383772868.782 [DataOverHttps](INFO): SBD MOMSN=222199
2013-11-06T21:21:08.782Z,1383772868.782 [DataOverHttps](INFO): disconnect
2013-11-06T21:21:09.193Z,1383772869.193 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:09.446Z,1383772869.446 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:21:09.846Z,1383772869.846 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:21:09.846Z,1383772869.846 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:21:09.846Z,1383772869.846 [DataOverHttps](INFO): sslConnect
2013-11-06T21:21:09.847Z,1383772869.847 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:10.246Z,1383772870.246 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:10.247Z,1383772870.247 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:11.112Z,1383772871.112 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:11.112Z,1383772871.112 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:11.114Z,1383772871.114 [DataOverHttps](INFO): dataWrite
2013-11-06T21:21:11.116Z,1383772871.116 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20131106T211339/Courier0020.lzma
2013-11-06T21:21:11.116Z,1383772871.116 [DataOverHttps](INFO): dataWriting
2013-11-06T21:21:11.117Z,1383772871.117 [DataOverHttps](INFO): Wrote 343 bytes.
2013-11-06T21:21:11.509Z,1383772871.509 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:11.509Z,1383772871.509 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:11.921Z,1383772871.921 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:11.921Z,1383772871.921 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:11.923Z,1383772871.923 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Courier0020.lzma.bak
2013-11-06T21:21:11.923Z,1383772871.923 [DataOverHttps](INFO): SBD MOMSN=222202
2013-11-06T21:21:11.923Z,1383772871.923 [DataOverHttps](INFO): disconnect
2013-11-06T21:21:12.334Z,1383772872.334 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:12.830Z,1383772872.830 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:21:13.220Z,1383772873.220 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:21:13.220Z,1383772873.220 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:21:13.220Z,1383772873.220 [DataOverHttps](INFO): sslConnect
2013-11-06T21:21:13.221Z,1383772873.221 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:13.596Z,1383772873.596 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:13.596Z,1383772873.596 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:14.481Z,1383772874.481 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:14.481Z,1383772874.481 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:14.483Z,1383772874.483 [DataOverHttps](INFO): dataWrite
2013-11-06T21:21:14.486Z,1383772874.486 [DataOverHttps](INFO): Sending 616 bytes from file Logs/20131106T211339/Express0017.lzma
2013-11-06T21:21:14.486Z,1383772874.486 [DataOverHttps](INFO): dataWriting
2013-11-06T21:21:14.489Z,1383772874.489 [DataOverHttps](INFO): Wrote 1798 bytes.
2013-11-06T21:21:14.890Z,1383772874.890 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:14.890Z,1383772874.890 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:15.302Z,1383772875.302 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:15.302Z,1383772875.302 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:15.304Z,1383772875.304 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Express0017.lzma.bak
2013-11-06T21:21:15.304Z,1383772875.304 [DataOverHttps](INFO): SBD MOMSN=222204
2013-11-06T21:21:15.304Z,1383772875.304 [DataOverHttps](INFO): disconnect
2013-11-06T21:21:15.727Z,1383772875.727 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:16.225Z,1383772876.225 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:21:16.592Z,1383772876.592 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:21:16.593Z,1383772876.593 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:21:16.593Z,1383772876.593 [DataOverHttps](INFO): sslConnect
2013-11-06T21:21:16.594Z,1383772876.594 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:16.997Z,1383772876.997 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:16.997Z,1383772876.997 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:17.866Z,1383772877.866 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:17.867Z,1383772877.867 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:17.869Z,1383772877.869 [DataOverHttps](INFO): dataWrite
2013-11-06T21:21:17.877Z,1383772877.877 [DataOverHttps](INFO): Sending 408 bytes from file Logs/20131106T211339/Express0021.lzma
2013-11-06T21:21:17.877Z,1383772877.877 [DataOverHttps](INFO): dataWriting
2013-11-06T21:21:17.880Z,1383772877.880 [DataOverHttps](INFO): Wrote 1316 bytes.
2013-11-06T21:21:18.299Z,1383772878.299 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:18.299Z,1383772878.299 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:18.700Z,1383772878.700 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:18.700Z,1383772878.700 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:18.701Z,1383772878.701 [DataOverHttps](INFO): Moved sent file to Logs/20131106T211339/Express0021.lzma.bak
2013-11-06T21:21:18.701Z,1383772878.701 [DataOverHttps](INFO): SBD MOMSN=222206
2013-11-06T21:21:18.702Z,1383772878.702 [DataOverHttps](INFO): disconnect
2013-11-06T21:21:19.100Z,1383772879.100 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:19.595Z,1383772879.595 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:21:23.126Z,1383772883.126 [Default:Iridium:Read_Iridium] Stopped
2013-11-06T21:21:23.126Z,1383772883.126 [Default:Iridium](INFO): Completed Default:Iridium
2013-11-06T21:21:23.126Z,1383772883.126 [Default:Iridium] Stopped
2013-11-06T21:21:23.126Z,1383772883.126 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-11-06T21:21:23.126Z,1383772883.126 [Default:Iridium:A.SetSpeed] Stopped
2013-11-06T21:21:23.126Z,1383772883.126 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-11-06T21:21:23.571Z,1383772883.571 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:21:23.571Z,1383772883.571 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:21:23.572Z,1383772883.572 [DataOverHttps](INFO): sslConnect
2013-11-06T21:21:23.573Z,1383772883.573 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:23.622Z,1383772883.622 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-11-06T21:21:23.622Z,1383772883.622 [Default:CallIridium:B] Stopped
2013-11-06T21:21:23.622Z,1383772883.622 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-11-06T21:21:23.622Z,1383772883.622 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-11-06T21:21:23.622Z,1383772883.622 [Default:CallIridium] Stopped
2013-11-06T21:21:23.623Z,1383772883.623 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-11-06T21:21:23.972Z,1383772883.972 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:23.972Z,1383772883.972 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:24.861Z,1383772884.861 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:24.861Z,1383772884.861 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:24.863Z,1383772884.863 [DataOverHttps](INFO): dataWrite
2013-11-06T21:21:24.864Z,1383772884.864 [DataOverHttps](INFO): dataWriting
2013-11-06T21:21:24.865Z,1383772884.865 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:21:25.293Z,1383772885.293 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:25.293Z,1383772885.293 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:25.678Z,1383772885.678 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:25.679Z,1383772885.679 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:25.679Z,1383772885.679 [DataOverHttps](INFO): disconnect
2013-11-06T21:21:26.079Z,1383772886.079 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:26.480Z,1383772886.480 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:26.890Z,1383772886.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:27.292Z,1383772887.292 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:27.692Z,1383772887.692 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:28.098Z,1383772888.098 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:28.489Z,1383772888.489 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:28.875Z,1383772888.875 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:29.291Z,1383772889.291 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:29.693Z,1383772889.693 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:30.091Z,1383772890.091 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:30.492Z,1383772890.492 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:30.890Z,1383772890.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:31.275Z,1383772891.275 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:31.684Z,1383772891.684 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:32.092Z,1383772892.092 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:32.491Z,1383772892.491 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:32.890Z,1383772892.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:33.293Z,1383772893.293 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:33.679Z,1383772893.679 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:34.089Z,1383772894.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:34.492Z,1383772894.492 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:34.889Z,1383772894.889 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:35.294Z,1383772895.294 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:35.688Z,1383772895.688 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:36.075Z,1383772896.075 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:36.491Z,1383772896.491 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:36.890Z,1383772896.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:37.277Z,1383772897.277 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:37.693Z,1383772897.693 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:38.092Z,1383772898.092 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:38.493Z,1383772898.493 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:38.889Z,1383772898.889 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:39.290Z,1383772899.290 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:39.681Z,1383772899.681 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:40.091Z,1383772900.091 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:40.482Z,1383772900.482 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:40.890Z,1383772900.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:41.279Z,1383772901.279 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:41.692Z,1383772901.692 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:42.076Z,1383772902.076 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:42.490Z,1383772902.490 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:42.888Z,1383772902.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:43.290Z,1383772903.290 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:43.678Z,1383772903.678 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:44.091Z,1383772904.091 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:44.484Z,1383772904.484 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:44.890Z,1383772904.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:45.291Z,1383772905.291 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:45.693Z,1383772905.693 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:46.098Z,1383772906.098 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:46.488Z,1383772906.488 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:46.875Z,1383772906.875 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:47.280Z,1383772907.280 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:47.693Z,1383772907.693 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:48.087Z,1383772908.087 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:48.494Z,1383772908.494 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:48.888Z,1383772908.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:49.275Z,1383772909.275 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:49.684Z,1383772909.684 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:49.684Z,1383772909.684 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:21:50.092Z,1383772910.092 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:21:50.092Z,1383772910.092 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:21:50.093Z,1383772910.093 [DataOverHttps](INFO): sslConnect
2013-11-06T21:21:50.094Z,1383772910.094 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:50.491Z,1383772910.491 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:50.491Z,1383772910.491 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:51.366Z,1383772911.366 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:21:51.366Z,1383772911.366 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:21:51.369Z,1383772911.369 [DataOverHttps](INFO): dataWrite
2013-11-06T21:21:51.369Z,1383772911.369 [DataOverHttps](INFO): dataWriting
2013-11-06T21:21:51.370Z,1383772911.370 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:21:51.788Z,1383772911.788 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:51.789Z,1383772911.789 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:52.175Z,1383772912.175 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:21:52.176Z,1383772912.176 [DataOverHttps](INFO): dataRead
2013-11-06T21:21:52.176Z,1383772912.176 [DataOverHttps](INFO): disconnect
2013-11-06T21:21:52.584Z,1383772912.584 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:52.993Z,1383772912.993 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:53.391Z,1383772913.391 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:53.790Z,1383772913.790 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:54.188Z,1383772914.188 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:54.589Z,1383772914.589 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:54.990Z,1383772914.990 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:55.389Z,1383772915.389 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:55.781Z,1383772915.781 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:56.194Z,1383772916.194 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:56.588Z,1383772916.588 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:56.991Z,1383772916.991 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:57.389Z,1383772917.389 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:57.790Z,1383772917.790 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:58.193Z,1383772918.193 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:58.593Z,1383772918.593 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:58.990Z,1383772918.990 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:59.391Z,1383772919.391 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:21:59.791Z,1383772919.791 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:00.189Z,1383772920.189 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:00.590Z,1383772920.590 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:00.981Z,1383772920.981 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:01.388Z,1383772921.388 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:01.788Z,1383772921.788 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:02.183Z,1383772922.183 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:02.592Z,1383772922.592 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:02.990Z,1383772922.990 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:03.389Z,1383772923.389 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:03.782Z,1383772923.782 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:04.192Z,1383772924.192 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:04.595Z,1383772924.595 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:04.975Z,1383772924.975 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:05.384Z,1383772925.384 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:05.793Z,1383772925.793 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:06.188Z,1383772926.188 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:06.590Z,1383772926.590 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:06.982Z,1383772926.982 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:07.389Z,1383772927.389 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:07.776Z,1383772927.776 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:08.190Z,1383772928.190 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:08.581Z,1383772928.581 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:08.990Z,1383772928.990 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:09.382Z,1383772929.382 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:09.788Z,1383772929.788 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:10.189Z,1383772930.189 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:10.580Z,1383772930.580 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:10.987Z,1383772930.987 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:11.391Z,1383772931.391 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:11.782Z,1383772931.782 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:12.195Z,1383772932.195 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:12.589Z,1383772932.589 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:12.980Z,1383772932.980 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:13.376Z,1383772933.376 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:13.789Z,1383772933.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:14.194Z,1383772934.194 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:14.574Z,1383772934.574 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:14.991Z,1383772934.991 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:15.383Z,1383772935.383 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:15.784Z,1383772935.784 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:16.191Z,1383772936.191 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:16.589Z,1383772936.589 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:16.982Z,1383772936.982 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:17.391Z,1383772937.391 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:17.783Z,1383772937.783 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:18.196Z,1383772938.196 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:18.576Z,1383772938.576 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:18.993Z,1383772938.993 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:19.388Z,1383772939.388 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:19.783Z,1383772939.783 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:19.783Z,1383772939.783 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:22:20.183Z,1383772940.183 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:22:20.184Z,1383772940.184 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:22:20.184Z,1383772940.184 [DataOverHttps](INFO): sslConnect
2013-11-06T21:22:20.185Z,1383772940.185 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:22:20.596Z,1383772940.596 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:22:20.596Z,1383772940.596 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:22:21.490Z,1383772941.490 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:22:21.491Z,1383772941.491 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:22:21.493Z,1383772941.493 [DataOverHttps](INFO): dataWrite
2013-11-06T21:22:21.493Z,1383772941.493 [DataOverHttps](INFO): dataWriting
2013-11-06T21:22:21.494Z,1383772941.494 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:22:21.862Z,1383772941.862 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:22:21.862Z,1383772941.862 [DataOverHttps](INFO): dataRead
2013-11-06T21:22:22.270Z,1383772942.270 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:22:22.270Z,1383772942.270 [DataOverHttps](INFO): dataRead
2013-11-06T21:22:22.271Z,1383772942.271 [DataOverHttps](INFO): disconnect
2013-11-06T21:22:22.675Z,1383772942.675 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:23.067Z,1383772943.067 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:23.468Z,1383772943.468 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:23.877Z,1383772943.877 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:24.276Z,1383772944.276 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:24.682Z,1383772944.682 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:25.074Z,1383772945.074 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:25.467Z,1383772945.467 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:25.868Z,1383772945.868 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:26.280Z,1383772946.280 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:26.673Z,1383772946.673 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:27.074Z,1383772947.074 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:27.482Z,1383772947.482 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:27.863Z,1383772947.863 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:28.274Z,1383772948.274 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:28.668Z,1383772948.668 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:29.065Z,1383772949.065 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:29.481Z,1383772949.481 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:29.892Z,1383772949.892 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:30.277Z,1383772950.277 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:30.675Z,1383772950.675 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:31.089Z,1383772951.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:31.472Z,1383772951.472 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:31.891Z,1383772951.891 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:32.290Z,1383772952.290 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:32.674Z,1383772952.674 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:33.075Z,1383772953.075 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:33.484Z,1383772953.484 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:33.876Z,1383772953.876 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:34.281Z,1383772954.281 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:34.697Z,1383772954.697 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:35.089Z,1383772955.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:35.488Z,1383772955.488 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:35.899Z,1383772955.899 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:36.290Z,1383772956.290 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:36.692Z,1383772956.692 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:37.089Z,1383772957.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:37.489Z,1383772957.489 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:37.888Z,1383772957.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:38.299Z,1383772958.299 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:38.690Z,1383772958.690 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:39.090Z,1383772959.090 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:39.490Z,1383772959.490 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:39.888Z,1383772959.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:40.293Z,1383772960.293 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:40.689Z,1383772960.689 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:41.089Z,1383772961.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:41.492Z,1383772961.492 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:41.897Z,1383772961.897 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:42.288Z,1383772962.288 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:42.692Z,1383772962.692 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:43.090Z,1383772963.090 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:43.491Z,1383772963.491 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:43.889Z,1383772963.889 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:44.292Z,1383772964.292 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:44.688Z,1383772964.688 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:45.091Z,1383772965.091 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:45.492Z,1383772965.492 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:45.888Z,1383772965.888 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:46.299Z,1383772966.299 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:46.696Z,1383772966.696 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:47.089Z,1383772967.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:47.481Z,1383772967.481 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:47.890Z,1383772967.890 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:48.283Z,1383772968.283 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:48.690Z,1383772968.690 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:49.089Z,1383772969.089 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:49.487Z,1383772969.487 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:49.891Z,1383772969.891 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:49.891Z,1383772969.891 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:22:50.294Z,1383772970.294 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:22:50.294Z,1383772970.294 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:22:50.294Z,1383772970.294 [DataOverHttps](INFO): sslConnect
2013-11-06T21:22:50.295Z,1383772970.295 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:22:50.689Z,1383772970.689 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:22:50.689Z,1383772970.689 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:22:51.564Z,1383772971.564 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:22:51.564Z,1383772971.564 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:22:51.566Z,1383772971.566 [DataOverHttps](INFO): dataWrite
2013-11-06T21:22:51.566Z,1383772971.566 [DataOverHttps](INFO): dataWriting
2013-11-06T21:22:51.567Z,1383772971.567 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:22:51.960Z,1383772971.960 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:22:51.960Z,1383772971.960 [DataOverHttps](INFO): dataRead
2013-11-06T21:22:52.361Z,1383772972.361 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:22:52.361Z,1383772972.361 [DataOverHttps](INFO): dataRead
2013-11-06T21:22:52.362Z,1383772972.362 [DataOverHttps](INFO): disconnect
2013-11-06T21:22:52.769Z,1383772972.769 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:53.174Z,1383772973.174 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:53.575Z,1383772973.575 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:53.983Z,1383772973.983 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:54.376Z,1383772974.376 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:54.777Z,1383772974.777 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:55.181Z,1383772975.181 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:55.574Z,1383772975.574 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:55.970Z,1383772975.970 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:56.383Z,1383772976.383 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:56.780Z,1383772976.780 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:57.184Z,1383772977.184 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:57.589Z,1383772977.589 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:57.990Z,1383772977.990 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:58.392Z,1383772978.392 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:58.791Z,1383772978.791 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:59.189Z,1383772979.189 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:59.589Z,1383772979.589 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:22:59.989Z,1383772979.989 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:00.388Z,1383772980.388 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:00.790Z,1383772980.790 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:01.194Z,1383772981.194 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:01.575Z,1383772981.575 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:01.980Z,1383772981.980 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:02.392Z,1383772982.392 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:02.789Z,1383772982.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:03.191Z,1383772983.191 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:03.590Z,1383772983.590 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:03.991Z,1383772983.991 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:04.375Z,1383772984.375 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:04.789Z,1383772984.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:05.193Z,1383772985.193 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:05.591Z,1383772985.591 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:05.994Z,1383772985.994 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:06.388Z,1383772986.388 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:06.789Z,1383772986.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:07.192Z,1383772987.192 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:07.588Z,1383772987.588 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:07.991Z,1383772987.991 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:08.390Z,1383772988.390 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:08.789Z,1383772988.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:09.188Z,1383772989.188 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:09.595Z,1383772989.595 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:09.976Z,1383772989.976 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:10.390Z,1383772990.390 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:10.789Z,1383772990.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:11.189Z,1383772991.189 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:11.588Z,1383772991.588 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:11.991Z,1383772991.991 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:12.389Z,1383772992.389 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:12.777Z,1383772992.777 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:13.193Z,1383772993.193 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:13.582Z,1383772993.582 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:13.982Z,1383772993.982 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:14.395Z,1383772994.395 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:14.789Z,1383772994.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:15.189Z,1383772995.189 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:15.581Z,1383772995.581 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:15.981Z,1383772995.981 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:16.392Z,1383772996.392 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:16.788Z,1383772996.788 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:17.183Z,1383772997.183 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:17.584Z,1383772997.584 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:17.992Z,1383772997.992 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:18.381Z,1383772998.381 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:18.790Z,1383772998.790 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:19.194Z,1383772999.194 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:19.583Z,1383772999.583 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:19.990Z,1383772999.990 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:19.990Z,1383772999.990 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:23:20.390Z,1383773000.390 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:23:20.390Z,1383773000.390 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:23:20.390Z,1383773000.390 [DataOverHttps](INFO): sslConnect
2013-11-06T21:23:20.392Z,1383773000.392 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:23:20.789Z,1383773000.789 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:23:20.789Z,1383773000.789 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:23:21.678Z,1383773001.678 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:23:21.678Z,1383773001.678 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:23:21.680Z,1383773001.680 [DataOverHttps](INFO): dataWrite
2013-11-06T21:23:21.681Z,1383773001.681 [DataOverHttps](INFO): dataWriting
2013-11-06T21:23:21.682Z,1383773001.682 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:23:22.079Z,1383773002.079 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:23:22.079Z,1383773002.079 [DataOverHttps](INFO): dataRead
2013-11-06T21:23:22.479Z,1383773002.479 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:23:22.480Z,1383773002.480 [DataOverHttps](INFO): dataRead
2013-11-06T21:23:22.480Z,1383773002.480 [DataOverHttps](INFO): disconnect
2013-11-06T21:23:22.889Z,1383773002.889 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:23.275Z,1383773003.275 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:23.673Z,1383773003.673 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:24.091Z,1383773004.091 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:24.488Z,1383773004.488 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:24.875Z,1383773004.875 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:25.290Z,1383773005.290 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:25.673Z,1383773005.673 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:26.090Z,1383773006.090 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:26.506Z,1383773006.506 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:26.887Z,1383773006.887 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:27.303Z,1383773007.303 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:27.696Z,1383773007.696 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:28.104Z,1383773008.104 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:28.497Z,1383773008.497 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:28.901Z,1383773008.901 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:29.306Z,1383773009.306 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:29.699Z,1383773009.699 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:30.103Z,1383773010.103 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:30.496Z,1383773010.496 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:30.901Z,1383773010.901 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:31.305Z,1383773011.305 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:31.698Z,1383773011.698 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:32.098Z,1383773012.098 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:32.507Z,1383773012.507 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:32.889Z,1383773012.889 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:33.290Z,1383773013.290 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:33.709Z,1383773013.709 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:34.102Z,1383773014.102 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:34.498Z,1383773014.498 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:34.911Z,1383773014.911 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:35.299Z,1383773015.299 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:35.700Z,1383773015.700 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:36.113Z,1383773016.113 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:36.505Z,1383773016.505 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:36.902Z,1383773016.902 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:37.294Z,1383773017.294 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:37.699Z,1383773017.699 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:38.112Z,1383773018.112 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:38.504Z,1383773018.504 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:38.897Z,1383773018.897 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:39.298Z,1383773019.298 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:39.710Z,1383773019.710 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:40.099Z,1383773020.099 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:40.503Z,1383773020.503 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:40.904Z,1383773020.904 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:41.305Z,1383773021.305 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:41.693Z,1383773021.693 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:42.090Z,1383773022.090 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:42.499Z,1383773022.499 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:42.899Z,1383773022.899 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:43.304Z,1383773023.304 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:43.704Z,1383773023.704 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:44.097Z,1383773024.097 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:44.506Z,1383773024.506 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:44.891Z,1383773024.891 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:45.291Z,1383773025.291 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:45.711Z,1383773025.711 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:46.100Z,1383773026.100 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:46.505Z,1383773026.505 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:46.909Z,1383773026.909 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:47.302Z,1383773027.302 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:47.703Z,1383773027.703 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:48.115Z,1383773028.115 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:48.500Z,1383773028.500 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:48.912Z,1383773028.912 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:49.305Z,1383773029.305 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:49.694Z,1383773029.694 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:50.090Z,1383773030.090 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:50.091Z,1383773030.091 [DataOverHttps](INFO): tcpConnect
2013-11-06T21:23:50.499Z,1383773030.499 [DataOverHttps](INFO): run, dataState=1
2013-11-06T21:23:50.499Z,1383773030.499 [DataOverHttps](INFO): tcpConnecting
2013-11-06T21:23:50.499Z,1383773030.499 [DataOverHttps](INFO): sslConnect
2013-11-06T21:23:50.501Z,1383773030.501 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:23:50.912Z,1383773030.912 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:23:50.912Z,1383773030.912 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:23:51.765Z,1383773031.765 [DataOverHttps](INFO): run, dataState=3
2013-11-06T21:23:51.765Z,1383773031.765 [DataOverHttps](INFO): sslConnecting
2013-11-06T21:23:51.767Z,1383773031.767 [DataOverHttps](INFO): dataWrite
2013-11-06T21:23:51.767Z,1383773031.767 [DataOverHttps](INFO): dataWriting
2013-11-06T21:23:51.769Z,1383773031.769 [DataOverHttps](INFO): Wrote 206 bytes.
2013-11-06T21:23:52.170Z,1383773032.170 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:23:52.170Z,1383773032.170 [DataOverHttps](INFO): dataRead
2013-11-06T21:23:52.570Z,1383773032.570 [DataOverHttps](INFO): run, dataState=6
2013-11-06T21:23:52.570Z,1383773032.570 [DataOverHttps](INFO): dataRead
2013-11-06T21:23:52.571Z,1383773032.571 [DataOverHttps](INFO): disconnect
2013-11-06T21:23:52.983Z,1383773032.983 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:53.395Z,1383773033.395 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:53.789Z,1383773033.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:54.197Z,1383773034.197 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:54.597Z,1383773034.597 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:55.002Z,1383773035.002 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:55.411Z,1383773035.411 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:55.783Z,1383773035.783 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:56.189Z,1383773036.189 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:56.596Z,1383773036.596 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:57.005Z,1383773037.005 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:57.406Z,1383773037.406 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:57.810Z,1383773037.810 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:58.188Z,1383773038.188 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:58.588Z,1383773038.588 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:58.996Z,1383773038.996 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:59.389Z,1383773039.389 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:59.399Z,1383773039.399 [NAL9602](IMPORTANT): GPS fix at: 1383773061.00
2013-11-06T21:23:59.414Z,1383773039.414 [Default:GPS:Read_GPS] Stopped
2013-11-06T21:23:59.414Z,1383773039.414 [Default:GPS:D] Running Loop=1
2013-11-06T21:23:59.789Z,1383773039.789 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:23:59.823Z,1383773039.823 [Default:GPS:D] Stopped
2013-11-06T21:23:59.823Z,1383773039.823 [Default:GPS](INFO): Completed Default:GPS
2013-11-06T21:23:59.823Z,1383773039.823 [Default:GPS] Stopped
2013-11-06T21:23:59.824Z,1383773039.824 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-11-06T21:23:59.824Z,1383773039.824 [Default:GPS:A.SetSpeed] Stopped
2013-11-06T21:23:59.824Z,1383773039.824 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-11-06T21:24:00.193Z,1383773040.193 [CommandLine](IMPORTANT): got command quit
2013-11-06T21:24:00.198Z,1383773040.198 [DataOverHttps](INFO): run, dataState=8
2013-11-06T21:24:01.342Z,1383773041.342 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2013-11-06T21:24:01.342Z,1383773041.342 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2013-11-06T21:24:02.196Z,1383773042.196 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2013-11-06T21:24:02.276Z,1383773042.276 [WetLabsBB2FL](INFO): Powering down
2013-11-06T21:24:02.296Z,1383773042.296 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2013-11-06T21:24:02.360Z,1383773042.360 [CTD_NeilBrown](INFO): Powering down
2013-11-06T21:24:02.368Z,1383773042.368 [ComponentRegistry](INFO): Shutting down DVL_micro ThreadHandler
2013-11-06T21:24:02.400Z,1383773042.400 [DVL_micro](INFO): uninitialize:Powering down
2013-11-06T21:24:02.412Z,1383773042.412 [ComponentRegistry](INFO): Shutting down AsyncPiEstimator ThreadHandler
2013-11-06T21:24:02.604Z,1383773042.604 [AsyncPiEstimator](DEBUG): Uninitialize AsyncPiEstimator.
2013-11-06T21:24:02.609Z,1383773042.609 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2013-11-06T21:24:02.689Z,1383773042.689 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2013-11-06T21:24:02.690Z,1383773042.690 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2013-11-06T21:24:04.852Z,1383773044.852 [controlThread](DEBUG): Uninitializing ControlThread
2013-11-06T21:24:04.853Z,1383773044.853 [AHRS_sp3003D](INFO): Powering down
2013-11-06T21:24:04.940Z,1383773044.940 [DataOverHttps](INFO): disconnect
2013-11-06T21:24:04.941Z,1383773044.941 [NAL9602](INFO): Powering down
2013-11-06T21:24:04.942Z,1383773044.942 [DAT](INFO): Powering down
2013-11-06T21:24:04.943Z,1383773044.943 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2013-11-06T21:24:04.944Z,1383773044.944 [NavChart](DEBUG): Uninitialize NavChart Derivation.
2013-11-06T21:24:04.945Z,1383773044.945 [Default] Stopped
2013-11-06T21:24:04.945Z,1383773044.945 [Default](INFO): Aggregate::uninitialize Default
2013-11-06T21:24:04.945Z,1383773044.945 [Default:D.SetSpeed] Stopped
2013-11-06T21:24:04.945Z,1383773044.945 [Default:D.SetSpeed](DEBUG): Uninitialize.
2013-11-06T21:24:04.945Z,1383773044.945 [Default:E.GoToSurface] Stopped
2013-11-06T21:24:04.945Z,1383773044.945 [Default:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-11-06T21:24:04.945Z,1383773044.945 [Default:F.Wait] Stopped
2013-11-06T21:24:04.945Z,1383773044.945 [Default:F.Wait](DEBUG): Uninitialize Wait Component.
2013-11-06T21:24:04.950Z,1383773044.950 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2013-11-06T21:24:04.950Z,1383773044.950 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2013-11-06T21:24:04.951Z,1383773044.951 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2013-11-06T21:24:04.951Z,1383773044.951 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2013-11-06T21:24:04.951Z,1383773044.951 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2013-11-06T21:24:04.951Z,1383773044.951 [BuoyancyServo](INFO): Powering down
2013-11-06T21:24:04.964Z,1383773044.964 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2013-11-06T21:24:04.964Z,1383773044.964 [ElevatorServo](INFO): Powering down
2013-11-06T21:24:04.965Z,1383773044.965 [MassServo](DEBUG): Uninitialize Mass Servo.
2013-11-06T21:24:04.965Z,1383773044.965 [MassServo](INFO): Powering down
2013-11-06T21:24:04.966Z,1383773044.966 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2013-11-06T21:24:04.966Z,1383773044.966 [RudderServo](INFO): Powering down
2013-11-06T21:24:04.967Z,1383773044.967 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2013-11-06T21:24:04.967Z,1383773044.967 [ThrusterServo](INFO): Powering down
2013-11-06T21:24:04.968Z,1383773044.968 [SBIT](DEBUG): Uninitialize SBIT Component.
2013-11-06T21:24:04.968Z,1383773044.968 [IBIT](DEBUG): Uninitialize IBIT Component.
2013-11-06T21:24:04.969Z,1383773044.969 [CBIT](DEBUG): Uninitialize CBIT Component.