Log opened at Sun, Feb 06 2022 00:43:02 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-02-06 00:45:15.4: ++ Observatory Startup ++
2022-02-06 00:45:15.5: Weather safety is now disabled
2022-02-06 00:45:15.5: Start ACP Sequencer's StartupObs script
2022-02-06 00:46:09.7: Weather safety is re-enabled
2022-02-06 00:46:09.7: Weather safety is now disabled
2022-02-06 00:46:09.8: Open the observatory dome/roof
2022-02-06 00:47:25.5: Weather safety is re-enabled
2022-02-06 00:47:25.5: Observatory startup succeeded, and dome opened successfully
2022-02-06 00:47:25.6: ++ Dusk Sky Flats ++
2022-02-06 00:47:25.6: Start ACP AutoFlat script for Dusk flats
2022-02-06 01:24:26.1: ++ Auto Focus ++
2022-02-06 01:24:26.2: Doing initial autofocus.
2022-02-06 01:24:26.2: Start special ACP AutoFocus script for scheduler
2022-02-06 01:29:33.3: Next periodic autofocus ASAP after 3600sec. 06-Feb-2022 02:29:20 UTC
2022-02-06 01:29:38.6: Plan EE_Cep has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan AG_Dra has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan AO_Aur has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan AZ_Cas has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan B0133+47 has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan BX_Pup has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan CSS091110:060919-064155 has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan CW_Mon has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan DW_Cas has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan ER_Aur has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan FS_Aur has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan GR_Ori has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan GZ_Cnc has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan HQ_Mon has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan HQ_Per has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan HS1340+1524 has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan IR_Com has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan J072816 has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan KK_Cas has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan NSV_11154 has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.6: Plan NSVS_0421121 has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan OI_158 has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan OJ287 has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan QZ_Aur has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan SU_Lyn has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan TT_Ari has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan TV_Cam has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan U_Leo has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan U_Sco has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan V370_And has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan V407_Cas has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan V504_Per has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan V630_Cas has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan X_Boo has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan X_Ser has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan YZ_Aur has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:38.7: Plan V1674_Her has Monitor Mode. Time to resubmit it.
2022-02-06 01:29:39.4: Plan GP_Com couldn't be run before latest time, failed.
2022-02-06 01:29:39.9: Plan M67 deferred, too early
2022-02-06 01:29:39.9: Plan Melotte_111 deferred, too early
2022-02-06 01:29:40.0: Plan NGC_7790 deferred, too early
2022-02-06 01:29:41.4: Plan YZ_LMi couldn't be run before latest time, failed.
2022-02-06 01:29:42.7: Dispatcher cycle time: 9.4 sec.
2022-02-06 01:29:42.7: Acquire data for Observation GZ_Cet...
2022-02-06 01:29:42.7:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan GZ_Cet)
2022-02-06 01:29:42.8: Send Observation GZ_Cet to ACP Sequencer
2022-02-06 01:53:00.8: Acquisition time: 1397.9941305 sec.
2022-02-06 01:53:00.8: Data for Observation GZ_Cet of Plan GZ_Cet acquired successfully.
2022-02-06 01:53:00.9: Plan GZ_Cet completed successfully.
2022-02-06 01:53:00.9: Image Efficiency: 76.7%
2022-02-06 01:53:00.9: Cycle Efficiency: 99.3%
2022-02-06 01:53:04.7: Dispatcher cycle time: 3.7 sec.
2022-02-06 01:53:04.7: Acquire data for Observation V630_Cas...
2022-02-06 01:53:04.7:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan V630_Cas)
2022-02-06 01:53:04.7: Send Observation V630_Cas to ACP Sequencer
2022-02-06 02:05:30.3: Acquisition time: 745.5227579 sec.
2022-02-06 02:05:30.3: Data for Observation V630_Cas of Plan V630_Cas acquired successfully.
2022-02-06 02:05:30.3: Plan V630_Cas completed successfully.
2022-02-06 02:05:30.3: Image Efficiency: 72.1%
2022-02-06 02:05:30.3: Cycle Efficiency: 99.5%
2022-02-06 02:05:32.6: Dispatcher cycle time: 2.1 sec.
2022-02-06 02:05:32.6: Acquire data for Observation DW_Cas...
2022-02-06 02:05:32.6:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan DW_Cas)
2022-02-06 02:05:32.6: Send Observation DW_Cas to ACP Sequencer
2022-02-06 02:17:06.8: Acquisition time: 694.1903178 sec.
2022-02-06 02:17:06.8: Data for Observation DW_Cas of Plan DW_Cas acquired successfully.
2022-02-06 02:17:06.9: Plan DW_Cas completed successfully.
2022-02-06 02:17:06.9: Image Efficiency: 54.6%
2022-02-06 02:17:06.9: Cycle Efficiency: 99.7%
2022-02-06 02:17:09.7: Dispatcher cycle time: 2.6 sec.
2022-02-06 02:17:09.7: Acquire data for Observation KK_Cas...
2022-02-06 02:17:09.7:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan KK_Cas)
2022-02-06 02:17:09.7: Send Observation KK_Cas to ACP Sequencer
2022-02-06 02:31:19.5: Acquisition time: 849.8256348 sec.
2022-02-06 02:31:19.5: Data for Observation KK_Cas of Plan KK_Cas acquired successfully.
2022-02-06 02:31:19.6: Plan KK_Cas completed successfully.
2022-02-06 02:31:19.6: Image Efficiency: 65.7%
2022-02-06 02:31:19.6: Cycle Efficiency: 99.7%
2022-02-06 02:31:19.8: ++ Auto Focus ++
2022-02-06 02:31:19.8: Doing periodic autofocus.
2022-02-06 02:31:19.8: Start special ACP AutoFocus script for scheduler
2022-02-06 02:35:11.7: Next periodic autofocus ASAP after 3600sec. 06-Feb-2022 03:34:52 UTC
2022-02-06 02:35:14.4: Dispatcher cycle time: 2.7 sec.
2022-02-06 02:35:14.4: Acquire data for Observation CGCS_5926...
2022-02-06 02:35:14.4:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan CGCS_5926)
2022-02-06 02:35:14.4: Send Observation CGCS_5926 to ACP Sequencer
2022-02-06 03:00:54.8: Acquisition time: 1540.4016546 sec.
2022-02-06 03:00:54.8: Data for Observation CGCS_5926 of Plan CGCS_5926 acquired successfully.
2022-02-06 03:00:54.9: Plan CGCS_5926 completed successfully.
2022-02-06 03:00:54.9: Image Efficiency: 75.2%
2022-02-06 03:00:54.9: Cycle Efficiency: 99.8%
2022-02-06 03:00:57.4: Dispatcher cycle time: 2.4 sec.
2022-02-06 03:00:57.4: Acquire data for Observation V407_Cas...
2022-02-06 03:00:57.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan V407_Cas)
2022-02-06 03:00:57.5: Send Observation V407_Cas to ACP Sequencer
2022-02-06 03:15:28.4: Acquisition time: 870.9161248 sec.
2022-02-06 03:15:28.4: Data for Observation V407_Cas of Plan V407_Cas acquired successfully.
2022-02-06 03:15:28.5: Plan V407_Cas completed successfully.
2022-02-06 03:15:28.5: Image Efficiency: 64.1%
2022-02-06 03:15:28.5: Cycle Efficiency: 99.7%
2022-02-06 03:15:31.2: Dispatcher cycle time: 2.6 sec.
2022-02-06 03:15:31.2: Acquire data for Observation TT_Ari...
2022-02-06 03:15:31.2:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan TT_Ari)
2022-02-06 03:15:31.3: Send Observation TT_Ari to ACP Sequencer
2022-02-06 03:39:05.0: Acquisition time: 1413.6989468 sec.
2022-02-06 03:39:05.0: Data for Observation TT_Ari of Plan TT_Ari acquired successfully.
2022-02-06 03:39:05.0: Plan TT_Ari completed successfully.
2022-02-06 03:39:05.1: Image Efficiency: 76.3%
2022-02-06 03:39:05.1: Cycle Efficiency: 99.8%
2022-02-06 03:39:05.2: ++ Auto Focus ++
2022-02-06 03:39:05.3: Doing periodic autofocus.
2022-02-06 03:39:05.3: Start special ACP AutoFocus script for scheduler
2022-02-06 03:44:34.4: Next periodic autofocus ASAP after 3600sec. 06-Feb-2022 04:44:19 UTC
2022-02-06 03:44:36.7: Dispatcher cycle time: 2.3 sec.
2022-02-06 03:44:36.7: Acquire data for Observation B0133+47...
2022-02-06 03:44:36.7:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan B0133+47)
2022-02-06 03:44:36.8: Send Observation B0133+47 to ACP Sequencer
2022-02-06 03:56:50.3: Acquisition time: 733.4725393 sec.
2022-02-06 03:56:50.3: Data for Observation B0133+47 of Plan B0133+47 acquired successfully.
2022-02-06 03:56:50.3: Plan B0133+47 completed successfully.
2022-02-06 03:56:50.3: Image Efficiency: 73.4%
2022-02-06 03:56:50.3: Cycle Efficiency: 99.7%
2022-02-06 03:56:52.3: Dispatcher cycle time: 1.8 sec.
2022-02-06 03:56:52.3: Acquire data for Observation V370_And...
2022-02-06 03:56:52.3:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan V370_And)
2022-02-06 03:56:52.3: Send Observation V370_And to ACP Sequencer
2022-02-06 03:59:06.1: Acquisition time: 133.8228375 sec.
2022-02-06 03:59:06.1: Data for Observation V370_And of Plan V370_And acquired successfully.
2022-02-06 03:59:06.2: Plan V370_And completed successfully.
2022-02-06 03:59:06.2: Image Efficiency: 14.7%
2022-02-06 03:59:06.2: Cycle Efficiency: 98.6%
2022-02-06 03:59:08.0: Dispatcher cycle time: 1.7 sec.
2022-02-06 03:59:08.0: Acquire data for Observation AZ_Cas...
2022-02-06 03:59:08.0:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan AZ_Cas)
2022-02-06 03:59:08.1: Send Observation AZ_Cas to ACP Sequencer
2022-02-06 04:01:41.1: Acquisition time: 153.0457741 sec.
2022-02-06 04:01:41.1: Data for Observation AZ_Cas of Plan AZ_Cas acquired successfully.
2022-02-06 04:01:41.1: Plan AZ_Cas completed successfully.
2022-02-06 04:01:41.2: Image Efficiency: 19.4%
2022-02-06 04:01:41.2: Cycle Efficiency: 98.8%
2022-02-06 04:01:43.8: Dispatcher cycle time: 2.5 sec.
2022-02-06 04:01:43.8: Acquire data for Observation V504_Per...
2022-02-06 04:01:43.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan V504_Per)
2022-02-06 04:01:43.8: Send Observation V504_Per to ACP Sequencer
2022-02-06 04:10:48.6: Acquisition time: 544.7475145 sec.
2022-02-06 04:10:48.6: Data for Observation V504_Per of Plan V504_Per acquired successfully.
2022-02-06 04:10:48.6: Plan V504_Per completed successfully.
2022-02-06 04:10:48.6: Image Efficiency: 33.6%
2022-02-06 04:10:48.6: Cycle Efficiency: 99.5%
2022-02-06 04:10:50.7: Dispatcher cycle time: 2.0 sec.
2022-02-06 04:10:50.7: Acquire data for Observation NSVS_0421121...
2022-02-06 04:10:50.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan NSVS_0421121)
2022-02-06 04:10:50.8: Send Observation NSVS_0421121 to ACP Sequencer
2022-02-06 04:28:54.3: Acquisition time: 1083.4782213 sec.
2022-02-06 04:28:54.3: Data for Observation NSVS_0421121 of Plan NSVS_0421121 acquired successfully.
2022-02-06 04:28:54.4: Plan NSVS_0421121 completed successfully.
2022-02-06 04:28:54.4: Image Efficiency: 82.9%
2022-02-06 04:28:54.4: Cycle Efficiency: 99.8%
2022-02-06 04:28:56.5: Dispatcher cycle time: 2.0 sec.
2022-02-06 04:28:56.5: Acquire data for Observation GR_Ori...
2022-02-06 04:28:56.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan GR_Ori)
2022-02-06 04:28:56.5: Send Observation GR_Ori to ACP Sequencer
2022-02-06 04:38:24.8: Acquisition time: 568.2397087 sec.
2022-02-06 04:38:24.8: Data for Observation GR_Ori of Plan GR_Ori acquired successfully.
2022-02-06 04:38:24.8: Plan GR_Ori completed successfully.
2022-02-06 04:38:24.8: Image Efficiency: 47.3%
2022-02-06 04:38:24.8: Cycle Efficiency: 99.6%
2022-02-06 04:38:27.1: Dispatcher cycle time: 2.2 sec.
2022-02-06 04:38:27.2: Acquire data for Observation CSS091110:060919-064155...
2022-02-06 04:38:27.2:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan CSS091110:060919-064155)
2022-02-06 04:38:27.2: Send Observation CSS091110:060919-064155 to ACP Sequencer
2022-02-06 05:00:49.9: Acquisition time: 1342.6870393 sec.
2022-02-06 05:00:49.9: Data for Observation CSS091110:060919-064155 of Plan CSS091110:060919-064155 acquired successfully.
2022-02-06 05:00:49.9: Plan CSS091110:060919-064155 completed successfully.
2022-02-06 05:00:50.0: Image Efficiency: 71.4%
2022-02-06 05:00:50.0: Cycle Efficiency: 99.8%
2022-02-06 05:00:50.1: ++ Auto Focus ++
2022-02-06 05:00:50.1: Doing periodic autofocus.
2022-02-06 05:00:50.1: Start special ACP AutoFocus script for scheduler
2022-02-06 05:05:15.3: Next periodic autofocus ASAP after 3600sec. 06-Feb-2022 06:05:00 UTC
2022-02-06 05:05:17.7: Dispatcher cycle time: 2.4 sec.
2022-02-06 05:05:17.7: Acquire data for Observation BX_Pup...
2022-02-06 05:05:17.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan BX_Pup)
2022-02-06 05:05:17.8: Send Observation BX_Pup to ACP Sequencer
2022-02-06 05:17:39.4: Acquisition time: 741.5662411 sec.
2022-02-06 05:17:39.4: Data for Observation BX_Pup of Plan BX_Pup acquired successfully.
2022-02-06 05:17:39.4: Plan BX_Pup completed successfully.
2022-02-06 05:17:39.4: Image Efficiency: 72.6%
2022-02-06 05:17:39.4: Cycle Efficiency: 99.7%
2022-02-06 05:17:41.6: Dispatcher cycle time: 2.0 sec.
2022-02-06 05:17:41.6: Acquire data for Observation TV_Cam...
2022-02-06 05:17:41.6:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan TV_Cam)
2022-02-06 05:17:41.6: Send Observation TV_Cam to ACP Sequencer
2022-02-06 05:33:32.3: Acquisition time: 950.6511681 sec.
2022-02-06 05:33:32.3: Data for Observation TV_Cam of Plan TV_Cam acquired successfully.
2022-02-06 05:33:32.3: Plan TV_Cam completed successfully.
2022-02-06 05:33:32.4: Image Efficiency: 58.8%
2022-02-06 05:33:32.4: Cycle Efficiency: 99.8%
2022-02-06 05:33:34.6: Dispatcher cycle time: 2.1 sec.
2022-02-06 05:33:34.6: Acquire data for Observation HQ_Per...
2022-02-06 05:33:34.6:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan HQ_Per)
2022-02-06 05:33:34.7: Send Observation HQ_Per to ACP Sequencer
2022-02-06 05:48:30.0: Acquisition time: 895.3459046 sec.
2022-02-06 05:48:30.0: Data for Observation HQ_Per of Plan HQ_Per acquired successfully.
2022-02-06 05:48:30.1: Plan HQ_Per completed successfully.
2022-02-06 05:48:30.1: Image Efficiency: 62.4%
2022-02-06 05:48:30.1: Cycle Efficiency: 99.8%
2022-02-06 05:48:32.3: Dispatcher cycle time: 2.1 sec.
2022-02-06 05:48:32.3: Acquire data for Observation CW_Mon...
2022-02-06 05:48:32.3:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan CW_Mon)
2022-02-06 05:48:32.4: Send Observation CW_Mon to ACP Sequencer
2022-02-06 05:58:21.5: Acquisition time: 589.0959129 sec.
2022-02-06 05:58:21.5: Data for Observation CW_Mon of Plan CW_Mon acquired successfully.
2022-02-06 05:58:21.5: Plan CW_Mon completed successfully.
2022-02-06 05:58:21.5: Image Efficiency: 60.9%
2022-02-06 05:58:21.5: Cycle Efficiency: 99.6%
2022-02-06 05:58:23.2: Dispatcher cycle time: 1.6 sec.
2022-02-06 05:58:23.2: Acquire data for Observation QZ_Aur...
2022-02-06 05:58:23.2:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan QZ_Aur)
2022-02-06 05:58:23.3: Send Observation QZ_Aur to ACP Sequencer
2022-02-06 06:30:11.9: Acquisition time: 1908.6294145 sec.
2022-02-06 06:30:11.9: Data for Observation QZ_Aur of Plan QZ_Aur acquired successfully.
2022-02-06 06:30:12.0: Plan QZ_Aur completed successfully.
2022-02-06 06:30:12.0: Image Efficiency: 73.3%
2022-02-06 06:30:12.0: Cycle Efficiency: 99.9%
2022-02-06 06:30:12.2: ++ Auto Focus ++
2022-02-06 06:30:12.3: Doing periodic autofocus.
2022-02-06 06:30:12.3: Start special ACP AutoFocus script for scheduler
2022-02-06 06:35:23.9: Next periodic autofocus ASAP after 3600sec. 06-Feb-2022 07:35:03 UTC
2022-02-06 06:35:25.6: Dispatcher cycle time: 1.7 sec.
2022-02-06 06:35:25.6: Acquire data for Observation ER_Aur...
2022-02-06 06:35:25.6:   (belongs to Project AAVSO_survey_HQ_AUTO_ver2706, Plan ER_Aur)
2022-02-06 06:35:25.6: Send Observation ER_Aur to ACP Sequencer
2022-02-06 06:49:55.6: **EXCEPTION IN SCHEDULER:
2022-02-06 06:49:55.6: 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))
2022-02-06 06:49:56.2: Traceback:
   at System.RuntimeType.InvokeDispMethod(String name, BindingFlags invokeAttr, Object target, Object[] args, Boolean[] byrefModifiers, Int32 culture, String[] namedParameters)
   at System.RuntimeType.InvokeMember(String name, BindingFlags bindingFlags, Binder binder, Object target, Object[] providedArgs, ParameterModifier[] modifiers, CultureInfo culture, String[] namedParams)
   at System.Type.InvokeMember(String name, BindingFlags invokeAttr, Binder binder, Object target, Object[] args)
   at DC3.Scheduler.ACPSequencer.RunScript(String scrPath, String param)
   at DC3.Scheduler.ACPSequencer.AcquireData(Observation Obs)
   at DC3.Scheduler.Engine.DoSchedulePass()
   at DC3.Scheduler.Engine.Run()
2022-02-06 06:49:56.2: DOME/ROOF FAILURE: In addition, attempting to close your dome/roof this error occurred:
2022-02-06 06:49:56.2: 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))
2022-02-06 06:49:56.8: No operator intervention command tool specified