Log opened at Sat, Sep 08 2018 20:58:26 UTC (actual time)
Current log level is Verbose
ACP Expert Scheduler version 8.1.1
Full license: Arne Henden
2018-09-09 01:48:06.1: ++ Weather Safe ++
2018-09-09 02:06:12.4: ++ Observatory Startup ++
2018-09-09 02:06:12.4: Start ACP Sequencer's StartupObs script
2018-09-09 02:07:14.2: Open the observatory dome/roof
2018-09-09 02:08:29.5: Observatory startup succeeded, and dome opened successfully
2018-09-09 02:16:03.1: ++ Auto Focus ++
2018-09-09 02:16:03.1: Doing initial autofocus.
2018-09-09 02:16:03.1: Start special ACP AutoFocus script for scheduler
2018-09-09 02:20:30.8: Next periodic autofocus ASAP after 09-Sep-2018 05:20:05 UTC
2018-09-09 02:20:33.1: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan RX_J0524+42 has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan V0809_Cep has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan V1722_Aql has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan NGC_7790 has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan U_Aqr has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan V339_Del_TMO61 has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan V841_Oph has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan Mkn_501 has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.1: Plan AF_And has Monitor Mode. Time to resubmit it.
2018-09-09 02:20:33.3: Rising plan delay enabled for Plan 2MASS_J19395313+0557550:
2018-09-09 02:20:33.3:     305 min. remaining to meet strict constraints.
2018-09-09 02:20:33.3:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.3:     but only 65 min till mid-Plan transit.
2018-09-09 02:20:33.3:     deferred (rising) for 63 min, until 09-Sep-2018 03:24:05 UTC
2018-09-09 02:20:33.4: Rising plan delay enabled for Plan BC_Lac:
2018-09-09 02:20:33.4:     562 min. remaining to meet strict constraints.
2018-09-09 02:20:33.4:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.4:     but only 241 min till mid-Plan transit.
2018-09-09 02:20:33.4:     deferred (rising) for 240 min, until 09-Sep-2018 06:20:43 UTC
2018-09-09 02:20:33.4: Rising plan delay enabled for Plan GSC_3649-0825:
2018-09-09 02:20:33.4:     602 min. remaining to meet strict constraints.
2018-09-09 02:20:33.4:     572 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.4:     but only 300 min till mid-Plan transit.
2018-09-09 02:20:33.4:     deferred (rising) for 300 min, until 09-Sep-2018 07:20:50 UTC
2018-09-09 02:20:33.4: Rising plan delay enabled for Plan IRAS_19067+2158:
2018-09-09 02:20:33.4:     312 min. remaining to meet strict constraints.
2018-09-09 02:20:33.4:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.4:     but only 34 min till mid-Plan transit.
2018-09-09 02:20:33.4:     deferred (rising) for 32 min, until 09-Sep-2018 02:53:11 UTC
2018-09-09 02:20:33.4: Rising plan delay enabled for Plan IRAS_19183+2339:
2018-09-09 02:20:33.4:     327 min. remaining to meet strict constraints.
2018-09-09 02:20:33.4:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.4:     but only 45 min till mid-Plan transit.
2018-09-09 02:20:33.4:     deferred (rising) for 44 min, until 09-Sep-2018 03:04:42 UTC
2018-09-09 02:20:33.5: Rising plan delay enabled for Plan M56:
2018-09-09 02:20:33.5:     336 min. remaining to meet strict constraints.
2018-09-09 02:20:33.5:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.5:     but only 41 min till mid-Plan transit.
2018-09-09 02:20:33.5:     deferred (rising) for 39 min, until 09-Sep-2018 03:00:33 UTC
2018-09-09 02:20:33.5: Rising plan delay enabled for Plan NGC_7790:
2018-09-09 02:20:33.5:     602 min. remaining to meet strict constraints.
2018-09-09 02:20:33.5:     572 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.5:     but only 331 min till mid-Plan transit.
2018-09-09 02:20:33.5:     deferred (rising) for 331 min, until 09-Sep-2018 07:52:07 UTC
2018-09-09 02:20:33.5: Rising plan delay enabled for Plan NSVS_11201899:
2018-09-09 02:20:33.5:     313 min. remaining to meet strict constraints.
2018-09-09 02:20:33.5:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.5:     but only 35 min till mid-Plan transit.
2018-09-09 02:20:33.5:     deferred (rising) for 33 min, until 09-Sep-2018 02:54:05 UTC
2018-09-09 02:20:33.6: Rising plan delay enabled for Plan V0809_Cep:
2018-09-09 02:20:33.6:     602 min. remaining to meet strict constraints.
2018-09-09 02:20:33.6:     572 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.6:     but only 281 min till mid-Plan transit.
2018-09-09 02:20:33.6:     deferred (rising) for 281 min, until 09-Sep-2018 07:01:56 UTC
2018-09-09 02:20:33.6: Rising plan delay enabled for Plan V1721_Aql:
2018-09-09 02:20:33.6:     275 min. remaining to meet strict constraints.
2018-09-09 02:20:33.6:     538 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.6:     but only 23 min till mid-Plan transit.
2018-09-09 02:20:33.6:     deferred (rising) for 20 min, until 09-Sep-2018 02:40:39 UTC
2018-09-09 02:20:33.6: Rising plan delay enabled for Plan V1722_Aql:
2018-09-09 02:20:33.6:     303 min. remaining to meet strict constraints.
2018-09-09 02:20:33.6:     572 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.6:     but only 48 min till mid-Plan transit.
2018-09-09 02:20:33.6:     deferred (rising) for 48 min, until 09-Sep-2018 03:08:39 UTC
2018-09-09 02:20:33.6: Rising plan delay enabled for Plan V1723_Aql:
2018-09-09 02:20:33.6:     224 min. remaining to meet strict constraints.
2018-09-09 02:20:33.6:     552 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.6:     but only 11 min till mid-Plan transit.
2018-09-09 02:20:33.6:     deferred (rising) for 9 min, until 09-Sep-2018 02:29:52 UTC
2018-09-09 02:20:33.6: Rising plan delay enabled for Plan V1724_Aql:
2018-09-09 02:20:33.6:     240 min. remaining to meet strict constraints.
2018-09-09 02:20:33.6:     552 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.6:     but only 16 min till mid-Plan transit.
2018-09-09 02:20:33.6:     deferred (rising) for 14 min, until 09-Sep-2018 02:34:48 UTC
2018-09-09 02:20:33.6: Rising plan delay enabled for Plan V1904_Cyg:
2018-09-09 02:20:33.6:     471 min. remaining to meet strict constraints.
2018-09-09 02:20:33.6:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.6:     but only 169 min till mid-Plan transit.
2018-09-09 02:20:33.6:     deferred (rising) for 168 min, until 09-Sep-2018 05:08:38 UTC
2018-09-09 02:20:33.7: Rising plan delay enabled for Plan V1907_Cyg:
2018-09-09 02:20:33.7:     487 min. remaining to meet strict constraints.
2018-09-09 02:20:33.7:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.7:     but only 176 min till mid-Plan transit.
2018-09-09 02:20:33.7:     deferred (rising) for 174 min, until 09-Sep-2018 05:15:08 UTC
2018-09-09 02:20:33.7: Rising plan delay enabled for Plan V2481_Cyg:
2018-09-09 02:20:33.7:     457 min. remaining to meet strict constraints.
2018-09-09 02:20:33.7:     555 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.7:     but only 149 min till mid-Plan transit.
2018-09-09 02:20:33.7:     deferred (rising) for 147 min, until 09-Sep-2018 04:48:15 UTC
2018-09-09 02:20:33.7: Rising plan delay enabled for Plan V339_Del_TMO61:
2018-09-09 02:20:33.7:     384 min. remaining to meet strict constraints.
2018-09-09 02:20:33.7:     572 min. remaining for the plan to fit before dawn.
2018-09-09 02:20:33.7:     but only 117 min till mid-Plan transit.
2018-09-09 02:20:33.7:     deferred (rising) for 117 min, until 09-Sep-2018 04:17:49 UTC
2018-09-09 02:20:33.7: Dispatcher cycle time: 0.6 sec.
2018-09-09 02:20:33.7: Acquire data for Observation Mkn_501...
2018-09-09 02:20:33.7:   (belongs to Project AAVSO_SXAC_Mkn_501, Plan Mkn_501)
2018-09-09 02:20:33.7: Doing 3 sets
2018-09-09 02:20:34.1: Send Observation Mkn_501 to ACP Sequencer
2018-09-09 02:28:17.3: Send Observation Mkn_501 to ACP Sequencer
2018-09-09 02:35:46.3: Send Observation Mkn_501 to ACP Sequencer
2018-09-09 02:43:15.1: Acquisition time: 1361.0087904 sec.
2018-09-09 02:43:15.1: Data for Observation Mkn_501 of Plan Mkn_501 acquired successfully.
2018-09-09 02:43:15.1: Plan Mkn_501 completed successfully.
2018-09-09 02:43:15.1: Image Efficiency: 66.1%
2018-09-09 02:43:15.1: Cycle Efficiency: 99.9%
2018-09-09 02:43:18.2: Rising plan delay enabled for Plan V1721_Aql:
2018-09-09 02:43:18.2:     252 min. remaining to meet strict constraints.
2018-09-09 02:43:18.2:     516 min. remaining for the plan to fit before dawn.
2018-09-09 02:43:18.2:     but only 0 min till mid-Plan transit.
2018-09-09 02:43:18.2:     ending rising plan delay. Plan is now eligible.
2018-09-09 02:43:18.3: Dispatcher cycle time: 0.1 sec.
2018-09-09 02:43:18.3: Acquire data for Observation V1723_Aql...
2018-09-09 02:43:18.3:   (belongs to Project Nova_Monitoring, Plan V1723_Aql)
2018-09-09 02:43:22.7: Send Observation V1723_Aql to ACP Sequencer
2018-09-09 03:04:01.3: Acquisition time: 1238.6265756 sec.
2018-09-09 03:04:01.3: Data for Observation V1723_Aql of Plan V1723_Aql acquired successfully.
2018-09-09 03:04:01.4: Plan V1723_Aql completed successfully.
2018-09-09 03:04:01.4: Image Efficiency: 72.7%
2018-09-09 03:04:01.4: Cycle Efficiency: 100.0%
2018-09-09 03:04:08.1: Dispatcher cycle time: 0.5 sec.
2018-09-09 03:04:08.1: Acquire data for Observation V1721_Aql...
2018-09-09 03:04:08.1:   (belongs to Project Nova_Monitoring, Plan V1721_Aql)
2018-09-09 03:04:08.3: Send Observation V1721_Aql to ACP Sequencer
2018-09-09 03:36:31.9: Acquisition time: 1943.5606137 sec.
2018-09-09 03:36:31.9: Data for Observation V1721_Aql of Plan V1721_Aql acquired successfully.
2018-09-09 03:36:31.9: Plan V1721_Aql completed successfully.
2018-09-09 03:36:31.9: Image Efficiency: 77.2%
2018-09-09 03:36:31.9: Cycle Efficiency: 100.0%
2018-09-09 03:36:36.6: Rising plan delay enabled for Plan AF_And:
2018-09-09 03:36:36.6:     606 min. remaining to meet strict constraints.
2018-09-09 03:36:36.6:     496 min. remaining for the plan to fit before dawn.
2018-09-09 03:36:36.6:     but only 300 min till mid-Plan transit.
2018-09-09 03:36:36.6:     deferred (rising) for 300 min, until 09-Sep-2018 08:37:08 UTC
2018-09-09 03:36:36.7: Rising plan delay enabled for Plan U_Aqr:
2018-09-09 03:36:36.7:     286 min. remaining to meet strict constraints.
2018-09-09 03:36:36.7:     496 min. remaining for the plan to fit before dawn.
2018-09-09 03:36:36.7:     but only 140 min till mid-Plan transit.
2018-09-09 03:36:36.7:     deferred (rising) for 140 min, until 09-Sep-2018 05:57:21 UTC
2018-09-09 03:36:36.8: Dispatcher cycle time: 0.2 sec.
2018-09-09 03:36:36.8: Acquire data for Observation V1724_Aql...
2018-09-09 03:36:36.8:   (belongs to Project Nova_Monitoring, Plan V1724_Aql)
2018-09-09 03:36:38.9: Send Observation V1724_Aql to ACP Sequencer
2018-09-09 03:56:33.7: Acquisition time: 1194.7904985 sec.
2018-09-09 03:56:33.7: Data for Observation V1724_Aql of Plan V1724_Aql acquired successfully.
2018-09-09 03:56:33.7: Plan V1724_Aql completed successfully.
2018-09-09 03:56:33.7: Image Efficiency: 75.3%
2018-09-09 03:56:33.7: Cycle Efficiency: 100.0%
2018-09-09 03:56:41.7: Dispatcher cycle time: 0.2 sec.
2018-09-09 03:56:41.7: Acquire data for Observation V1722_Aql...
2018-09-09 03:56:41.7:   (belongs to Project Nova_Monitoring, Plan V1722_Aql)
2018-09-09 03:56:42.5: Send Observation V1722_Aql to ACP Sequencer
2018-09-09 04:29:55.1: Acquisition time: 1992.5602998 sec.
2018-09-09 04:29:55.1: Data for Observation V1722_Aql of Plan V1722_Aql acquired successfully.
2018-09-09 04:29:55.1: Plan V1722_Aql completed successfully.
2018-09-09 04:29:55.1: Image Efficiency: 75.3%
2018-09-09 04:29:55.1: Cycle Efficiency: 100.0%
2018-09-09 04:30:00.7: Dispatcher cycle time: 0.5 sec.
2018-09-09 04:30:00.7: Acquire data for Observation M56...
2018-09-09 04:30:00.7:   (belongs to Project AAVSO_Monitoring, Plan M56)
2018-09-09 04:30:01.1: Send Observation M56 to ACP Sequencer
2018-09-09 04:47:13.4: Acquisition time: 1032.2850131 sec.
2018-09-09 04:47:13.4: Data for Observation M56 of Plan M56 acquired successfully.
2018-09-09 04:47:13.4: Plan M56 completed successfully.
2018-09-09 04:47:13.4: Image Efficiency: 69.7%
2018-09-09 04:47:13.4: Cycle Efficiency: 100.0%
2018-09-09 04:47:22.3: Dispatcher cycle time: 0.1 sec.
2018-09-09 04:47:22.3: Acquire data for Observation V339_Del_TMO61...
2018-09-09 04:47:22.3:   (belongs to Project AAVSO_Monitoring, Plan V339_Del_TMO61)
2018-09-09 04:47:22.3: Doing 3 sets
2018-09-09 04:47:28.7: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-09-09 04:53:07.6: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-09-09 04:57:56.3: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-09-09 05:02:40.7: Acquisition time: 912.0244018 sec.
2018-09-09 05:02:40.7: Data for Observation V339_Del_TMO61 of Plan V339_Del_TMO61 acquired successfully.
2018-09-09 05:02:40.7: Plan V339_Del_TMO61 completed successfully.
2018-09-09 05:02:40.8: Image Efficiency: 29.6%
2018-09-09 05:02:40.8: Cycle Efficiency: 100.0%
2018-09-09 05:02:47.8: Dispatcher cycle time: 0.1 sec.
2018-09-09 05:02:47.8: Acquire data for Observation V2481_Cyg...
2018-09-09 05:02:47.8:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V2481_Cyg)
2018-09-09 05:02:48.1: Send Observation V2481_Cyg to ACP Sequencer
2018-09-09 05:18:52.8: Acquisition time: 964.6432944 sec.
2018-09-09 05:18:52.8: Data for Observation V2481_Cyg of Plan V2481_Cyg acquired successfully.
2018-09-09 05:18:52.8: Plan V2481_Cyg completed successfully.
2018-09-09 05:18:52.8: Image Efficiency: 40.4%
2018-09-09 05:18:52.8: Cycle Efficiency: 100.0%
2018-09-09 05:18:56.2: Dispatcher cycle time: 0.1 sec.
2018-09-09 05:18:56.2: Acquire data for Observation V1904_Cyg...
2018-09-09 05:18:56.2:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V1904_Cyg)
2018-09-09 05:19:04.1: Send Observation V1904_Cyg to ACP Sequencer
2018-09-09 05:34:46.1: Acquisition time: 941.9608545 sec.
2018-09-09 05:34:46.1: Data for Observation V1904_Cyg of Plan V1904_Cyg acquired successfully.
2018-09-09 05:34:46.1: Plan V1904_Cyg completed successfully.
2018-09-09 05:34:46.1: Image Efficiency: 41.4%
2018-09-09 05:34:46.1: Cycle Efficiency: 100.0%
2018-09-09 05:34:57.3: ++ Auto Focus ++
2018-09-09 05:34:57.3: Doing periodic autofocus.
2018-09-09 05:34:57.3: Start special ACP AutoFocus script for scheduler
2018-09-09 05:38:24.2: Next periodic autofocus ASAP after 09-Sep-2018 08:38:10 UTC
2018-09-09 05:38:27.6: Rising plan delay enabled for Plan FU_Cam:
2018-09-09 05:38:27.6:     404 min. remaining to meet strict constraints.
2018-09-09 05:38:27.6:     357 min. remaining for the plan to fit before dawn.
2018-09-09 05:38:27.6:     but only 330 min till mid-Plan transit.
2018-09-09 05:38:27.6:     deferred (rising) for 328 min, until 09-Sep-2018 11:06:45 UTC
2018-09-09 05:38:27.6: Rising plan delay enabled for Plan FW_Cam:
2018-09-09 05:38:27.6:     404 min. remaining to meet strict constraints.
2018-09-09 05:38:27.6:     357 min. remaining for the plan to fit before dawn.
2018-09-09 05:38:27.6:     but only 336 min till mid-Plan transit.
2018-09-09 05:38:27.6:     deferred (rising) for 335 min, until 09-Sep-2018 11:13:35 UTC
2018-09-09 05:38:27.8: Dispatcher cycle time: 1.2 sec.
2018-09-09 05:38:27.8: Acquire data for Observation V1907_Cyg...
2018-09-09 05:38:27.8:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V1907_Cyg)
2018-09-09 05:38:35.2: Send Observation V1907_Cyg to ACP Sequencer
2018-09-09 05:54:56.5: Acquisition time: 981.3041236 sec.
2018-09-09 05:54:56.5: Data for Observation V1907_Cyg of Plan V1907_Cyg acquired successfully.
2018-09-09 05:54:56.5: Plan V1907_Cyg completed successfully.
2018-09-09 05:54:56.5: Image Efficiency: 39.7%
2018-09-09 05:54:56.5: Cycle Efficiency: 99.9%
2018-09-09 05:55:01.2: Rising plan delay enabled for Plan FY_Cam:
2018-09-09 05:55:01.2:     388 min. remaining to meet strict constraints.
2018-09-09 05:55:01.2:     341 min. remaining for the plan to fit before dawn.
2018-09-09 05:55:01.2:     but only 325 min till mid-Plan transit.
2018-09-09 05:55:01.2:     deferred (rising) for 324 min, until 09-Sep-2018 11:19:17 UTC
2018-09-09 05:55:01.3: Dispatcher cycle time: 0.1 sec.
2018-09-09 05:55:01.3: Acquire data for Observation 2MASS_J19395313+0557550...
2018-09-09 05:55:01.3:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan 2MASS_J19395313+0557550)
2018-09-09 05:55:07.7: Send Observation 2MASS_J19395313+0557550 to ACP Sequencer
2018-09-09 06:06:36.3: ACP ERROR: Run failed for unknown reason (see ACP run log)
2018-09-09 06:06:36.3: ACP data acquisition failed for Observation 2MASS_J19395313+0557550.
2018-09-09 06:06:36.3:   (Observation 2MASS_J19395313+0557550 interrupted by acquisition process failure.)
2018-09-09 06:06:40.8: -- Weather Unsafe --
2018-09-09 06:37:29.3: ++ Weather Safe ++
2018-09-09 06:37:30.3: ++ Observatory Startup ++
2018-09-09 06:37:30.3: Start ACP Sequencer's StartupObs script
2018-09-09 06:37:48.5: Open the observatory dome/roof
2018-09-09 06:39:16.5: Observatory startup succeeded, and dome opened successfully
2018-09-09 06:39:24.4: ++ Auto Focus ++
2018-09-09 06:39:24.4: Doing initial autofocus.
2018-09-09 06:39:24.5: Start special ACP AutoFocus script for scheduler
2018-09-09 06:43:22.1: Next periodic autofocus ASAP after 09-Sep-2018 09:43:05 UTC
2018-09-09 06:43:23.8: Rising plan delay enabled for Plan HI_Cam:
2018-09-09 06:43:23.8:     339 min. remaining to meet strict constraints.
2018-09-09 06:43:23.8:     292 min. remaining for the plan to fit before dawn.
2018-09-09 06:43:23.8:     deferred (rising) for 291 min, until 09-Sep-2018 11:34:35 UTC
2018-09-09 06:43:23.9: Rising plan delay enabled for Plan V0603_Per:
2018-09-09 06:43:23.9:     339 min. remaining to meet strict constraints.
2018-09-09 06:43:23.9:     292 min. remaining for the plan to fit before dawn.
2018-09-09 06:43:23.9:     but only 288 min till mid-Plan transit.
2018-09-09 06:43:23.9:     deferred (rising) for 287 min, until 09-Sep-2018 11:30:37 UTC
2018-09-09 06:43:23.9: Rising plan delay enabled for Plan V0965_Per:
2018-09-09 06:43:23.9:     339 min. remaining to meet strict constraints.
2018-09-09 06:43:23.9:     289 min. remaining for the plan to fit before dawn.
2018-09-09 06:43:23.9:     but only 250 min till mid-Plan transit.
2018-09-09 06:43:23.9:     deferred (rising) for 248 min, until 09-Sep-2018 10:52:08 UTC
2018-09-09 06:43:23.9: Rising plan delay enabled for Plan WZ_Per:
2018-09-09 06:43:23.9:     339 min. remaining to meet strict constraints.
2018-09-09 06:43:23.9:     292 min. remaining for the plan to fit before dawn.
2018-09-09 06:43:23.9:     but only 282 min till mid-Plan transit.
2018-09-09 06:43:23.9:     deferred (rising) for 281 min, until 09-Sep-2018 11:24:25 UTC
2018-09-09 06:43:24.0: Dispatcher cycle time: 0.2 sec.
2018-09-09 06:43:24.0: Acquire data for Observation BC_Lac...
2018-09-09 06:43:24.0:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan BC_Lac)
2018-09-09 06:43:24.3: Send Observation BC_Lac to ACP Sequencer
2018-09-09 06:59:47.1: Acquisition time: 982.7393261 sec.
2018-09-09 06:59:47.1: Data for Observation BC_Lac of Plan BC_Lac acquired successfully.
2018-09-09 06:59:47.1: Plan BC_Lac completed successfully.
2018-09-09 06:59:47.1: Image Efficiency: 39.7%
2018-09-09 06:59:47.1: Cycle Efficiency: 100.0%
2018-09-09 06:59:49.8: Dispatcher cycle time: 0.1 sec.
2018-09-09 06:59:49.8: Acquire data for Observation U_Aqr...
2018-09-09 06:59:49.8:   (belongs to Project AAVSO_Monitoring, Plan U_Aqr)
2018-09-09 06:59:49.8: Send Observation U_Aqr to ACP Sequencer
2018-09-09 07:03:51.5: ACP ERROR: Run failed for unknown reason (see ACP run log)
2018-09-09 07:03:51.5: ACP data acquisition failed for Observation U_Aqr.
2018-09-09 07:03:51.5:   (Observation U_Aqr interrupted by acquisition process failure.)
2018-09-09 07:03:54.4: -- Weather Unsafe --
2018-09-09 07:35:20.0: ++ Weather Safe ++
2018-09-09 07:35:21.0: ++ Observatory Startup ++
2018-09-09 07:35:21.0: Start ACP Sequencer's StartupObs script
2018-09-09 07:35:42.0: Open the observatory dome/roof
2018-09-09 07:37:06.6: Observatory startup succeeded, and dome opened successfully
2018-09-09 07:37:06.6: ++ Auto Focus ++
2018-09-09 07:37:06.6: Doing initial autofocus.
2018-09-09 07:37:06.6: Start special ACP AutoFocus script for scheduler
2018-09-09 07:39:01.8: ** ACP script "AutoFocusScheduler" failed:
2018-09-09 07:39:01.8: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 81 column 2.

