Log opened at Sat, Jul 05 2025 08:55:42 UTC (actual time)
Current log level is Normal
ACP Expert Scheduler Engine Version 9.2.1
Part of ACP Expert 9.2.1
Full license: Arne Henden
2025-07-05 08:55:42.2: REAL TIME internal clock initialized at 05-Jul-2025 08:55:42 UTC
2025-07-05 08:55:42.2: Dispatcher started at 05-Jul-2025 08:55:42 UTC
2025-07-05 08:55:42.3: Loaded Constraint plugin AirMass
2025-07-05 08:55:42.3: Loaded Constraint plugin AirmassRange
2025-07-05 08:55:42.3: Loaded Constraint plugin Horizon
2025-07-05 08:55:42.3: Loaded Constraint plugin HourAngle
2025-07-05 08:55:42.4: Loaded Constraint plugin MoonAvoid
2025-07-05 08:55:42.4: Loaded Constraint plugin MoonDown
2025-07-05 08:55:42.4: Loaded Constraint plugin SkyCondition
2025-07-05 08:55:42.4: Loaded Constraint plugin TimeRange
2025-07-05 08:55:43.3: 202 plans are now pending.
2025-07-05 08:55:43.3: Attach ACP sequencer
2025-07-05 08:55:49.5: ++ Weather Safe ++
2025-07-05 08:55:50.2: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2025-07-05 08:55:50.2: Sequencer does sky flats
2025-07-05 08:56:06.7: ++ Observatory Startup ++
2025-07-05 08:56:06.7: Weather safety is now disabled
2025-07-05 08:56:06.7: Start ACP Sequencer's StartupObs script
2025-07-05 08:57:32.2: Weather safety is re-enabled
2025-07-05 08:57:32.2: Observatory startup succeeded
2025-07-05 08:57:32.2: Periodic AF schedule reset. Interval is now 1.0 hours
2025-07-05 08:57:32.2: Last AutoFocus was completed at 04-Jul-2025 10:20:55 UTC
2025-07-05 08:57:32.2: Autofocus will be done ASAP.
2025-07-05 08:57:32.2: ++ Auto Focus ++
2025-07-05 08:57:32.2: Doing periodic autofocus.
2025-07-05 08:57:32.2: Start special ACP AutoFocus script for scheduler
2025-07-05 09:01:00.3: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2025-07-05 09:01:02.4: Plan V630_Cas has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan V884_Her has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan V2492_Cyg has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan IX_Dra has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan FY_Aql has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan V0406_Vul has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan CG_Dra has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan AZ_Cas has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan AZ_Cas has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan V370_And has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan V504_Per has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan MV_Lyr has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan AE_And has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan AF_And has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan V1323_Her has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan 1RXS_J213344 has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan NGC_6535 has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan NGC_7089 has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:02.4: Plan NGC_7492 has Monitor Mode. Time to resubmit it.
2025-07-05 09:01:03.1: Plan NGC_7790 deferred, too early
2025-07-05 09:01:03.9: Dispatcher cycle time: 3.5 sec.
2025-07-05 09:01:03.9: Acquire data for Observation V0406_Vul...
2025-07-05 09:01:03.9:   (belongs to Project AAVSO_P194_BPEC_AUTO_ver2706, Plan V0406_Vul)
2025-07-05 09:01:03.9: ++ Auto Focus ++
2025-07-05 09:01:03.9: Doing periodic autofocus.
2025-07-05 09:01:03.9: Start special ACP AutoFocus script for scheduler
2025-07-05 09:05:39.6: Next periodic autofocus ASAP after 3600sec. 05-Jul-2025 10:05:15 UTC
2025-07-05 09:05:39.6: Send Observation V0406_Vul to ACP Sequencer
2025-07-05 09:06:28.9: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2025-07-05 09:06:35.0: ** ACP script "AcquireScheduler" failed:
2025-07-05 09:06:35.0: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 1941 column 5.

2025-07-05 09:06:35.0: RUN FAILED: Scheduler was stopped during run
2025-07-05 09:06:35.0: ACP data acquisition failed for Observation V0406_Vul.
2025-07-05 09:06:35.0:   (Observation V0406_Vul interrupted by operator or system.)
2025-07-05 09:06:41.6: Requested shutdown of scheduler
2025-07-05 09:06:41.6: ++ EARLY SHUTDOWN ++
2025-07-05 09:06:41.8: Run statistics:
2025-07-05 09:06:41.8:   Observations:   296
2025-07-05 09:06:41.8:   Considered:     8
2025-07-05 09:06:41.8:   Completed:      0
2025-07-05 09:06:41.8:   Skipped:        0
2025-07-05 09:06:41.8:   Never Eligible: 288
2025-07-05 09:06:41.8:   Failed:         8
2025-07-05 09:06:41.8: Shutter-Open efficiency: 0.00%
2025-07-05 09:06:41.8: Overall Efficiency: 16.54%
2025-07-05 09:06:41.8: Release ACP sequencer
Log closed at Sat, Jul 05 2025 09:06:43 UTC (actual time)