Log opened at Sat, Jan 24 2015 03:35:15 UTC (actual time)
Current log level is Verbose
Scheduler version 3.5.3
Multi-user license: Arne Henden
24-Jan-2015 03:35:15.7: Simulated clock initialized at 24-Jan-2015 03:35:15 UTC
24-Jan-2015 03:35:15.7: Loaded Constraint plugin AirMass
24-Jan-2015 03:35:15.7: Loaded Constraint plugin AirmassRange
24-Jan-2015 03:35:15.7: Loaded Constraint plugin Horizon
24-Jan-2015 03:35:15.8: Loaded Constraint plugin HourAngle
24-Jan-2015 03:35:15.8: Loaded Constraint plugin MoonAvoid
24-Jan-2015 03:35:15.8: Loaded Constraint plugin MoonDown
24-Jan-2015 03:35:15.8: Loaded Constraint plugin SkyCondition
24-Jan-2015 03:35:15.8: Loaded Constraint plugin TimeRange
24-Jan-2015 03:35:16.3: 78 plans are now pending.
24-Jan-2015 03:35:16.3: Attach ACP sequencer
24-Jan-2015 03:35:23.5: Dispatcher started at 24-Jan-2015 03:35:23 UTC
24-Jan-2015 03:35:23.5:     Priority:          W[0]=1.00
24-Jan-2015 03:35:23.5:     Transit Altitude:  W[1]=0.70
24-Jan-2015 03:35:23.5:     Highest Altitude:  W[6]=0.00
24-Jan-2015 03:35:23.5:     Lateness:          W[5]=0.00
24-Jan-2015 03:35:23.5:     Slew Distance:     W[2]=0.30
24-Jan-2015 03:35:23.5:     Retry Count:       W[3]=0.20
24-Jan-2015 03:35:23.5:     Meridian Crossing: W[4]=0.30
24-Jan-2015 03:35:23.5:     Obs Conditions:    W[7]=0.40
24-Jan-2015 03:35:23.5:     Rising Plan Delay: disabled
24-Jan-2015 03:35:38.5: Weather successfully connected. Wait for valid data...
24-Jan-2015 03:35:45.7: ++ Observatory Startup ++
24-Jan-2015 03:35:45.7: Start ACP Sequencer's StartupObs script
24-Jan-2015 03:36:04.8: ++ Auto Focus ++
24-Jan-2015 03:36:04.8: Doing initial autofocus.
24-Jan-2015 03:36:04.8: Start special ACP AutoFocus script for scheduler
24-Jan-2015 03:38:18.5: Next periodic autofocus ASAP after 24-Jan-2015 05:38:00 UTC
24-Jan-2015 03:38:21.6: Plan V0809_Cep has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan V0959_Mon has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan MP_Gem has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan 2MASS_23275353+5214532 has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan IC_348 has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan KH_15D has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan V1184_Tau has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan CB_32 has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan NGC_2438 has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan V1404_Cyg has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan V0965_Per has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan KT_Eri has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan SDSS073224 has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan S_Lyn has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan S_Ori has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan ST_Aur has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan SV_And has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan SY_CMa has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan T_CMi has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan TT_Mon has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan VV_Gem has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan WX_CMi has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan Z_Tau has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan NGC_2419 has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan NGC_7790 has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan T_Ori has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:21.6: Plan V838_Mon has Monitor Mode. Time to resubmit it.
24-Jan-2015 03:38:22.5: Dispatcher cycle time: 2.0280035 sec.
24-Jan-2015 03:38:22.5: Acquire data for Observation SDSS073224...
24-Jan-2015 03:38:22.5:   (belongs to Project AGN, Plan SDSS073224)
24-Jan-2015 03:38:22.5: Send Observation SDSS073224 to ACP Sequencer
24-Jan-2015 03:52:06.5: ** Sequencer script "AcquireScheduler" failed:
24-Jan-2015 03:52:06.5: **Script Error**
Source:  ACP
Message: The script was aborted. at line 1531 column 5.
Script Context:
    1528:         End If
    1529:     End If
    1530:     
=>  1531:     If Not SUP.AutoGuide(True) Then
              ^
    1532:         If Not IMG Is Nothing Then
    1533:             If IMG.ExposureInterval > Prefs.AutoGuiding.MaxUnguidedExposureInterval Then
    1534:                 If STRICT_AUTOGUIDING And Not PLN.BestEfforts Then
-- end --