2018-09-09 07:39:01.8: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2018-09-09 07:39:04.0: -- Weather Unsafe --
2018-09-09 08:10:24.1: ++ Weather Safe ++
2018-09-09 08:10:25.1: ++ Observatory Startup ++
2018-09-09 08:10:25.1: Start ACP Sequencer's StartupObs script
2018-09-09 08:10:44.7: Open the observatory dome/roof
2018-09-09 08:12:14.9: Observatory startup succeeded, and dome opened successfully
2018-09-09 08:12:18.5: ++ Auto Focus ++
2018-09-09 08:12:18.5: Doing initial autofocus.
2018-09-09 08:12:18.5: Start special ACP AutoFocus script for scheduler
2018-09-09 08:15:08.0: ** ACP script "AutoFocusScheduler" failed:
2018-09-09 08:15:08.0: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 81 column 2.

2018-09-09 08:15:08.0: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2018-09-09 08:15:08.4: -- Weather Unsafe --
2018-09-09 08:46:13.1: ++ Weather Safe ++
2018-09-09 08:46:14.1: ++ Observatory Startup ++
2018-09-09 08:46:14.1: Start ACP Sequencer's StartupObs script
2018-09-09 08:46:29.3: Open the observatory dome/roof
2018-09-09 08:47:53.7: Observatory startup succeeded, and dome opened successfully
2018-09-09 08:47:53.7: ++ Auto Focus ++
2018-09-09 08:47:53.7: Doing initial autofocus.
2018-09-09 08:47:53.7: Start special ACP AutoFocus script for scheduler
2018-09-09 08:50:32.2: ** ACP script "AutoFocusScheduler" failed:
2018-09-09 08:50:32.2: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 81 column 2.

