Log opened at Tue, Nov 06 2018 08:02:09 UTC (actual time)
Current log level is Verbose
ACP Expert Scheduler version 8.1.1
Full license: Arne Henden
2018-11-06 08:02:09.6: Internal clock initialized at 06-Nov-2018 08:02:09 UTC
2018-11-06 08:02:09.7: Loaded Constraint plugin AirMass
2018-11-06 08:02:09.7: Loaded Constraint plugin AirmassRange
2018-11-06 08:02:09.7: Loaded Constraint plugin Horizon
2018-11-06 08:02:09.7: Loaded Constraint plugin HourAngle
2018-11-06 08:02:09.7: Loaded Constraint plugin MoonAvoid
2018-11-06 08:02:09.7: Loaded Constraint plugin MoonDown
2018-11-06 08:02:09.7: Loaded Constraint plugin SkyCondition
2018-11-06 08:02:09.7: Loaded Constraint plugin TimeRange
2018-11-06 08:02:10.6: 23 plans are now pending.
2018-11-06 08:02:10.6: Attach ACP sequencer
2018-11-06 08:02:17.0: ++ Weather Safe ++
2018-11-06 08:02:18.6: Sequencer does sky flats
2018-11-06 08:02:38.5: Dispatcher started at 06-Nov-2018 08:02:38 UTC
2018-11-06 08:02:40.1: ++ Observatory Startup ++
2018-11-06 08:02:40.1: Start ACP Sequencer's StartupObs script
2018-11-06 08:02:40.1: Starting with open dome, unsafe weather will cause operator intervention error
2018-11-06 08:02:57.9: Observatory startup succeeded
2018-11-06 08:02:59.2: ++ Auto Focus ++
2018-11-06 08:02:59.2: Doing initial autofocus.
2018-11-06 08:02:59.2: Start special ACP AutoFocus script for scheduler
2018-11-06 08:06:02.6: Next periodic autofocus ASAP after 06-Nov-2018 11:05:49 UTC
2018-11-06 08:06:04.5: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan CB_32 has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan GSC_4030_204 has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V0809_Cep has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V0965_Per has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V1722_Aql has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V1721_Aql has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan NGC_7790 has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan T_Ori has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan U_Aqr has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V339_Del_TMO61 has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan HQ_Aur has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan HX_Aur has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan FU_Cam has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan FW_Cam has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan FY_Cam has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan HI_Cam has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan HO_Cam has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan CM_Cas has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V0524_Cas has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V1904_Cyg has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V1907_Cyg has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan V2481_Cyg has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.5: Plan BC_Lac has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.6: Plan WZ_Per has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.6: Plan V0603_Per has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.6: Plan Mkn_501 has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.6: Plan AF_And has Monitor Mode. Time to resubmit it.
2018-11-06 08:06:04.6: Rising plan delay enabled for Plan CB_32:
2018-11-06 08:06:04.6:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.6:     267 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.6:     but only 95 min till mid-Plan transit.
2018-11-06 08:06:04.6:     deferred (rising) for 95 min, until 06-Nov-2018 09:41:18 UTC
2018-11-06 08:06:04.7: Rising plan delay enabled for Plan DN_Lyn:
2018-11-06 08:06:04.7:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.7:     250 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.7:     but only 201 min till mid-Plan transit.
2018-11-06 08:06:04.7:     deferred (rising) for 199 min, until 06-Nov-2018 11:25:57 UTC
2018-11-06 08:06:04.7: Rising plan delay enabled for Plan HI_Cam:
2018-11-06 08:06:04.7:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.7:     267 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.7:     but only 34 min till mid-Plan transit.
2018-11-06 08:06:04.7:     deferred (rising) for 34 min, until 06-Nov-2018 08:40:43 UTC
2018-11-06 08:06:04.7: Rising plan delay enabled for Plan HO_Cam:
2018-11-06 08:06:04.7:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.7:     267 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.7:     but only 71 min till mid-Plan transit.
2018-11-06 08:06:04.7:     deferred (rising) for 71 min, until 06-Nov-2018 09:17:45 UTC
2018-11-06 08:06:04.7: Rising plan delay enabled for Plan HQ_Aur:
2018-11-06 08:06:04.7:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.7:     267 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.7:     but only 88 min till mid-Plan transit.
2018-11-06 08:06:04.7:     deferred (rising) for 88 min, until 06-Nov-2018 09:34:44 UTC
2018-11-06 08:06:04.7: Rising plan delay enabled for Plan HX_Aur:
2018-11-06 08:06:04.7:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.7:     267 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.7:     but only 61 min till mid-Plan transit.
2018-11-06 08:06:04.8:     deferred (rising) for 61 min, until 06-Nov-2018 09:07:34 UTC
2018-11-06 08:06:04.8: Plan KH15D couldn't be run before latest time, failed.
2018-11-06 08:06:04.8: Rising plan delay enabled for Plan MP_Gem:
2018-11-06 08:06:04.8:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.8:     233 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.8:     but only 149 min till mid-Plan transit.
2018-11-06 08:06:04.8:     deferred (rising) for 146 min, until 06-Nov-2018 10:32:37 UTC
2018-11-06 08:06:04.8: Rising plan delay enabled for Plan QZ_Aur:
2018-11-06 08:06:04.8:     378 min. remaining to meet strict constraints.
2018-11-06 08:06:04.8:     232 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.8:     but only 69 min till mid-Plan transit.
2018-11-06 08:06:04.8:     deferred (rising) for 65 min, until 06-Nov-2018 09:12:03 UTC
2018-11-06 08:06:04.8: Rising plan delay enabled for Plan SDSS073224:
2018-11-06 08:06:04.8:     490 min. remaining to meet strict constraints.
2018-11-06 08:06:04.8:     223 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.8:     but only 188 min till mid-Plan transit.
2018-11-06 08:06:04.8:     deferred (rising) for 184 min, until 06-Nov-2018 11:10:33 UTC
2018-11-06 08:06:04.9: Rising plan delay enabled for Plan T_Ori:
2018-11-06 08:06:04.9:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.9:     267 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.9:     but only 94 min till mid-Plan transit.
2018-11-06 08:06:04.9:     deferred (rising) for 94 min, until 06-Nov-2018 09:40:38 UTC
2018-11-06 08:06:04.9: Rising plan delay enabled for Plan V0959_Mon:
2018-11-06 08:06:04.9:     242 min. remaining to meet strict constraints.
2018-11-06 08:06:04.9:     251 min. remaining for the plan to fit before dawn.
2018-11-06 08:06:04.9:     but only 150 min till mid-Plan transit.
2018-11-06 08:06:04.9:     deferred (rising) for 148 min, until 06-Nov-2018 10:34:38 UTC
2018-11-06 08:06:05.1: Dispatcher cycle time: 1.1 sec.
2018-11-06 08:06:05.1: Acquire data for Observation AF_And...
2018-11-06 08:06:05.1:   (belongs to Project AAVSO_UIS01_AF_And, Plan AF_And)
2018-11-06 08:06:05.7: Send Observation AF_And to ACP Sequencer
2018-11-06 08:08:20.7: ** ACP script "AcquireScheduler" failed:
2018-11-06 08:08:20.7: **Script Error (Tracking has been stopped)**
Source:   ACP
Message:  The script was aborted.
Location: line 1377 column 13.

