Log opened at Tue, Dec 06 2016 18:59:01 UTC (actual time) Current log level is Verbose Scheduler version 3.5.3 Multi-user license: Arne Henden 06-Dec-2016 22:32:28.2: ++ Weather Safe ++ 06-Dec-2016 23:57:24.9: ++ Observatory Startup ++ 06-Dec-2016 23:57:24.9: Start ACP Sequencer's StartupObs script 06-Dec-2016 23:58:02.2: Open the observatory dome/roof 07-Dec-2016 00:59:31.0: ++ Auto Focus ++ 07-Dec-2016 00:59:31.0: Doing initial autofocus. 07-Dec-2016 00:59:31.0: Start special ACP AutoFocus script for scheduler 07-Dec-2016 01:03:34.9: ** Autofocus failed (n=1), will retry ASAP after 0 min. 07-Dec-2016 01:03:36.4: Plan V0809_Cep has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan V0959_Mon has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan MP_Gem has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan CB_32 has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan V0965_Per has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan SDSS073224 has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan WD has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan M67 has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan GSC_4030_204 has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan BX_Pup has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan Z_Cam has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan AT_Cnc has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.4: Plan SY_Cnc has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.5: Plan ES_Dra has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.5: Plan NGC_7790 has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:36.5: Plan T_Ori has Monitor Mode. Time to resubmit it. 07-Dec-2016 01:03:37.2: Dispatcher cycle time: 0.8200012 sec. 07-Dec-2016 01:03:37.2: Acquire data for Observation U_Aqr... 07-Dec-2016 01:03:37.2: (belongs to Project AAVSO_Monitoring, Plan U_Aqr) 07-Dec-2016 01:03:37.2: Send Observation U_Aqr to ACP Sequencer 07-Dec-2016 01:11:16.6: ACP data acquisition failed for Observation U_Aqr. 07-Dec-2016 01:11:16.6: (Observation U_Aqr interrupted by acquisition process failure.) 07-Dec-2016 01:11:17.8: ++ Auto Focus ++ 07-Dec-2016 01:11:17.8: Doing periodic autofocus. 07-Dec-2016 01:11:17.8: Start special ACP AutoFocus script for scheduler 07-Dec-2016 01:14:24.9: Next periodic autofocus ASAP after 07-Dec-2016 03:13:57 UTC 07-Dec-2016 01:14:27.3: Dispatcher cycle time: 0.720001 sec. 07-Dec-2016 01:14:27.3: Acquire data for Observation QQ_Vul_TMO61... 07-Dec-2016 01:14:27.3: (belongs to Project Walker, Plan QQ_Vul) 07-Dec-2016 01:14:27.3: Doing 1000 sets 07-Dec-2016 01:14:27.3: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:19:25.4: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:23:32.8: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:27:39.3: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:31:46.5: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:35:50.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:39:56.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:44:00.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:48:09.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:52:15.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 01:56:19.8: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:00:20.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:04:24.2: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:08:37.4: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:12:46.8: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:16:53.0: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:20:57.5: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:25:10.0: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:29:21.3: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:33:20.8: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:37:26.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:41:37.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:45:42.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:49:50.4: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:53:59.8: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 02:58:08.7: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 03:02:13.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 03:06:18.3: Send Observation QQ_Vul_TMO61 to ACP Sequencer 07-Dec-2016 03:10:28.5: ***Running Plan QQ_Vul (best efforts) completed early: 07-Dec-2016 03:10:28.5: Obs QQ_Vul_TMO61 would would not meet constraints 07-Dec-2016 03:10:28.5: Acquisition time: 6960.6838798 sec. 07-Dec-2016 03:10:28.5: Data for Observation QQ_Vul_TMO61 acquired successfully. 07-Dec-2016 03:10:28.5: Image Efficiency: 80.4% 07-Dec-2016 03:10:28.5: Cycle Efficiency: 100.0% 07-Dec-2016 03:10:31.1: Dispatcher cycle time: 0.2100003 sec. 07-Dec-2016 03:10:31.1: Acquire data for Observation FO_Aqr... 07-Dec-2016 03:10:31.1: (belongs to Project Walker, Plan FO_Aqr) 07-Dec-2016 03:10:31.1: Doing 500 sets 07-Dec-2016 03:10:31.1: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:13:42.4: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:16:05.8: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:18:26.9: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:20:47.8: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:23:09.0: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:25:34.1: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:27:57.9: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:30:19.4: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:32:45.0: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:35:05.9: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:37:28.4: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:39:45.9: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:42:10.5: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:44:30.7: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:46:55.8: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:49:17.9: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:51:44.4: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:54:11.5: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:56:34.5: Send Observation FO_Aqr to ACP Sequencer 07-Dec-2016 03:58:56.9: ***Running Plan FO_Aqr (best efforts) completed early: 07-Dec-2016 03:58:56.9: Obs FO_Aqr would would not meet constraints 07-Dec-2016 03:58:56.9: Acquisition time: 2905.3982437 sec. 07-Dec-2016 03:58:56.9: Data for Observation FO_Aqr acquired successfully. 07-Dec-2016 03:58:57.0: Image Efficiency: 68.8% 07-Dec-2016 03:58:57.0: Cycle Efficiency: 100.0% 07-Dec-2016 03:58:59.8: ++ Auto Focus ++ 07-Dec-2016 03:58:59.9: Doing periodic autofocus. 07-Dec-2016 03:58:59.9: Start special ACP AutoFocus script for scheduler 07-Dec-2016 04:02:56.9: Next periodic autofocus ASAP after 07-Dec-2016 06:02:04 UTC 07-Dec-2016 04:02:57.1: Dispatcher cycle time: 0.2300003 sec. 07-Dec-2016 04:02:57.1: Acquire data for Observation V1404_Cyg_TMO61... 07-Dec-2016 04:02:57.1: (belongs to Project Walker, Plan V1404_Cyg) 07-Dec-2016 04:02:57.2: Send Observation V1404_Cyg_TMO61 to ACP Sequencer 07-Dec-2016 04:12:39.5: ACP data acquisition failed for Observation V1404_Cyg_TMO61. 07-Dec-2016 04:12:39.5: (Observation V1404_Cyg_TMO61 interrupted by acquisition process failure.) 07-Dec-2016 04:12:39.8: Dispatcher cycle time: 0.2100003 sec. 07-Dec-2016 04:12:39.8: Acquire data for Observation V0809_Cep... 07-Dec-2016 04:12:39.8: (belongs to Project Nova_Monitoring, Plan V0809_Cep) 07-Dec-2016 04:12:39.8: Send Observation V0809_Cep to ACP Sequencer 07-Dec-2016 04:42:51.9: Acquisition time: 1812.0846141 sec. 07-Dec-2016 04:42:51.9: Data for Observation V0809_Cep acquired successfully. 07-Dec-2016 04:42:52.0: Image Efficiency: 77.2% 07-Dec-2016 04:42:52.0: Cycle Efficiency: 100.0% 07-Dec-2016 04:42:54.0: Dispatcher cycle time: 0.2500003 sec. 07-Dec-2016 04:42:54.0: Acquire data for Observation GSC_3649-0825... 07-Dec-2016 04:42:54.0: (belongs to Project Staels, Plan GSC_3649-0825) 07-Dec-2016 04:42:54.0: Send Observation GSC_3649-0825 to ACP Sequencer 07-Dec-2016 04:47:07.5: Acquisition time: 253.5263648 sec. 07-Dec-2016 04:47:07.5: Data for Observation GSC_3649-0825 acquired successfully. 07-Dec-2016 04:47:07.5: Image Efficiency: 53.2% 07-Dec-2016 04:47:07.5: Cycle Efficiency: 99.9% 07-Dec-2016 04:47:07.8: Dispatcher cycle time: 0.1900003 sec. 07-Dec-2016 04:47:07.8: Acquire data for Observation NGC_7790... 07-Dec-2016 04:47:07.8: (belongs to Project AAVSO_Monitoring, Plan NGC_7790) 07-Dec-2016 04:47:07.8: Doing 3 sets 07-Dec-2016 04:47:07.8: Send Observation NGC_7790 to ACP Sequencer 07-Dec-2016 04:53:04.2: Send Observation NGC_7790 to ACP Sequencer 07-Dec-2016 04:58:32.9: Send Observation NGC_7790 to ACP Sequencer 07-Dec-2016 05:04:05.1: Acquisition time: 1017.240524 sec. 07-Dec-2016 05:04:05.1: Data for Observation NGC_7790 acquired successfully. 07-Dec-2016 05:04:05.1: Image Efficiency: 45.7% 07-Dec-2016 05:04:05.1: Cycle Efficiency: 100.0% 07-Dec-2016 05:04:05.8: Dispatcher cycle time: 0.2300003 sec. 07-Dec-2016 05:04:05.8: Acquire data for Observation GSC_4030_204... 07-Dec-2016 05:04:05.8: (belongs to Project Staels, Plan GSC_4030_204) 07-Dec-2016 05:04:06.2: Send Observation GSC_4030_204 to ACP Sequencer 07-Dec-2016 05:06:22.3: Acquisition time: 136.4061952 sec. 07-Dec-2016 05:06:22.3: Data for Observation GSC_4030_204 acquired successfully. 07-Dec-2016 05:06:22.3: Image Efficiency: 21.9% 07-Dec-2016 05:06:22.3: Cycle Efficiency: 99.8% 07-Dec-2016 05:06:23.2: Dispatcher cycle time: 0.2400003 sec. 07-Dec-2016 05:06:23.2: Acquire data for Observation V0965_Per... 07-Dec-2016 05:06:23.2: (belongs to Project Nova_Monitoring, Plan V0965_Per) 07-Dec-2016 05:06:23.2: Send Observation V0965_Per to ACP Sequencer 07-Dec-2016 05:26:17.8: Acquisition time: 1194.5527444 sec. 07-Dec-2016 05:26:17.8: Data for Observation V0965_Per acquired successfully. 07-Dec-2016 05:26:17.8: Image Efficiency: 75.3% 07-Dec-2016 05:26:17.8: Cycle Efficiency: 100.0% 07-Dec-2016 05:26:18.7: Dispatcher cycle time: 0.1800002 sec. 07-Dec-2016 05:26:18.7: Acquire data for Observation T_Ori... 07-Dec-2016 05:26:18.7: (belongs to Project AAVSO_Monitoring, Plan T_Ori) 07-Dec-2016 05:26:18.7: Doing 3 sets 07-Dec-2016 05:26:18.7: Send Observation T_Ori to ACP Sequencer 07-Dec-2016 05:30:21.4: Send Observation T_Ori to ACP Sequencer 07-Dec-2016 05:33:21.5: Send Observation T_Ori to ACP Sequencer 07-Dec-2016 05:36:25.7: Acquisition time: 606.9998827 sec. 07-Dec-2016 05:36:25.7: Data for Observation T_Ori acquired successfully. 07-Dec-2016 05:36:25.7: Image Efficiency: 44.5% 07-Dec-2016 05:36:25.7: Cycle Efficiency: 100.0% 07-Dec-2016 05:36:26.7: Dispatcher cycle time: 0.1800003 sec. 07-Dec-2016 05:36:26.7: Acquire data for Observation CB_32... 07-Dec-2016 05:36:26.7: (belongs to Project Staels, Plan CB_32) 07-Dec-2016 05:36:26.7: Send Observation CB_32 to ACP Sequencer 07-Dec-2016 05:40:21.4: Acquisition time: 234.7143372 sec. 07-Dec-2016 05:40:21.4: Data for Observation CB_32 acquired successfully. 07-Dec-2016 05:40:21.5: Image Efficiency: 38.3% 07-Dec-2016 05:40:21.5: Cycle Efficiency: 99.9% 07-Dec-2016 05:40:21.7: Dispatcher cycle time: 0.1700002 sec. 07-Dec-2016 05:40:21.7: Acquire data for Observation V0959_Mon... 07-Dec-2016 05:40:21.8: (belongs to Project Nova_Monitoring, Plan V0959_Mon) 07-Dec-2016 05:40:21.8: Send Observation V0959_Mon to ACP Sequencer 07-Dec-2016 05:55:30.4: Acquisition time: 908.6443219 sec. 07-Dec-2016 05:55:30.4: Data for Observation V0959_Mon acquired successfully. 07-Dec-2016 05:55:30.4: Image Efficiency: 69.3% 07-Dec-2016 05:55:30.4: Cycle Efficiency: 100.0% 07-Dec-2016 05:55:31.7: Dispatcher cycle time: 0.1600002 sec. 07-Dec-2016 05:55:31.7: Acquire data for Observation MP_Gem... 07-Dec-2016 05:55:31.7: (belongs to Project Staels, Plan MP_Gem) 07-Dec-2016 05:55:31.7: Send Observation MP_Gem to ACP Sequencer 07-Dec-2016 06:26:33.4: Acquisition time: 1861.6696665 sec. 07-Dec-2016 06:26:33.4: Data for Observation MP_Gem acquired successfully. 07-Dec-2016 06:26:33.4: Image Efficiency: 77.3% 07-Dec-2016 06:26:33.4: Cycle Efficiency: 100.0% 07-Dec-2016 06:26:33.7: ++ Auto Focus ++ 07-Dec-2016 06:26:33.8: Doing periodic autofocus. 07-Dec-2016 06:26:33.8: Start special ACP AutoFocus script for scheduler 07-Dec-2016 06:30:44.8: ** Autofocus failed (n=1), will retry ASAP after 0 min. 07-Dec-2016 06:30:45.5: Dispatcher cycle time: 0.1400002 sec. 07-Dec-2016 06:30:45.5: Acquire data for Observation SDSS073224... 07-Dec-2016 06:30:45.5: (belongs to Project AGN, Plan SDSS073224) 07-Dec-2016 06:30:45.6: Send Observation SDSS073224 to ACP Sequencer 07-Dec-2016 07:18:51.2: Acquisition time: 2885.6030559 sec. 07-Dec-2016 07:18:51.2: Data for Observation SDSS073224 acquired successfully. 07-Dec-2016 07:18:51.2: Image Efficiency: 83.2% 07-Dec-2016 07:18:51.2: Cycle Efficiency: 100.0% 07-Dec-2016 07:18:51.8: ++ Auto Focus ++ 07-Dec-2016 07:18:51.9: Doing periodic autofocus. 07-Dec-2016 07:18:51.9: Start special ACP AutoFocus script for scheduler 07-Dec-2016 07:21:48.0: Next periodic autofocus ASAP after 07-Dec-2016 09:21:29 UTC 07-Dec-2016 07:21:49.5: Dispatcher cycle time: 0.1300002 sec. 07-Dec-2016 07:21:49.5: Acquire data for Observation AT_Cnc... 07-Dec-2016 07:21:49.5: (belongs to Project NMSU, Plan AT_Cnc) 07-Dec-2016 07:21:49.5: Send Observation AT_Cnc to ACP Sequencer 07-Dec-2016 07:32:04.3: Acquisition time: 614.8118608 sec. 07-Dec-2016 07:32:04.3: Data for Observation AT_Cnc acquired successfully. 07-Dec-2016 07:32:04.3: Image Efficiency: 58.5% 07-Dec-2016 07:32:04.3: Cycle Efficiency: 100.0% 07-Dec-2016 07:32:04.6: Dispatcher cycle time: 0.1400002 sec. 07-Dec-2016 07:32:04.6: Acquire data for Observation M67... 07-Dec-2016 07:32:04.6: (belongs to Project AAVSO_Monitoring, Plan M67) 07-Dec-2016 07:32:04.6: Send Observation M67 to ACP Sequencer 07-Dec-2016 08:03:49.9: Acquisition time: 1905.2736674 sec. 07-Dec-2016 08:03:49.9: Data for Observation M67 acquired successfully. 07-Dec-2016 08:03:49.9: Image Efficiency: 74.0% 07-Dec-2016 08:03:49.9: Cycle Efficiency: 100.0% 07-Dec-2016 08:03:50.2: Dispatcher cycle time: 0.1200002 sec. 07-Dec-2016 08:03:50.2: Acquire data for Observation BX_Pup... 07-Dec-2016 08:03:50.2: (belongs to Project NMSU, Plan BX_Pup) 07-Dec-2016 08:03:50.2: Send Observation BX_Pup to ACP Sequencer 07-Dec-2016 08:13:54.7: Acquisition time: 604.4418463 sec. 07-Dec-2016 08:13:54.7: Data for Observation BX_Pup acquired successfully. 07-Dec-2016 08:13:54.7: Image Efficiency: 59.5% 07-Dec-2016 08:13:54.7: Cycle Efficiency: 100.0% 07-Dec-2016 08:13:57.0: Dispatcher cycle time: 0.0900001 sec. 07-Dec-2016 08:13:57.0: Acquire data for Observation SY_Cnc... 07-Dec-2016 08:13:57.0: (belongs to Project NMSU, Plan SY_Cnc) 07-Dec-2016 08:13:57.0: Send Observation SY_Cnc to ACP Sequencer 07-Dec-2016 08:24:05.4: Acquisition time: 608.4318519 sec. 07-Dec-2016 08:24:05.4: Data for Observation SY_Cnc acquired successfully. 07-Dec-2016 08:24:05.4: Image Efficiency: 59.2% 07-Dec-2016 08:24:05.4: Cycle Efficiency: 100.0% 07-Dec-2016 08:24:06.9: Dispatcher cycle time: 0.0700001 sec. 07-Dec-2016 08:24:06.9: Acquire data for Observation Z_Cam... 07-Dec-2016 08:24:06.9: (belongs to Project NMSU, Plan Z_Cam) 07-Dec-2016 08:24:06.9: Send Observation Z_Cam to ACP Sequencer 07-Dec-2016 08:34:26.9: Acquisition time: 619.9708679 sec. 07-Dec-2016 08:34:26.9: Data for Observation Z_Cam acquired successfully. 07-Dec-2016 08:34:26.9: Image Efficiency: 58.1% 07-Dec-2016 08:34:26.9: Cycle Efficiency: 100.0% 07-Dec-2016 08:40:11.1: -- Weather Unsafe -- 07-Dec-2016 08:59:54.0: ++ Weather Safe ++ 07-Dec-2016 08:59:56.1: ++ Observatory Startup ++ 07-Dec-2016 08:59:56.1: Start ACP Sequencer's StartupObs script 07-Dec-2016 09:00:12.8: Open the observatory dome/roof 07-Dec-2016 09:00:33.9: **EXCEPTION IN SCHEDULER: 07-Dec-2016 09:00:33.9: DOME FAILURE: Dome reports shutter error status while opening 07-Dec-2016 09:00:33.9: Traceback: at DC3.Scheduler.ACPSequencer.OpenDome() at DC3.Scheduler.Engine.DoStartupIf(Boolean openDome) at DC3.Scheduler.Engine.Run() 07-Dec-2016 09:00:33.9: Run statistics: 07-Dec-2016 09:00:33.9: Observations: 35 07-Dec-2016 09:00:33.9: Considered: 26 07-Dec-2016 09:00:33.9: Completed: 18 07-Dec-2016 09:00:33.9: Skipped: 4 07-Dec-2016 09:00:33.9: Never Eligible: 9 07-Dec-2016 09:00:33.9: Failed: 4 07-Dec-2016 09:00:33.9: Shutter-Open efficiency: 35.32% 07-Dec-2016 09:00:33.9: Overall Efficiency: 99.90% 07-Dec-2016 09:00:33.9: Release ACP sequencer Log closed at Wed, Dec 07 2016 09:00:35 UTC (actual time)