Log opened at Tue, Dec 18 2012 01:33:10 UTC (actual time)
Current log level is Debug
Scheduler version 3.5.3
Multi-user license: Arne Henden
18-Dec-2012 01:33:10.0: Simulated clock initialized at 18-Dec-2012 01:33:10 UTC
18-Dec-2012 01:33:10.0: Loaded Constraint plugin AirMass
18-Dec-2012 01:33:10.0: Loaded Constraint plugin AirmassRange
18-Dec-2012 01:33:10.0: Loaded Constraint plugin Horizon
18-Dec-2012 01:33:10.0: Loaded Constraint plugin HourAngle
18-Dec-2012 01:33:10.0: Loaded Constraint plugin MoonAvoid
18-Dec-2012 01:33:10.0: Loaded Constraint plugin MoonDown
18-Dec-2012 01:33:10.1: Loaded Constraint plugin SkyCondition
18-Dec-2012 01:33:10.1: Loaded Constraint plugin TimeRange
18-Dec-2012 01:33:10.6: 90 plans are now pending.
18-Dec-2012 01:33:10.6: Attach ACP sequencer
18-Dec-2012 01:33:17.1: Weather successfully connected. Wait for valid data...
18-Dec-2012 01:34:32.9: Dispatcher started at 18-Dec-2012 01:34:32 UTC
18-Dec-2012 01:34:32.9:     Priority:          W[0]=1.00
18-Dec-2012 01:34:32.9:     Transit Altitude:  W[1]=0.00
18-Dec-2012 01:34:32.9:     Highest Altitude:  W[6]=0.00
18-Dec-2012 01:34:32.9:     Lateness:          W[5]=0.70
18-Dec-2012 01:34:32.9:     Slew Distance:     W[2]=0.30
18-Dec-2012 01:34:32.9:     Retry Count:       W[3]=0.20
18-Dec-2012 01:34:32.9:     Meridian Crossing: W[4]=0.30
18-Dec-2012 01:34:32.9:     Obs Conditions:    W[7]=0.40
18-Dec-2012 01:34:32.9:     Rising Plan Delay: disabled
18-Dec-2012 01:34:33.8: ++ Observatory Startup ++
18-Dec-2012 01:34:33.8: Start ACP Sequencer's StartupObs script
18-Dec-2012 01:34:43.9: Sequencer is now active
18-Dec-2012 01:34:49.7: Sequencer is no longer active
18-Dec-2012 01:34:49.7: ++ Auto Focus ++
18-Dec-2012 01:34:49.7: Doing initial autofocus.
18-Dec-2012 01:34:49.7: Start special ACP AutoFocus script for scheduler
18-Dec-2012 01:34:59.7: Sequencer is now active
18-Dec-2012 01:35:05.2: Sequencer is no longer active
18-Dec-2012 01:35:05.2: ** Autofocus failed (n=1), will retry ASAP after 0 min.
18-Dec-2012 01:35:06.8: SelectRunning: No running plans
18-Dec-2012 01:35:06.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:06.9: Obs 1RXS_J0232388-371812 in Plan 1RXS_J0232388-371812 was failed by AirmassRange constraint.
18-Dec-2012 01:35:06.9: Obs 1RXS_J1050103-140431 in Plan 1RXS_J1050103-140431 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:06.9:     AirmassRange estimates ready after 18-Dec-2012 09:27:21 UTC
18-Dec-2012 01:35:06.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:06.9: Obs ASAS_J160048-48462 in Plan ASAS_J160048-48462 was failed by AirmassRange constraint.
18-Dec-2012 01:35:06.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:06.9: Obs AX_For in Plan AX_For was failed by AirmassRange constraint.
18-Dec-2012 01:35:06.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:06.9: Obs BB_Dor in Plan BB_Dor was failed by AirmassRange constraint.
18-Dec-2012 01:35:06.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:06.9: Obs BD Pav in Plan BD_Pav was failed by AirmassRange constraint.
18-Dec-2012 01:35:06.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:06.9: Obs CC_Scl in Plan CC_Scl was failed by AirmassRange constraint.
18-Dec-2012 01:35:06.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:06.9: Obs CU_Vel in Plan CU_Vel was failed by AirmassRange constraint.
18-Dec-2012 01:35:06.9: Obs CW_Mon in Plan CW_Mon was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:06.9:     AirmassRange estimates ready after 18-Dec-2012 04:19:12 UTC
18-Dec-2012 01:35:06.9: Obs CW_Mon in Plan CW_Mon was vetoed by AirMass constraint.
18-Dec-2012 01:35:06.9:     AirMass estimates ready after 18-Dec-2012 04:19:12 UTC
18-Dec-2012 01:35:06.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:06.9: Obs DT_Oct in Plan DT_Oct was failed by AirmassRange constraint.
18-Dec-2012 01:35:06.9: Obs GW_Lib in Plan GW_Lib was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:06.9:     AirmassRange estimates ready after 18-Dec-2012 15:20:02 UTC
18-Dec-2012 01:35:06.9: Obs HM_Leo in Plan HM_Leo was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:06.9:     AirmassRange estimates ready after 18-Dec-2012 06:59:47 UTC
18-Dec-2012 01:35:07.0: Obs IR_Com in Plan IR_Com was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 09:27:51 UTC
18-Dec-2012 01:35:07.0: Obs IU_Leo in Plan IU_Leo was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 08:13:22 UTC
18-Dec-2012 01:35:07.0: Obs IY_UMa in Plan IY_UMa was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 06:24:32 UTC
18-Dec-2012 01:35:07.0: Obs LN_UMa in Plan LN_UMa was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 05:28:09 UTC
18-Dec-2012 01:35:07.0: Obs LT_Eri in Plan LT_Eri was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 02:13:16 UTC
18-Dec-2012 01:35:07.0: Obs MR UMa in Plan MR_UMa was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 07:38:10 UTC
18-Dec-2012 01:35:07.0: Obs PU_CMa in Plan PU_CMa was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 06:34:37 UTC
18-Dec-2012 01:35:07.0: Obs QZ_Lib in Plan QZ_Lib was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 13:47:56 UTC
18-Dec-2012 01:35:07.0: Obs QZ_Ser in Plan QZ_Ser was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 12:44:43 UTC
18-Dec-2012 01:35:07.0: Obs RZ_Leo in Plan RZ_Leo was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 09:13:25 UTC
18-Dec-2012 01:35:07.0: Obs SA100_267 in Plan SA100_267 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.0:     AirmassRange estimates ready after 18-Dec-2012 08:04:11 UTC
18-Dec-2012 01:35:07.1: Obs SA100_267 in Plan SA100_267 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 05:56:07 UTC
18-Dec-2012 01:35:07.1: Obs SA103 in Plan SA103 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 08:57:39 UTC
18-Dec-2012 01:35:07.1: Obs SA103 in Plan SA103 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 11:05:33 UTC
18-Dec-2012 01:35:07.1: Obs SA106 in Plan SA106 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 11:41:33 UTC
18-Dec-2012 01:35:07.1: Obs SA106 in Plan SA106 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 13:48:51 UTC
18-Dec-2012 01:35:07.1: Obs SA109 in Plan SA109 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 16:52:16 UTC
18-Dec-2012 01:35:07.1: Obs SA109 in Plan SA109 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 14:45:10 UTC
18-Dec-2012 01:35:07.1: Obs SA110 in Plan SA110 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 17:46:22 UTC
18-Dec-2012 01:35:07.1: Obs SA110 in Plan SA110 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 15:40:13 UTC
18-Dec-2012 01:35:07.1: Obs SA111 in Plan SA111 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 16:35:48 UTC
18-Dec-2012 01:35:07.1: Obs SA111 in Plan SA111 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 18:42:08 UTC
18-Dec-2012 01:35:07.1: Obs SA1119 in Plan SA1119 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 18:41:26 UTC
18-Dec-2012 01:35:07.1: Obs SA1119 in Plan SA1119 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 16:35:33 UTC
18-Dec-2012 01:35:07.1: Obs SA112_810 in Plan SA112_810 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 19:47:08 UTC
18-Dec-2012 01:35:07.1: Obs SA112_810 in Plan SA112_810 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 01:37:24 UTC
18-Dec-2012 01:35:07.1: Obs SA116_180 in Plan SA116_180 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 04:16:11 UTC
18-Dec-2012 01:35:07.1: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:07.1: Obs SA116_180 in Plan SA116_180 was failed by AirmassRange constraint.
18-Dec-2012 01:35:07.1: Obs SA124_970 in Plan SA124_970 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.1:     AirmassRange estimates ready after 18-Dec-2012 06:12:39 UTC
18-Dec-2012 01:35:07.2: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:07.2: Obs SA124_970 in Plan SA124_970 was failed by AirmassRange constraint.
18-Dec-2012 01:35:07.2: Obs SA132 in Plan SA132 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 14:08:58 UTC
18-Dec-2012 01:35:07.2: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:07.2: Obs SA132 in Plan SA132 was failed by AirmassRange constraint.
18-Dec-2012 01:35:07.2: Obs SA44_28 in Plan SA44_28 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 06:33:44 UTC
18-Dec-2012 01:35:07.2: Obs SA52_56 in Plan SA52_56 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 04:22:05 UTC
18-Dec-2012 01:35:07.2: Obs SA52_56 in Plan SA52_56 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 06:19:45 UTC
18-Dec-2012 01:35:07.2: Obs SA61 in Plan SA61 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 14:49:07 UTC
18-Dec-2012 01:35:07.2: Obs SA61 in Plan SA61 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 12:51:02 UTC
18-Dec-2012 01:35:07.2: Obs SA68_216 in Plan SA68_216 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 05:53:00 UTC
18-Dec-2012 01:35:07.2: Obs SA84 in Plan SA84 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 12:39:19 UTC
18-Dec-2012 01:35:07.2: Obs SA84 in Plan SA84 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 14:32:51 UTC
18-Dec-2012 01:35:07.2: Obs SA93_317 in Plan SA93_317 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 06:49:41 UTC
18-Dec-2012 01:35:07.2: Obs SA96_171 in Plan SA96_171 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 01:53:18 UTC
18-Dec-2012 01:35:07.2: Obs SA96_171 in Plan SA96_171 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.2:     AirmassRange estimates ready after 18-Dec-2012 04:00:18 UTC
18-Dec-2012 01:35:07.3: Obs SA98 in Plan SA98 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 06:02:08 UTC
18-Dec-2012 01:35:07.3: Obs SA98 in Plan SA98 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 03:54:39 UTC
18-Dec-2012 01:35:07.3: Obs SA99_438 in Plan SA99_438 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 07:04:58 UTC
18-Dec-2012 01:35:07.3: Obs SA99_438 in Plan SA99_438 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 04:57:42 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J075507 in Plan SDSS_J075507 was vetoed by AirMass constraint.
18-Dec-2012 01:35:07.3:     AirMass estimates ready after 18-Dec-2012 04:58:31 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J07550770+1435476 in Plan SDSS_J07550770+1435476 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 04:58:31 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J09324957+4725230 in Plan SDSS_J09324957+4725230 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 05:32:51 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J10051538+1911079 in Plan SDSS_J10051538+1911079 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 06:58:07 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J10065840+2337244 in Plan SDSS_J10065840+2337244 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 06:50:36 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J10353303+0551584 in Plan SDSS_J10353303+0551584 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 08:00:15 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J14354402+2336387 in Plan SDSS_J14354402+2336387 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 11:18:39 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J15381735+5123380 in Plan SDSS_J15381735+5123380 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 11:30:19 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J15445360+2553488 in Plan SDSS_J15445360+2553488 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 12:23:04 UTC
18-Dec-2012 01:35:07.3: Obs SDSS_J16424852+1347514 in Plan SDSS_J16424852+1347514 was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 13:46:37 UTC
18-Dec-2012 01:35:07.3: Obs V0380_Oph in Plan V0380_Oph was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 15:13:08 UTC
18-Dec-2012 01:35:07.3: Obs V0406_Vir in Plan V0406_Vir was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 10:31:40 UTC
18-Dec-2012 01:35:07.3: Obs V0482_Cam in Plan V0482_Cam was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.3:     AirmassRange estimates ready after 18-Dec-2012 02:55:13 UTC
18-Dec-2012 01:35:07.4: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 01:35:07.4: Obs V0485_Cen in Plan V0485_Cen was failed by AirmassRange constraint.
18-Dec-2012 01:35:07.4: Obs V1108_Her in Plan V1108_Her was vetoed by AirmassRange constraint.
18-Dec-2012 01:35:07.4:     AirmassRange estimates ready after 18-Dec-2012 15:16:47 UTC
18-Dec-2012 01:35:07.4: Obs V1108_Her in Plan V1108_Her was vetoed by AirMass constraint.
18-Dec-2012 01:35:07.4:     AirMass estimates ready after 18-Dec-2012 15:16:47 UTC
18-Dec-2012 01:35:07.4: Efficiency: Selecting from 14 pending plans:
18-Dec-2012 01:35:07.5:   Selected Plan HS_2214+2845 (TotEff=1.77)
18-Dec-2012 01:35:07.5: Dispatcher cycle time: 2.3556042 sec.
18-Dec-2012 01:35:07.5: Acquire data for Observation HS_2214+2845...
18-Dec-2012 01:35:07.5:   (belongs to Project HST_CV, Plan HS_2214+2845)
18-Dec-2012 01:35:07.5: Send Observation HS_2214+2845 to ACP Sequencer
18-Dec-2012 01:35:17.6: Sequencer is now active
18-Dec-2012 01:41:01.4: Sequencer is no longer active
18-Dec-2012 01:41:01.7: Post-job status check done (stat=Failed)
18-Dec-2012 01:41:01.8: ACP data acquisition failed for Observation HS_2214+2845.
18-Dec-2012 01:41:01.8:   (Observation HS_2214+2845 interrupted by acquisition process failure.)
18-Dec-2012 01:41:01.9: ++ Auto Focus ++
18-Dec-2012 01:41:01.9: Doing periodic autofocus.
18-Dec-2012 01:41:01.9: Start special ACP AutoFocus script for scheduler
18-Dec-2012 01:41:11.9: Sequencer is now active
18-Dec-2012 01:41:17.1: Sequencer is no longer active
18-Dec-2012 01:41:17.1: ** Autofocus failed (n=2), will retry ASAP after 5 min.
18-Dec-2012 01:41:17.1: SelectRunning: No running plans
18-Dec-2012 01:41:17.2: Efficiency: Selecting from 14 pending plans:
18-Dec-2012 01:41:17.3:   Selected Plan SA112_810 (TotEff=2.14)
18-Dec-2012 01:41:17.3: Dispatcher cycle time: 0.2028003 sec.
18-Dec-2012 01:41:17.3: Acquire data for Observation SA112_810...
18-Dec-2012 01:41:17.3:   (belongs to Project Landolt_2, Plan SA112_810)
18-Dec-2012 01:41:17.3: Send Observation SA112_810 to ACP Sequencer
18-Dec-2012 01:41:27.3: Sequencer is now active
18-Dec-2012 01:44:51.6: Dispatcher stopped at 18-Dec-2012 01:44:51 UTC
18-Dec-2012 01:44:51.6: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
18-Dec-2012 01:44:59.6: Sequencer is no longer active
18-Dec-2012 01:44:59.6: ** Sequencer script "AcquireScheduler" failed:
18-Dec-2012 01:44:59.6: **Script Error**
Source:  ACP
Message: The script was aborted. at line 1531 column 5.
Script Context:
    1528:         End If
    1529:     End If
    1530:     
