Log opened at Wed, Nov 14 2018 01:46:15 UTC (actual time) Current log level is Verbose ACP Expert Scheduler version 8.1.1 Full license: Arne Henden 2018-11-14 01:46:16.1: ++ Observatory Startup ++ 2018-11-14 01:46:16.1: Start ACP Sequencer's StartupObs script 2018-11-14 01:46:32.1: Open the observatory dome/roof 2018-11-14 01:47:26.7: Observatory startup succeeded, and dome opened successfully 2018-11-14 01:47:31.3: ++ Auto Focus ++ 2018-11-14 01:47:31.7: Doing initial autofocus. 2018-11-14 01:47:31.7: Start special ACP AutoFocus script for scheduler 2018-11-14 01:47:48.3: ** Autofocus failed (n=1), will retry ASAP after 0 min. 2018-11-14 01:47:48.5: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan GSC_4030_204 has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan V0809_Cep has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan V0965_Per has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan NGC_7790 has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan FW_Cam has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan CM_Cas has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan V0524_Cas has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan V0603_Per has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.5: Plan AF_And has Monitor Mode. Time to resubmit it. 2018-11-14 01:47:48.6: Rising plan delay enabled for Plan AF_And: 2018-11-14 01:47:48.6: 455 min. remaining to meet strict constraints. 2018-11-14 01:47:48.6: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:48.6: but only 149 min till mid-Plan transit. 2018-11-14 01:47:48.6: deferred (rising) for 149 min, until 14-Nov-2018 04:17:41 UTC 2018-11-14 01:47:48.6: Rising plan delay enabled for Plan BC_Lac: 2018-11-14 01:47:48.6: 336 min. remaining to meet strict constraints. 2018-11-14 01:47:48.6: 635 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:48.6: but only 15 min till mid-Plan transit. 2018-11-14 01:47:48.6: deferred (rising) for 13 min, until 14-Nov-2018 02:01:15 UTC 2018-11-14 01:47:48.6: Rising plan delay enabled for Plan CM_Cas: 2018-11-14 01:47:48.6: 575 min. remaining to meet strict constraints. 2018-11-14 01:47:48.6: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:48.6: but only 219 min till mid-Plan transit. 2018-11-14 01:47:48.6: deferred (rising) for 219 min, until 14-Nov-2018 05:26:53 UTC 2018-11-14 01:47:49.2: Rising plan delay enabled for Plan FU_Cam: 2018-11-14 01:47:49.2: 659 min. remaining to meet strict constraints. 2018-11-14 01:47:49.2: 635 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:49.2: but only 301 min till mid-Plan transit. 2018-11-14 01:47:49.2: deferred (rising) for 299 min, until 14-Nov-2018 06:47:18 UTC 2018-11-14 01:47:49.7: Rising plan delay enabled for Plan FW_Cam: 2018-11-14 01:47:49.7: 671 min. remaining to meet strict constraints. 2018-11-14 01:47:49.7: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:49.7: but only 316 min till mid-Plan transit. 2018-11-14 01:47:49.7: deferred (rising) for 316 min, until 14-Nov-2018 07:04:21 UTC 2018-11-14 01:47:50.1: Rising plan delay enabled for Plan FY_Cam: 2018-11-14 01:47:50.1: 664 min. remaining to meet strict constraints. 2018-11-14 01:47:50.1: 635 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:50.1: but only 313 min till mid-Plan transit. 2018-11-14 01:47:50.1: deferred (rising) for 312 min, until 14-Nov-2018 06:59:49 UTC 2018-11-14 01:47:50.6: Rising plan delay enabled for Plan GSC_3649-0825: 2018-11-14 01:47:50.6: 398 min. remaining to meet strict constraints. 2018-11-14 01:47:50.6: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:50.6: but only 73 min till mid-Plan transit. 2018-11-14 01:47:50.6: deferred (rising) for 73 min, until 14-Nov-2018 03:01:22 UTC 2018-11-14 01:47:51.1: Rising plan delay enabled for Plan GSC_4030_204: 2018-11-14 01:47:51.1: 517 min. remaining to meet strict constraints. 2018-11-14 01:47:51.1: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:51.1: but only 174 min till mid-Plan transit. 2018-11-14 01:47:51.1: deferred (rising) for 174 min, until 14-Nov-2018 04:42:42 UTC 2018-11-14 01:47:53.6: Rising plan delay enabled for Plan NGC_7790: 2018-11-14 01:47:53.6: 446 min. remaining to meet strict constraints. 2018-11-14 01:47:53.6: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:53.6: but only 104 min till mid-Plan transit. 2018-11-14 01:47:53.6: deferred (rising) for 104 min, until 14-Nov-2018 03:32:39 UTC 2018-11-14 01:47:55.0: Rising plan delay enabled for Plan V0524_Cas: 2018-11-14 01:47:55.0: 511 min. remaining to meet strict constraints. 2018-11-14 01:47:55.0: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:55.0: but only 152 min till mid-Plan transit. 2018-11-14 01:47:55.0: deferred (rising) for 152 min, until 14-Nov-2018 04:20:08 UTC 2018-11-14 01:47:55.7: Rising plan delay enabled for Plan V0809_Cep: 2018-11-14 01:47:55.7: 395 min. remaining to meet strict constraints. 2018-11-14 01:47:55.7: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:55.7: but only 54 min till mid-Plan transit. 2018-11-14 01:47:55.7: deferred (rising) for 54 min, until 14-Nov-2018 02:42:28 UTC 2018-11-14 01:47:55.7: Rising plan delay enabled for Plan V0965_Per: 2018-11-14 01:47:55.7: 595 min. remaining to meet strict constraints. 2018-11-14 01:47:55.7: 652 min. remaining for the plan to fit before dawn. 2018-11-14 01:47:55.7: but only 297 min till mid-Plan transit. 2018-11-14 01:47:55.7: deferred (rising) for 297 min, until 14-Nov-2018 06:45:00 UTC 2018-11-14 01:47:55.9: Dispatcher cycle time: 7.4 sec. 2018-11-14 01:47:55.9: Acquire data for Observation U_Aqr... 2018-11-14 01:47:55.9: (belongs to Project AAVSO_Monitoring, Plan U_Aqr) 2018-11-14 01:47:55.9: ++ Auto Focus ++ 2018-11-14 01:47:56.0: Doing periodic autofocus. 2018-11-14 01:47:56.0: Start special ACP AutoFocus script for scheduler 2018-11-14 01:48:11.7: ** Autofocus failed (n=2), will retry ASAP after 5 min. 2018-11-14 01:48:12.2: Send Observation U_Aqr to ACP Sequencer 2018-11-14 01:48:31.5: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:48:31.5: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:48:31.5: ACP data acquisition failed for Observation U_Aqr. 2018-11-14 01:48:31.5: (Observation U_Aqr interrupted by acquisition process failure.) 2018-11-14 01:48:38.1: Dispatcher cycle time: 1.4 sec. 2018-11-14 01:48:38.1: Acquire data for Observation V339_Del_TMO61... 2018-11-14 01:48:38.1: (belongs to Project AAVSO_Monitoring, Plan V339_Del_TMO61) 2018-11-14 01:48:38.1: Doing 3 sets 2018-11-14 01:48:38.1: Send Observation V339_Del_TMO61 to ACP Sequencer 2018-11-14 01:48:56.5: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:48:56.5: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:48:56.5: ACP data acquisition failed for Observation V339_Del_TMO61. 2018-11-14 01:48:56.5: (Observation V339_Del_TMO61 interrupted by acquisition process failure.) 2018-11-14 01:49:05.2: Dispatcher cycle time: 1.5 sec. 2018-11-14 01:49:05.2: Acquire data for Observation V1907_Cyg... 2018-11-14 01:49:05.2: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V1907_Cyg) 2018-11-14 01:49:05.2: Send Observation V1907_Cyg to ACP Sequencer 2018-11-14 01:49:23.7: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:49:23.7: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:49:23.7: ACP data acquisition failed for Observation V1907_Cyg. 2018-11-14 01:49:23.7: (Observation V1907_Cyg interrupted by acquisition process failure.) 2018-11-14 01:49:31.3: Dispatcher cycle time: 2.5 sec. 2018-11-14 01:49:31.3: Acquire data for Observation V1722_Aql... 2018-11-14 01:49:31.3: (belongs to Project Nova_Monitoring, Plan V1722_Aql) 2018-11-14 01:49:31.3: Send Observation V1722_Aql to ACP Sequencer 2018-11-14 01:49:50.2: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:49:50.2: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:49:50.2: ACP data acquisition failed for Observation V1722_Aql. 2018-11-14 01:49:50.2: (Observation V1722_Aql interrupted by acquisition process failure.) 2018-11-14 01:50:00.2: Dispatcher cycle time: 4.1 sec. 2018-11-14 01:50:00.2: Acquire data for Observation V1904_Cyg... 2018-11-14 01:50:00.2: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V1904_Cyg) 2018-11-14 01:50:03.2: Send Observation V1904_Cyg to ACP Sequencer 2018-11-14 01:50:22.4: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:50:22.4: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:50:22.4: ACP data acquisition failed for Observation V1904_Cyg. 2018-11-14 01:50:22.4: (Observation V1904_Cyg interrupted by acquisition process failure.) 2018-11-14 01:50:26.8: Dispatcher cycle time: 0.7 sec. 2018-11-14 01:50:26.8: Acquire data for Observation V1721_Aql... 2018-11-14 01:50:26.8: (belongs to Project Nova_Monitoring, Plan V1721_Aql) 2018-11-14 01:50:26.9: Send Observation V1721_Aql to ACP Sequencer 2018-11-14 01:50:45.7: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:50:45.7: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:50:45.7: ACP data acquisition failed for Observation V1721_Aql. 2018-11-14 01:50:45.7: (Observation V1721_Aql interrupted by acquisition process failure.) 2018-11-14 01:50:55.1: Dispatcher cycle time: 2.4 sec. 2018-11-14 01:50:55.1: Acquire data for Observation V2481_Cyg... 2018-11-14 01:50:55.1: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V2481_Cyg) 2018-11-14 01:50:55.1: Send Observation V2481_Cyg to ACP Sequencer 2018-11-14 01:51:13.9: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:51:13.9: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:51:13.9: ACP data acquisition failed for Observation V2481_Cyg. 2018-11-14 01:51:13.9: (Observation V2481_Cyg interrupted by acquisition process failure.) 2018-11-14 01:51:22.5: Dispatcher cycle time: 2.4 sec. 2018-11-14 01:51:22.5: Acquire data for Observation M56... 2018-11-14 01:51:22.5: (belongs to Project AAVSO_Monitoring, Plan M56) 2018-11-14 01:51:22.5: Send Observation M56 to ACP Sequencer 2018-11-14 01:51:41.2: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:51:41.2: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:51:41.2: ACP data acquisition failed for Observation M56. 2018-11-14 01:51:41.2: (Observation M56 interrupted by acquisition process failure.) 2018-11-14 01:51:48.0: Dispatcher cycle time: 3.4 sec. 2018-11-14 01:51:48.0: Acquire data for Observation 2MASS_J19395313+0557550... 2018-11-14 01:51:48.0: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan 2MASS_J19395313+0557550) 2018-11-14 01:51:48.3: Send Observation 2MASS_J19395313+0557550 to ACP Sequencer 2018-11-14 01:52:06.8: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:52:06.8: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:52:06.8: ACP data acquisition failed for Observation 2MASS_J19395313+0557550. 2018-11-14 01:52:06.8: (Observation 2MASS_J19395313+0557550 interrupted by acquisition process failure.) 2018-11-14 01:52:11.7: Dispatcher cycle time: 1.4 sec. 2018-11-14 01:52:11.7: Acquire data for Observation IRAS_19183+2339... 2018-11-14 01:52:11.7: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan IRAS_19183+2339) 2018-11-14 01:52:12.1: Send Observation IRAS_19183+2339 to ACP Sequencer 2018-11-14 01:52:30.9: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:52:30.9: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:52:30.9: ACP data acquisition failed for Observation IRAS_19183+2339. 2018-11-14 01:52:30.9: (Observation IRAS_19183+2339 interrupted by acquisition process failure.) 2018-11-14 01:52:38.1: Dispatcher stopped at 14-Nov-2018 01:52:38 UTC 2018-11-14 01:52:38.2: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 2018-11-14 01:57:46.5: Dispatcher started at 14-Nov-2018 01:57:46 UTC 2018-11-14 01:57:49.8: ++ Observatory Startup ++ 2018-11-14 01:57:50.1: Start ACP Sequencer's StartupObs script 2018-11-14 01:57:51.0: Starting with open dome, unsafe weather will cause operator intervention error 2018-11-14 01:58:08.8: Observatory startup succeeded 2018-11-14 01:58:13.1: ++ Auto Focus ++ 2018-11-14 01:58:13.1: Doing initial autofocus. 2018-11-14 01:58:13.2: Start special ACP AutoFocus script for scheduler 2018-11-14 01:58:29.0: ** Autofocus failed (n=1), will retry ASAP after 0 min. 2018-11-14 01:58:29.0: Rising plan delay enabled for Plan V0603_Per: 2018-11-14 01:58:29.0: 646 min. remaining to meet strict constraints. 2018-11-14 01:58:29.0: 641 min. remaining for the plan to fit before dawn. 2018-11-14 01:58:29.0: but only 322 min till mid-Plan transit. 2018-11-14 01:58:29.0: deferred (rising) for 322 min, until 14-Nov-2018 07:21:23 UTC 2018-11-14 01:58:29.1: Dispatcher cycle time: 0.1 sec. 2018-11-14 01:58:29.1: Acquire data for Observation NSVS_11201899... 2018-11-14 01:58:29.1: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan NSVS_11201899) 2018-11-14 01:58:29.1: ++ Auto Focus ++ 2018-11-14 01:58:29.1: Doing periodic autofocus. 2018-11-14 01:58:29.1: Start special ACP AutoFocus script for scheduler 2018-11-14 01:58:44.6: ** Autofocus failed (n=2), will retry ASAP after 5 min. 2018-11-14 01:58:45.1: Send Observation NSVS_11201899 to ACP Sequencer 2018-11-14 01:58:57.8: Dispatcher stopped at 14-Nov-2018 01:58:57 UTC 2018-11-14 01:58:57.8: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 2018-11-14 01:59:05.2: ASSERT: ACP script exited with AcquireNow still True 2018-11-14 01:59:05.2: ACP ERROR: Run failed for unknown reason (see ACP run log) 2018-11-14 01:59:05.2: ACP data acquisition failed for Observation NSVS_11201899. 2018-11-14 01:59:05.2: (Observation NSVS_11201899 interrupted by acquisition process failure.)