Log opened at Thu, Dec 01 2016 01:52:07 UTC (actual time) Current log level is Verbose Scheduler version 3.5.3 Multi-user license: Arne Henden 01-Dec-2016 01:52:09.0: ++ Observatory Startup ++ 01-Dec-2016 01:52:09.0: Start ACP Sequencer's StartupObs script 01-Dec-2016 01:52:44.6: Open the observatory dome/roof 01-Dec-2016 01:53:53.7: ++ Auto Focus ++ 01-Dec-2016 01:53:53.8: Doing initial autofocus. 01-Dec-2016 01:53:53.8: Start special ACP AutoFocus script for scheduler 01-Dec-2016 01:56:52.8: Next periodic autofocus ASAP after 01-Dec-2016 03:56:37 UTC 01-Dec-2016 01:56:54.3: Plan MP_Gem has Monitor Mode. Time to resubmit it. 01-Dec-2016 01:56:54.3: Plan CB_32 has Monitor Mode. Time to resubmit it. 01-Dec-2016 01:56:54.3: Plan SDSS073224 has Monitor Mode. Time to resubmit it. 01-Dec-2016 01:56:54.3: Plan WD has Monitor Mode. Time to resubmit it. 01-Dec-2016 01:56:54.3: Plan M67 has Monitor Mode. Time to resubmit it. 01-Dec-2016 01:56:54.3: Plan NGC_7790 has Monitor Mode. Time to resubmit it. 01-Dec-2016 01:56:54.3: Plan T_Ori has Monitor Mode. Time to resubmit it. 01-Dec-2016 01:56:54.3: Plan U_Aqr has Monitor Mode. Time to resubmit it. 01-Dec-2016 01:56:54.9: Dispatcher cycle time: 0.6800009 sec. 01-Dec-2016 01:56:54.9: Acquire data for Observation QQ_Vul_TMO61... 01-Dec-2016 01:56:54.9: (belongs to Project Walker, Plan QQ_Vul) 01-Dec-2016 01:56:54.9: Doing 1000 sets 01-Dec-2016 01:56:54.9: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:01:52.9: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:05:56.9: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:10:01.5: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:14:06.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:18:09.7: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:22:13.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:26:18.4: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:30:25.2: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:34:29.4: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:38:36.7: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:42:44.4: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:46:52.2: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:50:59.6: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:55:05.8: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 02:59:09.7: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 03:03:13.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 03:07:23.4: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 03:11:27.9: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 03:15:32.9: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 03:19:41.1: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 03:23:46.5: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 03:27:55.5: Send Observation QQ_Vul_TMO61 to ACP Sequencer 01-Dec-2016 03:32:01.7: ***Running Plan QQ_Vul (best efforts) completed early: 01-Dec-2016 03:32:01.7: Obs QQ_Vul_TMO61 would would not meet constraints 01-Dec-2016 03:32:01.7: Acquisition time: 5706.4359903 sec. 01-Dec-2016 03:32:01.7: Data for Observation QQ_Vul_TMO61 acquired successfully. 01-Dec-2016 03:32:01.7: Image Efficiency: 80.6% 01-Dec-2016 03:32:01.7: Cycle Efficiency: 100.0% 01-Dec-2016 03:32:02.3: Dispatcher cycle time: 0.2300004 sec. 01-Dec-2016 03:32:02.3: Acquire data for Observation FO_Aqr... 01-Dec-2016 03:32:02.3: (belongs to Project Walker, Plan FO_Aqr) 01-Dec-2016 03:32:02.3: Doing 500 sets 01-Dec-2016 03:32:02.3: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:35:12.3: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:37:37.0: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:39:57.3: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:42:22.5: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:44:46.6: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:47:08.9: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:49:31.1: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:51:51.3: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:54:13.9: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:56:37.6: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 03:59:01.5: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:01:23.6: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:03:49.0: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:06:08.0: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:08:27.5: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:10:49.2: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:13:13.4: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:15:34.1: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:17:57.9: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:20:17.3: Send Observation FO_Aqr to ACP Sequencer 01-Dec-2016 04:22:41.6: ***Running Plan FO_Aqr (best efforts) completed early: 01-Dec-2016 04:22:41.6: Obs FO_Aqr would would not meet constraints 01-Dec-2016 04:22:41.6: Acquisition time: 3038.9322585 sec. 01-Dec-2016 04:22:41.6: Data for Observation FO_Aqr acquired successfully. 01-Dec-2016 04:22:41.6: Image Efficiency: 69.1% 01-Dec-2016 04:22:41.6: Cycle Efficiency: 100.0% 01-Dec-2016 04:22:43.4: ++ Auto Focus ++ 01-Dec-2016 04:22:43.5: Doing periodic autofocus. 01-Dec-2016 04:22:43.5: Start special ACP AutoFocus script for scheduler 01-Dec-2016 04:26:38.9: Next periodic autofocus ASAP after 01-Dec-2016 06:25:43 UTC 01-Dec-2016 04:26:40.6: Dispatcher cycle time: 0.1200002 sec. 01-Dec-2016 04:26:40.6: Acquire data for Observation V1404_Cyg_TMO61... 01-Dec-2016 04:26:40.6: (belongs to Project Walker, Plan V1404_Cyg) 01-Dec-2016 04:26:40.6: Send Observation V1404_Cyg_TMO61 to ACP Sequencer 01-Dec-2016 04:31:25.4: ACP data acquisition failed for Observation V1404_Cyg_TMO61. 01-Dec-2016 04:31:25.4: (Observation V1404_Cyg_TMO61 interrupted by acquisition process failure.) 01-Dec-2016 04:31:25.8: Dispatcher cycle time: 0.1300002 sec. 01-Dec-2016 04:31:25.8: Acquire data for Observation GSC_3649-0825... 01-Dec-2016 04:31:25.8: (belongs to Project Staels, Plan GSC_3649-0825) 01-Dec-2016 04:31:25.8: Send Observation GSC_3649-0825 to ACP Sequencer 01-Dec-2016 04:35:57.4: Acquisition time: 271.5903803 sec. 01-Dec-2016 04:35:57.4: Data for Observation GSC_3649-0825 acquired successfully. 01-Dec-2016 04:35:57.4: Image Efficiency: 49.7% 01-Dec-2016 04:35:57.4: Cycle Efficiency: 99.9% 01-Dec-2016 04:36:00.3: Dispatcher cycle time: 0.1400002 sec. 01-Dec-2016 04:36:00.3: Acquire data for Observation NGC_7790... 01-Dec-2016 04:36:00.3: (belongs to Project AAVSO_Monitoring, Plan NGC_7790) 01-Dec-2016 04:36:00.3: Doing 3 sets 01-Dec-2016 04:36:00.4: Send Observation NGC_7790 to ACP Sequencer 01-Dec-2016 04:41:57.6: Send Observation NGC_7790 to ACP Sequencer 01-Dec-2016 04:47:21.5: Send Observation NGC_7790 to ACP Sequencer 01-Dec-2016 04:52:51.9: Acquisition time: 1011.5224163 sec. 01-Dec-2016 04:52:51.9: Data for Observation NGC_7790 acquired successfully. 01-Dec-2016 04:52:51.9: Image Efficiency: 46.0% 01-Dec-2016 04:52:51.9: Cycle Efficiency: 100.0% 01-Dec-2016 04:52:53.9: Dispatcher cycle time: 0.1200002 sec. 01-Dec-2016 04:52:53.9: Acquire data for Observation GSC_4030_204... 01-Dec-2016 04:52:53.9: (belongs to Project Staels, Plan GSC_4030_204) 01-Dec-2016 04:52:53.9: Send Observation GSC_4030_204 to ACP Sequencer 01-Dec-2016 04:54:48.3: Acquisition time: 114.32016 sec. 01-Dec-2016 04:54:48.3: Data for Observation GSC_4030_204 acquired successfully. 01-Dec-2016 04:54:48.3: Image Efficiency: 26.2% 01-Dec-2016 04:54:48.3: Cycle Efficiency: 99.9% 01-Dec-2016 04:54:48.7: Dispatcher cycle time: 0.1400002 sec. 01-Dec-2016 04:54:48.7: Acquire data for Observation T_Ori... 01-Dec-2016 04:54:48.7: (belongs to Project AAVSO_Monitoring, Plan T_Ori) 01-Dec-2016 04:54:48.7: Doing 3 sets 01-Dec-2016 04:54:48.7: Send Observation T_Ori to ACP Sequencer 01-Dec-2016 04:58:52.3: Send Observation T_Ori to ACP Sequencer 01-Dec-2016 05:01:51.0: Send Observation T_Ori to ACP Sequencer 01-Dec-2016 05:04:49.3: Acquisition time: 600.5808409 sec. 01-Dec-2016 05:04:49.3: Data for Observation T_Ori acquired successfully. 01-Dec-2016 05:04:49.3: Image Efficiency: 44.9% 01-Dec-2016 05:04:49.3: Cycle Efficiency: 100.0% 01-Dec-2016 05:04:50.9: Dispatcher cycle time: 0.0900001 sec. 01-Dec-2016 05:04:50.9: Acquire data for Observation CB_32... 01-Dec-2016 05:04:50.9: (belongs to Project Staels, Plan CB_32) 01-Dec-2016 05:04:50.9: Send Observation CB_32 to ACP Sequencer 01-Dec-2016 05:08:24.7: Acquisition time: 213.7712993 sec. 01-Dec-2016 05:08:24.7: Data for Observation CB_32 acquired successfully. 01-Dec-2016 05:08:24.7: Image Efficiency: 42.1% 01-Dec-2016 05:08:24.7: Cycle Efficiency: 99.9% 01-Dec-2016 05:08:25.2: Dispatcher cycle time: 0.0800001 sec. 01-Dec-2016 05:08:25.2: Acquire data for Observation MP_Gem... 01-Dec-2016 05:08:25.2: (belongs to Project Staels, Plan MP_Gem) 01-Dec-2016 05:08:25.2: Send Observation MP_Gem to ACP Sequencer 01-Dec-2016 05:13:49.3: Acquisition time: 324.0804538 sec. 01-Dec-2016 05:13:49.3: Data for Observation MP_Gem acquired successfully. 01-Dec-2016 05:13:49.4: Image Efficiency: 55.5% 01-Dec-2016 05:13:49.4: Cycle Efficiency: 100.0% 01-Dec-2016 05:17:26.4: Dispatcher cycle time: 0.1500003 sec. 01-Dec-2016 05:17:26.4: Acquire data for Observation SDSS073224... 01-Dec-2016 05:17:26.4: (belongs to Project AGN, Plan SDSS073224) 01-Dec-2016 05:17:26.4: Send Observation SDSS073224 to ACP Sequencer 01-Dec-2016 05:19:11.3: ACP data acquisition failed for Observation SDSS073224. 01-Dec-2016 05:19:11.3: (Observation SDSS073224 interrupted by acquisition process failure.) 01-Dec-2016 05:58:05.3: Dispatcher stopped at 01-Dec-2016 05:58:05 UTC 01-Dec-2016 05:58:05.3: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 01-Dec-2016 05:58:11.7: Dispatcher started at 01-Dec-2016 05:58:11 UTC 01-Dec-2016 05:58:11.7: Priority: W[0]=0.00 01-Dec-2016 05:58:11.7: Transit Altitude: W[1]=0.00 01-Dec-2016 05:58:11.7: Highest Altitude: W[6]=0.00 01-Dec-2016 05:58:11.7: Lateness: W[5]=0.70 01-Dec-2016 05:58:11.7: Slew Distance: W[2]=0.30 01-Dec-2016 05:58:11.7: Retry Count: W[3]=0.20 01-Dec-2016 05:58:11.7: Meridian Crossing: W[4]=0.30 01-Dec-2016 05:58:11.7: Obs Conditions: W[7]=0.40 01-Dec-2016 05:58:11.7: Rising Plan Delay: disabled 01-Dec-2016 05:58:14.9: ++ Observatory Startup ++ 01-Dec-2016 05:58:14.9: Start ACP Sequencer's StartupObs script 01-Dec-2016 05:58:33.8: ++ Auto Focus ++ 01-Dec-2016 05:58:33.8: Doing initial autofocus. 01-Dec-2016 05:58:33.8: Start special ACP AutoFocus script for scheduler 01-Dec-2016 06:02:46.5: Next periodic autofocus ASAP after 01-Dec-2016 08:01:55 UTC 01-Dec-2016 07:37:24.5: Dispatcher cycle time: 0.0700001 sec. 01-Dec-2016 07:37:24.5: Acquire data for Observation M67... 01-Dec-2016 07:37:24.5: (belongs to Project AAVSO_Monitoring, Plan M67) 01-Dec-2016 07:37:24.5: Send Observation M67 to ACP Sequencer 01-Dec-2016 08:10:02.0: Acquisition time: 1957.5678034 sec. 01-Dec-2016 08:10:02.0: Data for Observation M67 acquired successfully. 01-Dec-2016 08:10:02.1: Image Efficiency: 72.0% 01-Dec-2016 08:10:02.1: Cycle Efficiency: 100.0% 01-Dec-2016 08:10:02.3: ++ Auto Focus ++ 01-Dec-2016 08:10:02.4: Doing periodic autofocus. 01-Dec-2016 08:10:02.4: Start special ACP AutoFocus script for scheduler 01-Dec-2016 08:13:32.4: Next periodic autofocus ASAP after 01-Dec-2016 10:13:07 UTC 01-Dec-2016 09:11:59.2: Dispatcher cycle time: 0.0700001 sec. 01-Dec-2016 09:11:59.2: Acquire data for Observation SDSSJ121027+502735... 01-Dec-2016 09:11:59.2: (belongs to Project NMSU, Plan WD) 01-Dec-2016 09:11:59.2: Send Observation SDSSJ121027+502735 to ACP Sequencer 01-Dec-2016 09:24:55.0: ACP data acquisition failed for Observation SDSSJ121027+502735. 01-Dec-2016 09:24:55.0: (Observation SDSSJ121027+502735 interrupted by acquisition process failure.) 01-Dec-2016 10:13:21.9: ++ Auto Focus ++ 01-Dec-2016 10:13:21.9: Doing periodic autofocus. 01-Dec-2016 10:13:21.9: Start special ACP AutoFocus script for scheduler 01-Dec-2016 10:16:59.6: Next periodic autofocus ASAP after 01-Dec-2016 12:16:38 UTC 01-Dec-2016 12:16:48.9: ++ Auto Focus ++ 01-Dec-2016 12:16:49.0: Doing periodic autofocus. 01-Dec-2016 12:16:49.0: Start special ACP AutoFocus script for scheduler 01-Dec-2016 12:20:10.9: Next periodic autofocus ASAP after 01-Dec-2016 14:19:24 UTC 01-Dec-2016 12:53:48.4: ++ Dawn Flats ++ 01-Dec-2016 12:53:48.4: Start ACP AutoFlat script for Dawn 01-Dec-2016 13:39:22.4: -- Observatory Shutdown -- 01-Dec-2016 13:39:22.4: Weather disconnected. 01-Dec-2016 13:39:22.4: Start ACP Sequencer's ShutdownObs script 01-Dec-2016 13:44:55.2: Weather successfully connected. Wait for valid data... 01-Dec-2016 13:50:02.2: Dispatcher stopped at 01-Dec-2016 13:50:02 UTC 01-Dec-2016 13:50:02.2: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 02-Dec-2016 01:06:15.8: Dispatcher started at 02-Dec-2016 01:06:15 UTC 02-Dec-2016 01:06:15.8: Priority: W[0]=0.00 02-Dec-2016 01:06:15.8: Transit Altitude: W[1]=0.00 02-Dec-2016 01:06:15.8: Highest Altitude: W[6]=0.00 02-Dec-2016 01:06:15.8: Lateness: W[5]=0.70 02-Dec-2016 01:06:15.8: Slew Distance: W[2]=0.30 02-Dec-2016 01:06:15.8: Retry Count: W[3]=0.20 02-Dec-2016 01:06:15.8: Meridian Crossing: W[4]=0.30 02-Dec-2016 01:06:15.8: Obs Conditions: W[7]=0.40 02-Dec-2016 01:06:15.8: Rising Plan Delay: disabled 02-Dec-2016 01:06:16.1: Run statistics: 02-Dec-2016 01:06:16.1: Observations: 22 02-Dec-2016 01:06:16.1: Considered: 19 02-Dec-2016 01:06:16.1: Completed: 10 02-Dec-2016 01:06:16.1: Skipped: 4 02-Dec-2016 01:06:16.1: Never Eligible: 3 02-Dec-2016 01:06:16.1: Failed: 5 Log closed at Fri, Dec 02 2016 01:06:16 UTC (actual time)