Log opened at Wed, Jan 28 2015 01:25:17 UTC (actual time)
Current log level is Verbose
Scheduler version 3.5.3
Multi-user license: Arne Henden
28-Jan-2015 01:25:17.6: Simulated clock initialized at 28-Jan-2015 01:25:17 UTC
28-Jan-2015 01:25:17.6: Loaded Constraint plugin AirMass
28-Jan-2015 01:25:17.6: Loaded Constraint plugin AirmassRange
28-Jan-2015 01:25:17.6: Loaded Constraint plugin Horizon
28-Jan-2015 01:25:17.6: Loaded Constraint plugin HourAngle
28-Jan-2015 01:25:17.6: Loaded Constraint plugin MoonAvoid
28-Jan-2015 01:25:17.6: Loaded Constraint plugin MoonDown
28-Jan-2015 01:25:17.6: Loaded Constraint plugin SkyCondition
28-Jan-2015 01:25:17.6: Loaded Constraint plugin TimeRange
28-Jan-2015 01:25:18.2: 103 plans are now pending.
28-Jan-2015 01:25:18.2: Attach ACP sequencer
28-Jan-2015 01:25:43.0: Weather successfully connected. Wait for valid data...
28-Jan-2015 01:26:35.9: Dispatcher started at 28-Jan-2015 01:26:35 UTC
28-Jan-2015 01:26:35.9:     Priority:          W[0]=1.00
28-Jan-2015 01:26:35.9:     Transit Altitude:  W[1]=0.70
28-Jan-2015 01:26:35.9:     Highest Altitude:  W[6]=0.00
28-Jan-2015 01:26:35.9:     Lateness:          W[5]=0.00
28-Jan-2015 01:26:35.9:     Slew Distance:     W[2]=0.30
28-Jan-2015 01:26:35.9:     Retry Count:       W[3]=0.20
28-Jan-2015 01:26:35.9:     Meridian Crossing: W[4]=0.30
28-Jan-2015 01:26:35.9:     Obs Conditions:    W[7]=0.40
28-Jan-2015 01:26:35.9:     Rising Plan Delay: disabled
28-Jan-2015 01:26:38.8: ++ Observatory Startup ++
28-Jan-2015 01:26:38.8: Start ACP Sequencer's StartupObs script
28-Jan-2015 01:27:12.0: Open the observatory dome/roof
28-Jan-2015 01:31:00.5: Plan CB_32 has Monitor Mode. Time to resubmit it.
28-Jan-2015 01:31:00.5: Plan KT_Eri has Monitor Mode. Time to resubmit it.
28-Jan-2015 01:31:00.5: Plan SDSS073224 has Monitor Mode. Time to resubmit it.
28-Jan-2015 01:31:01.4: Dispatcher cycle time: 2.8080049 sec.
28-Jan-2015 01:31:01.4: Acquire data for Observation SDSS073224...
28-Jan-2015 01:31:01.4:   (belongs to Project AGN, Plan SDSS073224)
28-Jan-2015 01:31:01.4: Send Observation SDSS073224 to ACP Sequencer
28-Jan-2015 01:31:10.6: Dispatcher stopped at 28-Jan-2015 01:31:10 UTC
28-Jan-2015 01:31:10.6: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
28-Jan-2015 01:31:19.4: ** Sequencer script "AcquireScheduler" failed:
28-Jan-2015 01:31:19.4: **Script Error**
Source:  ACP
Message: The script was aborted. at line 870 column 9.
Script Context:
     867:         ' OBS.PA doesn't change regardless of target type.
     868:         '
     869:         slewDist = StartSlewToTarget(True)                          ' Handles various target types
=>   870:         Call SUP.WaitForSlew()                                      ' Wait for the slew to complete.
                  ^
     871:         If SUP.HaveRotator Then SUP.WaitForRotator                  ' And for rotator slew
     872:     Else
     873:         slewDist = StartSlewToTarget(False)                         ' Kludge for simulator and no slew
-- end --

28-Jan-2015 01:31:22.4: RUN FAILED: Scheduler was stopped during run
28-Jan-2015 01:31:22.4: ACP data acquisition failed for Observation SDSS073224.
28-Jan-2015 01:31:22.4:   (Observation SDSS073224 interrupted by operator or system.)
28-Jan-2015 01:37:57.8: **EXCEPTION IN SCHEDULER:
28-Jan-2015 01:37:57.8: ConnectWeather() waited for over 5 seconds to read Weather.Available!
28-Jan-2015 01:37:57.8: Traceback:
   at DC3.Scheduler.ACPSequencer.ConnectWeather()
   at DC3.Scheduler.Engine.PollWeather()
   at DC3.Scheduler.Engine.Run()
28-Jan-2015 01:37:57.9: Run statistics:
28-Jan-2015 01:37:57.9:   Observations:   126
28-Jan-2015 01:37:57.9:   Considered:     26
28-Jan-2015 01:37:57.9:   Completed:      0
28-Jan-2015 01:37:57.9:   Skipped:        23
28-Jan-2015 01:37:57.9:   Never Eligible: 100
28-Jan-2015 01:37:57.9:   Failed:         3
28-Jan-2015 01:37:57.9: Shutter-Open efficiency: 0.00%
28-Jan-2015 01:37:57.9: Overall Efficiency: 88.04%
28-Jan-2015 01:37:57.9: Release ACP sequencer
28-Jan-2015 01:37:57.9: Failed to stop sequencer:
28-Jan-2015 01:37:57.9: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA)
Log closed at Wed, Jan 28 2015 01:37:59 UTC (actual time)