Log opened at Sat, Dec 10 2016 19:01:50 UTC (actual time) Current log level is Verbose Scheduler version 3.5.3 Multi-user license: Arne Henden 10-Dec-2016 23:57:52.4: ++ Observatory Startup ++ 10-Dec-2016 23:57:52.5: Start ACP Sequencer's StartupObs script 10-Dec-2016 23:58:30.7: Open the observatory dome/roof 11-Dec-2016 00:59:52.9: ++ Auto Focus ++ 11-Dec-2016 00:59:52.9: Doing initial autofocus. 11-Dec-2016 00:59:52.9: Start special ACP AutoFocus script for scheduler 11-Dec-2016 01:03:12.7: Next periodic autofocus ASAP after 11-Dec-2016 03:03:01 UTC 11-Dec-2016 01:03:14.3: Plan V0809_Cep has Monitor Mode. Time to resubmit it. 11-Dec-2016 01:03:14.3: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it. 11-Dec-2016 01:03:14.3: Plan V1404_Cyg has Monitor Mode. Time to resubmit it. 11-Dec-2016 01:03:14.3: Plan QQ_Vul has Monitor Mode. Time to resubmit it. 11-Dec-2016 01:03:14.3: Plan FO_Aqr has Monitor Mode. Time to resubmit it. 11-Dec-2016 01:03:14.3: Plan BY_Cam has Monitor Mode. Time to resubmit it. 11-Dec-2016 01:03:14.3: Plan NGC_7790 has Monitor Mode. Time to resubmit it. 11-Dec-2016 01:03:15.0: Dispatcher cycle time: 0.690001 sec. 11-Dec-2016 01:03:15.0: Acquire data for Observation M56... 11-Dec-2016 01:03:15.0: (belongs to Project AAVSO_Monitoring, Plan M56) 11-Dec-2016 01:03:15.0: Doing 3 sets 11-Dec-2016 01:03:15.0: Send Observation M56 to ACP Sequencer 11-Dec-2016 01:09:33.8: Send Observation M56 to ACP Sequencer 11-Dec-2016 01:15:07.8: Send Observation M56 to ACP Sequencer 11-Dec-2016 01:20:35.9: Acquisition time: 1040.858461 sec. 11-Dec-2016 01:20:35.9: Data for Observation M56 acquired successfully. 11-Dec-2016 01:20:35.9: Image Efficiency: 69.1% 11-Dec-2016 01:20:35.9: Cycle Efficiency: 99.9% 11-Dec-2016 01:20:36.7: Dispatcher cycle time: 0.3600005 sec. 11-Dec-2016 01:20:36.7: Acquire data for Observation QQ_Vul_TMO61... 11-Dec-2016 01:20:36.7: (belongs to Project Walker, Plan QQ_Vul) 11-Dec-2016 01:20:36.7: Doing 1000 sets 11-Dec-2016 01:20:36.7: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:25:21.5: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:29:21.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:33:29.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:37:35.8: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:41:42.5: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:45:50.0: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:49:56.8: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:53:56.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 01:57:59.9: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:02:08.0: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:06:14.5: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:10:12.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:14:14.3: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:18:23.0: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:22:25.0: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:26:28.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:30:35.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:34:35.7: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:38:44.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:42:50.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:46:58.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 11-Dec-2016 02:51:07.4: ***Running Plan QQ_Vul (best efforts) completed early: 11-Dec-2016 02:51:07.4: Obs QQ_Vul_TMO61 would would not meet constraints 11-Dec-2016 02:51:07.4: Acquisition time: 5430.4796558 sec. 11-Dec-2016 02:51:07.4: Data for Observation QQ_Vul_TMO61 acquired successfully. 11-Dec-2016 02:51:07.5: Image Efficiency: 81.0% 11-Dec-2016 02:51:07.5: Cycle Efficiency: 100.0% 11-Dec-2016 02:51:09.6: Dispatcher cycle time: 0.2000003 sec. 11-Dec-2016 02:51:09.6: Acquire data for Observation FO_Aqr... 11-Dec-2016 02:51:09.6: (belongs to Project Walker, Plan FO_Aqr) 11-Dec-2016 02:51:09.6: Doing 500 sets 11-Dec-2016 02:51:09.6: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 02:54:18.9: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 02:56:39.0: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 02:59:03.3: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:01:25.4: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:03:47.7: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:06:10.0: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:08:30.8: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:10:55.7: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:13:17.2: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:15:40.5: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:18:01.1: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:20:20.2: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:22:43.2: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:25:05.9: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:27:27.2: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:29:49.9: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:32:11.6: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:34:32.8: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:36:51.8: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:39:14.2: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:41:36.6: Send Observation FO_Aqr to ACP Sequencer 11-Dec-2016 03:43:58.8: ***Running Plan FO_Aqr (best efforts) completed early: 11-Dec-2016 03:43:58.8: Obs FO_Aqr would would not meet constraints 11-Dec-2016 03:43:58.8: Acquisition time: 3168.8594579 sec. 11-Dec-2016 03:43:58.8: Data for Observation FO_Aqr acquired successfully. 11-Dec-2016 03:43:58.8: Image Efficiency: 69.4% 11-Dec-2016 03:43:58.8: Cycle Efficiency: 100.0% 11-Dec-2016 03:43:59.0: ++ Auto Focus ++ 11-Dec-2016 03:43:59.0: Doing periodic autofocus. 11-Dec-2016 03:43:59.0: Start special ACP AutoFocus script for scheduler 11-Dec-2016 03:48:04.9: Next periodic autofocus ASAP after 11-Dec-2016 05:47:21 UTC 11-Dec-2016 03:48:05.2: Dispatcher cycle time: 0.1600003 sec. 11-Dec-2016 03:48:05.2: Acquire data for Observation V1404_Cyg_TMO61... 11-Dec-2016 03:48:05.2: (belongs to Project Walker, Plan V1404_Cyg) 11-Dec-2016 03:48:05.2: Send Observation V1404_Cyg_TMO61 to ACP Sequencer 11-Dec-2016 03:58:28.0: ACP data acquisition failed for Observation V1404_Cyg_TMO61. 11-Dec-2016 03:58:28.0: (Observation V1404_Cyg_TMO61 interrupted by acquisition process failure.) 11-Dec-2016 03:58:29.5: Dispatcher cycle time: 0.1400002 sec. 11-Dec-2016 03:58:29.5: Acquire data for Observation V0809_Cep... 11-Dec-2016 03:58:29.5: (belongs to Project Nova_Monitoring, Plan V0809_Cep) 11-Dec-2016 03:58:29.5: Send Observation V0809_Cep to ACP Sequencer 11-Dec-2016 04:28:25.9: Acquisition time: 1796.3645151 sec. 11-Dec-2016 04:28:25.9: Data for Observation V0809_Cep acquired successfully. 11-Dec-2016 04:28:25.9: Image Efficiency: 77.9% 11-Dec-2016 04:28:25.9: Cycle Efficiency: 100.0% 11-Dec-2016 04:28:26.6: Dispatcher cycle time: 0.1500002 sec. 11-Dec-2016 04:28:26.6: Acquire data for Observation GSC_3649-0825... 11-Dec-2016 04:28:26.6: (belongs to Project Staels, Plan GSC_3649-0825) 11-Dec-2016 04:28:26.7: Send Observation GSC_3649-0825 to ACP Sequencer 11-Dec-2016 04:32:38.9: Acquisition time: 252.2103531 sec. 11-Dec-2016 04:32:38.9: Data for Observation GSC_3649-0825 acquired successfully. 11-Dec-2016 04:32:38.9: Image Efficiency: 53.5% 11-Dec-2016 04:32:38.9: Cycle Efficiency: 99.9% 11-Dec-2016 04:32:40.6: Dispatcher cycle time: 0.1600002 sec. 11-Dec-2016 04:32:40.6: Acquire data for Observation NGC_7790... 11-Dec-2016 04:32:40.6: (belongs to Project AAVSO_Monitoring, Plan NGC_7790) 11-Dec-2016 04:32:40.6: Doing 3 sets 11-Dec-2016 04:32:40.6: Send Observation NGC_7790 to ACP Sequencer 11-Dec-2016 04:38:33.9: Send Observation NGC_7790 to ACP Sequencer 11-Dec-2016 04:44:04.8: Send Observation NGC_7790 to ACP Sequencer 11-Dec-2016 04:49:30.7: Acquisition time: 1010.066429 sec. 11-Dec-2016 04:49:30.7: Data for Observation NGC_7790 acquired successfully. 11-Dec-2016 04:49:30.7: Image Efficiency: 46.0% 11-Dec-2016 04:49:30.7: Cycle Efficiency: 100.0% 11-Dec-2016 04:49:31.4: Dispatcher cycle time: 0.1700002 sec. 11-Dec-2016 04:49:31.4: Acquire data for Observation BY Cam... 11-Dec-2016 04:49:31.4: (belongs to Project Walker, Plan BY_Cam) 11-Dec-2016 04:49:31.8: Send Observation BY Cam to ACP Sequencer 11-Dec-2016 09:53:39.6: ** Script interrupted by weather safety event. 11-Dec-2016 09:53:42.6: ACP ABORT: Acquisition process was interrupted by weather unsafe. 11-Dec-2016 09:53:42.6: ACP data acquisition failed for Observation BY Cam. 11-Dec-2016 09:53:42.6: (Plan BY_Cam will be resubmitted in its entirety. 11-Dec-2016 09:53:42.6: (Observation BY Cam interrupted by weather unsafe event.) 11-Dec-2016 09:53:43.0: -- Weather Unsafe -- 11-Dec-2016 10:31:58.8: ++ Weather Safe ++ 11-Dec-2016 10:32:00.9: ++ Observatory Startup ++ 11-Dec-2016 10:32:00.9: Start ACP Sequencer's StartupObs script 11-Dec-2016 10:32:17.6: Open the observatory dome/roof 11-Dec-2016 10:33:41.6: ++ Auto Focus ++ 11-Dec-2016 10:33:41.6: Doing initial autofocus. 11-Dec-2016 10:33:42.0: Start special ACP AutoFocus script for scheduler 11-Dec-2016 10:37:29.6: ** Autofocus failed (n=1), will retry ASAP after 0 min. 11-Dec-2016 10:37:30.8: Dispatcher cycle time: 0.5600008 sec. 11-Dec-2016 10:37:30.8: Acquire data for Observation CB_32... 11-Dec-2016 10:37:30.8: (belongs to Project Staels, Plan CB_32) 11-Dec-2016 10:37:30.8: Send Observation CB_32 to ACP Sequencer 11-Dec-2016 10:41:38.1: Acquisition time: 247.3113463 sec. 11-Dec-2016 10:41:38.1: Data for Observation CB_32 acquired successfully. 11-Dec-2016 10:41:38.1: Image Efficiency: 36.3% 11-Dec-2016 10:41:38.1: Cycle Efficiency: 99.8% 11-Dec-2016 10:41:39.7: ++ Auto Focus ++ 11-Dec-2016 10:41:39.8: Doing periodic autofocus. 11-Dec-2016 10:41:39.8: Start special ACP AutoFocus script for scheduler 11-Dec-2016 10:44:53.2: ** Autofocus failed (n=2), will retry ASAP after 5 min. 11-Dec-2016 10:44:53.8: Dispatcher cycle time: 0.1400002 sec. 11-Dec-2016 10:44:53.8: Acquire data for Observation V0959_Mon... 11-Dec-2016 10:44:53.8: (belongs to Project Nova_Monitoring, Plan V0959_Mon) 11-Dec-2016 10:44:53.8: Send Observation V0959_Mon to ACP Sequencer 11-Dec-2016 10:59:58.0: Acquisition time: 904.261266 sec. 11-Dec-2016 10:59:58.0: Data for Observation V0959_Mon acquired successfully. 11-Dec-2016 10:59:58.1: Image Efficiency: 69.7% 11-Dec-2016 10:59:58.1: Cycle Efficiency: 100.0% 11-Dec-2016 10:59:58.5: ++ Auto Focus ++ 11-Dec-2016 10:59:58.5: Doing periodic autofocus. 11-Dec-2016 10:59:58.5: Start special ACP AutoFocus script for scheduler 11-Dec-2016 11:06:39.8: ** Autofocus failed (n=3), will retry ASAP after 10 min. 11-Dec-2016 11:06:41.5: Dispatcher cycle time: 0.1400002 sec. 11-Dec-2016 11:06:41.5: Acquire data for Observation MP_Gem... 11-Dec-2016 11:06:41.5: (belongs to Project Staels, Plan MP_Gem) 11-Dec-2016 11:06:41.5: Send Observation MP_Gem to ACP Sequencer 11-Dec-2016 11:37:29.7: Acquisition time: 1848.2745877 sec. 11-Dec-2016 11:37:29.7: Data for Observation MP_Gem acquired successfully. 11-Dec-2016 11:37:29.8: Image Efficiency: 77.9% 11-Dec-2016 11:37:29.8: Cycle Efficiency: 100.0% 11-Dec-2016 11:37:30.9: ++ Auto Focus ++ 11-Dec-2016 11:37:31.0: Doing periodic autofocus. 11-Dec-2016 11:37:31.0: Start special ACP AutoFocus script for scheduler 11-Dec-2016 11:41:34.5: ** Autofocus failed (n=4), will retry ASAP after 15 min. 11-Dec-2016 11:41:36.3: Dispatcher cycle time: 0.1300001 sec. 11-Dec-2016 11:41:36.3: Acquire data for Observation BX_Pup... 11-Dec-2016 11:41:36.3: (belongs to Project NMSU, Plan BX_Pup) 11-Dec-2016 11:41:36.3: Send Observation BX_Pup to ACP Sequencer 11-Dec-2016 11:51:39.9: Acquisition time: 603.601845 sec. 11-Dec-2016 11:51:39.9: Data for Observation BX_Pup acquired successfully. 11-Dec-2016 11:51:39.9: Image Efficiency: 59.6% 11-Dec-2016 11:51:39.9: Cycle Efficiency: 100.0% 11-Dec-2016 11:51:40.4: Dispatcher cycle time: 0.1300002 sec. 11-Dec-2016 11:51:40.4: Acquire data for Observation SDSS073224... 11-Dec-2016 11:51:40.4: (belongs to Project AGN, Plan SDSS073224) 11-Dec-2016 11:51:40.4: Send Observation SDSS073224 to ACP Sequencer 11-Dec-2016 11:56:45.8: ** Script interrupted by weather safety event. 11-Dec-2016 11:56:48.8: ACP ABORT: Acquisition process was interrupted by weather unsafe. 11-Dec-2016 11:56:48.8: ACP data acquisition failed for Observation SDSS073224. 11-Dec-2016 11:56:48.8: (Plan SDSS073224 will be resubmitted in its entirety. 11-Dec-2016 11:56:48.8: (Observation SDSS073224 interrupted by weather unsafe event.) 11-Dec-2016 11:56:50.6: -- Weather Unsafe -- 11-Dec-2016 12:23:49.7: ++ Weather Safe ++ 11-Dec-2016 12:23:51.8: ++ Observatory Startup ++ 11-Dec-2016 12:23:51.8: Start ACP Sequencer's StartupObs script 11-Dec-2016 12:24:08.9: Open the observatory dome/roof 11-Dec-2016 12:25:15.9: ++ Auto Focus ++ 11-Dec-2016 12:25:16.0: Doing initial autofocus. 11-Dec-2016 12:25:16.0: Start special ACP AutoFocus script for scheduler 11-Dec-2016 12:30:41.3: ** Autofocus failed (n=5), will retry ASAP after 20 min. 11-Dec-2016 12:30:42.9: Dispatcher cycle time: 0.1400001 sec. 11-Dec-2016 12:30:42.9: Acquire data for Observation M67... 11-Dec-2016 12:30:43.2: (belongs to Project AAVSO_Monitoring, Plan M67) 11-Dec-2016 12:30:43.2: Send Observation M67 to ACP Sequencer 11-Dec-2016 12:58:05.6: ACP data acquisition failed for Observation M67. 11-Dec-2016 12:58:05.6: (Observation M67 interrupted by acquisition process failure.) 11-Dec-2016 12:58:06.9: ++ Auto Focus ++ 11-Dec-2016 12:58:06.9: Doing periodic autofocus. 11-Dec-2016 12:58:06.9: Start special ACP AutoFocus script for scheduler 11-Dec-2016 13:01:05.5: ** Autofocus failed (n=6), will retry ASAP after 20 min. 11-Dec-2016 13:01:36.6: ++ Dawn Flats ++ 11-Dec-2016 13:01:36.6: Start ACP AutoFlat script for Dawn 11-Dec-2016 13:47:25.5: -- Observatory Shutdown -- 11-Dec-2016 13:47:25.6: Weather disconnected. 11-Dec-2016 13:47:25.6: Start ACP Sequencer's ShutdownObs script 11-Dec-2016 13:51:56.6: Weather successfully connected. Wait for valid data... 11-Dec-2016 18:06:38.3: -- Weather Unsafe -- 11-Dec-2016 19:01:33.4: Run statistics: 11-Dec-2016 19:01:33.4: Observations: 35 11-Dec-2016 19:01:33.4: Considered: 26 11-Dec-2016 19:01:33.4: Completed: 11 11-Dec-2016 19:01:33.4: Skipped: 11 11-Dec-2016 19:01:33.4: Never Eligible: 9 11-Dec-2016 19:01:33.4: Failed: 4 Log closed at Sun, Dec 11 2016 19:01:33 UTC (actual time)