Log opened at Wed, Oct 09 2013 02:23:47 UTC (actual time) Current log level is Verbose Scheduler version 3.5.3 Multi-user license: Arne Henden 09-Oct-2013 02:23:47.1: Simulated clock initialized at 09-Oct-2013 02:23:47 UTC 09-Oct-2013 02:23:47.9: Loaded Constraint plugin AirMass 09-Oct-2013 02:23:47.9: Loaded Constraint plugin AirmassRange 09-Oct-2013 02:23:47.9: Loaded Constraint plugin Horizon 09-Oct-2013 02:23:47.9: Loaded Constraint plugin HourAngle 09-Oct-2013 02:23:47.9: Loaded Constraint plugin MoonAvoid 09-Oct-2013 02:23:47.9: Loaded Constraint plugin MoonDown 09-Oct-2013 02:23:48.0: Loaded Constraint plugin SkyCondition 09-Oct-2013 02:23:48.0: Loaded Constraint plugin TimeRange 09-Oct-2013 02:23:48.6: 83 plans are now pending. 09-Oct-2013 02:23:48.6: Attach ACP sequencer 09-Oct-2013 02:23:54.8: Weather successfully connected. Wait for valid data... 09-Oct-2013 02:24:03.6: Dispatcher started at 09-Oct-2013 02:24:03 UTC 09-Oct-2013 02:24:03.6: Priority: W[0]=1.00 09-Oct-2013 02:24:03.6: Transit Altitude: W[1]=0.00 09-Oct-2013 02:24:03.6: Highest Altitude: W[6]=0.00 09-Oct-2013 02:24:03.6: Lateness: W[5]=0.70 09-Oct-2013 02:24:03.6: Slew Distance: W[2]=0.30 09-Oct-2013 02:24:03.6: Retry Count: W[3]=0.20 09-Oct-2013 02:24:03.6: Meridian Crossing: W[4]=0.30 09-Oct-2013 02:24:03.6: Obs Conditions: W[7]=0.40 09-Oct-2013 02:24:03.6: Rising Plan Delay: disabled 09-Oct-2013 02:24:04.0: ++ Observatory Startup ++ 09-Oct-2013 02:24:04.0: Start ACP Sequencer's StartupObs script 09-Oct-2013 02:24:26.2: Open the observatory dome/roof 09-Oct-2013 02:25:17.1: ++ Auto Focus ++ 09-Oct-2013 02:25:17.1: Doing initial autofocus. 09-Oct-2013 02:25:17.1: Start special ACP AutoFocus script for scheduler 09-Oct-2013 02:28:39.2: Next periodic autofocus ASAP after 09-Oct-2013 04:28:22 UTC 09-Oct-2013 02:28:40.6: Plan KIC6761539 has Monitor Mode. Time to resubmit it. 09-Oct-2013 02:28:41.3: Dispatcher cycle time: 2.1684038 sec. 09-Oct-2013 02:28:41.3: Acquire data for Observation KIC6761539... 09-Oct-2013 02:28:41.3: (belongs to Project Delta Scuti, Plan KIC6761539) 09-Oct-2013 02:28:41.3: Doing 60 sets 09-Oct-2013 02:28:41.3: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 02:37:18.9: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 02:45:15.8: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 02:53:01.6: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 03:00:50.7: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 03:08:35.5: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 03:16:17.7: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 03:24:00.4: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 03:39:29.3: Send Observation KIC6761539 to ACP Sequencer 09-Oct-2013 03:40:58.9: Dispatcher stopped at 09-Oct-2013 03:40:58 UTC 09-Oct-2013 03:40:58.9: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 09-Oct-2013 03:41:11.5: RUN FAILED: Scheduler was stopped during run 09-Oct-2013 03:41:11.5: ACP data acquisition failed for Observation KIC6761539. 09-Oct-2013 03:41:11.5: (Observation KIC6761539 interrupted by operator or system.) 09-Oct-2013 03:43:39.3: Dispatcher started at 09-Oct-2013 03:43:39 UTC 09-Oct-2013 03:43:39.3: Priority: W[0]=1.00 09-Oct-2013 03:43:39.3: Transit Altitude: W[1]=0.00 09-Oct-2013 03:43:39.3: Highest Altitude: W[6]=0.00 09-Oct-2013 03:43:39.3: Lateness: W[5]=0.70 09-Oct-2013 03:43:39.3: Slew Distance: W[2]=0.30 09-Oct-2013 03:43:39.3: Retry Count: W[3]=0.20 09-Oct-2013 03:43:39.3: Meridian Crossing: W[4]=0.30 09-Oct-2013 03:43:39.3: Obs Conditions: W[7]=0.40 09-Oct-2013 03:43:39.3: Rising Plan Delay: disabled 09-Oct-2013 03:43:40.4: ++ Observatory Startup ++ 09-Oct-2013 03:43:40.4: Start ACP Sequencer's StartupObs script 09-Oct-2013 03:43:56.0: ++ Auto Focus ++ 09-Oct-2013 03:43:56.0: Doing initial autofocus. 09-Oct-2013 03:43:56.0: Start special ACP AutoFocus script for scheduler 09-Oct-2013 03:44:45.0: ** Sequencer script "AutoFocusScheduler" failed: 09-Oct-2013 03:44:45.0: **Script Error (Tracking has been stopped)** Source: Microsoft VBScript runtime error Message: ActiveX component can't create object: 'FocusMax.FocusControl' at line 72 column 2. Script Context: 69: Call SUP.WaitForSlew() 70: End If 71: => 72: If Not SUP.AutoFocus(CT.RightAscension, CT.Declination) Then ^ 73: Console.PrintLine "***AutoFocus failed." 74: End If 75: -- end -- 09-Oct-2013 03:44:45.0: ** Autofocus failed (n=1), will retry ASAP after 0 min. 09-Oct-2013 03:44:45.3: Dispatcher cycle time: 0.2964005 sec. 09-Oct-2013 03:44:45.3: Acquire data for Observation SA112_810... 09-Oct-2013 03:44:45.3: (belongs to Project Landolt_1, Plan SA112_810) 09-Oct-2013 03:44:45.3: Send Observation SA112_810 to ACP Sequencer 09-Oct-2013 03:45:55.8: Dispatcher stopped at 09-Oct-2013 03:45:55 UTC 09-Oct-2013 03:45:55.8: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 09-Oct-2013 03:46:05.1: RUN FAILED: Scheduler was stopped during run 09-Oct-2013 03:46:05.1: ACP data acquisition failed for Observation SA112_810. 09-Oct-2013 03:46:05.1: (Observation SA112_810 interrupted by operator or system.) 09-Oct-2013 03:52:37.1: **EXCEPTION IN SCHEDULER: 09-Oct-2013 03:52:37.1: ConnectWeather() waited for over 5 seconds to read Weather.Available! 09-Oct-2013 03:52:37.1: Traceback: at DC3.Scheduler.ACPSequencer.ConnectWeather() at DC3.Scheduler.Engine.PollWeather() at DC3.Scheduler.Engine.Run() 09-Oct-2013 03:52:37.2: Run statistics: 09-Oct-2013 03:52:37.2: Observations: 110 09-Oct-2013 03:52:37.2: Considered: 26 09-Oct-2013 03:52:37.2: Completed: 0 09-Oct-2013 03:52:37.2: Skipped: 23 09-Oct-2013 03:52:37.2: Never Eligible: 84 09-Oct-2013 03:52:37.2: Failed: 3 09-Oct-2013 03:52:37.2: Shutter-Open efficiency: 37.90% 09-Oct-2013 03:52:37.2: Overall Efficiency: 99.90% 09-Oct-2013 03:52:37.2: Release ACP sequencer 09-Oct-2013 03:52:37.2: Failed to stop sequencer: 09-Oct-2013 03:52:37.2: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA) Log closed at Wed, Oct 09 2013 03:52:38 UTC (actual time)