2014-09-12T21:09:38.233Z,1410556178.233 [Supervisor](DEBUG): Initializing supervisor. 2014-09-12T21:09:38.236Z,1410556178.236 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0 2014-09-12T21:09:38.236Z,1410556178.236 [SyncHandler](INFO): Protected caller Thread ID is 2111 2014-09-12T21:09:38.237Z,1410556178.237 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2014-09-12T21:09:38.238Z,1410556178.238 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0 2014-09-12T21:09:38.238Z,1410556178.238 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2112 2014-09-12T21:09:38.242Z,1410556178.242 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2014-09-12T21:09:38.442Z,1410556178.442 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2014-09-12T21:09:38.443Z,1410556178.443 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0 2014-09-12T21:09:38.443Z,1410556178.443 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2113 2014-09-12T21:09:38.444Z,1410556178.444 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2014-09-12T21:09:38.445Z,1410556178.445 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0 2014-09-12T21:09:38.445Z,1410556178.445 [logger ThreadHandler](INFO): Protected caller Thread ID is 2114 2014-09-12T21:09:38.447Z,1410556178.447 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2014-09-12T21:09:38.448Z,1410556178.448 [Supervisor](INFO): Looking for Config files in directory: Config/ 2014-09-12T21:09:38.461Z,1410556178.461 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2014-09-12T21:09:38.933Z,1410556178.933 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2014-09-12T21:09:38.934Z,1410556178.934 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2014-09-12T21:09:39.092Z,1410556179.092 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2014-09-12T21:09:39.093Z,1410556179.093 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2014-09-12T21:09:39.204Z,1410556179.204 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2014-09-12T21:09:39.205Z,1410556179.205 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2014-09-12T21:09:39.332Z,1410556179.332 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2014-09-12T21:09:39.332Z,1410556179.332 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2014-09-12T21:09:39.422Z,1410556179.422 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2014-09-12T21:09:39.567Z,1410556179.567 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2014-09-12T21:09:39.568Z,1410556179.568 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2014-09-12T21:09:39.656Z,1410556179.656 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2014-09-12T21:09:39.656Z,1410556179.656 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2014-09-12T21:09:39.855Z,1410556179.855 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2014-09-12T21:09:39.856Z,1410556179.856 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2014-09-12T21:09:40.152Z,1410556180.152 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2014-09-12T21:09:40.153Z,1410556180.153 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2014-09-12T21:09:40.449Z,1410556180.449 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2014-09-12T21:09:40.450Z,1410556180.450 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2014-09-12T21:09:40.934Z,1410556180.934 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2014-09-12T21:09:40.935Z,1410556180.935 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2014-09-12T21:09:41.124Z,1410556181.124 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2014-09-12T21:09:41.125Z,1410556181.125 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2014-09-12T21:09:41.230Z,1410556181.230 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2014-09-12T21:09:41.230Z,1410556181.230 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2014-09-12T21:09:41.631Z,1410556181.631 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2014-09-12T21:09:41.632Z,1410556181.632 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2014-09-12T21:09:41.743Z,1410556181.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2014-09-12T21:09:41.745Z,1410556181.745 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2014-09-12T21:09:41.746Z,1410556181.746 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2014-09-12T21:09:41.985Z,1410556181.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2014-09-12T21:09:41.986Z,1410556181.986 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2014-09-12T21:09:42.103Z,1410556182.103 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Estimation.cfg 2014-09-12T21:09:42.202Z,1410556182.202 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2014-09-12T21:09:42.300Z,1410556182.300 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2014-09-12T21:09:42.399Z,1410556182.399 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2014-09-12T21:09:42.538Z,1410556182.538 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2014-09-12T21:09:42.696Z,1410556182.696 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2014-09-12T21:09:42.798Z,1410556182.798 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2014-09-12T21:09:42.886Z,1410556182.886 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2014-09-12T21:09:42.980Z,1410556182.980 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2014-09-12T21:09:43.079Z,1410556183.079 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2014-09-12T21:09:43.240Z,1410556183.240 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/LOGIN/ 2014-09-12T21:09:43.240Z,1410556183.240 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2014-09-12T21:09:43.242Z,1410556183.242 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2014-09-12T21:09:43.293Z,1410556183.293 [VerticalControl](DEBUG): Construct VerticalControl. 2014-09-12T21:09:43.412Z,1410556183.412 [VerticalControl] Loaded 2014-09-12T21:09:43.412Z,1410556183.412 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2014-09-12T21:09:43.413Z,1410556183.413 [HorizontalControl](DEBUG): Construct HorizontalControl. 2014-09-12T21:09:43.483Z,1410556183.483 [HorizontalControl] Loaded 2014-09-12T21:09:43.483Z,1410556183.483 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2014-09-12T21:09:43.484Z,1410556183.484 [SpeedControl](DEBUG): Construct SpeedControl. 2014-09-12T21:09:43.489Z,1410556183.489 [SpeedControl] Loaded 2014-09-12T21:09:43.490Z,1410556183.490 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2014-09-12T21:09:43.490Z,1410556183.490 [LoopControl](DEBUG): Construct LoopControl. 2014-09-12T21:09:43.491Z,1410556183.491 [LoopControl] Loaded 2014-09-12T21:09:43.491Z,1410556183.491 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2014-09-12T21:09:43.492Z,1410556183.492 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2014-09-12T21:09:43.492Z,1410556183.492 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2014-09-12T21:09:43.592Z,1410556183.592 [SBIT](DEBUG): Construct Startup Built In Test. 2014-09-12T21:09:43.603Z,1410556183.603 [SBIT] Loaded 2014-09-12T21:09:43.603Z,1410556183.603 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2014-09-12T21:09:43.604Z,1410556183.604 [IBIT](DEBUG): Construct Initiated Built In Test. 2014-09-12T21:09:43.633Z,1410556183.633 [IBIT] Loaded 2014-09-12T21:09:43.633Z,1410556183.633 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2014-09-12T21:09:43.635Z,1410556183.635 [CBIT](DEBUG): Construct CBIT Built In Test. 2014-09-12T21:09:43.756Z,1410556183.756 [CBIT] Loaded 2014-09-12T21:09:43.757Z,1410556183.757 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2014-09-12T21:09:43.757Z,1410556183.757 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2014-09-12T21:09:43.758Z,1410556183.758 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2014-09-12T21:09:43.779Z,1410556183.779 [DepthRateCalculator] Loaded 2014-09-12T21:09:43.779Z,1410556183.779 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2014-09-12T21:09:43.785Z,1410556183.785 [PitchRateCalculator] Loaded 2014-09-12T21:09:43.785Z,1410556183.785 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2014-09-12T21:09:43.796Z,1410556183.796 [SpeedCalculator] Loaded 2014-09-12T21:09:43.796Z,1410556183.796 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2014-09-12T21:09:43.813Z,1410556183.813 [TempGradientCalculator] Loaded 2014-09-12T21:09:43.813Z,1410556183.813 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2014-09-12T21:09:43.818Z,1410556183.818 [YawRateCalculator] Loaded 2014-09-12T21:09:43.819Z,1410556183.819 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2014-09-12T21:09:43.819Z,1410556183.819 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2014-09-12T21:09:43.820Z,1410556183.820 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2014-09-12T21:09:58.362Z,1410556198.362 [HFRCMReconstructedInterpolator] Loaded 2014-09-12T21:09:58.362Z,1410556198.362 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread. 2014-09-12T21:09:58.363Z,1410556198.363 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2014-09-12T21:09:58.363Z,1410556198.363 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2014-09-12T21:09:58.596Z,1410556198.596 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2014-09-12T21:09:58.596Z,1410556198.596 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2014-09-12T21:09:58.677Z,1410556198.677 [DeadReckonUsingMultipleVelocitySourcesVector] Loaded 2014-09-12T21:09:58.677Z,1410556198.677 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySourcesVector" handled in the control thread. 2014-09-12T21:09:58.731Z,1410556198.731 [DeadReckonUsingMultipleVelocitySources] Loaded 2014-09-12T21:09:58.731Z,1410556198.731 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2014-09-12T21:09:58.776Z,1410556198.776 [DeadReckonWithRespectToWater] Loaded 2014-09-12T21:09:58.777Z,1410556198.777 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToWater" handled in the control thread. 2014-09-12T21:09:58.822Z,1410556198.822 [DeadReckonWithRespectToSeafloor] Loaded 2014-09-12T21:09:58.822Z,1410556198.822 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2014-09-12T21:09:58.881Z,1410556198.881 [DeadReckonUsingDVLWaterTrack] Loaded 2014-09-12T21:09:58.882Z,1410556198.882 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingDVLWaterTrack" handled in the control thread. 2014-09-12T21:09:58.898Z,1410556198.898 [NavChart] Loaded 2014-09-12T21:09:58.899Z,1410556198.899 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2014-09-12T21:09:58.903Z,1410556198.903 [UniversalFixResidualReporter] Loaded 2014-09-12T21:09:58.903Z,1410556198.903 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2014-09-12T21:09:58.904Z,1410556198.904 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2014-09-12T21:09:58.904Z,1410556198.904 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2014-09-12T21:09:58.910Z,1410556198.910 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2014-09-12T21:09:58.911Z,1410556198.911 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2014-09-12T21:09:59.083Z,1410556199.083 [Aanderaa_O2] Loaded 2014-09-12T21:09:59.083Z,1410556199.083 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2014-09-12T21:09:59.119Z,1410556199.119 [CTD_NeilBrown] Loaded 2014-09-12T21:09:59.119Z,1410556199.119 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2014-09-12T21:09:59.121Z,1410556199.121 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 405DB4E0 2014-09-12T21:09:59.121Z,1410556199.121 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 2196 2014-09-12T21:09:59.138Z,1410556199.138 [rhodamine] Loaded 2014-09-12T21:09:59.138Z,1410556199.138 [ComponentRegistry](DEBUG): SyncComponent "rhodamine" handled in the control thread. 2014-09-12T21:09:59.174Z,1410556199.174 [WetLabsBB2FL] Loaded 2014-09-12T21:09:59.174Z,1410556199.174 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2014-09-12T21:09:59.175Z,1410556199.175 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4060B4E0 2014-09-12T21:09:59.176Z,1410556199.176 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2197 2014-09-12T21:09:59.176Z,1410556199.176 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2014-09-12T21:09:59.177Z,1410556199.177 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2014-09-12T21:09:59.511Z,1410556199.511 [AHRS_sp3003D] Loaded 2014-09-12T21:09:59.511Z,1410556199.511 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread. 2014-09-12T21:09:59.583Z,1410556199.583 [DataOverHttps] Loaded 2014-09-12T21:09:59.584Z,1410556199.584 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2014-09-12T21:09:59.598Z,1410556199.598 [Depth_Keller] Loaded 2014-09-12T21:09:59.598Z,1410556199.598 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2014-09-12T21:09:59.603Z,1410556199.603 [DropWeight] Loaded 2014-09-12T21:09:59.603Z,1410556199.603 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2014-09-12T21:09:59.740Z,1410556199.740 [DVL_micro] Loaded 2014-09-12T21:09:59.740Z,1410556199.740 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2014-09-12T21:09:59.835Z,1410556199.835 [NAL9602] Loaded 2014-09-12T21:09:59.835Z,1410556199.835 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2014-09-12T21:09:59.877Z,1410556199.877 [Onboard] Loaded 2014-09-12T21:09:59.877Z,1410556199.877 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2014-09-12T21:10:01.719Z,1410556201.719 [BPC1] Loaded 2014-09-12T21:10:01.720Z,1410556201.720 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2014-09-12T21:10:01.720Z,1410556201.720 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2014-09-12T21:10:01.721Z,1410556201.721 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2014-09-12T21:10:01.823Z,1410556201.823 [BuoyancyServo] Loaded 2014-09-12T21:10:01.823Z,1410556201.823 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2014-09-12T21:10:01.835Z,1410556201.835 [ElevatorServo] Loaded 2014-09-12T21:10:01.836Z,1410556201.836 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2014-09-12T21:10:01.847Z,1410556201.847 [MassServo] Loaded 2014-09-12T21:10:01.848Z,1410556201.848 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2014-09-12T21:10:01.860Z,1410556201.860 [RudderServo] Loaded 2014-09-12T21:10:01.860Z,1410556201.860 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2014-09-12T21:10:01.871Z,1410556201.871 [ThrusterServo] Loaded 2014-09-12T21:10:01.872Z,1410556201.872 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2014-09-12T21:10:01.872Z,1410556201.872 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2014-09-12T21:10:01.873Z,1410556201.873 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2014-09-12T21:10:02.103Z,1410556202.103 [ExternalSim] Loaded 2014-09-12T21:10:02.103Z,1410556202.103 [ComponentRegistry](DEBUG): SyncComponent "ExternalSim" handled in the control thread. 2014-09-12T21:10:02.157Z,1410556202.157 [InternalSim] Loaded 2014-09-12T21:10:02.157Z,1410556202.157 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread. 2014-09-12T21:10:02.158Z,1410556202.158 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2014-09-12T21:10:02.159Z,1410556202.159 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2014-09-12T21:10:02.183Z,1410556202.183 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2014-09-12T21:10:02.185Z,1410556202.185 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2014-09-12T21:10:02.186Z,1410556202.186 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2014-09-12T21:10:02.193Z,1410556202.193 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2014-09-12T21:10:02.194Z,1410556202.194 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 408C84E0 2014-09-12T21:10:02.194Z,1410556202.194 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2198 2014-09-12T21:10:02.200Z,1410556202.200 [Supervisor](INFO): Main Thread ID is 2110 2014-09-12T21:10:02.200Z,1410556202.200 [Supervisor](DEBUG): Running supervisor. 2014-09-12T21:10:02.201Z,1410556202.201 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2199 2014-09-12T21:10:02.203Z,1410556202.203 [controlThread ThreadHandler](INFO): Handler Thread ID is 2200 2014-09-12T21:10:02.204Z,1410556202.204 [controlThread](DEBUG): Initializing ControlThread 2014-09-12T21:10:02.205Z,1410556202.205 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2014-09-12T21:10:02.206Z,1410556202.206 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2014-09-12T21:10:02.207Z,1410556202.207 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2014-09-12T21:10:02.208Z,1410556202.208 [LoopControl](DEBUG): Initialize LoopControlComponent. 2014-09-12T21:10:02.208Z,1410556202.208 [SBIT](INFO): Initialize SBIT Component. 2014-09-12T21:10:02.208Z,1410556202.208 [SBIT](IMPORTANT): Tethys CM Info: SVN revision: 11616 2014-09-12T21:10:02.209Z,1410556202.209 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2014-09-12T21:10:02.209Z,1410556202.209 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 2014-09-12T21:10:02.210Z,1410556202.210 [IBIT](INFO): Initialize IBIT Component. 2014-09-12T21:10:02.210Z,1410556202.210 [CBIT](DEBUG): Initialize CBIT Component. 2014-09-12T21:10:02.211Z,1410556202.211 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2014-09-12T21:10:02.212Z,1410556202.212 [logger ThreadHandler](INFO): Handler Thread ID is 2201 2014-09-12T21:10:02.237Z,1410556202.237 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2014-09-12T21:10:02.237Z,1410556202.237 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2014-09-12T21:10:02.237Z,1410556202.237 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2014-09-12T21:10:02.238Z,1410556202.238 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2014-09-12T21:10:02.238Z,1410556202.238 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2014-09-12T21:10:02.239Z,1410556202.239 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s. 2014-09-12T21:10:02.241Z,1410556202.241 [DeadReckonUsingMultipleVelocitySourcesVector](DEBUG): Initializing DeadReckonUsingMultipleVelocitySourcesVector component. 2014-09-12T21:10:02.242Z,1410556202.242 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2014-09-12T21:10:02.242Z,1410556202.242 [DeadReckonWithRespectToWater](DEBUG): Initializing DeadReckonWithRespectToWater component. 2014-09-12T21:10:02.243Z,1410556202.243 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2014-09-12T21:10:02.243Z,1410556202.243 [DeadReckonUsingDVLWaterTrack](DEBUG): Initializing DeadReckonUsingDVLWaterTrack component. 2014-09-12T21:10:02.243Z,1410556202.243 [NavChart](DEBUG): Initialize NavChart Navigation. 2014-09-12T21:10:02.244Z,1410556202.244 [UniversalFixResidualReporter](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2014-09-12T21:10:02.253Z,1410556202.253 [ExternalSim](INFO): ExternalSim initializing... 2014-09-12T21:10:02.257Z,1410556202.257 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 2202 2014-09-12T21:10:02.258Z,1410556202.258 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown. 2014-09-12T21:10:02.265Z,1410556202.265 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2204 2014-09-12T21:10:02.267Z,1410556202.267 [WetLabsBB2FL](INFO): Powering down 2014-09-12T21:10:02.271Z,1410556202.271 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4 2014-09-12T21:10:02.314Z,1410556202.314 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2205 2014-09-12T21:10:02.319Z,1410556202.319 [NavChartDb](FAULT): Change detected in ENC collection. Wiping NavChart Directory 2014-09-12T21:10:02.323Z,1410556202.323 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources 2014-09-12T21:10:02.325Z,1410556202.325 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US1WC07M.000 2014-09-12T21:10:02.327Z,1410556202.327 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2WC11M.000 2014-09-12T21:10:02.328Z,1410556202.328 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3CA52M.000 2014-09-12T21:10:02.330Z,1410556202.330 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4CA60M.000 2014-09-12T21:10:02.332Z,1410556202.332 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA50M.000 2014-09-12T21:10:02.353Z,1410556202.353 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA61M.000 2014-09-12T21:10:02.356Z,1410556202.356 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA62M.000 2014-09-12T21:10:02.358Z,1410556202.358 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA83M.000 2014-09-12T21:10:02.379Z,1410556202.379 [ExternalSim](ERROR): Error making socket connection to simulation server at tellum.shore.mbari.org: Could not connect due to error: Connection refused 2014-09-12T21:10:02.438Z,1410556202.438 [ExternalSim](DEBUG): beaconLat = 36.81340 2014-09-12T21:10:02.438Z,1410556202.438 [ExternalSim](DEBUG): beaconLon = -121.82240 2014-09-12T21:10:02.438Z,1410556202.438 [ExternalSim](DEBUG): beaconDepth = 25.00 2014-09-12T21:10:02.454Z,1410556202.454 [ExternalSim](DEBUG): Simulator initialized 2014-09-12T21:10:02.457Z,1410556202.457 [InternalSim](DEBUG): InternalSim initializing... 2014-09-12T21:10:02.526Z,1410556202.526 [NavChartDb](INFO): Setup scan of Resources/US5CA83M.000 2014-09-12T21:10:02.544Z,1410556202.544 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2014-09-12T21:10:02.559Z,1410556202.559 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2014-09-12T21:10:02.580Z,1410556202.580 [MissionManager](DEBUG): 2014-09-12T21:10:02.581Z,1410556202.581 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2014-09-12T21:10:02.642Z,1410556202.642 [MissionManager](INFO): DefineArg Default.TimeMissionWasStarted = 0.000000 h 2014-09-12T21:10:02.657Z,1410556202.657 [MissionManager](INFO): DefineArg Default.ElapsedSinceMissionWasStarted = 0.000000 h 2014-09-12T21:10:02.662Z,1410556202.662 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2014-09-12T21:10:02.682Z,1410556202.682 [Default:CheckIn:A.SetSpeed](DEBUG): Construct. 2014-09-12T21:10:02.688Z,1410556202.688 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2014-09-12T21:10:02.727Z,1410556202.727 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct. 2014-09-12T21:10:02.742Z,1410556202.742 [MissionManager](DEBUG): 0 0 5.0 1.0 400 Burn 300 Dropped drop weight due to communications timeout 5.0 Default mission has been running for 5 2014-09-12T21:10:02.751Z,1410556202.751 [controlThread](DEBUG): Component order: CycleStarter,ExternalSim,InternalSim,Aanderaa_O2,rhodamine,AHRS_sp3003D,DataOverHttps,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRCMReconstructedInterpolator,DeadReckonUsingMultipleVelocitySourcesVector,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToWater,DeadReckonWithRespectToSeafloor,DeadReckonUsingDVLWaterTrack,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2014-09-12T21:10:02.827Z,1410556202.827 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2014-09-12T21:10:02.857Z,1410556202.857 [Depth_Keller](ERROR): Pressure reading out of range: 1895.584351 decibar 2014-09-12T21:10:02.970Z,1410556202.970 [DVL_micro](INFO): Initializing 2014-09-12T21:10:03.190Z,1410556203.190 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:03.196Z,1410556203.196 [DeadReckonUsingMultipleVelocitySourcesVector](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.216Z,1410556203.216 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.233Z,1410556203.233 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.250Z,1410556203.250 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.257Z,1410556203.257 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.341Z,1410556203.341 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2014-09-12T21:10:03.342Z,1410556203.342 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2014-09-12T21:10:03.356Z,1410556203.356 [ElevatorServo](DEBUG): Initializing EZServoServo. 2014-09-12T21:10:03.363Z,1410556203.363 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2014-09-12T21:10:03.369Z,1410556203.369 [MassServo](DEBUG): Initializing EZServoServo. 2014-09-12T21:10:03.375Z,1410556203.375 [MassServo](DEBUG): Initializing MassServo. 2014-09-12T21:10:03.381Z,1410556203.381 [RudderServo](DEBUG): Initializing EZServoServo. 2014-09-12T21:10:03.387Z,1410556203.387 [RudderServo](DEBUG): Initializing RudderServo. 2014-09-12T21:10:03.393Z,1410556203.393 [ThrusterServo](DEBUG): Initializing EZServoServo. 2014-09-12T21:10:03.399Z,1410556203.399 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2014-09-12T21:10:03.659Z,1410556203.659 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:03.660Z,1410556203.660 [DeadReckonUsingMultipleVelocitySourcesVector](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.661Z,1410556203.661 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.662Z,1410556203.662 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.663Z,1410556203.663 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.664Z,1410556203.664 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.979Z,1410556203.979 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:03.980Z,1410556203.980 [DeadReckonUsingMultipleVelocitySourcesVector](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.981Z,1410556203.981 [DeadReckonUsingMultipleVelocitySources](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.982Z,1410556203.982 [DeadReckonWithRespectToWater](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.983Z,1410556203.983 [DeadReckonWithRespectToSeafloor](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:03.995Z,1410556203.995 [DeadReckonUsingDVLWaterTrack](DEBUG): Could not determine rotation from vehicle frame to navigation frame. 2014-09-12T21:10:04.328Z,1410556204.328 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2014-09-12T21:10:04.328Z,1410556204.328 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2014-09-12T21:10:04.328Z,1410556204.328 [BuoyancyServo] Communications Fault, FailCount= 1 2014-09-12T21:10:04.328Z,1410556204.328 [BuoyancyServo](ERROR): Communications Fault 2014-09-12T21:10:04.527Z,1410556204.527 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2014-09-12T21:10:04.871Z,1410556204.871 [NAL9602](INFO): Powering up NAL9602 2014-09-12T21:10:04.920Z,1410556204.920 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:04.943Z,1410556204.943 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2014-09-12T21:10:04.943Z,1410556204.943 [BuoyancyServo](INFO): Powering down 2014-09-12T21:10:05.380Z,1410556205.380 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:05.797Z,1410556205.797 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:06.262Z,1410556206.262 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:06.699Z,1410556206.699 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:06.726Z,1410556206.726 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2014-09-12T21:10:06.726Z,1410556206.726 [BuoyancyServo] Hardware Fault, FailCount= 1 2014-09-12T21:10:06.726Z,1410556206.726 [BuoyancyServo](ERROR): Hardware Fault 2014-09-12T21:10:07.140Z,1410556207.140 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:07.291Z,1410556207.291 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2014-09-12T21:10:07.291Z,1410556207.291 [BuoyancyServo] No Fault, FailCount= 1 2014-09-12T21:10:07.649Z,1410556207.649 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:07.671Z,1410556207.671 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2014-09-12T21:10:07.790Z,1410556207.790 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2014-09-12T21:10:08.362Z,1410556208.362 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:08.875Z,1410556208.875 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:09.328Z,1410556209.328 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:09.782Z,1410556209.782 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:10.241Z,1410556210.241 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:10.739Z,1410556210.739 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:11.263Z,1410556211.263 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:11.716Z,1410556211.716 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:12.220Z,1410556212.220 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:12.624Z,1410556212.624 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:13.051Z,1410556213.051 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:13.150Z,1410556213.150 [Aanderaa_O2](FAULT): Timed out starting 2014-09-12T21:10:13.151Z,1410556213.151 [Aanderaa_O2] Communications Fault, FailCount= 1 2014-09-12T21:10:13.151Z,1410556213.151 [Aanderaa_O2](ERROR): Communications Fault 2014-09-12T21:10:13.501Z,1410556213.501 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:13.649Z,1410556213.649 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2014-09-12T21:10:13.779Z,1410556213.779 [Aanderaa_O2](INFO): Powering down 2014-09-12T21:10:13.899Z,1410556213.899 [CommandLine](IMPORTANT): got command show variable rhodamine 2014-09-12T21:10:13.917Z,1410556213.917 [CommandLine](IMPORTANT): sea_water_rhodamine (unknown) 2014-09-12T21:10:13.937Z,1410556213.937 [CommandLine](IMPORTANT): rhodamine.loadAtStartup (bool) 2014-09-12T21:10:13.937Z,1410556213.937 [CommandLine](IMPORTANT): rhodamine.simulateHardware (bool) 2014-09-12T21:10:13.937Z,1410556213.937 [CommandLine](IMPORTANT): rhodamine.serial (none) 2014-09-12T21:10:13.938Z,1410556213.938 [CommandLine](IMPORTANT): rhodamine.scale (microvolt) 2014-09-12T21:10:13.938Z,1410556213.938 [CommandLine](IMPORTANT): rhodamine.maxBound (part_per_billion) 2014-09-12T21:10:13.955Z,1410556213.955 [CommandLine](IMPORTANT): rhodamine.minBound (part_per_billion) 2014-09-12T21:10:13.955Z,1410556213.955 [CommandLine](IMPORTANT): rhodamine.concentrationStandard (part_per_billion) 2014-09-12T21:10:13.956Z,1410556213.956 [CommandLine](IMPORTANT): rhodamine.voltageStandard (volt) 2014-09-12T21:10:13.956Z,1410556213.956 [CommandLine](IMPORTANT): rhodamine.voltageBlank (volt) 2014-09-12T21:10:14.008Z,1410556214.008 [CommandLine](IMPORTANT): rhodamine.loadControl (none) 2014-09-12T21:10:14.009Z,1410556214.009 [CommandLine](IMPORTANT): rhodamine.ad (none) 2014-09-12T21:10:14.010Z,1410556214.010 [CommandLine](IMPORTANT): rhodamine.adTimeout (millisecond) 2014-09-12T21:10:14.010Z,1410556214.010 [CommandLine](IMPORTANT): rhodamine.adVref (volt) 2014-09-12T21:10:14.011Z,1410556214.011 [CommandLine](IMPORTANT): rhodamine.adRes (bit) 2014-09-12T21:10:14.034Z,1410556214.034 [CommandLine](IMPORTANT): rhodamine.sea_water_rhodamine (part_per_billion) 2014-09-12T21:10:14.035Z,1410556214.035 [CommandLine](IMPORTANT): rhodamine.adcCount (count) 2014-09-12T21:10:14.035Z,1410556214.035 [CommandLine](IMPORTANT): rhodamine.voltage (millivolt) 2014-09-12T21:10:14.089Z,1410556214.089 [CommandLine](IMPORTANT): rhodamine.durationOfLastRun (second) 2014-09-12T21:10:14.155Z,1410556214.155 [DVL_micro](ERROR): No DVL communication! Re-initializing 2014-09-12T21:10:14.155Z,1410556214.155 [DVL_micro] Communications Fault, FailCount= 1 2014-09-12T21:10:14.155Z,1410556214.155 [DVL_micro](ERROR): Communications Fault 2014-09-12T21:10:14.166Z,1410556214.166 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:14.180Z,1410556214.180 [CBIT](ERROR): Communications Fault in component: DVL_micro 2014-09-12T21:10:14.616Z,1410556214.616 [DVL_micro](INFO): uninitialize:Powering down 2014-09-12T21:10:14.665Z,1410556214.665 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:15.037Z,1410556215.037 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:15.051Z,1410556215.051 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2014-09-12T21:10:15.051Z,1410556215.051 [Aanderaa_O2] No Fault, FailCount= 1 2014-09-12T21:10:15.434Z,1410556215.434 [DVL_micro](INFO): Initializing 2014-09-12T21:10:15.474Z,1410556215.474 [NAL9602](INFO): NAL9602 initialized 2014-09-12T21:10:15.489Z,1410556215.489 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:15.503Z,1410556215.503 [CBIT](INFO): Clearing failed state for component DVL_micro 2014-09-12T21:10:15.503Z,1410556215.503 [DVL_micro] No Fault, FailCount= 1 2014-09-12T21:10:15.906Z,1410556215.906 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:16.331Z,1410556216.331 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:16.742Z,1410556216.742 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:17.137Z,1410556217.137 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:17.530Z,1410556217.530 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:17.927Z,1410556217.927 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:17.940Z,1410556217.940 [SBIT](IMPORTANT): Beginning Startup BIT 2014-09-12T21:10:17.942Z,1410556217.942 [CBIT](IMPORTANT): Beginning GF scan 2014-09-12T21:10:18.327Z,1410556218.327 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:18.769Z,1410556218.769 [BPC1](FAULT): Failed to receive battery data 2014-09-12T21:10:18.769Z,1410556218.769 [BPC1] Communications Fault, FailCount= 1 2014-09-12T21:10:18.769Z,1410556218.769 [BPC1](ERROR): Communications Fault 2014-09-12T21:10:18.774Z,1410556218.774 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:18.840Z,1410556218.840 [CBIT](ERROR): Communications Fault in component: BPC1 2014-09-12T21:10:19.184Z,1410556219.184 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:19.613Z,1410556219.613 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:20.195Z,1410556220.195 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:20.661Z,1410556220.661 [CBIT](INFO): Clearing failed state for component BPC1 2014-09-12T21:10:20.661Z,1410556220.661 [BPC1] No Fault, FailCount= 1 2014-09-12T21:10:21.150Z,1410556221.150 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:21.664Z,1410556221.664 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:22.149Z,1410556222.149 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:22.610Z,1410556222.610 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:23.131Z,1410556223.131 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:23.789Z,1410556223.789 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:24.294Z,1410556224.294 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:24.832Z,1410556224.832 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:25.284Z,1410556225.284 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:25.374Z,1410556225.374 [Aanderaa_O2](FAULT): Timed out starting 2014-09-12T21:10:25.374Z,1410556225.374 [Aanderaa_O2] Communications Fault, FailCount= 2 2014-09-12T21:10:25.374Z,1410556225.374 [Aanderaa_O2](ERROR): Communications Fault 2014-09-12T21:10:25.705Z,1410556225.705 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:25.769Z,1410556225.769 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2014-09-12T21:10:25.794Z,1410556225.794 [CommandLine](IMPORTANT): got command report touch rhodamine.voltage 2014-09-12T21:10:25.918Z,1410556225.918 [Aanderaa_O2](INFO): Powering down 2014-09-12T21:10:26.244Z,1410556226.244 [DVL_micro](ERROR): No DVL communication! Re-initializing 2014-09-12T21:10:26.244Z,1410556226.244 [DVL_micro] Communications Fault, FailCount= 2 2014-09-12T21:10:26.244Z,1410556226.244 [DVL_micro](ERROR): Communications Fault 2014-09-12T21:10:26.256Z,1410556226.256 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:26.310Z,1410556226.310 [CBIT](ERROR): Communications Fault in component: DVL_micro 2014-09-12T21:10:26.727Z,1410556226.727 [DVL_micro](INFO): uninitialize:Powering down 2014-09-12T21:10:26.762Z,1410556226.762 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:27.265Z,1410556227.265 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:27.279Z,1410556227.279 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2014-09-12T21:10:27.279Z,1410556227.279 [Aanderaa_O2] No Fault, FailCount= 2 2014-09-12T21:10:27.660Z,1410556227.660 [DVL_micro](INFO): Initializing 2014-09-12T21:10:27.702Z,1410556227.702 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:27.717Z,1410556227.717 [CBIT](INFO): Clearing failed state for component DVL_micro 2014-09-12T21:10:27.717Z,1410556227.717 [DVL_micro] No Fault, FailCount= 2 2014-09-12T21:10:28.100Z,1410556228.100 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:28.499Z,1410556228.499 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:28.899Z,1410556228.899 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:29.314Z,1410556229.314 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:29.717Z,1410556229.717 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:30.123Z,1410556230.123 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:30.505Z,1410556230.505 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:30.910Z,1410556230.910 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:31.306Z,1410556231.306 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:31.708Z,1410556231.708 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:32.112Z,1410556232.112 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:32.559Z,1410556232.559 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:32.964Z,1410556232.964 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:33.409Z,1410556233.409 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:34.349Z,1410556234.349 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:34.811Z,1410556234.811 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:35.302Z,1410556235.302 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:35.850Z,1410556235.850 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:36.353Z,1410556236.353 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:36.852Z,1410556236.852 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:37.320Z,1410556237.320 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:37.453Z,1410556237.453 [Aanderaa_O2](FAULT): Timed out starting 2014-09-12T21:10:37.454Z,1410556237.454 [Aanderaa_O2] Communications Fault, FailCount= 3 2014-09-12T21:10:37.454Z,1410556237.454 [Aanderaa_O2](ERROR): Communications Fault 2014-09-12T21:10:37.802Z,1410556237.802 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:37.924Z,1410556237.924 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2014-09-12T21:10:37.925Z,1410556237.925 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2014-09-12T21:10:38.069Z,1410556238.069 [Aanderaa_O2](INFO): Powering down 2014-09-12T21:10:38.399Z,1410556238.399 [DVL_micro](ERROR): No DVL communication! Re-initializing 2014-09-12T21:10:38.399Z,1410556238.399 [DVL_micro] Communications Fault, FailCount= 3 2014-09-12T21:10:38.399Z,1410556238.399 [DVL_micro](ERROR): Communications Fault 2014-09-12T21:10:38.411Z,1410556238.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:38.517Z,1410556238.517 [CBIT](ERROR): Communications Fault in component: DVL_micro 2014-09-12T21:10:38.926Z,1410556238.926 [DVL_micro](INFO): uninitialize:Powering down 2014-09-12T21:10:38.965Z,1410556238.965 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:39.574Z,1410556239.574 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:40.104Z,1410556240.104 [DVL_micro](INFO): Initializing 2014-09-12T21:10:40.139Z,1410556240.139 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:40.211Z,1410556240.211 [CBIT](INFO): Clearing failed state for component DVL_micro 2014-09-12T21:10:40.212Z,1410556240.212 [DVL_micro] No Fault, FailCount= 3 2014-09-12T21:10:40.559Z,1410556240.559 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:40.965Z,1410556240.965 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:41.382Z,1410556241.382 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:41.811Z,1410556241.811 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:42.238Z,1410556242.238 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:42.677Z,1410556242.677 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:43.111Z,1410556243.111 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:43.521Z,1410556243.521 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:43.930Z,1410556243.930 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:44.364Z,1410556244.364 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:44.806Z,1410556244.806 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:44.863Z,1410556244.863 [CBIT](IMPORTANT): No ground fault detected 2014-09-12T21:10:45.238Z,1410556245.238 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:45.760Z,1410556245.760 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:46.221Z,1410556246.221 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:46.606Z,1410556246.606 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:47.015Z,1410556247.015 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:47.416Z,1410556247.416 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:47.836Z,1410556247.836 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:48.263Z,1410556248.263 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:48.659Z,1410556248.659 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:49.104Z,1410556249.104 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:49.474Z,1410556249.474 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:49.910Z,1410556249.910 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:50.320Z,1410556250.320 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:50.699Z,1410556250.699 [DVL_micro](ERROR): No DVL communication! Re-initializing 2014-09-12T21:10:50.699Z,1410556250.699 [DVL_micro] Communications Fault, FailCount= 4 2014-09-12T21:10:50.699Z,1410556250.699 [DVL_micro](ERROR): Communications Fault 2014-09-12T21:10:50.711Z,1410556250.711 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:50.727Z,1410556250.727 [CBIT](ERROR): Communications Fault in component: DVL_micro 2014-09-12T21:10:51.169Z,1410556251.169 [DVL_micro](INFO): uninitialize:Powering down 2014-09-12T21:10:51.192Z,1410556251.192 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:51.608Z,1410556251.608 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:51.982Z,1410556251.982 [DVL_micro](INFO): Initializing 2014-09-12T21:10:52.021Z,1410556252.021 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:52.037Z,1410556252.037 [CBIT](INFO): Clearing failed state for component DVL_micro 2014-09-12T21:10:52.037Z,1410556252.037 [DVL_micro] No Fault, FailCount= 4 2014-09-12T21:10:52.429Z,1410556252.429 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:52.814Z,1410556252.814 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:53.219Z,1410556253.219 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:53.621Z,1410556253.621 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:54.017Z,1410556254.017 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:54.430Z,1410556254.430 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:54.833Z,1410556254.833 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:55.231Z,1410556255.231 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:55.619Z,1410556255.619 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:56.016Z,1410556256.016 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:56.418Z,1410556256.418 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:56.822Z,1410556256.822 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:57.043Z,1410556257.043 [CommandLine](IMPORTANT): got command show stack 2014-09-12T21:10:57.043Z,1410556257.043 [CommandLine](IMPORTANT): Behavior Stack: 2014-09-12T21:10:57.044Z,1410556257.044 [MissionManager](IMPORTANT): Mission loaded, but not running. 2014-09-12T21:10:57.240Z,1410556257.240 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:57.658Z,1410556257.658 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:58.058Z,1410556258.058 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:58.340Z,1410556258.340 [CommandLine](IMPORTANT): got command failComponent 2014-09-12T21:10:58.341Z,1410556258.341 [CommandLine](IMPORTANT): Failed components: 2014-09-12T21:10:58.341Z,1410556258.341 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault 2014-09-12T21:10:58.437Z,1410556258.437 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:58.826Z,1410556258.826 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:59.227Z,1410556259.227 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:10:59.624Z,1410556259.624 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:00.024Z,1410556260.024 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:00.579Z,1410556260.579 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:01.436Z,1410556261.436 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:01.960Z,1410556261.960 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:02.412Z,1410556262.412 [DVL_micro](ERROR): No DVL communication! Re-initializing 2014-09-12T21:11:02.412Z,1410556262.412 [DVL_micro] Communications Fault, FailCount= 5 2014-09-12T21:11:02.412Z,1410556262.412 [DVL_micro](ERROR): Communications Fault 2014-09-12T21:11:02.470Z,1410556262.470 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:02.574Z,1410556262.574 [CBIT](ERROR): Communications Fault in component: DVL_micro 2014-09-12T21:11:02.575Z,1410556262.575 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2014-09-12T21:11:02.987Z,1410556262.987 [DVL_micro](INFO): uninitialize:Powering down 2014-09-12T21:11:03.007Z,1410556263.007 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:03.190Z,1410556263.190 [CommandLine](FAULT): Scheduling is paused 2014-09-12T21:11:03.612Z,1410556263.612 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:04.256Z,1410556264.256 [DVL_micro](INFO): Initializing 2014-09-12T21:11:04.288Z,1410556264.288 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:04.765Z,1410556264.765 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:05.209Z,1410556265.209 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:05.643Z,1410556265.643 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:06.112Z,1410556266.112 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:06.563Z,1410556266.563 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:06.993Z,1410556266.993 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:07.514Z,1410556267.514 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:07.929Z,1410556267.929 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:08.323Z,1410556268.323 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:08.729Z,1410556268.729 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:09.120Z,1410556269.120 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:09.519Z,1410556269.519 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:09.944Z,1410556269.944 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:10.338Z,1410556270.338 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:10.731Z,1410556270.731 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:11.133Z,1410556271.133 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:11.534Z,1410556271.534 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:11.938Z,1410556271.938 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:11.950Z,1410556271.950 [SBIT](IMPORTANT): SBIT PASSED 2014-09-12T21:11:12.353Z,1410556272.353 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:12.376Z,1410556272.376 [MissionManager](IMPORTANT): Started mission Startup 2014-09-12T21:11:12.376Z,1410556272.376 [Startup] Running Loop=1 2014-09-12T21:11:12.376Z,1410556272.376 [Startup](INFO): Aggregate::initialize Startup 2014-09-12T21:11:12.377Z,1410556272.377 [Startup:A.GoToSurface] Running Loop=1 2014-09-12T21:11:12.377Z,1410556272.377 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2014-09-12T21:11:12.377Z,1410556272.377 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2014-09-12T21:11:12.378Z,1410556272.378 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2014-09-12T21:11:12.378Z,1410556272.378 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s. 2014-09-12T21:11:12.384Z,1410556272.384 [Startup:StartupSatComms] Running Loop=1 2014-09-12T21:11:12.384Z,1410556272.384 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms 2014-09-12T21:11:12.384Z,1410556272.384 [Startup:StartupSatComms:A] Running Loop=1 2014-09-12T21:11:12.786Z,1410556272.786 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:12.792Z,1410556272.792 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2014-09-12T21:11:13.203Z,1410556273.203 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:13.588Z,1410556273.588 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:13.985Z,1410556273.985 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:14.385Z,1410556274.385 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:14.782Z,1410556274.782 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:15.206Z,1410556275.206 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:15.604Z,1410556275.604 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:15.892Z,1410556275.892 [CommandLine](IMPORTANT): got command show stack 2014-09-12T21:11:15.892Z,1410556275.892 [CommandLine](IMPORTANT): Behavior Stack: 2014-09-12T21:11:15.892Z,1410556275.892 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface 2014-09-12T21:11:15.892Z,1410556275.892 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A 2014-09-12T21:11:16.073Z,1410556276.073 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:16.445Z,1410556276.445 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:16.842Z,1410556276.842 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:17.246Z,1410556277.246 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:17.698Z,1410556277.698 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:18.078Z,1410556278.078 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:18.521Z,1410556278.521 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:18.922Z,1410556278.922 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:19.324Z,1410556279.324 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:19.718Z,1410556279.718 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:20.119Z,1410556280.119 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:20.483Z,1410556280.483 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:20.895Z,1410556280.895 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:21.327Z,1410556281.327 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:21.721Z,1410556281.721 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:22.099Z,1410556282.099 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:22.484Z,1410556282.484 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:22.890Z,1410556282.890 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:23.294Z,1410556283.294 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:23.695Z,1410556283.695 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:24.099Z,1410556284.099 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:24.525Z,1410556284.525 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:24.923Z,1410556284.923 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:25.299Z,1410556285.299 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:25.698Z,1410556285.698 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:26.099Z,1410556286.099 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:26.500Z,1410556286.500 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:26.895Z,1410556286.895 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:27.308Z,1410556287.308 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:27.705Z,1410556287.705 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:28.109Z,1410556288.109 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:28.526Z,1410556288.526 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:28.899Z,1410556288.899 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:29.300Z,1410556289.300 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:29.724Z,1410556289.724 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:30.089Z,1410556290.089 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:30.542Z,1410556290.542 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:30.954Z,1410556290.954 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:31.354Z,1410556291.354 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:31.789Z,1410556291.789 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:32.179Z,1410556292.179 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:32.601Z,1410556292.601 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:32.985Z,1410556292.985 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:33.430Z,1410556293.430 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:33.836Z,1410556293.836 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:34.234Z,1410556294.234 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:34.630Z,1410556294.630 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:35.030Z,1410556295.030 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:35.432Z,1410556295.432 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:35.830Z,1410556295.830 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:36.241Z,1410556296.241 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:36.645Z,1410556296.645 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:37.047Z,1410556297.047 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:37.437Z,1410556297.437 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:37.838Z,1410556297.838 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:38.239Z,1410556298.239 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:38.637Z,1410556298.637 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:39.041Z,1410556299.041 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:39.455Z,1410556299.455 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:39.888Z,1410556299.888 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:40.300Z,1410556300.300 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:40.690Z,1410556300.690 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:41.086Z,1410556301.086 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:41.492Z,1410556301.492 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:41.887Z,1410556301.887 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:42.307Z,1410556302.307 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:42.727Z,1410556302.727 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:43.105Z,1410556303.105 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:43.493Z,1410556303.493 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:43.892Z,1410556303.892 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:44.335Z,1410556304.335 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:44.727Z,1410556304.727 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:45.128Z,1410556305.128 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:45.540Z,1410556305.540 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:45.982Z,1410556305.982 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:46.376Z,1410556306.376 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:46.783Z,1410556306.783 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:47.177Z,1410556307.177 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:47.605Z,1410556307.605 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:48.027Z,1410556308.027 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:48.395Z,1410556308.395 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:48.804Z,1410556308.804 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:49.210Z,1410556309.210 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:49.595Z,1410556309.595 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:49.992Z,1410556309.992 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:50.390Z,1410556310.390 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:50.793Z,1410556310.793 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:51.204Z,1410556311.204 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:51.606Z,1410556311.606 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:52.009Z,1410556312.009 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:52.389Z,1410556312.389 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:52.789Z,1410556312.789 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:53.203Z,1410556313.203 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:53.636Z,1410556313.636 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:54.022Z,1410556314.022 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:54.404Z,1410556314.404 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:54.803Z,1410556314.803 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:55.221Z,1410556315.221 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:55.634Z,1410556315.634 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:56.011Z,1410556316.011 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:56.403Z,1410556316.403 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:56.803Z,1410556316.803 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:57.237Z,1410556317.237 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:57.623Z,1410556317.623 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:58.035Z,1410556318.035 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:58.454Z,1410556318.454 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:58.847Z,1410556318.847 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:59.242Z,1410556319.242 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:11:59.641Z,1410556319.641 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:00.088Z,1410556320.088 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:00.490Z,1410556320.490 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:00.937Z,1410556320.937 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:01.340Z,1410556321.340 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:01.741Z,1410556321.741 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:02.099Z,1410556322.099 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:02.545Z,1410556322.545 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:02.924Z,1410556322.924 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:03.343Z,1410556323.343 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:03.754Z,1410556323.754 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:04.161Z,1410556324.161 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:04.548Z,1410556324.548 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:04.948Z,1410556324.948 [CommandLine](IMPORTANT): got command show stack 2014-09-12T21:12:04.948Z,1410556324.948 [CommandLine](IMPORTANT): Behavior Stack: 2014-09-12T21:12:04.948Z,1410556324.948 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface 2014-09-12T21:12:04.949Z,1410556324.949 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A 2014-09-12T21:12:04.950Z,1410556324.950 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:05.353Z,1410556325.353 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:05.754Z,1410556325.754 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:06.154Z,1410556326.154 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:06.564Z,1410556326.564 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:06.969Z,1410556326.969 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:07.367Z,1410556327.367 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:07.763Z,1410556327.763 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:08.157Z,1410556328.157 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:08.559Z,1410556328.559 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:08.991Z,1410556328.991 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:09.393Z,1410556329.393 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:09.794Z,1410556329.794 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:10.203Z,1410556330.203 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:10.643Z,1410556330.643 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:11.005Z,1410556331.005 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:11.437Z,1410556331.437 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:11.826Z,1410556331.826 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:12.272Z,1410556332.272 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:12.695Z,1410556332.695 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:12.701Z,1410556332.701 [Startup:StartupSatComms:A](INFO): Timed out from 2014-09-12T21:11:12.4Z 2014-09-12T21:12:12.701Z,1410556332.701 [Startup:StartupSatComms:A] Stopped 2014-09-12T21:12:12.701Z,1410556332.701 [Startup:StartupSatComms:B] Running Loop=1 2014-09-12T21:12:13.122Z,1410556333.122 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:13.128Z,1410556333.128 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2014-09-12T21:12:13.837Z,1410556333.837 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:14.251Z,1410556334.251 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:14.690Z,1410556334.690 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:15.191Z,1410556335.191 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:16.112Z,1410556336.112 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:16.543Z,1410556336.543 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:16.958Z,1410556336.958 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:17.076Z,1410556337.076 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool 2014-09-12T21:12:17.356Z,1410556337.356 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:17.362Z,1410556337.362 [Startup:StartupSatComms:B] Stopped 2014-09-12T21:12:17.362Z,1410556337.362 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2014-09-12T21:12:17.363Z,1410556337.363 [Startup:StartupSatComms] Stopped 2014-09-12T21:12:17.363Z,1410556337.363 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms 2014-09-12T21:12:17.364Z,1410556337.364 [Startup](INFO): Completed Startup 2014-09-12T21:12:17.364Z,1410556337.364 [Startup] Stopped 2014-09-12T21:12:17.364Z,1410556337.364 [Startup](INFO): Aggregate::uninitialize Startup 2014-09-12T21:12:17.364Z,1410556337.364 [Startup:A.GoToSurface] Stopped 2014-09-12T21:12:17.364Z,1410556337.364 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2014-09-12T21:12:17.765Z,1410556337.765 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:17.771Z,1410556337.771 [MissionManager](IMPORTANT): Started mission Default 2014-09-12T21:12:17.771Z,1410556337.771 [Default] Running Loop=1 2014-09-12T21:12:17.771Z,1410556337.771 [Default](INFO): Aggregate::initialize Default 2014-09-12T21:12:17.771Z,1410556337.771 [Default:B.GoToSurface] Running Loop=1 2014-09-12T21:12:17.771Z,1410556337.771 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2014-09-12T21:12:17.772Z,1410556337.772 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2014-09-12T21:12:17.772Z,1410556337.772 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2014-09-12T21:12:17.772Z,1410556337.772 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s. 2014-09-12T21:12:17.772Z,1410556337.772 [Default:StartClock] Running Loop=1 2014-09-12T21:12:17.773Z,1410556337.773 [Default:StartClock](INFO): Aggregate::initialize Default:StartClock 2014-09-12T21:12:17.773Z,1410556337.773 [Default:StartClock:A] Running Loop=1 2014-09-12T21:12:17.803Z,1410556337.803 [Default:StartClock:A] Stopped 2014-09-12T21:12:17.803Z,1410556337.803 [Default:StartClock](INFO): Completed Default:StartClock 2014-09-12T21:12:17.803Z,1410556337.803 [Default:StartClock] Stopped 2014-09-12T21:12:17.803Z,1410556337.803 [Default:StartClock](INFO): Aggregate::uninitialize Default:StartClock 2014-09-12T21:12:18.223Z,1410556338.223 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:18.230Z,1410556338.230 [Default:WaitAtTheSurface] Running Loop=1 2014-09-12T21:12:18.230Z,1410556338.230 [Default:WaitAtTheSurface](INFO): Aggregate::initialize Default:WaitAtTheSurface 2014-09-12T21:12:18.231Z,1410556338.231 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1 2014-09-12T21:12:18.231Z,1410556338.231 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Initialize. 2014-09-12T21:12:18.620Z,1410556338.620 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:18.626Z,1410556338.626 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1 2014-09-12T21:12:23.702Z,1410556343.702 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:24.755Z,1410556344.755 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml 2014-09-12T21:12:24.755Z,1410556344.755 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml 2014-09-12T21:12:24.850Z,1410556344.850 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool 2014-09-12T21:12:24.853Z,1410556344.853 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg 2014-09-12T21:12:24.857Z,1410556344.857 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg 2014-09-12T21:12:24.860Z,1410556344.860 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool 2014-09-12T21:12:24.863Z,1410556344.863 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool 2014-09-12T21:12:24.866Z,1410556344.866 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool 2014-09-12T21:12:24.869Z,1410556344.869 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrent = 0 bool 2014-09-12T21:12:24.872Z,1410556344.872 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMinDepth = 2.000000 m 2014-09-12T21:12:24.876Z,1410556344.876 [MissionManager](INFO): DefineArg Science.ComputeWaterCurrentMaxDepth = 5.000000 m 2014-09-12T21:12:24.879Z,1410556344.879 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 1.000000 n/a 2014-09-12T21:12:24.883Z,1410556344.883 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 n/a 2014-09-12T21:12:24.887Z,1410556344.887 [MissionManager](INFO): DefineArg Science.EnabledRhodamine = 1.000000 n/a 2014-09-12T21:12:24.911Z,1410556344.911 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 n/a 2014-09-12T21:12:24.915Z,1410556344.915 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 n/a 2014-09-12T21:12:24.919Z,1410556344.919 [MissionManager](INFO): DefineArg Science.EnabledDVL = 1.000000 n/a 2014-09-12T21:12:24.922Z,1410556344.922 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 n/a 2014-09-12T21:12:24.938Z,1410556344.938 [MissionManager](INFO): DefineArg Science.EnabledSeeStar = 0.000000 n/a 2014-09-12T21:12:24.942Z,1410556344.942 [MissionManager](INFO): DefineArg Science.SeeStarTimeout = 2.000000 min 2014-09-12T21:12:24.957Z,1410556344.957 [MissionManager](INFO): DefineArg Science.SeeStarTriggerDepth = 40.000000 m 2014-09-12T21:12:24.961Z,1410556344.961 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l 2014-09-12T21:12:24.967Z,1410556344.967 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m 2014-09-12T21:12:24.970Z,1410556344.970 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg 2014-09-12T21:12:24.974Z,1410556344.974 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg 2014-09-12T21:12:24.990Z,1410556344.990 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l 2014-09-12T21:12:24.993Z,1410556344.993 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m 2014-09-12T21:12:25.008Z,1410556345.008 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg 2014-09-12T21:12:25.013Z,1410556345.013 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg 2014-09-12T21:12:25.067Z,1410556345.067 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2014-09-12T21:12:25.076Z,1410556345.076 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2014-09-12T21:12:25.125Z,1410556345.125 [MissionManager](DEBUG): Set either this or PeakDetectNO3Active to True in order to sample Nitrate. EnabledISUS must also be true. Maximum pitch to sample ISUS. (EnabledISUS must also be true.) 60.0 Minimum pitch to sample ISUS. (EnabledISUS must also be true.) -60.0 Turns on peak detection of Cholorphyll. Turns on peak detection of Nitrate (and turns on ISUS). Turns on seawater temperature derivative. Compute and report water current (from LinkQuest full column average) Minimum depth to compute and report water current (from LinkQuest full column average) 2.0 Maximum depth to compute and report water current (from LinkQuest full column average) 5.0 Automatically set to True if the Aanderaa O2 sensor is installed. Set to false to disable reading Aandera O2. Automatically set to true if the Neil Brown CTD is enabled. Set to false to disable reading from the Neil Brown. Automatically set to True if the rhodamine sensor is installed. Set to false to disable reading rhodamine. Automatically set to true if the NPS Turbulence sensor is enabled. Set to false to disable reading from the NPS Turbulence sensor. Automatically set to true if the the WetLabs BB2FL is enabled. Set to false to disable the WetLabs BB2FL. Automatically set to True if DVL is enabled. Set to false to disable the DVL. Automatically set to True if ISUS is enabled. Set to false to disable ISUS. Automatically set to True if SeeStar/SCPI is enabled. Set false to override. Timeout to trigger/read trigger for SeeStar camera. 2 Trigger the camera above this depth. 40.0 0 0 NaN NaN 0 0 NaN NaN Turn on the SeeStar/SCPI camera. (SCPI.sampleTime is set in Sensor.cfg) TODO: migrate to science 2014-09-12T21:12:25.763Z,1410556345.763 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml 2014-09-12T21:12:28.299Z,1410556348.299 [CommandLine](IMPORTANT): got command report 2014-09-12T21:12:28.299Z,1410556348.299 [Reporter](INFO): rhodamine.voltage reporting when touched 2014-09-12T21:12:28.768Z,1410556348.768 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:28.783Z,1410556348.783 [Default] Stopped 2014-09-12T21:12:28.783Z,1410556348.783 [Default](INFO): Aggregate::uninitialize Default 2014-09-12T21:12:28.783Z,1410556348.783 [Default:B.GoToSurface] Stopped 2014-09-12T21:12:28.783Z,1410556348.783 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2014-09-12T21:12:28.784Z,1410556348.784 [Default:WaitAtTheSurface] Stopped 2014-09-12T21:12:28.784Z,1410556348.784 [Default:WaitAtTheSurface](INFO): Aggregate::uninitialize Default:WaitAtTheSurface 2014-09-12T21:12:28.784Z,1410556348.784 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Stopped 2014-09-12T21:12:28.784Z,1410556348.784 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Uninitialize. 2014-09-12T21:12:28.784Z,1410556348.784 [MissionManager](IMPORTANT): Started mission Science 2014-09-12T21:12:28.784Z,1410556348.784 [Science] Running Loop=1 2014-09-12T21:12:28.784Z,1410556348.784 [Science](INFO): Aggregate::initialize Science 2014-09-12T21:12:28.784Z,1410556348.784 [Science:A] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:B] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:C] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:D] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:E] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:F] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:G] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:H] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:PeakDetectChl] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:PeakDetectChl](INFO): Aggregate::initialize Science:PeakDetectChl 2014-09-12T21:12:28.785Z,1410556348.785 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2014-09-12T21:12:28.785Z,1410556348.785 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2014-09-12T21:12:28.787Z,1410556348.787 [Science:PeakDetectNO3] Running Loop=1 2014-09-12T21:12:28.787Z,1410556348.787 [Science:PeakDetectNO3](INFO): Aggregate::initialize Science:PeakDetectNO3 2014-09-12T21:12:28.787Z,1410556348.787 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2014-09-12T21:12:28.787Z,1410556348.787 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2014-09-12T21:12:28.790Z,1410556348.790 [Science:PeakDetectNO3] Stopped 2014-09-12T21:12:28.790Z,1410556348.790 [Science:PeakDetectNO3](INFO): Aggregate::uninitialize Science:PeakDetectNO3 2014-09-12T21:12:28.790Z,1410556348.790 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2014-09-12T21:12:28.791Z,1410556348.791 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2014-09-12T21:12:28.791Z,1410556348.791 [Science:PeakDetectChl] Stopped 2014-09-12T21:12:28.791Z,1410556348.791 [Science:PeakDetectChl](INFO): Aggregate::uninitialize Science:PeakDetectChl 2014-09-12T21:12:28.791Z,1410556348.791 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2014-09-12T21:12:28.791Z,1410556348.791 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2014-09-12T21:12:28.791Z,1410556348.791 [Science:H] Running Loop=1 2014-09-12T21:12:28.792Z,1410556348.792 [Science:H](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2014-09-12T21:12:28.793Z,1410556348.793 [Science:G] Stopped 2014-09-12T21:12:28.794Z,1410556348.794 [Science:F] Stopped 2014-09-12T21:12:28.794Z,1410556348.794 [Science:E] Running Loop=1 2014-09-12T21:12:28.794Z,1410556348.794 [Science:E](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2014-09-12T21:12:28.795Z,1410556348.795 [Science:E](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2014-09-12T21:12:28.797Z,1410556348.797 [Science:D] Stopped 2014-09-12T21:12:28.797Z,1410556348.797 [Science:C] Stopped 2014-09-12T21:12:28.797Z,1410556348.797 [Science:B] Running Loop=1 2014-09-12T21:12:28.797Z,1410556348.797 [Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_rhodamine 2014-09-12T21:12:28.798Z,1410556348.798 [Science:B](DEBUG): Initialize ReadDataComponent to sense rhodamine.voltage 2014-09-12T21:12:28.800Z,1410556348.800 [Science:A] Running Loop=1 2014-09-12T21:12:28.801Z,1410556348.801 [Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water 2014-09-12T21:12:28.869Z,1410556348.869 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4 2014-09-12T21:12:28.869Z,1410556348.869 [WetLabsBB2FL](INFO): Powering up 2014-09-12T21:12:29.023Z,1410556349.023 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4 2014-09-12T21:12:29.191Z,1410556349.191 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:29.636Z,1410556349.636 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:30.050Z,1410556350.050 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:30.067Z,1410556350.067 [Reporter](INFO): rhodamine.voltage 1608.536124 mV 2014-09-12T21:12:30.472Z,1410556350.472 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:30.502Z,1410556350.502 [Reporter](INFO): rhodamine.voltage 13105.138779 mV 2014-09-12T21:12:30.890Z,1410556350.890 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:30.907Z,1410556350.907 [Reporter](INFO): rhodamine.voltage 26812.187195 mV 2014-09-12T21:12:31.294Z,1410556351.294 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:31.312Z,1410556351.312 [Reporter](INFO): rhodamine.voltage 33331.714630 mV 2014-09-12T21:12:31.688Z,1410556351.688 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:31.705Z,1410556351.705 [Reporter](INFO): rhodamine.voltage 36363.922119 mV 2014-09-12T21:12:32.098Z,1410556352.098 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:32.116Z,1410556352.116 [Reporter](INFO): rhodamine.voltage 37665.584564 mV 2014-09-12T21:12:32.518Z,1410556352.518 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:32.556Z,1410556352.556 [Reporter](INFO): rhodamine.voltage 38268.978119 mV 2014-09-12T21:12:32.922Z,1410556352.922 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:32.954Z,1410556352.954 [Reporter](INFO): rhodamine.voltage 38470.901489 mV 2014-09-12T21:12:33.348Z,1410556353.348 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:33.365Z,1410556353.365 [Reporter](INFO): rhodamine.voltage 38500.942230 mV 2014-09-12T21:12:33.741Z,1410556353.741 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:33.759Z,1410556353.759 [Reporter](INFO): rhodamine.voltage 38528.831482 mV 2014-09-12T21:12:34.133Z,1410556354.133 [WetLabsBB2FL] Communications Fault, FailCount= 1 2014-09-12T21:12:34.133Z,1410556354.133 [WetLabsBB2FL](ERROR): Communications Fault 2014-09-12T21:12:34.147Z,1410556354.147 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:34.162Z,1410556354.162 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2014-09-12T21:12:34.163Z,1410556354.163 [Reporter](INFO): rhodamine.voltage 38619.186401 mV 2014-09-12T21:12:34.548Z,1410556354.548 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:34.566Z,1410556354.566 [Reporter](INFO): rhodamine.voltage 38606.075287 mV 2014-09-12T21:12:34.632Z,1410556354.632 [WetLabsBB2FL](INFO): Powering down 2014-09-12T21:12:34.944Z,1410556354.944 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:34.961Z,1410556354.961 [Reporter](INFO): rhodamine.voltage 38643.981934 mV 2014-09-12T21:12:35.340Z,1410556355.340 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:35.358Z,1410556355.358 [Reporter](INFO): rhodamine.voltage 38663.288116 mV 2014-09-12T21:12:35.739Z,1410556355.739 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:35.757Z,1410556355.757 [Reporter](INFO): rhodamine.voltage 38558.151245 mV 2014-09-12T21:12:36.152Z,1410556356.152 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:36.168Z,1410556356.168 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2014-09-12T21:12:36.168Z,1410556356.168 [WetLabsBB2FL] No Fault, FailCount= 1 2014-09-12T21:12:36.170Z,1410556356.170 [Reporter](INFO): rhodamine.voltage 38414.402008 mV 2014-09-12T21:12:36.237Z,1410556356.237 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4 2014-09-12T21:12:36.238Z,1410556356.238 [WetLabsBB2FL](INFO): Powering up 2014-09-12T21:12:36.546Z,1410556356.546 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:36.562Z,1410556356.562 [Reporter](INFO): rhodamine.voltage 38404.861450 mV 2014-09-12T21:12:36.946Z,1410556356.946 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:36.963Z,1410556356.963 [Reporter](INFO): rhodamine.voltage 38448.493958 mV 2014-09-12T21:12:37.348Z,1410556357.348 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:37.365Z,1410556357.365 [Reporter](INFO): rhodamine.voltage 38587.478638 mV 2014-09-12T21:12:37.747Z,1410556357.747 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:37.764Z,1410556357.764 [Reporter](INFO): rhodamine.voltage 38522.636414 mV 2014-09-12T21:12:38.156Z,1410556358.156 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:38.174Z,1410556358.174 [Reporter](INFO): rhodamine.voltage 38562.206268 mV 2014-09-12T21:12:38.566Z,1410556358.566 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:38.604Z,1410556358.604 [Reporter](INFO): rhodamine.voltage 38452.064514 mV 2014-09-12T21:12:38.974Z,1410556358.974 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:39.008Z,1410556359.008 [Reporter](INFO): rhodamine.voltage 38523.586273 mV 2014-09-12T21:12:39.381Z,1410556359.381 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:39.422Z,1410556359.422 [Reporter](INFO): rhodamine.voltage 38549.575806 mV 2014-09-12T21:12:39.796Z,1410556359.796 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:39.813Z,1410556359.813 [Reporter](INFO): rhodamine.voltage 38526.687622 mV 2014-09-12T21:12:40.202Z,1410556360.202 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:40.219Z,1410556360.219 [Reporter](INFO): rhodamine.voltage 38622.760773 mV 2014-09-12T21:12:40.604Z,1410556360.604 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:40.621Z,1410556360.621 [Reporter](INFO): rhodamine.voltage 38628.479004 mV 2014-09-12T21:12:41.005Z,1410556361.005 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:41.022Z,1410556361.022 [Reporter](INFO): rhodamine.voltage 38492.359161 mV 2014-09-12T21:12:41.454Z,1410556361.454 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:41.470Z,1410556361.470 [Reporter](INFO): rhodamine.voltage 38516.674042 mV 2014-09-12T21:12:41.516Z,1410556361.516 [WetLabsBB2FL] Communications Fault, FailCount= 2 2014-09-12T21:12:41.516Z,1410556361.516 [WetLabsBB2FL](ERROR): Communications Fault 2014-09-12T21:12:41.864Z,1410556361.864 [BPC1](ERROR): A bank expecting battery number:1 and read number:0 2014-09-12T21:12:41.864Z,1410556361.864 [BPC1](FAULT): Failed to parse bank A battery data 2014-09-12T21:12:41.864Z,1410556361.864 [BPC1] Data Fault, FailCount= 1 2014-09-12T21:12:41.864Z,1410556361.864 [BPC1](ERROR): Data Fault 2014-09-12T21:12:41.871Z,1410556361.871 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:41.919Z,1410556361.919 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2014-09-12T21:12:41.919Z,1410556361.919 [CBIT](ERROR): Data Fault in component: BPC1 2014-09-12T21:12:41.920Z,1410556361.920 [Reporter](INFO): rhodamine.voltage 38442.054749 mV 2014-09-12T21:12:42.017Z,1410556362.017 [WetLabsBB2FL](INFO): Powering down 2014-09-12T21:12:42.306Z,1410556362.306 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:42.323Z,1410556362.323 [Reporter](INFO): rhodamine.voltage 38513.336182 mV 2014-09-12T21:12:42.702Z,1410556362.702 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:42.718Z,1410556362.718 [Reporter](INFO): rhodamine.voltage 38538.848877 mV 2014-09-12T21:12:43.098Z,1410556363.098 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:43.114Z,1410556363.114 [CBIT](INFO): Clearing failed state for component BPC1 2014-09-12T21:12:43.114Z,1410556363.114 [BPC1] No Fault, FailCount= 1 2014-09-12T21:12:43.116Z,1410556363.116 [Reporter](INFO): rhodamine.voltage 38520.248413 mV 2014-09-12T21:12:43.552Z,1410556363.552 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:43.567Z,1410556363.567 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2014-09-12T21:12:43.568Z,1410556363.568 [WetLabsBB2FL] No Fault, FailCount= 2 2014-09-12T21:12:43.569Z,1410556363.569 [Reporter](INFO): rhodamine.voltage 38623.001099 mV 2014-09-12T21:12:43.625Z,1410556363.625 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4 2014-09-12T21:12:43.625Z,1410556363.625 [WetLabsBB2FL](INFO): Powering up 2014-09-12T21:12:43.973Z,1410556363.973 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:44.005Z,1410556364.005 [Reporter](INFO): rhodamine.voltage 38534.072876 mV 2014-09-12T21:12:44.384Z,1410556364.384 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:44.418Z,1410556364.418 [Reporter](INFO): rhodamine.voltage 38468.280792 mV 2014-09-12T21:12:44.799Z,1410556364.799 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:44.816Z,1410556364.816 [Reporter](INFO): rhodamine.voltage 38453.735352 mV 2014-09-12T21:12:45.199Z,1410556365.199 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:45.216Z,1410556365.216 [Reporter](INFO): rhodamine.voltage 38489.494324 mV 2014-09-12T21:12:45.601Z,1410556365.601 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:45.618Z,1410556365.618 [Reporter](INFO): rhodamine.voltage 38395.565033 mV 2014-09-12T21:12:45.970Z,1410556365.970 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:45.997Z,1410556365.997 [Reporter](INFO): rhodamine.voltage 38456.359863 mV 2014-09-12T21:12:46.377Z,1410556366.377 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:46.413Z,1410556366.413 [Reporter](INFO): rhodamine.voltage 38537.174225 mV 2014-09-12T21:12:46.780Z,1410556366.780 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:46.814Z,1410556366.814 [Reporter](INFO): rhodamine.voltage 38638.732910 mV 2014-09-12T21:12:47.200Z,1410556367.200 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:47.218Z,1410556367.218 [Reporter](INFO): rhodamine.voltage 38641.120911 mV 2014-09-12T21:12:47.616Z,1410556367.616 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:47.632Z,1410556367.632 [Reporter](INFO): rhodamine.voltage 38466.133118 mV 2014-09-12T21:12:48.016Z,1410556368.016 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:48.033Z,1410556368.033 [Reporter](INFO): rhodamine.voltage 38443.485260 mV 2014-09-12T21:12:48.411Z,1410556368.411 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:48.428Z,1410556368.428 [Reporter](INFO): rhodamine.voltage 38489.734650 mV 2014-09-12T21:12:48.811Z,1410556368.811 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:48.828Z,1410556368.828 [Reporter](INFO): rhodamine.voltage 38503.322601 mV 2014-09-12T21:12:48.904Z,1410556368.904 [WetLabsBB2FL] Communications Fault, FailCount= 3 2014-09-12T21:12:48.904Z,1410556368.904 [WetLabsBB2FL](ERROR): Communications Fault 2014-09-12T21:12:49.222Z,1410556369.222 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:49.237Z,1410556369.237 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2014-09-12T21:12:49.239Z,1410556369.239 [Reporter](INFO): rhodamine.voltage 38502.845764 mV 2014-09-12T21:12:49.405Z,1410556369.405 [WetLabsBB2FL](INFO): Powering down 2014-09-12T21:12:49.632Z,1410556369.632 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:49.668Z,1410556369.668 [Reporter](INFO): rhodamine.voltage 38501.178741 mV 2014-09-12T21:12:50.037Z,1410556370.037 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:50.073Z,1410556370.073 [Reporter](INFO): rhodamine.voltage 38574.127197 mV 2014-09-12T21:12:50.425Z,1410556370.425 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:50.441Z,1410556370.441 [Reporter](INFO): rhodamine.voltage 38654.708862 mV 2014-09-12T21:12:50.823Z,1410556370.823 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:50.839Z,1410556370.839 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2014-09-12T21:12:50.839Z,1410556370.839 [WetLabsBB2FL] No Fault, FailCount= 3 2014-09-12T21:12:50.840Z,1410556370.840 [Reporter](INFO): rhodamine.voltage 38508.808136 mV 2014-09-12T21:12:51.017Z,1410556371.017 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4 2014-09-12T21:12:51.017Z,1410556371.017 [WetLabsBB2FL](INFO): Powering up 2014-09-12T21:12:51.231Z,1410556371.231 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:51.269Z,1410556371.269 [Reporter](INFO): rhodamine.voltage 38222.965240 mV 2014-09-12T21:12:51.625Z,1410556371.625 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:51.642Z,1410556371.642 [Reporter](INFO): rhodamine.voltage 37999.584198 mV 2014-09-12T21:12:52.029Z,1410556372.029 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:52.047Z,1410556372.047 [Reporter](INFO): rhodamine.voltage 38001.731873 mV 2014-09-12T21:12:52.439Z,1410556372.439 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:52.476Z,1410556372.476 [Reporter](INFO): rhodamine.voltage 37921.867371 mV 2014-09-12T21:12:52.849Z,1410556372.849 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:52.881Z,1410556372.881 [Reporter](INFO): rhodamine.voltage 37852.729797 mV 2014-09-12T21:12:53.266Z,1410556373.266 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:53.283Z,1410556373.283 [Reporter](INFO): rhodamine.voltage 37977.176666 mV 2014-09-12T21:12:53.644Z,1410556373.644 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:53.679Z,1410556373.679 [Reporter](INFO): rhodamine.voltage 38175.285339 mV 2014-09-12T21:12:54.066Z,1410556374.066 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:54.083Z,1410556374.083 [Reporter](INFO): rhodamine.voltage 38181.961060 mV 2014-09-12T21:12:54.430Z,1410556374.430 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:54.448Z,1410556374.448 [Reporter](INFO): rhodamine.voltage 38304.260254 mV 2014-09-12T21:12:54.841Z,1410556374.841 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:54.877Z,1410556374.877 [Reporter](INFO): rhodamine.voltage 38310.455322 mV 2014-09-12T21:12:55.265Z,1410556375.265 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:55.281Z,1410556375.281 [Reporter](INFO): rhodamine.voltage 38176.475525 mV 2014-09-12T21:12:55.665Z,1410556375.665 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:55.683Z,1410556375.683 [Reporter](INFO): rhodamine.voltage 38206.275940 mV 2014-09-12T21:12:56.123Z,1410556376.123 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:56.158Z,1410556376.158 [Reporter](INFO): rhodamine.voltage 38160.266876 mV 2014-09-12T21:12:56.307Z,1410556376.307 [WetLabsBB2FL] Communications Fault, FailCount= 4 2014-09-12T21:12:56.307Z,1410556376.307 [WetLabsBB2FL](ERROR): Communications Fault 2014-09-12T21:12:56.520Z,1410556376.520 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:56.535Z,1410556376.535 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2014-09-12T21:12:56.536Z,1410556376.536 [Reporter](INFO): rhodamine.voltage 38312.839508 mV 2014-09-12T21:12:56.809Z,1410556376.809 [WetLabsBB2FL](INFO): Powering down 2014-09-12T21:12:56.970Z,1410556376.970 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:56.987Z,1410556376.987 [Reporter](INFO): rhodamine.voltage 38185.058594 mV 2014-09-12T21:12:57.341Z,1410556377.341 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:57.380Z,1410556377.380 [Reporter](INFO): rhodamine.voltage 38037.731171 mV 2014-09-12T21:12:57.768Z,1410556377.768 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:57.784Z,1410556377.784 [Reporter](INFO): rhodamine.voltage 37919.246674 mV 2014-09-12T21:12:58.170Z,1410556378.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:58.186Z,1410556378.186 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2014-09-12T21:12:58.186Z,1410556378.186 [WetLabsBB2FL] No Fault, FailCount= 4 2014-09-12T21:12:58.188Z,1410556378.188 [Reporter](INFO): rhodamine.voltage 37802.906036 mV 2014-09-12T21:12:58.416Z,1410556378.416 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4 2014-09-12T21:12:58.416Z,1410556378.416 [WetLabsBB2FL](INFO): Powering up 2014-09-12T21:12:58.568Z,1410556378.568 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:58.585Z,1410556378.585 [Reporter](INFO): rhodamine.voltage 37594.303131 mV 2014-09-12T21:12:58.978Z,1410556378.978 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:58.994Z,1410556378.994 [Reporter](INFO): rhodamine.voltage 37664.871216 mV 2014-09-12T21:12:59.375Z,1410556379.375 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:59.392Z,1410556379.392 [Reporter](INFO): rhodamine.voltage 37652.950287 mV 2014-09-12T21:12:59.772Z,1410556379.772 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:12:59.788Z,1410556379.788 [Reporter](INFO): rhodamine.voltage 37609.561920 mV 2014-09-12T21:13:00.174Z,1410556380.174 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:00.191Z,1410556380.191 [Reporter](INFO): rhodamine.voltage 37588.104248 mV 2014-09-12T21:13:00.576Z,1410556380.576 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:00.593Z,1410556380.593 [Reporter](INFO): rhodamine.voltage 37631.019592 mV 2014-09-12T21:13:00.975Z,1410556380.975 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:00.992Z,1410556380.992 [Reporter](INFO): rhodamine.voltage 37724.231720 mV 2014-09-12T21:13:01.385Z,1410556381.385 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:01.402Z,1410556381.402 [Reporter](INFO): rhodamine.voltage 37701.343536 mV 2014-09-12T21:13:01.803Z,1410556381.803 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:01.836Z,1410556381.836 [Reporter](INFO): rhodamine.voltage 37724.948883 mV 2014-09-12T21:13:02.202Z,1410556382.202 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:02.235Z,1410556382.235 [Reporter](INFO): rhodamine.voltage 37616.714478 mV 2014-09-12T21:13:02.593Z,1410556382.593 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:02.631Z,1410556382.631 [Reporter](INFO): rhodamine.voltage 37657.241821 mV 2014-09-12T21:13:02.998Z,1410556382.998 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:03.034Z,1410556383.034 [Reporter](INFO): rhodamine.voltage 37648.181915 mV 2014-09-12T21:13:03.387Z,1410556383.387 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:03.404Z,1410556383.404 [Reporter](INFO): rhodamine.voltage 37687.282562 mV 2014-09-12T21:13:03.719Z,1410556383.719 [WetLabsBB2FL] Communications Fault, FailCount= 5 2014-09-12T21:13:03.719Z,1410556383.719 [WetLabsBB2FL](ERROR): Communications Fault 2014-09-12T21:13:03.786Z,1410556383.786 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:03.802Z,1410556383.802 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2014-09-12T21:13:03.802Z,1410556383.802 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2014-09-12T21:13:03.824Z,1410556383.824 [Reporter](INFO): rhodamine.voltage 37591.442108 mV 2014-09-12T21:13:04.220Z,1410556384.220 [WetLabsBB2FL](INFO): Powering down 2014-09-12T21:13:04.224Z,1410556384.224 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:04.242Z,1410556384.242 [Reporter](INFO): rhodamine.voltage 37356.857300 mV 2014-09-12T21:13:04.598Z,1410556384.598 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:04.638Z,1410556384.638 [Reporter](INFO): rhodamine.voltage 37265.552521 mV 2014-09-12T21:13:05.008Z,1410556385.008 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:05.037Z,1410556385.037 [Reporter](INFO): rhodamine.voltage 37104.389191 mV 2014-09-12T21:13:05.428Z,1410556385.428 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:05.446Z,1410556385.446 [Reporter](INFO): rhodamine.voltage 36989.006042 mV 2014-09-12T21:13:05.794Z,1410556385.794 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:05.812Z,1410556385.812 [Reporter](INFO): rhodamine.voltage 36983.047485 mV 2014-09-12T21:13:06.213Z,1410556386.213 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:06.250Z,1410556386.250 [Reporter](INFO): rhodamine.voltage 36945.140839 mV 2014-09-12T21:13:06.633Z,1410556386.633 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:06.651Z,1410556386.651 [Reporter](INFO): rhodamine.voltage 36718.185425 mV 2014-09-12T21:13:07.040Z,1410556387.040 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:07.058Z,1410556387.058 [Reporter](INFO): rhodamine.voltage 36625.205994 mV 2014-09-12T21:13:07.442Z,1410556387.442 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:07.457Z,1410556387.457 [CBIT](INFO): Clearing failed count for component Aanderaa_O2 2014-09-12T21:13:07.457Z,1410556387.457 [Aanderaa_O2] No Fault, FailCount= 3 2014-09-12T21:13:07.459Z,1410556387.459 [Reporter](INFO): rhodamine.voltage 36621.627808 mV 2014-09-12T21:13:07.861Z,1410556387.861 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:07.899Z,1410556387.899 [Reporter](INFO): rhodamine.voltage 36640.941620 mV 2014-09-12T21:13:08.262Z,1410556388.262 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:08.298Z,1410556388.298 [Reporter](INFO): rhodamine.voltage 39023.513794 mV 2014-09-12T21:13:08.651Z,1410556388.651 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:08.692Z,1410556388.692 [Reporter](INFO): rhodamine.voltage 29339.225769 mV 2014-09-12T21:13:09.060Z,1410556389.060 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:09.097Z,1410556389.097 [Reporter](INFO): rhodamine.voltage 15459.340096 mV 2014-09-12T21:13:09.467Z,1410556389.467 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:09.499Z,1410556389.499 [Reporter](INFO): rhodamine.voltage 7703.232288 mV 2014-09-12T21:13:09.901Z,1410556389.901 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:09.937Z,1410556389.937 [Reporter](INFO): rhodamine.voltage 4301.025867 mV 2014-09-12T21:13:10.317Z,1410556390.317 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:10.349Z,1410556390.349 [Reporter](INFO): rhodamine.voltage 2766.206503 mV 2014-09-12T21:13:10.741Z,1410556390.741 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:10.758Z,1410556390.758 [Reporter](INFO): rhodamine.voltage 1902.483225 mV 2014-09-12T21:13:11.110Z,1410556391.110 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:11.126Z,1410556391.126 [Reporter](INFO): rhodamine.voltage 1619.740963 mV 2014-09-12T21:13:11.543Z,1410556391.543 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:11.560Z,1410556391.560 [Reporter](INFO): rhodamine.voltage 1640.004992 mV 2014-09-12T21:13:11.923Z,1410556391.923 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:11.940Z,1410556391.940 [Reporter](INFO): rhodamine.voltage 1537.969708 mV 2014-09-12T21:13:12.341Z,1410556392.341 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:12.357Z,1410556392.357 [Reporter](INFO): rhodamine.voltage 1506.500959 mV 2014-09-12T21:13:12.765Z,1410556392.765 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:12.783Z,1410556392.783 [Reporter](INFO): rhodamine.voltage 1539.161801 mV 2014-09-12T21:13:13.147Z,1410556393.147 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:13.164Z,1410556393.164 [Reporter](INFO): rhodamine.voltage 1576.590419 mV 2014-09-12T21:13:13.575Z,1410556393.575 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:13.613Z,1410556393.613 [Reporter](INFO): rhodamine.voltage 1603.052974 mV 2014-09-12T21:13:13.967Z,1410556393.967 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:13.985Z,1410556393.985 [Reporter](INFO): rhodamine.voltage 1688.638687 mV 2014-09-12T21:13:14.364Z,1410556394.364 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:14.381Z,1410556394.381 [Reporter](INFO): rhodamine.voltage 1526.526570 mV 2014-09-12T21:13:14.783Z,1410556394.783 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:14.818Z,1410556394.818 [Reporter](INFO): rhodamine.voltage 1795.918584 mV 2014-09-12T21:13:15.196Z,1410556395.196 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:15.232Z,1410556395.232 [Reporter](INFO): rhodamine.voltage 4820.976257 mV 2014-09-12T21:13:15.596Z,1410556395.596 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:15.630Z,1410556395.630 [Reporter](INFO): rhodamine.voltage 8066.077232 mV 2014-09-12T21:13:16.021Z,1410556396.021 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:16.037Z,1410556396.037 [Reporter](INFO): rhodamine.voltage 8858.757019 mV 2014-09-12T21:13:16.417Z,1410556396.417 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:16.433Z,1410556396.433 [Reporter](INFO): rhodamine.voltage 8677.334785 mV 2014-09-12T21:13:16.816Z,1410556396.816 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:16.832Z,1410556396.832 [Reporter](INFO): rhodamine.voltage 8746.470451 mV 2014-09-12T21:13:17.230Z,1410556397.230 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:17.246Z,1410556397.246 [Reporter](INFO): rhodamine.voltage 18690.374374 mV 2014-09-12T21:13:17.648Z,1410556397.648 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:17.684Z,1410556397.684 [Reporter](INFO): rhodamine.voltage 75499.427795 mV 2014-09-12T21:13:17.723Z,1410556397.723 [Aanderaa_O2](FAULT): Timed out starting 2014-09-12T21:13:17.723Z,1410556397.723 [Aanderaa_O2] Communications Fault, FailCount= 1 2014-09-12T21:13:17.723Z,1410556397.723 [Aanderaa_O2](ERROR): Communications Fault 2014-09-12T21:13:18.080Z,1410556398.080 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:18.095Z,1410556398.095 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2014-09-12T21:13:18.097Z,1410556398.097 [Reporter](INFO): rhodamine.voltage 151335.678101 mV 2014-09-12T21:13:18.254Z,1410556398.254 [Aanderaa_O2](INFO): Powering down 2014-09-12T21:13:18.594Z,1410556398.594 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:18.628Z,1410556398.628 [Reporter](INFO): rhodamine.voltage 191052.383423 mV 2014-09-12T21:13:18.986Z,1410556398.986 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:19.023Z,1410556399.023 [Reporter](INFO): rhodamine.voltage 117097.602844 mV 2014-09-12T21:13:19.385Z,1410556399.385 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:19.423Z,1410556399.423 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2014-09-12T21:13:19.423Z,1410556399.423 [Aanderaa_O2] No Fault, FailCount= 1 2014-09-12T21:13:19.425Z,1410556399.425 [Reporter](INFO): rhodamine.voltage 59207.881927 mV 2014-09-12T21:13:19.783Z,1410556399.783 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:19.820Z,1410556399.820 [Reporter](INFO): rhodamine.voltage 27913.831711 mV 2014-09-12T21:13:20.220Z,1410556400.220 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:20.237Z,1410556400.237 [Reporter](INFO): rhodamine.voltage 13685.881615 mV 2014-09-12T21:13:20.631Z,1410556400.631 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:20.648Z,1410556400.648 [Reporter](INFO): rhodamine.voltage 7643.155098 mV 2014-09-12T21:13:21.045Z,1410556401.045 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:21.080Z,1410556401.080 [Reporter](INFO): rhodamine.voltage 5750.259399 mV 2014-09-12T21:13:21.427Z,1410556401.427 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:21.444Z,1410556401.444 [Reporter](INFO): rhodamine.voltage 4883.675098 mV 2014-09-12T21:13:21.831Z,1410556401.831 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:21.847Z,1410556401.847 [Reporter](INFO): rhodamine.voltage 4064.056396 mV 2014-09-12T21:13:22.232Z,1410556402.232 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:22.249Z,1410556402.249 [Reporter](INFO): rhodamine.voltage 2885.883331 mV 2014-09-12T21:13:22.634Z,1410556402.634 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:22.672Z,1410556402.672 [Reporter](INFO): rhodamine.voltage 2182.603598 mV 2014-09-12T21:13:23.033Z,1410556403.033 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:23.073Z,1410556403.073 [Reporter](INFO): rhodamine.voltage 1854.564905 mV 2014-09-12T21:13:23.464Z,1410556403.464 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:23.482Z,1410556403.482 [Reporter](INFO): rhodamine.voltage 1561.571360 mV 2014-09-12T21:13:23.842Z,1410556403.842 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:23.883Z,1410556403.883 [Reporter](INFO): rhodamine.voltage 1592.563391 mV 2014-09-12T21:13:24.269Z,1410556404.269 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:24.287Z,1410556404.287 [Reporter](INFO): rhodamine.voltage 1588.033795 mV 2014-09-12T21:13:24.644Z,1410556404.644 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:24.683Z,1410556404.683 [Reporter](INFO): rhodamine.voltage 1478.131294 mV 2014-09-12T21:13:25.101Z,1410556405.101 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:25.128Z,1410556405.128 [Reporter](INFO): rhodamine.voltage 1439.272046 mV 2014-09-12T21:13:25.484Z,1410556405.484 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:25.500Z,1410556405.500 [Reporter](INFO): rhodamine.voltage 1474.793673 mV 2014-09-12T21:13:25.920Z,1410556405.920 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:25.936Z,1410556405.936 [Reporter](INFO): rhodamine.voltage 1588.033795 mV 2014-09-12T21:13:26.320Z,1410556406.320 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:26.337Z,1410556406.337 [Reporter](INFO): rhodamine.voltage 1652.163506 mV 2014-09-12T21:13:26.743Z,1410556406.743 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:26.774Z,1410556406.774 [Reporter](INFO): rhodamine.voltage 1570.630670 mV 2014-09-12T21:13:27.170Z,1410556407.170 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:27.188Z,1410556407.188 [Reporter](INFO): rhodamine.voltage 1565.147281 mV 2014-09-12T21:13:27.548Z,1410556407.548 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:27.585Z,1410556407.585 [Reporter](INFO): rhodamine.voltage 1458.820939 mV 2014-09-12T21:13:27.949Z,1410556407.949 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:27.985Z,1410556407.985 [Reporter](INFO): rhodamine.voltage 1538.208127 mV 2014-09-12T21:13:28.367Z,1410556408.367 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:28.384Z,1410556408.384 [Reporter](INFO): rhodamine.voltage 1647.872090 mV 2014-09-12T21:13:28.730Z,1410556408.730 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:28.747Z,1410556408.747 [Reporter](INFO): rhodamine.voltage 1766.356945 mV 2014-09-12T21:13:29.169Z,1410556409.169 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:29.187Z,1410556409.187 [Reporter](INFO): rhodamine.voltage 1837.400198 mV 2014-09-12T21:13:29.569Z,1410556409.569 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:29.586Z,1410556409.586 [Reporter](INFO): rhodamine.voltage 1751.337767 mV 2014-09-12T21:13:29.624Z,1410556409.624 [Aanderaa_O2](FAULT): Timed out starting 2014-09-12T21:13:29.624Z,1410556409.624 [Aanderaa_O2] Communications Fault, FailCount= 2 2014-09-12T21:13:29.625Z,1410556409.625 [Aanderaa_O2](ERROR): Communications Fault 2014-09-12T21:13:29.975Z,1410556409.975 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:29.991Z,1410556409.991 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2014-09-12T21:13:29.993Z,1410556409.993 [Reporter](INFO): rhodamine.voltage 1669.089794 mV 2014-09-12T21:13:30.140Z,1410556410.140 [Aanderaa_O2](INFO): Powering down 2014-09-12T21:13:30.486Z,1410556410.486 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:30.502Z,1410556410.502 [Reporter](INFO): rhodamine.voltage 1697.459340 mV 2014-09-12T21:13:30.888Z,1410556410.888 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:30.922Z,1410556410.922 [Reporter](INFO): rhodamine.voltage 1632.376194 mV 2014-09-12T21:13:31.296Z,1410556411.296 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:31.333Z,1410556411.333 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2014-09-12T21:13:31.334Z,1410556411.334 [Aanderaa_O2] No Fault, FailCount= 2 2014-09-12T21:13:31.335Z,1410556411.335 [Reporter](INFO): rhodamine.voltage 1572.299361 mV 2014-09-12T21:13:31.720Z,1410556411.720 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:31.736Z,1410556411.736 [Reporter](INFO): rhodamine.voltage 1810.460925 mV 2014-09-12T21:13:32.135Z,1410556412.135 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:32.152Z,1410556412.152 [Reporter](INFO): rhodamine.voltage 1725.590706 mV 2014-09-12T21:13:32.531Z,1410556412.531 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:32.548Z,1410556412.548 [Reporter](INFO): rhodamine.voltage 1761.827350 mV 2014-09-12T21:13:32.936Z,1410556412.936 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:32.953Z,1410556412.953 [Reporter](INFO): rhodamine.voltage 1922.032118 mV 2014-09-12T21:13:33.337Z,1410556413.337 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:33.354Z,1410556413.354 [Reporter](INFO): rhodamine.voltage 2348.529816 mV 2014-09-12T21:13:33.734Z,1410556413.734 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:33.751Z,1410556413.751 [Reporter](INFO): rhodamine.voltage 2622.451305 mV 2014-09-12T21:13:34.135Z,1410556414.135 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:34.151Z,1410556414.151 [Reporter](INFO): rhodamine.voltage 2802.920103 mV 2014-09-12T21:13:34.558Z,1410556414.558 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:34.604Z,1410556414.604 [Reporter](INFO): rhodamine.voltage 2831.766844 mV 2014-09-12T21:13:34.990Z,1410556414.990 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:35.006Z,1410556415.006 [Reporter](INFO): rhodamine.voltage 2904.478788 mV 2014-09-12T21:13:35.402Z,1410556415.402 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:35.440Z,1410556415.440 [Reporter](INFO): rhodamine.voltage 3184.360027 mV 2014-09-12T21:13:35.789Z,1410556415.789 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:35.806Z,1410556415.806 [Reporter](INFO): rhodamine.voltage 3339.558601 mV 2014-09-12T21:13:36.193Z,1410556416.193 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:36.226Z,1410556416.226 [Reporter](INFO): rhodamine.voltage 3367.689610 mV 2014-09-12T21:13:36.587Z,1410556416.587 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:36.604Z,1410556416.604 [Reporter](INFO): rhodamine.voltage 3375.795126 mV 2014-09-12T21:13:37.003Z,1410556417.003 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:37.040Z,1410556417.040 [Reporter](INFO): rhodamine.voltage 3382.232189 mV 2014-09-12T21:13:37.405Z,1410556417.405 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:37.442Z,1410556417.442 [Reporter](INFO): rhodamine.voltage 3340.988874 mV 2014-09-12T21:13:37.839Z,1410556417.839 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:37.856Z,1410556417.856 [Reporter](INFO): rhodamine.voltage 3288.541079 mV 2014-09-12T21:13:38.290Z,1410556418.290 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:38.307Z,1410556418.307 [Reporter](INFO): rhodamine.voltage 3356.723309 mV 2014-09-12T21:13:38.683Z,1410556418.683 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:38.699Z,1410556418.699 [Reporter](INFO): rhodamine.voltage 3282.104015 mV 2014-09-12T21:13:39.103Z,1410556419.103 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:39.147Z,1410556419.147 [Reporter](INFO): rhodamine.voltage 2667.032242 mV 2014-09-12T21:13:39.500Z,1410556419.500 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:39.533Z,1410556419.533 [Reporter](INFO): rhodamine.voltage 2107.984066 mV 2014-09-12T21:13:39.911Z,1410556419.911 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:39.958Z,1410556419.958 [Reporter](INFO): rhodamine.voltage 1788.289785 mV 2014-09-12T21:13:40.356Z,1410556420.356 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:40.387Z,1410556420.387 [Reporter](INFO): rhodamine.voltage 1846.936107 mV 2014-09-12T21:13:40.760Z,1410556420.760 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:40.797Z,1410556420.797 [Reporter](INFO): rhodamine.voltage 2022.160053 mV 2014-09-12T21:13:41.194Z,1410556421.194 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:41.210Z,1410556421.210 [Reporter](INFO): rhodamine.voltage 2022.398472 mV 2014-09-12T21:13:41.611Z,1410556421.611 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:41.640Z,1410556421.640 [Reporter](INFO): rhodamine.voltage 2591.220856 mV 2014-09-12T21:13:41.654Z,1410556421.654 [Aanderaa_O2](FAULT): Timed out starting 2014-09-12T21:13:41.654Z,1410556421.654 [Aanderaa_O2] Communications Fault, FailCount= 3 2014-09-12T21:13:41.654Z,1410556421.654 [Aanderaa_O2](ERROR): Communications Fault 2014-09-12T21:13:41.999Z,1410556421.999 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:42.035Z,1410556422.035 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2014-09-12T21:13:42.035Z,1410556422.035 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2014-09-12T21:13:42.037Z,1410556422.037 [Reporter](INFO): rhodamine.voltage 8601.046562 mV 2014-09-12T21:13:42.183Z,1410556422.183 [Aanderaa_O2](INFO): Powering down 2014-09-12T21:13:42.533Z,1410556422.533 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:42.550Z,1410556422.550 [Reporter](INFO): rhodamine.voltage 80232.627869 mV 2014-09-12T21:13:42.960Z,1410556422.960 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:42.998Z,1410556422.998 [Reporter](INFO): rhodamine.voltage 158063.796997 mV 2014-09-12T21:13:43.371Z,1410556423.371 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:43.405Z,1410556423.405 [Reporter](INFO): rhodamine.voltage 174926.773071 mV 2014-09-12T21:13:43.790Z,1410556423.790 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:43.808Z,1410556423.808 [Reporter](INFO): rhodamine.voltage 406970.092773 mV 2014-09-12T21:13:44.188Z,1410556424.188 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:44.206Z,1410556424.206 [Reporter](INFO): rhodamine.voltage 485609.222412 mV 2014-09-12T21:13:44.585Z,1410556424.585 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:44.601Z,1410556424.601 [Reporter](INFO): rhodamine.voltage 444279.968262 mV 2014-09-12T21:13:44.970Z,1410556424.970 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:45.006Z,1410556425.006 [Reporter](INFO): rhodamine.voltage 296835.021973 mV 2014-09-12T21:13:45.374Z,1410556425.374 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:45.411Z,1410556425.411 [Reporter](INFO): rhodamine.voltage 185684.341431 mV 2014-09-12T21:13:45.777Z,1410556425.777 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:45.811Z,1410556425.811 [Reporter](INFO): rhodamine.voltage 126707.748413 mV 2014-09-12T21:13:46.199Z,1410556426.199 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:46.216Z,1410556426.216 [Reporter](INFO): rhodamine.voltage 107202.568054 mV 2014-09-12T21:13:46.595Z,1410556426.595 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:46.612Z,1410556426.612 [Reporter](INFO): rhodamine.voltage 222984.420776 mV 2014-09-12T21:13:46.973Z,1410556426.973 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:47.009Z,1410556427.009 [Reporter](INFO): rhodamine.voltage 445658.630371 mV 2014-09-12T21:13:47.366Z,1410556427.366 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:47.408Z,1410556427.408 [Reporter](INFO): rhodamine.voltage 486264.099121 mV 2014-09-12T21:13:47.777Z,1410556427.777 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:47.818Z,1410556427.818 [Reporter](INFO): rhodamine.voltage 486311.737061 mV 2014-09-12T21:13:48.198Z,1410556428.198 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:48.215Z,1410556428.215 [Reporter](INFO): rhodamine.voltage 486311.737061 mV 2014-09-12T21:13:48.603Z,1410556428.603 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:48.620Z,1410556428.620 [Reporter](INFO): rhodamine.voltage 486314.147949 mV 2014-09-12T21:13:49.017Z,1410556429.017 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:49.056Z,1410556429.056 [Reporter](INFO): rhodamine.voltage 486308.929443 mV 2014-09-12T21:13:49.410Z,1410556429.410 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:49.428Z,1410556429.428 [Reporter](INFO): rhodamine.voltage 486313.476562 mV 2014-09-12T21:13:49.815Z,1410556429.815 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:49.832Z,1410556429.832 [Reporter](INFO): rhodamine.voltage 486307.922363 mV 2014-09-12T21:13:50.231Z,1410556430.231 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:50.268Z,1410556430.268 [Reporter](INFO): rhodamine.voltage 486311.309814 mV 2014-09-12T21:13:50.658Z,1410556430.658 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:50.676Z,1410556430.676 [Reporter](INFO): rhodamine.voltage 486312.255859 mV 2014-09-12T21:13:51.055Z,1410556431.055 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:51.073Z,1410556431.073 [Reporter](INFO): rhodamine.voltage 486307.678223 mV 2014-09-12T21:13:51.455Z,1410556431.455 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:51.473Z,1410556431.473 [Reporter](INFO): rhodamine.voltage 486302.459717 mV 2014-09-12T21:13:51.856Z,1410556431.856 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:51.873Z,1410556431.873 [Reporter](INFO): rhodamine.voltage 486305.603027 mV 2014-09-12T21:13:52.269Z,1410556432.269 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:52.286Z,1410556432.286 [Reporter](INFO): rhodamine.voltage 486310.333252 mV 2014-09-12T21:13:52.673Z,1410556432.673 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:52.690Z,1410556432.690 [Reporter](INFO): rhodamine.voltage 486302.215576 mV 2014-09-12T21:13:53.067Z,1410556433.067 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:53.085Z,1410556433.085 [Reporter](INFO): rhodamine.voltage 486311.553955 mV 2014-09-12T21:13:53.486Z,1410556433.486 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:53.521Z,1410556433.521 [Reporter](INFO): rhodamine.voltage 486310.607910 mV 2014-09-12T21:13:53.937Z,1410556433.937 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:53.968Z,1410556433.968 [Reporter](INFO): rhodamine.voltage 486304.870605 mV 2014-09-12T21:13:54.336Z,1410556434.336 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:54.373Z,1410556434.373 [Reporter](INFO): rhodamine.voltage 486306.518555 mV 2014-09-12T21:13:54.756Z,1410556434.756 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:54.773Z,1410556434.773 [Reporter](INFO): rhodamine.voltage 486307.250977 mV 2014-09-12T21:13:55.119Z,1410556435.119 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:55.136Z,1410556435.136 [Reporter](INFO): rhodamine.voltage 486300.354004 mV 2014-09-12T21:13:55.557Z,1410556435.557 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:55.574Z,1410556435.574 [Reporter](INFO): rhodamine.voltage 486299.407959 mV 2014-09-12T21:13:55.958Z,1410556435.958 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:55.975Z,1410556435.975 [Reporter](INFO): rhodamine.voltage 486299.407959 mV 2014-09-12T21:13:56.344Z,1410556436.344 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:56.378Z,1410556436.378 [Reporter](INFO): rhodamine.voltage 486303.649902 mV 2014-09-12T21:13:56.759Z,1410556436.759 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:56.777Z,1410556436.777 [Reporter](INFO): rhodamine.voltage 486300.354004 mV 2014-09-12T21:13:57.164Z,1410556437.164 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:57.182Z,1410556437.182 [Reporter](INFO): rhodamine.voltage 486315.368652 mV 2014-09-12T21:13:57.560Z,1410556437.560 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:57.577Z,1410556437.577 [Reporter](INFO): rhodamine.voltage 486303.222656 mV 2014-09-12T21:13:57.963Z,1410556437.963 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:57.981Z,1410556437.981 [Reporter](INFO): rhodamine.voltage 486311.737061 mV 2014-09-12T21:13:58.359Z,1410556438.359 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:58.376Z,1410556438.376 [Reporter](INFO): rhodamine.voltage 486308.441162 mV 2014-09-12T21:13:58.774Z,1410556438.774 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:58.791Z,1410556438.791 [Reporter](INFO): rhodamine.voltage 486308.685303 mV 2014-09-12T21:13:59.187Z,1410556439.187 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:59.221Z,1410556439.221 [Reporter](INFO): rhodamine.voltage 486303.894043 mV 2014-09-12T21:13:59.592Z,1410556439.592 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:13:59.624Z,1410556439.624 [Reporter](INFO): rhodamine.voltage 486309.417725 mV 2014-09-12T21:14:00.008Z,1410556440.008 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:00.025Z,1410556440.025 [Reporter](INFO): rhodamine.voltage 486303.894043 mV 2014-09-12T21:14:00.380Z,1410556440.380 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:00.421Z,1410556440.421 [Reporter](INFO): rhodamine.voltage 486298.431396 mV 2014-09-12T21:14:00.773Z,1410556440.773 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:00.789Z,1410556440.789 [Reporter](INFO): rhodamine.voltage 486302.001953 mV 2014-09-12T21:14:01.196Z,1410556441.196 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:01.229Z,1410556441.229 [Reporter](INFO): rhodamine.voltage 486301.574707 mV 2014-09-12T21:14:01.606Z,1410556441.606 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:01.623Z,1410556441.623 [Reporter](INFO): rhodamine.voltage 486308.441162 mV 2014-09-12T21:14:02.013Z,1410556442.013 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:02.030Z,1410556442.030 [Reporter](INFO): rhodamine.voltage 486302.001953 mV 2014-09-12T21:14:02.384Z,1410556442.384 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:02.423Z,1410556442.423 [Reporter](INFO): rhodamine.voltage 486302.703857 mV 2014-09-12T21:14:02.787Z,1410556442.787 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:02.822Z,1410556442.822 [Reporter](INFO): rhodamine.voltage 486302.978516 mV 2014-09-12T21:14:03.213Z,1410556443.213 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:03.230Z,1410556443.230 [Reporter](INFO): rhodamine.voltage 486307.922363 mV 2014-09-12T21:14:03.619Z,1410556443.619 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:03.637Z,1410556443.637 [Reporter](INFO): rhodamine.voltage 486303.649902 mV 2014-09-12T21:14:04.031Z,1410556444.031 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:04.060Z,1410556444.060 [Reporter](INFO): rhodamine.voltage 486296.997070 mV 2014-09-12T21:14:04.422Z,1410556444.422 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:04.439Z,1410556444.439 [Reporter](INFO): rhodamine.voltage 486304.138184 mV 2014-09-12T21:14:04.842Z,1410556444.842 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:04.884Z,1410556444.884 [Reporter](INFO): rhodamine.voltage 486305.114746 mV 2014-09-12T21:14:05.234Z,1410556445.234 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:05.277Z,1410556445.277 [Reporter](INFO): rhodamine.voltage 360235.137939 mV 2014-09-12T21:14:05.665Z,1410556445.665 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:05.683Z,1410556445.683 [Reporter](INFO): rhodamine.voltage 192549.057007 mV 2014-09-12T21:14:06.036Z,1410556446.036 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:06.074Z,1410556446.074 [Reporter](INFO): rhodamine.voltage 108394.340515 mV 2014-09-12T21:14:06.164Z,1410556446.164 [CommandLine](IMPORTANT): got command stop 2014-09-12T21:14:06.485Z,1410556446.485 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:06.492Z,1410556446.492 [Science] Stopped 2014-09-12T21:14:06.492Z,1410556446.492 [Science](INFO): Aggregate::uninitialize Science 2014-09-12T21:14:06.492Z,1410556446.492 [Science:A] Stopped 2014-09-12T21:14:06.492Z,1410556446.492 [Science:B] Stopped 2014-09-12T21:14:06.492Z,1410556446.492 [Science:E] Stopped 2014-09-12T21:14:06.492Z,1410556446.492 [Science:H] Stopped 2014-09-12T21:14:06.545Z,1410556446.545 [Reporter](INFO): rhodamine.voltage 180500.091553 mV 2014-09-12T21:14:06.940Z,1410556446.940 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:06.946Z,1410556446.946 [MissionManager](IMPORTANT): Started mission Default 2014-09-12T21:14:06.946Z,1410556446.946 [Default] Running Loop=1 2014-09-12T21:14:06.946Z,1410556446.946 [Default](INFO): Aggregate::initialize Default 2014-09-12T21:14:06.946Z,1410556446.946 [Default:B.GoToSurface] Running Loop=1 2014-09-12T21:14:06.946Z,1410556446.946 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2014-09-12T21:14:06.947Z,1410556446.947 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2014-09-12T21:14:06.947Z,1410556446.947 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2014-09-12T21:14:06.947Z,1410556446.947 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s. 2014-09-12T21:14:06.948Z,1410556446.948 [Default:StartClock] Running Loop=1 2014-09-12T21:14:06.948Z,1410556446.948 [Default:StartClock](INFO): Aggregate::initialize Default:StartClock 2014-09-12T21:14:06.948Z,1410556446.948 [Default:StartClock:A] Running Loop=1 2014-09-12T21:14:06.950Z,1410556446.950 [Default:StartClock:A] Stopped 2014-09-12T21:14:06.950Z,1410556446.950 [Default:StartClock](INFO): Completed Default:StartClock 2014-09-12T21:14:06.950Z,1410556446.950 [Default:StartClock] Stopped 2014-09-12T21:14:06.950Z,1410556446.950 [Default:StartClock](INFO): Aggregate::uninitialize Default:StartClock 2014-09-12T21:14:07.013Z,1410556447.013 [rhodamine](INFO): Powering down 2014-09-12T21:14:07.405Z,1410556447.405 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:07.428Z,1410556447.428 [Default:WaitAtTheSurface] Running Loop=1 2014-09-12T21:14:07.429Z,1410556447.429 [Default:WaitAtTheSurface](INFO): Aggregate::initialize Default:WaitAtTheSurface 2014-09-12T21:14:07.429Z,1410556447.429 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1 2014-09-12T21:14:07.429Z,1410556447.429 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Initialize. 2014-09-12T21:14:07.838Z,1410556447.838 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:12.590Z,1410556452.590 [CommandLine](IMPORTANT): got command quit 2014-09-12T21:14:12.881Z,1410556452.881 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:13.595Z,1410556453.595 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2014-09-12T21:14:13.595Z,1410556453.595 [CommandLine ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:13.680Z,1410556453.680 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2014-09-12T21:14:13.680Z,1410556453.680 [CommandLine ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:13.680Z,1410556453.680 [CommandLine](INFO): Join timeout helper Thread ID is 2240 2014-09-12T21:14:13.681Z,1410556453.681 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2014-09-12T21:14:13.681Z,1410556453.681 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:13.681Z,1410556453.681 [NavChartDb](INFO): Join timeout helper Thread ID is 2241 2014-09-12T21:14:13.768Z,1410556453.768 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2014-09-12T21:14:13.768Z,1410556453.768 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:13.784Z,1410556453.784 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2014-09-12T21:14:13.784Z,1410556453.784 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:13.784Z,1410556453.784 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2242 2014-09-12T21:14:17.898Z,1410556457.898 [HFRCMReconstructedInterpolator](DEBUG): no valid forecast 2014-09-12T21:14:17.942Z,1410556457.942 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2014-09-12T21:14:17.943Z,1410556457.943 [WetLabsBB2FL](INFO): Powering down 2014-09-12T21:14:17.943Z,1410556457.943 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:17.962Z,1410556457.962 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2014-09-12T21:14:17.963Z,1410556457.963 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:17.963Z,1410556457.963 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 2243 2014-09-12T21:14:18.307Z,1410556458.307 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2014-09-12T21:14:18.307Z,1410556458.307 [CTD_NeilBrown](INFO): Powering down 2014-09-12T21:14:18.308Z,1410556458.308 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:18.323Z,1410556458.323 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2014-09-12T21:14:18.323Z,1410556458.323 [logger ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:18.324Z,1410556458.324 [logger](INFO): Join timeout helper Thread ID is 2244 2014-09-12T21:14:18.367Z,1410556458.367 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2014-09-12T21:14:18.367Z,1410556458.367 [logger ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:18.384Z,1410556458.384 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2014-09-12T21:14:18.384Z,1410556458.384 [CommandLine ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:18.384Z,1410556458.384 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2014-09-12T21:14:18.384Z,1410556458.384 [controlThread ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:18.385Z,1410556458.385 [controlThread](INFO): Join timeout helper Thread ID is 2245 2014-09-12T21:14:22.454Z,1410556462.454 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2014-09-12T21:14:22.454Z,1410556462.454 [controlThread](DEBUG): Uninitializing ControlThread 2014-09-12T21:14:22.455Z,1410556462.455 [Aanderaa_O2](INFO): Powering down 2014-09-12T21:14:22.456Z,1410556462.456 [AHRS_sp3003D](INFO): Powering down 2014-09-12T21:14:22.614Z,1410556462.614 [DVL_micro](INFO): uninitialize:Powering down 2014-09-12T21:14:22.615Z,1410556462.615 [NAL9602](INFO): Powering down 2014-09-12T21:14:22.617Z,1410556462.617 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2014-09-12T21:14:22.619Z,1410556462.619 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2014-09-12T21:14:22.619Z,1410556462.619 [Default] Stopped 2014-09-12T21:14:22.619Z,1410556462.619 [Default](INFO): Aggregate::uninitialize Default 2014-09-12T21:14:22.619Z,1410556462.619 [Default:B.GoToSurface] Stopped 2014-09-12T21:14:22.620Z,1410556462.620 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2014-09-12T21:14:22.620Z,1410556462.620 [Default:WaitAtTheSurface] Stopped 2014-09-12T21:14:22.620Z,1410556462.620 [Default:WaitAtTheSurface](INFO): Aggregate::uninitialize Default:WaitAtTheSurface 2014-09-12T21:14:22.620Z,1410556462.620 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Stopped 2014-09-12T21:14:22.620Z,1410556462.620 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Uninitialize. 2014-09-12T21:14:22.623Z,1410556462.623 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2014-09-12T21:14:22.623Z,1410556462.623 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2014-09-12T21:14:22.624Z,1410556462.624 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2014-09-12T21:14:22.624Z,1410556462.624 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2014-09-12T21:14:22.624Z,1410556462.624 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2014-09-12T21:14:22.624Z,1410556462.624 [BuoyancyServo](INFO): Powering down 2014-09-12T21:14:22.638Z,1410556462.638 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2014-09-12T21:14:22.638Z,1410556462.638 [ElevatorServo](INFO): Powering down 2014-09-12T21:14:22.639Z,1410556462.639 [MassServo](DEBUG): Uninitialize Mass Servo. 2014-09-12T21:14:22.639Z,1410556462.639 [MassServo](INFO): Powering down 2014-09-12T21:14:22.640Z,1410556462.640 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2014-09-12T21:14:22.640Z,1410556462.640 [RudderServo](INFO): Powering down 2014-09-12T21:14:22.641Z,1410556462.641 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2014-09-12T21:14:22.641Z,1410556462.641 [ThrusterServo](INFO): Powering down 2014-09-12T21:14:22.642Z,1410556462.642 [SBIT](DEBUG): Uninitialize SBIT Component. 2014-09-12T21:14:22.642Z,1410556462.642 [IBIT](DEBUG): Uninitialize IBIT Component. 2014-09-12T21:14:22.642Z,1410556462.642 [CBIT](DEBUG): Uninitialize CBIT Component. 2014-09-12T21:14:22.674Z,1410556462.674 [controlThread ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:22.736Z,1410556462.736 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:22.739Z,1410556462.739 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:22.846Z,1410556462.846 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2014-09-12T21:14:22.889Z,1410556462.889 [logger ThreadHandler](INFO): Thread cancelled.