Log opened at Tue, Sep 26 2017 02:22:26 UTC (actual time) Current log level is Debug Scheduler version 3.5.3 Multi-user license: Arne Henden 26-Sep-2017 02:22:26.8: Simulated clock initialized at 26-Sep-2017 02:22:26 UTC 26-Sep-2017 02:22:26.9: Loaded Constraint plugin AirMass 26-Sep-2017 02:22:26.9: Loaded Constraint plugin AirmassRange 26-Sep-2017 02:22:26.9: Loaded Constraint plugin Horizon 26-Sep-2017 02:22:26.9: Loaded Constraint plugin HourAngle 26-Sep-2017 02:22:26.9: Loaded Constraint plugin MoonAvoid 26-Sep-2017 02:22:26.9: Loaded Constraint plugin MoonDown 26-Sep-2017 02:22:26.9: Loaded Constraint plugin SkyCondition 26-Sep-2017 02:22:26.9: Loaded Constraint plugin TimeRange 26-Sep-2017 02:22:27.4: 46 plans are now pending. 26-Sep-2017 02:22:27.4: Attach ACP sequencer 26-Sep-2017 02:22:49.3: Weather successfully connected. Wait for valid data... 26-Sep-2017 02:22:51.3: Dispatcher started at 26-Sep-2017 02:22:51 UTC 26-Sep-2017 02:22:51.3: Priority: W[0]=0.00 26-Sep-2017 02:22:51.3: Transit Altitude: W[1]=0.70 26-Sep-2017 02:22:51.3: Highest Altitude: W[6]=0.00 26-Sep-2017 02:22:51.3: Lateness: W[5]=0.00 26-Sep-2017 02:22:51.3: Slew Distance: W[2]=0.00 26-Sep-2017 02:22:51.3: Retry Count: W[3]=0.20 26-Sep-2017 02:22:51.3: Meridian Crossing: W[4]=0.00 26-Sep-2017 02:22:51.3: Obs Conditions: W[7]=0.40 26-Sep-2017 02:22:51.3: Rising Plan Delay: disabled 26-Sep-2017 02:22:51.7: ++ Observatory Startup ++ 26-Sep-2017 02:22:51.7: Start ACP Sequencer's StartupObs script 26-Sep-2017 02:23:01.7: Sequencer is now active 26-Sep-2017 02:23:06.7: Sequencer is no longer active 26-Sep-2017 02:23:06.7: Open the observatory dome/roof 26-Sep-2017 02:24:12.6: ++ Auto Focus ++ 26-Sep-2017 02:24:12.6: Doing initial autofocus. 26-Sep-2017 02:24:12.6: Start special ACP AutoFocus script for scheduler 26-Sep-2017 02:24:22.6: Sequencer is now active 26-Sep-2017 02:27:53.2: Sequencer is no longer active 26-Sep-2017 02:27:53.2: ** Autofocus failed (n=1), will retry ASAP after 0 min. 26-Sep-2017 02:27:54.0: Plan U_Aqr has Monitor Mode. Time to resubmit it. 26-Sep-2017 02:27:54.0: SelectRunning: No running plans 26-Sep-2017 02:27:54.0: Obs AL_Boo in Plan AL_Boo was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.0: AirmassRange estimates ready after 26-Sep-2017 15:59:47 UTC 26-Sep-2017 02:27:54.0: Obs CB_32 in Plan CB_32 was vetoed by AirMass constraint. 26-Sep-2017 02:27:54.0: AirMass estimates ready after 26-Sep-2017 08:47:38 UTC 26-Sep-2017 02:27:54.0: Obs CM_Cas in Plan CM_Cas was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.0: AirmassRange estimates ready after 26-Sep-2017 02:41:59 UTC 26-Sep-2017 02:27:54.0: Obs CV_Vir in Plan CV_Vir was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.0: AirmassRange estimates ready after 26-Sep-2017 15:06:32 UTC 26-Sep-2017 02:27:54.0: Obs DN_Lyn in Plan DN_Lyn was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.0: AirmassRange estimates ready after 26-Sep-2017 08:59:23 UTC 26-Sep-2017 02:27:54.1: Obs FU_Cam in Plan FU_Cam was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.1: AirmassRange estimates ready after 26-Sep-2017 04:19:29 UTC 26-Sep-2017 02:27:54.1: Obs FW_Cam in Plan FW_Cam was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.1: AirmassRange estimates ready after 26-Sep-2017 04:20:45 UTC 26-Sep-2017 02:27:54.1: Obs FY_Cam in Plan FY_Cam was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.1: AirmassRange estimates ready after 26-Sep-2017 04:38:58 UTC 26-Sep-2017 02:27:54.1: Obs HI_Cam in Plan HI_Cam was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.1: AirmassRange estimates ready after 26-Sep-2017 05:34:54 UTC 26-Sep-2017 02:27:54.1: Obs HO_Cam in Plan HO_Cam was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.1: AirmassRange estimates ready after 26-Sep-2017 06:19:40 UTC 26-Sep-2017 02:27:54.1: Obs HQ_Aur in Plan HQ_Aur was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.1: AirmassRange estimates ready after 26-Sep-2017 06:50:46 UTC 26-Sep-2017 02:27:54.1: Obs HX_Aur in Plan HX_Aur was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.1: AirmassRange estimates ready after 26-Sep-2017 06:28:56 UTC 26-Sep-2017 02:27:54.1: Obs KK_UMa in Plan KK_UMa was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.1: AirmassRange estimates ready after 26-Sep-2017 12:39:38 UTC 26-Sep-2017 02:27:54.2: Obs M67 in Plan M67 was vetoed by AirMass constraint. 26-Sep-2017 02:27:54.2: AirMass estimates ready after 26-Sep-2017 11:57:27 UTC 26-Sep-2017 02:27:54.2: Obs MP_Gem in Plan MP_Gem was vetoed by AirMass constraint. 26-Sep-2017 02:27:54.2: AirMass estimates ready after 26-Sep-2017 09:08:34 UTC 26-Sep-2017 02:27:54.2: Obs SDSS073224 in Plan SDSS073224 was vetoed by AirMass constraint. 26-Sep-2017 02:27:54.2: AirMass estimates ready after 26-Sep-2017 09:37:27 UTC 26-Sep-2017 02:27:54.2: Obs SDSSJ121027+502735 in Plan SDSSJ121027+502735 was vetoed by AirMass constraint. 26-Sep-2017 02:27:54.2: AirMass estimates ready after 26-Sep-2017 13:32:16 UTC 26-Sep-2017 02:27:54.2: Obs T_Ori in Plan T_Ori was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.2: AirmassRange estimates ready after 26-Sep-2017 09:04:27 UTC 26-Sep-2017 02:27:54.2: Obs V0603_Per in Plan V0603_Per was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.2: AirmassRange estimates ready after 26-Sep-2017 05:09:40 UTC 26-Sep-2017 02:27:54.2: Obs V0959_Mon in Plan V0959_Mon was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.2: AirmassRange estimates ready after 26-Sep-2017 09:32:28 UTC 26-Sep-2017 02:27:54.2: Obs V0965_Per in Plan V0965_Per was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.2: AirmassRange estimates ready after 26-Sep-2017 04:58:07 UTC 26-Sep-2017 02:27:54.6: STRICT VETO: 26-Sep-2017 02:27:54.6: Obs V841_Oph in Plan V841_Oph was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.6: AirmassRange estimates ready after 26-Sep-2017 20:57:19 UTC 26-Sep-2017 02:27:54.6: Obs WZ_Per in Plan WZ_Per was vetoed by AirmassRange constraint. 26-Sep-2017 02:27:54.6: AirmassRange estimates ready after 26-Sep-2017 05:18:27 UTC 26-Sep-2017 02:27:54.6: Efficiency: Selecting from 24 pending plans: 26-Sep-2017 02:27:54.8: Selected Plan 2MASS_J19395313+0557550 (TotEff=0.90) 26-Sep-2017 02:27:54.9: Dispatcher cycle time: 1.5950912 sec. 26-Sep-2017 02:27:54.9: Acquire data for Observation 2MASS_J19395313+0557550... 26-Sep-2017 02:27:54.9: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan 2MASS_J19395313+0557550) 26-Sep-2017 02:27:54.9: Send Observation 2MASS_J19395313+0557550 to ACP Sequencer 26-Sep-2017 02:28:04.9: Sequencer is now active 26-Sep-2017 02:41:34.8: Sequencer is no longer active 26-Sep-2017 02:41:34.8: Post-job status check done (stat=Completed) 26-Sep-2017 02:41:34.8: Acquisition time: 819.9218968 sec. 26-Sep-2017 02:41:34.8: Data for Observation 2MASS_J19395313+0557550 acquired successfully. 26-Sep-2017 02:41:34.8: Image Efficiency: 47.5% 26-Sep-2017 02:41:34.8: Cycle Efficiency: 99.8% 26-Sep-2017 02:41:35.2: ++ Auto Focus ++ 26-Sep-2017 02:41:35.3: Doing periodic autofocus. 26-Sep-2017 02:41:35.3: Start special ACP AutoFocus script for scheduler 26-Sep-2017 02:41:45.3: Sequencer is now active 26-Sep-2017 02:43:10.7: Sequencer is no longer active 26-Sep-2017 02:43:10.7: ** Autofocus failed (n=2), will retry ASAP after 5 min. 26-Sep-2017 02:43:10.8: SelectRunning: No running plans 26-Sep-2017 02:43:10.9: Efficiency: Selecting from 24 pending plans: 26-Sep-2017 02:43:11.1: Selected Plan V339_Del_TMO61 (TotEff=0.89) 26-Sep-2017 02:43:11.2: Dispatcher cycle time: 0.4060232 sec. 26-Sep-2017 02:43:11.2: Acquire data for Observation V339_Del_TMO61... 26-Sep-2017 02:43:11.2: (belongs to Project AAVSO_Monitoring, Plan V339_Del_TMO61) 26-Sep-2017 02:43:11.2: Doing 3 sets 26-Sep-2017 02:43:11.2: Send Observation V339_Del_TMO61 to ACP Sequencer 26-Sep-2017 02:43:21.2: Sequencer is now active 26-Sep-2017 02:48:14.7: Sequencer is no longer active 26-Sep-2017 02:48:14.7: Post-job status check done (stat=Completed) 26-Sep-2017 02:48:14.8: Send Observation V339_Del_TMO61 to ACP Sequencer 26-Sep-2017 02:48:24.8: Sequencer is now active 26-Sep-2017 02:52:30.0: Sequencer is no longer active 26-Sep-2017 02:52:30.0: Post-job status check done (stat=Completed) 26-Sep-2017 02:52:30.0: Send Observation V339_Del_TMO61 to ACP Sequencer 26-Sep-2017 02:52:40.0: Sequencer is now active 26-Sep-2017 02:56:42.7: Sequencer is no longer active 26-Sep-2017 02:56:42.7: Post-job status check done (stat=Completed) 26-Sep-2017 02:56:42.7: Acquisition time: 811.5254164 sec. 26-Sep-2017 02:56:42.7: Data for Observation V339_Del_TMO61 acquired successfully. 26-Sep-2017 02:56:42.8: Image Efficiency: 33.3% 26-Sep-2017 02:56:42.8: Cycle Efficiency: 99.9% 26-Sep-2017 02:56:42.9: ++ Auto Focus ++ 26-Sep-2017 02:56:42.9: Doing periodic autofocus. 26-Sep-2017 02:56:42.9: Start special ACP AutoFocus script for scheduler 26-Sep-2017 02:56:52.9: Sequencer is now active 26-Sep-2017 02:59:02.6: Sequencer is no longer active 26-Sep-2017 02:59:02.6: ** Autofocus failed (n=3), will retry ASAP after 10 min. 26-Sep-2017 02:59:02.7: SelectRunning: No running plans 26-Sep-2017 02:59:02.8: Efficiency: Selecting from 23 pending plans: 26-Sep-2017 02:59:03.0: Selected Plan V1722_Aql (TotEff=0.86) 26-Sep-2017 02:59:03.0: Dispatcher cycle time: 0.3390193 sec. 26-Sep-2017 02:59:03.0: Acquire data for Observation V1722_Aql... 26-Sep-2017 02:59:03.0: (belongs to Project Nova_Monitoring, Plan V1722_Aql) 26-Sep-2017 02:59:03.0: Send Observation V1722_Aql to ACP Sequencer 26-Sep-2017 02:59:13.0: Sequencer is now active 26-Sep-2017 03:30:14.3: Sequencer is no longer active 26-Sep-2017 03:30:14.3: Post-job status check done (stat=Completed) 26-Sep-2017 03:30:14.3: Acquisition time: 1871.278031 sec. 26-Sep-2017 03:30:14.3: Data for Observation V1722_Aql acquired successfully. 26-Sep-2017 03:30:14.3: Image Efficiency: 80.1% 26-Sep-2017 03:30:14.3: Cycle Efficiency: 100.0% 26-Sep-2017 03:30:14.8: ++ Auto Focus ++ 26-Sep-2017 03:30:14.8: Doing periodic autofocus. 26-Sep-2017 03:30:14.8: Start special ACP AutoFocus script for scheduler 26-Sep-2017 03:30:24.9: Sequencer is now active 26-Sep-2017 03:32:06.9: Sequencer is no longer active 26-Sep-2017 03:32:06.9: ** Autofocus failed (n=4), will retry ASAP after 15 min. 26-Sep-2017 03:32:07.0: SelectRunning: No running plans 26-Sep-2017 03:32:07.0: Obs V0336_Ser in Plan V0336_Ser was vetoed by AirmassRange constraint. 26-Sep-2017 03:32:07.0: AirmassRange estimates ready after 26-Sep-2017 18:17:37 UTC 26-Sep-2017 03:32:07.1: Efficiency: Selecting from 21 pending plans: 26-Sep-2017 03:32:07.2: Selected Plan V2481_Cyg (TotEff=0.89) 26-Sep-2017 03:32:07.3: Dispatcher cycle time: 0.3190182 sec. 26-Sep-2017 03:32:07.3: Acquire data for Observation V2481_Cyg... 26-Sep-2017 03:32:07.3: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V2481_Cyg) 26-Sep-2017 03:32:07.3: Send Observation V2481_Cyg to ACP Sequencer 26-Sep-2017 03:32:17.3: Sequencer is now active 26-Sep-2017 03:45:58.5: Sequencer is no longer active 26-Sep-2017 03:45:58.5: Post-job status check done (stat=Completed) 26-Sep-2017 03:45:58.5: Acquisition time: 831.1965417 sec. 26-Sep-2017 03:45:58.5: Data for Observation V2481_Cyg acquired successfully. 26-Sep-2017 03:45:58.5: Image Efficiency: 46.9% 26-Sep-2017 03:45:58.5: Cycle Efficiency: 100.0% 26-Sep-2017 03:45:58.9: SelectRunning: No running plans 26-Sep-2017 03:45:59.0: Efficiency: Selecting from 20 pending plans: 26-Sep-2017 03:45:59.1: Selected Plan V1904_Cyg (TotEff=0.87) 26-Sep-2017 03:45:59.2: Dispatcher cycle time: 0.3060175 sec. 26-Sep-2017 03:45:59.2: Acquire data for Observation V1904_Cyg... 26-Sep-2017 03:45:59.2: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V1904_Cyg) 26-Sep-2017 03:45:59.2: Send Observation V1904_Cyg to ACP Sequencer 26-Sep-2017 03:46:09.2: Sequencer is now active 26-Sep-2017 03:59:24.9: Sequencer is no longer active 26-Sep-2017 03:59:24.9: Post-job status check done (stat=Completed) 26-Sep-2017 03:59:24.9: Acquisition time: 805.6870827 sec. 26-Sep-2017 03:59:24.9: Data for Observation V1904_Cyg acquired successfully. 26-Sep-2017 03:59:24.9: Image Efficiency: 48.4% 26-Sep-2017 03:59:24.9: Cycle Efficiency: 100.0% 26-Sep-2017 03:59:25.0: ++ Auto Focus ++ 26-Sep-2017 03:59:25.0: Doing periodic autofocus. 26-Sep-2017 03:59:25.0: Start special ACP AutoFocus script for scheduler 26-Sep-2017 03:59:35.0: Sequencer is now active 26-Sep-2017 04:01:22.2: Sequencer is no longer active 26-Sep-2017 04:01:22.2: ** Autofocus failed (n=5), will retry ASAP after 20 min. 26-Sep-2017 04:01:22.2: SelectRunning: No running plans 26-Sep-2017 04:01:22.3: Efficiency: Selecting from 19 pending plans: 26-Sep-2017 04:01:22.5: Selected Plan U_Aqr (TotEff=0.88) 26-Sep-2017 04:01:22.5: Dispatcher cycle time: 0.3050175 sec. 26-Sep-2017 04:01:22.5: Acquire data for Observation U_Aqr... 26-Sep-2017 04:01:22.5: (belongs to Project AAVSO_Monitoring, Plan U_Aqr) 26-Sep-2017 04:01:22.5: Send Observation U_Aqr to ACP Sequencer 26-Sep-2017 04:01:32.5: Sequencer is now active 26-Sep-2017 04:41:02.6: Sequencer is no longer active 26-Sep-2017 04:41:02.6: Post-job status check done (stat=Completed) 26-Sep-2017 04:41:02.6: Acquisition time: 2380.0601317 sec. 26-Sep-2017 04:41:02.6: Data for Observation U_Aqr acquired successfully. 26-Sep-2017 04:41:02.6: Image Efficiency: 58.8% 26-Sep-2017 04:41:02.6: Cycle Efficiency: 100.0% 26-Sep-2017 04:41:02.7: ++ Auto Focus ++ 26-Sep-2017 04:41:02.7: Doing periodic autofocus. 26-Sep-2017 04:41:02.7: Start special ACP AutoFocus script for scheduler 26-Sep-2017 04:41:12.7: Sequencer is now active 26-Sep-2017 04:42:47.9: Sequencer is no longer active 26-Sep-2017 04:42:47.9: ** Autofocus failed (n=6), will retry ASAP after 20 min. 26-Sep-2017 04:42:48.3: SelectRunning: No running plans 26-Sep-2017 04:42:48.4: STRICT VETO: 26-Sep-2017 04:42:48.4: Obs Mkn_501 in Plan Mkn_501 was vetoed by AirMass constraint. 26-Sep-2017 04:42:48.4: AirMass estimates ready after 26-Sep-2017 18:33:42 UTC 26-Sep-2017 04:42:48.5: STRICT VETO: 26-Sep-2017 04:42:48.5: Obs V1723_Aql in Plan V1723_Aql was vetoed by AirmassRange constraint. 26-Sep-2017 04:42:48.5: AirmassRange estimates ready after 26-Sep-2017 22:08:04 UTC 26-Sep-2017 04:42:48.5: Efficiency: Selecting from 19 pending plans: 26-Sep-2017 04:42:48.6: Selected Plan V0809_Cep (TotEff=0.87) 26-Sep-2017 04:42:48.7: Dispatcher cycle time: 0.3790216 sec. 26-Sep-2017 04:42:48.7: Acquire data for Observation V0809_Cep... 26-Sep-2017 04:42:48.7: (belongs to Project Nova_Monitoring, Plan V0809_Cep) 26-Sep-2017 04:42:48.7: Send Observation V0809_Cep to ACP Sequencer 26-Sep-2017 04:42:58.7: Sequencer is now active 26-Sep-2017 05:13:21.0: Sequencer is no longer active 26-Sep-2017 05:13:21.0: Post-job status check done (stat=Completed) 26-Sep-2017 05:13:21.0: Acquisition time: 1832.2838006 sec. 26-Sep-2017 05:13:21.0: Data for Observation V0809_Cep acquired successfully. 26-Sep-2017 05:13:21.0: Image Efficiency: 76.4% 26-Sep-2017 05:13:21.0: Cycle Efficiency: 100.0% 26-Sep-2017 05:13:21.2: ++ Auto Focus ++ 26-Sep-2017 05:13:21.2: Doing periodic autofocus. 26-Sep-2017 05:13:21.2: Start special ACP AutoFocus script for scheduler 26-Sep-2017 05:13:31.2: Sequencer is now active 26-Sep-2017 05:16:23.9: Sequencer is no longer active 26-Sep-2017 05:16:23.9: ** Autofocus failed (n=7), will retry ASAP after 20 min. 26-Sep-2017 05:16:24.1: SelectRunning: No running plans 26-Sep-2017 05:16:24.1: STRICT VETO: 26-Sep-2017 05:16:24.1: Obs FY_Aql in Plan FY_Aql was vetoed by AirMass constraint. 26-Sep-2017 05:16:24.1: AirMass estimates ready after 26-Sep-2017 22:55:10 UTC 26-Sep-2017 05:16:24.2: Obs V1724_Aql in Plan V1724_Aql was vetoed by AirmassRange constraint. 26-Sep-2017 05:16:24.2: AirmassRange estimates ready after 26-Sep-2017 22:01:31 UTC 26-Sep-2017 05:16:24.2: Efficiency: Selecting from 18 pending plans: 26-Sep-2017 05:16:24.4: Selected Plan GSC_3649-0825 (TotEff=0.88) 26-Sep-2017 05:16:24.4: Dispatcher cycle time: 0.3440196 sec. 26-Sep-2017 05:16:24.4: Acquire data for Observation GSC_3649-0825... 26-Sep-2017 05:16:24.4: (belongs to Project Staels, Plan GSC_3649-0825) 26-Sep-2017 05:16:24.4: Send Observation GSC_3649-0825 to ACP Sequencer 26-Sep-2017 05:16:34.4: Sequencer is now active 26-Sep-2017 05:21:22.3: Sequencer is no longer active 26-Sep-2017 05:21:22.3: Post-job status check done (stat=Completed) 26-Sep-2017 05:21:22.3: Acquisition time: 297.8530362 sec. 26-Sep-2017 05:21:22.3: Data for Observation GSC_3649-0825 acquired successfully. 26-Sep-2017 05:21:22.3: Image Efficiency: 45.3% 26-Sep-2017 05:21:22.3: Cycle Efficiency: 99.9% 26-Sep-2017 05:21:22.7: SelectRunning: No running plans 26-Sep-2017 05:21:22.8: STRICT VETO: 26-Sep-2017 05:21:22.8: Obs V1015_Her in Plan V1015_Her was vetoed by AirmassRange constraint. 26-Sep-2017 05:21:22.8: AirmassRange estimates ready after 26-Sep-2017 19:42:06 UTC 26-Sep-2017 05:21:22.8: STRICT VETO: 26-Sep-2017 05:21:22.8: Obs V1721_Aql in Plan V1721_Aql was vetoed by AirmassRange constraint. 26-Sep-2017 05:21:22.8: AirmassRange estimates ready after 26-Sep-2017 21:54:00 UTC 26-Sep-2017 05:21:22.8: Efficiency: Selecting from 16 pending plans: 26-Sep-2017 05:21:23.0: Selected Plan NGC_7790 (TotEff=0.87) 26-Sep-2017 05:21:23.0: Dispatcher cycle time: 0.3200183 sec. 26-Sep-2017 05:21:23.0: Acquire data for Observation NGC_7790... 26-Sep-2017 05:21:23.0: (belongs to Project AAVSO_Monitoring, Plan NGC_7790) 26-Sep-2017 05:21:23.0: Send Observation NGC_7790 to ACP Sequencer 26-Sep-2017 05:21:33.0: Sequencer is now active 26-Sep-2017 05:36:32.9: Sequencer is no longer active 26-Sep-2017 05:36:32.9: Post-job status check done (stat=Completed) 26-Sep-2017 05:36:32.9: Acquisition time: 909.894043 sec. 26-Sep-2017 05:36:32.9: Data for Observation NGC_7790 acquired successfully. 26-Sep-2017 05:36:33.0: Image Efficiency: 51.1% 26-Sep-2017 05:36:33.0: Cycle Efficiency: 100.0% 26-Sep-2017 05:36:33.1: ++ Auto Focus ++ 26-Sep-2017 05:36:33.1: Doing periodic autofocus. 26-Sep-2017 05:36:33.1: Start special ACP AutoFocus script for scheduler 26-Sep-2017 05:36:43.1: Sequencer is now active 26-Sep-2017 05:38:45.0: Sequencer is no longer active 26-Sep-2017 05:38:45.0: ** Autofocus failed (n=8), will retry ASAP after 20 min. 26-Sep-2017 05:38:45.0: SelectRunning: No running plans 26-Sep-2017 05:38:45.1: Efficiency: Selecting from 16 pending plans: 26-Sep-2017 05:38:45.3: Selected Plan V0524_Cas (TotEff=0.86) 26-Sep-2017 05:38:45.3: Dispatcher cycle time: 0.3060175 sec. 26-Sep-2017 05:38:45.3: Acquire data for Observation V0524_Cas... 26-Sep-2017 05:38:45.3: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V0524_Cas) 26-Sep-2017 05:38:45.3: Send Observation V0524_Cas to ACP Sequencer 26-Sep-2017 05:38:55.3: Sequencer is now active 26-Sep-2017 05:52:53.7: Sequencer is no longer active 26-Sep-2017 05:52:53.7: Post-job status check done (stat=Completed) 26-Sep-2017 05:52:53.7: Acquisition time: 848.3425225 sec. 26-Sep-2017 05:52:53.7: Data for Observation V0524_Cas acquired successfully. 26-Sep-2017 05:52:53.7: Image Efficiency: 46.0% 26-Sep-2017 05:52:53.7: Cycle Efficiency: 100.0% 26-Sep-2017 05:52:53.9: SelectRunning: No running plans 26-Sep-2017 05:52:54.0: Efficiency: Selecting from 15 pending plans: 26-Sep-2017 05:52:54.1: Selected Plan CM_Cas (TotEff=0.81) 26-Sep-2017 05:52:54.2: Dispatcher cycle time: 0.2930168 sec. 26-Sep-2017 05:52:54.2: Acquire data for Observation CM_Cas... 26-Sep-2017 05:52:54.2: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan CM_Cas) 26-Sep-2017 05:52:54.2: Send Observation CM_Cas to ACP Sequencer 26-Sep-2017 05:53:04.2: Sequencer is now active 26-Sep-2017 06:06:34.7: Sequencer is no longer active 26-Sep-2017 06:06:34.7: Post-job status check done (stat=Completed) 26-Sep-2017 06:06:34.7: Acquisition time: 820.5099304 sec. 26-Sep-2017 06:06:34.7: Data for Observation CM_Cas acquired successfully. 26-Sep-2017 06:06:34.7: Image Efficiency: 47.5% 26-Sep-2017 06:06:34.7: Cycle Efficiency: 100.0% 26-Sep-2017 06:06:35.1: ++ Auto Focus ++ 26-Sep-2017 06:06:35.1: Doing periodic autofocus. 26-Sep-2017 06:06:35.1: Start special ACP AutoFocus script for scheduler 26-Sep-2017 06:06:45.1: Sequencer is now active 26-Sep-2017 06:08:39.9: Sequencer is no longer active 26-Sep-2017 06:08:39.9: ** Autofocus failed (n=9), will retry ASAP after 20 min. 26-Sep-2017 06:08:40.0: SelectRunning: No running plans 26-Sep-2017 06:08:40.1: Efficiency: Selecting from 14 pending plans: 26-Sep-2017 06:08:40.2: Selected Plan FW_Cam (TotEff=0.71) 26-Sep-2017 06:08:40.2: Dispatcher cycle time: 0.2320133 sec. 26-Sep-2017 06:08:40.2: Acquire data for Observation FW_Cam... 26-Sep-2017 06:08:40.2: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FW_Cam) 26-Sep-2017 06:08:40.2: Send Observation FW_Cam to ACP Sequencer 26-Sep-2017 06:08:50.2: Sequencer is now active 26-Sep-2017 06:23:33.7: Sequencer is no longer active 26-Sep-2017 06:23:33.7: Post-job status check done (stat=Completed) 26-Sep-2017 06:23:33.7: Acquisition time: 893.5151062 sec. 26-Sep-2017 06:23:33.7: Data for Observation FW_Cam acquired successfully. 26-Sep-2017 06:23:33.7: Image Efficiency: 43.6% 26-Sep-2017 06:23:33.7: Cycle Efficiency: 100.0% 26-Sep-2017 06:23:33.9: SelectRunning: No running plans 26-Sep-2017 06:23:34.0: STRICT VETO: 26-Sep-2017 06:23:34.0: Obs IRAS_19067+2158 in Plan IRAS_19067+2158 was vetoed by AirmassRange constraint. 26-Sep-2017 06:23:34.0: AirmassRange estimates ready after 26-Sep-2017 21:21:48 UTC 26-Sep-2017 06:23:34.0: STRICT VETO: 26-Sep-2017 06:23:34.0: Obs NSVS_11201899 in Plan NSVS_11201899 was vetoed by AirmassRange constraint. 26-Sep-2017 06:23:34.0: AirmassRange estimates ready after 26-Sep-2017 21:22:49 UTC 26-Sep-2017 06:23:34.0: Efficiency: Selecting from 12 pending plans: 26-Sep-2017 06:23:34.1: Selected Plan FU_Cam (TotEff=0.72) 26-Sep-2017 06:23:34.1: Dispatcher cycle time: 0.2240128 sec. 26-Sep-2017 06:23:34.1: Acquire data for Observation FU_Cam... 26-Sep-2017 06:23:34.1: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FU_Cam) 26-Sep-2017 06:23:34.2: Send Observation FU_Cam to ACP Sequencer 26-Sep-2017 06:23:44.2: Sequencer is now active 26-Sep-2017 06:36:49.9: Sequencer is no longer active 26-Sep-2017 06:36:49.9: Post-job status check done (stat=Completed) 26-Sep-2017 06:36:49.9: Acquisition time: 795.7725156 sec. 26-Sep-2017 06:36:49.9: Data for Observation FU_Cam acquired successfully. 26-Sep-2017 06:36:49.9: Image Efficiency: 49.0% 26-Sep-2017 06:36:49.9: Cycle Efficiency: 100.0% 26-Sep-2017 06:36:50.1: ++ Auto Focus ++ 26-Sep-2017 06:36:50.1: Doing periodic autofocus. 26-Sep-2017 06:36:50.1: Start special ACP AutoFocus script for scheduler 26-Sep-2017 06:37:00.1: Sequencer is now active 26-Sep-2017 06:39:34.4: Sequencer is no longer active 26-Sep-2017 06:39:34.4: ** Autofocus failed (n=10), will retry ASAP after 20 min. 26-Sep-2017 06:39:34.5: SelectRunning: No running plans 26-Sep-2017 06:39:34.5: STRICT VETO: 26-Sep-2017 06:39:34.5: Obs IRAS_19183+2339 in Plan IRAS_19183+2339 was vetoed by AirmassRange constraint. 26-Sep-2017 06:39:34.5: AirmassRange estimates ready after 26-Sep-2017 21:29:52 UTC 26-Sep-2017 06:39:34.5: STRICT VETO: 26-Sep-2017 06:39:34.5: Obs M56 in Plan M56 was vetoed by AirmassRange constraint. 26-Sep-2017 06:39:34.5: AirmassRange estimates ready after 26-Sep-2017 21:13:29 UTC 26-Sep-2017 06:39:34.6: Efficiency: Selecting from 10 pending plans: 26-Sep-2017 06:39:34.6: Selected Plan FY_Cam (TotEff=0.71) 26-Sep-2017 06:39:34.7: Dispatcher cycle time: 0.2470142 sec. 26-Sep-2017 06:39:34.7: Acquire data for Observation FY_Cam... 26-Sep-2017 06:39:34.7: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FY_Cam) 26-Sep-2017 06:39:34.7: Send Observation FY_Cam to ACP Sequencer 26-Sep-2017 06:39:44.7: Sequencer is now active 26-Sep-2017 06:54:20.2: Sequencer is no longer active 26-Sep-2017 06:54:20.2: Post-job status check done (stat=Completed) 26-Sep-2017 06:54:20.2: Acquisition time: 885.4546451 sec. 26-Sep-2017 06:54:20.2: Data for Observation FY_Cam acquired successfully. 26-Sep-2017 06:54:20.2: Image Efficiency: 44.0% 26-Sep-2017 06:54:20.2: Cycle Efficiency: 100.0% 26-Sep-2017 06:54:20.4: SelectRunning: No running plans 26-Sep-2017 06:54:20.4: Efficiency: Selecting from 10 pending plans: 26-Sep-2017 06:54:20.5: Selected Plan GSC_4030_204 (TotEff=0.68) 26-Sep-2017 06:54:20.5: Dispatcher cycle time: 0.1830104 sec. 26-Sep-2017 06:54:20.5: Acquire data for Observation GSC_4030_204... 26-Sep-2017 06:54:20.5: (belongs to Project Staels, Plan GSC_4030_204) 26-Sep-2017 06:54:20.5: Send Observation GSC_4030_204 to ACP Sequencer 26-Sep-2017 06:54:30.5: Sequencer is now active 26-Sep-2017 06:56:49.2: Sequencer is no longer active 26-Sep-2017 06:56:49.2: Post-job status check done (stat=Completed) 26-Sep-2017 06:56:49.2: Acquisition time: 148.6585028 sec. 26-Sep-2017 06:56:49.2: Data for Observation GSC_4030_204 acquired successfully. 26-Sep-2017 06:56:49.2: Image Efficiency: 20.2% 26-Sep-2017 06:56:49.2: Cycle Efficiency: 99.9% 26-Sep-2017 06:56:49.4: SelectRunning: No running plans 26-Sep-2017 06:56:49.5: Efficiency: Selecting from 9 pending plans: 26-Sep-2017 06:56:49.6: Selected Plan AF_And (TotEff=0.68) 26-Sep-2017 06:56:49.6: Dispatcher cycle time: 0.1760101 sec. 26-Sep-2017 06:56:49.6: Acquire data for Observation AF_And... 26-Sep-2017 06:56:49.6: (belongs to Project AAVSO_UIS01_AF_And, Plan AF_And) 26-Sep-2017 06:56:49.6: Send Observation AF_And to ACP Sequencer 26-Sep-2017 06:56:59.6: Sequencer is now active 26-Sep-2017 07:26:17.3: Sequencer is no longer active 26-Sep-2017 07:26:17.3: Post-job status check done (stat=Completed) 26-Sep-2017 07:26:17.3: Acquisition time: 1767.6401033 sec. 26-Sep-2017 07:26:17.3: Data for Observation AF_And acquired successfully. 26-Sep-2017 07:26:17.3: Image Efficiency: 73.5% 26-Sep-2017 07:26:17.3: Cycle Efficiency: 100.0% 26-Sep-2017 07:26:17.4: ++ Auto Focus ++ 26-Sep-2017 07:26:17.5: Doing periodic autofocus. 26-Sep-2017 07:26:17.5: Start special ACP AutoFocus script for scheduler 26-Sep-2017 07:26:27.5: Sequencer is now active 26-Sep-2017 07:28:09.6: Sequencer is no longer active 26-Sep-2017 07:28:09.6: ** Autofocus failed (n=11), will retry ASAP after 20 min. 26-Sep-2017 07:28:09.7: SelectRunning: No running plans 26-Sep-2017 07:28:09.8: Efficiency: Selecting from 8 pending plans: 26-Sep-2017 07:28:09.9: Selected Plan V0603_Per (TotEff=0.71) 26-Sep-2017 07:28:09.9: Dispatcher cycle time: 0.1620093 sec. 26-Sep-2017 07:28:09.9: Acquire data for Observation V0603_Per... 26-Sep-2017 07:28:09.9: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V0603_Per) 26-Sep-2017 07:28:09.9: Send Observation V0603_Per to ACP Sequencer 26-Sep-2017 07:28:19.9: Sequencer is now active 26-Sep-2017 07:42:45.3: Sequencer is no longer active 26-Sep-2017 07:42:45.3: Post-job status check done (stat=Completed) 26-Sep-2017 07:42:45.3: Acquisition time: 875.4310718 sec. 26-Sep-2017 07:42:45.3: Data for Observation V0603_Per acquired successfully. 26-Sep-2017 07:42:45.4: Image Efficiency: 44.5% 26-Sep-2017 07:42:45.4: Cycle Efficiency: 100.0% 26-Sep-2017 07:42:45.5: SelectRunning: No running plans 26-Sep-2017 07:42:45.6: Efficiency: Selecting from 7 pending plans: 26-Sep-2017 07:42:45.6: Selected Plan HI_Cam (TotEff=0.72) 26-Sep-2017 07:42:45.7: Dispatcher cycle time: 0.1710098 sec. 26-Sep-2017 07:42:45.7: Acquire data for Observation HI_Cam... 26-Sep-2017 07:42:45.7: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HI_Cam) 26-Sep-2017 07:42:45.7: Send Observation HI_Cam to ACP Sequencer 26-Sep-2017 07:42:56.0: Sequencer is now active 26-Sep-2017 07:56:21.7: Sequencer is no longer active 26-Sep-2017 07:56:21.7: Post-job status check done (stat=Completed) 26-Sep-2017 07:56:21.7: Acquisition time: 816.0376747 sec. 26-Sep-2017 07:56:21.7: Data for Observation HI_Cam acquired successfully. 26-Sep-2017 07:56:21.8: Image Efficiency: 47.8% 26-Sep-2017 07:56:21.8: Cycle Efficiency: 100.0% 26-Sep-2017 07:56:22.3: ++ Auto Focus ++ 26-Sep-2017 07:56:22.3: Doing periodic autofocus. 26-Sep-2017 07:56:22.3: Start special ACP AutoFocus script for scheduler 26-Sep-2017 07:56:32.3: Sequencer is now active 26-Sep-2017 07:59:01.4: Sequencer is no longer active 26-Sep-2017 07:59:01.4: ** Autofocus failed (n=12), will retry ASAP after 20 min. 26-Sep-2017 07:59:01.5: SelectRunning: No running plans 26-Sep-2017 07:59:01.5: Efficiency: Selecting from 6 pending plans: 26-Sep-2017 07:59:01.6: Selected Plan V0965_Per (TotEff=0.74) 26-Sep-2017 07:59:01.6: Dispatcher cycle time: 0.1600091 sec. 26-Sep-2017 07:59:01.6: Acquire data for Observation V0965_Per... 26-Sep-2017 07:59:01.6: (belongs to Project Nova_Monitoring, Plan V0965_Per) 26-Sep-2017 07:59:01.6: Send Observation V0965_Per to ACP Sequencer 26-Sep-2017 07:59:11.6: Sequencer is now active 26-Sep-2017 08:18:52.7: Sequencer is no longer active 26-Sep-2017 08:18:52.7: Post-job status check done (stat=Completed) 26-Sep-2017 08:18:52.7: Acquisition time: 1191.0271228 sec. 26-Sep-2017 08:18:52.7: Data for Observation V0965_Per acquired successfully. 26-Sep-2017 08:18:52.7: Image Efficiency: 75.6% 26-Sep-2017 08:18:52.7: Cycle Efficiency: 100.0% 26-Sep-2017 08:18:52.9: SelectRunning: No running plans 26-Sep-2017 08:18:53.0: Obs QQ_Vul_TMO61 in Plan QQ_Vul was vetoed by AirMass constraint. 26-Sep-2017 08:18:53.0: AirMass estimates ready after 26-Sep-2017 21:26:03 UTC 26-Sep-2017 08:18:53.0: Efficiency: Selecting from 4 pending plans: 26-Sep-2017 08:18:53.0: Selected Plan WZ_Per (TotEff=0.75) 26-Sep-2017 08:18:53.1: Dispatcher cycle time: 0.1200069 sec. 26-Sep-2017 08:18:53.1: Acquire data for Observation WZ_Per... 26-Sep-2017 08:18:53.1: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan WZ_Per) 26-Sep-2017 08:18:53.4: Send Observation WZ_Per to ACP Sequencer 26-Sep-2017 08:19:03.4: Sequencer is now active 26-Sep-2017 08:32:13.3: Sequencer is no longer active 26-Sep-2017 08:32:13.3: Post-job status check done (stat=Completed) 26-Sep-2017 08:32:13.3: Acquisition time: 800.1967686 sec. 26-Sep-2017 08:32:13.3: Data for Observation WZ_Per acquired successfully. 26-Sep-2017 08:32:13.3: Image Efficiency: 48.7% 26-Sep-2017 08:32:13.3: Cycle Efficiency: 100.0% 26-Sep-2017 08:32:14.0: ++ Auto Focus ++ 26-Sep-2017 08:32:14.0: Doing periodic autofocus. 26-Sep-2017 08:32:14.0: Start special ACP AutoFocus script for scheduler 26-Sep-2017 08:32:24.0: Sequencer is now active 26-Sep-2017 08:34:55.1: Sequencer is no longer active 26-Sep-2017 08:34:55.1: ** Autofocus failed (n=13), will retry ASAP after 20 min. 26-Sep-2017 08:34:55.1: SelectRunning: No running plans 26-Sep-2017 08:34:55.1: Efficiency: Selecting from 3 pending plans: 26-Sep-2017 08:34:55.1: Selected Plan HO_Cam (TotEff=0.72) 26-Sep-2017 08:34:55.2: Dispatcher cycle time: 0.1020059 sec. 26-Sep-2017 08:34:55.2: Acquire data for Observation HO_Cam... 26-Sep-2017 08:34:55.2: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HO_Cam) 26-Sep-2017 08:34:55.2: Send Observation HO_Cam to ACP Sequencer 26-Sep-2017 08:35:05.2: Sequencer is now active 26-Sep-2017 08:49:35.7: Sequencer is no longer active 26-Sep-2017 08:49:35.7: Post-job status check done (stat=Completed) 26-Sep-2017 08:49:35.7: Acquisition time: 880.4573593 sec. 26-Sep-2017 08:49:35.7: Data for Observation HO_Cam acquired successfully. 26-Sep-2017 08:49:35.7: Image Efficiency: 44.3% 26-Sep-2017 08:49:35.7: Cycle Efficiency: 100.0% 26-Sep-2017 08:49:36.1: SelectRunning: No running plans 26-Sep-2017 08:49:36.2: Efficiency: Selecting from 3 pending plans: 26-Sep-2017 08:49:36.2: Selected Plan HX_Aur (TotEff=0.70) 26-Sep-2017 08:49:36.2: Dispatcher cycle time: 0.0960055 sec. 26-Sep-2017 08:49:36.2: Acquire data for Observation HX_Aur... 26-Sep-2017 08:49:36.2: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HX_Aur) 26-Sep-2017 08:49:36.2: Send Observation HX_Aur to ACP Sequencer 26-Sep-2017 08:49:46.2: Sequencer is now active 26-Sep-2017 09:03:04.2: Sequencer is no longer active 26-Sep-2017 09:03:04.2: Post-job status check done (stat=Completed) 26-Sep-2017 09:03:04.2: Acquisition time: 808.0112156 sec. 26-Sep-2017 09:03:04.2: Data for Observation HX_Aur acquired successfully. 26-Sep-2017 09:03:04.3: Image Efficiency: 48.3% 26-Sep-2017 09:03:04.3: Cycle Efficiency: 100.0% 26-Sep-2017 09:03:04.5: ++ Auto Focus ++ 26-Sep-2017 09:03:04.5: Doing periodic autofocus. 26-Sep-2017 09:03:04.6: Start special ACP AutoFocus script for scheduler 26-Sep-2017 09:03:14.6: Sequencer is now active 26-Sep-2017 09:05:33.2: Sequencer is no longer active 26-Sep-2017 09:05:33.2: ** Autofocus failed (n=14), will retry ASAP after 20 min. 26-Sep-2017 09:05:33.4: SelectRunning: No running plans 26-Sep-2017 09:05:33.4: Efficiency: Selecting from 4 pending plans: 26-Sep-2017 09:05:33.5: Selected Plan HQ_Aur (TotEff=0.70) 26-Sep-2017 09:05:33.5: Dispatcher cycle time: 0.1260072 sec. 26-Sep-2017 09:05:33.5: Acquire data for Observation HQ_Aur... 26-Sep-2017 09:05:33.5: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HQ_Aur) 26-Sep-2017 09:05:33.5: Send Observation HQ_Aur to ACP Sequencer 26-Sep-2017 09:05:43.6: Sequencer is now active 26-Sep-2017 09:20:11.9: Sequencer is no longer active 26-Sep-2017 09:20:11.9: Post-job status check done (stat=Completed) 26-Sep-2017 09:20:11.9: Acquisition time: 878.3592392 sec. 26-Sep-2017 09:20:11.9: Data for Observation HQ_Aur acquired successfully. 26-Sep-2017 09:20:11.9: Image Efficiency: 44.4% 26-Sep-2017 09:20:11.9: Cycle Efficiency: 100.0% 26-Sep-2017 09:20:12.1: SelectRunning: No running plans 26-Sep-2017 09:20:12.1: Efficiency: Selecting from 4 pending plans: 26-Sep-2017 09:20:12.1: Selected Plan CB_32 (TotEff=0.64) 26-Sep-2017 09:20:12.2: Dispatcher cycle time: 0.1100062 sec. 26-Sep-2017 09:20:12.2: Acquire data for Observation CB_32... 26-Sep-2017 09:20:12.2: (belongs to Project Staels, Plan CB_32) 26-Sep-2017 09:20:12.2: Send Observation CB_32 to ACP Sequencer 26-Sep-2017 09:20:22.2: Sequencer is now active 26-Sep-2017 09:24:39.8: Sequencer is no longer active 26-Sep-2017 09:24:39.8: Post-job status check done (stat=Completed) 26-Sep-2017 09:24:39.8: Acquisition time: 267.6493087 sec. 26-Sep-2017 09:24:39.8: Data for Observation CB_32 acquired successfully. 26-Sep-2017 09:24:39.9: Image Efficiency: 33.6% 26-Sep-2017 09:24:39.9: Cycle Efficiency: 99.9% 26-Sep-2017 09:24:40.3: SelectRunning: No running plans 26-Sep-2017 09:24:40.4: Efficiency: Selecting from 3 pending plans: 26-Sep-2017 09:24:40.4: Selected Plan T_Ori (TotEff=0.65) 26-Sep-2017 09:24:40.4: Dispatcher cycle time: 0.0990057 sec. 26-Sep-2017 09:24:40.4: Acquire data for Observation T_Ori... 26-Sep-2017 09:24:40.4: (belongs to Project AAVSO_Monitoring, Plan T_Ori) 26-Sep-2017 09:24:40.4: Doing 3 sets 26-Sep-2017 09:24:40.4: Send Observation T_Ori to ACP Sequencer 26-Sep-2017 09:24:50.4: Sequencer is now active 26-Sep-2017 09:27:52.6: Sequencer is no longer active 26-Sep-2017 09:27:52.6: Post-job status check done (stat=Completed) 26-Sep-2017 09:27:52.6: Send Observation T_Ori to ACP Sequencer 26-Sep-2017 09:28:02.6: Sequencer is now active 26-Sep-2017 09:30:48.8: Sequencer is no longer active 26-Sep-2017 09:30:48.8: Post-job status check done (stat=Completed) 26-Sep-2017 09:30:48.8: Send Observation T_Ori to ACP Sequencer 26-Sep-2017 09:30:58.8: Sequencer is now active 26-Sep-2017 09:33:43.7: Sequencer is no longer active 26-Sep-2017 09:33:43.7: Post-job status check done (stat=Completed) 26-Sep-2017 09:33:43.8: Acquisition time: 543.2800739 sec. 26-Sep-2017 09:33:43.8: Data for Observation T_Ori acquired successfully. 26-Sep-2017 09:33:43.8: Image Efficiency: 49.7% 26-Sep-2017 09:33:43.8: Cycle Efficiency: 100.0% 26-Sep-2017 09:33:43.9: ++ Auto Focus ++ 26-Sep-2017 09:33:43.9: Doing periodic autofocus. 26-Sep-2017 09:33:43.9: Start special ACP AutoFocus script for scheduler 26-Sep-2017 09:33:53.9: Sequencer is now active 26-Sep-2017 09:36:29.1: Sequencer is no longer active 26-Sep-2017 09:36:29.1: ** Autofocus failed (n=15), will retry ASAP after 20 min. 26-Sep-2017 09:36:29.1: SelectRunning: No running plans 26-Sep-2017 09:36:29.1: Efficiency: Selecting from 3 pending plans: 26-Sep-2017 09:36:29.1: Selected Plan V0959_Mon (TotEff=0.54) 26-Sep-2017 09:36:29.2: Dispatcher cycle time: 0.1020059 sec. 26-Sep-2017 09:36:29.2: Acquire data for Observation V0959_Mon... 26-Sep-2017 09:36:29.2: (belongs to Project Nova_Monitoring, Plan V0959_Mon) 26-Sep-2017 09:36:29.2: Send Observation V0959_Mon to ACP Sequencer 26-Sep-2017 09:36:39.2: Sequencer is now active 26-Sep-2017 09:52:39.5: Sequencer is no longer active 26-Sep-2017 09:52:39.5: Post-job status check done (stat=Completed) 26-Sep-2017 09:52:39.5: Acquisition time: 970.3455006 sec. 26-Sep-2017 09:52:39.5: Data for Observation V0959_Mon acquired successfully. 26-Sep-2017 09:52:39.6: Image Efficiency: 64.9% 26-Sep-2017 09:52:39.6: Cycle Efficiency: 100.0% 26-Sep-2017 09:52:40.3: SelectRunning: No running plans 26-Sep-2017 09:52:40.3: Efficiency: Selecting from 3 pending plans: 26-Sep-2017 09:52:40.3: Selected Plan DN_Lyn (TotEff=0.56) 26-Sep-2017 09:52:40.4: Dispatcher cycle time: 0.1070061 sec. 26-Sep-2017 09:52:40.4: Acquire data for Observation DN_Lyn... 26-Sep-2017 09:52:40.4: (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan DN_Lyn) 26-Sep-2017 09:52:40.4: Send Observation DN_Lyn to ACP Sequencer 26-Sep-2017 09:52:50.4: Sequencer is now active 26-Sep-2017 10:05:51.7: Sequencer is no longer active 26-Sep-2017 10:05:51.7: Post-job status check done (stat=Completed) 26-Sep-2017 10:05:51.7: Acquisition time: 791.3002598 sec. 26-Sep-2017 10:05:51.7: Data for Observation DN_Lyn acquired successfully. 26-Sep-2017 10:05:51.7: Image Efficiency: 49.3% 26-Sep-2017 10:05:51.7: Cycle Efficiency: 100.0% 26-Sep-2017 10:05:51.9: ++ Auto Focus ++ 26-Sep-2017 10:05:51.9: Doing periodic autofocus. 26-Sep-2017 10:05:51.9: Start special ACP AutoFocus script for scheduler 26-Sep-2017 10:06:01.9: Sequencer is now active 26-Sep-2017 10:09:43.0: Sequencer is no longer active 26-Sep-2017 10:09:43.1: ** Autofocus failed (n=16), will retry ASAP after 20 min. 26-Sep-2017 10:09:43.2: SelectRunning: No running plans 26-Sep-2017 10:09:43.2: Efficiency: Selecting from 2 pending plans: 26-Sep-2017 10:09:43.2: Selected Plan MP_Gem (TotEff=0.59) 26-Sep-2017 10:09:43.2: Dispatcher cycle time: 0.0880051 sec. 26-Sep-2017 10:09:43.2: Acquire data for Observation MP_Gem... 26-Sep-2017 10:09:43.2: (belongs to Project Staels, Plan MP_Gem) 26-Sep-2017 10:09:43.2: Send Observation MP_Gem to ACP Sequencer 26-Sep-2017 10:09:53.2: Sequencer is now active 26-Sep-2017 10:42:06.8: Sequencer is no longer active 26-Sep-2017 10:42:06.8: Post-job status check done (stat=Completed) 26-Sep-2017 10:42:06.8: Acquisition time: 1943.5361639 sec. 26-Sep-2017 10:42:06.8: Data for Observation MP_Gem acquired successfully. 26-Sep-2017 10:42:06.8: Image Efficiency: 74.1% 26-Sep-2017 10:42:06.8: Cycle Efficiency: 100.0% 26-Sep-2017 10:42:06.9: ++ Auto Focus ++ 26-Sep-2017 10:42:06.9: Doing periodic autofocus. 26-Sep-2017 10:42:06.9: Start special ACP AutoFocus script for scheduler 26-Sep-2017 10:42:16.9: Sequencer is now active 26-Sep-2017 10:44:45.7: Sequencer is no longer active 26-Sep-2017 10:44:45.7: ** Autofocus failed (n=17), will retry ASAP after 20 min. 26-Sep-2017 10:44:45.7: SelectRunning: No running plans 26-Sep-2017 10:44:45.7: Efficiency: Only one pending plan SDSS073224, it is the "best" 26-Sep-2017 10:44:45.7: Dispatcher cycle time: 0.0620035 sec. 26-Sep-2017 10:44:45.7: Acquire data for Observation SDSS073224... 26-Sep-2017 10:44:45.7: (belongs to Project AGN, Plan SDSS073224) 26-Sep-2017 10:44:45.7: Send Observation SDSS073224 to ACP Sequencer 26-Sep-2017 10:44:55.7: Sequencer is now active 26-Sep-2017 11:39:48.9: Sequencer is no longer active 26-Sep-2017 11:39:48.9: Post-job status check done (stat=Completed) 26-Sep-2017 11:39:48.9: Acquisition time: 3303.1499294 sec. 26-Sep-2017 11:39:48.9: Data for Observation SDSS073224 acquired successfully. 26-Sep-2017 11:39:48.9: Image Efficiency: 72.7% 26-Sep-2017 11:39:48.9: Cycle Efficiency: 100.0% 26-Sep-2017 11:39:49.0: ++ Auto Focus ++ 26-Sep-2017 11:39:49.1: Doing periodic autofocus. 26-Sep-2017 11:39:49.1: Start special ACP AutoFocus script for scheduler 26-Sep-2017 11:39:59.1: Sequencer is now active 26-Sep-2017 11:42:44.5: Sequencer is no longer active 26-Sep-2017 11:42:44.5: ** Autofocus failed (n=18), will retry ASAP after 20 min. 26-Sep-2017 11:42:44.5: SelectRunning: No running plans 26-Sep-2017 11:42:44.5: No pending plans that can be started now. 26-Sep-2017 11:42:44.5: Dispatcher cycle time: 0.0140008 sec. 26-Sep-2017 11:43:15.0: SelectRunning: No running plans 26-Sep-2017 11:43:15.0: No pending plans that can be started now. 26-Sep-2017 11:43:15.0: Dispatcher cycle time: 0.0130007 sec. 26-Sep-2017 11:43:45.1: SelectRunning: No running plans 26-Sep-2017 11:43:45.1: No pending plans that can be started now. 26-Sep-2017 11:43:45.1: Dispatcher cycle time: 0.0150008 sec. 26-Sep-2017 11:44:15.3: SelectRunning: No running plans 26-Sep-2017 11:44:15.3: No pending plans that can be started now. 26-Sep-2017 11:44:15.3: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 11:44:45.9: SelectRunning: No running plans 26-Sep-2017 11:44:45.9: No pending plans that can be started now. 26-Sep-2017 11:44:45.9: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 11:45:16.3: SelectRunning: No running plans 26-Sep-2017 11:45:16.3: No pending plans that can be started now. 26-Sep-2017 11:45:16.3: Dispatcher cycle time: 0.0130008 sec. 26-Sep-2017 11:45:46.5: SelectRunning: No running plans 26-Sep-2017 11:45:46.5: No pending plans that can be started now. 26-Sep-2017 11:45:46.5: Dispatcher cycle time: 0.0130008 sec. 26-Sep-2017 11:46:17.0: SelectRunning: No running plans 26-Sep-2017 11:46:17.0: No pending plans that can be started now. 26-Sep-2017 11:46:17.0: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 11:46:47.8: SelectRunning: No running plans 26-Sep-2017 11:46:47.8: No pending plans that can be started now. 26-Sep-2017 11:46:47.8: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 11:47:18.1: SelectRunning: No running plans 26-Sep-2017 11:47:18.1: No pending plans that can be started now. 26-Sep-2017 11:47:18.1: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 11:47:48.3: SelectRunning: No running plans 26-Sep-2017 11:47:48.3: No pending plans that can be started now. 26-Sep-2017 11:47:48.3: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 11:48:18.9: SelectRunning: No running plans 26-Sep-2017 11:48:18.9: No pending plans that can be started now. 26-Sep-2017 11:48:18.9: Dispatcher cycle time: 0.0140008 sec. 26-Sep-2017 11:48:49.0: SelectRunning: No running plans 26-Sep-2017 11:48:49.0: No pending plans that can be started now. 26-Sep-2017 11:48:49.0: Dispatcher cycle time: 0.0100006 sec. 26-Sep-2017 11:49:19.7: SelectRunning: No running plans 26-Sep-2017 11:49:19.7: No pending plans that can be started now. 26-Sep-2017 11:49:19.7: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:49:49.9: SelectRunning: No running plans 26-Sep-2017 11:49:49.9: No pending plans that can be started now. 26-Sep-2017 11:49:49.9: Dispatcher cycle time: 0.0120006 sec. 26-Sep-2017 11:50:20.0: SelectRunning: No running plans 26-Sep-2017 11:50:20.0: No pending plans that can be started now. 26-Sep-2017 11:50:20.0: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:50:50.3: SelectRunning: No running plans 26-Sep-2017 11:50:50.3: No pending plans that can be started now. 26-Sep-2017 11:50:50.3: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:51:20.4: SelectRunning: No running plans 26-Sep-2017 11:51:20.4: No pending plans that can be started now. 26-Sep-2017 11:51:20.4: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:51:50.6: SelectRunning: No running plans 26-Sep-2017 11:51:50.6: No pending plans that can be started now. 26-Sep-2017 11:51:50.6: Dispatcher cycle time: 0.0120006 sec. 26-Sep-2017 11:52:21.3: SelectRunning: No running plans 26-Sep-2017 11:52:21.3: No pending plans that can be started now. 26-Sep-2017 11:52:21.3: Dispatcher cycle time: 0.0140008 sec. 26-Sep-2017 11:52:51.5: SelectRunning: No running plans 26-Sep-2017 11:52:51.5: No pending plans that can be started now. 26-Sep-2017 11:52:51.5: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 11:53:21.6: SelectRunning: No running plans 26-Sep-2017 11:53:21.6: No pending plans that can be started now. 26-Sep-2017 11:53:21.6: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:53:51.8: SelectRunning: No running plans 26-Sep-2017 11:53:51.8: No pending plans that can be started now. 26-Sep-2017 11:53:51.8: Dispatcher cycle time: 0.0150008 sec. 26-Sep-2017 11:54:21.9: SelectRunning: No running plans 26-Sep-2017 11:54:21.9: No pending plans that can be started now. 26-Sep-2017 11:54:21.9: Dispatcher cycle time: 0.0120006 sec. 26-Sep-2017 11:54:52.1: SelectRunning: No running plans 26-Sep-2017 11:54:52.1: No pending plans that can be started now. 26-Sep-2017 11:54:52.1: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 11:55:23.0: SelectRunning: No running plans 26-Sep-2017 11:55:23.0: No pending plans that can be started now. 26-Sep-2017 11:55:23.0: Dispatcher cycle time: 0.018001 sec. 26-Sep-2017 11:55:53.1: SelectRunning: No running plans 26-Sep-2017 11:55:53.1: No pending plans that can be started now. 26-Sep-2017 11:55:53.1: Dispatcher cycle time: 0.0120006 sec. 26-Sep-2017 11:56:23.2: SelectRunning: No running plans 26-Sep-2017 11:56:23.2: No pending plans that can be started now. 26-Sep-2017 11:56:23.3: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:56:53.4: SelectRunning: No running plans 26-Sep-2017 11:56:53.4: No pending plans that can be started now. 26-Sep-2017 11:56:53.4: Dispatcher cycle time: 0.0120006 sec. 26-Sep-2017 11:57:23.5: SelectRunning: No running plans 26-Sep-2017 11:57:23.5: No pending plans that can be started now. 26-Sep-2017 11:57:23.5: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:57:54.1: SelectRunning: No running plans 26-Sep-2017 11:57:54.1: Plan M67 would extend past daylight, deferred to next night 26-Sep-2017 11:57:54.1: No pending plans that can be started now. 26-Sep-2017 11:57:54.1: Dispatcher cycle time: 0.0140008 sec. 26-Sep-2017 11:58:24.2: SelectRunning: No running plans 26-Sep-2017 11:58:24.2: No pending plans that can be started now. 26-Sep-2017 11:58:24.2: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:58:54.4: SelectRunning: No running plans 26-Sep-2017 11:58:54.4: No pending plans that can be started now. 26-Sep-2017 11:58:54.4: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:59:24.6: SelectRunning: No running plans 26-Sep-2017 11:59:24.6: No pending plans that can be started now. 26-Sep-2017 11:59:24.6: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 11:59:55.1: SelectRunning: No running plans 26-Sep-2017 11:59:55.1: No pending plans that can be started now. 26-Sep-2017 11:59:55.1: Dispatcher cycle time: 0.0130007 sec. 26-Sep-2017 12:00:25.2: SelectRunning: No running plans 26-Sep-2017 12:00:25.2: No pending plans that can be started now. 26-Sep-2017 12:00:25.2: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 12:00:55.4: SelectRunning: No running plans 26-Sep-2017 12:00:55.4: No pending plans that can be started now. 26-Sep-2017 12:00:55.4: Dispatcher cycle time: 0.0130007 sec. 26-Sep-2017 12:01:25.6: SelectRunning: No running plans 26-Sep-2017 12:01:25.6: No pending plans that can be started now. 26-Sep-2017 12:01:25.6: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 12:01:55.7: SelectRunning: No running plans 26-Sep-2017 12:01:55.7: No pending plans that can be started now. 26-Sep-2017 12:01:55.7: Dispatcher cycle time: 0.0120007 sec. 26-Sep-2017 12:02:25.9: SelectRunning: No running plans 26-Sep-2017 12:02:25.9: No pending plans that can be started now. 26-Sep-2017 12:02:25.9: Dispatcher cycle time: 0.0120006 sec. 26-Sep-2017 12:02:56.2: ++ Auto Focus ++ 26-Sep-2017 12:02:56.2: Doing periodic autofocus. 26-Sep-2017 12:02:56.2: Start special ACP AutoFocus script for scheduler 26-Sep-2017 12:03:06.2: Sequencer is now active 26-Sep-2017 12:04:16.9: Sequencer is no longer active 26-Sep-2017 12:04:16.9: ** Autofocus failed (n=19), will retry ASAP after 20 min. 26-Sep-2017 12:04:16.9: SelectRunning: No running plans 26-Sep-2017 12:04:16.9: No pending plans that can be started now. 26-Sep-2017 12:04:16.9: Dispatcher cycle time: 0.0110006 sec. 26-Sep-2017 12:04:47.6: SelectRunning: No running plans 26-Sep-2017 12:04:47.6: No pending plans that can be started now. 26-Sep-2017 12:04:47.6: Dispatcher cycle time: 0.0120006 sec. 26-Sep-2017 12:05:18.4: ++ Dawn Flats ++ 26-Sep-2017 12:05:18.4: Start ACP AutoFlat script for Dawn 26-Sep-2017 12:05:28.5: Sequencer is now active 26-Sep-2017 12:22:44.2: ** Script interrupted by weather safety event. 26-Sep-2017 12:22:44.5: -- Weather Unsafe -- 26-Sep-2017 12:22:45.5: -- Observatory Shutdown -- 26-Sep-2017 12:22:45.8: Weather disconnected. 26-Sep-2017 12:22:45.9: Start ACP Sequencer's ShutdownObs script 26-Sep-2017 12:22:46.4: WARNING: Request sent while Weather Safety Script is running 26-Sep-2017 12:23:46.6: WARNING: Request sent while Weather Safety Script is running 26-Sep-2017 12:24:56.7: Sequencer is now active 26-Sep-2017 12:27:00.0: Sequencer is no longer active 26-Sep-2017 12:27:15.7: Weather successfully connected. Wait for valid data... 26-Sep-2017 12:32:47.4: ++ Weather Safe ++ 26-Sep-2017 13:30:33.3: Dispatcher stopped at 26-Sep-2017 13:30:33 UTC 26-Sep-2017 13:30:33.3: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 26-Sep-2017 13:52:14.9: -- Weather Unsafe -- 26-Sep-2017 14:30:45.1: ++ Weather Safe ++ 26-Sep-2017 15:24:52.4: -- Weather Unsafe -- 26-Sep-2017 17:15:37.7: ++ Weather Safe ++ 26-Sep-2017 19:58:35.2: -- Weather Unsafe -- 26-Sep-2017 22:36:12.3: ++ Weather Safe ++ 26-Sep-2017 23:08:52.1: -- Weather Unsafe -- 27-Sep-2017 03:57:03.2: ++ Weather Safe ++ 27-Sep-2017 04:11:08.2: -- Weather Unsafe -- 27-Sep-2017 04:42:01.2: ++ Weather Safe ++ 27-Sep-2017 05:05:39.6: -- Weather Unsafe -- 27-Sep-2017 07:01:19.6: ++ Weather Safe ++ 27-Sep-2017 07:19:00.1: -- Weather Unsafe -- 27-Sep-2017 09:24:06.1: ++ Weather Safe ++ 27-Sep-2017 09:38:52.9: -- Weather Unsafe -- 27-Sep-2017 10:24:58.2: ++ Weather Safe ++ 27-Sep-2017 10:31:01.9: -- Weather Unsafe -- 27-Sep-2017 22:51:16.0: ++ Weather Safe ++ 27-Sep-2017 22:51:18.1: -- Weather Unsafe -- 28-Sep-2017 01:06:59.3: ++ Weather Safe ++ 28-Sep-2017 01:07:46.4: -- Weather Unsafe -- 29-Sep-2017 05:52:28.6: ++ Weather Safe ++ 29-Sep-2017 06:37:34.9: -- Weather Unsafe -- 29-Sep-2017 08:26:57.8: ++ Weather Safe ++ 29-Sep-2017 11:34:49.0: -- Weather Unsafe -- 29-Sep-2017 11:54:52.7: ++ Weather Safe ++ 29-Sep-2017 11:59:54.6: -- Weather Unsafe -- 29-Sep-2017 14:21:08.1: ++ Weather Safe ++ 29-Sep-2017 19:47:53.2: -- Weather Unsafe -- 29-Sep-2017 21:58:33.2: ++ Weather Safe ++ 30-Sep-2017 04:02:36.2: -- Weather Unsafe -- 30-Sep-2017 04:52:03.7: ++ Weather Safe ++ 30-Sep-2017 05:15:55.8: -- Weather Unsafe -- 30-Sep-2017 06:14:58.4: ++ Weather Safe ++ 30-Sep-2017 07:53:27.7: -- Weather Unsafe -- 30-Sep-2017 08:43:47.7: ++ Weather Safe ++ 30-Sep-2017 09:45:33.3: -- Weather Unsafe -- 30-Sep-2017 10:14:46.5: ++ Weather Safe ++ 30-Sep-2017 10:37:21.3: -- Weather Unsafe -- 30-Sep-2017 11:26:16.1: ++ Weather Safe ++ 30-Sep-2017 11:37:05.6: -- Weather Unsafe -- 30-Sep-2017 16:22:59.7: ++ Weather Safe ++ 30-Sep-2017 16:36:31.2: -- Weather Unsafe -- 30-Sep-2017 18:09:50.6: ++ Weather Safe ++ 30-Sep-2017 18:57:14.4: -- Weather Unsafe -- 30-Sep-2017 22:55:44.2: ++ Weather Safe ++ 30-Sep-2017 23:33:03.3: COMException while trying to get ACP Weather.Available. Probably operator script abort. 30-Sep-2017 23:33:03.3: 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)) 30-Sep-2017 23:33:04.3: COMException while trying to get ACP Weather.Available. Probably operator script abort. 30-Sep-2017 23:33:04.3: 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)) 30-Sep-2017 23:33:05.3: COMException while trying to get ACP Weather.Available. Probably operator script abort. 30-Sep-2017 23:33:05.3: 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)) 30-Sep-2017 23:33:06.3: COMException while trying to get ACP Weather.Available. Probably operator script abort. 30-Sep-2017 23:33:06.3: 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)) 30-Sep-2017 23:33:07.3: COMException while trying to get ACP Weather.Available. Probably operator script abort. 30-Sep-2017 23:33:07.3: The object invoked has disconnected from its clients. (Exception from HRESULT: 0x80010108 (RPC_E_DISCONNECTED)) 30-Sep-2017 23:33:08.3: **EXCEPTION IN SCHEDULER: 30-Sep-2017 23:33:08.3: ConnectWeather() waited for over 5 seconds to read Weather.Available! 30-Sep-2017 23:33:08.3: Traceback: at DC3.Scheduler.ACPSequencer.ConnectWeather() at DC3.Scheduler.Engine.PollWeather() at DC3.Scheduler.Engine.Run() 30-Sep-2017 23:33:08.4: Run statistics: 30-Sep-2017 23:33:08.4: Observations: 52 30-Sep-2017 23:33:08.4: Considered: 45 30-Sep-2017 23:33:08.4: Completed: 31 30-Sep-2017 23:33:08.4: Skipped: 12 30-Sep-2017 23:33:08.4: Never Eligible: 7 30-Sep-2017 23:33:08.4: Failed: 2 30-Sep-2017 23:33:08.4: Shutter-Open efficiency: 56.45% 30-Sep-2017 23:33:08.4: Overall Efficiency: 99.90% 30-Sep-2017 23:33:08.4: Release ACP sequencer 30-Sep-2017 23:33:08.4: Failed to stop sequencer: 30-Sep-2017 23:33:08.4: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA) Log closed at Sat, Sep 30 2017 23:33:10 UTC (actual time)