Log opened at Mon, Oct 02 2017 04:01:35 UTC (actual time) Current log level is Debug Scheduler version 3.5.3 Multi-user license: Arne Henden 02-Oct-2017 04:01:35.6: Simulated clock initialized at 02-Oct-2017 04:01:35 UTC 02-Oct-2017 04:01:35.6: Loaded Constraint plugin AirMass 02-Oct-2017 04:01:35.6: Loaded Constraint plugin AirmassRange 02-Oct-2017 04:01:35.6: Loaded Constraint plugin Horizon 02-Oct-2017 04:01:35.7: Loaded Constraint plugin HourAngle 02-Oct-2017 04:01:35.7: Loaded Constraint plugin MoonAvoid 02-Oct-2017 04:01:35.7: Loaded Constraint plugin MoonDown 02-Oct-2017 04:01:35.7: Loaded Constraint plugin SkyCondition 02-Oct-2017 04:01:35.7: Loaded Constraint plugin TimeRange 02-Oct-2017 04:01:36.2: 22 plans are now pending. 02-Oct-2017 04:01:36.2: Attach ACP sequencer 02-Oct-2017 04:01:42.6: Dispatcher started at 02-Oct-2017 04:01:42 UTC 02-Oct-2017 04:01:42.6: Priority: W[0]=0.00 02-Oct-2017 04:01:42.6: Transit Altitude: W[1]=0.70 02-Oct-2017 04:01:42.6: Highest Altitude: W[6]=0.00 02-Oct-2017 04:01:42.6: Lateness: W[5]=0.00 02-Oct-2017 04:01:42.6: Slew Distance: W[2]=0.00 02-Oct-2017 04:01:42.6: Retry Count: W[3]=0.20 02-Oct-2017 04:01:42.6: Meridian Crossing: W[4]=0.00 02-Oct-2017 04:01:42.6: Obs Conditions: W[7]=0.40 02-Oct-2017 04:01:42.6: Rising Plan Delay: disabled 02-Oct-2017 04:01:57.7: Weather successfully connected. Wait for valid data... 02-Oct-2017 04:01:58.9: ++ Observatory Startup ++ 02-Oct-2017 04:01:58.9: Start ACP Sequencer's StartupObs script 02-Oct-2017 04:02:08.9: Sequencer is now active 02-Oct-2017 04:02:13.9: Sequencer is no longer active 02-Oct-2017 04:02:14.2: ++ Auto Focus ++ 02-Oct-2017 04:02:14.2: Doing initial autofocus. 02-Oct-2017 04:02:14.2: Start special ACP AutoFocus script for scheduler 02-Oct-2017 04:02:24.3: Sequencer is now active 02-Oct-2017 04:02:29.3: Sequencer is no longer active 02-Oct-2017 04:02:29.3: ** Sequencer script "AutoFocusScheduler" failed: 02-Oct-2017 04:02:29.3: **Script Error (Tracking has been stopped)** Source: ACP.AcquireSupport Message: FilterInfo.txt has more offset entries than filters in the camera 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 -- 02-Oct-2017 04:02:29.3: ** Autofocus failed (n=1), will retry ASAP after 0 min. 02-Oct-2017 04:02:29.7: SelectRunning: No running plans 02-Oct-2017 04:02:29.7: Obs AL_Boo in Plan AL_Boo was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 15:36:12 UTC 02-Oct-2017 04:02:29.7: Obs CB_32 in Plan CB_32 was vetoed by AirMass constraint. 02-Oct-2017 04:02:29.7: AirMass estimates ready after 02-Oct-2017 08:24:02 UTC 02-Oct-2017 04:02:29.7: Obs CV_Vir in Plan CV_Vir was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 14:42:56 UTC 02-Oct-2017 04:02:29.7: Obs DN_Lyn in Plan DN_Lyn was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 08:35:48 UTC 02-Oct-2017 04:02:29.7: Obs FY_Cam in Plan FY_Cam was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 04:15:23 UTC 02-Oct-2017 04:02:29.7: Obs HI_Cam in Plan HI_Cam was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 05:11:19 UTC 02-Oct-2017 04:02:29.7: Obs HO_Cam in Plan HO_Cam was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 05:56:05 UTC 02-Oct-2017 04:02:29.7: Obs HQ_Aur in Plan HQ_Aur was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 06:27:11 UTC 02-Oct-2017 04:02:29.7: Obs HX_Aur in Plan HX_Aur was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 06:05:20 UTC 02-Oct-2017 04:02:29.7: Obs KK_UMa in Plan KK_UMa was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.7: AirmassRange estimates ready after 02-Oct-2017 12:16:03 UTC 02-Oct-2017 04:02:29.7: Obs M67 in Plan M67 was vetoed by AirMass constraint. 02-Oct-2017 04:02:29.7: AirMass estimates ready after 02-Oct-2017 11:33:52 UTC 02-Oct-2017 04:02:29.7: Obs MP_Gem in Plan MP_Gem was vetoed by AirMass constraint. 02-Oct-2017 04:02:29.7: AirMass estimates ready after 02-Oct-2017 08:44:59 UTC 02-Oct-2017 04:02:29.7: Obs omi_Cet in Plan omi_Cet was vetoed by AirMass constraint. 02-Oct-2017 04:02:29.7: AirMass estimates ready after 02-Oct-2017 04:43:04 UTC 02-Oct-2017 04:02:29.8: Obs SDSS073224 in Plan SDSS073224 was vetoed by AirMass constraint. 02-Oct-2017 04:02:29.8: AirMass estimates ready after 02-Oct-2017 09:13:51 UTC 02-Oct-2017 04:02:29.8: Obs SDSSJ121027+502735 in Plan SDSSJ121027+502735 was vetoed by AirMass constraint. 02-Oct-2017 04:02:29.8: AirMass estimates ready after 02-Oct-2017 13:08:41 UTC 02-Oct-2017 04:02:29.8: Obs T_Ori in Plan T_Ori was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.8: AirmassRange estimates ready after 02-Oct-2017 08:40:52 UTC 02-Oct-2017 04:02:29.8: Obs U_Aqr in Plan U_Aqr was vetoed by MoonAvoid constraint. 02-Oct-2017 04:02:29.8: MoonAvoid estimates ready after 02-Oct-2017 16:02:29 UTC 02-Oct-2017 04:02:29.8: Obs V0603_Per in Plan V0603_Per was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.8: AirmassRange estimates ready after 02-Oct-2017 04:46:05 UTC 02-Oct-2017 04:02:29.8: Obs V0959_Mon in Plan V0959_Mon was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.8: AirmassRange estimates ready after 02-Oct-2017 09:08:53 UTC 02-Oct-2017 04:02:29.8: Obs V0965_Per in Plan V0965_Per was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.8: AirmassRange estimates ready after 02-Oct-2017 04:34:32 UTC 02-Oct-2017 04:02:29.8: Obs V841_Oph in Plan V841_Oph was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.8: AirmassRange estimates ready after 02-Oct-2017 20:33:44 UTC 02-Oct-2017 04:02:29.8: Obs WZ_Per in Plan WZ_Per was vetoed by AirmassRange constraint. 02-Oct-2017 04:02:29.8: AirmassRange estimates ready after 02-Oct-2017 04:54:51 UTC 02-Oct-2017 04:02:29.8: No pending plans that can be started now. 02-Oct-2017 04:02:29.8: Dispatcher cycle time: 0.4880279 sec. 02-Oct-2017 04:02:54.6: Dispatcher stopped at 02-Oct-2017 04:02:54 UTC 02-Oct-2017 04:02:54.6: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 02-Oct-2017 04:03:10.1: Dispatcher started at 02-Oct-2017 04:03:10 UTC 02-Oct-2017 04:03:10.1: Priority: W[0]=0.00 02-Oct-2017 04:03:10.1: Transit Altitude: W[1]=0.70 02-Oct-2017 04:03:10.1: Highest Altitude: W[6]=0.00 02-Oct-2017 04:03:10.1: Lateness: W[5]=0.00 02-Oct-2017 04:03:10.1: Slew Distance: W[2]=0.00 02-Oct-2017 04:03:10.1: Retry Count: W[3]=0.20 02-Oct-2017 04:03:10.1: Meridian Crossing: W[4]=0.00 02-Oct-2017 04:03:10.1: Obs Conditions: W[7]=0.40 02-Oct-2017 04:03:10.1: Rising Plan Delay: disabled 02-Oct-2017 04:03:11.1: ++ Observatory Startup ++ 02-Oct-2017 04:03:11.1: Start ACP Sequencer's StartupObs script 02-Oct-2017 04:03:21.1: Sequencer is now active 02-Oct-2017 04:03:26.1: Sequencer is no longer active 02-Oct-2017 04:03:26.1: SelectRunning: No running plans 02-Oct-2017 04:03:26.1: No pending plans that can be started now. 02-Oct-2017 04:03:26.1: Dispatcher cycle time: 0.0130007 sec. 02-Oct-2017 04:03:35.4: Dispatcher stopped at 02-Oct-2017 04:03:35 UTC 02-Oct-2017 04:03:35.4: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 02-Oct-2017 04:04:35.8: Dispatcher started at 02-Oct-2017 04:04:35 UTC 02-Oct-2017 04:04:35.8: Priority: W[0]=0.00 02-Oct-2017 04:04:35.8: Transit Altitude: W[1]=0.70 02-Oct-2017 04:04:35.8: Highest Altitude: W[6]=0.00 02-Oct-2017 04:04:35.8: Lateness: W[5]=0.00 02-Oct-2017 04:04:35.8: Slew Distance: W[2]=0.00 02-Oct-2017 04:04:35.8: Retry Count: W[3]=0.20 02-Oct-2017 04:04:35.8: Meridian Crossing: W[4]=0.00 02-Oct-2017 04:04:35.8: Obs Conditions: W[7]=0.40 02-Oct-2017 04:04:35.8: Rising Plan Delay: disabled 02-Oct-2017 04:04:36.1: ++ Observatory Startup ++ 02-Oct-2017 04:04:36.1: Start ACP Sequencer's StartupObs script 02-Oct-2017 04:04:46.1: Sequencer is now active 02-Oct-2017 04:04:51.2: Sequencer is no longer active 02-Oct-2017 04:04:52.0: SelectRunning: No running plans 02-Oct-2017 04:04:52.0: No pending plans that can be started now. 02-Oct-2017 04:04:52.0: Dispatcher cycle time: 0.0120007 sec. 02-Oct-2017 04:05:02.2: Dispatcher stopped at 02-Oct-2017 04:05:02 UTC 02-Oct-2017 04:05:02.2: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 02-Oct-2017 04:05:04.7: Requested shutdown of scheduler 02-Oct-2017 04:05:04.7: Run statistics: 02-Oct-2017 04:05:04.7: Observations: 52 02-Oct-2017 04:05:04.7: Considered: 30 02-Oct-2017 04:05:04.7: Completed: 0 02-Oct-2017 04:05:04.7: Skipped: 0 02-Oct-2017 04:05:04.7: Never Eligible: 22 02-Oct-2017 04:05:04.7: Failed: 30 02-Oct-2017 04:05:04.7: Shutter-Open efficiency: 0.00% 02-Oct-2017 04:05:04.7: Overall Efficiency: 0.00% 02-Oct-2017 04:05:04.7: Release ACP sequencer Log closed at Mon, Oct 02 2017 04:05:06 UTC (actual time)