Log opened at Sun, May 15 2022 03:31:37 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
2022-05-15 03:31:39.0: ++ Observatory Startup ++
2022-05-15 03:31:39.2: Weather safety is now disabled
2022-05-15 03:31:39.2: Start ACP Sequencer's StartupObs script
2022-05-15 03:32:32.8: Weather safety is re-enabled
2022-05-15 03:32:32.8: Weather safety is now disabled
2022-05-15 03:32:32.8: Open the observatory dome/roof
2022-05-15 03:33:33.5: Weather safety is re-enabled
2022-05-15 03:33:33.5: Observatory startup succeeded, and dome opened successfully
2022-05-15 03:33:33.5: ++ Auto Focus ++
2022-05-15 03:33:33.6: Doing initial autofocus.
2022-05-15 03:33:33.6: Start special ACP AutoFocus script for scheduler
2022-05-15 03:39:44.3: Next periodic autofocus ASAP after 3600sec. 15-May-2022 04:39:30 UTC
2022-05-15 03:39:49.5: Plan IR_Com has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.5: Plan V1687_Cyg has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.5: Plan AG_Dra has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan CSS_J212625 has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan HD168418 has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan HR_Lyr has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan HS1340+1524 has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan IR_Com has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan KP_Cyg has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan KU_Cyg has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan M56_V6 has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan MN84 has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan NSV_11154 has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan NSV_11749 has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan PNV_17291350 has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan RS_Sge has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan U_Leo has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan U_Sco has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan V1412_Aql has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan V1687_Cyg has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan V2492_Cyg has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan V413_Aql has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan V5631_Sgr has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan V884_Her has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan X_Boo has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan X_Ser has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:49.6: Plan V1674_Her has Monitor Mode. Time to resubmit it.
2022-05-15 03:39:50.6: Plan Melotte_111 deferred, too early
2022-05-15 03:39:51.0: Plan NGC_7790 deferred, too early
2022-05-15 03:39:51.3: Plan RY_Ser deferred, too early
2022-05-15 03:39:52.5: Dispatcher cycle time: 8.2 sec.
2022-05-15 03:39:52.5: Acquire data for Observation IR_Com...
2022-05-15 03:39:52.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan IR_Com)
2022-05-15 03:39:52.6: Send Observation IR_Com to ACP Sequencer
2022-05-15 03:56:10.2: Acquisition time: 977.5646334 sec.
2022-05-15 03:56:10.2: Data for Observation IR_Com of Plan IR_Com acquired successfully.
2022-05-15 03:56:10.2: Plan IR_Com completed successfully.
2022-05-15 03:56:10.2: Image Efficiency: 73.0%
2022-05-15 03:56:10.2: Cycle Efficiency: 99.2%
2022-05-15 03:56:11.1: Dispatcher cycle time: 0.7 sec.
2022-05-15 03:56:11.1: Acquire data for Observation HS1340+1524...
2022-05-15 03:56:11.1:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan HS1340+1524)
2022-05-15 03:56:11.1: Send Observation HS1340+1524 to ACP Sequencer
2022-05-15 03:58:45.3: ACP data acquisition failed for Observation HS1340+1524.
2022-05-15 03:58:45.3:   (Observation HS1340+1524 interrupted by acquisition process failure.)
2022-05-15 03:59:13.6: Dispatcher cycle time: 0.5 sec.
2022-05-15 03:59:13.6: Acquire data for Observation U_Leo...
2022-05-15 03:59:13.6:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan U_Leo)
2022-05-15 03:59:13.6: Send Observation U_Leo to ACP Sequencer
2022-05-15 04:10:41.4: Acquisition time: 687.7664631 sec.
2022-05-15 04:10:41.4: Data for Observation U_Leo of Plan U_Leo acquired successfully.
2022-05-15 04:10:41.4: Plan U_Leo completed successfully.
2022-05-15 04:10:41.4: Image Efficiency: 69.7%
2022-05-15 04:10:41.4: Cycle Efficiency: 99.9%
2022-05-15 04:10:42.0: Dispatcher cycle time: 0.4 sec.
2022-05-15 04:10:42.0: Acquire data for Observation X_Boo...
2022-05-15 04:10:42.0:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan X_Boo)
2022-05-15 04:10:42.0: Send Observation X_Boo to ACP Sequencer
2022-05-15 04:17:19.4: Acquisition time: 397.3525475 sec.
2022-05-15 04:17:19.4: Data for Observation X_Boo of Plan X_Boo acquired successfully.
2022-05-15 04:17:19.4: Plan X_Boo completed successfully.
2022-05-15 04:17:19.4: Image Efficiency: 11.6%
2022-05-15 04:17:19.4: Cycle Efficiency: 99.9%
2022-05-15 04:17:19.9: Dispatcher cycle time: 0.4 sec.
2022-05-15 04:17:19.9: Acquire data for Observation AG_Dra...
2022-05-15 04:17:19.9:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan AG_Dra)
2022-05-15 04:17:20.0: Send Observation AG_Dra to ACP Sequencer
2022-05-15 04:24:04.7: Acquisition time: 404.7380431 sec.
2022-05-15 04:24:04.7: Data for Observation AG_Dra of Plan AG_Dra acquired successfully.
2022-05-15 04:24:04.7: Plan AG_Dra completed successfully.
2022-05-15 04:24:04.8: Image Efficiency: 44.4%
2022-05-15 04:24:04.8: Cycle Efficiency: 99.9%
2022-05-15 04:24:05.3: Dispatcher cycle time: 0.4 sec.
2022-05-15 04:24:05.3: Acquire data for Observation IR_Com...
2022-05-15 04:24:05.3:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver2706, Plan IR_Com)
2022-05-15 04:24:05.3: Send Observation IR_Com to ACP Sequencer
2022-05-15 04:40:14.3: Acquisition time: 969.0452973 sec.
2022-05-15 04:40:14.3: Data for Observation IR_Com of Plan IR_Com acquired successfully.
2022-05-15 04:40:14.4: Plan IR_Com completed successfully.
2022-05-15 04:40:14.4: Image Efficiency: 74.3%
2022-05-15 04:40:14.4: Cycle Efficiency: 100.0%
2022-05-15 04:40:14.5: ++ Auto Focus ++
2022-05-15 04:40:14.6: Doing periodic autofocus.
2022-05-15 04:40:14.6: Start special ACP AutoFocus script for scheduler
2022-05-15 04:45:49.3: Next periodic autofocus ASAP after 3600sec. 15-May-2022 05:45:30 UTC
2022-05-15 04:45:49.7: Dispatcher cycle time: 0.4 sec.
2022-05-15 04:45:49.7: Acquire data for Observation J072816...
2022-05-15 04:45:49.7:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan J072816)
2022-05-15 04:45:49.7: Send Observation J072816 to ACP Sequencer
2022-05-15 05:11:28.8: Acquisition time: 1539.0810336 sec.
2022-05-15 05:11:28.8: Data for Observation J072816 of Plan J072816 acquired successfully.
2022-05-15 05:11:28.8: Plan J072816 completed successfully.
2022-05-15 05:11:28.8: Image Efficiency: 74.0%
2022-05-15 05:11:28.8: Cycle Efficiency: 100.0%
2022-05-15 05:11:29.5: Dispatcher cycle time: 0.5 sec.
2022-05-15 05:11:29.5: Acquire data for Observation X_Ser...
2022-05-15 05:11:29.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan X_Ser)
2022-05-15 05:11:29.5: Send Observation X_Ser to ACP Sequencer
2022-05-15 05:23:01.6: Acquisition time: 692.1532597 sec.
2022-05-15 05:23:01.6: Data for Observation X_Ser of Plan X_Ser acquired successfully.
2022-05-15 05:23:01.7: Plan X_Ser completed successfully.
2022-05-15 05:23:01.7: Image Efficiency: 52.0%
2022-05-15 05:23:01.7: Cycle Efficiency: 99.9%
2022-05-15 05:23:02.4: Dispatcher cycle time: 0.6 sec.
2022-05-15 05:23:02.4: Acquire data for Observation M3-V154...
2022-05-15 05:23:02.4:   (belongs to Project AAVSO_P246_KPRB_AUTO_ver3043, Plan M3-V154)
2022-05-15 05:23:02.4: Send Observation M3-V154 to ACP Sequencer
2022-05-15 05:28:03.1: Acquisition time: 300.6585264 sec.
2022-05-15 05:28:03.1: Data for Observation M3-V154 of Plan M3-V154 acquired successfully.
2022-05-15 05:28:03.1: Plan M3-V154 completed successfully.
2022-05-15 05:28:03.1: Image Efficiency: 34.9%
2022-05-15 05:28:03.1: Cycle Efficiency: 99.8%
2022-05-15 05:28:03.8: Dispatcher cycle time: 0.6 sec.
2022-05-15 05:28:03.8: Acquire data for Observation NSV_11154...
2022-05-15 05:28:03.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan NSV_11154)
2022-05-15 05:28:03.9: Send Observation NSV_11154 to ACP Sequencer
2022-05-15 05:54:09.2: Acquisition time: 1565.3134444 sec.
2022-05-15 05:54:09.2: Data for Observation NSV_11154 of Plan NSV_11154 acquired successfully.
2022-05-15 05:54:09.2: Plan NSV_11154 completed successfully.
2022-05-15 05:54:09.2: Image Efficiency: 72.8%
2022-05-15 05:54:09.2: Cycle Efficiency: 100.0%
2022-05-15 05:54:09.4: ++ Auto Focus ++
2022-05-15 05:54:09.4: Doing periodic autofocus.
2022-05-15 05:54:09.4: Start special ACP AutoFocus script for scheduler
2022-05-15 06:01:12.2: Next periodic autofocus ASAP after 3600sec. 15-May-2022 07:00:54 UTC
2022-05-15 06:01:13.2: Dispatcher cycle time: 1.0 sec.
2022-05-15 06:01:13.2: Acquire data for Observation U_Sco...
2022-05-15 06:01:13.2:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan U_Sco)
2022-05-15 06:01:13.2: Send Observation U_Sco to ACP Sequencer
2022-05-15 06:03:19.6: ACP data acquisition failed for Observation U_Sco.
2022-05-15 06:03:19.6:   (Observation U_Sco interrupted by acquisition process failure.)
2022-05-15 06:03:20.7: Dispatcher cycle time: 0.9 sec.
2022-05-15 06:03:20.7: Acquire data for Observation V884_Her...
2022-05-15 06:03:20.7:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan V884_Her)
2022-05-15 06:03:20.8: Send Observation V884_Her to ACP Sequencer
2022-05-15 06:10:04.6: Acquisition time: 403.8432345 sec.
2022-05-15 06:10:04.6: Data for Observation V884_Her of Plan V884_Her acquired successfully.
2022-05-15 06:10:04.6: Plan V884_Her completed successfully.
2022-05-15 06:10:04.7: Image Efficiency: 44.5%
2022-05-15 06:10:04.7: Cycle Efficiency: 99.8%
2022-05-15 06:10:05.8: Dispatcher cycle time: 1.0 sec.
2022-05-15 06:10:05.8: Acquire data for Observation HR_Lyr...
2022-05-15 06:10:05.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan HR_Lyr)
2022-05-15 06:10:05.8: Send Observation HR_Lyr to ACP Sequencer
2022-05-15 06:28:05.6: Acquisition time: 1079.8140317 sec.
2022-05-15 06:28:05.6: Data for Observation HR_Lyr of Plan HR_Lyr acquired successfully.
2022-05-15 06:28:05.7: Plan HR_Lyr completed successfully.
2022-05-15 06:28:05.7: Image Efficiency: 77.7%
2022-05-15 06:28:05.7: Cycle Efficiency: 99.9%
2022-05-15 06:28:07.1: Dispatcher cycle time: 1.2 sec.
2022-05-15 06:28:07.1: Acquire data for Observation RY_Ser...
2022-05-15 06:28:07.1:   (belongs to Project AAVSO_P249_RBCA_AUTO_ver3073, Plan RY_Ser)
2022-05-15 06:28:07.1: Send Observation RY_Ser to ACP Sequencer
2022-05-15 06:46:33.2: Acquisition time: 1106.0268754 sec.
2022-05-15 06:46:33.2: Data for Observation RY_Ser of Plan RY_Ser acquired successfully.
2022-05-15 06:46:33.2: Plan RY_Ser completed successfully.
2022-05-15 06:46:33.2: Image Efficiency: 81.3%
2022-05-15 06:46:33.2: Cycle Efficiency: 99.9%
2022-05-15 06:46:34.6: Dispatcher cycle time: 1.3 sec.
2022-05-15 06:46:34.6: Acquire data for Observation M56_V6...
2022-05-15 06:46:34.6:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan M56_V6)
2022-05-15 06:46:34.6: Send Observation M56_V6 to ACP Sequencer
2022-05-15 07:03:47.5: Acquisition time: 1032.9486408 sec.
2022-05-15 07:03:47.5: Data for Observation M56_V6 of Plan M56_V6 acquired successfully.
2022-05-15 07:03:47.6: Plan M56_V6 completed successfully.
2022-05-15 07:03:47.6: Image Efficiency: 75.4%
2022-05-15 07:03:47.6: Cycle Efficiency: 99.9%
2022-05-15 07:03:47.7: ++ Auto Focus ++
2022-05-15 07:03:47.8: Doing periodic autofocus.
2022-05-15 07:03:47.8: Start special ACP AutoFocus script for scheduler
2022-05-15 07:09:22.7: Next periodic autofocus ASAP after 3600sec. 15-May-2022 08:09:03 UTC
2022-05-15 07:09:24.9: Dispatcher cycle time: 2.2 sec.
2022-05-15 07:09:24.9: Acquire data for Observation PNV_17291350...
2022-05-15 07:09:24.9:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan PNV_17291350)
2022-05-15 07:09:24.9: Doing 3 sets
2022-05-15 07:09:24.9: Send Observation PNV_17291350 to ACP Sequencer
2022-05-15 07:14:53.2: Send Observation PNV_17291350 to ACP Sequencer
2022-05-15 07:19:05.4: Send Observation PNV_17291350 to ACP Sequencer
2022-05-15 07:23:46.7: Acquisition time: 861.7538845 sec.
2022-05-15 07:23:46.7: Data for Observation PNV_17291350 of Plan PNV_17291350 acquired successfully.
2022-05-15 07:23:46.7: Plan PNV_17291350 completed successfully.
2022-05-15 07:23:46.8: Image Efficiency: 45.1%
2022-05-15 07:23:46.8: Cycle Efficiency: 99.7%
2022-05-15 07:23:48.8: Dispatcher cycle time: 1.9 sec.
2022-05-15 07:23:48.8: Acquire data for Observation MN84...
2022-05-15 07:23:48.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan MN84)
2022-05-15 07:23:48.9: Send Observation MN84 to ACP Sequencer
2022-05-15 07:46:32.6: Acquisition time: 1363.6859112 sec.
2022-05-15 07:46:32.6: Data for Observation MN84 of Plan MN84 acquired successfully.
2022-05-15 07:46:32.6: Plan MN84 completed successfully.
2022-05-15 07:46:32.6: Image Efficiency: 79.1%
2022-05-15 07:46:32.6: Cycle Efficiency: 99.9%
2022-05-15 07:46:34.5: Dispatcher cycle time: 1.8 sec.
2022-05-15 07:46:34.5: Acquire data for Observation HD168418...
2022-05-15 07:46:34.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan HD168418)
2022-05-15 07:46:34.5: Send Observation HD168418 to ACP Sequencer
2022-05-15 07:52:52.7: Acquisition time: 378.227201 sec.
2022-05-15 07:52:52.7: Data for Observation HD168418 of Plan HD168418 acquired successfully.
2022-05-15 07:52:53.3: Plan HD168418 completed successfully.
2022-05-15 07:52:53.4: Image Efficiency: 28.1%
2022-05-15 07:52:53.4: Cycle Efficiency: 99.4%
2022-05-15 07:52:56.4: Dispatcher cycle time: 2.9 sec.
2022-05-15 07:52:56.4: Acquire data for Observation NSV_11749...
2022-05-15 07:52:56.4:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan NSV_11749)
2022-05-15 07:52:56.7: Send Observation NSV_11749 to ACP Sequencer
2022-05-15 07:58:18.5: ** Script interrupted by weather safety event.
2022-05-15 07:59:57.2: ACP ABORT: Acquisition process was interrupted by weather unsafe.
2022-05-15 07:59:57.2: ACP data acquisition failed for Observation NSV_11749.
2022-05-15 07:59:57.2:   (Plan NSV_11749 will be resubmitted in its entirety.
2022-05-15 07:59:57.2:   (Observation NSV_11749 interrupted by weather unsafe event.)
2022-05-15 07:59:57.6: -- Weather Unsafe --
2022-05-15 08:18:18.6: ++ Weather Safe ++
2022-05-15 08:18:23.4: ++ Observatory Startup ++
2022-05-15 08:18:23.5: Weather safety is now disabled
2022-05-15 08:18:23.5: Start ACP Sequencer's StartupObs script
2022-05-15 08:19:38.9: Weather safety is re-enabled
2022-05-15 08:19:38.9: Weather safety is now disabled
2022-05-15 08:19:38.9: Open the observatory dome/roof
2022-05-15 08:20:39.6: Weather safety is re-enabled
2022-05-15 08:20:39.6: Observatory startup succeeded, and dome opened successfully
2022-05-15 08:20:41.3: ++ Auto Focus ++
2022-05-15 08:20:41.4: Doing initial autofocus.
2022-05-15 08:20:41.4: Start special ACP AutoFocus script for scheduler
2022-05-15 12:03:01.1: ** ACP script "AutoFocusScheduler" failed:
2022-05-15 12:03:01.1: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 78 column 9.

2022-05-15 12:03:01.1: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2022-05-15 12:03:08.0: ++ Dawn Flats ++
2022-05-15 12:03:08.6: Start ACP AutoFlat script for Dawn flats
2022-05-15 12:22:22.2: ** ACP script "AutoFlat" failed:
2022-05-15 12:22:22.2: **Script Error (Tracking has been stopped)**
Source:   AutoFlat
Message:    ** Looks like dome/roof closed!
Probably an error in the flat plan
Location: line 961 column 17.

2022-05-15 12:22:27.4: ++ Morning Cal Frames ++
2022-05-15 12:22:27.4: Weather safety is now disabled
2022-05-15 12:22:27.4: Weather safety is re-enabled
2022-05-15 12:22:27.4: Weather safety is now disabled
2022-05-15 12:22:27.4: Start ACP Sequencer's SchedulerCalFrames.txt observing plan
2022-05-15 12:23:48.0: Weather safety is re-enabled
2022-05-15 12:23:53.2: -- Observatory Shutdown --
2022-05-15 12:23:53.2: Weather safety is now disabled
2022-05-15 12:23:53.2: Start ACP Sequencer's ShutdownObs script
2022-05-15 12:24:11.0: Weather safety is re-enabled
2022-05-15 18:25:18.3: -- Weather Unsafe --
2022-05-15 18:46:36.9: ++ Weather Safe ++
2022-05-16 13:47:05.7: -- Weather Unsafe --
2022-05-16 14:07:19.6: ++ Weather Safe ++
2022-05-16 17:05:19.2: -- Weather Unsafe --
2022-05-16 17:25:34.5: ++ Weather Safe ++
2022-05-19 08:07:50.7: -- Weather Unsafe --
2022-05-19 08:41:37.5: ++ Weather Safe ++
2022-05-19 15:03:28.7: -- Weather Unsafe --
2022-05-19 15:23:32.4: ++ Weather Safe ++
2022-05-19 18:04:20.6: -- Weather Unsafe --
2022-05-19 18:24:18.0: ++ Weather Safe ++