Log opened at Sat, Sep 29 2018 18:59:58 UTC (actual time)
Current log level is Verbose
ACP Expert Scheduler version 8.1.1
Full license: Arne Henden
2018-09-30 01:22:23.3: ++ Weather Safe ++
2018-09-30 01:37:32.7: ++ Observatory Startup ++
2018-09-30 01:37:32.7: Start ACP Sequencer's StartupObs script
2018-09-30 01:38:40.9: Open the observatory dome/roof
2018-09-30 01:39:39.8: Observatory startup succeeded, and dome opened successfully
2018-09-30 01:47:12.8: ++ Auto Focus ++
2018-09-30 01:47:12.9: Doing initial autofocus.
2018-09-30 01:47:12.9: Start special ACP AutoFocus script for scheduler
2018-09-30 01:51:46.1: Next periodic autofocus ASAP after 30-Sep-2018 04:51:28 UTC
2018-09-30 01:51:48.5: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan RX_J0524+42 has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan V0809_Cep has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan V1724_Aql has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan V0965_Per has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan V1722_Aql has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan V1721_Aql has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan NGC_7790 has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan U_Aqr has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan V339_Del_TMO61 has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan Mkn_501 has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.5: Plan AF_And has Monitor Mode. Time to resubmit it.
2018-09-30 01:51:48.6: Rising plan delay enabled for Plan 2MASS_J19395313+0557550:
2018-09-30 01:51:48.6:     132 min. remaining to meet strict constraints.
2018-09-30 01:51:48.6:     598 min. remaining for the plan to fit before dawn.
2018-09-30 01:51:48.6:     but only 11 min till mid-Plan transit.
2018-09-30 01:51:48.6:     deferred (rising) for 9 min, until 30-Sep-2018 02:01:32 UTC
2018-09-30 01:51:48.6: Rising plan delay enabled for Plan GSC_3649-0825:
2018-09-30 01:51:48.6:     132 min. remaining to meet strict constraints.
2018-09-30 01:51:48.6:     615 min. remaining for the plan to fit before dawn.
2018-09-30 01:51:48.6:     deferred (rising) for 132 min, until 30-Sep-2018 04:04:16 UTC
2018-09-30 01:51:48.7: Rising plan delay enabled for Plan NGC_7790:
2018-09-30 01:51:48.7:     132 min. remaining to meet strict constraints.
2018-09-30 01:51:48.7:     615 min. remaining for the plan to fit before dawn.
2018-09-30 01:51:48.7:     deferred (rising) for 132 min, until 30-Sep-2018 04:04:16 UTC
2018-09-30 01:51:48.8: Rising plan delay enabled for Plan V0809_Cep:
2018-09-30 01:51:48.8:     132 min. remaining to meet strict constraints.
2018-09-30 01:51:48.8:     615 min. remaining for the plan to fit before dawn.
2018-09-30 01:51:48.8:     deferred (rising) for 132 min, until 30-Sep-2018 04:04:16 UTC
2018-09-30 01:51:48.8: Rising plan delay enabled for Plan V2481_Cyg:
2018-09-30 01:51:48.8:     132 min. remaining to meet strict constraints.
2018-09-30 01:51:48.8:     598 min. remaining for the plan to fit before dawn.
2018-09-30 01:51:48.8:     but only 95 min till mid-Plan transit.
2018-09-30 01:51:48.8:     deferred (rising) for 93 min, until 30-Sep-2018 03:25:43 UTC
2018-09-30 01:51:48.8: Rising plan delay enabled for Plan V339_Del_TMO61:
2018-09-30 01:51:48.8:     132 min. remaining to meet strict constraints.
2018-09-30 01:51:48.8:     615 min. remaining for the plan to fit before dawn.
2018-09-30 01:51:48.8:     but only 63 min till mid-Plan transit.
2018-09-30 01:51:48.8:     deferred (rising) for 63 min, until 30-Sep-2018 02:55:16 UTC
2018-09-30 01:51:49.0: Dispatcher cycle time: 0.5 sec.
2018-09-30 01:51:49.0: Acquire data for Observation Mkn_501...
2018-09-30 01:51:49.0:   (belongs to Project AAVSO_SXAC_Mkn_501, Plan Mkn_501)
2018-09-30 01:51:49.0: Doing 3 sets
2018-09-30 01:51:49.3: Send Observation Mkn_501 to ACP Sequencer
2018-09-30 02:00:22.6: Send Observation Mkn_501 to ACP Sequencer
2018-09-30 02:07:48.7: Send Observation Mkn_501 to ACP Sequencer
2018-09-30 02:15:21.7: Acquisition time: 1412.3172806 sec.
2018-09-30 02:15:21.7: Data for Observation Mkn_501 of Plan Mkn_501 acquired successfully.
2018-09-30 02:15:21.7: Plan Mkn_501 completed successfully.
2018-09-30 02:15:21.7: Image Efficiency: 63.7%
2018-09-30 02:15:21.7: Cycle Efficiency: 100.0%
2018-09-30 02:15:27.6: Rising plan delay enabled for Plan AF_And:
2018-09-30 02:15:27.6:     604 min. remaining to meet strict constraints.
2018-09-30 02:15:27.6:     592 min. remaining for the plan to fit before dawn.
2018-09-30 02:15:27.6:     but only 299 min till mid-Plan transit.
2018-09-30 02:15:27.6:     deferred (rising) for 299 min, until 30-Sep-2018 07:14:36 UTC
2018-09-30 02:15:27.7: Rising plan delay enabled for Plan U_Aqr:
2018-09-30 02:15:27.7:     108 min. remaining to meet strict constraints.
2018-09-30 02:15:27.7:     592 min. remaining for the plan to fit before dawn.
2018-09-30 02:15:27.7:     deferred (rising) for 108 min, until 30-Sep-2018 04:04:16 UTC
2018-09-30 02:15:28.1: Dispatcher cycle time: 0.6 sec.
2018-09-30 02:15:28.1: Acquire data for Observation V1722_Aql...
2018-09-30 02:15:28.1:   (belongs to Project Nova_Monitoring, Plan V1722_Aql)
2018-09-30 02:15:35.7: Send Observation V1722_Aql to ACP Sequencer
2018-09-30 02:49:07.7: Acquisition time: 2011.9979339 sec.
2018-09-30 02:49:07.7: Data for Observation V1722_Aql of Plan V1722_Aql acquired successfully.
2018-09-30 02:49:07.7: Plan V1722_Aql completed successfully.
2018-09-30 02:49:07.7: Image Efficiency: 74.5%
2018-09-30 02:49:07.7: Cycle Efficiency: 100.0%
2018-09-30 02:49:11.3: Rising plan delay enabled for Plan CM_Cas:
2018-09-30 02:49:11.3:     75 min. remaining to meet strict constraints.
2018-09-30 02:49:11.3:     541 min. remaining for the plan to fit before dawn.
2018-09-30 02:49:11.3:     deferred (rising) for 73 min, until 30-Sep-2018 04:02:34 UTC
2018-09-30 02:49:11.5: Dispatcher cycle time: 0.2 sec.
2018-09-30 02:49:11.5: Acquire data for Observation V1721_Aql...
2018-09-30 02:49:11.5:   (belongs to Project Nova_Monitoring, Plan V1721_Aql)
2018-09-30 02:49:19.1: Send Observation V1721_Aql to ACP Sequencer
2018-09-30 03:21:47.1: Acquisition time: 1947.9754214 sec.
2018-09-30 03:21:47.1: Data for Observation V1721_Aql of Plan V1721_Aql acquired successfully.
2018-09-30 03:21:47.1: Plan V1721_Aql completed successfully.
2018-09-30 03:21:47.1: Image Efficiency: 77.0%
2018-09-30 03:21:47.1: Cycle Efficiency: 100.0%
2018-09-30 03:21:53.1: Dispatcher cycle time: 0.2 sec.
2018-09-30 03:21:53.1: Acquire data for Observation V1724_Aql...
2018-09-30 03:21:53.1:   (belongs to Project Nova_Monitoring, Plan V1724_Aql)
2018-09-30 03:21:53.1: Send Observation V1724_Aql to ACP Sequencer
2018-09-30 03:41:45.5: Acquisition time: 1192.4036944 sec.
2018-09-30 03:41:45.5: Data for Observation V1724_Aql of Plan V1724_Aql acquired successfully.
2018-09-30 03:41:45.6: Plan V1724_Aql completed successfully.
2018-09-30 03:41:45.6: Image Efficiency: 75.5%
2018-09-30 03:41:45.6: Cycle Efficiency: 100.0%
2018-09-30 03:41:48.8: Dispatcher cycle time: 0.2 sec.
2018-09-30 03:41:48.8: Acquire data for Observation V339_Del_TMO61...
2018-09-30 03:41:48.8:   (belongs to Project AAVSO_Monitoring, Plan V339_Del_TMO61)
2018-09-30 03:41:48.8: Doing 3 sets
2018-09-30 03:41:48.8: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-09-30 03:47:37.9: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-09-30 03:52:26.4: Send Observation V339_Del_TMO61 to ACP Sequencer
2018-09-30 03:57:14.2: Acquisition time: 925.3780254 sec.
2018-09-30 03:57:14.2: Data for Observation V339_Del_TMO61 of Plan V339_Del_TMO61 acquired successfully.
2018-09-30 03:57:14.2: Plan V339_Del_TMO61 completed successfully.
2018-09-30 03:57:14.2: Image Efficiency: 29.2%
2018-09-30 03:57:14.2: Cycle Efficiency: 100.0%
2018-09-30 03:57:16.7: Dispatcher cycle time: 0.2 sec.
2018-09-30 03:57:16.7: Acquire data for Observation V1723_Aql...
2018-09-30 03:57:16.7:   (belongs to Project Nova_Monitoring, Plan V1723_Aql)
2018-09-30 03:57:23.9: Send Observation V1723_Aql to ACP Sequencer
2018-09-30 04:18:14.0: Acquisition time: 1250.0769956 sec.
2018-09-30 04:18:14.0: Data for Observation V1723_Aql of Plan V1723_Aql acquired successfully.
2018-09-30 04:18:14.0: Plan V1723_Aql completed successfully.
2018-09-30 04:18:14.0: Image Efficiency: 72.0%
2018-09-30 04:18:14.0: Cycle Efficiency: 100.0%
2018-09-30 04:18:19.3: Rising plan delay enabled for Plan CM_Cas:
2018-09-30 04:18:19.3:     602 min. remaining to meet strict constraints.
2018-09-30 04:18:19.3:     452 min. remaining for the plan to fit before dawn.
2018-09-30 04:18:19.3:     but only 236 min till mid-Plan transit.
2018-09-30 04:18:19.3:     deferred (rising) for 235 min, until 30-Sep-2018 08:13:34 UTC
2018-09-30 04:18:19.3: Rising plan delay enabled for Plan FU_Cam:
2018-09-30 04:18:19.3:     685 min. remaining to meet strict constraints.
2018-09-30 04:18:19.3:     452 min. remaining for the plan to fit before dawn.
2018-09-30 04:18:19.3:     but only 327 min till mid-Plan transit.
2018-09-30 04:18:19.3:     deferred (rising) for 325 min, until 30-Sep-2018 09:44:13 UTC
2018-09-30 04:18:19.3: Rising plan delay enabled for Plan FW_Cam:
2018-09-30 04:18:19.3:     698 min. remaining to meet strict constraints.
2018-09-30 04:18:19.3:     452 min. remaining for the plan to fit before dawn.
2018-09-30 04:18:19.3:     but only 334 min till mid-Plan transit.
2018-09-30 04:18:19.3:     deferred (rising) for 332 min, until 30-Sep-2018 09:51:03 UTC
2018-09-30 04:18:19.3: Rising plan delay enabled for Plan GSC_3649-0825:
2018-09-30 04:18:19.3:     425 min. remaining to meet strict constraints.
2018-09-30 04:18:19.3:     469 min. remaining for the plan to fit before dawn.
2018-09-30 04:18:19.3:     but only 99 min till mid-Plan transit.
2018-09-30 04:18:19.3:     deferred (rising) for 99 min, until 30-Sep-2018 05:58:17 UTC
2018-09-30 04:18:19.3: Rising plan delay enabled for Plan NGC_7790:
2018-09-30 04:18:19.3:     473 min. remaining to meet strict constraints.
2018-09-30 04:18:19.3:     469 min. remaining for the plan to fit before dawn.
2018-09-30 04:18:19.3:     but only 131 min till mid-Plan transit.
2018-09-30 04:18:19.3:     deferred (rising) for 131 min, until 30-Sep-2018 06:29:34 UTC
2018-09-30 04:18:19.3: Rising plan delay enabled for Plan U_Aqr:
2018-09-30 04:18:19.3:     161 min. remaining to meet strict constraints.
2018-09-30 04:18:19.3:     469 min. remaining for the plan to fit before dawn.
2018-09-30 04:18:19.3:     but only 16 min till mid-Plan transit.
2018-09-30 04:18:19.3:     deferred (rising) for 16 min, until 30-Sep-2018 04:34:49 UTC
2018-09-30 04:18:19.3: Rising plan delay enabled for Plan V0809_Cep:
2018-09-30 04:18:19.3:     422 min. remaining to meet strict constraints.
2018-09-30 04:18:19.3:     469 min. remaining for the plan to fit before dawn.
2018-09-30 04:18:19.3:     but only 81 min till mid-Plan transit.
2018-09-30 04:18:19.3:     deferred (rising) for 81 min, until 30-Sep-2018 05:39:23 UTC
2018-09-30 04:18:19.4: Dispatcher cycle time: 0.2 sec.
2018-09-30 04:18:19.4: Acquire data for Observation V2481_Cyg...
2018-09-30 04:18:19.4:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V2481_Cyg)
2018-09-30 04:18:23.1: Send Observation V2481_Cyg to ACP Sequencer
2018-09-30 04:35:02.2: Acquisition time: 999.0881548 sec.
2018-09-30 04:35:02.2: Data for Observation V2481_Cyg of Plan V2481_Cyg acquired successfully.
2018-09-30 04:35:02.2: Plan V2481_Cyg completed successfully.
2018-09-30 04:35:02.2: Image Efficiency: 39.0%
2018-09-30 04:35:02.2: Cycle Efficiency: 100.0%
2018-09-30 04:35:07.7: Rising plan delay enabled for Plan FY_Cam:
2018-09-30 04:35:07.7:     674 min. remaining to meet strict constraints.
2018-09-30 04:35:07.7:     435 min. remaining for the plan to fit before dawn.
2018-09-30 04:35:07.7:     but only 323 min till mid-Plan transit.
2018-09-30 04:35:07.7:     deferred (rising) for 321 min, until 30-Sep-2018 09:56:45 UTC
2018-09-30 04:35:07.8: Dispatcher cycle time: 0.2 sec.
2018-09-30 04:35:07.8: Acquire data for Observation M56...
2018-09-30 04:35:07.8:   (belongs to Project AAVSO_Monitoring, Plan M56)
2018-09-30 04:35:16.1: Send Observation M56 to ACP Sequencer
2018-09-30 04:53:14.5: Acquisition time: 1078.3830941 sec.
2018-09-30 04:53:14.5: Data for Observation M56 of Plan M56 acquired successfully.
2018-09-30 04:53:14.5: Plan M56 completed successfully.
2018-09-30 04:53:14.5: Image Efficiency: 66.8%
2018-09-30 04:53:14.5: Cycle Efficiency: 100.0%
2018-09-30 04:53:28.5: ++ Auto Focus ++
2018-09-30 04:53:28.5: Doing periodic autofocus.
2018-09-30 04:53:28.5: Start special ACP AutoFocus script for scheduler
2018-09-30 04:56:27.5: Next periodic autofocus ASAP after 30-Sep-2018 07:56:09 UTC
2018-09-30 04:56:30.3: Rising plan delay enabled for Plan V0603_Per:
2018-09-30 04:56:30.3:     645 min. remaining to meet strict constraints.
2018-09-30 04:56:30.3:     413 min. remaining for the plan to fit before dawn.
2018-09-30 04:56:30.3:     but only 313 min till mid-Plan transit.
2018-09-30 04:56:30.3:     deferred (rising) for 311 min, until 30-Sep-2018 10:08:05 UTC
2018-09-30 04:56:30.3: Rising plan delay enabled for Plan V0965_Per:
2018-09-30 04:56:30.3:     583 min. remaining to meet strict constraints.
2018-09-30 04:56:30.3:     430 min. remaining for the plan to fit before dawn.
2018-09-30 04:56:30.3:     but only 285 min till mid-Plan transit.
2018-09-30 04:56:30.3:     deferred (rising) for 285 min, until 30-Sep-2018 09:41:55 UTC
2018-09-30 04:56:30.4: Dispatcher cycle time: 1.2 sec.
2018-09-30 04:56:30.4: Acquire data for Observation U_Aqr...
2018-09-30 04:56:30.4:   (belongs to Project AAVSO_Monitoring, Plan U_Aqr)
2018-09-30 04:56:31.1: Send Observation U_Aqr to ACP Sequencer
2018-09-30 05:27:18.2: Acquisition time: 1847.1368443 sec.
2018-09-30 05:27:18.2: Data for Observation U_Aqr of Plan U_Aqr acquired successfully.
2018-09-30 05:27:18.2: Plan U_Aqr completed successfully.
2018-09-30 05:27:18.2: Image Efficiency: 75.7%
2018-09-30 05:27:18.2: Cycle Efficiency: 99.9%
2018-09-30 05:27:20.9: Rising plan delay enabled for Plan HI_Cam:
2018-09-30 05:27:20.9:     684 min. remaining to meet strict constraints.
2018-09-30 05:27:20.9:     383 min. remaining for the plan to fit before dawn.
2018-09-30 05:27:20.9:     but only 330 min till mid-Plan transit.
2018-09-30 05:27:20.9:     deferred (rising) for 328 min, until 30-Sep-2018 10:55:57 UTC
2018-09-30 05:27:20.9: Rising plan delay enabled for Plan WZ_Per:
2018-09-30 05:27:20.9:     593 min. remaining to meet strict constraints.
2018-09-30 05:27:20.9:     383 min. remaining for the plan to fit before dawn.
2018-09-30 05:27:20.9:     but only 276 min till mid-Plan transit.
2018-09-30 05:27:20.9:     deferred (rising) for 274 min, until 30-Sep-2018 10:01:53 UTC
2018-09-30 05:27:21.0: Dispatcher cycle time: 0.1 sec.
2018-09-30 05:27:21.0: Acquire data for Observation 2MASS_J19395313+0557550...
2018-09-30 05:27:21.0:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan 2MASS_J19395313+0557550)
2018-09-30 05:27:28.9: Send Observation 2MASS_J19395313+0557550 to ACP Sequencer
2018-09-30 05:44:44.8: Acquisition time: 1035.8418194 sec.
2018-09-30 05:44:44.8: Data for Observation 2MASS_J19395313+0557550 of Plan 2MASS_J19395313+0557550 acquired successfully.
2018-09-30 05:44:44.8: Plan 2MASS_J19395313+0557550 completed successfully.
2018-09-30 05:44:44.8: Image Efficiency: 37.6%
2018-09-30 05:44:44.8: Cycle Efficiency: 100.0%
2018-09-30 05:44:49.4: Dispatcher cycle time: 0.1 sec.
2018-09-30 05:44:49.4: Acquire data for Observation V0809_Cep...
2018-09-30 05:44:49.4:   (belongs to Project Nova_Monitoring, Plan V0809_Cep)
2018-09-30 05:44:49.4: Send Observation V0809_Cep to ACP Sequencer
2018-09-30 06:17:25.2: Acquisition time: 1955.8222352 sec.
2018-09-30 06:17:25.2: Data for Observation V0809_Cep of Plan V0809_Cep acquired successfully.
2018-09-30 06:17:25.3: Plan V0809_Cep completed successfully.
2018-09-30 06:17:25.3: Image Efficiency: 71.6%
2018-09-30 06:17:25.3: Cycle Efficiency: 100.0%
2018-09-30 06:17:33.7: Rising plan delay enabled for Plan HO_Cam:
2018-09-30 06:17:33.7:     663 min. remaining to meet strict constraints.
2018-09-30 06:17:33.7:     332 min. remaining for the plan to fit before dawn.
2018-09-30 06:17:33.7:     but only 317 min till mid-Plan transit.
2018-09-30 06:17:33.7:     deferred (rising) for 315 min, until 30-Sep-2018 11:32:59 UTC
2018-09-30 06:17:33.7: Rising plan delay enabled for Plan HX_Aur:
2018-09-30 06:17:33.7:     634 min. remaining to meet strict constraints.
2018-09-30 06:17:33.7:     332 min. remaining for the plan to fit before dawn.
2018-09-30 06:17:33.7:     but only 306 min till mid-Plan transit.
2018-09-30 06:17:33.7:     deferred (rising) for 305 min, until 30-Sep-2018 11:22:47 UTC
2018-09-30 06:17:33.8: Dispatcher cycle time: 0.4 sec.
2018-09-30 06:17:33.8: Acquire data for Observation GSC_3649-0825...
2018-09-30 06:17:33.8:   (belongs to Project Staels, Plan GSC_3649-0825)
2018-09-30 06:17:34.3: Send Observation GSC_3649-0825 to ACP Sequencer
2018-09-30 06:21:54.3: Acquisition time: 259.9588566 sec.
2018-09-30 06:21:54.3: Data for Observation GSC_3649-0825 of Plan GSC_3649-0825 acquired successfully.
2018-09-30 06:21:54.3: Plan GSC_3649-0825 completed successfully.
2018-09-30 06:21:54.3: Image Efficiency: 51.8%
2018-09-30 06:21:54.3: Cycle Efficiency: 99.8%
2018-09-30 06:30:01.2: Dispatcher cycle time: 0.0 sec.
2018-09-30 06:30:01.2: Acquire data for Observation NGC_7790...
2018-09-30 06:30:01.2:   (belongs to Project AAVSO_Monitoring, Plan NGC_7790)
2018-09-30 06:30:01.3: Send Observation NGC_7790 to ACP Sequencer
2018-09-30 06:47:06.4: Acquisition time: 1025.1090005 sec.
2018-09-30 06:47:06.4: Data for Observation NGC_7790 of Plan NGC_7790 acquired successfully.
2018-09-30 06:47:06.4: Plan NGC_7790 completed successfully.
2018-09-30 06:47:06.4: Image Efficiency: 45.4%
2018-09-30 06:47:06.4: Cycle Efficiency: 100.0%
2018-09-30 06:47:08.7: Rising plan delay enabled for Plan HQ_Aur:
2018-09-30 06:47:08.7:     637 min. remaining to meet strict constraints.
2018-09-30 06:47:08.7:     303 min. remaining for the plan to fit before dawn.
2018-09-30 06:47:08.7:     deferred (rising) for 301 min, until 30-Sep-2018 11:48:44 UTC
2018-09-30 06:47:08.7: Rising plan delay enabled for Plan RX_J0524+42:
2018-09-30 06:47:08.7:     616 min. remaining to meet strict constraints.
2018-09-30 06:47:08.7:     320 min. remaining for the plan to fit before dawn.
2018-09-30 06:47:08.7:     but only 307 min till mid-Plan transit.
2018-09-30 06:47:08.7:     deferred (rising) for 307 min, until 30-Sep-2018 11:54:47 UTC
2018-09-30 07:14:59.1: Dispatcher cycle time: 0.0 sec.
2018-09-30 07:14:59.1: Acquire data for Observation AF_And...
2018-09-30 07:14:59.1:   (belongs to Project AAVSO_UIS01_AF_And, Plan AF_And)
2018-09-30 07:14:59.1: Send Observation AF_And to ACP Sequencer
2018-09-30 07:47:20.4: Acquisition time: 1941.2518096 sec.
2018-09-30 07:47:20.4: Data for Observation AF_And of Plan AF_And acquired successfully.
2018-09-30 07:47:20.4: Plan AF_And completed successfully.
2018-09-30 07:47:20.4: Image Efficiency: 67.0%
2018-09-30 07:47:20.4: Cycle Efficiency: 100.0%
2018-09-30 07:56:15.5: ++ Auto Focus ++
2018-09-30 07:56:15.6: Doing periodic autofocus.
2018-09-30 07:56:15.6: Start special ACP AutoFocus script for scheduler
2018-09-30 07:59:20.3: Next periodic autofocus ASAP after 30-Sep-2018 10:59:10 UTC
2018-09-30 08:13:58.8: Rising plan delay enabled for Plan CM_Cas:
2018-09-30 08:13:58.8:     366 min. remaining to meet strict constraints.
2018-09-30 08:13:58.8:     216 min. remaining for the plan to fit before dawn.
2018-09-30 08:13:58.8:     but only 1 min till mid-Plan transit.
2018-09-30 08:13:58.8:     ending rising plan delay. Plan is now eligible.
2018-09-30 08:13:58.8: Dispatcher cycle time: 0.0 sec.
2018-09-30 08:13:58.8: Acquire data for Observation CM_Cas...
2018-09-30 08:13:58.8:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan CM_Cas)
2018-09-30 08:13:58.9: Send Observation CM_Cas to ACP Sequencer
2018-09-30 08:29:48.8: Acquisition time: 949.9168684 sec.
2018-09-30 08:29:48.8: Data for Observation CM_Cas of Plan CM_Cas acquired successfully.
2018-09-30 08:29:48.8: Plan CM_Cas completed successfully.
2018-09-30 08:29:48.8: Image Efficiency: 41.1%
2018-09-30 08:29:48.8: Cycle Efficiency: 100.0%
2018-09-30 08:32:57.6: Rising plan delay enabled for Plan CB_32:
2018-09-30 08:32:57.6:     427 min. remaining to meet strict constraints.
2018-09-30 08:32:57.6:     210 min. remaining for the plan to fit before dawn.
2018-09-30 08:32:57.6:     deferred (rising) for 210 min, until 30-Sep-2018 12:03:24 UTC
2018-09-30 08:44:47.8: Rising plan delay enabled for Plan DN_Lyn:
2018-09-30 08:44:47.8:     633 min. remaining to meet strict constraints.
2018-09-30 08:44:47.8:     185 min. remaining for the plan to fit before dawn.
2018-09-30 08:44:47.8:     deferred (rising) for 183 min, until 30-Sep-2018 11:48:44 UTC
2018-09-30 08:50:17.9: Rising plan delay enabled for Plan T_Ori:
2018-09-30 08:50:17.9:     392 min. remaining to meet strict constraints.
2018-09-30 08:50:17.9:     186 min. remaining for the plan to fit before dawn.
2018-09-30 08:50:17.9:     deferred (rising) for 185 min, until 30-Sep-2018 11:55:42 UTC
2018-09-30 08:53:56.0: Rising plan delay enabled for Plan MP_Gem:
2018-09-30 08:53:56.0:     529 min. remaining to meet strict constraints.
2018-09-30 08:53:56.0:     159 min. remaining for the plan to fit before dawn.
2018-09-30 08:53:56.0:     deferred (rising) for 155 min, until 30-Sep-2018 11:29:51 UTC
2018-09-30 09:02:11.2: Rising plan delay enabled for Plan KH15D:
2018-09-30 09:02:11.2:     720 min. remaining to meet strict constraints.
2018-09-30 09:02:11.2:     185 min. remaining for the plan to fit before dawn.
2018-09-30 09:02:11.2:     deferred (rising) for 185 min, until 30-Sep-2018 12:07:15 UTC
2018-09-30 09:18:22.8: Rising plan delay enabled for Plan V0959_Mon:
2018-09-30 09:18:22.8:     463 min. remaining to meet strict constraints.
2018-09-30 09:18:22.8:     153 min. remaining for the plan to fit before dawn.
2018-09-30 09:18:22.8:     deferred (rising) for 151 min, until 30-Sep-2018 11:49:50 UTC
2018-09-30 09:22:54.4: Rising plan delay enabled for Plan SDSS073224:
2018-09-30 09:22:54.4:     559 min. remaining to meet strict constraints.
2018-09-30 09:22:54.4:     120 min. remaining for the plan to fit before dawn.
2018-09-30 09:22:54.4:     deferred (rising) for 116 min, until 30-Sep-2018 11:19:13 UTC
2018-09-30 09:42:18.5: Dispatcher cycle time: 0.0 sec.
2018-09-30 09:42:18.5: Acquire data for Observation V0965_Per...
2018-09-30 09:42:18.5:   (belongs to Project Nova_Monitoring, Plan V0965_Per)
2018-09-30 09:42:18.5: Send Observation V0965_Per to ACP Sequencer
2018-09-30 10:03:32.4: Acquisition time: 1273.8514374 sec.
2018-09-30 10:03:32.4: Data for Observation V0965_Per of Plan V0965_Per acquired successfully.
2018-09-30 10:03:32.4: Plan V0965_Per completed successfully.
2018-09-30 10:03:32.4: Image Efficiency: 70.6%
2018-09-30 10:03:32.4: Cycle Efficiency: 100.0%
2018-09-30 10:03:34.0: Rising plan delay enabled for Plan WZ_Per:
2018-09-30 10:03:34.0:     316 min. remaining to meet strict constraints.
2018-09-30 10:03:34.0:     106 min. remaining for the plan to fit before dawn.
2018-09-30 10:03:34.0:     but only 0 min till mid-Plan transit.
2018-09-30 10:03:34.0:     ending rising plan delay. Plan is now eligible.
2018-09-30 10:03:34.1: Dispatcher cycle time: 0.1 sec.
2018-09-30 10:03:34.1: Acquire data for Observation FW_Cam...
2018-09-30 10:03:34.1:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FW_Cam)
2018-09-30 10:03:34.1: Send Observation FW_Cam to ACP Sequencer
2018-09-30 10:19:44.4: Acquisition time: 970.3373044 sec.
2018-09-30 10:19:44.4: Data for Observation FW_Cam of Plan FW_Cam acquired successfully.
2018-09-30 10:19:44.4: Plan FW_Cam completed successfully.
2018-09-30 10:19:44.4: Image Efficiency: 40.2%
2018-09-30 10:19:44.4: Cycle Efficiency: 100.0%
2018-09-30 10:19:48.6: Dispatcher cycle time: 0.1 sec.
2018-09-30 10:19:48.6: Acquire data for Observation FY_Cam...
2018-09-30 10:19:48.6:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FY_Cam)
2018-09-30 10:19:48.6: Send Observation FY_Cam to ACP Sequencer
2018-09-30 10:35:28.9: Acquisition time: 940.2916515 sec.
2018-09-30 10:35:28.9: Data for Observation FY_Cam of Plan FY_Cam acquired successfully.
2018-09-30 10:35:28.9: Plan FY_Cam completed successfully.
2018-09-30 10:35:28.9: Image Efficiency: 41.5%
2018-09-30 10:35:28.9: Cycle Efficiency: 100.0%
2018-09-30 10:35:36.8: Dispatcher cycle time: 0.4 sec.
2018-09-30 10:35:36.8: Acquire data for Observation V0603_Per...
2018-09-30 10:35:36.8:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V0603_Per)
2018-09-30 10:35:40.8: Send Observation V0603_Per to ACP Sequencer
2018-09-30 10:51:41.3: Acquisition time: 960.509287 sec.
2018-09-30 10:51:41.3: Data for Observation V0603_Per of Plan V0603_Per acquired successfully.
2018-09-30 10:51:41.3: Plan V0603_Per completed successfully.
2018-09-30 10:51:41.3: Image Efficiency: 40.6%
2018-09-30 10:51:41.3: Cycle Efficiency: 100.0%
2018-09-30 10:51:45.5: Dispatcher cycle time: 0.1 sec.
2018-09-30 10:51:45.5: Acquire data for Observation FU_Cam...
2018-09-30 10:51:45.5:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FU_Cam)
2018-09-30 10:51:48.7: Send Observation FU_Cam to ACP Sequencer
2018-09-30 11:07:52.9: Acquisition time: 964.2688937 sec.
2018-09-30 11:07:52.9: Data for Observation FU_Cam of Plan FU_Cam acquired successfully.
2018-09-30 11:07:52.9: Plan FU_Cam completed successfully.
2018-09-30 11:07:52.9: Image Efficiency: 40.4%
2018-09-30 11:07:52.9: Cycle Efficiency: 100.0%
2018-09-30 11:07:56.5: ++ Auto Focus ++
2018-09-30 11:07:56.5: Doing periodic autofocus.
2018-09-30 11:07:56.5: Start special ACP AutoFocus script for scheduler
2018-09-30 11:11:24.8: Next periodic autofocus ASAP after 30-Sep-2018 14:11:01 UTC
2018-09-30 11:11:28.5: Dispatcher cycle time: 1.1 sec.
2018-09-30 11:11:28.5: Acquire data for Observation HI_Cam...
2018-09-30 11:11:28.5:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HI_Cam)
2018-09-30 11:11:29.3: Send Observation HI_Cam to ACP Sequencer
2018-09-30 11:27:56.8: Acquisition time: 987.5597345 sec.
2018-09-30 11:27:56.8: Data for Observation HI_Cam of Plan HI_Cam acquired successfully.
2018-09-30 11:27:56.8: Plan HI_Cam completed successfully.
2018-09-30 11:27:56.8: Image Efficiency: 39.4%
2018-09-30 11:27:56.8: Cycle Efficiency: 99.9%
2018-09-30 11:28:04.4: Dispatcher cycle time: 0.1 sec.
2018-09-30 11:28:04.4: Acquire data for Observation WZ_Per...
2018-09-30 11:28:04.4:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan WZ_Per)
2018-09-30 11:28:04.4: Send Observation WZ_Per to ACP Sequencer
2018-09-30 11:44:22.2: Acquisition time: 977.7473173 sec.
2018-09-30 11:44:22.2: Data for Observation WZ_Per of Plan WZ_Per acquired successfully.
2018-09-30 11:44:22.2: Plan WZ_Per completed successfully.
2018-09-30 11:44:22.2: Image Efficiency: 39.9%
2018-09-30 11:44:22.2: Cycle Efficiency: 100.0%
2018-09-30 11:44:26.0: Dispatcher cycle time: 0.1 sec.
2018-09-30 11:44:26.0: Acquire data for Observation HO_Cam...
2018-09-30 11:44:26.0:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HO_Cam)
2018-09-30 11:44:26.1: Send Observation HO_Cam to ACP Sequencer
2018-09-30 12:00:48.7: Acquisition time: 982.6457259 sec.
2018-09-30 12:00:48.7: Data for Observation HO_Cam of Plan HO_Cam acquired successfully.
2018-09-30 12:00:48.7: Plan HO_Cam completed successfully.
2018-09-30 12:00:48.7: Image Efficiency: 39.7%
2018-09-30 12:00:48.7: Cycle Efficiency: 100.0%
2018-09-30 12:00:57.4: Dispatcher cycle time: 0.0 sec.
2018-09-30 12:00:57.4: Acquire data for Observation RX_J0524+42...
2018-09-30 12:00:57.4:   (belongs to Project Walker, Plan RX_J0524+42)
2018-09-30 12:00:57.4: Doing 30 sets
2018-09-30 12:00:58.1: Send Observation RX_J0524+42 to ACP Sequencer
2018-09-30 12:04:53.0: ACP data acquisition failed for Observation RX_J0524+42.
2018-09-30 12:04:53.0:   (Observation RX_J0524+42 interrupted by acquisition process failure.)
2018-09-30 12:21:54.0: ++ Dawn Flats ++
2018-09-30 12:21:54.0: Start ACP AutoFlat script for Dawn flats
2018-09-30 12:54:24.4: -- Observatory Shutdown --
2018-09-30 12:54:24.5: Start ACP Sequencer's ShutdownObs script
2018-10-01 16:02:52.1: Dispatcher stopped at 01-Oct-2018 16:02:52 UTC
2018-10-01 16:02:52.1: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2018-10-02 02:34:28.0: **EXCEPTION IN SCHEDULER:
2018-10-02 02:34:28.0: 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))
2018-10-02 02:34:28.0: 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.DoShutdown()
   at DC3.Scheduler.Engine.DoShutdownIf()
   at DC3.Scheduler.Engine.Run()
2018-10-02 02:34:28.0: DOME/ROOF FAILURE: In addition, attempting to close your dome/roof this error occurred:
2018-10-02 02:34:28.0: 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))