24-Jan-2015 03:52:09.6: ACP OPERATOR ABORT: The operator killed the run
24-Jan-2015 03:52:09.6: ACP data acquisition failed for Observation SDSS073224.
24-Jan-2015 03:52:09.6:   (Observation SDSS073224 interrupted by acquisition process failure.)
24-Jan-2015 03:52:11.5: Dispatcher cycle time: 0.6240011 sec.
24-Jan-2015 03:52:11.5: Acquire data for Observation CB_32...
24-Jan-2015 03:52:11.5:   (belongs to Project Staels, Plan CB_32)
24-Jan-2015 03:52:11.5: Send Observation CB_32 to ACP Sequencer
24-Jan-2015 03:52:20.4: Dispatcher stopped at 24-Jan-2015 03:52:20 UTC
24-Jan-2015 03:52:20.4: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
24-Jan-2015 03:52:28.8: ** Sequencer script "AcquireScheduler" failed:
24-Jan-2015 03:52:28.8: **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 --

24-Jan-2015 03:52:31.9: RUN FAILED: Scheduler was stopped during run
24-Jan-2015 03:52:31.9: ACP data acquisition failed for Observation CB_32.
24-Jan-2015 03:52:31.9:   (Observation CB_32 interrupted by operator or system.)
24-Jan-2015 04:06:27.0: Dispatcher started at 24-Jan-2015 04:06:27 UTC
24-Jan-2015 04:06:27.0:     Priority:          W[0]=1.00
24-Jan-2015 04:06:27.0:     Transit Altitude:  W[1]=0.70
24-Jan-2015 04:06:27.0:     Highest Altitude:  W[6]=0.00
24-Jan-2015 04:06:27.0:     Lateness:          W[5]=0.00
24-Jan-2015 04:06:27.0:     Slew Distance:     W[2]=0.30
24-Jan-2015 04:06:27.0:     Retry Count:       W[3]=0.20
24-Jan-2015 04:06:27.0:     Meridian Crossing: W[4]=0.30
24-Jan-2015 04:06:27.0:     Obs Conditions:    W[7]=0.40
24-Jan-2015 04:06:27.0:     Rising Plan Delay: disabled
24-Jan-2015 04:06:31.9: ++ Observatory Startup ++
24-Jan-2015 04:06:31.9: Start ACP Sequencer's StartupObs script
24-Jan-2015 04:06:51.6: ++ Auto Focus ++
24-Jan-2015 04:06:51.6: Doing initial autofocus.
24-Jan-2015 04:06:51.6: Start special ACP AutoFocus script for scheduler
24-Jan-2015 04:09:16.1: Next periodic autofocus ASAP after 24-Jan-2015 06:08:58 UTC
24-Jan-2015 04:09:18.3: Dispatcher cycle time: 0.2964005 sec.
24-Jan-2015 04:09:18.3: Acquire data for Observation KT_Eri...
24-Jan-2015 04:09:18.3:   (belongs to Project Nova_Monitoring, Plan KT_Eri)
24-Jan-2015 04:09:18.3: Send Observation KT_Eri to ACP Sequencer
24-Jan-2015 04:36:53.7: Dispatcher stopped at 24-Jan-2015 04:36:53 UTC
24-Jan-2015 04:36:53.7: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
24-Jan-2015 04:37:04.1: RUN FAILED: Scheduler was stopped during run
24-Jan-2015 04:37:04.1: ACP data acquisition failed for Observation KT_Eri.
24-Jan-2015 04:37:04.1:   (Observation KT_Eri interrupted by operator or system.)
24-Jan-2015 08:55:06.7: -- Weather Unsafe --
24-Jan-2015 09:16:23.3: ++ Weather Safe ++
24-Jan-2015 12:18:37.7: -- Weather Unsafe --
24-Jan-2015 12:42:02.9: ++ Weather Safe ++
24-Jan-2015 13:10:09.1: -- Weather Unsafe --
24-Jan-2015 13:31:09.3: ++ Weather Safe ++
24-Jan-2015 21:43:15.2: Requested shutdown of scheduler
24-Jan-2015 21:43:15.3: Run statistics:
24-Jan-2015 21:43:15.3:   Observations:   126
24-Jan-2015 21:43:15.3:   Considered:     29
24-Jan-2015 21:43:15.3:   Completed:      0
24-Jan-2015 21:43:15.3:   Skipped:        24
24-Jan-2015 21:43:15.3:   Never Eligible: 97
24-Jan-2015 21:43:15.3:   Failed:         5
24-Jan-2015 21:43:15.3: Shutter-Open efficiency: 0.00%
24-Jan-2015 21:43:15.3: Overall Efficiency: 99.88%
24-Jan-2015 21:43:15.3: Release ACP sequencer
Log closed at Sat, Jan 24 2015 21:43:16 UTC (actual time)