2012-09-20T23:34:52.105Z,1348184092.105 [Supervisor](DEBUG): Initializing supervisor.
2012-09-20T23:34:52.110Z,1348184092.110 [SyncHandler](DEBUG): Created PCaller Thread at 4033B4E0
2012-09-20T23:34:52.111Z,1348184092.111 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2012-09-20T23:34:52.114Z,1348184092.114 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4036B4E0
2012-09-20T23:34:52.118Z,1348184092.118 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2012-09-20T23:34:52.129Z,1348184092.129 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2012-09-20T23:34:52.130Z,1348184092.130 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4039B4E0
2012-09-20T23:34:52.131Z,1348184092.131 [ComponentRegistry](DEBUG): SyncComponent "logger" handled in the control thread.
2012-09-20T23:34:52.132Z,1348184092.132 [Supervisor](INFO): Looking for Config files in directory: Config/
2012-09-20T23:34:52.134Z,1348184092.134 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2012-09-20T23:34:52.449Z,1348184092.450 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2012-09-20T23:34:52.452Z,1348184092.452 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2012-09-20T23:34:52.650Z,1348184092.650 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2012-09-20T23:34:52.650Z,1348184092.650 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2012-09-20T23:34:52.746Z,1348184092.746 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2012-09-20T23:34:52.748Z,1348184092.748 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2012-09-20T23:34:52.967Z,1348184092.967 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2012-09-20T23:34:52.968Z,1348184092.968 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2012-09-20T23:34:53.117Z,1348184093.118 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2012-09-20T23:34:53.120Z,1348184093.120 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2012-09-20T23:34:53.383Z,1348184093.383 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2012-09-20T23:34:53.384Z,1348184093.384 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2012-09-20T23:34:53.574Z,1348184093.574 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2012-09-20T23:34:53.576Z,1348184093.576 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2012-09-20T23:34:53.859Z,1348184093.859 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2012-09-20T23:34:53.862Z,1348184093.862 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2012-09-20T23:34:53.975Z,1348184093.975 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2012-09-20T23:34:53.975Z,1348184093.975 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2012-09-20T23:34:54.444Z,1348184094.444 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2012-09-20T23:34:54.444Z,1348184094.444 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2012-09-20T23:34:54.563Z,1348184094.563 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2012-09-20T23:34:54.563Z,1348184094.563 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2012-09-20T23:34:54.659Z,1348184094.659 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2012-09-20T23:34:54.663Z,1348184094.663 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2012-09-20T23:34:54.774Z,1348184094.774 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2012-09-20T23:34:54.919Z,1348184094.919 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2012-09-20T23:34:55.014Z,1348184095.014 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2012-09-20T23:34:55.126Z,1348184095.126 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2012-09-20T23:34:55.239Z,1348184095.239 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2012-09-20T23:34:55.375Z,1348184095.375 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2012-09-20T23:34:55.478Z,1348184095.478 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2012-09-20T23:34:55.623Z,1348184095.623 [Supervisor](FAULT): Ignoring configuration overrides from Data/config.db
2012-09-20T23:34:55.718Z,1348184095.718 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2012-09-20T23:34:55.913Z,1348184095.912 [InternalSim] Loaded
2012-09-20T23:34:55.913Z,1348184095.913 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2012-09-20T23:34:55.914Z,1348184095.914 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2012-09-20T23:34:55.914Z,1348184095.914 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2012-09-20T23:34:55.997Z,1348184095.997 [SBIT](DEBUG): Construct Startup Built In Test.
2012-09-20T23:34:56.010Z,1348184096.010 [SBIT] Loaded
2012-09-20T23:34:56.010Z,1348184096.010 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2012-09-20T23:34:56.011Z,1348184096.011 [IBIT](DEBUG): Construct Initiated Built In Test.
2012-09-20T23:34:56.043Z,1348184096.043 [IBIT] Loaded
2012-09-20T23:34:56.043Z,1348184096.043 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2012-09-20T23:34:56.050Z,1348184096.050 [CBIT](DEBUG): Construct CBIT Built In Test.
2012-09-20T23:34:56.171Z,1348184096.171 [CBIT] Loaded
2012-09-20T23:34:56.171Z,1348184096.171 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2012-09-20T23:34:56.172Z,1348184096.172 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2012-09-20T23:34:56.173Z,1348184096.173 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2012-09-20T23:34:56.340Z,1348184096.341 [BuoyancyServo] Loaded
2012-09-20T23:34:56.341Z,1348184096.341 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2012-09-20T23:34:56.354Z,1348184096.354 [RudderServo] Loaded
2012-09-20T23:34:56.354Z,1348184096.354 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2012-09-20T23:34:56.365Z,1348184096.365 [ThrusterServo] Loaded
2012-09-20T23:34:56.366Z,1348184096.366 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2012-09-20T23:34:56.366Z,1348184096.366 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2012-09-20T23:34:56.367Z,1348184096.367 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2012-09-20T23:34:56.399Z,1348184096.399 [DepthRateCalculator] Loaded
2012-09-20T23:34:56.399Z,1348184096.399 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2012-09-20T23:34:59.079Z,1348184099.079 [HFRadarModelCalc] Loaded
2012-09-20T23:34:59.080Z,1348184099.080 [ComponentRegistry](DEBUG): SyncComponent "HFRadarModelCalc" handled in the control thread.
2012-09-20T23:34:59.095Z,1348184099.095 [NavChart] Loaded
2012-09-20T23:34:59.095Z,1348184099.095 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2012-09-20T23:34:59.101Z,1348184099.101 [PitchRateCalculator] Loaded
2012-09-20T23:34:59.101Z,1348184099.101 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2012-09-20T23:34:59.107Z,1348184099.107 [SpeedCalculator] Loaded
2012-09-20T23:34:59.108Z,1348184099.108 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2012-09-20T23:34:59.122Z,1348184099.122 [TempGradientCalculator] Loaded
2012-09-20T23:34:59.123Z,1348184099.123 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2012-09-20T23:34:59.128Z,1348184099.128 [YawRateCalculator] Loaded
2012-09-20T23:34:59.128Z,1348184099.128 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2012-09-20T23:34:59.148Z,1348184099.148 [Navigation] Loaded
2012-09-20T23:34:59.148Z,1348184099.148 [ComponentRegistry](DEBUG): SyncComponent "Navigation" handled in the control thread.
2012-09-20T23:34:59.149Z,1348184099.149 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2012-09-20T23:34:59.149Z,1348184099.149 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2012-09-20T23:34:59.439Z,1348184099.439 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2012-09-20T23:34:59.440Z,1348184099.440 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2012-09-20T23:34:59.477Z,1348184099.477 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2012-09-20T23:34:59.477Z,1348184099.477 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2012-09-20T23:34:59.546Z,1348184099.546 [VerticalControl](DEBUG): Construct VerticalControl.
2012-09-20T23:34:59.595Z,1348184099.595 [VerticalControl] Loaded
2012-09-20T23:34:59.596Z,1348184099.596 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2012-09-20T23:34:59.597Z,1348184099.597 [HorizontalControl](DEBUG): Construct HorizontalControl.
2012-09-20T23:34:59.621Z,1348184099.621 [HorizontalControl] Loaded
2012-09-20T23:34:59.622Z,1348184099.622 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2012-09-20T23:34:59.623Z,1348184099.623 [SpeedControl](DEBUG): Construct SpeedControl.
2012-09-20T23:34:59.624Z,1348184099.624 [SpeedControl] Loaded
2012-09-20T23:34:59.625Z,1348184099.625 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2012-09-20T23:34:59.626Z,1348184099.625 [LoopControl](DEBUG): Construct LoopControl.
2012-09-20T23:34:59.626Z,1348184099.626 [LoopControl] Loaded
2012-09-20T23:34:59.626Z,1348184099.626 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2012-09-20T23:34:59.627Z,1348184099.627 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2012-09-20T23:34:59.627Z,1348184099.627 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2012-09-20T23:34:59.635Z,1348184099.635 [AsyncPiEstimator](DEBUG): Construct AsyncPiEstimator.
2012-09-20T23:34:59.640Z,1348184099.640 [AsyncPiEstimator] Loaded
2012-09-20T23:34:59.640Z,1348184099.640 [ComponentRegistry](DEBUG): Component "AsyncPiEstimator" handled in its own thread.
2012-09-20T23:34:59.642Z,1348184099.642 [AsyncPiEstimator ThreadHandler](DEBUG): Created PCaller Thread at 4060A4E0
2012-09-20T23:34:59.643Z,1348184099.643 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2012-09-20T23:34:59.644Z,1348184099.644 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2012-09-20T23:34:59.812Z,1348184099.812 [AHRS_sp3003D] Loaded
2012-09-20T23:34:59.812Z,1348184099.812 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread.
2012-09-20T23:34:59.829Z,1348184099.829 [Depth_Keller] Loaded
2012-09-20T23:34:59.830Z,1348184099.830 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2012-09-20T23:34:59.835Z,1348184099.835 [DropWeight] Loaded
2012-09-20T23:34:59.835Z,1348184099.835 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2012-09-20T23:34:59.960Z,1348184099.960 [DVL_micro] Loaded
2012-09-20T23:34:59.961Z,1348184099.961 [ComponentRegistry](DEBUG): Component "DVL_micro" handled in its own thread.
2012-09-20T23:34:59.962Z,1348184099.962 [DVL_micro ThreadHandler](DEBUG): Created PCaller Thread at 4068A4E0
2012-09-20T23:35:00.050Z,1348184100.050 [NAL9602] Loaded
2012-09-20T23:35:00.050Z,1348184100.050 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2012-09-20T23:35:00.103Z,1348184100.103 [Onboard] Loaded
2012-09-20T23:35:00.103Z,1348184100.103 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2012-09-20T23:35:00.110Z,1348184100.110 [Radio_Freewave] Loaded
2012-09-20T23:35:00.110Z,1348184100.110 [ComponentRegistry](DEBUG): SyncComponent "Radio_Freewave" handled in the control thread.
2012-09-20T23:35:00.111Z,1348184100.111 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2012-09-20T23:35:00.112Z,1348184100.112 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2012-09-20T23:35:00.215Z,1348184100.215 [CTD_NeilBrown] Loaded
2012-09-20T23:35:00.215Z,1348184100.215 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2012-09-20T23:35:00.218Z,1348184100.218 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406E24E0
2012-09-20T23:35:00.229Z,1348184100.229 [PAR_Licor] Loaded
2012-09-20T23:35:00.229Z,1348184100.229 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2012-09-20T23:35:00.250Z,1348184100.250 [Turbulence_NPS] Loaded
2012-09-20T23:35:00.250Z,1348184100.250 [ComponentRegistry](DEBUG): Component "Turbulence_NPS" handled in its own thread.
2012-09-20T23:35:00.254Z,1348184100.254 [Turbulence_NPS ThreadHandler](DEBUG): Created PCaller Thread at 407124E0
2012-09-20T23:35:00.289Z,1348184100.289 [WetLabsBB2FL] Loaded
2012-09-20T23:35:00.289Z,1348184100.289 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2012-09-20T23:35:00.290Z,1348184100.290 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407424E0
2012-09-20T23:35:00.291Z,1348184100.291 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2012-09-20T23:35:00.293Z,1348184100.293 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2012-09-20T23:35:00.294Z,1348184100.294 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2012-09-20T23:35:00.300Z,1348184100.300 [NavChartDb](CRITICAL): No configuration setting for: NavChartDb.cycleTimeout
2012-09-20T23:35:00.301Z,1348184100.301 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2012-09-20T23:35:00.306Z,1348184100.306 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 407724E0
2012-09-20T23:35:00.310Z,1348184100.310 [Supervisor](DEBUG): Running supervisor.
2012-09-20T23:35:00.312Z,1348184100.312 [CommandLine](INFO): Thread ID is 749
2012-09-20T23:35:00.315Z,1348184100.315 [controlThread](INFO): Thread ID is 748
2012-09-20T23:35:00.315Z,1348184100.315 [controlThread](DEBUG): Initializing ControlThread
2012-09-20T23:35:00.316Z,1348184100.316 [CycleStarter](INFO): Thread ID is 747
2012-09-20T23:35:00.316Z,1348184100.316 [InternalSim](DEBUG): InternalSim initializing...
2012-09-20T23:35:00.428Z,1348184100.428 [AsyncPiEstimator](INFO): Thread ID is 810
2012-09-20T23:35:00.428Z,1348184100.428 [AsyncPiEstimator](DEBUG): Initialize AsyncPiEstimator.
2012-09-20T23:35:00.499Z,1348184100.499 [DVL_micro](INFO): Thread ID is 811
2012-09-20T23:35:00.924Z,1348184100.924 [CTD_NeilBrown](INFO): Thread ID is 812
2012-09-20T23:35:00.924Z,1348184100.924 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2012-09-20T23:35:00.929Z,1348184100.929 [SBIT](INFO): Initialize SBIT Component.
2012-09-20T23:35:00.930Z,1348184100.930 [SBIT](IMPORTANT): Tethys CM Info:
$Rev: 9861
2012-09-20T23:35:00.944Z,1348184100.944 [Turbulence_NPS](INFO): Thread ID is 813
2012-09-20T23:35:00.944Z,1348184100.944 [Turbulence_NPS](DEBUG): Initializing Turbulence_NPS.
2012-09-20T23:35:00.951Z,1348184100.951 [IBIT](INFO): Initialize IBIT Component.
2012-09-20T23:35:00.952Z,1348184100.952 [CBIT](DEBUG): Initialize CBIT Component.
2012-09-20T23:35:00.953Z,1348184100.953 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2012-09-20T23:35:00.953Z,1348184100.953 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2012-09-20T23:35:00.954Z,1348184100.954 [WetLabsBB2FL](INFO): Thread ID is 814
2012-09-20T23:35:00.959Z,1348184100.959 [WetLabsBB2FL](INFO): Powering down
2012-09-20T23:35:00.964Z,1348184100.964 [NavChartDb](INFO): Thread ID is 815
2012-09-20T23:35:01.007Z,1348184101.007 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2012-09-20T23:35:01.007Z,1348184101.007 [NavChart](DEBUG): Initialize NavChart Derivation.
2012-09-20T23:35:01.008Z,1348184101.008 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2012-09-20T23:35:01.008Z,1348184101.008 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2012-09-20T23:35:01.008Z,1348184101.008 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2012-09-20T23:35:01.010Z,1348184101.010 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2012-09-20T23:35:01.010Z,1348184101.010 [Navigation](DEBUG): Initializing Navigation.
2012-09-20T23:35:01.011Z,1348184101.011 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2012-09-20T23:35:01.012Z,1348184101.012 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2012-09-20T23:35:01.013Z,1348184101.013 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2012-09-20T23:35:01.014Z,1348184101.013 [LoopControl](DEBUG): Initialize LoopControlComponent.
2012-09-20T23:35:01.027Z,1348184101.027 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2012-09-20T23:35:01.084Z,1348184101.084 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T23:35:01.236Z,1348184101.236 [DVL_micro](INFO): Initializing
2012-09-20T23:35:01.236Z,1348184101.236 [DVL_micro](INFO): start:Powering up
2012-09-20T23:35:01.263Z,1348184101.263 [MissionManager](DEBUG):
2012-09-20T23:35:01.264Z,1348184101.264 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2012-09-20T23:35:01.299Z,1348184101.299 [MissionManager](INFO): DefineArg Default.NeedGPS = 1 bool
2012-09-20T23:35:01.301Z,1348184101.301 [Default:GPS:A.SetSpeed](DEBUG): Construct.
2012-09-20T23:35:01.309Z,1348184101.309 [Default:GPS:B.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T23:35:01.317Z,1348184101.317 [Default:Iridium:A.SetSpeed](DEBUG): Construct.
2012-09-20T23:35:01.324Z,1348184101.324 [Default:Iridium:B.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T23:35:01.330Z,1348184101.330 [Default:Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2012-09-20T23:35:01.339Z,1348184101.339 [Default:D.SetSpeed](DEBUG): Construct.
2012-09-20T23:35:01.342Z,1348184101.342 [Default:E.GoToSurface](DEBUG): Construct GoToSurface.
2012-09-20T23:35:01.351Z,1348184101.351 [Default:F.Wait](DEBUG): Construct Wait.
2012-09-20T23:35:01.354Z,1348184101.354 [MissionManager](DEBUG):
400
400
Burn 300
Dropped drop weight due to communications timeout
5.0
1.0
5
2012-09-20T23:35:01.362Z,1348184101.362 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,AHRS_sp3003D,Depth_Keller,DropWeight,NAL9602,Onboard,Radio_Freewave,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,HFRadarModelCalc,NavChart,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,Navigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,logger,
2012-09-20T23:35:01.382Z,1348184101.382 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2012-09-20T23:35:01.567Z,1348184101.567 [Radio_Freewave](INFO): Powering up
2012-09-20T23:35:01.671Z,1348184101.671 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2012-09-20T23:35:01.674Z,1348184101.674 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2012-09-20T23:35:01.681Z,1348184101.681 [RudderServo](DEBUG): Initializing EZServoServo.
2012-09-20T23:35:01.683Z,1348184101.682 [RudderServo](DEBUG): Initializing RudderServo.
2012-09-20T23:35:01.689Z,1348184101.689 [ThrusterServo](DEBUG): Initializing EZServoServo.
2012-09-20T23:35:01.691Z,1348184101.691 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2012-09-20T23:35:05.209Z,1348184105.209 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:35:07.025Z,1348184107.025 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources
2012-09-20T23:35:07.451Z,1348184107.451 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2012-09-20T23:35:07.463Z,1348184107.463 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2012-09-20T23:35:07.588Z,1348184107.588 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2012-09-20T23:35:07.672Z,1348184107.672 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2012-09-20T23:35:07.672Z,1348184107.672 [NavChartDb](INFO): Creating index for Soundings
2012-09-20T23:35:07.908Z,1348184107.908 [NavChartDb](INFO): Creating index for Contour 0p0
2012-09-20T23:35:07.910Z,1348184107.910 [NavChartDb](INFO): Creating index for Contour 1p8
2012-09-20T23:35:07.932Z,1348184107.932 [NavChartDb](INFO): Creating index for Contour 3p6
2012-09-20T23:35:07.934Z,1348184107.934 [NavChartDb](INFO): Creating index for Contour 5p4
2012-09-20T23:35:07.956Z,1348184107.956 [NavChartDb](INFO): Creating index for Contour 9p1
2012-09-20T23:35:07.958Z,1348184107.958 [NavChartDb](INFO): Creating index for Contour 10p9
2012-09-20T23:35:08.112Z,1348184108.112 [NavChartDb](INFO): Creating index for Contour 18p2
2012-09-20T23:35:08.114Z,1348184108.114 [NavChartDb](INFO): Creating index for Contour 36p5
2012-09-20T23:35:08.616Z,1348184108.616 [NavChartDb](INFO): Creating index for Contour 54p8
2012-09-20T23:35:08.618Z,1348184108.618 [NavChartDb](INFO): Creating index for Contour 73p1
2012-09-20T23:35:08.984Z,1348184108.984 [NavChartDb](INFO): Creating index for Contour 91p4
2012-09-20T23:35:08.986Z,1348184108.986 [NavChartDb](INFO): Creating index for Contour 182p8
2012-09-20T23:35:09.180Z,1348184109.180 [NavChartDb](INFO): Creating index for Contour 365p7
2012-09-20T23:35:09.238Z,1348184109.238 [NavChartDb](INFO): Creating index for Contour 548p6
2012-09-20T23:35:09.240Z,1348184109.240 [NavChartDb](INFO): Creating index for Contour 731p5
2012-09-20T23:35:09.678Z,1348184109.678 [NavChartDb](INFO): Creating index for Contour 914p4
2012-09-20T23:35:09.680Z,1348184109.680 [NavChartDb](INFO): Creating index for Contour 1097p2
2012-09-20T23:35:09.794Z,1348184109.794 [NavChartDb](INFO): Creating index for Contour 1280p1
2012-09-20T23:35:09.796Z,1348184109.796 [NavChartDb](INFO): Creating index for Contour 1463p0
2012-09-20T23:35:09.818Z,1348184109.818 [NavChartDb](INFO): Creating index for Contour 1645p9
2012-09-20T23:35:09.820Z,1348184109.820 [NavChartDb](INFO): Creating index for Contour 1828p8
2012-09-20T23:35:10.154Z,1348184110.154 [NavChartDb](INFO): Creating index for Contour 2011p6
2012-09-20T23:35:10.156Z,1348184110.156 [NavChartDb](INFO): Creating index for Contour 2194p5
2012-09-20T23:35:10.158Z,1348184110.158 [NavChartDb](INFO): Creating index for Contour 2377p4
2012-09-20T23:35:10.160Z,1348184110.160 [NavChartDb](INFO): Creating index for Contour 2560p3
2012-09-20T23:35:10.286Z,1348184110.286 [NavChartDb](INFO): Creating index for Contour 2743p2
2012-09-20T23:35:10.288Z,1348184110.288 [NavChartDb](INFO): Creating index for Contour 2926p0
2012-09-20T23:35:10.310Z,1348184110.310 [NavChartDb](INFO): Creating index for Contour 3108p9
2012-09-20T23:35:10.312Z,1348184110.312 [NavChartDb](INFO): Creating index for Contour 3291p8
2012-09-20T23:35:10.454Z,1348184110.454 [NavChartDb](INFO): Creating index for Contour 3474p7
2012-09-20T23:35:10.456Z,1348184110.456 [NavChartDb](INFO): Creating index for Contour 3657p6
2012-09-20T23:35:15.675Z,1348184115.675 [NAL9602](ERROR): NAL9602 initialize error - Can't enter command mode:pCopyright(c) 2010
NAL Research Corporation
2012-09-20T23:35:15.675Z,1348184115.675 [NAL9602] Communications Fault, FailCount= 1
2012-09-20T23:35:15.675Z,1348184115.675 [NAL9602](ERROR): Communications Fault
2012-09-20T23:35:15.750Z,1348184115.750 [CBIT](ERROR): Communications Fault in component: NAL9602
2012-09-20T23:35:15.858Z,1348184115.858 [DVL_micro](INFO): Querying output modes
2012-09-20T23:35:15.859Z,1348184115.859 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD0606
2012-09-20T23:35:16.045Z,1348184116.045 [NAL9602](INFO): Powering down
2012-09-20T23:35:16.163Z,1348184116.163 [CBIT](INFO): Clearing failed state for component NAL9602
2012-09-20T23:35:16.163Z,1348184116.163 [NAL9602] No Fault, FailCount= 1
2012-09-20T23:35:16.612Z,1348184116.612 [SBIT](IMPORTANT): Beginning Startup BIT
2012-09-20T23:35:16.614Z,1348184116.614 [CBIT](IMPORTANT): Beginning GF scan
2012-09-20T23:35:17.285Z,1348184117.285 [Radio_Freewave](INFO): Powering down
2012-09-20T23:35:17.785Z,1348184117.785 [Radio_Freewave](INFO): Powering up
2012-09-20T23:35:21.261Z,1348184121.261 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:35:23.547Z,1348184123.547 [AHRS_sp3003D](FAULT): Read Acceleration Vector Failure.
2012-09-20T23:35:23.547Z,1348184123.547 [AHRS_sp3003D] Communications Fault, FailCount= 1
2012-09-20T23:35:23.547Z,1348184123.547 [AHRS_sp3003D](ERROR): Communications Fault
2012-09-20T23:35:23.680Z,1348184123.680 [CBIT](ERROR): Communications Fault in component: AHRS_sp3003D
2012-09-20T23:35:23.720Z,1348184123.720 [AHRS_sp3003D](INFO): Powering down
2012-09-20T23:35:24.572Z,1348184124.572 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2012-09-20T23:35:24.572Z,1348184124.572 [AHRS_sp3003D] No Fault, FailCount= 1
2012-09-20T23:35:25.354Z,1348184125.355 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2012-09-20T23:35:26.047Z,1348184126.047 [DVL_micro](DEBUG): cmdResponse:
2012-09-20T23:35:26.047Z,1348184126.047 [DVL_micro](DEBUG): commandDVL: #&!LQNQ.COMD2525
2012-09-20T23:35:26.939Z,1348184126.939 [AHRS_sp3003D](FAULT): Read Magnetics Failure.
2012-09-20T23:35:26.939Z,1348184126.939 [AHRS_sp3003D] Communications Fault, FailCount= 2
2012-09-20T23:35:26.939Z,1348184126.939 [AHRS_sp3003D](ERROR): Communications Fault
2012-09-20T23:35:27.987Z,1348184127.987 [CBIT](ERROR): Communications Fault in component: AHRS_sp3003D
2012-09-20T23:35:28.056Z,1348184128.056 [AHRS_sp3003D](INFO): Powering down
2012-09-20T23:35:28.567Z,1348184128.567 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2012-09-20T23:35:28.567Z,1348184128.567 [AHRS_sp3003D] No Fault, FailCount= 2
2012-09-20T23:35:29.769Z,1348184129.769 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2012-09-20T23:35:33.191Z,1348184133.191 [AHRS_sp3003D](FAULT): Read Heading/Pitch/Roll Failure.
2012-09-20T23:35:33.191Z,1348184133.191 [AHRS_sp3003D] Communications Fault, FailCount= 1
2012-09-20T23:35:33.191Z,1348184133.191 [AHRS_sp3003D](ERROR): Communications Fault
2012-09-20T23:35:33.198Z,1348184133.198 [NAL9602](ERROR): NAL9602 initialize error - Can't enter command mode:Copyright(c) 2010
NAL Research Corporation
2012-09-20T23:35:33.198Z,1348184133.198 [NAL9602] Communications Fault, FailCount= 2
2012-09-20T23:35:33.198Z,1348184133.198 [NAL9602](ERROR): Communications Fault
2012-09-20T23:35:33.697Z,1348184133.697 [CBIT](ERROR): Communications Fault in component: AHRS_sp3003D
2012-09-20T23:35:33.698Z,1348184133.698 [CBIT](ERROR): Communications Fault in component: NAL9602
2012-09-20T23:35:33.698Z,1348184133.698 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2012-09-20T23:35:33.759Z,1348184133.759 [AHRS_sp3003D](INFO): Powering down
2012-09-20T23:35:33.860Z,1348184133.860 [NAL9602](INFO): Powering down
2012-09-20T23:35:34.622Z,1348184134.622 [CBIT](INFO): Clearing failed state for component AHRS_sp3003D
2012-09-20T23:35:34.622Z,1348184134.622 [AHRS_sp3003D] No Fault, FailCount= 1
2012-09-20T23:35:35.478Z,1348184135.478 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D.
2012-09-20T23:35:36.339Z,1348184136.339 [DVL_micro](DEBUG): cmdResponse:
AUTO_VEL_ON
2012-09-20T23:35:36.357Z,1348184136.357 [DVL_micro](INFO): pause:Powering down
2012-09-20T23:35:44.454Z,1348184144.454 [CBIT](IMPORTANT): No ground fault detected
2012-09-20T23:36:10.454Z,1348184170.454 [SBIT](IMPORTANT): SBIT PASSED
2012-09-20T23:36:10.842Z,1348184170.842 [MissionManager](IMPORTANT): Started mission Startup
2012-09-20T23:36:10.842Z,1348184170.842 [Startup] Running Loop=1
2012-09-20T23:36:10.842Z,1348184170.842 [Startup](INFO): Aggregate::initialize Startup
2012-09-20T23:36:10.842Z,1348184170.842 [Startup:A.GoToSurface] Running Loop=1
2012-09-20T23:36:10.842Z,1348184170.842 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T23:36:10.848Z,1348184170.848 [Startup:StartupSatComms] Running Loop=1
2012-09-20T23:36:10.848Z,1348184170.848 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms
2012-09-20T23:36:10.848Z,1348184170.848 [Startup:StartupSatComms:A] Running Loop=1
2012-09-20T23:36:11.242Z,1348184171.242 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2012-09-20T23:37:11.242Z,1348184231.242 [Startup:StartupSatComms:A](INFO): Timed out from 2012-09-20T23:36:10.8Z
2012-09-20T23:37:11.243Z,1348184231.243 [Startup:StartupSatComms:A_Timeout] Running Loop=1
2012-09-20T23:37:11.243Z,1348184231.243 [Startup:StartupSatComms:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:A_Timeout
2012-09-20T23:37:11.243Z,1348184231.243 [Startup:StartupSatComms:A_Timeout](INFO): Completed Startup:StartupSatComms:A_Timeout
2012-09-20T23:37:11.243Z,1348184231.243 [Startup:StartupSatComms:A] Stopped
2012-09-20T23:37:11.243Z,1348184231.243 [Startup:StartupSatComms:B] Running Loop=1
2012-09-20T23:37:11.646Z,1348184231.646 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2012-09-20T23:37:33.267Z,1348184253.267 [CBIT](INFO): Clearing failed count for component NAL9602
2012-09-20T23:37:33.267Z,1348184253.267 [NAL9602] No Fault, FailCount= 2
2012-09-20T23:37:33.637Z,1348184253.637 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:37:34.439Z,1348184254.439 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:37:44.434Z,1348184264.434 [NAL9602](ERROR): NAL9602 initialize error - Can't enter command mode:Copyright(c) 2010
NAL Research Corporation
2012-09-20T23:37:44.434Z,1348184264.434 [NAL9602] Communications Fault, FailCount= 1
2012-09-20T23:37:44.434Z,1348184264.434 [NAL9602](ERROR): Communications Fault
2012-09-20T23:37:44.456Z,1348184264.456 [CBIT](ERROR): Communications Fault in component: NAL9602
2012-09-20T23:37:44.829Z,1348184264.829 [NAL9602](INFO): Powering down
2012-09-20T23:37:44.851Z,1348184264.851 [CBIT](INFO): Clearing failed state for component NAL9602
2012-09-20T23:37:44.851Z,1348184264.851 [NAL9602] No Fault, FailCount= 1
2012-09-20T23:37:45.235Z,1348184265.236 [PAR_Licor](ERROR): PAR reading out of range: -0.022253 uMol/s/m2
2012-09-20T23:37:48.839Z,1348184268.839 [PAR_Licor](ERROR): PAR reading out of range: -0.001589 uMol/s/m2
2012-09-20T23:37:50.031Z,1348184270.031 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:38:00.835Z,1348184280.835 [NAL9602](ERROR): NAL9602 initialize error - Can't enter command mode:Copyright(c) 2010
NAL Research Corporation
2012-09-20T23:38:00.835Z,1348184280.835 [NAL9602] Communications Fault, FailCount= 2
2012-09-20T23:38:00.835Z,1348184280.835 [NAL9602](ERROR): Communications Fault
2012-09-20T23:38:00.857Z,1348184280.857 [CBIT](ERROR): Communications Fault in component: NAL9602
2012-09-20T23:38:00.858Z,1348184280.858 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2012-09-20T23:38:01.232Z,1348184281.232 [NAL9602](INFO): Powering down
2012-09-20T23:38:01.240Z,1348184281.240 [PAR_Licor](ERROR): PAR reading out of range: -0.058811 uMol/s/m2
2012-09-20T23:38:03.235Z,1348184283.235 [PAR_Licor](ERROR): PAR reading out of range: -0.039737 uMol/s/m2
2012-09-20T23:38:06.035Z,1348184286.035 [PAR_Licor](ERROR): PAR reading out of range: -0.020663 uMol/s/m2
2012-09-20T23:38:07.642Z,1348184287.642 [PAR_Licor](ERROR): PAR reading out of range: -0.027021 uMol/s/m2
2012-09-20T23:38:11.646Z,1348184291.645 [Startup:StartupSatComms:B](INFO): Timed out from 2012-09-20T23:37:11.2Z
2012-09-20T23:38:11.646Z,1348184291.646 [Startup:StartupSatComms:A_Timeout] Running Loop=1
2012-09-20T23:38:11.646Z,1348184291.646 [Startup:StartupSatComms:A_Timeout](INFO): Aggregate::initialize Startup:StartupSatComms:A_Timeout
2012-09-20T23:38:11.646Z,1348184291.646 [Startup:StartupSatComms:A_Timeout](INFO): Completed Startup:StartupSatComms:A_Timeout
2012-09-20T23:38:11.646Z,1348184291.646 [Startup:StartupSatComms:B] Stopped
2012-09-20T23:38:11.646Z,1348184291.647 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2012-09-20T23:38:11.646Z,1348184291.647 [Startup:StartupSatComms] Stopped
2012-09-20T23:38:11.647Z,1348184291.647 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms
2012-09-20T23:38:11.647Z,1348184291.648 [Startup](INFO): Completed Startup
2012-09-20T23:38:11.648Z,1348184291.648 [Startup] Stopped
2012-09-20T23:38:11.648Z,1348184291.648 [Startup](INFO): Aggregate::uninitialize Startup
2012-09-20T23:38:11.648Z,1348184291.648 [Startup:A.GoToSurface] Stopped
2012-09-20T23:38:11.648Z,1348184291.648 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T23:38:12.034Z,1348184292.034 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:38:12.041Z,1348184292.041 [MissionManager](IMPORTANT): Started mission Default
2012-09-20T23:38:12.041Z,1348184292.041 [Default] Running Loop=1
2012-09-20T23:38:12.042Z,1348184292.042 [Default](INFO): Aggregate::initialize Default
2012-09-20T23:38:12.042Z,1348184292.042 [Default:D.SetSpeed] Running Loop=1
2012-09-20T23:38:12.042Z,1348184292.042 [Default:D.SetSpeed](DEBUG): Initialize.
2012-09-20T23:38:12.042Z,1348184292.042 [Default:E.GoToSurface] Running Loop=1
2012-09-20T23:38:12.042Z,1348184292.042 [Default:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T23:38:12.043Z,1348184292.043 [Default:Iridium] Running Loop=1
2012-09-20T23:38:12.043Z,1348184292.043 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2012-09-20T23:38:12.043Z,1348184292.043 [Default:Iridium:A.SetSpeed] Running Loop=1
2012-09-20T23:38:12.043Z,1348184292.043 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2012-09-20T23:38:12.043Z,1348184292.043 [Default:Iridium:B.GoToSurface] Running Loop=1
2012-09-20T23:38:12.043Z,1348184292.043 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T23:38:12.044Z,1348184292.044 [Default:E.GoToSurface] Running Loop=1
2012-09-20T23:38:12.049Z,1348184292.049 [Default:D.SetSpeed] Running Loop=1
2012-09-20T23:38:12.054Z,1348184292.054 [Default:CallIridium] Running Loop=1
2012-09-20T23:38:12.054Z,1348184292.054 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2012-09-20T23:38:12.054Z,1348184292.054 [Default:CallIridium:A] Running Loop=1
2012-09-20T23:38:12.056Z,1348184292.056 [Default:CallIridium:A] Stopped
2012-09-20T23:38:12.056Z,1348184292.056 [Default:CallIridium:B] Running Loop=1
2012-09-20T23:38:12.056Z,1348184292.056 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2012-09-20T23:38:12.062Z,1348184292.062 [Default:Iridium:B.GoToSurface] Stopped
2012-09-20T23:38:12.062Z,1348184292.062 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T23:38:12.062Z,1348184292.062 [Default:Iridium:Read_Iridium] Running Loop=1
2012-09-20T23:38:12.062Z,1348184292.062 [Default:Iridium:A.SetSpeed] Running Loop=1
2012-09-20T23:38:12.067Z,1348184292.067 [Default:GPS] Running Loop=1
2012-09-20T23:38:12.067Z,1348184292.067 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2012-09-20T23:38:12.067Z,1348184292.067 [Default:GPS:A.SetSpeed] Running Loop=1
2012-09-20T23:38:12.067Z,1348184292.067 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2012-09-20T23:38:12.067Z,1348184292.067 [Default:GPS:B.GoToSurface] Running Loop=1
2012-09-20T23:38:12.067Z,1348184292.067 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2012-09-20T23:38:12.073Z,1348184292.073 [Default:GPS:B.GoToSurface] Stopped
2012-09-20T23:38:12.073Z,1348184292.073 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2012-09-20T23:38:12.073Z,1348184292.073 [Default:GPS:Read_GPS] Running Loop=1
2012-09-20T23:38:12.073Z,1348184292.073 [Default:GPS:A.SetSpeed] Running Loop=1
2012-09-20T23:38:12.448Z,1348184292.448 [Default:Iridium:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2012-09-20T23:38:12.451Z,1348184292.451 [Default:GPS:Read_GPS](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2012-09-20T23:38:13.638Z,1348184293.638 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:38:16.839Z,1348184296.839 [PAR_Licor](ERROR): PAR reading out of range: -0.014305 uMol/s/m2
2012-09-20T23:38:18.437Z,1348184298.437 [PAR_Licor](ERROR): PAR reading out of range: -0.038148 uMol/s/m2
2012-09-20T23:38:20.035Z,1348184300.035 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:38:21.235Z,1348184301.235 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:38:22.034Z,1348184302.034 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:38:23.640Z,1348184303.639 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:38:29.238Z,1348184309.238 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:38:30.437Z,1348184310.437 [PAR_Licor](ERROR): PAR reading out of range: -0.012716 uMol/s/m2
2012-09-20T23:38:31.235Z,1348184311.235 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:38:32.441Z,1348184312.441 [PAR_Licor](ERROR): PAR reading out of range: -0.042916 uMol/s/m2
2012-09-20T23:38:33.635Z,1348184313.635 [PAR_Licor](ERROR): PAR reading out of range: -0.027021 uMol/s/m2
2012-09-20T23:38:34.441Z,1348184314.441 [PAR_Licor](ERROR): PAR reading out of range: -0.073117 uMol/s/m2
2012-09-20T23:38:35.638Z,1348184315.638 [PAR_Licor](ERROR): PAR reading out of range: -0.012716 uMol/s/m2
2012-09-20T23:38:38.834Z,1348184318.834 [PAR_Licor](ERROR): PAR reading out of range: -0.022253 uMol/s/m2
2012-09-20T23:38:42.437Z,1348184322.437 [PAR_Licor](ERROR): PAR reading out of range: -0.001589 uMol/s/m2
2012-09-20T23:38:48.042Z,1348184328.042 [PAR_Licor](ERROR): PAR reading out of range: -0.039737 uMol/s/m2
2012-09-20T23:38:53.234Z,1348184333.234 [PAR_Licor](ERROR): PAR reading out of range: -0.014305 uMol/s/m2
2012-09-20T23:38:54.839Z,1348184334.839 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:38:56.035Z,1348184336.035 [PAR_Licor](ERROR): PAR reading out of range: -0.015895 uMol/s/m2
2012-09-20T23:38:59.234Z,1348184339.234 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:39:01.235Z,1348184341.234 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:39:02.438Z,1348184342.438 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:39:03.635Z,1348184343.635 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:39:04.835Z,1348184344.835 [PAR_Licor](ERROR): PAR reading out of range: 0.000000 uMol/s/m2
2012-09-20T23:39:06.835Z,1348184346.835 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:39:08.440Z,1348184348.440 [PAR_Licor](ERROR): PAR reading out of range: -0.046095 uMol/s/m2
2012-09-20T23:39:12.454Z,1348184352.454 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:39:13.243Z,1348184353.243 [PAR_Licor](ERROR): PAR reading out of range: -0.023842 uMol/s/m2
2012-09-20T23:39:14.440Z,1348184354.440 [PAR_Licor](ERROR): PAR reading out of range: -0.058811 uMol/s/m2
2012-09-20T23:39:15.235Z,1348184355.235 [PAR_Licor](ERROR): PAR reading out of range: -0.020663 uMol/s/m2
2012-09-20T23:39:17.234Z,1348184357.234 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:39:20.437Z,1348184360.437 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:39:22.441Z,1348184362.441 [PAR_Licor](ERROR): PAR reading out of range: 0.000000 uMol/s/m2
2012-09-20T23:39:23.234Z,1348184363.234 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:39:26.440Z,1348184366.440 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:39:32.441Z,1348184372.441 [PAR_Licor](ERROR): PAR reading out of range: -0.030200 uMol/s/m2
2012-09-20T23:39:33.235Z,1348184373.235 [PAR_Licor](ERROR): PAR reading out of range: -0.020663 uMol/s/m2
2012-09-20T23:39:34.441Z,1348184374.441 [PAR_Licor](ERROR): PAR reading out of range: -0.052453 uMol/s/m2
2012-09-20T23:39:36.437Z,1348184376.437 [PAR_Licor](ERROR): PAR reading out of range: 0.000000 uMol/s/m2
2012-09-20T23:39:37.238Z,1348184377.238 [PAR_Licor](ERROR): PAR reading out of range: -0.027021 uMol/s/m2
2012-09-20T23:39:38.834Z,1348184378.834 [PAR_Licor](ERROR): PAR reading out of range: -0.019074 uMol/s/m2
2012-09-20T23:39:39.635Z,1348184379.635 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:39:44.834Z,1348184384.834 [PAR_Licor](ERROR): PAR reading out of range: -0.030200 uMol/s/m2
2012-09-20T23:39:46.441Z,1348184386.441 [PAR_Licor](ERROR): PAR reading out of range: -0.012716 uMol/s/m2
2012-09-20T23:39:48.042Z,1348184388.042 [PAR_Licor](ERROR): PAR reading out of range: -0.025432 uMol/s/m2
2012-09-20T23:39:49.234Z,1348184389.234 [PAR_Licor](ERROR): PAR reading out of range: -0.020663 uMol/s/m2
2012-09-20T23:39:50.035Z,1348184390.035 [PAR_Licor](ERROR): PAR reading out of range: -0.071527 uMol/s/m2
2012-09-20T23:39:52.843Z,1348184392.843 [PAR_Licor](ERROR): PAR reading out of range: -0.039737 uMol/s/m2
2012-09-20T23:39:54.034Z,1348184394.034 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:40:00.437Z,1348184400.437 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:40:00.855Z,1348184400.855 [CBIT](INFO): Clearing failed count for component NAL9602
2012-09-20T23:40:00.855Z,1348184400.855 [NAL9602] No Fault, FailCount= 2
2012-09-20T23:40:01.229Z,1348184401.229 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:40:06.035Z,1348184406.035 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:40:07.235Z,1348184407.235 [PAR_Licor](ERROR): PAR reading out of range: -0.055632 uMol/s/m2
2012-09-20T23:40:08.437Z,1348184408.437 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:40:09.236Z,1348184409.236 [PAR_Licor](ERROR): PAR reading out of range: -0.063580 uMol/s/m2
2012-09-20T23:40:10.441Z,1348184410.441 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:40:11.635Z,1348184411.635 [NAL9602](ERROR): NAL9602 initialize error - Can't enter command mode:Copyright(c) 2010
NAL Research Corporation
2012-09-20T23:40:11.635Z,1348184411.635 [NAL9602] Communications Fault, FailCount= 1
2012-09-20T23:40:11.635Z,1348184411.635 [NAL9602](ERROR): Communications Fault
2012-09-20T23:40:11.659Z,1348184411.659 [CBIT](ERROR): Communications Fault in component: NAL9602
2012-09-20T23:40:12.036Z,1348184412.036 [NAL9602](INFO): Powering down
2012-09-20T23:40:12.060Z,1348184412.060 [CBIT](INFO): Clearing failed state for component NAL9602
2012-09-20T23:40:12.060Z,1348184412.060 [NAL9602] No Fault, FailCount= 1
2012-09-20T23:40:12.437Z,1348184412.437 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:40:13.635Z,1348184413.635 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:40:15.642Z,1348184415.642 [PAR_Licor](ERROR): PAR reading out of range: -0.034969 uMol/s/m2
2012-09-20T23:40:17.265Z,1348184417.265 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:40:17.639Z,1348184417.639 [PAR_Licor](ERROR): PAR reading out of range: -0.039737 uMol/s/m2
2012-09-20T23:40:19.235Z,1348184419.235 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:40:21.236Z,1348184421.236 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:40:22.441Z,1348184422.441 [PAR_Licor](ERROR): PAR reading out of range: -0.055632 uMol/s/m2
2012-09-20T23:40:26.437Z,1348184426.437 [PAR_Licor](ERROR): PAR reading out of range: -0.044506 uMol/s/m2
2012-09-20T23:40:28.031Z,1348184428.030 [NAL9602](ERROR): NAL9602 initialize error - Can't enter command mode:Copyright(c) 2010
NAL Research Corporation
2012-09-20T23:40:28.031Z,1348184428.031 [NAL9602] Communications Fault, FailCount= 2
2012-09-20T23:40:28.031Z,1348184428.031 [NAL9602](ERROR): Communications Fault
2012-09-20T23:40:28.053Z,1348184428.053 [CBIT](ERROR): Communications Fault in component: NAL9602
2012-09-20T23:40:28.054Z,1348184428.053 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2012-09-20T23:40:28.435Z,1348184428.435 [NAL9602](INFO): Powering down
2012-09-20T23:40:28.442Z,1348184428.443 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:40:30.836Z,1348184430.836 [PAR_Licor](ERROR): PAR reading out of range: -0.030200 uMol/s/m2
2012-09-20T23:40:34.034Z,1348184434.034 [PAR_Licor](ERROR): PAR reading out of range: -0.030200 uMol/s/m2
2012-09-20T23:40:41.234Z,1348184441.234 [PAR_Licor](ERROR): PAR reading out of range: -0.036558 uMol/s/m2
2012-09-20T23:40:44.442Z,1348184444.442 [PAR_Licor](ERROR): PAR reading out of range: -0.001589 uMol/s/m2
2012-09-20T23:40:46.842Z,1348184446.842 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:40:48.446Z,1348184448.446 [PAR_Licor](ERROR): PAR reading out of range: -0.007947 uMol/s/m2
2012-09-20T23:40:50.035Z,1348184450.035 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:40:52.834Z,1348184452.834 [PAR_Licor](ERROR): PAR reading out of range: 0.000000 uMol/s/m2
2012-09-20T23:40:59.235Z,1348184459.235 [PAR_Licor](ERROR): PAR reading out of range: -0.009537 uMol/s/m2
2012-09-20T23:41:01.239Z,1348184461.239 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:41:02.440Z,1348184462.440 [PAR_Licor](ERROR): PAR reading out of range: -0.028611 uMol/s/m2
2012-09-20T23:41:03.235Z,1348184463.235 [PAR_Licor](ERROR): PAR reading out of range: -0.039737 uMol/s/m2
2012-09-20T23:41:05.234Z,1348184465.234 [PAR_Licor](ERROR): PAR reading out of range: -0.014305 uMol/s/m2
2012-09-20T23:41:09.235Z,1348184469.235 [PAR_Licor](ERROR): PAR reading out of range: -0.023842 uMol/s/m2
2012-09-20T23:41:10.088Z,1348184470.088 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:41:13.634Z,1348184473.634 [PAR_Licor](ERROR): PAR reading out of range: -0.027021 uMol/s/m2
2012-09-20T23:41:18.437Z,1348184478.437 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:41:20.035Z,1348184480.035 [PAR_Licor](ERROR): PAR reading out of range: -0.058811 uMol/s/m2
2012-09-20T23:41:20.834Z,1348184480.834 [PAR_Licor](ERROR): PAR reading out of range: -0.034969 uMol/s/m2
2012-09-20T23:41:21.634Z,1348184481.634 [PAR_Licor](ERROR): PAR reading out of range: -0.046095 uMol/s/m2
2012-09-20T23:41:22.842Z,1348184482.842 [PAR_Licor](ERROR): PAR reading out of range: -0.034969 uMol/s/m2
2012-09-20T23:41:23.638Z,1348184483.638 [PAR_Licor](ERROR): PAR reading out of range: -0.015895 uMol/s/m2
2012-09-20T23:41:24.835Z,1348184484.835 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:41:26.442Z,1348184486.442 [PAR_Licor](ERROR): PAR reading out of range: -0.001589 uMol/s/m2
2012-09-20T23:41:27.634Z,1348184487.634 [PAR_Licor](ERROR): PAR reading out of range: -0.009537 uMol/s/m2
2012-09-20T23:41:28.441Z,1348184488.441 [PAR_Licor](ERROR): PAR reading out of range: -0.007947 uMol/s/m2
2012-09-20T23:41:29.234Z,1348184489.234 [PAR_Licor](ERROR): PAR reading out of range: -0.022253 uMol/s/m2
2012-09-20T23:41:30.437Z,1348184490.437 [PAR_Licor](ERROR): PAR reading out of range: -0.017484 uMol/s/m2
2012-09-20T23:41:31.634Z,1348184491.634 [PAR_Licor](ERROR): PAR reading out of range: -0.038148 uMol/s/m2
2012-09-20T23:41:32.437Z,1348184492.437 [PAR_Licor](ERROR): PAR reading out of range: -0.001589 uMol/s/m2
2012-09-20T23:41:33.235Z,1348184493.235 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:41:41.238Z,1348184501.238 [PAR_Licor](ERROR): PAR reading out of range: -0.007947 uMol/s/m2
2012-09-20T23:41:44.834Z,1348184504.834 [PAR_Licor](ERROR): PAR reading out of range: -0.025432 uMol/s/m2
2012-09-20T23:41:48.437Z,1348184508.437 [PAR_Licor](ERROR): PAR reading out of range: -0.034969 uMol/s/m2
2012-09-20T23:41:50.443Z,1348184510.443 [PAR_Licor](ERROR): PAR reading out of range: -0.025432 uMol/s/m2
2012-09-20T23:41:51.634Z,1348184511.634 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:41:52.835Z,1348184512.835 [PAR_Licor](ERROR): PAR reading out of range: -0.054043 uMol/s/m2
2012-09-20T23:41:54.437Z,1348184514.437 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:41:56.513Z,1348184516.513 [PAR_Licor](ERROR): PAR reading out of range: -0.044506 uMol/s/m2
2012-09-20T23:41:57.235Z,1348184517.235 [PAR_Licor](ERROR): PAR reading out of range: -0.014305 uMol/s/m2
2012-09-20T23:41:59.639Z,1348184519.639 [PAR_Licor](ERROR): PAR reading out of range: -0.052453 uMol/s/m2
2012-09-20T23:42:03.235Z,1348184523.235 [PAR_Licor](ERROR): PAR reading out of range: -0.042916 uMol/s/m2
2012-09-20T23:42:04.441Z,1348184524.441 [PAR_Licor](ERROR): PAR reading out of range: -0.057222 uMol/s/m2
2012-09-20T23:42:06.046Z,1348184526.046 [PAR_Licor](ERROR): PAR reading out of range: -0.071527 uMol/s/m2
2012-09-20T23:42:07.634Z,1348184527.634 [PAR_Licor](ERROR): PAR reading out of range: -0.030200 uMol/s/m2
2012-09-20T23:42:13.634Z,1348184533.634 [PAR_Licor](ERROR): PAR reading out of range: -0.028611 uMol/s/m2
2012-09-20T23:42:16.835Z,1348184536.835 [PAR_Licor](ERROR): PAR reading out of range: -0.028611 uMol/s/m2
2012-09-20T23:42:17.638Z,1348184537.638 [PAR_Licor](ERROR): PAR reading out of range: -0.012716 uMol/s/m2
2012-09-20T23:42:19.235Z,1348184539.235 [PAR_Licor](ERROR): PAR reading out of range: -0.066759 uMol/s/m2
2012-09-20T23:42:20.035Z,1348184540.035 [PAR_Licor](ERROR): PAR reading out of range: -0.036558 uMol/s/m2
2012-09-20T23:42:21.263Z,1348184541.263 [PAR_Licor](ERROR): PAR reading out of range: -0.019074 uMol/s/m2
2012-09-20T23:42:26.035Z,1348184546.035 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:42:27.639Z,1348184547.639 [PAR_Licor](ERROR): PAR reading out of range: -0.012716 uMol/s/m2
2012-09-20T23:42:28.051Z,1348184548.050 [CBIT](INFO): Clearing failed count for component NAL9602
2012-09-20T23:42:28.051Z,1348184548.051 [NAL9602] No Fault, FailCount= 2
2012-09-20T23:42:28.430Z,1348184548.430 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:42:30.035Z,1348184550.035 [PAR_Licor](ERROR): PAR reading out of range: -0.034969 uMol/s/m2
2012-09-20T23:42:31.635Z,1348184551.635 [PAR_Licor](ERROR): PAR reading out of range: -0.060401 uMol/s/m2
2012-09-20T23:42:33.235Z,1348184553.235 [PAR_Licor](ERROR): PAR reading out of range: -0.001589 uMol/s/m2
2012-09-20T23:42:34.836Z,1348184554.836 [PAR_Licor](ERROR): PAR reading out of range: -0.054043 uMol/s/m2
2012-09-20T23:42:36.035Z,1348184556.035 [PAR_Licor](ERROR): PAR reading out of range: -0.046095 uMol/s/m2
2012-09-20T23:42:38.831Z,1348184558.831 [NAL9602](ERROR): NAL9602 initialize error - Can't enter command mode:Copyright(c) 2010
NAL Research Corporation
2012-09-20T23:42:38.831Z,1348184558.831 [NAL9602] Communications Fault, FailCount= 1
2012-09-20T23:42:38.831Z,1348184558.831 [NAL9602](ERROR): Communications Fault
2012-09-20T23:42:38.854Z,1348184558.855 [CBIT](ERROR): Communications Fault in component: NAL9602
2012-09-20T23:42:39.232Z,1348184559.232 [NAL9602](INFO): Powering down
2012-09-20T23:42:39.240Z,1348184559.240 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:42:39.257Z,1348184559.257 [CBIT](INFO): Clearing failed state for component NAL9602
2012-09-20T23:42:39.257Z,1348184559.257 [NAL9602] No Fault, FailCount= 1
2012-09-20T23:42:44.430Z,1348184564.430 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:42:48.437Z,1348184568.437 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:42:50.036Z,1348184570.036 [PAR_Licor](ERROR): PAR reading out of range: -0.058811 uMol/s/m2
2012-09-20T23:42:52.441Z,1348184572.441 [PAR_Licor](ERROR): PAR reading out of range: -0.025432 uMol/s/m2
2012-09-20T23:42:53.235Z,1348184573.235 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:42:55.231Z,1348184575.231 [NAL9602](ERROR): NAL9602 initialize error - Can't enter command mode:Copyright(c) 2010
NAL Research Corporation
2012-09-20T23:42:55.231Z,1348184575.231 [NAL9602] Communications Fault, FailCount= 2
2012-09-20T23:42:55.231Z,1348184575.231 [NAL9602](ERROR): Communications Fault
2012-09-20T23:42:55.238Z,1348184575.238 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:42:55.255Z,1348184575.255 [CBIT](ERROR): Communications Fault in component: NAL9602
2012-09-20T23:42:55.255Z,1348184575.255 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2012-09-20T23:42:55.629Z,1348184575.629 [NAL9602](INFO): Powering down
2012-09-20T23:42:58.035Z,1348184578.035 [PAR_Licor](ERROR): PAR reading out of range: -0.019074 uMol/s/m2
2012-09-20T23:42:59.638Z,1348184579.638 [PAR_Licor](ERROR): PAR reading out of range: -0.047685 uMol/s/m2
2012-09-20T23:43:00.839Z,1348184580.839 [PAR_Licor](ERROR): PAR reading out of range: -0.030200 uMol/s/m2
2012-09-20T23:43:02.835Z,1348184582.835 [PAR_Licor](ERROR): PAR reading out of range: -0.055632 uMol/s/m2
2012-09-20T23:43:04.835Z,1348184584.835 [PAR_Licor](ERROR): PAR reading out of range: -0.007947 uMol/s/m2
2012-09-20T23:43:05.639Z,1348184585.639 [PAR_Licor](ERROR): PAR reading out of range: -0.020663 uMol/s/m2
2012-09-20T23:43:06.437Z,1348184586.437 [PAR_Licor](ERROR): PAR reading out of range: 0.000000 uMol/s/m2
2012-09-20T23:43:08.836Z,1348184588.836 [PAR_Licor](ERROR): PAR reading out of range: -0.014305 uMol/s/m2
2012-09-20T23:43:10.835Z,1348184590.835 [PAR_Licor](ERROR): PAR reading out of range: -0.028611 uMol/s/m2
2012-09-20T23:43:13.635Z,1348184593.635 [PAR_Licor](ERROR): PAR reading out of range: -0.046095 uMol/s/m2
2012-09-20T23:43:14.835Z,1348184594.835 [PAR_Licor](ERROR): PAR reading out of range: -0.019074 uMol/s/m2
2012-09-20T23:43:15.635Z,1348184595.635 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:43:16.441Z,1348184596.441 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:43:18.035Z,1348184598.035 [PAR_Licor](ERROR): PAR reading out of range: -0.058811 uMol/s/m2
2012-09-20T23:43:27.635Z,1348184607.635 [PAR_Licor](ERROR): PAR reading out of range: -0.033379 uMol/s/m2
2012-09-20T23:43:28.836Z,1348184608.836 [PAR_Licor](ERROR): PAR reading out of range: -0.028611 uMol/s/m2
2012-09-20T23:43:31.235Z,1348184611.235 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:43:33.635Z,1348184613.635 [PAR_Licor](ERROR): PAR reading out of range: -0.031790 uMol/s/m2
2012-09-20T23:43:35.639Z,1348184615.639 [PAR_Licor](ERROR): PAR reading out of range: -0.009537 uMol/s/m2
2012-09-20T23:43:36.438Z,1348184616.438 [PAR_Licor](ERROR): PAR reading out of range: -0.066759 uMol/s/m2
2012-09-20T23:43:38.036Z,1348184618.036 [PAR_Licor](ERROR): PAR reading out of range: -0.006358 uMol/s/m2
2012-09-20T23:43:40.035Z,1348184620.035 [PAR_Licor](ERROR): PAR reading out of range: -0.025432 uMol/s/m2
2012-09-20T23:43:41.235Z,1348184621.235 [PAR_Licor](ERROR): PAR reading out of range: -0.009537 uMol/s/m2
2012-09-20T23:43:45.236Z,1348184625.236 [PAR_Licor](ERROR): PAR reading out of range: -0.038148 uMol/s/m2
2012-09-20T23:43:46.835Z,1348184626.835 [PAR_Licor](ERROR): PAR reading out of range: -0.009537 uMol/s/m2
2012-09-20T23:43:48.036Z,1348184628.036 [PAR_Licor](ERROR): PAR reading out of range: -0.030200 uMol/s/m2
2012-09-20T23:43:49.235Z,1348184629.235 [PAR_Licor](ERROR): PAR reading out of range: -0.001589 uMol/s/m2
2012-09-20T23:43:51.236Z,1348184631.236 [PAR_Licor](ERROR): PAR reading out of range: 0.000000 uMol/s/m2
2012-09-20T23:43:52.441Z,1348184632.441 [PAR_Licor](ERROR): PAR reading out of range: -0.015895 uMol/s/m2
2012-09-20T23:43:54.438Z,1348184634.438 [PAR_Licor](ERROR): PAR reading out of range: -0.022253 uMol/s/m2
2012-09-20T23:43:56.838Z,1348184636.838 [PAR_Licor](ERROR): PAR reading out of range: -0.020663 uMol/s/m2
2012-09-20T23:43:58.036Z,1348184638.036 [PAR_Licor](ERROR): PAR reading out of range: -0.023842 uMol/s/m2
2012-09-20T23:44:04.036Z,1348184644.036 [PAR_Licor](ERROR): PAR reading out of range: -0.038148 uMol/s/m2
2012-09-20T23:44:08.438Z,1348184648.438 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:44:13.235Z,1348184653.236 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:44:16.441Z,1348184656.441 [PAR_Licor](ERROR): PAR reading out of range: -0.038148 uMol/s/m2
2012-09-20T23:44:18.035Z,1348184658.035 [PAR_Licor](ERROR): PAR reading out of range: -0.014305 uMol/s/m2
2012-09-20T23:44:20.836Z,1348184660.836 [PAR_Licor](ERROR): PAR reading out of range: -0.011126 uMol/s/m2
2012-09-20T23:44:21.636Z,1348184661.635 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:44:22.441Z,1348184662.441 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:44:23.639Z,1348184663.639 [PAR_Licor](ERROR): PAR reading out of range: -0.019074 uMol/s/m2
2012-09-20T23:44:25.236Z,1348184665.236 [PAR_Licor](ERROR): PAR reading out of range: -0.022253 uMol/s/m2
2012-09-20T23:44:26.037Z,1348184666.037 [PAR_Licor](ERROR): PAR reading out of range: -0.003179 uMol/s/m2
2012-09-20T23:44:27.237Z,1348184667.237 [PAR_Licor](ERROR): PAR reading out of range: -0.036558 uMol/s/m2
2012-09-20T23:44:28.836Z,1348184668.836 [PAR_Licor](ERROR): PAR reading out of range: -0.038148 uMol/s/m2
2012-09-20T23:44:30.038Z,1348184670.039 [PAR_Licor](ERROR): PAR reading out of range: -0.014305 uMol/s/m2
2012-09-20T23:44:31.235Z,1348184671.235 [PAR_Licor](ERROR): PAR reading out of range: -0.009537 uMol/s/m2
2012-09-20T23:44:33.240Z,1348184673.240 [PAR_Licor](ERROR): PAR reading out of range: -0.052453 uMol/s/m2
2012-09-20T23:44:38.836Z,1348184678.836 [PAR_Licor](ERROR): PAR reading out of range: 0.000000 uMol/s/m2
2012-09-20T23:44:41.236Z,1348184681.236 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:44:52.836Z,1348184692.836 [PAR_Licor](ERROR): PAR reading out of range: -0.004768 uMol/s/m2
2012-09-20T23:44:54.438Z,1348184694.438 [PAR_Licor](ERROR): PAR reading out of range: -0.046095 uMol/s/m2
2012-09-20T23:44:55.235Z,1348184695.235 [PAR_Licor](ERROR): PAR reading out of range: -0.049274 uMol/s/m2
2012-09-20T23:44:55.252Z,1348184695.252 [CBIT](INFO): Clearing failed count for component NAL9602
2012-09-20T23:44:55.252Z,1348184695.253 [NAL9602] No Fault, FailCount= 2
2012-09-20T23:44:55.630Z,1348184695.630 [NAL9602](INFO): Powering up NAL9602
2012-09-20T23:44:56.438Z,1348184696.438 [PAR_Licor](ERROR): PAR reading out of range: -0.093780 uMol/s/m2