Log opened at Thu, Dec 16 2021 04:11:25 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 04:11:25.8: REAL TIME internal clock initialized at 16-Dec-2021 04:11:25 UTC
2021-12-16 04:11:25.8: Dispatcher started at 16-Dec-2021 04:11:25 UTC
2021-12-16 04:11:26.6: Loaded Constraint plugin AirMass
2021-12-16 04:11:26.7: Loaded Constraint plugin AirmassRange
2021-12-16 04:11:26.7: Loaded Constraint plugin Horizon
2021-12-16 04:11:26.8: Loaded Constraint plugin HourAngle
2021-12-16 04:11:26.8: Loaded Constraint plugin MoonAvoid
2021-12-16 04:11:26.9: Loaded Constraint plugin MoonDown
2021-12-16 04:11:26.9: Loaded Constraint plugin SkyCondition
2021-12-16 04:11:26.9: Loaded Constraint plugin TimeRange
2021-12-16 04:11:27.9: 180 plans are now pending.
2021-12-16 04:11:28.0: Attach ACP sequencer
2021-12-16 04:11:45.3: ++ Weather Safe ++
2021-12-16 04:11:45.6: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2021-12-16 04:11:45.6: Sequencer does sky flats
2021-12-16 04:11:47.5: HTTP command listener failed to start: Access is denied
2021-12-16 04:11:47.5:   If this is Windows 8-10, you will need to add permission (ACL) to listen on port 9123.
2021-12-16 04:11:47.5:   See Scheduler Help > Configuring the Program > Noteworthy Configuration Options, at the bottom.
2021-12-16 06:49:36.4: ++ Observatory Startup ++
2021-12-16 06:49:36.5: Weather safety is now disabled
2021-12-16 06:49:36.5: Start ACP Sequencer's StartupObs script
2021-12-16 06:50:27.7: Weather safety is re-enabled
2021-12-16 06:50:27.7: Observatory startup succeeded
2021-12-16 06:50:27.7: ++ Auto Focus ++
2021-12-16 06:50:27.7: Doing initial autofocus.
2021-12-16 06:50:27.7: Start special ACP AutoFocus script for scheduler
2021-12-16 06:55:32.0: Next periodic autofocus ASAP after 3600sec. 16-Dec-2021 07:55:12 UTC
2021-12-16 06:55:40.7: Dispatcher cycle time: 8.6 sec.
2021-12-16 06:55:40.7: Acquire data for Observation AZ_Cas...
2021-12-16 06:55:40.7:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver2706, Plan AZ_Cas)
2021-12-16 06:55:40.7: Send Observation AZ_Cas to ACP Sequencer
2021-12-16 06:58:25.1: Acquisition time: 164.397386 sec.
2021-12-16 06:58:25.1: Data for Observation AZ_Cas of Plan AZ_Cas acquired successfully.
2021-12-16 06:58:25.1: Plan AZ_Cas completed successfully.
2021-12-16 06:58:25.1: Image Efficiency: 17.3%
2021-12-16 06:58:25.1: Cycle Efficiency: 95.0%
2021-12-16 06:58:26.8: Dispatcher cycle time: 1.5 sec.
2021-12-16 06:58:26.8: Acquire data for Observation TU_Cas...
2021-12-16 06:58:26.8:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver2706, Plan TU_Cas)
2021-12-16 06:58:26.8: Send Observation TU_Cas to ACP Sequencer
2021-12-16 07:04:29.5: Acquisition time: 362.7096374 sec.
2021-12-16 07:04:29.5: Data for Observation TU_Cas of Plan TU_Cas acquired successfully.
2021-12-16 07:04:29.6: Plan TU_Cas completed successfully.
2021-12-16 07:04:29.7: Image Efficiency: 4.4%
2021-12-16 07:04:29.7: Cycle Efficiency: 99.5%
2021-12-16 07:04:31.4: Dispatcher cycle time: 1.6 sec.
2021-12-16 07:04:31.4: Acquire data for Observation TT_Ari...
2021-12-16 07:04:31.4:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver2706, Plan TT_Ari)
2021-12-16 07:04:31.4: Send Observation TT_Ari to ACP Sequencer
2021-12-16 07:22:32.4: Acquisition time: 1080.9516266 sec.
2021-12-16 07:22:32.4: Data for Observation TT_Ari of Plan TT_Ari acquired successfully.
2021-12-16 07:22:32.5: Plan TT_Ari completed successfully.
2021-12-16 07:22:32.5: Image Efficiency: 72.0%
2021-12-16 07:22:32.5: Cycle Efficiency: 99.8%
2021-12-16 07:22:34.2: Dispatcher cycle time: 1.6 sec.
2021-12-16 07:22:34.2: Acquire data for Observation RY_Lep...
2021-12-16 07:22:34.2:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver2706, Plan RY_Lep)
2021-12-16 07:22:34.3: Send Observation RY_Lep to ACP Sequencer
2021-12-16 07:28:57.8: Acquisition time: 383.4867635 sec.
2021-12-16 07:28:57.8: Data for Observation RY_Lep of Plan RY_Lep acquired successfully.
2021-12-16 07:28:57.8: Plan RY_Lep completed successfully.
2021-12-16 07:28:57.8: Image Efficiency: 4.4%
2021-12-16 07:28:57.8: Cycle Efficiency: 99.6%
2021-12-16 07:28:59.3: Dispatcher cycle time: 1.4 sec.
2021-12-16 07:28:59.3: Acquire data for Observation TV_Cam...
2021-12-16 07:28:59.3:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver2706, Plan TV_Cam)
2021-12-16 07:28:59.4: Send Observation TV_Cam to ACP Sequencer
2021-12-16 07:44:49.9: Acquisition time: 950.5034083 sec.
2021-12-16 07:44:49.9: Data for Observation TV_Cam of Plan TV_Cam acquired successfully.
2021-12-16 07:44:49.9: Plan TV_Cam completed successfully.
2021-12-16 07:44:50.0: Image Efficiency: 58.8%
2021-12-16 07:44:50.0: Cycle Efficiency: 99.8%
2021-12-16 07:44:52.0: Dispatcher cycle time: 1.9 sec.
2021-12-16 07:44:52.0: Acquire data for Observation V838_Mon...
2021-12-16 07:44:52.0:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver2706, Plan V838_Mon)
2021-12-16 07:44:52.0: Doing 2 sets
2021-12-16 07:44:52.0: Send Observation V838_Mon to ACP Sequencer
2021-12-16 08:28:14.7: Send Observation V838_Mon to ACP Sequencer
2021-12-16 08:51:28.6: ACP data acquisition failed for Observation V838_Mon.
2021-12-16 08:51:28.6:   (Observation V838_Mon interrupted by acquisition process failure.)
2021-12-16 08:51:28.7: **EXCEPTION IN SCHEDULER:
2021-12-16 08:51:28.7: DOME FAILURE: Dome reports shutter error status
2021-12-16 08:51:28.9: Traceback:
   at DC3.Scheduler.ACPSequencer.get_DomeOpen()
   at DC3.Scheduler.Engine.DoStartupIf(Boolean openDome)
   at DC3.Scheduler.Engine.Run()
2021-12-16 08:51:28.9: Weather safety is now disabled
2021-12-16 08:51:28.9: Weather safety is re-enabled
2021-12-16 08:51:28.9: DOME/ROOF FAILURE: In addition, attempting to close your dome/roof this error occurred:
2021-12-16 08:51:28.9: DOME FAILURE: Dome reports shutter error status when asked to close.
2021-12-16 08:51:29.0: No operator intervention command tool specified
2021-12-16 08:51:30.3: Run statistics:
2021-12-16 08:51:30.3:   Observations:   198
2021-12-16 08:51:30.3:   Considered:     3
2021-12-16 08:51:30.3:   Completed:      0
2021-12-16 08:51:30.3:   Skipped:        0
2021-12-16 08:51:30.3:   Never Eligible: 195
2021-12-16 08:51:30.3:   Failed:         3
2021-12-16 08:51:30.3: Shutter-Open efficiency: 50.36%
2021-12-16 08:51:30.3: Overall Efficiency: 99.90%
2021-12-16 08:51:30.3: Release ACP sequencer
Log closed at Thu, Dec 16 2021 08:51:32 UTC (actual time)