Log opened at Wed, Dec 14 2016 23:12:56 UTC (actual time) Current log level is Verbose Scheduler version 3.5.3 Multi-user license: Arne Henden 14-Dec-2016 23:12:56.1: Simulated clock initialized at 14-Dec-2016 23:12:56 UTC 14-Dec-2016 23:12:56.1: Loaded Constraint plugin AirMass 14-Dec-2016 23:12:56.1: Loaded Constraint plugin AirmassRange 14-Dec-2016 23:12:56.1: Loaded Constraint plugin Horizon 14-Dec-2016 23:12:56.1: Loaded Constraint plugin HourAngle 14-Dec-2016 23:12:56.1: Loaded Constraint plugin MoonAvoid 14-Dec-2016 23:12:56.1: Loaded Constraint plugin MoonDown 14-Dec-2016 23:12:56.1: Loaded Constraint plugin SkyCondition 14-Dec-2016 23:12:56.1: Loaded Constraint plugin TimeRange 14-Dec-2016 23:12:56.7: 20 plans are now pending. 14-Dec-2016 23:12:56.7: Attach ACP sequencer 14-Dec-2016 23:13:18.1: Weather successfully connected. Wait for valid data... 15-Dec-2016 00:51:35.6: Dispatcher started at 15-Dec-2016 00:51:35 UTC 15-Dec-2016 00:51:35.6: Priority: W[0]=0.00 15-Dec-2016 00:51:35.6: Transit Altitude: W[1]=0.00 15-Dec-2016 00:51:35.6: Highest Altitude: W[6]=0.00 15-Dec-2016 00:51:35.6: Lateness: W[5]=0.70 15-Dec-2016 00:51:35.6: Slew Distance: W[2]=0.30 15-Dec-2016 00:51:35.6: Retry Count: W[3]=0.20 15-Dec-2016 00:51:35.6: Meridian Crossing: W[4]=0.30 15-Dec-2016 00:51:35.6: Obs Conditions: W[7]=0.40 15-Dec-2016 00:51:35.6: Rising Plan Delay: disabled 15-Dec-2016 00:51:36.7: ++ Observatory Startup ++ 15-Dec-2016 00:51:36.7: Start ACP Sequencer's StartupObs script 15-Dec-2016 00:51:57.8: Open the observatory dome/roof 15-Dec-2016 01:01:26.8: ++ Auto Focus ++ 15-Dec-2016 01:01:26.8: Doing initial autofocus. 15-Dec-2016 01:01:26.8: Start special ACP AutoFocus script for scheduler 15-Dec-2016 01:04:31.6: Next periodic autofocus ASAP after 15-Dec-2016 03:04:18 UTC 15-Dec-2016 01:04:33.3: Plan V0809_Cep has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.3: Plan V0959_Mon has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.3: Plan MP_Gem has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.3: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.3: Plan CB_32 has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.3: Plan V1404_Cyg has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.3: Plan M67 has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.3: Plan QQ_Vul has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.4: Plan FO_Aqr has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.4: Plan BX_Pup has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.4: Plan M56 has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.4: Plan NGC_7790 has Monitor Mode. Time to resubmit it. 15-Dec-2016 01:04:33.7: Dispatcher cycle time: 1.0900016 sec. 15-Dec-2016 01:04:33.7: Acquire data for Observation BY Cam... 15-Dec-2016 01:04:33.7: (belongs to Project Walker, Plan BY_Cam) 15-Dec-2016 01:04:33.7: Doing 200 sets 15-Dec-2016 01:04:33.8: Send Observation BY Cam to ACP Sequencer 15-Dec-2016 09:34:51.2: ***Running Plan BY_Cam (best efforts) completed early: 15-Dec-2016 09:34:51.2: Obs BY Cam would would not meet constraints 15-Dec-2016 09:34:51.2: ***Running Plan BY_Cam (best efforts) completed early: 15-Dec-2016 09:34:51.2: Obs BY Cam would extend past dawn 15-Dec-2016 09:34:51.2: Acquisition time: 30617.456028 sec. 15-Dec-2016 09:34:51.2: Data for Observation BY Cam acquired successfully. 15-Dec-2016 09:34:51.3: Image Efficiency: 78.4% 15-Dec-2016 09:34:51.3: Cycle Efficiency: 100.0% 15-Dec-2016 09:34:53.0: ++ Auto Focus ++ 15-Dec-2016 09:34:53.0: Doing periodic autofocus. 15-Dec-2016 09:34:53.0: Start special ACP AutoFocus script for scheduler 15-Dec-2016 09:37:53.2: Next periodic autofocus ASAP after 15-Dec-2016 11:37:29 UTC 15-Dec-2016 09:37:54.0: Dispatcher cycle time: 0.690001 sec. 15-Dec-2016 09:37:54.0: Acquire data for Observation V647_Aur... 15-Dec-2016 09:37:54.0: (belongs to Project NMSU, Plan V647_Aur) 15-Dec-2016 09:37:54.0: Doing 300 sets 15-Dec-2016 09:37:54.0: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:40:50.4: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:43:08.2: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:45:25.1: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:47:42.1: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:49:57.4: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:52:14.8: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:54:31.0: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:56:48.9: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 09:59:07.4: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:01:25.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:03:43.8: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:05:59.5: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:08:14.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:10:34.6: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:12:49.7: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:15:05.7: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:17:20.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:19:36.8: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:21:52.1: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:24:09.7: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:26:32.5: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:28:47.5: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:31:07.2: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:33:22.9: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:35:38.9: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:37:57.4: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:40:14.1: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:42:34.9: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:44:50.4: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:47:08.6: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:49:25.4: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:51:40.6: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:53:55.7: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:56:14.8: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 10:58:32.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:00:49.9: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:03:04.1: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:05:20.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:07:37.7: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:09:57.7: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:12:14.7: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:14:32.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:16:49.8: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:19:08.7: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:21:23.6: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:23:38.2: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:25:55.1: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:28:10.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:30:28.2: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:32:49.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:35:07.2: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:37:23.5: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:39:41.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:42:00.9: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:44:18.5: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:46:32.2: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:48:50.4: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:51:11.0: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:53:28.2: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:55:46.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 11:58:06.5: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 12:00:26.0: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 12:02:42.6: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 12:04:59.3: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 12:07:18.0: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 12:09:37.2: Send Observation V647_Aur to ACP Sequencer 15-Dec-2016 12:11:54.3: ***Running Plan V647_Aur (best efforts) completed early: 15-Dec-2016 12:11:54.3: Obs V647_Aur would would not meet constraints 15-Dec-2016 12:11:54.3: Acquisition time: 9239.5109361 sec. 15-Dec-2016 12:11:54.3: Data for Observation V647_Aur acquired successfully. 15-Dec-2016 12:11:54.3: Image Efficiency: 72.5% 15-Dec-2016 12:11:54.3: Cycle Efficiency: 100.0% 15-Dec-2016 12:11:54.4: ++ Auto Focus ++ 15-Dec-2016 12:11:54.4: Doing periodic autofocus. 15-Dec-2016 12:11:54.4: Start special ACP AutoFocus script for scheduler 15-Dec-2016 12:15:21.2: Next periodic autofocus ASAP after 15-Dec-2016 14:14:40 UTC 15-Dec-2016 12:15:23.5: Dispatcher cycle time: 0.5200007 sec. 15-Dec-2016 12:15:23.5: Acquire data for Observation Swift_J0614.0+1709... 15-Dec-2016 12:15:23.5: (belongs to Project NMSU, Plan Swift_J0614.0+1709) 15-Dec-2016 12:15:23.5: Doing 300 sets 15-Dec-2016 12:15:23.5: Send Observation Swift_J0614.0+1709 to ACP Sequencer 15-Dec-2016 12:18:49.8: Send Observation Swift_J0614.0+1709 to ACP Sequencer 15-Dec-2016 12:21:10.3: Send Observation Swift_J0614.0+1709 to ACP Sequencer 15-Dec-2016 12:23:28.9: Send Observation Swift_J0614.0+1709 to ACP Sequencer 15-Dec-2016 12:25:49.3: Send Observation Swift_J0614.0+1709 to ACP Sequencer 15-Dec-2016 12:28:08.1: Send Observation Swift_J0614.0+1709 to ACP Sequencer 15-Dec-2016 12:30:25.4: Send Observation Swift_J0614.0+1709 to ACP Sequencer 15-Dec-2016 12:32:46.8: ***Running Plan Swift_J0614.0+1709 (best efforts) completed early: 15-Dec-2016 12:32:46.8: Obs Swift_J0614.0+1709 would would not meet constraints 15-Dec-2016 12:32:46.8: Acquisition time: 1043.2524606 sec. 15-Dec-2016 12:32:46.8: Data for Observation Swift_J0614.0+1709 acquired successfully. 15-Dec-2016 12:32:46.8: Image Efficiency: 67.1% 15-Dec-2016 12:32:46.8: Cycle Efficiency: 99.9% 15-Dec-2016 12:32:47.9: Dispatcher cycle time: 0.1100001 sec. 15-Dec-2016 12:32:47.9: Acquire data for Observation M67... 15-Dec-2016 12:32:47.9: (belongs to Project AAVSO_Monitoring, Plan M67) 15-Dec-2016 12:32:47.9: Send Observation M67 to ACP Sequencer 15-Dec-2016 13:02:29.2: ACP data acquisition failed for Observation M67. 15-Dec-2016 13:02:29.2: (Observation M67 interrupted by acquisition process failure.) 15-Dec-2016 13:03:30.8: ++ Dawn Flats ++ 15-Dec-2016 13:03:30.8: Start ACP AutoFlat script for Dawn 15-Dec-2016 13:49:32.4: -- Observatory Shutdown -- 15-Dec-2016 13:49:32.5: Weather disconnected. 15-Dec-2016 13:49:32.5: Start ACP Sequencer's ShutdownObs script 15-Dec-2016 15:05:10.9: **EXCEPTION IN SCHEDULER: 15-Dec-2016 15:05:10.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)) 15-Dec-2016 15:05:10.9: 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() 15-Dec-2016 15:05:11.0: Run statistics: 15-Dec-2016 15:05:11.0: Observations: 35 15-Dec-2016 15:05:11.0: Considered: 27 15-Dec-2016 15:05:11.0: Completed: 4 15-Dec-2016 15:05:11.0: Skipped: 20 15-Dec-2016 15:05:11.0: Never Eligible: 8 15-Dec-2016 15:05:11.0: Failed: 3 15-Dec-2016 15:05:11.0: Shutter-Open efficiency: 73.46% 15-Dec-2016 15:05:11.0: Overall Efficiency: 99.90% 15-Dec-2016 15:05:11.0: Release ACP sequencer 15-Dec-2016 15:05:11.0: Failed to stop sequencer: 15-Dec-2016 15:05:11.0: 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 Thu, Dec 15 2016 15:05:13 UTC (actual time)