Log opened at Mon, Feb 19 2024 10:33:06 UTC (actual time)
Current log level is Normal
ACP Expert Scheduler Engine Version 9.0.4
Part of ACP Expert 9.0 Release
Full license: Arne Henden
2024-02-19 10:33:06.6: REAL TIME internal clock initialized at 19-Feb-2024 10:33:06 UTC
2024-02-19 10:33:06.6: Dispatcher started at 19-Feb-2024 10:33:06 UTC
2024-02-19 10:33:06.7: Loaded Constraint plugin AirMass
2024-02-19 10:33:06.7: Loaded Constraint plugin AirmassRange
2024-02-19 10:33:06.7: Loaded Constraint plugin Horizon
2024-02-19 10:33:06.7: Loaded Constraint plugin HourAngle
2024-02-19 10:33:06.7: Loaded Constraint plugin MoonAvoid
2024-02-19 10:33:06.7: Loaded Constraint plugin MoonDown
2024-02-19 10:33:06.8: Loaded Constraint plugin SkyCondition
2024-02-19 10:33:06.8: Loaded Constraint plugin TimeRange
2024-02-19 10:33:07.6: 135 plans are now pending.
2024-02-19 10:33:07.6: Attach ACP sequencer
2024-02-19 10:33:14.6: ++ Weather Safe ++
2024-02-19 10:33:14.6: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2024-02-19 10:33:14.6: Sequencer does sky flats
2024-02-19 10:33:35.5: ++ Observatory Startup ++
2024-02-19 10:33:35.5: Weather safety is now disabled
2024-02-19 10:33:35.5: Start ACP Sequencer's StartupObs script
2024-02-19 10:34:43.4: Weather safety is re-enabled
2024-02-19 10:34:43.4: Weather safety is now disabled
2024-02-19 10:34:43.4: Open the observatory dome/roof
2024-02-19 10:35:59.5: Weather safety is re-enabled
2024-02-19 10:35:59.5: Observatory startup succeeded, and dome opened successfully
2024-02-19 10:35:59.5: Periodic AF schedule reset. Interval is now 1.0 hours
2024-02-19 10:35:59.5: Last AutoFocus was completed at 17-Feb-2024 02:56:22 UTC
2024-02-19 10:35:59.5: Autofocus will be done ASAP.
2024-02-19 10:35:59.5: ++ Auto Focus ++
2024-02-19 10:35:59.5: Doing periodic autofocus.
2024-02-19 10:35:59.5: Start special ACP AutoFocus script for scheduler
2024-02-19 10:39:10.6: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2024-02-19 10:39:12.4: Dispatcher cycle time: 1.7 sec.
2024-02-19 10:39:12.4: Acquire data for Observation MV_Lyr...
2024-02-19 10:39:12.4:   (belongs to Project AAVSO_P233_DKS_AUTO_ver2623, Plan MV_Lyr)
2024-02-19 10:39:12.7: ++ Auto Focus ++
2024-02-19 10:39:12.7: Doing periodic autofocus.
2024-02-19 10:39:12.7: Start special ACP AutoFocus script for scheduler
2024-02-19 10:40:34.5: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2024-02-19 10:40:34.5: Send Observation MV_Lyr to ACP Sequencer
2024-02-19 10:44:25.3: ACP data acquisition failed for Observation MV_Lyr.
2024-02-19 10:44:25.3:   (Observation MV_Lyr interrupted by acquisition process failure.)
2024-02-19 10:44:25.5: Dispatcher cycle time: 0.1 sec.
2024-02-19 10:44:25.5: Acquire data for Observation IX_Dra...
2024-02-19 10:44:25.5:   (belongs to Project AAVSO_P153_SFY_AUTO_ver2706, Plan IX_Dra)
2024-02-19 10:44:25.5: Send Observation IX_Dra to ACP Sequencer
2024-02-19 10:48:12.6: ACP data acquisition failed for Observation IX_Dra.
2024-02-19 10:48:12.6:   (Observation IX_Dra interrupted by acquisition process failure.)
2024-02-19 10:48:12.7: ++ Auto Focus ++
2024-02-19 10:48:12.8: Doing periodic autofocus.
2024-02-19 10:48:12.8: Start special ACP AutoFocus script for scheduler
2024-02-19 10:51:24.8: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2024-02-19 10:51:25.0: Dispatcher cycle time: 0.2 sec.
2024-02-19 10:51:25.0: Acquire data for Observation V884_Her...
2024-02-19 10:51:25.0:   (belongs to Project AAVSO_MISC_PYG_AUTO_ver3260, Plan V884_Her)
2024-02-19 10:51:25.0: Send Observation V884_Her to ACP Sequencer
2024-02-19 10:58:33.5: Acquisition time: 428.4880344 sec.
2024-02-19 10:58:33.5: Data for Observation V884_Her of Plan V884_Her acquired successfully.
2024-02-19 10:58:33.5: Plan V884_Her completed successfully.
2024-02-19 10:58:33.5: Image Efficiency: 42.0%
2024-02-19 10:58:33.5: Cycle Efficiency: 100.0%
2024-02-19 10:58:33.8: Dispatcher cycle time: 0.1 sec.
2024-02-19 10:58:33.8: Acquire data for Observation NGC_5897...
2024-02-19 10:58:33.8:   (belongs to Project AAVSO_Pgc_Welch_AUTO_ver2411, Plan NGC_5897)
2024-02-19 10:58:33.8: Send Observation NGC_5897 to ACP Sequencer
2024-02-19 11:01:46.4: ACP data acquisition failed for Observation NGC_5897.
2024-02-19 11:01:46.4:   (Observation NGC_5897 interrupted by acquisition process failure.)
2024-02-19 11:01:46.5: ++ Auto Focus ++
2024-02-19 11:01:46.5: Doing periodic autofocus.
2024-02-19 11:01:46.5: Start special ACP AutoFocus script for scheduler
2024-02-19 11:04:25.7: ** Autofocus failed (n=4), will retry ASAP after 15 min.
2024-02-19 11:04:25.9: Dispatcher cycle time: 0.2 sec.
2024-02-19 11:04:25.9: Acquire data for Observation NGC_6171...
2024-02-19 11:04:25.9:   (belongs to Project AAVSO_Pgc_Welch_AUTO_ver2411, Plan NGC_6171)
2024-02-19 11:04:25.9: Send Observation NGC_6171 to ACP Sequencer
2024-02-19 11:10:37.0: ACP data acquisition failed for Observation NGC_6171.
2024-02-19 11:10:37.0:   (Observation NGC_6171 interrupted by acquisition process failure.)
2024-02-19 11:10:37.3: Dispatcher cycle time: 0.2 sec.
2024-02-19 11:10:37.3: Acquire data for Observation NGC_6254...
2024-02-19 11:10:37.3:   (belongs to Project AAVSO_Pgc_Welch_AUTO_ver2411, Plan NGC_6254)
2024-02-19 11:10:37.3: Send Observation NGC_6254 to ACP Sequencer
2024-02-19 11:15:18.8: ACP data acquisition failed for Observation NGC_6254.
2024-02-19 11:15:18.8:   (Observation NGC_6254 interrupted by acquisition process failure.)
2024-02-19 11:15:19.1: Dispatcher cycle time: 0.2 sec.
2024-02-19 11:15:19.1: Acquire data for Observation X_Ser...
2024-02-19 11:15:19.1:   (belongs to Project AAVSO_MISC_MRV_AUTO_ver3136, Plan X_Ser)
2024-02-19 11:15:19.1: Send Observation X_Ser to ACP Sequencer
2024-02-19 11:20:59.1: ACP data acquisition failed for Observation X_Ser.
2024-02-19 11:20:59.1:   (Observation X_Ser interrupted by acquisition process failure.)
2024-02-19 11:20:59.2: ++ Auto Focus ++
2024-02-19 11:20:59.2: Doing periodic autofocus.
2024-02-19 11:20:59.2: Start special ACP AutoFocus script for scheduler
2024-02-19 11:23:36.6: ** Autofocus failed (n=5), will retry ASAP after 20 min.
2024-02-19 11:23:36.8: Dispatcher cycle time: 0.3 sec.
2024-02-19 11:23:36.8: Acquire data for Observation NGC_6366...
2024-02-19 11:23:36.8:   (belongs to Project AAVSO_Pgc_Welch_AUTO_ver2411, Plan NGC_6366)
2024-02-19 11:23:36.8: Send Observation NGC_6366 to ACP Sequencer
2024-02-19 11:28:34.1: ACP data acquisition failed for Observation NGC_6366.
2024-02-19 11:28:34.1:   (Observation NGC_6366 interrupted by acquisition process failure.)
2024-02-19 11:28:34.5: Dispatcher cycle time: 0.3 sec.
2024-02-19 11:28:34.5: Acquire data for Observation NGC_6402...
2024-02-19 11:28:34.5:   (belongs to Project AAVSO_Pgc_Welch_AUTO_ver2411, Plan NGC_6402)
2024-02-19 11:28:34.5: Send Observation NGC_6402 to ACP Sequencer
2024-02-19 11:30:40.3: ACP data acquisition failed for Observation NGC_6402.
2024-02-19 11:30:40.3:   (Observation NGC_6402 interrupted by acquisition process failure.)
2024-02-19 11:30:40.7: Dispatcher cycle time: 0.2 sec.
2024-02-19 11:30:40.7: Acquire data for Observation CG_Dra...
2024-02-19 11:30:40.7:   (belongs to Project AAVSO_P211_BENS_AUTO_ver2706, Plan CG_Dra)
2024-02-19 11:30:40.7: Send Observation CG_Dra to ACP Sequencer
2024-02-19 11:36:09.9: ACP data acquisition failed for Observation CG_Dra.
2024-02-19 11:36:09.9:   (Observation CG_Dra interrupted by acquisition process failure.)
2024-02-19 11:36:10.3: Dispatcher cycle time: 0.2 sec.
2024-02-19 11:36:10.3: Acquire data for Observation Pal_5...
2024-02-19 11:36:10.3:   (belongs to Project AAVSO_Pgc_Welch_AUTO_ver2411, Plan Pal_5)
2024-02-19 11:36:10.3: Send Observation Pal_5 to ACP Sequencer
2024-02-19 11:41:58.6: ACP data acquisition failed for Observation Pal_5.
2024-02-19 11:41:58.6:   (Observation Pal_5 interrupted by acquisition process failure.)
2024-02-19 11:41:58.7: **EXCEPTION IN SCHEDULER:
2024-02-19 11:41:58.7: DOME FAILURE: Dome reports shutter error status
2024-02-19 11:41:58.7: Traceback:
   at DC3.Scheduler.ACPSequencer.get_DomeOpen()
   at DC3.Scheduler.Engine.DoStartupIf(Boolean openDome)
   at DC3.Scheduler.Engine.Run()