=>  1531:     If Not SUP.AutoGuide(True) Then
              ^
    1532:         If Not IMG Is Nothing Then
    1533:             If IMG.ExposureInterval > Prefs.AutoGuiding.MaxUnguidedExposureInterval Then
    1534:                 If STRICT_AUTOGUIDING And Not PLN.BestEfforts Then
-- end --

18-Dec-2012 01:45:02.7: Post-job status check done (stat=Running)
18-Dec-2012 01:45:02.7: RUN FAILED: Scheduler was stopped during run
18-Dec-2012 01:45:02.7: ACP data acquisition failed for Observation SA112_810.
18-Dec-2012 01:45:02.7:   (Observation SA112_810 interrupted by operator or system.)
18-Dec-2012 03:24:57.7: Dispatcher started at 18-Dec-2012 03:24:57 UTC
18-Dec-2012 03:24:57.7:     Priority:          W[0]=1.00
18-Dec-2012 03:24:57.7:     Transit Altitude:  W[1]=0.00
18-Dec-2012 03:24:57.7:     Highest Altitude:  W[6]=0.00
18-Dec-2012 03:24:57.7:     Lateness:          W[5]=0.70
18-Dec-2012 03:24:57.7:     Slew Distance:     W[2]=0.30
18-Dec-2012 03:24:57.7:     Retry Count:       W[3]=0.20
18-Dec-2012 03:24:57.7:     Meridian Crossing: W[4]=0.30
18-Dec-2012 03:24:57.7:     Obs Conditions:    W[7]=0.40
18-Dec-2012 03:24:57.7:     Rising Plan Delay: disabled
18-Dec-2012 03:24:58.2: ++ Observatory Startup ++
18-Dec-2012 03:24:58.2: Start ACP Sequencer's StartupObs script
18-Dec-2012 03:25:08.2: Sequencer is now active
18-Dec-2012 03:25:13.8: Sequencer is no longer active
18-Dec-2012 03:25:13.8: ++ Auto Focus ++
18-Dec-2012 03:25:13.8: Doing initial autofocus.
18-Dec-2012 03:25:13.8: Start special ACP AutoFocus script for scheduler
18-Dec-2012 03:25:23.8: Sequencer is now active
18-Dec-2012 03:25:29.1: Sequencer is no longer active
18-Dec-2012 03:25:29.1: ** Autofocus failed (n=1), will retry ASAP after 0 min.
18-Dec-2012 03:25:29.1: SelectRunning: No running plans
18-Dec-2012 03:25:29.2: Obs SA96_171 in Plan SA96_171 was vetoed by AirmassRange constraint.
18-Dec-2012 03:25:29.2:     AirmassRange estimates ready after 18-Dec-2012 09:43:15 UTC
18-Dec-2012 03:25:29.2: Efficiency: Selecting from 15 pending plans:
18-Dec-2012 03:25:29.3:   Selected Plan SA68_216 (TotEff=2.09)
18-Dec-2012 03:25:29.3: Dispatcher cycle time: 0.2184004 sec.
18-Dec-2012 03:25:29.3: Acquire data for Observation SA68_216...
18-Dec-2012 03:25:29.3:   (belongs to Project Landolt_1, Plan SA68_216)
18-Dec-2012 03:25:29.3: Send Observation SA68_216 to ACP Sequencer
18-Dec-2012 03:25:39.3: Sequencer is now active
18-Dec-2012 03:30:41.4: Sequencer is no longer active
18-Dec-2012 03:30:41.4: Post-job status check done (stat=Completed)
18-Dec-2012 03:30:41.4: Acquisition time: 312.031748 sec.
18-Dec-2012 03:30:41.4: Data for Observation SA68_216 acquired successfully.
18-Dec-2012 03:30:41.4: Image Efficiency: 30.4%
18-Dec-2012 03:30:41.4: Cycle Efficiency: 99.9%
18-Dec-2012 03:30:41.5: ++ Auto Focus ++
18-Dec-2012 03:30:41.5: Doing periodic autofocus.
18-Dec-2012 03:30:41.5: Start special ACP AutoFocus script for scheduler
18-Dec-2012 03:30:51.5: Sequencer is now active
18-Dec-2012 03:30:57.0: Sequencer is no longer active
18-Dec-2012 03:30:57.0: ** Autofocus failed (n=2), will retry ASAP after 5 min.
18-Dec-2012 03:30:57.0: SelectRunning: No running plans
18-Dec-2012 03:30:57.1: Efficiency: Selecting from 14 pending plans:
18-Dec-2012 03:30:57.2:   Selected Plan SA44_28 (TotEff=2.05)
18-Dec-2012 03:30:57.2: Dispatcher cycle time: 0.1872003 sec.
18-Dec-2012 03:30:57.2: Acquire data for Observation SA44_28...
18-Dec-2012 03:30:57.2:   (belongs to Project Landolt_1, Plan SA44_28)
18-Dec-2012 03:30:57.2: Doing 10 sets
18-Dec-2012 03:30:57.2: Send Observation SA44_28 to ACP Sequencer
18-Dec-2012 03:31:07.3: Sequencer is now active
18-Dec-2012 03:36:42.3: Sequencer is no longer active
18-Dec-2012 03:36:42.3: Post-job status check done (stat=Completed)
18-Dec-2012 03:36:42.3: Send Observation SA44_28 to ACP Sequencer
18-Dec-2012 03:36:52.3: Sequencer is now active
18-Dec-2012 03:40:55.8: Sequencer is no longer active
18-Dec-2012 03:40:55.8: Post-job status check done (stat=Completed)
18-Dec-2012 03:40:55.8: Send Observation SA44_28 to ACP Sequencer
18-Dec-2012 03:41:05.8: Sequencer is now active
18-Dec-2012 03:45:09.0: Sequencer is no longer active
18-Dec-2012 03:45:09.0: Post-job status check done (stat=Completed)
18-Dec-2012 03:45:09.0: Send Observation SA44_28 to ACP Sequencer
18-Dec-2012 03:45:19.0: Sequencer is now active
18-Dec-2012 03:51:10.3: Sequencer is no longer active
18-Dec-2012 03:51:10.3: Post-job status check done (stat=Completed)
18-Dec-2012 03:51:10.3: Send Observation SA44_28 to ACP Sequencer
18-Dec-2012 03:51:20.3: Sequencer is now active
18-Dec-2012 03:56:22.6: Sequencer is no longer active
18-Dec-2012 03:56:22.6: Post-job status check done (stat=Failed)
18-Dec-2012 03:56:22.7: ACP data acquisition failed for Observation SA44_28.
18-Dec-2012 03:56:22.7:   (Observation SA44_28 interrupted by acquisition process failure.)
18-Dec-2012 03:56:22.8: ++ Auto Focus ++
18-Dec-2012 03:56:22.8: Doing periodic autofocus.
18-Dec-2012 03:56:22.8: Start special ACP AutoFocus script for scheduler
18-Dec-2012 03:56:32.8: Sequencer is now active
18-Dec-2012 03:56:38.0: Sequencer is no longer active
18-Dec-2012 03:56:38.0: ** Autofocus failed (n=3), will retry ASAP after 10 min.
18-Dec-2012 03:56:38.0: SelectRunning: No running plans
18-Dec-2012 03:56:38.1: Efficiency: Selecting from 14 pending plans:
18-Dec-2012 03:56:38.1:   Selected Plan SA93_317 (TotEff=2.08)
18-Dec-2012 03:56:38.2: Dispatcher cycle time: 0.2028003 sec.
18-Dec-2012 03:56:38.2: Acquire data for Observation SA93_317...
18-Dec-2012 03:56:38.2:   (belongs to Project Landolt_1, Plan SA93_317)
18-Dec-2012 03:56:38.2: Doing 10 sets
18-Dec-2012 03:56:38.2: Send Observation SA93_317 to ACP Sequencer
18-Dec-2012 03:56:48.2: Sequencer is now active
18-Dec-2012 04:02:05.5: Dispatcher stopped at 18-Dec-2012 04:02:05 UTC
18-Dec-2012 04:02:05.5: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
18-Dec-2012 04:02:11.8: Sequencer is no longer active
18-Dec-2012 04:02:14.8: Post-job status check done (stat=Running)
18-Dec-2012 04:02:14.8: RUN FAILED: Scheduler was stopped during run
18-Dec-2012 04:02:14.8: ACP data acquisition failed for Observation SA93_317.
18-Dec-2012 04:02:14.8:   (Observation SA93_317 interrupted by operator or system.)
18-Dec-2012 05:12:51.8: Dispatcher started at 18-Dec-2012 05:12:51 UTC
18-Dec-2012 05:12:51.8:     Priority:          W[0]=1.00
18-Dec-2012 05:12:51.8:     Transit Altitude:  W[1]=0.00
18-Dec-2012 05:12:51.8:     Highest Altitude:  W[6]=0.00
18-Dec-2012 05:12:51.8:     Lateness:          W[5]=0.70
18-Dec-2012 05:12:51.8:     Slew Distance:     W[2]=0.30
18-Dec-2012 05:12:51.8:     Retry Count:       W[3]=0.20
18-Dec-2012 05:12:51.8:     Meridian Crossing: W[4]=0.30
18-Dec-2012 05:12:51.8:     Obs Conditions:    W[7]=0.40
18-Dec-2012 05:12:51.8:     Rising Plan Delay: disabled
18-Dec-2012 05:12:53.1: ++ Observatory Startup ++
18-Dec-2012 05:12:53.1: Start ACP Sequencer's StartupObs script
18-Dec-2012 05:13:03.1: Sequencer is now active
18-Dec-2012 05:13:08.7: Sequencer is no longer active
18-Dec-2012 05:13:08.7: ++ Auto Focus ++
18-Dec-2012 05:13:08.7: Doing initial autofocus.
18-Dec-2012 05:13:08.7: Start special ACP AutoFocus script for scheduler
18-Dec-2012 05:13:18.7: Sequencer is now active
18-Dec-2012 05:13:20.1: Dispatcher stopped at 18-Dec-2012 05:13:20 UTC
18-Dec-2012 05:13:20.1: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
18-Dec-2012 05:13:24.0: Sequencer is no longer active
18-Dec-2012 05:13:24.0: ** Autofocus failed (n=1), will retry ASAP after 0 min.
18-Dec-2012 05:14:18.1: Dispatcher started at 18-Dec-2012 05:14:18 UTC
18-Dec-2012 05:14:18.1:     Priority:          W[0]=1.00
18-Dec-2012 05:14:18.1:     Transit Altitude:  W[1]=0.00
18-Dec-2012 05:14:18.1:     Highest Altitude:  W[6]=0.00
18-Dec-2012 05:14:18.1:     Lateness:          W[5]=0.70
18-Dec-2012 05:14:18.1:     Slew Distance:     W[2]=0.30
18-Dec-2012 05:14:18.1:     Retry Count:       W[3]=0.20
18-Dec-2012 05:14:18.1:     Meridian Crossing: W[4]=0.30
18-Dec-2012 05:14:18.1:     Obs Conditions:    W[7]=0.40
18-Dec-2012 05:14:18.1:     Rising Plan Delay: disabled
18-Dec-2012 05:14:18.4: ++ Observatory Startup ++
18-Dec-2012 05:14:18.4: Start ACP Sequencer's StartupObs script
18-Dec-2012 05:14:28.4: Sequencer is now active
18-Dec-2012 05:14:34.4: Sequencer is no longer active
18-Dec-2012 05:14:34.4: ++ Auto Focus ++
18-Dec-2012 05:14:34.4: Doing initial autofocus.
18-Dec-2012 05:14:34.4: Start special ACP AutoFocus script for scheduler
18-Dec-2012 05:14:44.4: Sequencer is now active
18-Dec-2012 05:17:39.2: Sequencer is no longer active
18-Dec-2012 05:17:39.2: Next periodic autofocus ASAP after 18-Dec-2012 07:17:02 UTC
18-Dec-2012 05:17:40.6: SelectRunning: No running plans
18-Dec-2012 05:17:40.6: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.6: Obs 1RXS_J0232388-371812 in Plan 1RXS_J0232388-371812 was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.6: Obs 1RXS_J1050103-140431 in Plan 1RXS_J1050103-140431 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.6:     AirmassRange estimates ready after 18-Dec-2012 09:27:21 UTC
18-Dec-2012 05:17:40.6: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.6: Obs ASAS_J160048-48462 in Plan ASAS_J160048-48462 was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.6: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.6: Obs AX_For in Plan AX_For was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.6: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.6: Obs BB_Dor in Plan BB_Dor was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.6: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.6: Obs BD Pav in Plan BD_Pav was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.6: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.6: Obs CC_Scl in Plan CC_Scl was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.6: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.6: Obs CU_Vel in Plan CU_Vel was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.6: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.6: Obs DT_Oct in Plan DT_Oct was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.6: Obs GW_Lib in Plan GW_Lib was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.6:     AirmassRange estimates ready after 18-Dec-2012 15:20:02 UTC
18-Dec-2012 05:17:40.6: Obs HM_Leo in Plan HM_Leo was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.6:     AirmassRange estimates ready after 18-Dec-2012 06:59:47 UTC
18-Dec-2012 05:17:40.7: Obs HS_2214+2845 in Plan HS_2214+2845 was vetoed by AirMass constraint.
18-Dec-2012 05:17:40.7:     AirMass estimates ready after 18-Dec-2012 18:47:36 UTC
18-Dec-2012 05:17:40.7: Obs HS_2214+2845 in Plan HS_2214+2845 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 18:47:36 UTC
18-Dec-2012 05:17:40.7: Obs IR_Com in Plan IR_Com was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 09:27:51 UTC
18-Dec-2012 05:17:40.7: Obs IU_Leo in Plan IU_Leo was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 08:13:22 UTC
18-Dec-2012 05:17:40.7: Obs IY_UMa in Plan IY_UMa was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 06:24:32 UTC
18-Dec-2012 05:17:40.7: Obs LN_UMa in Plan LN_UMa was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 05:28:09 UTC
18-Dec-2012 05:17:40.7: STRICT VETO:
18-Dec-2012 05:17:40.7: Obs M33 in Plan M33-Clear (1-6) was vetoed by HourAngle constraint.
18-Dec-2012 05:17:40.7:     HourAngle estimates ready after 18-Dec-2012 22:44:29 UTC
18-Dec-2012 05:17:40.7: Obs MR UMa in Plan MR_UMa was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 07:38:10 UTC
18-Dec-2012 05:17:40.7: Obs PU_CMa in Plan PU_CMa was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 06:34:37 UTC
18-Dec-2012 05:17:40.7: Obs QZ_Lib in Plan QZ_Lib was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 13:47:56 UTC
18-Dec-2012 05:17:40.7: Obs QZ_Ser in Plan QZ_Ser was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.7:     AirmassRange estimates ready after 18-Dec-2012 12:44:43 UTC
18-Dec-2012 05:17:40.8: Obs RZ_Leo in Plan RZ_Leo was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 09:13:25 UTC
18-Dec-2012 05:17:40.8: Obs SA100_267 in Plan SA100_267 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 05:56:07 UTC
18-Dec-2012 05:17:40.8: Obs SA100_267 in Plan SA100_267 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 08:04:11 UTC
18-Dec-2012 05:17:40.8: Obs SA103 in Plan SA103 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 08:57:39 UTC
18-Dec-2012 05:17:40.8: Obs SA103 in Plan SA103 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 11:05:33 UTC
18-Dec-2012 05:17:40.8: Obs SA106 in Plan SA106 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 11:41:33 UTC
18-Dec-2012 05:17:40.8: Obs SA106 in Plan SA106 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 13:48:51 UTC
18-Dec-2012 05:17:40.8: Obs SA109 in Plan SA109 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 16:52:16 UTC
18-Dec-2012 05:17:40.8: Obs SA109 in Plan SA109 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 14:45:10 UTC
18-Dec-2012 05:17:40.8: Obs SA110 in Plan SA110 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 17:46:22 UTC
18-Dec-2012 05:17:40.8: Obs SA110 in Plan SA110 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 15:40:13 UTC
18-Dec-2012 05:17:40.8: Obs SA111 in Plan SA111 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 16:35:48 UTC
18-Dec-2012 05:17:40.8: Obs SA111 in Plan SA111 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 18:42:08 UTC
18-Dec-2012 05:17:40.8: Obs SA1119 in Plan SA1119 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 16:35:33 UTC
18-Dec-2012 05:17:40.8: Obs SA1119 in Plan SA1119 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 18:41:26 UTC
18-Dec-2012 05:17:40.8: Obs SA112_810 in Plan SA112_810 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 19:47:08 UTC
18-Dec-2012 05:17:40.8: Obs SA112_810 in Plan SA112_810 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 17:40:58 UTC
18-Dec-2012 05:17:40.8: Obs SA116_180 in Plan SA116_180 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.8:     AirmassRange estimates ready after 18-Dec-2012 22:01:58 UTC
18-Dec-2012 05:17:40.8: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.8: Obs SA116_180 in Plan SA116_180 was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.9: Obs SA124_970 in Plan SA124_970 was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.9: Obs SA124_970 in Plan SA124_970 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 06:12:39 UTC
18-Dec-2012 05:17:40.9: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:40.9: Obs SA132 in Plan SA132 was failed by AirmassRange constraint.
18-Dec-2012 05:17:40.9: Obs SA132 in Plan SA132 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 14:08:58 UTC
18-Dec-2012 05:17:40.9: Obs SA44_28 in Plan SA44_28 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 22:13:58 UTC
18-Dec-2012 05:17:40.9: Obs SA44_28 in Plan SA44_28 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 06:33:44 UTC
18-Dec-2012 05:17:40.9: Obs SA52_56 in Plan SA52_56 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 06:19:45 UTC
18-Dec-2012 05:17:40.9: Obs SA52_56 in Plan SA52_56 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 14:31:51 UTC
18-Dec-2012 05:17:40.9: Obs SA61 in Plan SA61 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 14:49:07 UTC
18-Dec-2012 05:17:40.9: Obs SA61 in Plan SA61 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 12:51:02 UTC
18-Dec-2012 05:17:40.9: Obs SA68_216 in Plan SA68_216 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 05:53:00 UTC
18-Dec-2012 05:17:40.9: Obs SA68_216 in Plan SA68_216 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 22:30:12 UTC
18-Dec-2012 05:17:40.9: Obs SA84 in Plan SA84 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 12:39:19 UTC
18-Dec-2012 05:17:40.9: Obs SA84 in Plan SA84 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 18-Dec-2012 14:32:51 UTC
18-Dec-2012 05:17:40.9: STRICT VETO:
18-Dec-2012 05:17:40.9: Obs SA93_317 in Plan SA93_317 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:40.9:     AirmassRange estimates ready after 19-Dec-2012 00:56:07 UTC
18-Dec-2012 05:17:41.2: Obs SA93_317 in Plan SA93_317 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.2:     AirmassRange estimates ready after 18-Dec-2012 06:49:41 UTC
18-Dec-2012 05:17:41.2: Obs SA96_171 in Plan SA96_171 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.2:     AirmassRange estimates ready after 18-Dec-2012 09:43:15 UTC
18-Dec-2012 05:17:41.3: Obs SA98 in Plan SA98 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 06:02:08 UTC
18-Dec-2012 05:17:41.3: Obs SA98 in Plan SA98 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 11:43:06 UTC
18-Dec-2012 05:17:41.3: Obs SA99_438 in Plan SA99_438 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 07:04:58 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J00115308-0647391 in Plan SDSS_J00115308-0647391 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 22:14:49 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J09324957+4725230 in Plan SDSS_J09324957+4725230 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 05:32:51 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J10051538+1911079 in Plan SDSS_J10051538+1911079 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 06:58:07 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J10065840+2337244 in Plan SDSS_J10065840+2337244 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 06:50:36 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J10353303+0551584 in Plan SDSS_J10353303+0551584 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 08:00:15 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J14354402+2336387 in Plan SDSS_J14354402+2336387 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 11:18:39 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J15381735+5123380 in Plan SDSS_J15381735+5123380 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 11:30:19 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J15445360+2553488 in Plan SDSS_J15445360+2553488 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 12:23:04 UTC
18-Dec-2012 05:17:41.3: Obs SDSS_J16424852+1347514 in Plan SDSS_J16424852+1347514 was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 13:46:37 UTC
18-Dec-2012 05:17:41.3: Obs V0380_Oph in Plan V0380_Oph was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 15:13:08 UTC
18-Dec-2012 05:17:41.3: Obs V0405_Peg in Plan V0405_Peg was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 19:55:28 UTC
18-Dec-2012 05:17:41.3: Obs V0406_Vir in Plan V0406_Vir was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.3:     AirmassRange estimates ready after 18-Dec-2012 10:31:40 UTC
18-Dec-2012 05:17:41.4: [AirmassRange] Target will never be below the maximum air mass
18-Dec-2012 05:17:41.4: Obs V0485_Cen in Plan V0485_Cen was failed by AirmassRange constraint.
18-Dec-2012 05:17:41.4: Obs V1108_Her in Plan V1108_Her was vetoed by AirMass constraint.
18-Dec-2012 05:17:41.4:     AirMass estimates ready after 18-Dec-2012 15:16:47 UTC
18-Dec-2012 05:17:41.4: Obs V1108_Her in Plan V1108_Her was vetoed by AirmassRange constraint.
18-Dec-2012 05:17:41.4:     AirmassRange estimates ready after 18-Dec-2012 15:16:47 UTC
18-Dec-2012 05:17:41.4: Obs V405_Peg in Plan V405_Peg was vetoed by AirMass constraint.
18-Dec-2012 05:17:41.4:     AirMass estimates ready after 18-Dec-2012 19:55:28 UTC
18-Dec-2012 05:17:41.4: Efficiency: Selecting from 16 pending plans:
18-Dec-2012 05:17:41.5:   Selected Plan FL_Psc (TotEff=1.95)
18-Dec-2012 05:17:41.5: Dispatcher cycle time: 2.324404 sec.
18-Dec-2012 05:17:41.5: Acquire data for Observation FL_Psc...
18-Dec-2012 05:17:41.5:   (belongs to Project HST_CV, Plan FL_Psc)
18-Dec-2012 05:17:41.5: Send Observation FL_Psc to ACP Sequencer
18-Dec-2012 05:17:51.5: Sequencer is now active
18-Dec-2012 05:29:35.8: Sequencer is no longer active
18-Dec-2012 05:29:35.8: Post-job status check done (stat=Completed)
18-Dec-2012 05:29:35.8: Acquisition time: 714.2472545 sec.
18-Dec-2012 05:29:35.8: Data for Observation FL_Psc acquired successfully.
18-Dec-2012 05:29:35.8: Image Efficiency: 75.4%
18-Dec-2012 05:29:35.8: Cycle Efficiency: 99.7%
18-Dec-2012 05:29:35.9: SelectRunning: No running plans
18-Dec-2012 05:29:36.0: Efficiency: Selecting from 16 pending plans:
18-Dec-2012 05:29:36.1:   Selected Plan HS_0220+0603 (TotEff=1.82)
18-Dec-2012 05:29:36.1: Dispatcher cycle time: 0.2340004 sec.
18-Dec-2012 05:29:36.1: Acquire data for Observation HS 0220+0603...
18-Dec-2012 05:29:36.1:   (belongs to Project HST_CV, Plan HS_0220+0603)
18-Dec-2012 05:29:36.1: Send Observation HS 0220+0603 to ACP Sequencer
18-Dec-2012 05:29:46.2: Sequencer is now active
18-Dec-2012 05:41:19.4: Sequencer is no longer active
18-Dec-2012 05:41:19.4: Post-job status check done (stat=Completed)
18-Dec-2012 05:41:19.4: Acquisition time: 703.2804353 sec.
18-Dec-2012 05:41:19.4: Data for Observation HS 0220+0603 acquired successfully.
18-Dec-2012 05:41:19.4: Image Efficiency: 76.8%
18-Dec-2012 05:41:19.4: Cycle Efficiency: 100.0%
18-Dec-2012 05:41:19.5: SelectRunning: No running plans
18-Dec-2012 05:41:19.6: Obs SA99_438 in Plan SA99_438 was vetoed by AirmassRange constraint.
18-Dec-2012 05:41:19.6:     AirmassRange estimates ready after 18-Dec-2012 12:46:52 UTC
18-Dec-2012 05:41:19.6: Efficiency: Selecting from 15 pending plans:
18-Dec-2012 05:41:19.7:   Selected Plan HS_0218+3229 (TotEff=1.82)
18-Dec-2012 05:41:19.8: Dispatcher cycle time: 0.2340004 sec.
18-Dec-2012 05:41:19.8: Acquire data for Observation HS_0218+3229...
18-Dec-2012 05:41:19.8:   (belongs to Project xx, Plan HS_0218+3229)
18-Dec-2012 05:41:19.8: Send Observation HS_0218+3229 to ACP Sequencer
18-Dec-2012 05:41:29.8: Sequencer is now active
18-Dec-2012 05:49:45.2: Sequencer is no longer active
18-Dec-2012 05:49:45.2: Post-job status check done (stat=Completed)
18-Dec-2012 05:49:45.2: Acquisition time: 505.4096877 sec.
18-Dec-2012 05:49:45.2: Data for Observation HS_0218+3229 acquired successfully.
18-Dec-2012 05:49:45.2: Image Efficiency: 71.2%
18-Dec-2012 05:49:45.2: Cycle Efficiency: 100.0%
18-Dec-2012 05:49:45.3: SelectRunning: No running plans
18-Dec-2012 05:49:45.4: Efficiency: Selecting from 14 pending plans:
18-Dec-2012 05:49:45.5:   Selected Plan HS_0218+3229 (TotEff=1.77)
18-Dec-2012 05:49:45.5: Dispatcher cycle time: 0.2028004 sec.
18-Dec-2012 05:49:45.5: Acquire data for Observation HS_0218+3229...
18-Dec-2012 05:49:45.5:   (belongs to Project HST_CV, Plan HS_0218+3229)
18-Dec-2012 05:49:45.5: Send Observation HS_0218+3229 to ACP Sequencer
18-Dec-2012 05:49:55.5: Sequencer is now active
18-Dec-2012 06:00:45.9: Sequencer is no longer active
18-Dec-2012 06:00:45.9: Post-job status check done (stat=Completed)
18-Dec-2012 06:00:45.9: Acquisition time: 660.4115599 sec.
18-Dec-2012 06:00:45.9: Data for Observation HS_0218+3229 acquired successfully.
18-Dec-2012 06:00:46.0: Image Efficiency: 81.7%
18-Dec-2012 06:00:46.0: Cycle Efficiency: 100.0%
18-Dec-2012 06:00:46.1: SelectRunning: No running plans
18-Dec-2012 06:00:46.2: Efficiency: Selecting from 15 pending plans:
18-Dec-2012 06:00:46.3:   Selected Plan SA68_216 (TotEff=2.15)
18-Dec-2012 06:00:46.3: Dispatcher cycle time: 0.2184003 sec.
18-Dec-2012 06:00:46.3: Acquire data for Observation SA68_216...
18-Dec-2012 06:00:46.3:   (belongs to Project Landolt_2, Plan SA68_216)
18-Dec-2012 06:00:46.3: Send Observation SA68_216 to ACP Sequencer
18-Dec-2012 06:00:56.3: Sequencer is now active
18-Dec-2012 06:05:19.6: Sequencer is no longer active
18-Dec-2012 06:05:19.6: Post-job status check done (stat=Completed)
18-Dec-2012 06:05:19.6: Acquisition time: 273.3124801 sec.
18-Dec-2012 06:05:19.6: Data for Observation SA68_216 acquired successfully.
18-Dec-2012 06:05:19.6: Image Efficiency: 34.7%
18-Dec-2012 06:05:19.6: Cycle Efficiency: 99.9%
18-Dec-2012 06:05:19.7: SelectRunning: No running plans
18-Dec-2012 06:05:19.8: Efficiency: Selecting from 15 pending plans:
18-Dec-2012 06:05:19.9:   Selected Plan LT_Eri (TotEff=1.78)
18-Dec-2012 06:05:19.9: Dispatcher cycle time: 0.2184004 sec.
18-Dec-2012 06:05:19.9: Acquire data for Observation LT_Eri...
18-Dec-2012 06:05:19.9:   (belongs to Project HST_CV, Plan LT_Eri)
18-Dec-2012 06:05:20.0: Send Observation LT_Eri to ACP Sequencer
18-Dec-2012 06:05:30.0: Sequencer is now active
18-Dec-2012 06:17:27.9: Sequencer is no longer active
18-Dec-2012 06:17:27.9: Post-job status check done (stat=Completed)
18-Dec-2012 06:17:27.9: Acquisition time: 727.9128785 sec.
18-Dec-2012 06:17:27.9: Data for Observation LT_Eri acquired successfully.
18-Dec-2012 06:17:27.9: Image Efficiency: 74.2%
18-Dec-2012 06:17:27.9: Cycle Efficiency: 100.0%
18-Dec-2012 06:17:28.0: SelectRunning: No running plans
18-Dec-2012 06:17:28.1: Efficiency: Selecting from 15 pending plans:
18-Dec-2012 06:17:28.2:   Selected Plan SA96_171 (TotEff=2.03)
18-Dec-2012 06:17:28.2: Dispatcher cycle time: 0.2184003 sec.
18-Dec-2012 06:17:28.2: Acquire data for Observation SA96_171...
18-Dec-2012 06:17:28.2:   (belongs to Project Landolt_1, Plan SA96_171)
18-Dec-2012 06:17:28.2: Send Observation SA96_171 to ACP Sequencer
18-Dec-2012 06:17:38.2: Sequencer is now active
18-Dec-2012 06:21:46.8: Sequencer is no longer active
18-Dec-2012 06:21:46.8: Post-job status check done (stat=Completed)
18-Dec-2012 06:21:46.8: Acquisition time: 258.6016542 sec.
18-Dec-2012 06:21:46.8: Data for Observation SA96_171 acquired successfully.
18-Dec-2012 06:21:46.8: Image Efficiency: 36.7%
18-Dec-2012 06:21:46.8: Cycle Efficiency: 99.9%
18-Dec-2012 06:21:47.0: SelectRunning: No running plans
18-Dec-2012 06:21:47.1: Efficiency: Selecting from 15 pending plans:
18-Dec-2012 06:21:47.1:   Selected Plan SA100_267 (TotEff=1.80)
18-Dec-2012 06:21:47.2: Dispatcher cycle time: 0.2184004 sec.
18-Dec-2012 06:21:47.2: Acquire data for Observation SA100_267...
18-Dec-2012 06:21:47.2:   (belongs to Project Landolt_2, Plan SA100_267)
18-Dec-2012 06:21:47.2: Send Observation SA100_267 to ACP Sequencer
18-Dec-2012 06:21:57.2: Sequencer is now active
18-Dec-2012 06:26:47.4: Sequencer is no longer active
18-Dec-2012 06:26:47.4: Post-job status check done (stat=Completed)
18-Dec-2012 06:26:47.4: Acquisition time: 300.2069273 sec.
18-Dec-2012 06:26:47.4: Data for Observation SA100_267 acquired successfully.
18-Dec-2012 06:26:47.4: Image Efficiency: 31.6%
18-Dec-2012 06:26:47.4: Cycle Efficiency: 99.9%
18-Dec-2012 06:26:47.5: SelectRunning: No running plans
18-Dec-2012 06:26:47.6: Efficiency: Selecting from 15 pending plans:
18-Dec-2012 06:26:47.7:   Selected Plan SA124_970 (TotEff=2.15)
18-Dec-2012 06:26:47.7: Dispatcher cycle time: 0.2028004 sec.
18-Dec-2012 06:26:47.7: Acquire data for Observation SA124_970...
18-Dec-2012 06:26:47.7:   (belongs to Project Landolt_2, Plan SA124_970)
18-Dec-2012 06:26:47.7: Send Observation SA124_970 to ACP Sequencer
18-Dec-2012 06:26:57.8: Sequencer is now active
18-Dec-2012 06:31:07.6: Sequencer is no longer active
18-Dec-2012 06:31:07.6: Post-job status check done (stat=Completed)
18-Dec-2012 06:31:07.6: Acquisition time: 259.8184563 sec.
18-Dec-2012 06:31:07.6: Data for Observation SA124_970 acquired successfully.
18-Dec-2012 06:31:07.6: Image Efficiency: 36.5%
18-Dec-2012 06:31:07.6: Cycle Efficiency: 99.9%
18-Dec-2012 06:31:07.7: SelectRunning: No running plans
18-Dec-2012 06:31:07.8: Efficiency: Selecting from 14 pending plans:
18-Dec-2012 06:31:07.9:   Selected Plan SA98 (TotEff=1.67)
18-Dec-2012 06:31:07.9: Dispatcher cycle time: 0.2184003 sec.
18-Dec-2012 06:31:07.9: Acquire data for Observation SA98...
18-Dec-2012 06:31:07.9:   (belongs to Project Landolt_1, Plan SA98)
18-Dec-2012 06:31:07.9: Send Observation SA98 to ACP Sequencer
18-Dec-2012 06:31:17.9: Sequencer is now active
18-Dec-2012 06:36:10.0: Sequencer is no longer active
18-Dec-2012 06:36:10.0: Post-job status check done (stat=Completed)
18-Dec-2012 06:36:10.0: Acquisition time: 302.0789306 sec.
18-Dec-2012 06:36:10.0: Data for Observation SA98 acquired successfully.
18-Dec-2012 06:36:10.0: Image Efficiency: 43.0%
18-Dec-2012 06:36:10.0: Cycle Efficiency: 99.9%
18-Dec-2012 06:36:10.1: SelectRunning: No running plans
18-Dec-2012 06:36:10.2: STRICT VETO:
18-Dec-2012 06:36:10.2: Obs M33-Cent in Plan M33-Cent was vetoed by AirMass constraint.
18-Dec-2012 06:36:10.2:     AirMass estimates ready after 18-Dec-2012 22:01:14 UTC
18-Dec-2012 06:36:10.2: STRICT VETO:
18-Dec-2012 06:36:10.2: Obs SA44_28 in Plan SA44_28 was vetoed by AirmassRange constraint.
18-Dec-2012 06:36:10.2:     AirmassRange estimates ready after 18-Dec-2012 20:15:23 UTC
18-Dec-2012 06:36:10.2: Efficiency: Selecting from 13 pending plans:
18-Dec-2012 06:36:10.3:   Selected Plan PU_CMa (TotEff=1.76)
18-Dec-2012 06:36:10.3: Dispatcher cycle time: 0.2184004 sec.
18-Dec-2012 06:36:10.3: Acquire data for Observation PU_CMa...
18-Dec-2012 06:36:10.3:   (belongs to Project HST_CV, Plan PU_CMa)
18-Dec-2012 06:36:10.3: Send Observation PU_CMa to ACP Sequencer
18-Dec-2012 06:36:20.4: Sequencer is now active
18-Dec-2012 06:47:47.0: Sequencer is no longer active
18-Dec-2012 06:47:47.0: Post-job status check done (stat=Completed)
18-Dec-2012 06:47:47.0: Acquisition time: 696.6972236 sec.
18-Dec-2012 06:47:47.0: Data for Observation PU_CMa acquired successfully.
18-Dec-2012 06:47:47.1: Image Efficiency: 77.5%
18-Dec-2012 06:47:47.1: Cycle Efficiency: 100.0%
18-Dec-2012 06:47:47.2: SelectRunning: No running plans
18-Dec-2012 06:47:47.2: Efficiency: Selecting from 12 pending plans:
18-Dec-2012 06:47:47.3:   Selected Plan CW_Mon (TotEff=1.66)
18-Dec-2012 06:47:47.3: Dispatcher cycle time: 0.1716003 sec.
18-Dec-2012 06:47:47.3: Acquire data for Observation CW_Mon...
18-Dec-2012 06:47:47.3:   (belongs to Project AAVSO_Monitoring, Plan CW_Mon)
18-Dec-2012 06:47:47.3: Send Observation CW_Mon to ACP Sequencer
18-Dec-2012 06:47:57.4: Sequencer is now active
18-Dec-2012 06:56:12.9: Sequencer is no longer active
18-Dec-2012 06:56:12.9: Post-job status check done (stat=Completed)
18-Dec-2012 06:56:12.9: Acquisition time: 505.5500879 sec.
18-Dec-2012 06:56:12.9: Data for Observation CW_Mon acquired successfully.
18-Dec-2012 06:56:12.9: Image Efficiency: 71.2%
18-Dec-2012 06:56:12.9: Cycle Efficiency: 100.0%
18-Dec-2012 06:56:13.0: SelectRunning: No running plans
18-Dec-2012 06:56:13.1: STRICT VETO:
18-Dec-2012 06:56:13.1: Obs SA93_317 in Plan SA93_317 was vetoed by AirmassRange constraint.
18-Dec-2012 06:56:13.1:     AirmassRange estimates ready after 18-Dec-2012 22:50:43 UTC
18-Dec-2012 06:56:13.1: Efficiency: Selecting from 12 pending plans:
18-Dec-2012 06:56:13.2:   Selected Plan SA52_56 (TotEff=1.64)
18-Dec-2012 06:56:13.2: Dispatcher cycle time: 0.1872003 sec.
18-Dec-2012 06:56:13.2: Acquire data for Observation SA52_56...
18-Dec-2012 06:56:13.2:   (belongs to Project Landolt_1, Plan SA52_56)
18-Dec-2012 06:56:13.2: Send Observation SA52_56 to ACP Sequencer
18-Dec-2012 06:56:23.2: Sequencer is now active
18-Dec-2012 07:00:43.7: Sequencer is no longer active
18-Dec-2012 07:00:43.7: Post-job status check done (stat=Completed)
18-Dec-2012 07:00:43.7: Acquisition time: 270.4888751 sec.
18-Dec-2012 07:00:43.7: Data for Observation SA52_56 acquired successfully.
18-Dec-2012 07:00:43.7: Image Efficiency: 35.1%
18-Dec-2012 07:00:43.7: Cycle Efficiency: 99.9%
18-Dec-2012 07:00:43.8: SelectRunning: No running plans
18-Dec-2012 07:00:44.0: Efficiency: Selecting from 13 pending plans:
18-Dec-2012 07:00:44.0:   Selected Plan CW_Mon (TotEff=1.61)
18-Dec-2012 07:00:44.1: Dispatcher cycle time: 0.2184004 sec.
18-Dec-2012 07:00:44.1: Acquire data for Observation CW_Mon...
18-Dec-2012 07:00:44.1:   (belongs to Project HST_CV, Plan CW_Mon)
18-Dec-2012 07:00:44.1: Send Observation CW_Mon to ACP Sequencer
18-Dec-2012 07:00:54.1: Sequencer is now active
18-Dec-2012 07:12:28.5: Sequencer is no longer active
18-Dec-2012 07:12:28.5: Post-job status check done (stat=Completed)
18-Dec-2012 07:12:28.5: Acquisition time: 704.4348373 sec.
18-Dec-2012 07:12:28.5: Data for Observation CW_Mon acquired successfully.
18-Dec-2012 07:12:28.5: Image Efficiency: 76.6%
18-Dec-2012 07:12:28.5: Cycle Efficiency: 100.0%
18-Dec-2012 07:12:28.6: SelectRunning: No running plans
18-Dec-2012 07:12:28.7: Efficiency: Selecting from 13 pending plans:
18-Dec-2012 07:12:28.8:   Selected Plan SA99_438 (TotEff=1.84)
18-Dec-2012 07:12:28.8: Dispatcher cycle time: 0.2028004 sec.
18-Dec-2012 07:12:28.8: Acquire data for Observation SA99_438...
18-Dec-2012 07:12:28.8:   (belongs to Project Landolt_1, Plan SA99_438)
18-Dec-2012 07:12:28.8: Send Observation SA99_438 to ACP Sequencer
18-Dec-2012 07:12:38.9: Sequencer is now active
18-Dec-2012 07:16:13.0: Sequencer is no longer active
18-Dec-2012 07:16:13.0: Post-job status check done (stat=Completed)
18-Dec-2012 07:16:13.0: Acquisition time: 224.1723937 sec.
18-Dec-2012 07:16:13.0: Data for Observation SA99_438 acquired successfully.
18-Dec-2012 07:16:13.0: Image Efficiency: 24.5%
18-Dec-2012 07:16:13.0: Cycle Efficiency: 99.9%
18-Dec-2012 07:16:13.1: SelectRunning: No running plans
18-Dec-2012 07:16:13.2: Efficiency: Selecting from 12 pending plans:
18-Dec-2012 07:16:13.3:   Selected Plan BB_Ari (TotEff=1.54)
18-Dec-2012 07:16:13.3: Dispatcher cycle time: 0.1872004 sec.
18-Dec-2012 07:16:13.3: Acquire data for Observation BB_Ari...
18-Dec-2012 07:16:13.3:   (belongs to Project HST_CV, Plan BB_Ari)
18-Dec-2012 07:16:13.3: Send Observation BB_Ari to ACP Sequencer
18-Dec-2012 07:16:23.3: Sequencer is now active
18-Dec-2012 07:28:36.9: Sequencer is no longer active
18-Dec-2012 07:28:36.9: Post-job status check done (stat=Completed)
18-Dec-2012 07:28:36.9: Acquisition time: 743.575306 sec.
18-Dec-2012 07:28:36.9: Data for Observation BB_Ari acquired successfully.
18-Dec-2012 07:28:36.9: Image Efficiency: 72.6%
18-Dec-2012 07:28:36.9: Cycle Efficiency: 100.0%
18-Dec-2012 07:28:37.0: ++ Auto Focus ++
18-Dec-2012 07:28:37.0: Doing periodic autofocus.
18-Dec-2012 07:28:37.0: Start special ACP AutoFocus script for scheduler
18-Dec-2012 07:28:47.1: Sequencer is now active
18-Dec-2012 07:32:11.8: Sequencer is no longer active
18-Dec-2012 07:32:11.8: Next periodic autofocus ASAP after 18-Dec-2012 09:31:36 UTC
18-Dec-2012 07:32:11.8: SelectRunning: No running plans
18-Dec-2012 07:32:11.9: Efficiency: Selecting from 11 pending plans:
18-Dec-2012 07:32:12.0:   Selected Plan V1294_Tau (TotEff=1.86)
18-Dec-2012 07:32:12.0: Dispatcher cycle time: 0.1716003 sec.
18-Dec-2012 07:32:12.0: Acquire data for Observation V1294_Tau...
18-Dec-2012 07:32:12.0:   (belongs to Project HST_CV, Plan V1294_Tau)
18-Dec-2012 07:32:12.0: Send Observation V1294_Tau to ACP Sequencer
18-Dec-2012 07:32:22.0: Sequencer is now active
18-Dec-2012 07:43:47.8: Sequencer is no longer active
18-Dec-2012 07:43:47.8: Post-job status check done (stat=Completed)
18-Dec-2012 07:43:47.8: Acquisition time: 695.8080221 sec.
18-Dec-2012 07:43:47.8: Data for Observation V1294_Tau acquired successfully.
18-Dec-2012 07:43:47.8: Image Efficiency: 77.6%
18-Dec-2012 07:43:47.8: Cycle Efficiency: 100.0%
18-Dec-2012 07:43:47.9: SelectRunning: No running plans
18-Dec-2012 07:43:48.0: Efficiency: Selecting from 11 pending plans:
18-Dec-2012 07:43:48.1:   Selected Plan HS_0455+8315 (TotEff=1.48)
18-Dec-2012 07:43:48.1: Dispatcher cycle time: 0.1716003 sec.
18-Dec-2012 07:43:48.1: Acquire data for Observation HS_0455+8315...
18-Dec-2012 07:43:48.1:   (belongs to Project HST_CV, Plan HS_0455+8315)
18-Dec-2012 07:43:48.1: Send Observation HS_0455+8315 to ACP Sequencer
18-Dec-2012 07:43:58.1: Sequencer is now active
18-Dec-2012 07:55:55.9: Sequencer is no longer active
18-Dec-2012 07:55:55.9: Post-job status check done (stat=Completed)
18-Dec-2012 07:55:55.9: Acquisition time: 727.8036783 sec.
18-Dec-2012 07:55:55.9: Data for Observation HS_0455+8315 acquired successfully.
18-Dec-2012 07:55:55.9: Image Efficiency: 74.2%
18-Dec-2012 07:55:55.9: Cycle Efficiency: 100.0%
18-Dec-2012 07:55:56.1: SelectRunning: No running plans
18-Dec-2012 07:55:56.1: Efficiency: Selecting from 10 pending plans:
18-Dec-2012 07:55:56.2:   Selected Plan SDSS_J075507 (TotEff=1.24)
18-Dec-2012 07:55:56.2: Dispatcher cycle time: 0.1716003 sec.
18-Dec-2012 07:55:56.2: Acquire data for Observation SDSS_J075507...
18-Dec-2012 07:55:56.2:   (belongs to Project zz, Plan SDSS_J075507)
18-Dec-2012 07:55:56.2: Send Observation SDSS_J075507 to ACP Sequencer
18-Dec-2012 07:56:06.2: Sequencer is now active
18-Dec-2012 08:07:21.3: Sequencer is no longer active
18-Dec-2012 08:07:21.3: Post-job status check done (stat=Completed)
18-Dec-2012 08:07:21.3: Acquisition time: 685.1064033 sec.
18-Dec-2012 08:07:21.3: Data for Observation SDSS_J075507 acquired successfully.
18-Dec-2012 08:07:21.3: Image Efficiency: 70.0%
18-Dec-2012 08:07:21.3: Cycle Efficiency: 100.0%
18-Dec-2012 08:07:21.5: SelectRunning: No running plans
18-Dec-2012 08:07:21.5: Efficiency: Selecting from 11 pending plans:
18-Dec-2012 08:07:21.6:   Selected Plan SA100_267 (TotEff=1.84)
18-Dec-2012 08:07:21.6: Dispatcher cycle time: 0.1716003 sec.
18-Dec-2012 08:07:21.6: Acquire data for Observation SA100_267...
18-Dec-2012 08:07:21.6:   (belongs to Project Landolt_1, Plan SA100_267)
18-Dec-2012 08:07:21.6: Send Observation SA100_267 to ACP Sequencer
18-Dec-2012 08:07:31.7: Sequencer is now active
18-Dec-2012 08:11:41.6: Sequencer is no longer active
18-Dec-2012 08:11:41.6: Post-job status check done (stat=Completed)
18-Dec-2012 08:11:41.6: Acquisition time: 259.9588566 sec.
18-Dec-2012 08:11:41.6: Data for Observation SA100_267 acquired successfully.
18-Dec-2012 08:11:41.6: Image Efficiency: 36.5%
18-Dec-2012 08:11:41.6: Cycle Efficiency: 99.9%
18-Dec-2012 08:11:41.7: SelectRunning: No running plans
18-Dec-2012 08:11:41.8: Efficiency: Selecting from 10 pending plans:
18-Dec-2012 08:11:41.9:   Selected Plan SDSS_J07550770+1435476 (TotEff=1.55)
18-Dec-2012 08:11:41.9: Dispatcher cycle time: 0.1716003 sec.
18-Dec-2012 08:11:41.9: Acquire data for Observation SDSS_J07550770+1435476...
18-Dec-2012 08:11:41.9:   (belongs to Project HST_CV, Plan SDSS_J07550770+1435476)
18-Dec-2012 08:11:41.9: Send Observation SDSS_J07550770+1435476 to ACP Sequencer
18-Dec-2012 08:11:51.9: Sequencer is now active
18-Dec-2012 08:23:13.5: Sequencer is no longer active
18-Dec-2012 08:23:13.5: Post-job status check done (stat=Completed)
18-Dec-2012 08:23:13.5: Acquisition time: 691.6272148 sec.
18-Dec-2012 08:23:13.5: Data for Observation SDSS_J07550770+1435476 acquired successfully.
18-Dec-2012 08:23:13.5: Image Efficiency: 78.1%
18-Dec-2012 08:23:13.5: Cycle Efficiency: 100.0%
18-Dec-2012 08:23:13.7: SelectRunning: No running plans
18-Dec-2012 08:23:13.7: Efficiency: Selecting from 10 pending plans:
18-Dec-2012 08:23:13.8:   Selected Plan V0482_Cam (TotEff=1.44)
18-Dec-2012 08:23:13.8: Dispatcher cycle time: 0.1560003 sec.
18-Dec-2012 08:23:13.8: Acquire data for Observation V0482_Cam...
18-Dec-2012 08:23:13.8:   (belongs to Project HST_CV, Plan V0482_Cam)
18-Dec-2012 08:23:13.8: Send Observation V0482_Cam to ACP Sequencer
18-Dec-2012 08:23:23.8: Sequencer is now active
18-Dec-2012 08:35:05.3: Sequencer is no longer active
18-Dec-2012 08:35:05.3: Post-job status check done (stat=Completed)
18-Dec-2012 08:35:05.3: Acquisition time: 711.4860497 sec.
18-Dec-2012 08:35:05.3: Data for Observation V0482_Cam acquired successfully.
18-Dec-2012 08:35:05.3: Image Efficiency: 75.9%
18-Dec-2012 08:35:05.3: Cycle Efficiency: 100.0%
18-Dec-2012 08:35:05.4: SelectRunning: No running plans
18-Dec-2012 08:35:05.5: Efficiency: Selecting from 9 pending plans:
18-Dec-2012 08:35:05.6:   Selected Plan HM_Leo (TotEff=1.45)
18-Dec-2012 08:35:05.6: Dispatcher cycle time: 0.1560003 sec.
18-Dec-2012 08:35:05.6: Acquire data for Observation HM_Leo...
18-Dec-2012 08:35:05.6:   (belongs to Project HST_CV, Plan HM_Leo)
18-Dec-2012 08:35:05.6: Send Observation HM_Leo to ACP Sequencer
18-Dec-2012 08:35:15.6: Sequencer is now active
18-Dec-2012 08:47:01.9: Sequencer is no longer active
18-Dec-2012 08:47:01.9: Post-job status check done (stat=Completed)
18-Dec-2012 08:47:01.9: Acquisition time: 716.3064581 sec.
18-Dec-2012 08:47:01.9: Data for Observation HM_Leo acquired successfully.
18-Dec-2012 08:47:01.9: Image Efficiency: 75.4%
18-Dec-2012 08:47:01.9: Cycle Efficiency: 100.0%
18-Dec-2012 08:47:02.0: SelectRunning: No running plans
18-Dec-2012 08:47:02.1: Efficiency: Selecting from 8 pending plans:
18-Dec-2012 08:47:02.1:   Selected Plan SDSS_J10353303+0551584 (TotEff=1.40)
18-Dec-2012 08:47:02.1: Dispatcher cycle time: 0.1248002 sec.
18-Dec-2012 08:47:02.1: Acquire data for Observation SDSS_J10353303+0551584...
18-Dec-2012 08:47:02.2:   (belongs to Project HST_CV, Plan SDSS_J10353303+0551584)
18-Dec-2012 08:47:02.2: Send Observation SDSS_J10353303+0551584 to ACP Sequencer
18-Dec-2012 08:47:12.2: Sequencer is now active
18-Dec-2012 08:58:29.2: Sequencer is no longer active
18-Dec-2012 08:58:29.2: Post-job status check done (stat=Completed)
18-Dec-2012 08:58:29.2: Acquisition time: 686.9940067 sec.
18-Dec-2012 08:58:29.2: Data for Observation SDSS_J10353303+0551584 acquired successfully.
18-Dec-2012 08:58:29.2: Image Efficiency: 78.6%
18-Dec-2012 08:58:29.2: Cycle Efficiency: 100.0%
18-Dec-2012 08:58:29.3: SelectRunning: No running plans
18-Dec-2012 08:58:29.3: Obs SA103 in Plan SA103 vetoed for sequencer hard limit.
18-Dec-2012 08:58:29.3:  (deferred for 58 min, until 18-Dec-2012 09:56:29 UTC
18-Dec-2012 08:58:29.3: Efficiency: Selecting from 7 pending plans:
18-Dec-2012 08:58:29.4:   Selected Plan SDSS_J10051538+1911079 (TotEff=1.41)
18-Dec-2012 08:58:29.4: Dispatcher cycle time: 0.1404003 sec.
18-Dec-2012 08:58:29.4: Acquire data for Observation SDSS_J10051538+1911079...
18-Dec-2012 08:58:29.4:   (belongs to Project HST_CV, Plan SDSS_J10051538+1911079)
18-Dec-2012 08:58:29.4: Send Observation SDSS_J10051538+1911079 to ACP Sequencer
18-Dec-2012 08:58:39.5: Sequencer is now active
18-Dec-2012 09:09:57.4: Sequencer is no longer active
18-Dec-2012 09:09:57.4: Post-job status check done (stat=Completed)
18-Dec-2012 09:09:57.4: Acquisition time: 687.9612083 sec.
18-Dec-2012 09:09:57.4: Data for Observation SDSS_J10051538+1911079 acquired successfully.
18-Dec-2012 09:09:57.4: Image Efficiency: 78.5%
18-Dec-2012 09:09:57.4: Cycle Efficiency: 100.0%
18-Dec-2012 09:09:57.5: SelectRunning: No running plans
18-Dec-2012 09:09:57.6: Efficiency: Selecting from 6 pending plans:
18-Dec-2012 09:09:57.6:   Selected Plan SDSS_J10065840+2337244 (TotEff=1.41)
18-Dec-2012 09:09:57.6: Dispatcher cycle time: 0.1248003 sec.
18-Dec-2012 09:09:57.6: Acquire data for Observation SDSS_J10065840+2337244...
18-Dec-2012 09:09:57.6:   (belongs to Project HST_CV, Plan SDSS_J10065840+2337244)
18-Dec-2012 09:09:57.6: Send Observation SDSS_J10065840+2337244 to ACP Sequencer
18-Dec-2012 09:10:07.7: Sequencer is now active
18-Dec-2012 09:21:03.9: Sequencer is no longer active
18-Dec-2012 09:21:03.9: Post-job status check done (stat=Completed)
18-Dec-2012 09:21:03.9: Acquisition time: 666.2771702 sec.
18-Dec-2012 09:21:03.9: Data for Observation SDSS_J10065840+2337244 acquired successfully.
18-Dec-2012 09:21:03.9: Image Efficiency: 81.0%
18-Dec-2012 09:21:03.9: Cycle Efficiency: 100.0%
18-Dec-2012 09:21:04.0: SelectRunning: No running plans
18-Dec-2012 09:21:04.1: Efficiency: Selecting from 6 pending plans:
18-Dec-2012 09:21:04.1:   Selected Plan SDSS_J09324957+4725230 (TotEff=1.41)
18-Dec-2012 09:21:04.2: Dispatcher cycle time: 0.1248003 sec.
18-Dec-2012 09:21:04.2: Acquire data for Observation SDSS_J09324957+4725230...
18-Dec-2012 09:21:04.2:   (belongs to Project HST_CV, Plan SDSS_J09324957+4725230)
18-Dec-2012 09:21:04.2: Send Observation SDSS_J09324957+4725230 to ACP Sequencer
18-Dec-2012 09:21:14.2: Sequencer is now active
18-Dec-2012 09:32:40.5: Sequencer is no longer active
18-Dec-2012 09:32:40.5: Post-job status check done (stat=Completed)
18-Dec-2012 09:32:40.5: Acquisition time: 696.291623 sec.
18-Dec-2012 09:32:40.5: Data for Observation SDSS_J09324957+4725230 acquired successfully.
18-Dec-2012 09:32:40.5: Image Efficiency: 77.5%
18-Dec-2012 09:32:40.5: Cycle Efficiency: 100.0%
18-Dec-2012 09:32:40.6: ++ Auto Focus ++
18-Dec-2012 09:32:40.6: Doing periodic autofocus.
18-Dec-2012 09:32:40.6: Start special ACP AutoFocus script for scheduler
18-Dec-2012 09:32:50.6: Sequencer is now active
18-Dec-2012 09:36:21.4: Sequencer is no longer active
18-Dec-2012 09:36:21.4: Next periodic autofocus ASAP after 18-Dec-2012 11:35:39 UTC
18-Dec-2012 09:36:21.4: SelectRunning: No running plans
18-Dec-2012 09:36:21.4: Efficiency: Selecting from 7 pending plans:
18-Dec-2012 09:36:21.5:   Selected Plan 1RXS_J1050103-140431 (TotEff=1.21)
18-Dec-2012 09:36:21.5: Dispatcher cycle time: 0.1248003 sec.
18-Dec-2012 09:36:21.5: Acquire data for Observation 1RXS_J1050103-140431...
18-Dec-2012 09:36:21.5:   (belongs to Project HST_CV, Plan 1RXS_J1050103-140431)
18-Dec-2012 09:36:21.5: Send Observation 1RXS_J1050103-140431 to ACP Sequencer
18-Dec-2012 09:36:31.5: Sequencer is now active
18-Dec-2012 09:48:21.6: Sequencer is no longer active
18-Dec-2012 09:48:21.6: Post-job status check done (stat=Completed)
18-Dec-2012 09:48:21.6: Acquisition time: 720.0972647 sec.
18-Dec-2012 09:48:21.6: Data for Observation 1RXS_J1050103-140431 acquired successfully.
18-Dec-2012 09:48:21.6: Image Efficiency: 75.0%
18-Dec-2012 09:48:21.6: Cycle Efficiency: 100.0%
18-Dec-2012 09:48:21.7: SelectRunning: No running plans
18-Dec-2012 09:48:21.8: Efficiency: Selecting from 7 pending plans:
18-Dec-2012 09:48:21.8:   Selected Plan SA96_171 (TotEff=1.76)
18-Dec-2012 09:48:21.8: Dispatcher cycle time: 0.1248002 sec.
18-Dec-2012 09:48:21.8: Acquire data for Observation SA96_171...
18-Dec-2012 09:48:21.8:   (belongs to Project Landolt_2, Plan SA96_171)
18-Dec-2012 09:48:21.9: Send Observation SA96_171 to ACP Sequencer
18-Dec-2012 09:48:31.9: Sequencer is now active
18-Dec-2012 09:53:43.2: Sequencer is no longer active
18-Dec-2012 09:53:43.2: Post-job status check done (stat=Completed)
18-Dec-2012 09:53:43.2: Acquisition time: 321.3761645 sec.
18-Dec-2012 09:53:43.2: Data for Observation SA96_171 acquired successfully.
18-Dec-2012 09:53:43.3: Image Efficiency: 29.5%
18-Dec-2012 09:53:43.3: Cycle Efficiency: 100.0%
18-Dec-2012 09:53:43.4: SelectRunning: No running plans
18-Dec-2012 09:53:43.4: Efficiency: Selecting from 6 pending plans:
18-Dec-2012 09:53:43.4:   Selected Plan IU_Leo (TotEff=1.10)
18-Dec-2012 09:53:43.5: Dispatcher cycle time: 0.1092002 sec.
18-Dec-2012 09:53:43.5: Acquire data for Observation IU_Leo...
18-Dec-2012 09:53:43.5:   (belongs to Project HST_CV, Plan IU_Leo)
18-Dec-2012 09:53:43.5: Send Observation IU_Leo to ACP Sequencer
18-Dec-2012 09:53:53.5: Sequencer is now active
18-Dec-2012 10:06:16.4: Sequencer is no longer active
18-Dec-2012 10:06:16.4: Post-job status check done (stat=Completed)
18-Dec-2012 10:06:16.4: Acquisition time: 752.9509225 sec.
18-Dec-2012 10:06:16.4: Data for Observation IU_Leo acquired successfully.
18-Dec-2012 10:06:16.4: Image Efficiency: 71.7%
18-Dec-2012 10:06:16.4: Cycle Efficiency: 100.0%
18-Dec-2012 10:06:16.6: SelectRunning: No running plans
18-Dec-2012 10:06:16.6: Obs SA103 in Plan SA103 was vetoed by AirmassRange constraint.
18-Dec-2012 10:06:16.6:     AirmassRange estimates ready after 18-Dec-2012 16:44:54 UTC
18-Dec-2012 10:06:16.6: Efficiency: Selecting from 5 pending plans:
18-Dec-2012 10:06:16.6:   Selected Plan RZ_Leo (TotEff=1.44)
18-Dec-2012 10:06:16.7: Dispatcher cycle time: 0.1092002 sec.
18-Dec-2012 10:06:16.7: Acquire data for Observation RZ_Leo...
18-Dec-2012 10:06:16.7:   (belongs to Project HST_CV, Plan RZ_Leo)
18-Dec-2012 10:06:16.7: Send Observation RZ_Leo to ACP Sequencer
18-Dec-2012 10:06:26.7: Sequencer is now active
18-Dec-2012 10:17:44.1: Sequencer is no longer active
18-Dec-2012 10:17:44.1: Post-job status check done (stat=Completed)
18-Dec-2012 10:17:44.1: Acquisition time: 687.4620074 sec.
18-Dec-2012 10:17:44.1: Data for Observation RZ_Leo acquired successfully.
18-Dec-2012 10:17:44.1: Image Efficiency: 78.5%
18-Dec-2012 10:17:44.1: Cycle Efficiency: 100.0%
18-Dec-2012 10:17:44.2: SelectRunning: No running plans
18-Dec-2012 10:17:44.3: Efficiency: Selecting from 4 pending plans:
18-Dec-2012 10:17:44.3:   Selected Plan LN_UMa (TotEff=1.39)
18-Dec-2012 10:17:44.3: Dispatcher cycle time: 0.0780001 sec.
18-Dec-2012 10:17:44.3: Acquire data for Observation LN_UMa...
18-Dec-2012 10:17:44.3:   (belongs to Project HST_CV, Plan LN_UMa)
18-Dec-2012 10:17:44.3: Send Observation LN_UMa to ACP Sequencer
18-Dec-2012 10:17:54.4: Sequencer is now active
18-Dec-2012 10:29:39.3: Sequencer is no longer active
18-Dec-2012 10:29:39.3: Post-job status check done (stat=Completed)
18-Dec-2012 10:29:39.3: Acquisition time: 714.9804558 sec.
18-Dec-2012 10:29:39.3: Data for Observation LN_UMa acquired successfully.
18-Dec-2012 10:29:39.3: Image Efficiency: 75.5%
18-Dec-2012 10:29:39.3: Cycle Efficiency: 100.0%
18-Dec-2012 10:29:39.4: SelectRunning: No running plans
18-Dec-2012 10:29:39.5: Efficiency: Selecting from 3 pending plans:
18-Dec-2012 10:29:39.5:   Selected Plan IY_UMa (TotEff=1.38)
18-Dec-2012 10:29:39.5: Dispatcher cycle time: 0.0780002 sec.
18-Dec-2012 10:29:39.5: Acquire data for Observation IY_UMa...
18-Dec-2012 10:29:39.5:   (belongs to Project HST_CV, Plan IY_UMa)
18-Dec-2012 10:29:39.5: Send Observation IY_UMa to ACP Sequencer
18-Dec-2012 10:29:49.5: Sequencer is now active
18-Dec-2012 10:40:48.6: Sequencer is no longer active
18-Dec-2012 10:40:48.6: Post-job status check done (stat=Completed)
18-Dec-2012 10:40:48.6: Acquisition time: 669.0383751 sec.
18-Dec-2012 10:40:48.6: Data for Observation IY_UMa acquired successfully.
18-Dec-2012 10:40:48.6: Image Efficiency: 80.7%
18-Dec-2012 10:40:48.6: Cycle Efficiency: 100.0%
18-Dec-2012 10:40:48.7: SelectRunning: No running plans
18-Dec-2012 10:40:48.7: Efficiency: Selecting from 3 pending plans:
18-Dec-2012 10:40:48.7:   Selected Plan V0406_Vir (TotEff=1.42)
18-Dec-2012 10:40:48.8: Dispatcher cycle time: 0.0780001 sec.
18-Dec-2012 10:40:48.8: Acquire data for Observation V0406_Vir...
18-Dec-2012 10:40:48.8:   (belongs to Project HST_CV, Plan V0406_Vir)
18-Dec-2012 10:40:48.8: Send Observation V0406_Vir to ACP Sequencer
18-Dec-2012 10:40:58.8: Sequencer is now active
18-Dec-2012 10:52:42.1: Sequencer is no longer active
18-Dec-2012 10:52:42.1: Post-job status check done (stat=Completed)
18-Dec-2012 10:52:42.1: Acquisition time: 713.3112529 sec.
18-Dec-2012 10:52:42.1: Data for Observation V0406_Vir acquired successfully.
18-Dec-2012 10:52:42.1: Image Efficiency: 75.7%
18-Dec-2012 10:52:42.1: Cycle Efficiency: 100.0%
18-Dec-2012 10:52:42.2: SelectRunning: No running plans
18-Dec-2012 10:52:42.2: Efficiency: Selecting from 2 pending plans:
18-Dec-2012 10:52:42.2:   Selected Plan MR_UMa (TotEff=1.38)
18-Dec-2012 10:52:42.3: Dispatcher cycle time: 0.0624001 sec.
18-Dec-2012 10:52:42.3: Acquire data for Observation MR UMa...
18-Dec-2012 10:52:42.3:   (belongs to Project HST_CV, Plan MR_UMa)
18-Dec-2012 10:52:42.3: Send Observation MR UMa to ACP Sequencer
18-Dec-2012 10:52:52.3: Sequencer is now active
18-Dec-2012 11:04:28.0: Sequencer is no longer active
18-Dec-2012 11:04:28.0: Post-job status check done (stat=Completed)
18-Dec-2012 11:04:28.0: Acquisition time: 705.7296396 sec.
18-Dec-2012 11:04:28.0: Data for Observation MR UMa acquired successfully.
18-Dec-2012 11:04:28.0: Image Efficiency: 76.5%
18-Dec-2012 11:04:28.0: Cycle Efficiency: 100.0%
18-Dec-2012 11:04:28.1: SelectRunning: No running plans
18-Dec-2012 11:04:28.1: Efficiency: Only one pending plan IR_Com, it is the "best"
18-Dec-2012 11:04:28.2: Dispatcher cycle time: 0.0468001 sec.
18-Dec-2012 11:04:28.2: Acquire data for Observation IR_Com...
18-Dec-2012 11:04:28.2:   (belongs to Project HST_CV, Plan IR_Com)
18-Dec-2012 11:04:28.2: Send Observation IR_Com to ACP Sequencer
18-Dec-2012 11:04:38.2: Sequencer is now active
18-Dec-2012 11:16:02.0: Sequencer is no longer active
18-Dec-2012 11:16:02.0: Post-job status check done (stat=Completed)
18-Dec-2012 11:16:02.0: Acquisition time: 693.8112186 sec.
18-Dec-2012 11:16:02.0: Data for Observation IR_Com acquired successfully.
18-Dec-2012 11:16:02.0: Image Efficiency: 77.8%
18-Dec-2012 11:16:02.0: Cycle Efficiency: 100.0%
18-Dec-2012 11:16:02.1: SelectRunning: No running plans
18-Dec-2012 11:16:02.1: Efficiency: Only one pending plan SA103, it is the "best"
18-Dec-2012 11:16:02.1: Dispatcher cycle time: 0.0468001 sec.
18-Dec-2012 11:16:02.1: Acquire data for Observation SA103...
18-Dec-2012 11:16:02.1:   (belongs to Project Landolt_1, Plan SA103)
18-Dec-2012 11:16:02.1: Send Observation SA103 to ACP Sequencer
18-Dec-2012 11:16:12.2: Sequencer is now active
18-Dec-2012 11:21:21.0: Sequencer is no longer active
18-Dec-2012 11:21:21.0: Post-job status check done (stat=Completed)
18-Dec-2012 11:21:21.0: Acquisition time: 318.83336 sec.
18-Dec-2012 11:21:21.0: Data for Observation SA103 acquired successfully.
18-Dec-2012 11:21:21.0: Image Efficiency: 40.8%
18-Dec-2012 11:21:21.0: Cycle Efficiency: 100.0%
18-Dec-2012 11:21:21.1: SelectRunning: No running plans
18-Dec-2012 11:21:21.1: Efficiency: Only one pending plan SDSS_J14354402+2336387, it is the "best"
18-Dec-2012 11:21:21.2: Dispatcher cycle time: 0.0468001 sec.
18-Dec-2012 11:21:21.2: Acquire data for Observation SDSS_J14354402+2336387...
18-Dec-2012 11:21:21.2:   (belongs to Project HST_CV, Plan SDSS_J14354402+2336387)
18-Dec-2012 11:21:21.2: Send Observation SDSS_J14354402+2336387 to ACP Sequencer
18-Dec-2012 11:21:31.2: Sequencer is now active
18-Dec-2012 11:33:33.6: Sequencer is no longer active
18-Dec-2012 11:33:33.6: Post-job status check done (stat=Completed)
18-Dec-2012 11:33:33.6: Acquisition time: 732.4680865 sec.
18-Dec-2012 11:33:33.6: Data for Observation SDSS_J14354402+2336387 acquired successfully.
18-Dec-2012 11:33:33.6: Image Efficiency: 73.7%
18-Dec-2012 11:33:33.6: Cycle Efficiency: 100.0%
18-Dec-2012 11:33:33.7: SelectRunning: No running plans
18-Dec-2012 11:33:33.8: Efficiency: Only one pending plan SDSS_J15381735+5123380, it is the "best"
18-Dec-2012 11:33:33.8: Dispatcher cycle time: 0.0312001 sec.
18-Dec-2012 11:33:33.8: Acquire data for Observation SDSS_J15381735+5123380...
18-Dec-2012 11:33:33.8:   (belongs to Project HST_CV, Plan SDSS_J15381735+5123380)
18-Dec-2012 11:33:33.8: Send Observation SDSS_J15381735+5123380 to ACP Sequencer
18-Dec-2012 11:33:43.8: Sequencer is now active
18-Dec-2012 11:45:09.9: Sequencer is no longer active
18-Dec-2012 11:45:09.9: Post-job status check done (stat=Completed)
18-Dec-2012 11:45:09.9: Acquisition time: 696.0732226 sec.
18-Dec-2012 11:45:09.9: Data for Observation SDSS_J15381735+5123380 acquired successfully.
18-Dec-2012 11:45:09.9: Image Efficiency: 77.6%
18-Dec-2012 11:45:09.9: Cycle Efficiency: 100.0%
18-Dec-2012 11:45:10.0: ++ Auto Focus ++
18-Dec-2012 11:45:10.0: Doing periodic autofocus.
18-Dec-2012 11:45:10.0: Start special ACP AutoFocus script for scheduler
18-Dec-2012 11:45:20.0: Sequencer is now active
18-Dec-2012 11:48:46.3: Sequencer is no longer active
18-Dec-2012 11:48:46.3: Next periodic autofocus ASAP after 18-Dec-2012 13:48:18 UTC
18-Dec-2012 11:48:46.3: SelectRunning: No running plans
18-Dec-2012 11:48:46.3: Efficiency: Selecting from 2 pending plans:
18-Dec-2012 11:48:46.4:   Selected Plan SA98 (TotEff=1.94)
18-Dec-2012 11:48:46.4: Dispatcher cycle time: 0.0780001 sec.
18-Dec-2012 11:48:46.4: Acquire data for Observation SA98...
18-Dec-2012 11:48:46.4:   (belongs to Project Landolt_2, Plan SA98)
18-Dec-2012 11:48:46.4: Send Observation SA98 to ACP Sequencer
18-Dec-2012 11:48:56.4: Sequencer is now active
18-Dec-2012 11:54:03.5: Sequencer is no longer active
18-Dec-2012 11:54:03.5: Post-job status check done (stat=Completed)
18-Dec-2012 11:54:03.5: Acquisition time: 317.101757 sec.
18-Dec-2012 11:54:03.5: Data for Observation SA98 acquired successfully.
18-Dec-2012 11:54:03.5: Image Efficiency: 41.0%
18-Dec-2012 11:54:03.5: Cycle Efficiency: 100.0%
18-Dec-2012 11:54:03.7: SelectRunning: No running plans
18-Dec-2012 11:54:03.7: Efficiency: Only one pending plan SA106, it is the "best"
18-Dec-2012 11:54:03.7: Dispatcher cycle time: 0.0468001 sec.
18-Dec-2012 11:54:03.7: Acquire data for Observation SA106...
18-Dec-2012 11:54:03.7:   (belongs to Project Landolt_2, Plan SA106)
18-Dec-2012 11:54:03.7: Send Observation SA106 to ACP Sequencer
18-Dec-2012 11:54:13.7: Sequencer is now active
18-Dec-2012 12:00:20.9: Sequencer is no longer active
18-Dec-2012 12:00:20.9: Post-job status check done (stat=Completed)
18-Dec-2012 12:00:20.9: Acquisition time: 377.2086625 sec.
18-Dec-2012 12:00:20.9: Data for Observation SA106 acquired successfully.
18-Dec-2012 12:00:20.9: Image Efficiency: 34.5%
18-Dec-2012 12:00:20.9: Cycle Efficiency: 100.0%
18-Dec-2012 12:00:21.0: SelectRunning: No running plans
18-Dec-2012 12:00:21.0: No pending plans that can be started now.
18-Dec-2012 12:00:21.0: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:00:51.5: SelectRunning: No running plans
18-Dec-2012 12:00:51.5: No pending plans that can be started now.
18-Dec-2012 12:00:51.5: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:01:22.3: SelectRunning: No running plans
18-Dec-2012 12:01:22.3: No pending plans that can be started now.
18-Dec-2012 12:01:22.3: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:01:53.1: SelectRunning: No running plans
18-Dec-2012 12:01:53.1: No pending plans that can be started now.
18-Dec-2012 12:01:53.1: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:02:23.9: SelectRunning: No running plans
18-Dec-2012 12:02:23.9: No pending plans that can be started now.
18-Dec-2012 12:02:23.9: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:02:54.7: SelectRunning: No running plans
18-Dec-2012 12:02:54.7: No pending plans that can be started now.
18-Dec-2012 12:02:54.7: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:03:25.6: SelectRunning: No running plans
18-Dec-2012 12:03:25.6: No pending plans that can be started now.
18-Dec-2012 12:03:25.6: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:03:56.4: SelectRunning: No running plans
18-Dec-2012 12:03:56.4: No pending plans that can be started now.
18-Dec-2012 12:03:56.4: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:04:27.2: SelectRunning: No running plans
18-Dec-2012 12:04:27.2: No pending plans that can be started now.
18-Dec-2012 12:04:27.2: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:04:58.0: SelectRunning: No running plans
18-Dec-2012 12:04:58.0: No pending plans that can be started now.
18-Dec-2012 12:04:58.0: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:05:28.9: SelectRunning: No running plans
18-Dec-2012 12:05:28.9: No pending plans that can be started now.
18-Dec-2012 12:05:28.9: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:05:59.7: SelectRunning: No running plans
18-Dec-2012 12:05:59.7: No pending plans that can be started now.
18-Dec-2012 12:05:59.7: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:06:30.5: SelectRunning: No running plans
18-Dec-2012 12:06:30.5: No pending plans that can be started now.
18-Dec-2012 12:06:30.5: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:07:01.3: SelectRunning: No running plans
18-Dec-2012 12:07:01.3: No pending plans that can be started now.
18-Dec-2012 12:07:01.3: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:07:32.2: SelectRunning: No running plans
18-Dec-2012 12:07:32.2: No pending plans that can be started now.
18-Dec-2012 12:07:32.2: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:08:03.0: SelectRunning: No running plans
18-Dec-2012 12:08:03.0: No pending plans that can be started now.
18-Dec-2012 12:08:03.0: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:08:33.8: SelectRunning: No running plans
18-Dec-2012 12:08:33.8: No pending plans that can be started now.
18-Dec-2012 12:08:33.8: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:09:04.6: SelectRunning: No running plans
18-Dec-2012 12:09:04.6: No pending plans that can be started now.
18-Dec-2012 12:09:04.6: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:09:35.5: SelectRunning: No running plans
18-Dec-2012 12:09:35.5: No pending plans that can be started now.
18-Dec-2012 12:09:35.5: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:10:06.3: SelectRunning: No running plans
18-Dec-2012 12:10:06.3: No pending plans that can be started now.
18-Dec-2012 12:10:06.3: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:10:37.1: SelectRunning: No running plans
18-Dec-2012 12:10:37.1: No pending plans that can be started now.
18-Dec-2012 12:10:37.1: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:11:07.9: SelectRunning: No running plans
18-Dec-2012 12:11:07.9: No pending plans that can be started now.
18-Dec-2012 12:11:07.9: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:11:38.8: SelectRunning: No running plans
18-Dec-2012 12:11:38.8: No pending plans that can be started now.
18-Dec-2012 12:11:38.8: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:12:09.6: SelectRunning: No running plans
18-Dec-2012 12:12:09.6: No pending plans that can be started now.
18-Dec-2012 12:12:09.6: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:12:40.4: SelectRunning: No running plans
18-Dec-2012 12:12:40.4: No pending plans that can be started now.
18-Dec-2012 12:12:40.4: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:13:11.3: SelectRunning: No running plans
18-Dec-2012 12:13:11.3: No pending plans that can be started now.
18-Dec-2012 12:13:11.3: Dispatcher cycle time: 0.0156 sec.
18-Dec-2012 12:13:42.1: SelectRunning: No running plans
18-Dec-2012 12:13:42.1: No pending plans that can be started now.
18-Dec-2012 12:13:42.1: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:14:12.9: SelectRunning: No running plans
18-Dec-2012 12:14:12.9: No pending plans that can be started now.
18-Dec-2012 12:14:12.9: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:14:43.7: SelectRunning: No running plans
18-Dec-2012 12:14:43.7: No pending plans that can be started now.
18-Dec-2012 12:14:43.7: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:15:14.6: SelectRunning: No running plans
18-Dec-2012 12:15:14.6: No pending plans that can be started now.
18-Dec-2012 12:15:14.6: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:15:45.4: SelectRunning: No running plans
18-Dec-2012 12:15:45.4: No pending plans that can be started now.
18-Dec-2012 12:15:45.4: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:16:16.2: SelectRunning: No running plans
18-Dec-2012 12:16:16.2: No pending plans that can be started now.
18-Dec-2012 12:16:16.2: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:16:47.0: SelectRunning: No running plans
18-Dec-2012 12:16:47.0: No pending plans that can be started now.
18-Dec-2012 12:16:47.0: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:17:17.9: SelectRunning: No running plans
18-Dec-2012 12:17:17.9: No pending plans that can be started now.
18-Dec-2012 12:17:17.9: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:17:48.7: SelectRunning: No running plans
18-Dec-2012 12:17:48.7: No pending plans that can be started now.
18-Dec-2012 12:17:48.7: Dispatcher cycle time: 0.0156 sec.
18-Dec-2012 12:18:19.5: SelectRunning: No running plans
18-Dec-2012 12:18:19.5: No pending plans that can be started now.
18-Dec-2012 12:18:19.5: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:18:50.3: SelectRunning: No running plans
18-Dec-2012 12:18:50.3: No pending plans that can be started now.
18-Dec-2012 12:18:50.3: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:19:21.2: SelectRunning: No running plans
18-Dec-2012 12:19:21.2: No pending plans that can be started now.
18-Dec-2012 12:19:21.2: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:19:52.0: SelectRunning: No running plans
18-Dec-2012 12:19:52.0: No pending plans that can be started now.
18-Dec-2012 12:19:52.0: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:20:22.8: SelectRunning: No running plans
18-Dec-2012 12:20:22.8: No pending plans that can be started now.
18-Dec-2012 12:20:22.8: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:20:53.6: SelectRunning: No running plans
18-Dec-2012 12:20:53.6: No pending plans that can be started now.
18-Dec-2012 12:20:53.6: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:21:24.5: SelectRunning: No running plans
18-Dec-2012 12:21:24.5: No pending plans that can be started now.
18-Dec-2012 12:21:24.5: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:21:55.3: SelectRunning: No running plans
18-Dec-2012 12:21:55.3: No pending plans that can be started now.
18-Dec-2012 12:21:55.3: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:22:26.1: SelectRunning: No running plans
18-Dec-2012 12:22:26.1: No pending plans that can be started now.
18-Dec-2012 12:22:26.1: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:22:56.9: SelectRunning: No running plans
18-Dec-2012 12:22:56.9: No pending plans that can be started now.
18-Dec-2012 12:22:56.9: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:23:27.8: SelectRunning: No running plans
18-Dec-2012 12:23:27.8: Efficiency: Only one pending plan SDSS_J15445360+2553488, it is the "best"
18-Dec-2012 12:23:27.8: Dispatcher cycle time: 0.0312 sec.
18-Dec-2012 12:23:27.8: Acquire data for Observation SDSS_J15445360+2553488...
18-Dec-2012 12:23:27.8:   (belongs to Project HST_CV, Plan SDSS_J15445360+2553488)
18-Dec-2012 12:23:27.8: Send Observation SDSS_J15445360+2553488 to ACP Sequencer
18-Dec-2012 12:23:37.8: Sequencer is now active
18-Dec-2012 12:35:04.5: Sequencer is no longer active
18-Dec-2012 12:35:04.5: Post-job status check done (stat=Completed)
18-Dec-2012 12:35:04.5: Acquisition time: 696.6660237 sec.
18-Dec-2012 12:35:04.5: Data for Observation SDSS_J15445360+2553488 acquired successfully.
18-Dec-2012 12:35:04.5: Image Efficiency: 77.5%
18-Dec-2012 12:35:04.5: Cycle Efficiency: 100.0%
18-Dec-2012 12:35:04.6: SelectRunning: No running plans
18-Dec-2012 12:35:04.6: No pending plans that can be started now.
18-Dec-2012 12:35:04.6: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:35:35.1: SelectRunning: No running plans
18-Dec-2012 12:35:35.1: No pending plans that can be started now.
18-Dec-2012 12:35:35.1: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:36:06.0: SelectRunning: No running plans
18-Dec-2012 12:36:06.0: No pending plans that can be started now.
18-Dec-2012 12:36:06.0: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:36:36.8: SelectRunning: No running plans
18-Dec-2012 12:36:36.8: No pending plans that can be started now.
18-Dec-2012 12:36:36.8: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:37:07.6: SelectRunning: No running plans
18-Dec-2012 12:37:07.6: No pending plans that can be started now.
18-Dec-2012 12:37:07.6: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:37:38.4: SelectRunning: No running plans
18-Dec-2012 12:37:38.4: No pending plans that can be started now.
18-Dec-2012 12:37:38.4: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:38:09.3: SelectRunning: No running plans
18-Dec-2012 12:38:09.3: No pending plans that can be started now.
18-Dec-2012 12:38:09.3: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:38:40.1: SelectRunning: No running plans
18-Dec-2012 12:38:40.1: No pending plans that can be started now.
18-Dec-2012 12:38:40.1: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:39:10.9: SelectRunning: No running plans
18-Dec-2012 12:39:10.9: No pending plans that can be started now.
18-Dec-2012 12:39:10.9: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:39:41.7: SelectRunning: No running plans
18-Dec-2012 12:39:41.7: Obs SA84 in Plan SA84 vetoed for sequencer hard limit.
18-Dec-2012 12:39:41.7:  (deferred for 64 min, until 18-Dec-2012 13:43:41 UTC
18-Dec-2012 12:39:41.7: No pending plans that can be started now.
18-Dec-2012 12:39:41.7: Dispatcher cycle time: 0.0156 sec.
18-Dec-2012 12:40:12.5: SelectRunning: No running plans
18-Dec-2012 12:40:12.5: No pending plans that can be started now.
18-Dec-2012 12:40:12.5: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:40:43.4: SelectRunning: No running plans
18-Dec-2012 12:40:43.4: No pending plans that can be started now.
18-Dec-2012 12:40:43.4: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:41:14.2: SelectRunning: No running plans
18-Dec-2012 12:41:14.2: No pending plans that can be started now.
18-Dec-2012 12:41:14.2: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:41:45.0: SelectRunning: No running plans
18-Dec-2012 12:41:45.0: No pending plans that can be started now.
18-Dec-2012 12:41:45.0: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:42:15.9: SelectRunning: No running plans
18-Dec-2012 12:42:15.9: No pending plans that can be started now.
18-Dec-2012 12:42:15.9: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:42:46.7: SelectRunning: No running plans
18-Dec-2012 12:42:46.7: No pending plans that can be started now.
18-Dec-2012 12:42:46.7: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:43:17.5: SelectRunning: No running plans
18-Dec-2012 12:43:17.5: No pending plans that can be started now.
18-Dec-2012 12:43:17.5: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:43:48.3: SelectRunning: No running plans
18-Dec-2012 12:43:48.3: No pending plans that can be started now.
18-Dec-2012 12:43:48.3: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:44:19.2: SelectRunning: No running plans
18-Dec-2012 12:44:19.2: No pending plans that can be started now.
18-Dec-2012 12:44:19.2: Dispatcher cycle time: 0 sec.
18-Dec-2012 12:44:50.0: SelectRunning: No running plans
18-Dec-2012 12:44:50.0: Efficiency: Only one pending plan QZ_Ser, it is the "best"
18-Dec-2012 12:44:50.0: Dispatcher cycle time: 0.0312 sec.
18-Dec-2012 12:44:50.0: Acquire data for Observation QZ_Ser...
18-Dec-2012 12:44:50.0:   (belongs to Project HST_CV, Plan QZ_Ser)
18-Dec-2012 12:44:50.0: Send Observation QZ_Ser to ACP Sequencer
18-Dec-2012 12:45:00.1: Sequencer is now active
18-Dec-2012 12:55:56.8: Sequencer is no longer active
18-Dec-2012 12:55:56.8: Post-job status check done (stat=Completed)
18-Dec-2012 12:55:56.8: Acquisition time: 666.729571 sec.
18-Dec-2012 12:55:56.8: Data for Observation QZ_Ser acquired successfully.
18-Dec-2012 12:55:56.8: Image Efficiency: 81.0%
18-Dec-2012 12:55:56.8: Cycle Efficiency: 100.0%
18-Dec-2012 12:55:56.9: SelectRunning: No running plans
18-Dec-2012 12:55:56.9: Efficiency: Selecting from 2 pending plans:
18-Dec-2012 12:55:56.9:   Selected Plan SA61 (TotEff=1.95)
18-Dec-2012 12:55:57.0: Dispatcher cycle time: 0.0624001 sec.
18-Dec-2012 12:55:57.0: Acquire data for Observation SA61...
18-Dec-2012 12:55:57.0:   (belongs to Project Landolt_2, Plan SA61)
18-Dec-2012 12:55:57.0: Send Observation SA61 to ACP Sequencer
18-Dec-2012 12:56:07.0: Sequencer is now active
18-Dec-2012 13:00:52.7: Sequencer is no longer active
18-Dec-2012 13:00:52.7: Post-job status check done (stat=Completed)
18-Dec-2012 13:00:52.7: Acquisition time: 295.7453195 sec.
18-Dec-2012 13:00:52.7: Data for Observation SA61 acquired successfully.
18-Dec-2012 13:00:52.7: Image Efficiency: 43.9%
18-Dec-2012 13:00:52.7: Cycle Efficiency: 100.0%
18-Dec-2012 13:00:52.8: SelectRunning: No running plans
18-Dec-2012 13:00:52.8: Efficiency: Only one pending plan SA99_438, it is the "best"
18-Dec-2012 13:00:52.9: Dispatcher cycle time: 0.0312001 sec.
18-Dec-2012 13:00:52.9: Acquire data for Observation SA99_438...
18-Dec-2012 13:00:52.9:   (belongs to Project Landolt_2, Plan SA99_438)
18-Dec-2012 13:00:52.9: Send Observation SA99_438 to ACP Sequencer
18-Dec-2012 13:01:02.9: Sequencer is now active
18-Dec-2012 13:04:14.4: Sequencer is no longer active
18-Dec-2012 13:04:14.4: Post-job status check done (stat=Failed)
18-Dec-2012 13:04:14.4: ACP data acquisition failed for Observation SA99_438.
18-Dec-2012 13:04:14.4:   (Observation SA99_438 interrupted by acquisition process failure.)
18-Dec-2012 13:04:14.5: SelectRunning: No running plans
18-Dec-2012 13:04:14.5: No pending plans that can be started now.
18-Dec-2012 13:04:14.5: Dispatcher cycle time: 0 sec.
18-Dec-2012 13:04:45.1: ++ Dawn Flats ++
18-Dec-2012 13:04:45.1: Start ACP AutoFlat script for Dawn
18-Dec-2012 13:04:55.2: Sequencer is now active
18-Dec-2012 14:00:27.4: Sequencer is no longer active
18-Dec-2012 14:00:27.4: -- Observatory Shutdown --
18-Dec-2012 14:00:27.4: Weather disconnected.
18-Dec-2012 14:00:27.4: Start ACP Sequencer's ShutdownObs script
18-Dec-2012 14:00:37.4: Sequencer is now active
18-Dec-2012 14:05:32.8: Sequencer is no longer active
18-Dec-2012 14:05:32.9: Weather successfully connected. Wait for valid data...
18-Dec-2012 19:05:45.3: Run statistics:
18-Dec-2012 19:05:45.3:   Observations:   93
18-Dec-2012 19:05:45.3:   Considered:     46
18-Dec-2012 19:05:45.3:   Completed:      44
18-Dec-2012 19:05:45.3:   Skipped:        1
18-Dec-2012 19:05:45.3:   Never Eligible: 47
18-Dec-2012 19:05:45.3:   Failed:         1
Log closed at Tue, Dec 18 2012 19:05:45 UTC (actual time)