Log opened at Sat, May 03 2014 02:05:34 UTC (actual time) Current log level is Verbose Scheduler version 3.5.3 Multi-user license: Arne Henden 03-May-2014 02:05:34.4: Simulated clock initialized at 03-May-2014 02:05:34 UTC 03-May-2014 02:05:34.6: Loaded Constraint plugin AirMass 03-May-2014 02:05:34.6: Loaded Constraint plugin AirmassRange 03-May-2014 02:05:34.6: Loaded Constraint plugin Horizon 03-May-2014 02:05:34.6: Loaded Constraint plugin HourAngle 03-May-2014 02:05:34.6: Loaded Constraint plugin MoonAvoid 03-May-2014 02:05:34.7: Loaded Constraint plugin MoonDown 03-May-2014 02:05:34.7: Loaded Constraint plugin SkyCondition 03-May-2014 02:05:34.7: Loaded Constraint plugin TimeRange 03-May-2014 02:05:35.3: 123 plans are now pending. 03-May-2014 02:05:35.3: Attach ACP sequencer 03-May-2014 02:05:57.3: Weather successfully connected. Wait for valid data... 03-May-2014 02:31:40.3: Dispatcher started at 03-May-2014 02:31:40 UTC 03-May-2014 02:31:40.3: Priority: W[0]=1.00 03-May-2014 02:31:40.3: Transit Altitude: W[1]=0.70 03-May-2014 02:31:40.3: Highest Altitude: W[6]=0.00 03-May-2014 02:31:40.3: Lateness: W[5]=0.00 03-May-2014 02:31:40.3: Slew Distance: W[2]=0.30 03-May-2014 02:31:40.3: Retry Count: W[3]=0.20 03-May-2014 02:31:40.3: Meridian Crossing: W[4]=0.30 03-May-2014 02:31:40.3: Obs Conditions: W[7]=0.40 03-May-2014 02:31:40.3: Rising Plan Delay: disabled 03-May-2014 02:31:42.1: ++ Observatory Startup ++ 03-May-2014 02:31:42.1: Start ACP Sequencer's StartupObs script 03-May-2014 02:32:09.8: Open the observatory dome/roof 03-May-2014 02:46:14.3: ++ Auto Focus ++ 03-May-2014 02:46:14.4: Doing initial autofocus. 03-May-2014 02:46:14.4: Start special ACP AutoFocus script for scheduler 03-May-2014 02:49:49.9: Next periodic autofocus ASAP after 03-May-2014 04:49:19 UTC 03-May-2014 02:49:54.0: Plan SA61 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA61 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA84 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA84 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA106 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA103 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan MP_Gem has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan V849_Her has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan RZ_Leo has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SDSS073224 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA52_56 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA100_267 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA99_438 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA124_970 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA52_56 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SA100_267 has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SN_2014G has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan SN_2014J has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan RR_Vir has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan S_Lyn has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan ST_Lyr has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan T_CMi has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan WZ_Lyr has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:54.0: Plan X_Dra has Monitor Mode. Time to resubmit it. 03-May-2014 02:49:55.1: Dispatcher cycle time: 3.2916058 sec. 03-May-2014 02:49:55.1: Acquire data for Observation SN_2014J... 03-May-2014 02:49:55.1: (belongs to Project AAVSO_Monitoring, Plan SN_2014J) 03-May-2014 02:49:55.1: Doing 3 sets 03-May-2014 02:49:55.1: Send Observation SN_2014J to ACP Sequencer 03-May-2014 02:55:37.5: Send Observation SN_2014J to ACP Sequencer 03-May-2014 03:00:21.1: Send Observation SN_2014J to ACP Sequencer 03-May-2014 03:05:00.0: Acquisition time: 904.8639894 sec. 03-May-2014 03:05:00.0: Data for Observation SN_2014J acquired successfully. 03-May-2014 03:05:00.0: Image Efficiency: 49.5% 03-May-2014 03:05:00.0: Cycle Efficiency: 99.6% 03-May-2014 03:05:03.1: Dispatcher cycle time: 0.4368008 sec. 03-May-2014 03:05:03.1: Acquire data for Observation SDSS073224... 03-May-2014 03:05:03.1: (belongs to Project AGN, Plan SDSS073224) 03-May-2014 03:05:03.1: Send Observation SDSS073224 to ACP Sequencer 03-May-2014 03:53:12.6: Acquisition time: 2889.5462752 sec. 03-May-2014 03:53:12.6: Data for Observation SDSS073224 acquired successfully. 03-May-2014 03:53:12.7: Image Efficiency: 83.0% 03-May-2014 03:53:12.7: Cycle Efficiency: 100.0% 03-May-2014 03:53:19.0: Dispatcher cycle time: 0.2808005 sec. 03-May-2014 03:53:19.0: Acquire data for Observation SN_2014G... 03-May-2014 03:53:19.0: (belongs to Project AAVSO_Monitoring, Plan SN_2014G) 03-May-2014 03:53:19.0: Send Observation SN_2014G to ACP Sequencer 03-May-2014 04:03:32.2: Acquisition time: 613.174677 sec. 03-May-2014 04:03:32.2: Data for Observation SN_2014G acquired successfully. 03-May-2014 04:03:32.2: Image Efficiency: 68.5% 03-May-2014 04:03:32.2: Cycle Efficiency: 100.0% 03-May-2014 04:03:42.3: Dispatcher cycle time: 0.6396012 sec. 03-May-2014 04:03:42.3: Acquire data for Observation RZ_Leo... 03-May-2014 04:03:42.3: (belongs to Project Walker, Plan RZ_Leo) 03-May-2014 04:03:42.3: Send Observation RZ_Leo to ACP Sequencer 03-May-2014 04:48:37.1: Acquisition time: 2694.8111331 sec. 03-May-2014 04:48:37.1: Data for Observation RZ_Leo acquired successfully. 03-May-2014 04:48:37.1: Image Efficiency: 74.2% 03-May-2014 04:48:37.1: Cycle Efficiency: 100.0% 03-May-2014 04:48:45.2: Dispatcher cycle time: 0.3120005 sec. 03-May-2014 04:48:45.2: Acquire data for Observation SA103... 03-May-2014 04:48:45.3: (belongs to Project Landolt_1, Plan SA103) 03-May-2014 04:48:45.3: Send Observation SA103 to ACP Sequencer 03-May-2014 04:53:55.4: Acquisition time: 310.0973446 sec. 03-May-2014 04:53:55.4: Data for Observation SA103 acquired successfully. 03-May-2014 04:53:55.4: Image Efficiency: 41.9% 03-May-2014 04:53:55.4: Cycle Efficiency: 99.9% 03-May-2014 04:53:55.8: ++ Auto Focus ++ 03-May-2014 04:53:55.8: Doing periodic autofocus. 03-May-2014 04:53:55.8: Start special ACP AutoFocus script for scheduler 03-May-2014 04:57:43.5: Next periodic autofocus ASAP after 03-May-2014 06:56:37 UTC 03-May-2014 04:57:44.4: Dispatcher cycle time: 0.2964005 sec. 03-May-2014 04:57:44.4: Acquire data for Observation NGC_4147... 03-May-2014 04:57:44.4: (belongs to Project Welch_gc, Plan NGC_4147) 03-May-2014 04:57:44.4: Send Observation NGC_4147 to ACP Sequencer 03-May-2014 05:22:20.7: Acquisition time: 1476.2149928 sec. 03-May-2014 05:22:20.7: Data for Observation NGC_4147 acquired successfully. 03-May-2014 05:22:20.7: Image Efficiency: 81.3% 03-May-2014 05:22:20.7: Cycle Efficiency: 100.0% 03-May-2014 05:22:29.4: Dispatcher cycle time: 0.6552011 sec. 03-May-2014 05:22:29.4: Acquire data for Observation Pal_4... 03-May-2014 05:22:29.4: (belongs to Project Welch_gc, Plan Pal_4) 03-May-2014 05:22:29.4: Send Observation Pal_4 to ACP Sequencer 03-May-2014 06:02:20.7: Acquisition time: 2391.2970001 sec. 03-May-2014 06:02:20.7: Data for Observation Pal_4 acquired successfully. 03-May-2014 06:02:20.7: Image Efficiency: 83.6% 03-May-2014 06:02:20.7: Cycle Efficiency: 100.0% 03-May-2014 06:02:28.1: Dispatcher cycle time: 0.2964005 sec. 03-May-2014 06:02:28.1: Acquire data for Observation NGC_5053... 03-May-2014 06:02:28.1: (belongs to Project Welch_gc, Plan NGC_5053) 03-May-2014 06:02:28.1: Send Observation NGC_5053 to ACP Sequencer 03-May-2014 06:26:58.7: Acquisition time: 1470.5209829 sec. 03-May-2014 06:26:58.7: Data for Observation NGC_5053 acquired successfully. 03-May-2014 06:26:58.7: Image Efficiency: 81.6% 03-May-2014 06:26:58.7: Cycle Efficiency: 100.0% 03-May-2014 06:27:03.2: Dispatcher cycle time: 0.7176013 sec. 03-May-2014 06:27:03.2: Acquire data for Observation NGC_5272... 03-May-2014 06:27:03.2: (belongs to Project Welch_gc, Plan NGC_5272) 03-May-2014 06:27:03.2: Send Observation NGC_5272 to ACP Sequencer 03-May-2014 06:45:54.6: Acquisition time: 1131.3607871 sec. 03-May-2014 06:45:54.6: Data for Observation NGC_5272 acquired successfully. 03-May-2014 06:45:54.6: Image Efficiency: 79.5% 03-May-2014 06:45:54.6: Cycle Efficiency: 99.9% 03-May-2014 06:46:01.1: Dispatcher cycle time: 0.4056008 sec. 03-May-2014 06:46:01.1: Acquire data for Observation RR_Vir... 03-May-2014 06:46:01.1: (belongs to Project Mogul_Mira, Plan RR_Vir) 03-May-2014 06:46:01.1: Send Observation RR_Vir to ACP Sequencer 03-May-2014 07:05:34.9: Acquisition time: 1173.8084616 sec. 03-May-2014 07:05:34.9: Data for Observation RR_Vir acquired successfully. 03-May-2014 07:05:34.9: Image Efficiency: 59.6% 03-May-2014 07:05:34.9: Cycle Efficiency: 100.0% 03-May-2014 07:05:35.3: ++ Auto Focus ++ 03-May-2014 07:05:35.3: Doing periodic autofocus. 03-May-2014 07:05:35.3: Start special ACP AutoFocus script for scheduler 03-May-2014 07:07:55.8: Next periodic autofocus ASAP after 03-May-2014 09:07:38 UTC 03-May-2014 07:07:57.9: Dispatcher cycle time: 0.3588007 sec. 03-May-2014 07:07:57.9: Acquire data for Observation M56... 03-May-2014 07:07:57.9: (belongs to Project AAVSO_Monitoring, Plan M56) 03-May-2014 07:07:57.9: Doing 3 sets 03-May-2014 07:07:57.9: Send Observation M56 to ACP Sequencer 03-May-2014 07:14:38.5: Send Observation M56 to ACP Sequencer 03-May-2014 07:19:49.4: Send Observation M56 to ACP Sequencer 03-May-2014 07:24:56.5: Acquisition time: 1018.572589 sec. 03-May-2014 07:24:56.5: Data for Observation M56 acquired successfully. 03-May-2014 07:24:56.6: Image Efficiency: 70.7% 03-May-2014 07:24:56.6: Cycle Efficiency: 100.0% 03-May-2014 07:25:03.6: Dispatcher cycle time: 0.4056007 sec. 03-May-2014 07:25:03.6: Acquire data for Observation PNV_J1902... 03-May-2014 07:25:03.6: (belongs to Project AAVSO_Monitoring, Plan PNV_J1902) 03-May-2014 07:25:03.6: Send Observation PNV_J1902 to ACP Sequencer 03-May-2014 07:58:40.5: Acquisition time: 2016.8651424 sec. 03-May-2014 07:58:40.5: Data for Observation PNV_J1902 acquired successfully. 03-May-2014 07:58:40.5: Image Efficiency: 69.4% 03-May-2014 07:58:40.5: Cycle Efficiency: 100.0% 03-May-2014 07:58:50.0: Dispatcher cycle time: 0.9048016 sec. 03-May-2014 07:58:50.0: Acquire data for Observation SA84... 03-May-2014 07:58:50.0: (belongs to Project Landolt_1, Plan SA84) 03-May-2014 07:58:50.0: Send Observation SA84 to ACP Sequencer 03-May-2014 08:04:11.5: Acquisition time: 321.4229646 sec. 03-May-2014 08:04:11.5: Data for Observation SA84 acquired successfully. 03-May-2014 08:04:11.5: Image Efficiency: 40.3% 03-May-2014 08:04:11.5: Cycle Efficiency: 99.7% 03-May-2014 08:04:19.3: Dispatcher cycle time: 0.8892016 sec. 03-May-2014 08:04:19.3: Acquire data for Observation V339_Del_TMO61... 03-May-2014 08:04:19.3: (belongs to Project AAVSO_Monitoring, Plan V339_Del_TMO61) 03-May-2014 08:04:19.3: Doing 400 sets 03-May-2014 08:04:19.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:09:14.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:12:51.0: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:16:23.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:20:00.8: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:23:31.0: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:27:07.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:30:38.4: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:34:07.7: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:37:45.5: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:41:17.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:44:54.0: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:48:28.4: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:52:08.9: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:55:45.2: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 08:59:16.6: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:02:53.0: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:06:26.7: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:09:55.0: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:13:29.0: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:17:01.0: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:20:34.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:24:12.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:27:47.6: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:33:11.1: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:36:42.4: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:40:17.5: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:43:59.1: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:47:34.9: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:51:08.9: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:54:43.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 09:58:16.7: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:01:55.9: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:05:29.8: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:09:05.6: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:12:40.8: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:16:13.5: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:19:49.0: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:23:24.9: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:26:58.4: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:30:36.6: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:34:08.2: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:37:41.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:41:13.2: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:44:51.3: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:48:26.5: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:52:01.5: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:55:36.2: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 10:59:10.1: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 11:02:41.9: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 11:06:21.8: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 11:09:53.2: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 11:13:29.1: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 11:17:01.9: Send Observation V339_Del_TMO61 to ACP Sequencer 03-May-2014 11:20:39.0: ***Running Plan V339_Del_TMO61 (best efforts) completed early: 03-May-2014 11:20:39.0: Obs V339_Del_TMO61 would extend past dawn 03-May-2014 11:20:39.0: Acquisition time: 11778.8630889 sec. 03-May-2014 11:20:39.0: Data for Observation V339_Del_TMO61 acquired successfully. 03-May-2014 11:20:39.1: Image Efficiency: 41.3% 03-May-2014 11:20:39.1: Cycle Efficiency: 100.0% 03-May-2014 11:20:44.1: ++ Auto Focus ++ 03-May-2014 11:20:44.1: Doing periodic autofocus. 03-May-2014 11:20:44.1: Start special ACP AutoFocus script for scheduler 03-May-2014 11:24:09.9: Next periodic autofocus ASAP after 03-May-2014 13:23:44 UTC 03-May-2014 11:24:46.1: ++ Dawn Flats ++ 03-May-2014 11:24:46.1: Start ACP AutoFlat script for Dawn 03-May-2014 12:13:32.6: -- Observatory Shutdown -- 03-May-2014 12:13:32.6: Weather disconnected. 03-May-2014 12:13:32.6: Start ACP Sequencer's ShutdownObs script 03-May-2014 12:13:47.7: **EXCEPTION IN SCHEDULER: 03-May-2014 12:13:47.7: 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)) 03-May-2014 12:13:47.8: 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() 03-May-2014 12:13:47.9: Run statistics: 03-May-2014 12:13:47.9: Observations: 173 03-May-2014 12:13:47.9: Considered: 84 03-May-2014 12:13:47.9: Completed: 14 03-May-2014 12:13:47.9: Skipped: 66 03-May-2014 12:13:47.9: Never Eligible: 89 03-May-2014 12:13:47.9: Failed: 4 03-May-2014 12:13:47.9: Shutter-Open efficiency: 61.22% 03-May-2014 12:13:47.9: Overall Efficiency: 99.90% 03-May-2014 12:13:47.9: Release ACP sequencer 03-May-2014 12:13:47.9: Failed to stop sequencer: 03-May-2014 12:13:47.9: 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)) Log closed at Sat, May 03 2014 12:13:49 UTC (actual time)