2018-09-09 08:50:32.2: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2018-09-09 08:50:34.4: -- Weather Unsafe --
2018-09-09 09:22:06.2: ++ Weather Safe ++
2018-09-09 09:22:07.2: ++ Observatory Startup ++
2018-09-09 09:22:07.4: Start ACP Sequencer's StartupObs script
2018-09-09 09:22:25.0: Open the observatory dome/roof
2018-09-09 09:23:52.5: Observatory startup succeeded, and dome opened successfully
2018-09-09 09:23:53.4: ++ Auto Focus ++
2018-09-09 09:23:53.4: Doing initial autofocus.
2018-09-09 09:23:53.4: Start special ACP AutoFocus script for scheduler
2018-09-09 09:27:35.2: Next periodic autofocus ASAP after 09-Sep-2018 12:27:21 UTC
2018-09-09 09:27:38.6: Rising plan delay enabled for Plan HO_Cam:
2018-09-09 09:27:38.6:     175 min. remaining to meet strict constraints.
2018-09-09 09:27:38.6:     128 min. remaining for the plan to fit before dawn.
2018-09-09 09:27:38.6:     deferred (rising) for 126 min, until 09-Sep-2018 11:34:35 UTC
2018-09-09 09:27:38.6: Rising plan delay enabled for Plan HQ_Aur:
2018-09-09 09:27:38.6:     175 min. remaining to meet strict constraints.
2018-09-09 09:27:38.6:     128 min. remaining for the plan to fit before dawn.
2018-09-09 09:27:38.6:     deferred (rising) for 126 min, until 09-Sep-2018 11:34:35 UTC
2018-09-09 09:27:38.6: Rising plan delay enabled for Plan HX_Aur:
2018-09-09 09:27:38.6:     175 min. remaining to meet strict constraints.
2018-09-09 09:27:38.6:     128 min. remaining for the plan to fit before dawn.
2018-09-09 09:27:38.6:     deferred (rising) for 126 min, until 09-Sep-2018 11:34:35 UTC
2018-09-09 09:27:38.7: Rising plan delay enabled for Plan RX_J0524+42:
2018-09-09 09:27:38.7:     538 min. remaining to meet strict constraints.
2018-09-09 09:27:38.7:     145 min. remaining for the plan to fit before dawn.
2018-09-09 09:27:38.7:     deferred (rising) for 145 min, until 09-Sep-2018 11:53:20 UTC
2018-09-09 09:27:38.8: Dispatcher cycle time: 1.2 sec.
2018-09-09 09:27:38.8: Acquire data for Observation AF_And...
2018-09-09 09:27:38.8:   (belongs to Project AAVSO_UIS01_AF_And, Plan AF_And)
2018-09-09 09:27:46.1: Send Observation AF_And to ACP Sequencer
2018-09-09 09:59:22.7: Acquisition time: 1896.6045312 sec.
2018-09-09 09:59:22.7: Data for Observation AF_And of Plan AF_And acquired successfully.
2018-09-09 09:59:22.7: Plan AF_And completed successfully.
2018-09-09 09:59:22.7: Image Efficiency: 68.5%
2018-09-09 09:59:22.7: Cycle Efficiency: 99.9%
2018-09-09 09:59:30.3: Rising plan delay enabled for Plan CB_32:
2018-09-09 09:59:30.3:     143 min. remaining to meet strict constraints.
2018-09-09 09:59:30.3:     110 min. remaining for the plan to fit before dawn.
2018-09-09 09:59:30.3:     deferred (rising) for 109 min, until 09-Sep-2018 11:49:15 UTC
2018-09-09 09:59:30.4: Dispatcher cycle time: 0.1 sec.
2018-09-09 09:59:30.4: Acquire data for Observation GSC_3649-0825...
2018-09-09 09:59:30.4:   (belongs to Project Staels, Plan GSC_3649-0825)
2018-09-09 09:59:36.7: Send Observation GSC_3649-0825 to ACP Sequencer
2018-09-09 10:04:53.0: Acquisition time: 316.2281554 sec.
2018-09-09 10:04:53.0: Data for Observation GSC_3649-0825 of Plan GSC_3649-0825 acquired successfully.
2018-09-09 10:04:53.0: Plan GSC_3649-0825 completed successfully.
2018-09-09 10:04:53.0: Image Efficiency: 42.7%
2018-09-09 10:04:53.0: Cycle Efficiency: 100.0%
2018-09-09 10:04:57.6: Dispatcher cycle time: 0.1 sec.
2018-09-09 10:04:57.6: Acquire data for Observation V0809_Cep...
2018-09-09 10:04:57.6:   (belongs to Project Nova_Monitoring, Plan V0809_Cep)
2018-09-09 10:05:04.9: Send Observation V0809_Cep to ACP Sequencer
2018-09-09 10:36:14.6: Acquisition time: 1869.6944839 sec.
2018-09-09 10:36:14.6: Data for Observation V0809_Cep of Plan V0809_Cep acquired successfully.
2018-09-09 10:36:14.6: Plan V0809_Cep completed successfully.
2018-09-09 10:36:14.6: Image Efficiency: 74.9%
2018-09-09 10:36:14.6: Cycle Efficiency: 100.0%
2018-09-09 10:36:18.6: Rising plan delay enabled for Plan DN_Lyn:
2018-09-09 10:36:18.6:     106 min. remaining to meet strict constraints.
2018-09-09 10:36:18.6:     59 min. remaining for the plan to fit before dawn.
2018-09-09 10:36:18.6:     deferred (rising) for 58 min, until 09-Sep-2018 11:34:35 UTC
2018-09-09 10:36:18.6: Rising plan delay enabled for Plan KH15D:
2018-09-09 10:36:18.6:     720 min. remaining to meet strict constraints.
2018-09-09 10:36:18.6:     76 min. remaining for the plan to fit before dawn.
2018-09-09 10:36:18.6:     deferred (rising) for 76 min, until 09-Sep-2018 11:53:06 UTC
2018-09-09 10:36:18.6: Rising plan delay enabled for Plan MP_Gem:
2018-09-09 10:36:18.6:     106 min. remaining to meet strict constraints.
2018-09-09 10:36:18.6:     42 min. remaining for the plan to fit before dawn.
2018-09-09 10:36:18.6:     deferred (rising) for 39 min, until 09-Sep-2018 11:15:42 UTC
2018-09-09 10:36:18.6: Rising plan delay enabled for Plan T_Ori:
2018-09-09 10:36:18.6:     106 min. remaining to meet strict constraints.
2018-09-09 10:36:18.6:     66 min. remaining for the plan to fit before dawn.
2018-09-09 10:36:18.6:     deferred (rising) for 65 min, until 09-Sep-2018 11:41:33 UTC
2018-09-09 10:36:18.7: Dispatcher cycle time: 0.1 sec.
2018-09-09 10:36:18.7: Acquire data for Observation NGC_7790...
2018-09-09 10:36:18.7:   (belongs to Project AAVSO_Monitoring, Plan NGC_7790)
2018-09-09 10:36:26.4: Send Observation NGC_7790 to ACP Sequencer
2018-09-09 10:53:29.1: Acquisition time: 1022.6753962 sec.
2018-09-09 10:53:29.1: Data for Observation NGC_7790 of Plan NGC_7790 acquired successfully.
2018-09-09 10:53:29.1: Plan NGC_7790 completed successfully.
2018-09-09 10:53:29.1: Image Efficiency: 45.5%
2018-09-09 10:53:29.1: Cycle Efficiency: 100.0%
2018-09-09 10:53:34.6: Rising plan delay enabled for Plan SDSS073224:
2018-09-09 10:53:34.6:     550 min. remaining to meet strict constraints.
2018-09-09 10:53:34.6:     15 min. remaining for the plan to fit before dawn.
2018-09-09 10:53:34.6:     deferred (rising) for 11 min, until 09-Sep-2018 11:05:04 UTC
2018-09-09 10:53:34.6: Rising plan delay enabled for Plan V0959_Mon:
2018-09-09 10:53:34.6:     89 min. remaining to meet strict constraints.
2018-09-09 10:53:34.6:     43 min. remaining for the plan to fit before dawn.
2018-09-09 10:53:34.6:     deferred (rising) for 42 min, until 09-Sep-2018 11:35:41 UTC
2018-09-09 10:53:34.6: Rising plan delay enabled for Plan V0965_Per:
2018-09-09 10:53:34.6:     89 min. remaining to meet strict constraints.
2018-09-09 10:53:34.6:     39 min. remaining for the plan to fit before dawn.
2018-09-09 10:53:34.6:     but only 0 min till mid-Plan transit.
2018-09-09 10:53:34.6:     ending rising plan delay. Plan is now eligible.
2018-09-09 10:53:34.6: Dispatcher cycle time: 0.1 sec.
2018-09-09 10:53:34.6: Acquire data for Observation V0965_Per...
2018-09-09 10:53:34.6:   (belongs to Project Nova_Monitoring, Plan V0965_Per)
2018-09-09 10:53:42.7: Send Observation V0965_Per to ACP Sequencer
2018-09-09 11:14:54.9: Acquisition time: 1272.1666345 sec.
2018-09-09 11:14:54.9: Data for Observation V0965_Per of Plan V0965_Per acquired successfully.
2018-09-09 11:14:54.9: Plan V0965_Per completed successfully.
2018-09-09 11:14:54.9: Image Efficiency: 70.7%
2018-09-09 11:14:54.9: Cycle Efficiency: 100.0%
2018-09-09 11:15:03.9: Rising plan delay enabled for Plan FW_Cam:
2018-09-09 11:15:03.9:     68 min. remaining to meet strict constraints.
2018-09-09 11:15:03.9:     21 min. remaining for the plan to fit before dawn.
2018-09-09 11:15:03.9:     but only 0 min till mid-Plan transit.
2018-09-09 11:15:03.9:     ending rising plan delay. Plan is now eligible.
2018-09-09 11:15:04.0: Dispatcher cycle time: 0.1 sec.
2018-09-09 11:15:04.0: Acquire data for Observation FU_Cam...
2018-09-09 11:15:04.0:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FU_Cam)
2018-09-09 11:15:08.6: Send Observation FU_Cam to ACP Sequencer
2018-09-09 11:31:45.2: Acquisition time: 996.5921504 sec.
2018-09-09 11:31:45.2: Data for Observation FU_Cam of Plan FU_Cam acquired successfully.
2018-09-09 11:31:45.2: Plan FU_Cam completed successfully.
2018-09-09 11:31:45.2: Image Efficiency: 39.1%
2018-09-09 11:31:45.2: Cycle Efficiency: 100.0%
2018-09-09 11:31:48.9: Rising plan delay enabled for Plan V0603_Per:
2018-09-09 11:31:48.9:     51 min. remaining to meet strict constraints.
2018-09-09 11:31:48.9:     4 min. remaining for the plan to fit before dawn.
2018-09-09 11:31:48.9:     but only 0 min till mid-Plan transit.
2018-09-09 11:31:48.9:     ending rising plan delay. Plan is now eligible.
2018-09-09 11:31:49.0: Dispatcher cycle time: 0.1 sec.
2018-09-09 11:31:49.0: Acquire data for Observation FW_Cam...
2018-09-09 11:31:49.0:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FW_Cam)
2018-09-09 11:31:57.3: Send Observation FW_Cam to ACP Sequencer
2018-09-09 11:47:45.7: Acquisition time: 948.3724657 sec.
2018-09-09 11:47:45.7: Data for Observation FW_Cam of Plan FW_Cam acquired successfully.
2018-09-09 11:47:45.7: Plan FW_Cam completed successfully.
2018-09-09 11:47:45.7: Image Efficiency: 41.1%
2018-09-09 11:47:45.7: Cycle Efficiency: 100.0%
2018-09-09 12:08:17.2: ++ Dawn Flats ++
2018-09-09 12:08:17.2: Start ACP AutoFlat script for Dawn flats
2018-09-09 12:41:04.6: -- Observatory Shutdown --
2018-09-09 12:41:04.6: Start ACP Sequencer's ShutdownObs script
2018-09-09 12:46:28.1: Dispatcher stopped at 09-Sep-2018 12:46:28 UTC
2018-09-09 12:46:28.1: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2018-09-09 12:47:41.0: -- Weather Unsafe --
2018-09-09 23:35:40.6: Dispatcher started at 09-Sep-2018 23:35:40 UTC
2018-09-09 23:35:41.8: Run statistics:
2018-09-09 23:35:41.8:   Observations:   54
2018-09-09 23:35:41.8:   Considered:     35
2018-09-09 23:35:41.8:   Completed:      20
2018-09-09 23:35:41.8:   Skipped:        9
2018-09-09 23:35:41.8:   Never Eligible: 19
2018-09-09 23:35:41.8:   Failed:         6
Log closed at Sun, Sep 09 2018 23:35:41 UTC (actual time)