Log opened at Sun, Jan 22 2023 12:23:22 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
2023-01-22 12:23:22.8: Periodic AF schedule reset. Interval is now 1.0 hours
2023-01-22 12:23:22.8: Last AutoFocus was completed at 22-Jan-2023 10:48:44 UTC
2023-01-22 12:23:22.8: Autofocus will be done ASAP.
2023-01-22 12:23:23.2: ++ Auto Focus ++
2023-01-22 12:23:23.2: Doing periodic autofocus.
2023-01-22 12:23:23.2: Start special ACP AutoFocus script for scheduler
2023-01-22 12:26:53.2: Next periodic autofocus ASAP after 3600sec. 22-Jan-2023 13:26:34 UTC
2023-01-22 12:26:53.3: Rising plan delay enabled for Plan MV_Lyr:
2023-01-22 12:26:53.3:     149 min. remaining to meet strict constraints.
2023-01-22 12:26:53.3:     9 min. remaining for the plan to fit before dawn.
2023-01-22 12:26:53.3:     deferred (rising) for 5 min, until 22-Jan-2023 12:32:34 UTC
2023-01-22 12:26:53.3: Rising plan delay enabled for Plan NGC_5897:
2023-01-22 12:26:53.3:     149 min. remaining to meet strict constraints.
2023-01-22 12:26:53.3:     20 min. remaining for the plan to fit before dawn.
2023-01-22 12:26:53.3:     deferred (rising) for 17 min, until 22-Jan-2023 12:44:35 UTC
2023-01-22 12:26:53.3: Rising plan delay enabled for Plan NSV_11154:
2023-01-22 12:26:53.3:     149 min. remaining to meet strict constraints.
2023-01-22 12:26:53.3:     16 min. remaining for the plan to fit before dawn.
2023-01-22 12:26:53.3:     deferred (rising) for 13 min, until 22-Jan-2023 12:40:49 UTC
2023-01-22 12:26:53.3: Rising plan delay enabled for Plan NSV_11154:
2023-01-22 12:26:53.3:     149 min. remaining to meet strict constraints.
2023-01-22 12:26:53.3:     16 min. remaining for the plan to fit before dawn.
2023-01-22 12:26:53.3:     deferred (rising) for 13 min, until 22-Jan-2023 12:40:49 UTC
2023-01-22 12:26:53.3: Dispatcher cycle time: 0.1 sec.
2023-01-22 12:26:53.3: Acquire data for Observation IR_Com...
2023-01-22 12:26:53.3:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3411, Plan IR_Com)
2023-01-22 12:26:53.3: Send Observation IR_Com to ACP Sequencer
2023-01-22 12:42:42.5: Acquisition time: 949.1731404 sec.
2023-01-22 12:42:42.5: Data for Observation IR_Com of Plan IR_Com acquired successfully.
2023-01-22 12:42:42.5: Plan IR_Com completed successfully.
2023-01-22 12:42:42.5: Image Efficiency: 75.8%
2023-01-22 12:42:42.5: Cycle Efficiency: 100.0%
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan ASAS_185038:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     8 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     deferred (rising) for 6 min, until 22-Jan-2023 12:48:53 UTC
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan CG_Dra:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     13 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     deferred (rising) for 12 min, until 22-Jan-2023 12:54:45 UTC
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan HS1340+1524:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     19 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     but only -2 min till start so Plan transits mid-way in its time span.
2023-01-22 12:42:42.7:     ending rising plan delay. Plan is now eligible.
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan HS1340+1524:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     19 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     but only -2 min till start so Plan transits mid-way in its time span.
2023-01-22 12:42:42.7:     ending rising plan delay. Plan is now eligible.
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan J184706:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     10 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     deferred (rising) for 8 min, until 22-Jan-2023 12:51:27 UTC
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan M3-V154:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     23 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     but only -1 min till start so Plan transits mid-way in its time span.
2023-01-22 12:42:42.7:     ending rising plan delay. Plan is now eligible.
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan NGC_6254:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     13 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     deferred (rising) for 12 min, until 22-Jan-2023 12:55:18 UTC
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan NGC_6254:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     12 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     deferred (rising) for 11 min, until 22-Jan-2023 12:53:45 UTC
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan NSV_11154:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     0 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     ending rising plan delay. Plan is now eligible.
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan NSV_11154:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     0 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     ending rising plan delay. Plan is now eligible.
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan V884_Her:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     23 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     deferred (rising) for 22 min, until 22-Jan-2023 13:05:40 UTC
2023-01-22 12:42:42.7: Rising plan delay enabled for Plan V884_Her:
2023-01-22 12:42:42.7:     133 min. remaining to meet strict constraints.
2023-01-22 12:42:42.7:     23 min. remaining for the plan to fit before dawn.
2023-01-22 12:42:42.7:     deferred (rising) for 22 min, until 22-Jan-2023 13:05:40 UTC
2023-01-22 12:42:42.8: Dispatcher cycle time: 0.1 sec.
2023-01-22 12:42:42.8: Acquire data for Observation IR_Com...
2023-01-22 12:42:42.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3411, Plan IR_Com)
2023-01-22 12:42:42.8: Send Observation IR_Com to ACP Sequencer
2023-01-22 12:56:42.2: Acquisition time: 839.4167261 sec.
2023-01-22 12:56:42.2: Data for Observation IR_Com of Plan IR_Com acquired successfully.
2023-01-22 12:56:42.2: Plan IR_Com completed successfully.
2023-01-22 12:56:42.2: Image Efficiency: 85.8%
2023-01-22 12:56:42.2: Cycle Efficiency: 100.0%
2023-01-22 12:56:42.3: Rising plan delay enabled for Plan ASAS_191806:
2023-01-22 12:56:42.3:     119 min. remaining to meet strict constraints.
2023-01-22 12:56:42.3:     5 min. remaining for the plan to fit before dawn.
2023-01-22 12:56:42.3:     deferred (rising) for 4 min, until 22-Jan-2023 13:00:57 UTC
2023-01-22 12:56:42.4: Rising plan delay enabled for Plan V1674_Her:
2023-01-22 12:56:42.4:     119 min. remaining to meet strict constraints.
2023-01-22 12:56:42.4:     -569 min. remaining for the plan to fit before dawn.
2023-01-22 12:56:42.4:     ending rising plan delay. Plan is now eligible.
2023-01-22 12:56:42.4: Dispatcher cycle time: 0.1 sec.
2023-01-22 12:56:42.4: Acquire data for Observation V1674_Her...
2023-01-22 12:56:42.4:   (belongs to Project AAVSO_MISC_CWT_AUTO_ver2730, Plan V1674_Her)
2023-01-22 12:56:42.4: Doing 5 sets
2023-01-22 12:56:42.4: ***Running Plan V1674_Her (best efforts) completed early:
2023-01-22 12:56:42.4:    Obs V1674_Her would extend past dawn
2023-01-22 12:56:42.4: Acquisition time: 0 sec.
2023-01-22 12:56:42.4: Data for Observation V1674_Her of Plan V1674_Her acquired successfully.
2023-01-22 12:56:42.4: Plan V1674_Her completed successfully.
2023-01-22 12:56:42.4: Image Efficiency: 0.0%
2023-01-22 12:56:42.4: Cycle Efficiency: 0.0%
2023-01-22 12:56:42.6: Dispatcher cycle time: 0.0 sec.
2023-01-22 12:56:42.6: Acquire data for Observation HS1340+1524...
2023-01-22 12:56:42.6:   (belongs to Project AAVSO_MISC_PYG_AUTO_ver3260, Plan HS1340+1524)
2023-01-22 12:56:42.6: Send Observation HS1340+1524 to ACP Sequencer
2023-01-22 12:58:25.0: ACP data acquisition failed for Observation HS1340+1524.
2023-01-22 12:58:25.0:   (Observation HS1340+1524 interrupted by acquisition process failure.)
2023-01-22 12:58:25.2: Dispatcher cycle time: 0.0 sec.
2023-01-22 12:58:25.2: Acquire data for Observation M3-V154...
2023-01-22 12:58:25.2:   (belongs to Project AAVSO_P246_KPRB_AUTO_ver3160, Plan M3-V154)
2023-01-22 12:58:25.2: Send Observation M3-V154 to ACP Sequencer
2023-01-22 13:03:09.4: Acquisition time: 284.1506536 sec.
2023-01-22 13:03:09.4: Data for Observation M3-V154 of Plan M3-V154 acquired successfully.
2023-01-22 13:03:09.4: Plan M3-V154 completed successfully.
2023-01-22 13:03:09.4: Image Efficiency: 36.9%
2023-01-22 13:03:09.4: Cycle Efficiency: 100.0%
2023-01-22 13:05:11.1: Rising plan delay enabled for Plan AG_Dra:
2023-01-22 13:05:11.1:     111 min. remaining to meet strict constraints.
2023-01-22 13:05:11.1:     0 min. remaining for the plan to fit before dawn.
2023-01-22 13:05:11.1:     ending rising plan delay. Plan is now eligible.
2023-01-22 13:05:11.1: Rising plan delay enabled for Plan AG_Dra:
2023-01-22 13:05:11.1:     111 min. remaining to meet strict constraints.
2023-01-22 13:05:11.1:     0 min. remaining for the plan to fit before dawn.
2023-01-22 13:05:11.1:     ending rising plan delay. Plan is now eligible.
2023-01-22 13:05:11.1: Rising plan delay enabled for Plan M5-V42:
2023-01-22 13:05:11.1:     111 min. remaining to meet strict constraints.
2023-01-22 13:05:11.1:     0 min. remaining for the plan to fit before dawn.
2023-01-22 13:05:11.1:     ending rising plan delay. Plan is now eligible.
2023-01-22 13:05:11.1: Rising plan delay enabled for Plan M5-V84:
2023-01-22 13:05:11.1:     111 min. remaining to meet strict constraints.
2023-01-22 13:05:11.1:     0 min. remaining for the plan to fit before dawn.
2023-01-22 13:05:11.1:     ending rising plan delay. Plan is now eligible.
2023-01-22 13:05:11.1: Rising plan delay enabled for Plan X_Boo:
2023-01-22 13:05:11.1:     111 min. remaining to meet strict constraints.
2023-01-22 13:05:11.1:     0 min. remaining for the plan to fit before dawn.
2023-01-22 13:05:11.1:     ending rising plan delay. Plan is now eligible.
2023-01-22 13:05:11.2: Rising plan delay enabled for Plan X_Boo:
2023-01-22 13:05:11.2:     111 min. remaining to meet strict constraints.
2023-01-22 13:05:11.2:     0 min. remaining for the plan to fit before dawn.
2023-01-22 13:05:11.2:     ending rising plan delay. Plan is now eligible.
2023-01-22 13:05:11.2: Dispatcher cycle time: 0.1 sec.
2023-01-22 13:05:11.2: Acquire data for Observation M5-V42...
2023-01-22 13:05:11.2:   (belongs to Project AAVSO_P246_KPRB_AUTO_ver3160, Plan M5-V42)
2023-01-22 13:05:11.2: Send Observation M5-V42 to ACP Sequencer
2023-01-22 13:09:38.6: ACP data acquisition failed for Observation M5-V42.
2023-01-22 13:09:38.6:   (Observation M5-V42 interrupted by acquisition process failure.)
2023-01-22 13:23:19.6: ++ Dawn Flats ++
2023-01-22 13:23:19.6: Start ACP AutoFlat script for Dawn flats
2023-01-22 13:40:19.1: -- Observatory Shutdown --
2023-01-22 13:40:19.1: Weather safety is now disabled
2023-01-22 13:40:19.1: Start ACP Sequencer's ShutdownObs script
2023-01-22 13:41:43.3: Weather safety is re-enabled
2023-01-23 20:19:21.3: -- Weather Unsafe --
2023-01-23 20:57:06.7: ++ Weather Safe ++
2023-01-23 21:27:01.5: -- Weather Unsafe --
2023-01-24 08:22:25.1: ++ Weather Safe ++
2023-01-24 09:45:24.7: -- Weather Unsafe --
2023-01-24 10:14:23.8: ++ Weather Safe ++
2023-01-24 10:30:00.4: -- Weather Unsafe --
2023-01-24 12:50:27.3: ++ Weather Safe ++
2023-01-24 13:05:02.3: -- Weather Unsafe --
2023-01-24 17:02:24.5: ++ Weather Safe ++
2023-01-24 19:04:41.0: -- Weather Unsafe --
2023-01-24 20:02:36.3: ++ Weather Safe ++
2023-01-26 04:21:40.1: ACPSequencer: Failed to get ACP's DispatcherEnabled property. ACP is compromised.
2023-01-26 04:21:40.1:               The callee (server [not server application]) is not available and disappeared; all connections are invalid. The call may have executed. (Exception from HRESULT: 0x80010007 (RPC_E_SERVER_DIED))
2023-01-26 04:21:40.2: **ACP HAS BECOME COMPROMISED:
2023-01-26 04:21:40.2:   Scheduler depends on ACP and yet ACP is frozen, dead, or otherwise compromised.
2023-01-26 04:21:40.2:   If this happens again, please look at ACP. Is it running? Is a fatal error box visible? Is it frozen?
2023-01-26 04:21:40.2:   Usually this is a result of a device or USB failure or lock-up.
2023-01-26 04:21:40.3: Running C:\windows\syswow64\cscript.exe
2023-01-26 04:21:40.3: Arguments: '//NoLogo "C:\Users\Public\Documents\ACP Config\Scheduler\ShutdownObs.js"'
2023-01-26 04:21:40.4: Results look OK, the tool returned this text:
2023-01-26 04:21:40.4:   ''
2023-01-26 04:21:40.6: Run statistics:
2023-01-26 04:21:40.6:   Observations:   269
2023-01-26 04:21:40.6:   Considered:     19
2023-01-26 04:21:40.6:   Completed:      1
2023-01-26 04:21:40.6:   Skipped:        0
2023-01-26 04:21:40.6:   Never Eligible: 250
2023-01-26 04:21:40.6:   Failed:         18
2023-01-26 04:21:40.6: Shutter-Open efficiency: 63.59%
2023-01-26 04:21:40.6: Overall Efficiency: 98.69%
Log closed at Thu, Jan 26 2023 04:21:43 UTC (actual time)