Log opened at Thu, Dec 16 2021 00:08:06 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-16 00:08:06.6: REAL TIME internal clock initialized at 16-Dec-2021 00:08:06 UTC
2021-12-16 00:08:06.6: Dispatcher started at 16-Dec-2021 00:08:06 UTC
2021-12-16 00:08:06.7: Loaded Constraint plugin AirMass
2021-12-16 00:08:06.7: Loaded Constraint plugin AirmassRange
2021-12-16 00:08:06.7: Loaded Constraint plugin Horizon
2021-12-16 00:08:06.7: Loaded Constraint plugin HourAngle
2021-12-16 00:08:06.7: Loaded Constraint plugin MoonAvoid
2021-12-16 00:08:06.7: Loaded Constraint plugin MoonDown
2021-12-16 00:08:06.7: Loaded Constraint plugin SkyCondition
2021-12-16 00:08:06.7: Loaded Constraint plugin TimeRange
2021-12-16 00:08:07.6: 180 plans are now pending.
2021-12-16 00:08:07.7: Attach ACP sequencer
2021-12-16 00:08:13.9: There is no controllable dome or roof.
2021-12-16 00:08:14.0: ++ Weather Safe ++
2021-12-16 00:08:14.6: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2021-12-16 00:08:14.6: Sequencer does sky flats
2021-12-16 00:08:17.3: HTTP command listener failed to start: Access is denied
2021-12-16 00:08:17.3:   If this is Windows 8-10, you will need to add permission (ACL) to listen on port 9123.
2021-12-16 00:08:17.3:   See Scheduler Help > Configuring the Program > Noteworthy Configuration Options, at the bottom.
2021-12-16 00:09:03.4: ++ Observatory Startup ++
2021-12-16 00:09:03.4: Weather safety is now disabled
2021-12-16 00:09:03.4: Start ACP Sequencer's StartupObs script
2021-12-16 00:09:55.0: Weather safety is re-enabled
2021-12-16 00:09:55.0: Weather safety is now disabled
2021-12-16 00:09:55.0: Open the observatory dome/roof
2021-12-16 00:10:55.8: Weather safety is re-enabled
2021-12-16 00:10:55.8: Observatory startup succeeded, and dome opened successfully
2021-12-16 00:10:55.8: ++ Dusk Sky Flats ++
2021-12-16 00:10:55.8: Start ACP AutoFlat script for Dusk flats
2021-12-16 00:24:04.0: ** ACP script "AutoFlat" failed:
2021-12-16 00:24:04.0: **Script Error**
Source:   ACP Observatory Control Software
Message:  The script was interrupted before completion.
Location: line 955 column 13.

