Log opened at Wed, Oct 28 2015 01:14:06 UTC (actual time) Current log level is Verbose Scheduler version 3.5.3 Multi-user license: Arne Henden 28-Oct-2015 01:14:06.6: Simulated clock initialized at 28-Oct-2015 01:14:06 UTC 28-Oct-2015 01:14:06.6: Loaded Constraint plugin AirMass 28-Oct-2015 01:14:06.6: Loaded Constraint plugin AirmassRange 28-Oct-2015 01:14:06.6: Loaded Constraint plugin Horizon 28-Oct-2015 01:14:06.6: Loaded Constraint plugin HourAngle 28-Oct-2015 01:14:06.6: Loaded Constraint plugin MoonAvoid 28-Oct-2015 01:14:06.6: Loaded Constraint plugin MoonDown 28-Oct-2015 01:14:06.6: Loaded Constraint plugin SkyCondition 28-Oct-2015 01:14:06.6: Loaded Constraint plugin TimeRange 28-Oct-2015 01:14:07.2: 94 plans are now pending. 28-Oct-2015 01:14:07.2: Attach ACP sequencer 28-Oct-2015 01:14:15.9: Dispatcher started at 28-Oct-2015 01:14:15 UTC 28-Oct-2015 01:14:15.9: Priority: W[0]=1.00 28-Oct-2015 01:14:15.9: Transit Altitude: W[1]=0.70 28-Oct-2015 01:14:15.9: Highest Altitude: W[6]=0.00 28-Oct-2015 01:14:15.9: Lateness: W[5]=0.00 28-Oct-2015 01:14:15.9: Slew Distance: W[2]=0.30 28-Oct-2015 01:14:15.9: Retry Count: W[3]=0.20 28-Oct-2015 01:14:15.9: Meridian Crossing: W[4]=0.30 28-Oct-2015 01:14:15.9: Obs Conditions: W[7]=0.40 28-Oct-2015 01:14:15.9: Rising Plan Delay: disabled 28-Oct-2015 01:14:28.6: Weather successfully connected. Wait for valid data... 28-Oct-2015 01:14:29.6: ++ Observatory Startup ++ 28-Oct-2015 01:14:29.6: Start ACP Sequencer's StartupObs script 28-Oct-2015 01:15:15.9: Dispatcher stopped at 28-Oct-2015 01:15:15 UTC 28-Oct-2015 01:15:15.9: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 28-Oct-2015 01:15:55.0: Dispatcher started at 28-Oct-2015 01:15:55 UTC 28-Oct-2015 01:15:55.0: Priority: W[0]=1.00 28-Oct-2015 01:15:55.0: Transit Altitude: W[1]=0.70 28-Oct-2015 01:15:55.0: Highest Altitude: W[6]=0.00 28-Oct-2015 01:15:55.0: Lateness: W[5]=0.00 28-Oct-2015 01:15:55.0: Slew Distance: W[2]=0.30 28-Oct-2015 01:15:55.0: Retry Count: W[3]=0.20 28-Oct-2015 01:15:55.0: Meridian Crossing: W[4]=0.30 28-Oct-2015 01:15:55.0: Obs Conditions: W[7]=0.40 28-Oct-2015 01:15:55.0: Rising Plan Delay: disabled 28-Oct-2015 01:15:56.1: ++ Observatory Startup ++ 28-Oct-2015 01:15:56.1: Start ACP Sequencer's StartupObs script 28-Oct-2015 01:16:11.2: ++ Auto Focus ++ 28-Oct-2015 01:16:11.2: Doing initial autofocus. 28-Oct-2015 01:16:11.2: Start special ACP AutoFocus script for scheduler 28-Oct-2015 01:18:48.9: Next periodic autofocus ASAP after 28-Oct-2015 03:18:35 UTC 28-Oct-2015 01:18:50.3: Plan GSC_3649-0825 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.3: Plan 2MASS_23275353+5214532 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.3: Plan IC_348 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.3: Plan KH_15D has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.3: Plan V1184_Tau has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.3: Plan CB_32 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.3: Plan V1404_Cyg has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.3: Plan SA68_216 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan SA44_28 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan SA93_317 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan SA96_171 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan SA112_810 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan SA96_171 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan DG_Peg has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan LX_Cyg has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan S_Lyn has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan S_Ori has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan ST_Aur has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan SV_And has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan Z_Tau has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan NGC_7078 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan NGC_7089 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan Pal_13 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan NGC_7492 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan NGC_7790 has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan T_Ori has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:50.4: Plan U_Aqr has Monitor Mode. Time to resubmit it. 28-Oct-2015 01:18:51.8: Dispatcher cycle time: 2.8081606 sec. 28-Oct-2015 01:18:51.8: Acquire data for Observation SA1119... 28-Oct-2015 01:18:51.8: (belongs to Project Landolt_1, Plan SA1119) 28-Oct-2015 01:18:51.8: Send Observation SA1119 to ACP Sequencer 28-Oct-2015 01:19:21.1: Dispatcher stopped at 28-Oct-2015 01:19:21 UTC 28-Oct-2015 01:19:21.1: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 28-Oct-2015 01:19:26.3: ** Sequencer script "AcquireScheduler" failed: 28-Oct-2015 01:19:26.3: **Script Error** Source: ACP Message: The script was aborted. at line 951 column 17. Script Context: 948: If Not bPtgUpdDone Then ' If didn't get ptg upd from auto-flip 949: On Error Resume Next ' May fail on slew-back below horizon 950: isPointing = True ' For ACP web UI (typ.) => 951: bPtgUpdDone = SUP.UpdatePointing(OBS.Name, OBS.RA, OBS.Dec, OBS.PA) ' Uses Clear or filter specified for pointing updates ^ 952: If Err.Number <> 0 Then 953: bPtgUpdDone = False ' Hard error, probably horizon 954: Console.PrintLine "**Pointing update error from " & Err.Source & _ -- end -- 28-Oct-2015 01:19:29.5: RUN FAILED: Scheduler was stopped during run 28-Oct-2015 01:19:29.5: ACP data acquisition failed for Observation SA1119. 28-Oct-2015 01:19:29.5: (Observation SA1119 interrupted by operator or system.) 28-Oct-2015 01:46:39.5: Dispatcher started at 28-Oct-2015 01:46:39 UTC 28-Oct-2015 01:46:39.5: Priority: W[0]=1.00 28-Oct-2015 01:46:39.5: Transit Altitude: W[1]=0.70 28-Oct-2015 01:46:39.5: Highest Altitude: W[6]=0.00 28-Oct-2015 01:46:39.5: Lateness: W[5]=0.00 28-Oct-2015 01:46:39.5: Slew Distance: W[2]=0.30 28-Oct-2015 01:46:39.5: Retry Count: W[3]=0.20 28-Oct-2015 01:46:39.5: Meridian Crossing: W[4]=0.30 28-Oct-2015 01:46:39.5: Obs Conditions: W[7]=0.40 28-Oct-2015 01:46:39.5: Rising Plan Delay: disabled 28-Oct-2015 01:46:40.7: ++ Observatory Startup ++ 28-Oct-2015 01:46:40.7: Start ACP Sequencer's StartupObs script 28-Oct-2015 01:46:56.1: ++ Auto Focus ++ 28-Oct-2015 01:46:56.1: Doing initial autofocus. 28-Oct-2015 01:46:56.1: Start special ACP AutoFocus script for scheduler 28-Oct-2015 01:47:11.4: ** Sequencer script "AutoFocusScheduler" failed: 28-Oct-2015 01:47:11.4: **Script Error (Tracking has been stopped)** Source: ACP.AcquireSupport Message: Pointing/Focus Reference filter is invalid. Check ACP Imaging preferences at line 38 column 5. Script Context: 35: Dim Filt, dtStart, buf, CT 36: 37: Set SUP = CreateObject("ACP.AcquireSupport") => 38: SUP.Initialize ^ 39: 40: dtStart = Util.SysUTCDate 41: buf = "AutoFocus-" & Util.FormatVar(dtStart, "dd-mmm-yyyy@HhNnSs") & ".log" ' Typical Log Name -- end -- 28-Oct-2015 01:47:11.4: ** Autofocus failed (n=1), will retry ASAP after 0 min. 28-Oct-2015 01:47:12.3: Dispatcher cycle time: 0.7260416 sec. 28-Oct-2015 01:47:12.3: Acquire data for Observation V1404_Cyg... 28-Oct-2015 01:47:12.3: (belongs to Project Walker, Plan V1404_Cyg) 28-Oct-2015 01:47:12.4: Send Observation V1404_Cyg to ACP Sequencer 28-Oct-2015 01:47:17.3: Dispatcher stopped at 28-Oct-2015 01:47:17 UTC 28-Oct-2015 01:47:17.3: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 28-Oct-2015 01:47:27.6: ** Sequencer script "AcquireScheduler" failed: 28-Oct-2015 01:47:27.6: **Script Error (Tracking has been stopped)** Source: ACP.AcquireSupport Message: Pointing/Focus Reference filter is invalid. Check ACP Imaging preferences at line 792 column 5. Script Context: 789: ' Support library 790: ' 791: Set SUP = CreateObject("ACP.AcquireSupport") ' Support methods here => 792: Call SUP.Initialize() ' Do initialization (may log) ^ 793: 794: cdir = ACPApp.Path & "\Calibration" ' Cal library directory 795: -- end -- 28-Oct-2015 01:47:30.6: ACP ERROR: Run failed due to script error (see ACP run log) 28-Oct-2015 01:47:30.6: ACP data acquisition failed for Observation V1404_Cyg. 28-Oct-2015 01:47:30.6: (Observation V1404_Cyg interrupted by acquisition process failure.) 28-Oct-2015 01:47:31.4: Requested shutdown of scheduler 28-Oct-2015 01:47:31.7: Run statistics: 28-Oct-2015 01:47:31.7: Observations: 126 28-Oct-2015 01:47:31.7: Considered: 50 28-Oct-2015 01:47:31.7: Completed: 0 28-Oct-2015 01:47:31.7: Skipped: 46 28-Oct-2015 01:47:31.7: Never Eligible: 76 28-Oct-2015 01:47:31.7: Failed: 4 28-Oct-2015 01:47:31.7: Shutter-Open efficiency: 0.00% 28-Oct-2015 01:47:31.7: Overall Efficiency: 92.42% 28-Oct-2015 01:47:31.7: Release ACP sequencer Log closed at Wed, Oct 28 2015 01:47:33 UTC (actual time)