2018-11-06 08:08:23.8: ACP OPERATOR ABORT: The operator killed the run
2018-11-06 08:08:23.8: ACP data acquisition failed for Observation AF_And.
2018-11-06 08:08:23.8:   (Observation AF_And interrupted by acquisition process failure.)
2018-11-06 08:08:24.0: -- Weather Unsafe --
2018-11-06 12:48:32.0: Skipping dawn sky flats because the weather was unsafe at sky-flat time
2018-11-06 12:49:02.5: -- Observatory Shutdown --
2018-11-06 12:49:02.6: Start ACP Sequencer's ShutdownObs script
2018-11-06 15:19:48.9: Dispatcher stopped at 06-Nov-2018 15:19:48 UTC
2018-11-06 15:19:48.9: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2018-11-07 03:51:36.3: ++ Weather Safe ++
2018-11-07 04:15:02.1: Requested shutdown of scheduler
2018-11-07 04:15:02.1: Run statistics:
2018-11-07 04:15:02.1:   Observations:   54
2018-11-07 04:15:02.1:   Considered:     16
2018-11-07 04:15:02.1:   Completed:      0
2018-11-07 04:15:02.1:   Skipped:        12
2018-11-07 04:15:02.1:   Never Eligible: 38
2018-11-07 04:15:02.1:   Failed:         4
2018-11-07 04:15:02.1: Shutter-Open efficiency: 0.00%
2018-11-07 04:15:02.1: Overall Efficiency: 98.50%
2018-11-07 04:15:02.1: Release ACP sequencer
Log closed at Wed, Nov 07 2018 04:15:03 UTC (actual time)