Log opened at Thu, Oct 11 2018 02:10:46 UTC (actual time)
Current log level is Verbose
ACP Expert Scheduler version 8.1.1
Full license: Arne Henden
2018-10-11 02:10:47.2: ++ Observatory Startup ++
2018-10-11 02:10:47.2: Start ACP Sequencer's StartupObs script
2018-10-11 02:11:42.6: Open the observatory dome/roof
2018-10-11 02:12:50.4: Observatory startup succeeded, and dome opened successfully
2018-10-11 02:12:50.4: ++ Auto Focus ++
2018-10-11 02:12:50.4: Doing initial autofocus.
2018-10-11 02:12:50.4: Start special ACP AutoFocus script for scheduler
2018-10-11 02:17:07.8: Next periodic autofocus ASAP after 11-Oct-2018 05:16:49 UTC
2018-10-11 02:17:08.1: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan GSC_4030_204 has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan V0809_Cep has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan V1724_Aql has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan V0965_Per has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan V1723_Aql has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan V1722_Aql has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan V1721_Aql has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan SDSS073224 has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan NGC_7790 has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan U_Aqr has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan V339_Del_TMO61 has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan HX_Aur has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan FU_Cam has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan FW_Cam has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan FY_Cam has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan HI_Cam has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan CM_Cas has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.1: Plan V0524_Cas has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.2: Plan V1904_Cyg has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.3: Plan V1907_Cyg has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.3: Plan V2481_Cyg has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.3: Plan BC_Lac has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.3: Plan WZ_Per has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.3: Plan V0603_Per has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.3: Plan Mkn_501 has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:08.3: Plan AF_And has Monitor Mode. Time to resubmit it.
2018-10-11 02:17:09.2: Rising plan delay enabled for Plan AF_And:
2018-10-11 02:17:09.2:     560 min. remaining to meet strict constraints.
2018-10-11 02:17:09.2:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.2:     but only 254 min till mid-Plan transit.
2018-10-11 02:17:09.2:     deferred (rising) for 254 min, until 11-Oct-2018 06:31:21 UTC
2018-10-11 02:17:09.2: Rising plan delay enabled for Plan BC_Lac:
2018-10-11 02:17:09.2:     440 min. remaining to meet strict constraints.
2018-10-11 02:17:09.2:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.2:     but only 127 min till mid-Plan transit.
2018-10-11 02:17:09.2:     deferred (rising) for 127 min, until 11-Oct-2018 04:25:08 UTC
2018-10-11 02:17:09.2: Rising plan delay enabled for Plan CM_Cas:
2018-10-11 02:17:09.2:     679 min. remaining to meet strict constraints.
2018-10-11 02:17:09.2:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.2:     but only 323 min till mid-Plan transit.
2018-10-11 02:17:09.2:     deferred (rising) for 323 min, until 11-Oct-2018 07:40:33 UTC
2018-10-11 02:17:09.3: Rising plan delay enabled for Plan GSC_3649-0825:
2018-10-11 02:17:09.3:     503 min. remaining to meet strict constraints.
2018-10-11 02:17:09.3:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.3:     but only 177 min till mid-Plan transit.
2018-10-11 02:17:09.3:     deferred (rising) for 177 min, until 11-Oct-2018 05:15:02 UTC
2018-10-11 02:17:09.3: Rising plan delay enabled for Plan GSC_4030_204:
2018-10-11 02:17:09.3:     621 min. remaining to meet strict constraints.
2018-10-11 02:17:09.3:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.3:     but only 279 min till mid-Plan transit.
2018-10-11 02:17:09.3:     deferred (rising) for 279 min, until 11-Oct-2018 06:56:21 UTC
2018-10-11 02:17:09.3: Rising plan delay enabled for Plan NGC_7790:
2018-10-11 02:17:09.3:     551 min. remaining to meet strict constraints.
2018-10-11 02:17:09.3:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.3:     but only 209 min till mid-Plan transit.
2018-10-11 02:17:09.4:     deferred (rising) for 209 min, until 11-Oct-2018 05:46:19 UTC
2018-10-11 02:17:09.4: Rising plan delay enabled for Plan U_Aqr:
2018-10-11 02:17:09.4:     239 min. remaining to meet strict constraints.
2018-10-11 02:17:09.4:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.4:     but only 94 min till mid-Plan transit.
2018-10-11 02:17:09.4:     deferred (rising) for 94 min, until 11-Oct-2018 03:51:34 UTC
2018-10-11 02:17:09.4: Rising plan delay enabled for Plan V0524_Cas:
2018-10-11 02:17:09.4:     616 min. remaining to meet strict constraints.
2018-10-11 02:17:09.4:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.4:     but only 256 min till mid-Plan transit.
2018-10-11 02:17:09.4:     deferred (rising) for 256 min, until 11-Oct-2018 06:33:47 UTC
2018-10-11 02:17:09.4: Rising plan delay enabled for Plan V0809_Cep:
2018-10-11 02:17:09.4:     500 min. remaining to meet strict constraints.
2018-10-11 02:17:09.4:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.4:     but only 158 min till mid-Plan transit.
2018-10-11 02:17:09.4:     deferred (rising) for 158 min, until 11-Oct-2018 04:56:08 UTC
2018-10-11 02:17:09.5: Rising plan delay enabled for Plan V1904_Cyg:
2018-10-11 02:17:09.5:     348 min. remaining to meet strict constraints.
2018-10-11 02:17:09.5:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.5:     but only 55 min till mid-Plan transit.
2018-10-11 02:17:09.5:     deferred (rising) for 55 min, until 11-Oct-2018 03:13:04 UTC
2018-10-11 02:17:09.5: Rising plan delay enabled for Plan V1907_Cyg:
2018-10-11 02:17:09.5:     365 min. remaining to meet strict constraints.
2018-10-11 02:17:09.5:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.5:     but only 62 min till mid-Plan transit.
2018-10-11 02:17:09.5:     deferred (rising) for 62 min, until 11-Oct-2018 03:19:34 UTC
2018-10-11 02:17:09.5: Rising plan delay enabled for Plan V2481_Cyg:
2018-10-11 02:17:09.5:     335 min. remaining to meet strict constraints.
2018-10-11 02:17:09.5:     597 min. remaining for the plan to fit before dawn.
2018-10-11 02:17:09.5:     but only 35 min till mid-Plan transit.
2018-10-11 02:17:09.5:     deferred (rising) for 35 min, until 11-Oct-2018 02:52:41 UTC
2018-10-11 02:17:09.6: Dispatcher cycle time: 1.5 sec.
2018-10-11 02:17:09.6: Acquire data for Observation Mkn_501...
2018-10-11 02:17:09.6:   (belongs to Project AAVSO_SXAC_Mkn_501, Plan Mkn_501)
2018-10-11 02:17:09.6: Doing 3 sets
2018-10-11 02:17:09.7: Send Observation Mkn_501 to ACP Sequencer
2018-10-11 02:26:16.5: Send Observation Mkn_501 to ACP Sequencer
2018-10-11 02:33:40.1: Send Observation Mkn_501 to ACP Sequencer
2018-10-11 02:41:04.8: Acquisition time: 1435.1220091 sec.
2018-10-11 02:41:04.8: Data for Observation Mkn_501 of Plan Mkn_501 acquired successfully.
2018-10-11 02:41:04.8: Plan Mkn_501 completed successfully.
2018-10-11 02:41:04.8: Image Efficiency: 62.6%
2018-10-11 02:41:04.8: Cycle Efficiency: 99.9%
2018-10-11 02:41:08.6: Dispatcher cycle time: 0.3 sec.
2018-10-11 02:41:08.6: Acquire data for Observation V339_Del_TMO61...
2018-10-11 02:41:08.6:   (belongs to Project AAVSO_Monitoring, Plan V339_Del_TMO61)
2018-10-11 02:41:08.6: Doing 3 sets
2018-10-11 02:41:08.6: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-10-11 02:47:16.3: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-10-11 02:51:55.0: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-10-11 02:56:27.4: Acquisition time: 918.7212862 sec.
2018-10-11 02:56:27.4: Data for Observation V339_Del_TMO61 of Plan V339_Del_TMO61 acquired successfully.
2018-10-11 02:56:27.4: Plan V339_Del_TMO61 completed successfully.
2018-10-11 02:56:27.4: Image Efficiency: 29.4%
2018-10-11 02:56:27.4: Cycle Efficiency: 100.0%
2018-10-11 02:56:30.2: Dispatcher cycle time: 0.9 sec.
2018-10-11 02:56:30.2: Acquire data for Observation V1722_Aql...
2018-10-11 02:56:30.2:   (belongs to Project Nova_Monitoring, Plan V1722_Aql)
2018-10-11 02:56:32.4: Send Observation V1722_Aql to ACP Sequencer
2018-10-11 03:29:45.1: Acquisition time: 1992.6727897 sec.
2018-10-11 03:29:45.1: Data for Observation V1722_Aql of Plan V1722_Aql acquired successfully.
2018-10-11 03:29:45.1: Plan V1722_Aql completed successfully.
2018-10-11 03:29:45.1: Image Efficiency: 75.2%
2018-10-11 03:29:45.1: Cycle Efficiency: 100.0%
2018-10-11 03:29:46.9: Rising plan delay enabled for Plan FU_Cam:
2018-10-11 03:29:46.9:     691 min. remaining to meet strict constraints.
2018-10-11 03:29:46.9:     525 min. remaining for the plan to fit before dawn.
2018-10-11 03:29:46.9:     but only 341 min till mid-Plan transit.
2018-10-11 03:29:46.9:     deferred (rising) for 341 min, until 11-Oct-2018 09:11:11 UTC
2018-10-11 03:29:46.9: Rising plan delay enabled for Plan FW_Cam:
2018-10-11 03:29:46.9:     703 min. remaining to meet strict constraints.
2018-10-11 03:29:46.9:     525 min. remaining for the plan to fit before dawn.
2018-10-11 03:29:46.9:     but only 348 min till mid-Plan transit.
2018-10-11 03:29:46.9:     deferred (rising) for 348 min, until 11-Oct-2018 09:18:01 UTC
2018-10-11 03:29:47.1: Dispatcher cycle time: 0.3 sec.
2018-10-11 03:29:47.1: Acquire data for Observation V1721_Aql...
2018-10-11 03:29:47.1:   (belongs to Project Nova_Monitoring, Plan V1721_Aql)
2018-10-11 03:29:47.1: Send Observation V1721_Aql to ACP Sequencer
2018-10-11 04:01:41.5: Acquisition time: 1914.3626801 sec.
2018-10-11 04:01:41.5: Data for Observation V1721_Aql of Plan V1721_Aql acquired successfully.
2018-10-11 04:01:41.5: Plan V1721_Aql completed successfully.
2018-10-11 04:01:41.5: Image Efficiency: 78.3%
2018-10-11 04:01:41.5: Cycle Efficiency: 100.0%
2018-10-11 04:01:44.4: Rising plan delay enabled for Plan FY_Cam:
2018-10-11 04:01:44.4:     664 min. remaining to meet strict constraints.
2018-10-11 04:01:44.4:     493 min. remaining for the plan to fit before dawn.
2018-10-11 04:01:44.4:     but only 321 min till mid-Plan transit.
2018-10-11 04:01:44.4:     deferred (rising) for 321 min, until 11-Oct-2018 09:23:43 UTC
2018-10-11 04:01:44.5: Rising plan delay enabled for Plan V0965_Per:
2018-10-11 04:01:44.5:     595 min. remaining to meet strict constraints.
2018-10-11 04:01:44.5:     493 min. remaining for the plan to fit before dawn.
2018-10-11 04:01:44.5:     but only 296 min till mid-Plan transit.
2018-10-11 04:01:44.5:     deferred (rising) for 296 min, until 11-Oct-2018 08:58:40 UTC
2018-10-11 04:01:44.6: Dispatcher cycle time: 0.3 sec.
2018-10-11 04:01:44.6: Acquire data for Observation V1907_Cyg...
2018-10-11 04:01:44.6:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V1907_Cyg)
2018-10-11 04:01:44.7: Send Observation V1907_Cyg to ACP Sequencer
2018-10-11 04:17:42.4: Acquisition time: 957.7113408 sec.
2018-10-11 04:17:42.4: Data for Observation V1907_Cyg of Plan V1907_Cyg acquired successfully.
2018-10-11 04:17:42.4: Plan V1907_Cyg completed successfully.
2018-10-11 04:17:42.4: Image Efficiency: 40.7%
2018-10-11 04:17:42.4: Cycle Efficiency: 100.0%
2018-10-11 04:17:44.4: Rising plan delay enabled for Plan V0603_Per:
2018-10-11 04:17:44.4:     640 min. remaining to meet strict constraints.
2018-10-11 04:17:44.4:     477 min. remaining for the plan to fit before dawn.
2018-10-11 04:17:44.4:     but only 317 min till mid-Plan transit.
2018-10-11 04:17:44.4:     deferred (rising) for 317 min, until 11-Oct-2018 09:35:03 UTC
2018-10-11 04:17:44.5: Dispatcher cycle time: 0.9 sec.
2018-10-11 04:17:44.5: Acquire data for Observation U_Aqr...
2018-10-11 04:17:44.5:   (belongs to Project AAVSO_Monitoring, Plan U_Aqr)
2018-10-11 04:17:44.7: Send Observation U_Aqr to ACP Sequencer
2018-10-11 04:49:41.0: Acquisition time: 1916.2826828 sec.
2018-10-11 04:49:41.0: Data for Observation U_Aqr of Plan U_Aqr acquired successfully.
2018-10-11 04:49:41.0: Plan U_Aqr completed successfully.
2018-10-11 04:49:41.0: Image Efficiency: 73.0%
2018-10-11 04:49:41.0: Cycle Efficiency: 100.0%
2018-10-11 04:49:43.2: Rising plan delay enabled for Plan HI_Cam:
2018-10-11 04:49:43.2:     635 min. remaining to meet strict constraints.
2018-10-11 04:49:43.2:     445 min. remaining for the plan to fit before dawn.
2018-10-11 04:49:43.2:     but only 333 min till mid-Plan transit.
2018-10-11 04:49:43.2:     deferred (rising) for 333 min, until 11-Oct-2018 10:22:55 UTC
2018-10-11 04:49:43.3: Rising plan delay enabled for Plan WZ_Per:
2018-10-11 04:49:43.3:     587 min. remaining to meet strict constraints.
2018-10-11 04:49:43.3:     445 min. remaining for the plan to fit before dawn.
2018-10-11 04:49:43.3:     but only 279 min till mid-Plan transit.
2018-10-11 04:49:43.3:     deferred (rising) for 279 min, until 11-Oct-2018 09:28:51 UTC
2018-10-11 04:49:43.4: Dispatcher cycle time: 1.2 sec.
2018-10-11 04:49:43.4: Acquire data for Observation V1904_Cyg...
2018-10-11 04:49:43.4:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V1904_Cyg)
2018-10-11 04:49:43.7: Send Observation V1904_Cyg to ACP Sequencer
2018-10-11 05:05:34.7: Acquisition time: 951.0513315 sec.
2018-10-11 05:05:34.7: Data for Observation V1904_Cyg of Plan V1904_Cyg acquired successfully.
2018-10-11 05:05:34.7: Plan V1904_Cyg completed successfully.
2018-10-11 05:05:34.8: Image Efficiency: 41.0%
2018-10-11 05:05:34.8: Cycle Efficiency: 99.9%
2018-10-11 05:05:38.1: Dispatcher cycle time: 0.2 sec.
2018-10-11 05:05:38.1: Acquire data for Observation BC_Lac...
2018-10-11 05:05:38.1:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan BC_Lac)
2018-10-11 05:05:38.1: Send Observation BC_Lac to ACP Sequencer
2018-10-11 05:21:25.2: Acquisition time: 947.0213258 sec.
2018-10-11 05:21:25.2: Data for Observation BC_Lac of Plan BC_Lac acquired successfully.
2018-10-11 05:21:25.2: Plan BC_Lac completed successfully.
2018-10-11 05:21:25.2: Image Efficiency: 41.2%
2018-10-11 05:21:25.2: Cycle Efficiency: 100.0%
2018-10-11 05:21:28.0: ++ Auto Focus ++
2018-10-11 05:21:28.0: Doing periodic autofocus.
2018-10-11 05:21:28.0: Start special ACP AutoFocus script for scheduler
2018-10-11 05:24:37.4: Next periodic autofocus ASAP after 11-Oct-2018 08:24:11 UTC
2018-10-11 05:24:39.9: Rising plan delay enabled for Plan HO_Cam:
2018-10-11 05:24:39.9:     600 min. remaining to meet strict constraints.
2018-10-11 05:24:39.9:     410 min. remaining for the plan to fit before dawn.
2018-10-11 05:24:39.9:     but only 335 min till mid-Plan transit.
2018-10-11 05:24:39.9:     deferred (rising) for 335 min, until 11-Oct-2018 10:59:58 UTC
2018-10-11 05:24:40.0: Dispatcher cycle time: 1.2 sec.
2018-10-11 05:24:40.0: Acquire data for Observation V0809_Cep...
2018-10-11 05:24:40.0:   (belongs to Project Nova_Monitoring, Plan V0809_Cep)
2018-10-11 05:24:40.2: Send Observation V0809_Cep to ACP Sequencer
2018-10-11 05:55:47.8: Acquisition time: 1867.6226147 sec.
2018-10-11 05:55:47.8: Data for Observation V0809_Cep of Plan V0809_Cep acquired successfully.
2018-10-11 05:55:47.8: Plan V0809_Cep completed successfully.
2018-10-11 05:55:47.8: Image Efficiency: 74.9%
2018-10-11 05:55:47.8: Cycle Efficiency: 99.9%
2018-10-11 05:55:50.6: Rising plan delay enabled for Plan HQ_Aur:
2018-10-11 05:55:50.6:     569 min. remaining to meet strict constraints.
2018-10-11 05:55:50.6:     361 min. remaining for the plan to fit before dawn.
2018-10-11 05:55:50.6:     but only 312 min till mid-Plan transit.
2018-10-11 05:55:50.6:     deferred (rising) for 310 min, until 11-Oct-2018 11:06:43 UTC
2018-10-11 05:55:50.6: Rising plan delay enabled for Plan HX_Aur:
2018-10-11 05:55:50.6:     569 min. remaining to meet strict constraints.
2018-10-11 05:55:50.6:     378 min. remaining for the plan to fit before dawn.
2018-10-11 05:55:50.6:     but only 293 min till mid-Plan transit.
2018-10-11 05:55:50.6:     deferred (rising) for 293 min, until 11-Oct-2018 10:49:46 UTC
2018-10-11 05:55:50.7: Dispatcher cycle time: 0.1 sec.
2018-10-11 05:55:50.7: Acquire data for Observation GSC_3649-0825...
2018-10-11 05:55:50.7:   (belongs to Project Staels, Plan GSC_3649-0825)
2018-10-11 05:55:52.0: Send Observation GSC_3649-0825 to ACP Sequencer
2018-10-11 06:00:05.8: Acquisition time: 253.8703554 sec.
2018-10-11 06:00:05.8: Data for Observation GSC_3649-0825 of Plan GSC_3649-0825 acquired successfully.
2018-10-11 06:00:05.8: Plan GSC_3649-0825 completed successfully.
2018-10-11 06:00:05.9: Image Efficiency: 53.1%
2018-10-11 06:00:05.9: Cycle Efficiency: 99.9%
2018-10-11 06:00:09.1: Dispatcher cycle time: 0.1 sec.
2018-10-11 06:00:09.1: Acquire data for Observation NGC_7790...
2018-10-11 06:00:09.1:   (belongs to Project AAVSO_Monitoring, Plan NGC_7790)
2018-10-11 06:00:09.1: Send Observation NGC_7790 to ACP Sequencer
2018-10-11 06:16:40.0: Acquisition time: 990.9013872 sec.
2018-10-11 06:16:40.0: Data for Observation NGC_7790 of Plan NGC_7790 acquired successfully.
2018-10-11 06:16:40.0: Plan NGC_7790 completed successfully.
2018-10-11 06:16:40.1: Image Efficiency: 46.9%
2018-10-11 06:16:40.1: Cycle Efficiency: 100.0%
2018-10-11 06:16:43.5: Dispatcher cycle time: 0.1 sec.
2018-10-11 06:16:43.5: Acquire data for Observation V2481_Cyg...
2018-10-11 06:16:43.5:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V2481_Cyg)
2018-10-11 06:16:43.5: Send Observation V2481_Cyg to ACP Sequencer
2018-10-11 06:33:54.5: Acquisition time: 1031.0414435 sec.
2018-10-11 06:33:54.5: Data for Observation V2481_Cyg of Plan V2481_Cyg acquired successfully.
2018-10-11 06:33:54.5: Plan V2481_Cyg completed successfully.
2018-10-11 06:33:54.6: Image Efficiency: 37.8%
2018-10-11 06:33:54.6: Cycle Efficiency: 100.0%
2018-10-11 06:33:57.6: Dispatcher cycle time: 0.1 sec.
2018-10-11 06:33:57.6: Acquire data for Observation AF_And...
2018-10-11 06:33:57.6:   (belongs to Project AAVSO_UIS01_AF_And, Plan AF_And)
2018-10-11 06:33:57.6: Send Observation AF_And to ACP Sequencer
2018-10-11 07:06:01.9: Acquisition time: 1924.272694 sec.
2018-10-11 07:06:01.9: Data for Observation AF_And of Plan AF_And acquired successfully.
2018-10-11 07:06:01.9: Plan AF_And completed successfully.
2018-10-11 07:06:01.9: Image Efficiency: 67.6%
2018-10-11 07:06:01.9: Cycle Efficiency: 100.0%
2018-10-11 07:06:04.7: Dispatcher cycle time: 0.1 sec.
2018-10-11 07:06:04.7: Acquire data for Observation V0524_Cas...
2018-10-11 07:06:04.7:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V0524_Cas)
2018-10-11 07:06:04.7: Send Observation V0524_Cas to ACP Sequencer
2018-10-11 07:21:45.9: Acquisition time: 941.1513176 sec.
2018-10-11 07:21:45.9: Data for Observation V0524_Cas of Plan V0524_Cas acquired successfully.
2018-10-11 07:21:45.9: Plan V0524_Cas completed successfully.
2018-10-11 07:21:45.9: Image Efficiency: 41.4%
2018-10-11 07:21:45.9: Cycle Efficiency: 100.0%
2018-10-11 07:21:49.4: Dispatcher cycle time: 0.8 sec.
2018-10-11 07:21:49.4: Acquire data for Observation GSC_4030_204...
2018-10-11 07:21:49.4:   (belongs to Project Staels, Plan GSC_4030_204)
2018-10-11 07:21:50.5: Send Observation GSC_4030_204 to ACP Sequencer
2018-10-11 07:23:37.3: Acquisition time: 106.8601496 sec.
2018-10-11 07:23:37.3: Data for Observation GSC_4030_204 of Plan GSC_4030_204 acquired successfully.
2018-10-11 07:23:37.3: Plan GSC_4030_204 completed successfully.
2018-10-11 07:23:37.3: Image Efficiency: 27.9%
2018-10-11 07:23:37.3: Cycle Efficiency: 99.2%
2018-10-11 07:40:43.8: Dispatcher cycle time: 0.1 sec.
2018-10-11 07:40:43.8: Acquire data for Observation CM_Cas...
2018-10-11 07:40:43.8:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan CM_Cas)
2018-10-11 07:40:47.2: Send Observation CM_Cas to ACP Sequencer
2018-10-11 07:55:21.4: Acquisition time: 874.1612238 sec.
2018-10-11 07:55:21.4: Data for Observation CM_Cas of Plan CM_Cas acquired successfully.
2018-10-11 07:55:21.4: Plan CM_Cas completed successfully.
2018-10-11 07:55:21.4: Image Efficiency: 44.6%
2018-10-11 07:55:21.4: Cycle Efficiency: 100.0%
2018-10-11 07:55:22.8: Rising plan delay enabled for Plan CB_32:
2018-10-11 07:55:22.8:     421 min. remaining to meet strict constraints.
2018-10-11 07:55:22.8:     255 min. remaining for the plan to fit before dawn.
2018-10-11 07:55:22.8:     but only 206 min till mid-Plan transit.
2018-10-11 07:55:22.8:     deferred (rising) for 205 min, until 11-Oct-2018 11:21:17 UTC
2018-10-11 08:01:47.0: Rising plan delay enabled for Plan DN_Lyn:
2018-10-11 08:01:47.0:     443 min. remaining to meet strict constraints.
2018-10-11 08:01:47.0:     235 min. remaining for the plan to fit before dawn.
2018-10-11 08:01:47.0:     deferred (rising) for 234 min, until 11-Oct-2018 11:56:04 UTC
2018-10-11 08:06:37.5: Rising plan delay enabled for Plan T_Ori:
2018-10-11 08:06:37.5:     392 min. remaining to meet strict constraints.
2018-10-11 08:06:37.5:     237 min. remaining for the plan to fit before dawn.
2018-10-11 08:06:37.5:     but only 190 min till mid-Plan transit.
2018-10-11 08:06:37.5:     deferred (rising) for 189 min, until 11-Oct-2018 11:16:24 UTC
2018-10-11 08:10:58.4: Rising plan delay enabled for Plan MP_Gem:
2018-10-11 08:10:58.4:     434 min. remaining to meet strict constraints.
2018-10-11 08:10:58.4:     209 min. remaining for the plan to fit before dawn.
2018-10-11 08:10:58.4:     deferred (rising) for 206 min, until 11-Oct-2018 11:37:11 UTC
2018-10-11 08:22:06.4: Rising plan delay enabled for Plan KH15D:
2018-10-11 08:22:06.4:     720 min. remaining to meet strict constraints.
2018-10-11 08:22:06.4:     232 min. remaining for the plan to fit before dawn.
2018-10-11 08:22:06.4:     deferred (rising) for 232 min, until 11-Oct-2018 12:14:35 UTC
2018-10-11 08:24:18.1: ++ Auto Focus ++
2018-10-11 08:24:18.1: Doing periodic autofocus.
2018-10-11 08:24:18.1: Start special ACP AutoFocus script for scheduler
2018-10-11 08:31:04.1: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2018-10-11 08:31:36.9: ++ Auto Focus ++
2018-10-11 08:31:36.9: Doing periodic autofocus.
2018-10-11 08:31:36.9: Start special ACP AutoFocus script for scheduler
2018-10-11 08:34:01.5: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2018-10-11 08:34:32.1: Rising plan delay enabled for Plan V0959_Mon:
2018-10-11 08:34:32.1:     410 min. remaining to meet strict constraints.
2018-10-11 08:34:32.1:     204 min. remaining for the plan to fit before dawn.
2018-10-11 08:34:32.1:     deferred (rising) for 202 min, until 11-Oct-2018 11:57:10 UTC
2018-10-11 08:39:18.3: ++ Auto Focus ++
2018-10-11 08:39:18.3: Doing periodic autofocus.
2018-10-11 08:39:18.3: Start special ACP AutoFocus script for scheduler
2018-10-11 08:53:58.9: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2018-10-11 08:53:59.0: Rising plan delay enabled for Plan SDSS073224:
2018-10-11 08:53:59.0:     544 min. remaining to meet strict constraints.
2018-10-11 08:53:59.0:     200 min. remaining for the plan to fit before dawn.
2018-10-11 08:53:59.0:     deferred (rising) for 200 min, until 11-Oct-2018 12:14:49 UTC
2018-10-11 08:58:50.3: Dispatcher cycle time: 0.1 sec.
2018-10-11 08:58:50.3: Acquire data for Observation V0965_Per...
2018-10-11 08:58:50.3:   (belongs to Project Nova_Monitoring, Plan V0965_Per)
2018-10-11 08:58:50.3: Send Observation V0965_Per to ACP Sequencer
2018-10-11 09:19:23.3: Acquisition time: 1232.9417261 sec.
2018-10-11 09:19:23.3: Data for Observation V0965_Per of Plan V0965_Per acquired successfully.
2018-10-11 09:19:23.3: Plan V0965_Per completed successfully.
2018-10-11 09:19:23.3: Image Efficiency: 73.0%
2018-10-11 09:19:23.3: Cycle Efficiency: 100.0%
2018-10-11 09:19:25.6: ++ Auto Focus ++
2018-10-11 09:19:25.6: Doing periodic autofocus.
2018-10-11 09:19:25.6: Start special ACP AutoFocus script for scheduler
2018-10-11 09:22:18.5: ** Autofocus failed (n=4), will retry ASAP after 15 min.
2018-10-11 09:22:20.6: Dispatcher cycle time: 1.1 sec.
2018-10-11 09:22:20.6: Acquire data for Observation FW_Cam...
2018-10-11 09:22:20.6:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FW_Cam)
2018-10-11 09:22:21.6: Send Observation FW_Cam to ACP Sequencer
2018-10-11 09:38:03.9: Acquisition time: 942.3473765 sec.
2018-10-11 09:38:03.9: Data for Observation FW_Cam of Plan FW_Cam acquired successfully.
2018-10-11 09:38:03.9: Plan FW_Cam completed successfully.
2018-10-11 09:38:03.9: Image Efficiency: 41.3%
2018-10-11 09:38:03.9: Cycle Efficiency: 99.9%
2018-10-11 09:38:06.2: ++ Auto Focus ++
2018-10-11 09:38:06.3: Doing periodic autofocus.
2018-10-11 09:38:06.3: Start special ACP AutoFocus script for scheduler
2018-10-11 09:42:57.2: Next periodic autofocus ASAP after 11-Oct-2018 12:42:42 UTC
2018-10-11 09:43:00.1: Dispatcher cycle time: 1.1 sec.
2018-10-11 09:43:00.1: Acquire data for Observation FU_Cam...
2018-10-11 09:43:00.1:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FU_Cam)
2018-10-11 09:43:01.1: Send Observation FU_Cam to ACP Sequencer
2018-10-11 09:58:25.4: Acquisition time: 924.3212941 sec.
2018-10-11 09:58:25.4: Data for Observation FU_Cam of Plan FU_Cam acquired successfully.
2018-10-11 09:58:25.4: Plan FU_Cam completed successfully.
2018-10-11 09:58:25.4: Image Efficiency: 42.1%
2018-10-11 09:58:25.4: Cycle Efficiency: 99.9%
2018-10-11 09:58:28.1: Dispatcher cycle time: 0.1 sec.
2018-10-11 09:58:28.1: Acquire data for Observation V0603_Per...
2018-10-11 09:58:28.1:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V0603_Per)
2018-10-11 09:58:28.1: Send Observation V0603_Per to ACP Sequencer
2018-10-11 10:13:50.0: Acquisition time: 921.9412908 sec.
2018-10-11 10:13:50.0: Data for Observation V0603_Per of Plan V0603_Per acquired successfully.
2018-10-11 10:13:50.0: Plan V0603_Per completed successfully.
2018-10-11 10:13:50.0: Image Efficiency: 42.3%
2018-10-11 10:13:50.0: Cycle Efficiency: 100.0%
2018-10-11 10:13:53.9: Dispatcher cycle time: 0.9 sec.
2018-10-11 10:13:53.9: Acquire data for Observation FY_Cam...
2018-10-11 10:13:53.9:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FY_Cam)
2018-10-11 10:13:54.1: Send Observation FY_Cam to ACP Sequencer
2018-10-11 10:28:46.2: Acquisition time: 892.0812489 sec.
2018-10-11 10:28:46.2: Data for Observation FY_Cam of Plan FY_Cam acquired successfully.
2018-10-11 10:28:46.2: Plan FY_Cam completed successfully.
2018-10-11 10:28:46.2: Image Efficiency: 43.7%
2018-10-11 10:28:46.2: Cycle Efficiency: 99.9%
2018-10-11 10:28:46.9: Dispatcher cycle time: 0.1 sec.
2018-10-11 10:28:46.9: Acquire data for Observation WZ_Per...
2018-10-11 10:28:46.9:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan WZ_Per)
2018-10-11 10:28:49.1: Send Observation WZ_Per to ACP Sequencer
2018-10-11 10:44:14.6: Acquisition time: 925.8612962 sec.
2018-10-11 10:44:14.6: Data for Observation WZ_Per of Plan WZ_Per acquired successfully.
2018-10-11 10:44:14.6: Plan WZ_Per completed successfully.
2018-10-11 10:44:14.6: Image Efficiency: 42.1%
2018-10-11 10:44:14.6: Cycle Efficiency: 100.0%
2018-10-11 10:44:17.5: Rising plan delay enabled for Plan CY_UMa:
2018-10-11 10:44:17.5:     720 min. remaining to meet strict constraints.
2018-10-11 10:44:17.5:     90 min. remaining for the plan to fit before dawn.
2018-10-11 10:44:17.5:     deferred (rising) for 90 min, until 11-Oct-2018 12:14:49 UTC
2018-10-11 10:44:17.6: Dispatcher cycle time: 0.7 sec.
2018-10-11 10:44:17.6: Acquire data for Observation HI_Cam...
2018-10-11 10:44:17.6:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HI_Cam)
2018-10-11 10:44:17.6: Send Observation HI_Cam to ACP Sequencer
2018-10-11 11:00:09.2: Acquisition time: 951.6813324 sec.
2018-10-11 11:00:09.2: Data for Observation HI_Cam of Plan HI_Cam acquired successfully.
2018-10-11 11:00:09.3: Plan HI_Cam completed successfully.
2018-10-11 11:00:09.3: Image Efficiency: 41.0%
2018-10-11 11:00:09.3: Cycle Efficiency: 99.9%
2018-10-11 11:00:11.6: Rising plan delay enabled for Plan M67:
2018-10-11 11:00:11.6:     435 min. remaining to meet strict constraints.
2018-10-11 11:00:11.6:     39 min. remaining for the plan to fit before dawn.
2018-10-11 11:00:11.6:     deferred (rising) for 36 min, until 11-Oct-2018 11:36:38 UTC
2018-10-11 11:00:11.6: Dispatcher cycle time: 0.1 sec.
2018-10-11 11:00:11.6: Acquire data for Observation HO_Cam...
2018-10-11 11:00:11.6:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HO_Cam)
2018-10-11 11:00:11.6: Send Observation HO_Cam to ACP Sequencer
2018-10-11 11:15:00.6: Acquisition time: 888.9812446 sec.
2018-10-11 11:15:00.6: Data for Observation HO_Cam of Plan HO_Cam acquired successfully.
2018-10-11 11:15:00.6: Plan HO_Cam completed successfully.
2018-10-11 11:15:00.6: Image Efficiency: 43.9%
2018-10-11 11:15:00.6: Cycle Efficiency: 100.0%
2018-10-11 11:15:03.9: Dispatcher cycle time: 0.7 sec.
2018-10-11 11:15:03.9: Acquire data for Observation HX_Aur...
2018-10-11 11:15:03.9:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HX_Aur)
2018-10-11 11:15:04.9: Send Observation HX_Aur to ACP Sequencer
2018-10-11 11:30:54.7: Acquisition time: 949.8313298 sec.
2018-10-11 11:30:54.7: Data for Observation HX_Aur of Plan HX_Aur acquired successfully.
2018-10-11 11:30:54.7: Plan HX_Aur completed successfully.
2018-10-11 11:30:54.8: Image Efficiency: 41.0%
2018-10-11 11:30:54.8: Cycle Efficiency: 99.9%
2018-10-11 11:30:57.9: Dispatcher cycle time: 0.9 sec.
2018-10-11 11:30:57.9: Acquire data for Observation CB_32...
2018-10-11 11:30:57.9:   (belongs to Project Staels, Plan CB_32)
2018-10-11 11:30:59.0: Send Observation CB_32 to ACP Sequencer
2018-10-11 11:36:05.8: Acquisition time: 306.8004296 sec.
2018-10-11 11:36:05.8: Data for Observation CB_32 of Plan CB_32 acquired successfully.
2018-10-11 11:36:05.8: Plan CB_32 completed successfully.
2018-10-11 11:36:05.8: Image Efficiency: 29.2%
2018-10-11 11:36:05.8: Cycle Efficiency: 99.7%
2018-10-11 11:36:08.4: Dispatcher cycle time: 0.1 sec.
2018-10-11 11:36:08.4: Acquire data for Observation T_Ori...
2018-10-11 11:36:08.4:   (belongs to Project AAVSO_Monitoring, Plan T_Ori)
2018-10-11 11:36:08.4: Doing 3 sets
2018-10-11 11:36:11.7: Send Observation T_Ori to ACP Sequencer
2018-10-11 11:39:48.1: Send Observation T_Ori to ACP Sequencer
2018-10-11 11:42:59.1: Send Observation T_Ori to ACP Sequencer
2018-10-11 11:46:13.6: Acquisition time: 601.8508425 sec.
2018-10-11 11:46:13.6: Data for Observation T_Ori of Plan T_Ori acquired successfully.
2018-10-11 11:46:13.6: Plan T_Ori completed successfully.
2018-10-11 11:46:13.6: Image Efficiency: 44.9%
2018-10-11 11:46:13.6: Cycle Efficiency: 100.0%
2018-10-11 11:46:14.4: Rising plan delay enabled for Plan KK_UMa:
2018-10-11 11:46:14.4:     219 min. remaining to meet strict constraints.
2018-10-11 11:46:14.4:     11 min. remaining for the plan to fit before dawn.
2018-10-11 11:46:14.4:     deferred (rising) for 9 min, until 11-Oct-2018 11:56:04 UTC
2018-10-11 11:46:14.4: Dispatcher cycle time: 0.1 sec.
2018-10-11 11:46:14.4: Acquire data for Observation HQ_Aur...
2018-10-11 11:46:14.4:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HQ_Aur)
2018-10-11 11:46:16.0: Send Observation HQ_Aur to ACP Sequencer
2018-10-11 12:03:11.5: Acquisition time: 1015.701422 sec.
2018-10-11 12:03:11.5: Data for Observation HQ_Aur of Plan HQ_Aur acquired successfully.
2018-10-11 12:03:11.5: Plan HQ_Aur completed successfully.
2018-10-11 12:03:11.5: Image Efficiency: 38.4%
2018-10-11 12:03:11.5: Cycle Efficiency: 100.0%
2018-10-11 12:29:26.9: ++ Dawn Flats ++
2018-10-11 12:29:26.9: Start ACP AutoFlat script for Dawn flats
2018-10-11 13:01:06.7: -- Observatory Shutdown --
2018-10-11 13:01:06.7: Start ACP Sequencer's ShutdownObs script
2018-10-11 13:07:51.1: -- Weather Unsafe --
2018-10-11 14:44:05.6: Dispatcher stopped at 11-Oct-2018 14:44:05 UTC
2018-10-11 14:44:05.6: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2018-10-11 23:17:43.4: Requested shutdown of scheduler
2018-10-11 23:17:43.5: Run statistics:
2018-10-11 23:17:43.5:   Observations:   53
2018-10-11 23:17:43.5:   Considered:     40
2018-10-11 23:17:43.5:   Completed:      28
2018-10-11 23:17:43.5:   Skipped:        9
2018-10-11 23:17:43.5:   Never Eligible: 13
2018-10-11 23:17:43.5:   Failed:         3
2018-10-11 23:17:43.5: Shutter-Open efficiency: 50.35%
2018-10-11 23:17:43.5: Overall Efficiency: 95.65%
2018-10-11 23:17:43.5: Release ACP sequencer
Log closed at Thu, Oct 11 2018 23:17:45 UTC (actual time)