2021-12-16 00:25:07.0: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2021-12-16 00:25:11.5: ++ Observatory Startup ++
2021-12-16 00:25:11.5: Weather safety is now disabled
2021-12-16 00:25:11.5: Start ACP Sequencer's StartupObs script
2021-12-16 00:26:03.3: Weather safety is re-enabled
2021-12-16 00:26:03.3: Observatory startup succeeded
2021-12-16 00:26:03.3: ++ Dusk Sky Flats ++
2021-12-16 00:26:03.4: Start ACP AutoFlat script for Dusk flats
2021-12-16 00:46:16.1: ++ Auto Focus ++
2021-12-16 00:46:16.1: Doing initial autofocus.
2021-12-16 00:46:16.1: Start special ACP AutoFocus script for scheduler
2021-12-16 00:53:28.8: Next periodic autofocus ASAP after 3600sec. 16-Dec-2021 01:53:13 UTC
2021-12-16 00:53:33.4: Plan EE_Cep has Monitor Mode. Time to resubmit it.
2021-12-16 00:53:33.4: Plan EE_Cep has Monitor Mode. Time to resubmit it.
2021-12-16 00:53:33.4: Plan GZ_Cet has Monitor Mode. Time to resubmit it.
2021-12-16 00:53:33.4: Plan V630_Cas has Monitor Mode. Time to resubmit it.
2021-12-16 00:53:37.4: Dispatcher cycle time: 8.6 sec.
2021-12-16 00:53:37.4: Acquire data for Observation V1674_Her...
2021-12-16 00:53:37.4:   (belongs to Project AAVSO_MISC_CWT_AUTO_ver2730, Plan V1674_Her)
2021-12-16 00:53:37.4: Doing 5 sets
2021-12-16 00:53:37.4: ***Running Plan V1674_Her (best efforts) completed early:
2021-12-16 00:53:37.4:    Obs V1674_Her would not meet strict constraints
2021-12-16 00:53:37.4: Acquisition time: 0 sec.
2021-12-16 00:53:37.4: Data for Observation V1674_Her of Plan V1674_Her acquired successfully.
2021-12-16 00:53:37.5: Plan V1674_Her completed successfully.
2021-12-16 00:53:37.5: Image Efficiency: 0.0%
2021-12-16 00:53:37.5: Cycle Efficiency: 0.0%
2021-12-16 00:53:40.3: Dispatcher cycle time: 2.7 sec.
2021-12-16 00:53:40.3: Acquire data for Observation IX_Dra...
2021-12-16 00:53:40.3:   (belongs to Project AAVSO_P153_SFY_AUTO_ver2706, Plan IX_Dra)
2021-12-16 00:53:40.4: Send Observation IX_Dra to ACP Sequencer
2021-12-16 01:17:58.5: Acquisition time: 1458.1172785 sec.
2021-12-16 01:17:58.5: Data for Observation IX_Dra of Plan IX_Dra acquired successfully.
2021-12-16 01:17:58.5: Plan IX_Dra completed successfully.
2021-12-16 01:17:58.6: Image Efficiency: 82.1%
2021-12-16 01:17:58.6: Cycle Efficiency: 99.8%
2021-12-16 01:18:00.8: Dispatcher cycle time: 2.1 sec.
2021-12-16 01:18:00.8: Acquire data for Observation MV_Lyr...
2021-12-16 01:18:00.8:   (belongs to Project AAVSO_P233_DKS_AUTO_ver2623, Plan MV_Lyr)
2021-12-16 01:18:00.8: Send Observation MV_Lyr to ACP Sequencer
2021-12-16 01:38:59.2: ACP data acquisition failed for Observation MV_Lyr.
2021-12-16 01:38:59.2:   (Observation MV_Lyr interrupted by acquisition process failure.)
2021-12-16 01:39:01.5: Dispatcher cycle time: 2.0 sec.
2021-12-16 01:39:01.5: Acquire data for Observation CG_Dra...
2021-12-16 01:39:01.5:   (belongs to Project AAVSO_P211_BENS_AUTO_ver2706, Plan CG_Dra)
2021-12-16 01:39:01.5: Send Observation CG_Dra to ACP Sequencer
2021-12-16 01:53:58.5: Acquisition time: 896.9665314 sec.
2021-12-16 01:53:58.5: Data for Observation CG_Dra of Plan CG_Dra acquired successfully.
2021-12-16 01:53:58.6: Plan CG_Dra completed successfully.
2021-12-16 01:53:58.6: Image Efficiency: 80.1%
2021-12-16 01:53:58.6: Cycle Efficiency: 99.8%
2021-12-16 01:53:58.8: **EXCEPTION IN SCHEDULER:
2021-12-16 01:53:58.8: DOME FAILURE: Dome reports shutter error status
2021-12-16 01:53:59.9: Traceback:
   at DC3.Scheduler.ACPSequencer.get_DomeOpen()
   at DC3.Scheduler.Engine.DoStartupIf(Boolean openDome)
   at DC3.Scheduler.Engine.Run()
2021-12-16 01:53:59.9: Weather safety is now disabled
2021-12-16 01:53:59.9: Weather safety is re-enabled
2021-12-16 01:53:59.9: DOME/ROOF FAILURE: In addition, attempting to close your dome/roof this error occurred:
2021-12-16 01:53:59.9: DOME FAILURE: Dome reports shutter error status when asked to close.
2021-12-16 01:54:00.0: No operator intervention command tool specified
2021-12-16 01:54:01.1: Run statistics:
2021-12-16 01:54:01.1:   Observations:   202
2021-12-16 01:54:01.1:   Considered:     2
2021-12-16 01:54:01.1:   Completed:      0
2021-12-16 01:54:01.1:   Skipped:        0
2021-12-16 01:54:01.1:   Never Eligible: 200
2021-12-16 01:54:01.1:   Failed:         2
2021-12-16 01:54:01.1: Shutter-Open efficiency: 52.90%
2021-12-16 01:54:01.1: Overall Efficiency: 99.56%
2021-12-16 01:54:01.1: Release ACP sequencer
Log closed at Thu, Dec 16 2021 01:54:03 UTC (actual time)