Log opened at Sat, Dec 18 2021 01:11:53 UTC (actual time)
Current log level is Normal
ACP Expert Scheduler Engine Version 8.3.2
Part of ACP Expert Release 8.3
Full license: Arne Henden
2021-12-18 01:11:53.2: REAL TIME internal clock initialized at 18-Dec-2021 01:11:53 UTC
2021-12-18 01:11:53.2: Dispatcher started at 18-Dec-2021 01:11:53 UTC
2021-12-18 01:11:53.4: Loaded Constraint plugin AirMass
2021-12-18 01:11:53.5: Loaded Constraint plugin AirmassRange
2021-12-18 01:11:53.5: Loaded Constraint plugin Horizon
2021-12-18 01:11:53.5: Loaded Constraint plugin HourAngle
2021-12-18 01:11:53.6: Loaded Constraint plugin MoonAvoid
2021-12-18 01:11:53.6: Loaded Constraint plugin MoonDown
2021-12-18 01:11:53.7: Loaded Constraint plugin SkyCondition
2021-12-18 01:11:53.7: Loaded Constraint plugin TimeRange
2021-12-18 01:11:54.6: 184 plans are now pending.
2021-12-18 01:11:54.7: Attach ACP sequencer
2021-12-18 01:12:01.5: Weather successfully connected. Wait for valid data...
2021-12-18 01:12:03.1: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2021-12-18 01:12:03.1: Sequencer does sky flats
2021-12-18 01:12:06.6: ++ Weather Safe ++
2021-12-18 01:12:06.8: HTTP command listener failed to start: Access is denied
2021-12-18 01:12:06.8:   If this is Windows 8-10, you will need to add permission (ACL) to listen on port 9123.
2021-12-18 01:12:06.8:   See Scheduler Help > Configuring the Program > Noteworthy Configuration Options, at the bottom.
2021-12-18 01:12:41.8: ++ Observatory Startup ++
2021-12-18 01:12:41.8: Weather safety is now disabled
2021-12-18 01:12:41.8: Start ACP Sequencer's StartupObs script
2021-12-18 01:13:34.1: Weather safety is re-enabled
2021-12-18 01:13:34.1: Observatory startup succeeded
2021-12-18 01:13:34.1: ++ Auto Focus ++
2021-12-18 01:13:34.1: Doing initial autofocus.
2021-12-18 01:13:34.1: Start special ACP AutoFocus script for scheduler
2021-12-18 01:19:34.2: Next periodic autofocus ASAP after 3600sec. 18-Dec-2021 02:19:14 UTC
2021-12-18 01:19:42.1: Dispatcher cycle time: 8.0 sec.
2021-12-18 01:19:42.1: Acquire data for Observation MV_Lyr...
2021-12-18 01:19:42.1:   (belongs to Project AAVSO_P233_DKS_AUTO_ver2623, Plan MV_Lyr)
2021-12-18 01:19:42.2: Send Observation MV_Lyr to ACP Sequencer
2021-12-18 01:24:23.6: ** ACP script "AcquireScheduler" failed:
2021-12-18 01:24:23.6: **Script Error (Tracking has been stopped)**
Source:   ACP Observatory Control Software
Message:  
Location: line 1885 column 5.

2021-12-18 01:24:23.6: ACP ERROR: Run failed due to script error (see ACP run log)
2021-12-18 01:24:23.7: ACP data acquisition failed for Observation MV_Lyr.
2021-12-18 01:24:23.7:   (Observation MV_Lyr interrupted by acquisition process failure.)
2021-12-18 01:24:25.7: Dispatcher cycle time: 1.7 sec.
2021-12-18 01:24:25.7: Acquire data for Observation CG_Dra...
2021-12-18 01:24:25.7:   (belongs to Project AAVSO_P211_BENS_AUTO_ver2706, Plan CG_Dra)
2021-12-18 01:24:25.7: Send Observation CG_Dra to ACP Sequencer
2021-12-18 01:39:00.5: Acquisition time: 874.8373139 sec.
2021-12-18 01:39:00.5: Data for Observation CG_Dra of Plan CG_Dra acquired successfully.
2021-12-18 01:39:00.6: Plan CG_Dra completed successfully.
2021-12-18 01:39:00.6: Image Efficiency: 82.1%
2021-12-18 01:39:00.6: Cycle Efficiency: 99.8%
2021-12-18 01:39:00.7: **EXCEPTION IN SCHEDULER:
2021-12-18 01:39:00.7: DOME FAILURE: Dome reports shutter error status
2021-12-18 01:39:00.9: Traceback:
   at DC3.Scheduler.ACPSequencer.get_DomeOpen()
   at DC3.Scheduler.Engine.DoStartupIf(Boolean openDome)
   at DC3.Scheduler.Engine.Run()
2021-12-18 01:39:00.9: Weather safety is now disabled
2021-12-18 01:39:00.9: Weather safety is re-enabled
2021-12-18 01:39:00.9: DOME/ROOF FAILURE: In addition, attempting to close your dome/roof this error occurred:
2021-12-18 01:39:00.9: DOME FAILURE: Dome reports shutter error status when asked to close.
2021-12-18 01:39:00.9: No operator intervention command tool specified
2021-12-18 01:39:02.5: Run statistics:
2021-12-18 01:39:02.5:   Observations:   205
2021-12-18 01:39:02.5:   Considered:     3
2021-12-18 01:39:02.5:   Completed:      0
2021-12-18 01:39:02.5:   Skipped:        0
2021-12-18 01:39:02.5:   Never Eligible: 202
2021-12-18 01:39:02.5:   Failed:         3
2021-12-18 01:39:02.5: Shutter-Open efficiency: 61.74%
2021-12-18 01:39:02.5: Overall Efficiency: 99.15%
2021-12-18 01:39:02.5: Release ACP sequencer
Log closed at Sat, Dec 18 2021 01:39:05 UTC (actual time)