Log opened at Sun, Apr 15 2018 04:16:39 UTC (actual time) Current log level is Debug Scheduler version 3.5.3 Multi-user license: Arne Henden 15-Apr-2018 04:16:39.6: Simulated clock initialized at 15-Apr-2018 04:16:39 UTC 15-Apr-2018 04:16:39.7: Loaded Constraint plugin AirMass 15-Apr-2018 04:16:39.7: Loaded Constraint plugin AirmassRange 15-Apr-2018 04:16:39.7: Loaded Constraint plugin Horizon 15-Apr-2018 04:16:39.7: Loaded Constraint plugin HourAngle 15-Apr-2018 04:16:39.7: Loaded Constraint plugin MoonAvoid 15-Apr-2018 04:16:39.7: Loaded Constraint plugin MoonDown 15-Apr-2018 04:16:39.7: Loaded Constraint plugin SkyCondition 15-Apr-2018 04:16:39.7: Loaded Constraint plugin TimeRange 15-Apr-2018 04:16:40.3: 48 plans are now pending. 15-Apr-2018 04:16:40.3: Attach ACP sequencer 15-Apr-2018 04:17:01.9: Weather successfully connected. Wait for valid data... 15-Apr-2018 04:17:19.3: Dispatcher started at 15-Apr-2018 04:17:19 UTC 15-Apr-2018 04:17:19.3: Priority: W[0]=0.00 15-Apr-2018 04:17:19.3: Transit Altitude: W[1]=0.70 15-Apr-2018 04:17:19.3: Highest Altitude: W[6]=0.00 15-Apr-2018 04:17:19.3: Lateness: W[5]=0.00 15-Apr-2018 04:17:19.3: Slew Distance: W[2]=0.00 15-Apr-2018 04:17:19.3: Retry Count: W[3]=0.20 15-Apr-2018 04:17:19.3: Meridian Crossing: W[4]=0.00 15-Apr-2018 04:17:19.3: Obs Conditions: W[7]=0.40 15-Apr-2018 04:17:19.3: Rising Plan Delay: disabled 15-Apr-2018 04:17:19.5: ++ Observatory Startup ++ 15-Apr-2018 04:17:19.5: Start ACP Sequencer's StartupObs script 15-Apr-2018 04:17:29.5: Sequencer is now active 15-Apr-2018 04:17:38.2: Sequencer is no longer active 15-Apr-2018 04:17:38.2: Open the observatory dome/roof 15-Apr-2018 04:18:29.5: ++ Auto Focus ++ 15-Apr-2018 04:18:29.5: Doing initial autofocus. 15-Apr-2018 04:18:29.5: Start special ACP AutoFocus script for scheduler 15-Apr-2018 04:18:39.5: Sequencer is now active 15-Apr-2018 04:21:27.6: Sequencer is no longer active 15-Apr-2018 04:21:27.6: ** Sequencer script "AutoFocusScheduler" failed: 15-Apr-2018 04:21:27.6: **Script Error** Source: ACP Message: The script was aborted. at line 69 column 9. Script Context: 66: Telescope.Tracking = True ' AcquireStar needs tracking scope 67: Else 68: Call SUP.StartSlewJ2000("FocusArea", CT.RightAscension, CT.Declination) => 69: Call SUP.WaitForSlew() ^ 70: End If 71: 72: If Not SUP.AutoFocus(CT.RightAscension, CT.Declination) Then -- end -- 15-Apr-2018 04:21:27.6: ** Autofocus failed (n=1), will retry ASAP after 0 min. 15-Apr-2018 04:21:28.9: Plan RZ_Leo has Monitor Mode. Time to resubmit it. 15-Apr-2018 04:21:28.9: Plan KK_UMa has Monitor Mode. Time to resubmit it. 15-Apr-2018 04:21:28.9: SelectRunning: No running plans 15-Apr-2018 04:21:28.9: Obs 2MASS_J19395313+0557550 in Plan 2MASS_J19395313+0557550 was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.0: AirmassRange estimates ready after 15-Apr-2018 09:20:09 UTC 15-Apr-2018 04:21:29.0: Obs AF_And in Plan AF_And was vetoed by AirMass constraint. 15-Apr-2018 04:21:29.0: AirMass estimates ready after 15-Apr-2018 13:09:18 UTC 15-Apr-2018 04:21:29.0: Obs BC_Lac in Plan BC_Lac was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.0: AirmassRange estimates ready after 15-Apr-2018 10:56:23 UTC 15-Apr-2018 04:21:29.0: Obs CB_32 in Plan CB_32 was vetoed by AirMass constraint. 15-Apr-2018 04:21:29.0: AirMass estimates ready after 15-Apr-2018 19:33:27 UTC 15-Apr-2018 04:21:29.0: Obs CM_Cas in Plan CM_Cas was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.0: AirmassRange estimates ready after 15-Apr-2018 13:27:48 UTC 15-Apr-2018 04:21:29.0: Obs FU_Cam in Plan FU_Cam was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.0: AirmassRange estimates ready after 15-Apr-2018 15:05:18 UTC 15-Apr-2018 04:21:29.0: Obs FW_Cam in Plan FW_Cam was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.0: AirmassRange estimates ready after 15-Apr-2018 15:06:34 UTC 15-Apr-2018 04:21:29.0: Obs FY_Cam in Plan FY_Cam was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.0: AirmassRange estimates ready after 15-Apr-2018 15:24:47 UTC 15-Apr-2018 04:21:29.0: Obs GSC_3649-0825 in Plan GSC_3649-0825 was vetoed by AirMass constraint. 15-Apr-2018 04:21:29.0: AirMass estimates ready after 15-Apr-2018 11:33:35 UTC 15-Apr-2018 04:21:29.0: Obs GSC_4030_204 in Plan GSC_4030_204 was vetoed by AirMass constraint. 15-Apr-2018 04:21:29.0: AirMass estimates ready after 15-Apr-2018 12:57:30 UTC 15-Apr-2018 04:21:29.1: Obs HI_Cam in Plan HI_Cam was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 16:20:44 UTC 15-Apr-2018 04:21:29.1: STRICT VETO: 15-Apr-2018 04:21:29.1: Obs HO_Cam in Plan HO_Cam was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 17:05:29 UTC 15-Apr-2018 04:21:29.1: STRICT VETO: 15-Apr-2018 04:21:29.1: Obs HQ_Aur in Plan HQ_Aur was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 17:36:35 UTC 15-Apr-2018 04:21:29.1: Obs HX_Aur in Plan HX_Aur was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 17:14:45 UTC 15-Apr-2018 04:21:29.1: Obs IRAS_19067+2158 in Plan IRAS_19067+2158 was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 08:11:33 UTC 15-Apr-2018 04:21:29.1: Obs IRAS_19183+2339 in Plan IRAS_19183+2339 was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 08:19:37 UTC 15-Apr-2018 04:21:29.1: Obs M56 in Plan M56 was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 08:03:14 UTC 15-Apr-2018 04:21:29.1: Obs Mkn_501 in Plan Mkn_501 was vetoed by AirMass constraint. 15-Apr-2018 04:21:29.1: AirMass estimates ready after 15-Apr-2018 05:23:27 UTC 15-Apr-2018 04:21:29.1: STRICT VETO: 15-Apr-2018 04:21:29.1: Obs MP_Gem in Plan MP_Gem was vetoed by AirMass constraint. 15-Apr-2018 04:21:29.1: AirMass estimates ready after 15-Apr-2018 19:54:24 UTC 15-Apr-2018 04:21:29.1: Obs NGC_7790 in Plan NGC_7790 was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 11:48:11 UTC 15-Apr-2018 04:21:29.1: Obs NSVS_11201899 in Plan NSVS_11201899 was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.1: AirmassRange estimates ready after 15-Apr-2018 08:12:34 UTC 15-Apr-2018 04:21:29.1: Obs RX_J0524+42 in Plan RX_J0524+42 was vetoed by AirMass constraint. 15-Apr-2018 04:21:29.1: AirMass estimates ready after 15-Apr-2018 17:46:47 UTC 15-Apr-2018 04:21:29.2: Obs T_Ori in Plan T_Ori was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 19:50:16 UTC 15-Apr-2018 04:21:29.2: Obs U_Aqr in Plan U_Aqr was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 13:09:55 UTC 15-Apr-2018 04:21:29.2: Obs V0336_Ser in Plan V0336_Ser was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 05:07:22 UTC 15-Apr-2018 04:21:29.2: Obs V0524_Cas in Plan V0524_Cas was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 12:17:59 UTC 15-Apr-2018 04:21:29.2: Obs V0603_Per in Plan V0603_Per was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 15:55:29 UTC 15-Apr-2018 04:21:29.2: Obs V0809_Cep in Plan V0809_Cep was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 10:58:50 UTC 15-Apr-2018 04:21:29.2: Obs V0959_Mon in Plan V0959_Mon was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 20:18:17 UTC 15-Apr-2018 04:21:29.2: Obs V0965_Per in Plan V0965_Per was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 15:43:56 UTC 15-Apr-2018 04:21:29.2: Obs V1015_Her in Plan V1015_Her was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 06:31:51 UTC 15-Apr-2018 04:21:29.2: Obs V1721_Aql in Plan V1721_Aql was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 08:43:45 UTC 15-Apr-2018 04:21:29.2: Obs V1722_Aql in Plan V1722_Aql was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 08:31:27 UTC 15-Apr-2018 04:21:29.2: Obs V1723_Aql in Plan V1723_Aql was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 08:57:49 UTC 15-Apr-2018 04:21:29.2: Obs V1724_Aql in Plan V1724_Aql was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 08:51:16 UTC 15-Apr-2018 04:21:29.2: Obs V1904_Cyg in Plan V1904_Cyg was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 10:03:57 UTC 15-Apr-2018 04:21:29.2: Obs V1907_Cyg in Plan V1907_Cyg was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 10:00:37 UTC 15-Apr-2018 04:21:29.2: Obs V2481_Cyg in Plan V2481_Cyg was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.2: AirmassRange estimates ready after 15-Apr-2018 09:36:35 UTC 15-Apr-2018 04:21:29.3: Obs V339_Del_TMO61 in Plan V339_Del_TMO61 was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.3: AirmassRange estimates ready after 15-Apr-2018 09:28:38 UTC 15-Apr-2018 04:21:29.3: Obs V841_Oph in Plan V841_Oph was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.3: AirmassRange estimates ready after 15-Apr-2018 07:47:04 UTC 15-Apr-2018 04:21:29.3: Obs WZ_Per in Plan WZ_Per was vetoed by AirmassRange constraint. 15-Apr-2018 04:21:29.3: AirmassRange estimates ready after 15-Apr-2018 16:04:16 UTC 15-Apr-2018 04:21:29.3: Efficiency: Selecting from 9 pending plans: 15-Apr-2018 04:21:29.4: Selected Plan KK_UMa (TotEff=0.89) 15-Apr-2018 04:21:29.4: Dispatcher cycle time: 1.6270931 sec. 15-Apr-2018 04:21:29.4: Acquire data for Observation KK_UMa... 15-Apr-2018 04:21:29.4: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan KK_UMa) 15-Apr-2018 04:21:29.4: Send Observation KK_UMa to ACP Sequencer 15-Apr-2018 04:21:39.4: Sequencer is now active 15-Apr-2018 04:22:12.2: Dispatcher stopped at 15-Apr-2018 04:22:12 UTC 15-Apr-2018 04:22:12.2: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 15-Apr-2018 04:22:18.9: Sequencer is no longer active 15-Apr-2018 04:22:18.9: ** Sequencer script "AcquireScheduler" failed: 15-Apr-2018 04:22:18.9: **Script Error** Source: ACP Message: The script was aborted. at line 1741 column 9. Script Context: 1738: SUP.CalcSimImageCoordinates TargetRA, TargetDec ' Calculate simulator image 1739: End If 1740: Else => 1741: SUP.StartSlewJ2000 OBS.Name, TargetRA, TargetDec ' START THE SLEW ^ 1742: End If 1743: If SUP.HaveRotator Then SUP.StartRotateToPA OBS.PA, TargetRA ' Always start rotator slew 1744: -- end -- 15-Apr-2018 04:22:21.9: Post-job status check done (stat=Running) 15-Apr-2018 04:22:21.9: RUN FAILED: Scheduler was stopped during run 15-Apr-2018 04:22:21.9: ACP data acquisition failed for Observation KK_UMa. 15-Apr-2018 04:22:21.9: (Observation KK_UMa interrupted by operator or system.) 15-Apr-2018 04:23:29.4: COMException while trying to get ACP Weather.Available. Probably operator script abort. 15-Apr-2018 04:23:29.4: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA) 15-Apr-2018 04:23:30.4: COMException while trying to get ACP Weather.Available. Probably operator script abort. 15-Apr-2018 04:23:30.4: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA) 15-Apr-2018 04:23:31.4: COMException while trying to get ACP Weather.Available. Probably operator script abort. 15-Apr-2018 04:23:31.4: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA) 15-Apr-2018 04:23:32.4: COMException while trying to get ACP Weather.Available. Probably operator script abort. 15-Apr-2018 04:23:32.4: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA) 15-Apr-2018 04:23:33.4: COMException while trying to get ACP Weather.Available. Probably operator script abort. 15-Apr-2018 04:23:33.4: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA) 15-Apr-2018 04:23:34.5: **EXCEPTION IN SCHEDULER: 15-Apr-2018 04:23:34.5: ConnectWeather() waited for over 5 seconds to read Weather.Available! 15-Apr-2018 04:23:34.5: Traceback: at DC3.Scheduler.ACPSequencer.ConnectWeather() at DC3.Scheduler.Engine.PollWeather() at DC3.Scheduler.Engine.Run() 15-Apr-2018 04:23:34.5: Run statistics: 15-Apr-2018 04:23:34.5: Observations: 53 15-Apr-2018 04:23:34.5: Considered: 12 15-Apr-2018 04:23:34.5: Completed: 0 15-Apr-2018 04:23:34.5: Skipped: 8 15-Apr-2018 04:23:34.5: Never Eligible: 41 15-Apr-2018 04:23:34.5: Failed: 4 15-Apr-2018 04:23:34.5: Shutter-Open efficiency: 0.00% 15-Apr-2018 04:23:34.5: Overall Efficiency: 96.94% 15-Apr-2018 04:23:34.5: Release ACP sequencer 15-Apr-2018 04:23:34.5: Failed to stop sequencer: 15-Apr-2018 04:23:34.5: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA) Log closed at Sun, Apr 15 2018 04:23:36 UTC (actual time)