2024-02-19 11:41:58.7: Weather safety is now disabled
2024-02-19 11:41:58.7: Weather safety is re-enabled
2024-02-19 11:41:58.7: DOME/ROOF FAILURE: In addition, attempting to close your dome/roof this error occurred:
2024-02-19 11:41:58.7: DOME FAILURE: Dome reports shutter error status when asked to close.
2024-02-19 11:41:58.8: Running C:\WINDOWS\syswow64\cscript.exe
2024-02-19 11:41:58.8: Arguments: '//NoLogo "C:\Users\Public\Documents\ACP Config\Scheduler\ShutdownObs.js"'
2024-02-19 11:41:58.9: Results look OK, the tool returned this text:
2024-02-19 11:41:58.9:   ''
2024-02-19 11:41:59.1: Run statistics:
2024-02-19 11:41:59.1:   Observations:   274
2024-02-19 11:41:59.1:   Considered:     77
2024-02-19 11:41:59.1:   Completed:      0
2024-02-19 11:41:59.1:   Skipped:        0
2024-02-19 11:41:59.1:   Never Eligible: 197
2024-02-19 11:41:59.1:   Failed:         77
2024-02-19 11:41:59.1: Shutter-Open efficiency: 5.52%
2024-02-19 11:41:59.1: Overall Efficiency: 97.36%
2024-02-19 11:41:59.1: Release ACP sequencer
2024-02-19 11:41:59.5: ACPSequencer: Failed to get ACP's DispatcherEnabled property. ACP is compromised.
2024-02-19 11:41:59.5:               Object reference not set to an instance of an object.
Log closed at Mon, Feb 19 2024 11:42:00 UTC (actual time)