Log opened at Thu, Jan 25 2018 01:20:43 UTC (actual time)
Current log level is Debug
Scheduler version 3.5.3
Multi-user license: Arne Henden
25-Jan-2018 01:20:43.0: Simulated clock initialized at 25-Jan-2018 01:20:43 UTC
25-Jan-2018 01:20:43.1: Loaded Constraint plugin AirMass
25-Jan-2018 01:20:43.1: Loaded Constraint plugin AirmassRange
25-Jan-2018 01:20:43.1: Loaded Constraint plugin Horizon
25-Jan-2018 01:20:43.1: Loaded Constraint plugin HourAngle
25-Jan-2018 01:20:43.1: Loaded Constraint plugin MoonAvoid
25-Jan-2018 01:20:43.1: Loaded Constraint plugin MoonDown
25-Jan-2018 01:20:43.1: Loaded Constraint plugin SkyCondition
25-Jan-2018 01:20:43.1: Loaded Constraint plugin TimeRange
25-Jan-2018 01:20:43.6: 31 plans are now pending.
25-Jan-2018 01:20:43.6: Attach ACP sequencer
25-Jan-2018 01:21:05.5: Weather successfully connected. Wait for valid data...
25-Jan-2018 01:21:05.6: -- Weather Unsafe --
25-Jan-2018 01:21:20.0: Dispatcher started at 25-Jan-2018 01:21:20 UTC
25-Jan-2018 01:21:20.0:     Priority:          W[0]=0.00
25-Jan-2018 01:21:20.0:     Transit Altitude:  W[1]=0.70
25-Jan-2018 01:21:20.0:     Highest Altitude:  W[6]=0.00
25-Jan-2018 01:21:20.0:     Lateness:          W[5]=0.00
25-Jan-2018 01:21:20.0:     Slew Distance:     W[2]=0.00
25-Jan-2018 01:21:20.0:     Retry Count:       W[3]=0.20
25-Jan-2018 01:21:20.0:     Meridian Crossing: W[4]=0.00
25-Jan-2018 01:21:20.0:     Obs Conditions:    W[7]=0.40
25-Jan-2018 01:21:20.0:     Rising Plan Delay: disabled
25-Jan-2018 02:58:54.4: ++ Weather Safe ++
25-Jan-2018 02:58:55.5: ++ Observatory Startup ++
25-Jan-2018 02:58:55.5: Start ACP Sequencer's StartupObs script
25-Jan-2018 02:59:05.5: Sequencer is now active
25-Jan-2018 02:59:15.2: Sequencer is no longer active
25-Jan-2018 02:59:15.3: Open the observatory dome/roof
25-Jan-2018 03:00:21.3: ++ Auto Focus ++
25-Jan-2018 03:00:21.3: Doing initial autofocus.
25-Jan-2018 03:00:21.3: Start special ACP AutoFocus script for scheduler
25-Jan-2018 03:00:31.3: Sequencer is now active
25-Jan-2018 03:03:49.3: Sequencer is no longer active
25-Jan-2018 03:03:49.3: Next periodic autofocus ASAP after 25-Jan-2018 06:03:31 UTC
25-Jan-2018 03:03:49.8: Plan V0959_Mon has Monitor Mode. Time to resubmit it.
25-Jan-2018 03:03:49.8: Plan MP_Gem has Monitor Mode. Time to resubmit it.
25-Jan-2018 03:03:49.8: Plan CB_32 has Monitor Mode. Time to resubmit it.
25-Jan-2018 03:03:49.8: Plan V0965_Per has Monitor Mode. Time to resubmit it.
25-Jan-2018 03:03:49.8: Plan T_Ori has Monitor Mode. Time to resubmit it.
25-Jan-2018 03:03:49.8: Plan RX_J0524+42 has Monitor Mode. Time to resubmit it.
25-Jan-2018 03:03:49.8: SelectRunning: No running plans
25-Jan-2018 03:03:49.9: Obs 2MASS_J19395313+0557550 in Plan 2MASS_J19395313+0557550 was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:49.9:     AirmassRange estimates ready after 25-Jan-2018 14:34:39 UTC
25-Jan-2018 03:03:49.9: Obs AL_Boo in Plan AL_Boo was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:49.9:     AirmassRange estimates ready after 25-Jan-2018 08:04:02 UTC
25-Jan-2018 03:03:49.9: Obs BC_Lac in Plan BC_Lac was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:49.9:     AirmassRange estimates ready after 25-Jan-2018 16:10:53 UTC
25-Jan-2018 03:03:49.9: Obs CV_Vir in Plan CV_Vir was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:49.9:     AirmassRange estimates ready after 25-Jan-2018 07:10:47 UTC
25-Jan-2018 03:03:49.9: Obs IRAS_19067+2158 in Plan IRAS_19067+2158 was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:49.9:     AirmassRange estimates ready after 25-Jan-2018 13:26:03 UTC
25-Jan-2018 03:03:49.9: Obs IRAS_19183+2339 in Plan IRAS_19183+2339 was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:49.9:     AirmassRange estimates ready after 25-Jan-2018 13:34:07 UTC
25-Jan-2018 03:03:49.9: Obs KK_UMa in Plan KK_UMa was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:49.9:     AirmassRange estimates ready after 25-Jan-2018 04:43:53 UTC
25-Jan-2018 03:03:49.9: Obs M56 in Plan M56 was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:49.9:     AirmassRange estimates ready after 25-Jan-2018 13:17:44 UTC
25-Jan-2018 03:03:49.9: Obs M67 in Plan M67 was vetoed by AirMass constraint.
25-Jan-2018 03:03:49.9:     AirMass estimates ready after 25-Jan-2018 04:01:42 UTC
25-Jan-2018 03:03:49.9: Obs Mkn_501 in Plan Mkn_501 was vetoed by AirMass constraint.
25-Jan-2018 03:03:49.9:     AirMass estimates ready after 25-Jan-2018 10:37:57 UTC
25-Jan-2018 03:03:50.0: Obs NSVS_11201899 in Plan NSVS_11201899 was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.0:     AirmassRange estimates ready after 25-Jan-2018 13:27:04 UTC
25-Jan-2018 03:03:50.0: Obs SDSSJ121027+502735 in Plan SDSSJ121027+502735 was vetoed by AirMass constraint.
25-Jan-2018 03:03:50.0:     AirMass estimates ready after 25-Jan-2018 05:36:31 UTC
25-Jan-2018 03:03:50.0: Obs U_Aqr in Plan U_Aqr was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.0:     AirmassRange estimates ready after 25-Jan-2018 18:24:25 UTC
25-Jan-2018 03:03:50.0: Obs V0336_Ser in Plan V0336_Ser was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.0:     AirmassRange estimates ready after 25-Jan-2018 10:21:52 UTC
25-Jan-2018 03:03:50.0: Obs V1015_Her in Plan V1015_Her was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.0:     AirmassRange estimates ready after 25-Jan-2018 11:46:21 UTC
25-Jan-2018 03:03:50.0: Obs V1721_Aql in Plan V1721_Aql was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.0:     AirmassRange estimates ready after 25-Jan-2018 13:58:15 UTC
25-Jan-2018 03:03:50.0: Obs V1722_Aql in Plan V1722_Aql was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.0:     AirmassRange estimates ready after 25-Jan-2018 13:45:57 UTC
25-Jan-2018 03:03:50.1: Obs V1723_Aql in Plan V1723_Aql was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.1:     AirmassRange estimates ready after 25-Jan-2018 14:12:19 UTC
25-Jan-2018 03:03:50.1: Obs V1724_Aql in Plan V1724_Aql was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.1:     AirmassRange estimates ready after 25-Jan-2018 14:05:46 UTC
25-Jan-2018 03:03:50.1: Obs V1904_Cyg in Plan V1904_Cyg was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.1:     AirmassRange estimates ready after 25-Jan-2018 15:18:27 UTC
25-Jan-2018 03:03:50.1: Obs V1907_Cyg in Plan V1907_Cyg was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.1:     AirmassRange estimates ready after 25-Jan-2018 15:15:07 UTC
25-Jan-2018 03:03:50.1: Obs V2481_Cyg in Plan V2481_Cyg was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.1:     AirmassRange estimates ready after 25-Jan-2018 14:51:05 UTC
25-Jan-2018 03:03:50.1: Obs V339_Del_TMO61 in Plan V339_Del_TMO61 was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.1:     AirmassRange estimates ready after 25-Jan-2018 14:43:08 UTC
25-Jan-2018 03:03:50.1: Obs V841_Oph in Plan V841_Oph was vetoed by AirmassRange constraint.
25-Jan-2018 03:03:50.1:     AirmassRange estimates ready after 25-Jan-2018 13:01:34 UTC
25-Jan-2018 03:03:50.1: Efficiency: Selecting from 13 pending plans:
25-Jan-2018 03:03:50.2:   Selected Plan T_Ori (TotEff=0.84)
25-Jan-2018 03:03:50.3: Dispatcher cycle time: 0.9180525 sec.
25-Jan-2018 03:03:50.3: Acquire data for Observation T_Ori...
25-Jan-2018 03:03:50.3:   (belongs to Project AAVSO_Monitoring, Plan T_Ori)
25-Jan-2018 03:03:50.3: Doing 3 sets
25-Jan-2018 03:03:50.3: Send Observation T_Ori to ACP Sequencer
25-Jan-2018 03:04:00.3: Sequencer is now active
25-Jan-2018 03:08:00.1: Sequencer is no longer active
25-Jan-2018 03:08:00.1: Post-job status check done (stat=Completed)
25-Jan-2018 03:08:00.1: Send Observation T_Ori to ACP Sequencer
25-Jan-2018 03:08:10.1: Sequencer is now active
25-Jan-2018 03:10:57.2: Sequencer is no longer active
25-Jan-2018 03:10:57.2: Post-job status check done (stat=Completed)
25-Jan-2018 03:10:57.2: Send Observation T_Ori to ACP Sequencer
25-Jan-2018 03:11:07.2: Sequencer is now active
25-Jan-2018 03:13:54.9: Sequencer is no longer active
25-Jan-2018 03:13:54.9: Post-job status check done (stat=Completed)
25-Jan-2018 03:13:54.9: Acquisition time: 604.5845803 sec.
25-Jan-2018 03:13:54.9: Data for Observation T_Ori acquired successfully.
25-Jan-2018 03:13:54.9: Image Efficiency: 44.6%
25-Jan-2018 03:13:54.9: Cycle Efficiency: 99.8%
25-Jan-2018 03:13:55.4: SelectRunning: No running plans
25-Jan-2018 03:13:55.4: STRICT VETO:
25-Jan-2018 03:13:55.4: Obs V0809_Cep in Plan V0809_Cep was vetoed by AirmassRange constraint.
25-Jan-2018 03:13:55.4:     AirmassRange estimates ready after 25-Jan-2018 16:13:20 UTC
25-Jan-2018 03:13:55.4: Efficiency: Selecting from 11 pending plans:
25-Jan-2018 03:13:55.5:   Selected Plan CB_32 (TotEff=0.85)
25-Jan-2018 03:13:55.6: Dispatcher cycle time: 0.3060175 sec.
25-Jan-2018 03:13:55.6: Acquire data for Observation CB_32...
25-Jan-2018 03:13:55.6:   (belongs to Project Staels, Plan CB_32)
25-Jan-2018 03:13:55.6: Send Observation CB_32 to ACP Sequencer
25-Jan-2018 03:14:05.6: Sequencer is now active
25-Jan-2018 03:17:45.6: Sequencer is no longer active
25-Jan-2018 03:17:45.6: Post-job status check done (stat=Completed)
25-Jan-2018 03:17:45.6: Acquisition time: 229.9571528 sec.
25-Jan-2018 03:17:45.6: Data for Observation CB_32 acquired successfully.
25-Jan-2018 03:17:45.6: Image Efficiency: 39.1%
25-Jan-2018 03:17:45.6: Cycle Efficiency: 99.9%
25-Jan-2018 03:17:45.9: SelectRunning: No running plans
25-Jan-2018 03:17:46.0: Efficiency: Selecting from 10 pending plans:
25-Jan-2018 03:17:46.1:   Selected Plan V0965_Per (TotEff=0.80)
25-Jan-2018 03:17:46.1: Dispatcher cycle time: 0.2130121 sec.
25-Jan-2018 03:17:46.1: Acquire data for Observation V0965_Per...
25-Jan-2018 03:17:46.2:   (belongs to Project Nova_Monitoring, Plan V0965_Per)
25-Jan-2018 03:17:46.2: Send Observation V0965_Per to ACP Sequencer
25-Jan-2018 03:17:56.2: Sequencer is now active
25-Jan-2018 03:37:25.4: Sequencer is no longer active
25-Jan-2018 03:37:25.4: Post-job status check done (stat=Completed)
25-Jan-2018 03:37:25.4: Acquisition time: 1179.2474491 sec.
25-Jan-2018 03:37:25.4: Data for Observation V0965_Per acquired successfully.
25-Jan-2018 03:37:25.4: Image Efficiency: 76.3%
25-Jan-2018 03:37:25.4: Cycle Efficiency: 100.0%
25-Jan-2018 03:37:25.6: SelectRunning: No running plans
25-Jan-2018 03:37:25.7: Efficiency: Selecting from 9 pending plans:
25-Jan-2018 03:37:25.7:   Selected Plan V0959_Mon (TotEff=0.78)
25-Jan-2018 03:37:25.8: Dispatcher cycle time: 0.2130122 sec.
25-Jan-2018 03:37:25.8: Acquire data for Observation V0959_Mon...
25-Jan-2018 03:37:25.8:   (belongs to Project Nova_Monitoring, Plan V0959_Mon)
25-Jan-2018 03:37:26.1: Send Observation V0959_Mon to ACP Sequencer
25-Jan-2018 03:37:36.1: Sequencer is now active
25-Jan-2018 03:53:01.5: Sequencer is no longer active
25-Jan-2018 03:53:01.5: Post-job status check done (stat=Completed)
25-Jan-2018 03:53:01.5: Acquisition time: 935.6515163 sec.
25-Jan-2018 03:53:01.5: Data for Observation V0959_Mon acquired successfully.
25-Jan-2018 03:53:01.5: Image Efficiency: 67.3%
25-Jan-2018 03:53:01.5: Cycle Efficiency: 100.0%
25-Jan-2018 03:53:01.6: SelectRunning: No running plans
25-Jan-2018 03:53:01.6: Obs GSC_3649-0825 in Plan GSC_3649-0825 was vetoed by AirMass constraint.
25-Jan-2018 03:53:01.6:     AirMass estimates ready after 25-Jan-2018 16:48:05 UTC
25-Jan-2018 03:53:01.7: Efficiency: Selecting from 7 pending plans:
25-Jan-2018 03:53:01.7:   Selected Plan MP_Gem (TotEff=0.77)
25-Jan-2018 03:53:01.8: Dispatcher cycle time: 0.1690096 sec.
25-Jan-2018 03:53:01.8: Acquire data for Observation MP_Gem...
25-Jan-2018 03:53:01.8:   (belongs to Project Staels, Plan MP_Gem)
25-Jan-2018 03:53:01.8: Send Observation MP_Gem to ACP Sequencer
25-Jan-2018 03:53:11.8: Sequencer is now active
25-Jan-2018 04:23:42.2: Sequencer is no longer active
25-Jan-2018 04:23:42.3: Post-job status check done (stat=Completed)
25-Jan-2018 04:23:42.3: Acquisition time: 1840.4512678 sec.
25-Jan-2018 04:23:42.3: Data for Observation MP_Gem acquired successfully.
25-Jan-2018 04:23:42.3: Image Efficiency: 78.2%
25-Jan-2018 04:23:42.3: Cycle Efficiency: 100.0%
25-Jan-2018 04:23:42.6: SelectRunning: No running plans
25-Jan-2018 04:23:42.6: STRICT VETO:
25-Jan-2018 04:23:42.6: Obs AF_And in Plan AF_And was vetoed by AirMass constraint.
25-Jan-2018 04:23:42.6:     AirMass estimates ready after 25-Jan-2018 18:23:48 UTC
25-Jan-2018 04:23:42.6: STRICT VETO:
25-Jan-2018 04:23:42.6: Obs NGC_7790 in Plan NGC_7790 was vetoed by AirmassRange constraint.
25-Jan-2018 04:23:42.6:     AirmassRange estimates ready after 25-Jan-2018 17:02:41 UTC
25-Jan-2018 04:23:42.7: Efficiency: Selecting from 5 pending plans:
25-Jan-2018 04:23:42.7:   Selected Plan RX_J0524+42 (TotEff=0.70)
25-Jan-2018 04:23:42.8: Dispatcher cycle time: 0.1480084 sec.
25-Jan-2018 04:23:42.8: Acquire data for Observation RX_J0524+42...
25-Jan-2018 04:23:42.8:   (belongs to Project Walker, Plan RX_J0524+42)
25-Jan-2018 04:23:42.8: Doing 30 sets
25-Jan-2018 04:23:42.8: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 04:23:52.8: Sequencer is now active
25-Jan-2018 04:49:32.3: Sequencer is no longer active
25-Jan-2018 04:49:32.3: Post-job status check done (stat=Completed)
25-Jan-2018 04:49:32.3: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 04:49:42.4: Sequencer is now active
25-Jan-2018 05:14:46.4: Sequencer is no longer active
25-Jan-2018 05:14:46.4: Post-job status check done (stat=Completed)
25-Jan-2018 05:14:46.4: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 05:14:56.4: Sequencer is now active
25-Jan-2018 05:40:01.3: Sequencer is no longer active
25-Jan-2018 05:40:01.3: Post-job status check done (stat=Completed)
25-Jan-2018 05:40:01.3: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 05:40:11.3: Sequencer is now active
25-Jan-2018 06:05:18.9: Sequencer is no longer active
25-Jan-2018 06:05:18.9: Post-job status check done (stat=Completed)
25-Jan-2018 06:05:18.9: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 06:05:28.9: Sequencer is now active
25-Jan-2018 06:30:29.6: Sequencer is no longer active
25-Jan-2018 06:30:29.6: Post-job status check done (stat=Completed)
25-Jan-2018 06:30:29.6: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 06:30:39.6: Sequencer is now active
25-Jan-2018 06:55:42.0: Sequencer is no longer active
25-Jan-2018 06:55:42.0: Post-job status check done (stat=Completed)
25-Jan-2018 06:55:42.0: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 06:55:52.0: Sequencer is now active
25-Jan-2018 07:20:57.8: Sequencer is no longer active
25-Jan-2018 07:20:57.8: Post-job status check done (stat=Completed)
25-Jan-2018 07:20:58.1: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 07:21:08.1: Sequencer is now active
25-Jan-2018 07:46:12.9: Sequencer is no longer active
25-Jan-2018 07:46:12.9: Post-job status check done (stat=Completed)
25-Jan-2018 07:46:12.9: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 07:46:22.9: Sequencer is now active
25-Jan-2018 08:11:28.9: Sequencer is no longer active
25-Jan-2018 08:11:28.9: Post-job status check done (stat=Completed)
25-Jan-2018 08:11:28.9: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 08:11:39.0: Sequencer is now active
25-Jan-2018 08:36:38.9: Sequencer is no longer active
25-Jan-2018 08:36:38.9: Post-job status check done (stat=Completed)
25-Jan-2018 08:36:38.9: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 08:36:48.9: Sequencer is now active
25-Jan-2018 09:01:55.4: Sequencer is no longer active
25-Jan-2018 09:01:55.4: Post-job status check done (stat=Completed)
25-Jan-2018 09:01:55.5: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 09:02:05.5: Sequencer is now active
25-Jan-2018 09:27:10.8: Sequencer is no longer active
25-Jan-2018 09:27:10.8: Post-job status check done (stat=Completed)
25-Jan-2018 09:27:10.8: Send Observation RX_J0524+42 to ACP Sequencer
25-Jan-2018 09:27:20.8: Sequencer is now active
25-Jan-2018 09:52:24.8: Sequencer is no longer active
25-Jan-2018 09:52:24.8: Post-job status check done (stat=Completed)
25-Jan-2018 09:52:24.8: TestConstraints: AirMass vetoed/failed for end time of Obs
25-Jan-2018 09:52:24.8: ***Running Plan RX_J0524+42 (best efforts) completed early:
25-Jan-2018 09:52:24.8:    Obs RX_J0524+42 would would not meet constraints
25-Jan-2018 09:52:24.8: Acquisition time: 19721.8690266 sec.
25-Jan-2018 09:52:24.8: Data for Observation RX_J0524+42 acquired successfully.
25-Jan-2018 09:52:24.8: Image Efficiency: 79.1%
25-Jan-2018 09:52:24.8: Cycle Efficiency: 100.0%
25-Jan-2018 09:52:25.6: ++ Auto Focus ++
25-Jan-2018 09:52:25.6: Doing periodic autofocus.
25-Jan-2018 09:52:25.6: Start special ACP AutoFocus script for scheduler
25-Jan-2018 09:52:35.6: Sequencer is now active
25-Jan-2018 09:55:55.4: Sequencer is no longer active
25-Jan-2018 09:55:55.4: Next periodic autofocus ASAP after 25-Jan-2018 12:55:21 UTC
25-Jan-2018 09:55:55.7: SelectRunning: No running plans
25-Jan-2018 09:55:55.7: Obs GSC_4030_204 in Plan GSC_4030_204 was vetoed by AirMass constraint.
25-Jan-2018 09:55:55.7:     AirMass estimates ready after 25-Jan-2018 18:12:00 UTC
25-Jan-2018 09:55:55.8: Obs V0524_Cas in Plan V0524_Cas was vetoed by AirmassRange constraint.
25-Jan-2018 09:55:55.8:     AirmassRange estimates ready after 25-Jan-2018 17:32:29 UTC
25-Jan-2018 09:55:55.8: Efficiency: Selecting from 6 pending plans:
25-Jan-2018 09:55:55.8:   Selected Plan KK_UMa (TotEff=0.89)
25-Jan-2018 09:55:55.9: Dispatcher cycle time: 0.2250129 sec.
25-Jan-2018 09:55:55.9: Acquire data for Observation KK_UMa...
25-Jan-2018 09:55:55.9:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan KK_UMa)
25-Jan-2018 09:55:55.9: Send Observation KK_UMa to ACP Sequencer
25-Jan-2018 09:56:05.9: Sequencer is now active
25-Jan-2018 10:09:52.7: Sequencer is no longer active
25-Jan-2018 10:09:52.7: Post-job status check done (stat=Completed)
25-Jan-2018 10:09:52.7: Acquisition time: 836.8048625 sec.
25-Jan-2018 10:09:52.7: Data for Observation KK_UMa acquired successfully.
25-Jan-2018 10:09:52.7: Image Efficiency: 46.6%
25-Jan-2018 10:09:52.7: Cycle Efficiency: 100.0%
25-Jan-2018 10:09:52.9: SelectRunning: No running plans
25-Jan-2018 10:09:52.9: Efficiency: Selecting from 5 pending plans:
25-Jan-2018 10:09:53.0:   Selected Plan CV_Vir (TotEff=0.84)
25-Jan-2018 10:09:53.1: Dispatcher cycle time: 0.1940111 sec.
25-Jan-2018 10:09:53.1: Acquire data for Observation CV_Vir...
25-Jan-2018 10:09:53.1:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan CV_Vir)
25-Jan-2018 10:09:53.1: Send Observation CV_Vir to ACP Sequencer
25-Jan-2018 10:10:03.1: Sequencer is now active
25-Jan-2018 10:23:58.3: Sequencer is no longer active
25-Jan-2018 10:23:58.3: Post-job status check done (stat=Completed)
25-Jan-2018 10:23:58.3: Acquisition time: 845.1663408 sec.
25-Jan-2018 10:23:58.3: Data for Observation CV_Vir acquired successfully.
25-Jan-2018 10:23:58.3: Image Efficiency: 46.1%
25-Jan-2018 10:23:58.3: Cycle Efficiency: 100.0%
25-Jan-2018 10:23:58.4: SelectRunning: No running plans
25-Jan-2018 10:23:58.4: STRICT VETO:
25-Jan-2018 10:23:58.4: Obs SDSS073224 in Plan SDSS073224 was vetoed by AirMass constraint.
25-Jan-2018 10:23:58.4:     AirMass estimates ready after 26-Jan-2018 01:37:46 UTC
25-Jan-2018 10:23:58.5: Efficiency: Selecting from 4 pending plans:
25-Jan-2018 10:23:58.5:   Selected Plan AL_Boo (TotEff=0.74)
25-Jan-2018 10:23:58.6: Dispatcher cycle time: 0.17501 sec.
25-Jan-2018 10:23:58.6: Acquire data for Observation AL_Boo...
25-Jan-2018 10:23:58.6:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan AL_Boo)
25-Jan-2018 10:23:58.6: Send Observation AL_Boo to ACP Sequencer
25-Jan-2018 10:24:08.6: Sequencer is now active
25-Jan-2018 10:29:25.8: ** Script interrupted by weather safety event.
25-Jan-2018 10:29:28.8: Post-job status check done (stat=Running)
25-Jan-2018 10:29:28.8: ACP ABORT: Acquisition process was interrupted by weather unsafe.
25-Jan-2018 10:29:28.8: ACP data acquisition failed for Observation AL_Boo.
25-Jan-2018 10:29:28.8:   (Plan AL_Boo will be resubmitted in its entirety.
25-Jan-2018 10:29:28.8:   (Observation AL_Boo interrupted by weather unsafe event.)
25-Jan-2018 10:29:29.4: -- Weather Unsafe --
25-Jan-2018 10:50:41.7: ++ Weather Safe ++
25-Jan-2018 10:50:42.7: ++ Observatory Startup ++
25-Jan-2018 10:50:42.7: Start ACP Sequencer's StartupObs script
25-Jan-2018 10:50:52.7: Sequencer is now active
25-Jan-2018 10:50:57.9: Sequencer is no longer active
25-Jan-2018 10:50:58.2: Open the observatory dome/roof
25-Jan-2018 10:52:19.6: ++ Auto Focus ++
25-Jan-2018 10:52:19.7: Doing initial autofocus.
25-Jan-2018 10:52:19.7: Start special ACP AutoFocus script for scheduler
25-Jan-2018 10:52:29.7: Sequencer is now active
25-Jan-2018 10:56:09.3: Sequencer is no longer active
25-Jan-2018 10:56:09.3: Next periodic autofocus ASAP after 25-Jan-2018 13:55:43 UTC
25-Jan-2018 10:56:09.3: SelectRunning: No running plans
25-Jan-2018 10:56:09.3: STRICT VETO:
25-Jan-2018 10:56:09.3: Obs M67 in Plan M67 was vetoed by AirMass constraint.
25-Jan-2018 10:56:09.3:     AirMass estimates ready after 26-Jan-2018 03:57:46 UTC
25-Jan-2018 10:56:09.3: Efficiency: Selecting from 4 pending plans:
25-Jan-2018 10:56:09.4:   Selected Plan AL_Boo (TotEff=0.80)
25-Jan-2018 10:56:09.4: Dispatcher cycle time: 0.1610092 sec.
25-Jan-2018 10:56:09.4: Acquire data for Observation AL_Boo...
25-Jan-2018 10:56:09.4:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan AL_Boo)
25-Jan-2018 10:56:09.4: Send Observation AL_Boo to ACP Sequencer
25-Jan-2018 10:56:19.4: Sequencer is now active
25-Jan-2018 11:09:39.0: Sequencer is no longer active
25-Jan-2018 11:09:39.0: Post-job status check done (stat=Completed)
25-Jan-2018 11:09:39.0: Acquisition time: 809.5483035 sec.
25-Jan-2018 11:09:39.0: Data for Observation AL_Boo acquired successfully.
25-Jan-2018 11:09:39.0: Image Efficiency: 48.2%
25-Jan-2018 11:09:39.0: Cycle Efficiency: 100.0%
25-Jan-2018 11:09:39.2: SelectRunning: No running plans
25-Jan-2018 11:09:39.2: Efficiency: Selecting from 3 pending plans:
25-Jan-2018 11:09:39.3:   Selected Plan SDSSJ121027+502735 (TotEff=0.70)
25-Jan-2018 11:09:39.3: Dispatcher cycle time: 0.1310075 sec.
25-Jan-2018 11:09:39.3: Acquire data for Observation SDSSJ121027+502735...
25-Jan-2018 11:09:39.3:   (belongs to Project NMSU, Plan SDSSJ121027+502735)
25-Jan-2018 11:09:39.4: Send Observation SDSSJ121027+502735 to ACP Sequencer
25-Jan-2018 11:09:49.4: Sequencer is now active
25-Jan-2018 11:24:26.1: Sequencer is no longer active
25-Jan-2018 11:24:26.1: Post-job status check done (stat=Completed)
25-Jan-2018 11:24:26.1: Acquisition time: 886.7227177 sec.
25-Jan-2018 11:24:26.1: Data for Observation SDSSJ121027+502735 acquired successfully.
25-Jan-2018 11:24:26.1: Image Efficiency: 67.7%
25-Jan-2018 11:24:26.1: Cycle Efficiency: 100.0%
25-Jan-2018 11:24:26.3: SelectRunning: No running plans
25-Jan-2018 11:24:26.3: Efficiency: Selecting from 2 pending plans:
25-Jan-2018 11:24:26.3:   Selected Plan V0336_Ser (TotEff=0.59)
25-Jan-2018 11:24:26.3: Dispatcher cycle time: 0.0920053 sec.
25-Jan-2018 11:24:26.3: Acquire data for Observation V0336_Ser...
25-Jan-2018 11:24:26.3:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V0336_Ser)
25-Jan-2018 11:24:26.4: Send Observation V0336_Ser to ACP Sequencer
25-Jan-2018 11:24:36.4: Sequencer is now active
25-Jan-2018 11:39:40.7: Sequencer is no longer active
25-Jan-2018 11:39:40.7: Post-job status check done (stat=Completed)
25-Jan-2018 11:39:40.8: Acquisition time: 914.4053009 sec.
25-Jan-2018 11:39:40.8: Data for Observation V0336_Ser acquired successfully.
25-Jan-2018 11:39:40.8: Image Efficiency: 42.6%
25-Jan-2018 11:39:40.8: Cycle Efficiency: 100.0%
25-Jan-2018 11:39:40.9: SelectRunning: No running plans
25-Jan-2018 11:39:40.9: Efficiency: Only one pending plan Mkn_501, it is the "best"
25-Jan-2018 11:39:41.0: Dispatcher cycle time: 0.0910052 sec.
25-Jan-2018 11:39:41.0: Acquire data for Observation Mkn_501...
25-Jan-2018 11:39:41.0:   (belongs to Project AAVSO_SXAC_Mkn_501, Plan Mkn_501)
25-Jan-2018 11:39:41.0: Doing 3 sets
25-Jan-2018 11:39:41.0: Send Observation Mkn_501 to ACP Sequencer
25-Jan-2018 11:39:51.0: Sequencer is now active
25-Jan-2018 11:47:33.9: Sequencer is no longer active
25-Jan-2018 11:47:33.9: Post-job status check done (stat=Completed)
25-Jan-2018 11:47:33.9: Send Observation Mkn_501 to ACP Sequencer
25-Jan-2018 11:47:43.9: Sequencer is now active
25-Jan-2018 11:54:41.9: Sequencer is no longer active
25-Jan-2018 11:54:42.0: Post-job status check done (stat=Completed)
25-Jan-2018 11:54:42.0: Send Observation Mkn_501 to ACP Sequencer
25-Jan-2018 11:54:52.0: Sequencer is now active
25-Jan-2018 12:01:48.4: Sequencer is no longer active
25-Jan-2018 12:01:48.4: Post-job status check done (stat=Completed)
25-Jan-2018 12:01:48.4: Acquisition time: 1327.3679211 sec.
25-Jan-2018 12:01:48.4: Data for Observation Mkn_501 acquired successfully.
25-Jan-2018 12:01:48.4: Image Efficiency: 67.8%
25-Jan-2018 12:01:48.4: Cycle Efficiency: 100.0%
25-Jan-2018 12:01:48.5: SelectRunning: No running plans
25-Jan-2018 12:01:48.5: Efficiency: Only one pending plan V1015_Her, it is the "best"
25-Jan-2018 12:01:48.6: Dispatcher cycle time: 0.0670038 sec.
25-Jan-2018 12:01:48.6: Acquire data for Observation V1015_Her...
25-Jan-2018 12:01:48.6:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan V1015_Her)
25-Jan-2018 12:01:48.6: Send Observation V1015_Her to ACP Sequencer
25-Jan-2018 12:01:58.6: Sequencer is now active
25-Jan-2018 12:15:26.7: Sequencer is no longer active
25-Jan-2018 12:15:26.7: Post-job status check done (stat=Completed)
25-Jan-2018 12:15:26.7: Acquisition time: 818.1187938 sec.
25-Jan-2018 12:15:26.7: Data for Observation V1015_Her acquired successfully.
25-Jan-2018 12:15:26.7: Image Efficiency: 47.7%
25-Jan-2018 12:15:26.7: Cycle Efficiency: 100.0%
25-Jan-2018 12:15:26.9: SelectRunning: No running plans
25-Jan-2018 12:15:26.9: No pending plans that can be started now.
25-Jan-2018 12:15:26.9: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:15:57.3: SelectRunning: No running plans
25-Jan-2018 12:15:57.3: No pending plans that can be started now.
25-Jan-2018 12:15:57.3: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:16:28.1: SelectRunning: No running plans
25-Jan-2018 12:16:28.1: No pending plans that can be started now.
25-Jan-2018 12:16:28.1: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:16:58.4: SelectRunning: No running plans
25-Jan-2018 12:16:58.4: No pending plans that can be started now.
25-Jan-2018 12:16:58.4: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:17:28.7: SelectRunning: No running plans
25-Jan-2018 12:17:28.7: No pending plans that can be started now.
25-Jan-2018 12:17:28.7: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:17:58.8: SelectRunning: No running plans
25-Jan-2018 12:17:58.8: No pending plans that can be started now.
25-Jan-2018 12:17:58.8: Dispatcher cycle time: 0.0150009 sec.
25-Jan-2018 12:18:29.4: SelectRunning: No running plans
25-Jan-2018 12:18:29.4: No pending plans that can be started now.
25-Jan-2018 12:18:29.4: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:18:59.7: SelectRunning: No running plans
25-Jan-2018 12:18:59.7: No pending plans that can be started now.
25-Jan-2018 12:18:59.7: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:19:29.9: SelectRunning: No running plans
25-Jan-2018 12:19:29.9: No pending plans that can be started now.
25-Jan-2018 12:19:29.9: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:20:00.2: SelectRunning: No running plans
25-Jan-2018 12:20:00.2: No pending plans that can be started now.
25-Jan-2018 12:20:00.2: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:20:30.4: SelectRunning: No running plans
25-Jan-2018 12:20:30.4: No pending plans that can be started now.
25-Jan-2018 12:20:30.4: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 12:21:00.8: SelectRunning: No running plans
25-Jan-2018 12:21:00.8: No pending plans that can be started now.
25-Jan-2018 12:21:00.8: Dispatcher cycle time: 0.0220012 sec.
25-Jan-2018 12:21:30.9: SelectRunning: No running plans
25-Jan-2018 12:21:30.9: No pending plans that can be started now.
25-Jan-2018 12:21:30.9: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:22:01.4: SelectRunning: No running plans
25-Jan-2018 12:22:01.4: No pending plans that can be started now.
25-Jan-2018 12:22:01.4: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:22:31.5: SelectRunning: No running plans
25-Jan-2018 12:22:31.5: No pending plans that can be started now.
25-Jan-2018 12:22:31.5: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:23:01.7: SelectRunning: No running plans
25-Jan-2018 12:23:01.7: No pending plans that can be started now.
25-Jan-2018 12:23:01.7: Dispatcher cycle time: 0.0130008 sec.
25-Jan-2018 12:23:31.9: SelectRunning: No running plans
25-Jan-2018 12:23:31.9: No pending plans that can be started now.
25-Jan-2018 12:23:31.9: Dispatcher cycle time: 0.0130008 sec.
25-Jan-2018 12:24:02.0: SelectRunning: No running plans
25-Jan-2018 12:24:02.0: No pending plans that can be started now.
25-Jan-2018 12:24:02.0: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:24:32.3: SelectRunning: No running plans
25-Jan-2018 12:24:32.3: No pending plans that can be started now.
25-Jan-2018 12:24:32.3: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:25:02.5: SelectRunning: No running plans
25-Jan-2018 12:25:02.5: No pending plans that can be started now.
25-Jan-2018 12:25:02.5: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:25:32.6: SelectRunning: No running plans
25-Jan-2018 12:25:32.6: No pending plans that can be started now.
25-Jan-2018 12:25:32.6: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:26:02.9: SelectRunning: No running plans
25-Jan-2018 12:26:02.9: No pending plans that can be started now.
25-Jan-2018 12:26:02.9: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:26:33.0: SelectRunning: No running plans
25-Jan-2018 12:26:33.0: No pending plans that can be started now.
25-Jan-2018 12:26:33.0: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:27:03.5: SelectRunning: No running plans
25-Jan-2018 12:27:03.5: No pending plans that can be started now.
25-Jan-2018 12:27:03.5: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:27:33.6: SelectRunning: No running plans
25-Jan-2018 12:27:33.7: No pending plans that can be started now.
25-Jan-2018 12:27:33.7: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:28:03.8: SelectRunning: No running plans
25-Jan-2018 12:28:03.8: No pending plans that can be started now.
25-Jan-2018 12:28:03.8: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:28:34.0: SelectRunning: No running plans
25-Jan-2018 12:28:34.0: No pending plans that can be started now.
25-Jan-2018 12:28:34.0: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:29:04.1: SelectRunning: No running plans
25-Jan-2018 12:29:04.1: No pending plans that can be started now.
25-Jan-2018 12:29:04.1: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:29:34.6: SelectRunning: No running plans
25-Jan-2018 12:29:34.6: No pending plans that can be started now.
25-Jan-2018 12:29:34.6: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:30:04.7: SelectRunning: No running plans
25-Jan-2018 12:30:04.7: No pending plans that can be started now.
25-Jan-2018 12:30:04.7: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:30:35.2: SelectRunning: No running plans
25-Jan-2018 12:30:35.2: No pending plans that can be started now.
25-Jan-2018 12:30:35.2: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:31:05.4: SelectRunning: No running plans
25-Jan-2018 12:31:05.4: No pending plans that can be started now.
25-Jan-2018 12:31:05.4: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:31:35.9: SelectRunning: No running plans
25-Jan-2018 12:31:35.9: No pending plans that can be started now.
25-Jan-2018 12:31:35.9: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 12:32:06.2: SelectRunning: No running plans
25-Jan-2018 12:32:06.2: No pending plans that can be started now.
25-Jan-2018 12:32:06.2: Dispatcher cycle time: 0.0130007 sec.
25-Jan-2018 12:32:36.9: SelectRunning: No running plans
25-Jan-2018 12:32:36.9: No pending plans that can be started now.
25-Jan-2018 12:32:36.9: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 12:33:07.2: SelectRunning: No running plans
25-Jan-2018 12:33:07.2: No pending plans that can be started now.
25-Jan-2018 12:33:07.2: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:33:37.9: SelectRunning: No running plans
25-Jan-2018 12:33:37.9: No pending plans that can be started now.
25-Jan-2018 12:33:37.9: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:34:08.1: SelectRunning: No running plans
25-Jan-2018 12:34:08.1: No pending plans that can be started now.
25-Jan-2018 12:34:08.1: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:34:38.2: SelectRunning: No running plans
25-Jan-2018 12:34:38.2: No pending plans that can be started now.
25-Jan-2018 12:34:38.2: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:35:08.5: SelectRunning: No running plans
25-Jan-2018 12:35:08.5: No pending plans that can be started now.
25-Jan-2018 12:35:08.5: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:35:39.1: SelectRunning: No running plans
25-Jan-2018 12:35:39.1: No pending plans that can be started now.
25-Jan-2018 12:35:39.1: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 12:36:09.5: SelectRunning: No running plans
25-Jan-2018 12:36:09.5: No pending plans that can be started now.
25-Jan-2018 12:36:09.5: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:36:39.6: SelectRunning: No running plans
25-Jan-2018 12:36:39.6: No pending plans that can be started now.
25-Jan-2018 12:36:39.6: Dispatcher cycle time: 0.0230013 sec.
25-Jan-2018 12:37:09.7: SelectRunning: No running plans
25-Jan-2018 12:37:09.7: No pending plans that can be started now.
25-Jan-2018 12:37:09.7: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:37:39.9: SelectRunning: No running plans
25-Jan-2018 12:37:39.9: No pending plans that can be started now.
25-Jan-2018 12:37:39.9: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:38:10.3: SelectRunning: No running plans
25-Jan-2018 12:38:10.3: No pending plans that can be started now.
25-Jan-2018 12:38:10.3: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 12:38:40.4: SelectRunning: No running plans
25-Jan-2018 12:38:40.4: No pending plans that can be started now.
25-Jan-2018 12:38:40.4: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 12:39:11.1: SelectRunning: No running plans
25-Jan-2018 12:39:11.1: No pending plans that can be started now.
25-Jan-2018 12:39:11.1: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:39:41.5: SelectRunning: No running plans
25-Jan-2018 12:39:41.5: No pending plans that can be started now.
25-Jan-2018 12:39:41.5: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:40:12.2: SelectRunning: No running plans
25-Jan-2018 12:40:12.2: No pending plans that can be started now.
25-Jan-2018 12:40:12.2: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:40:42.3: SelectRunning: No running plans
25-Jan-2018 12:40:42.3: No pending plans that can be started now.
25-Jan-2018 12:40:42.3: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:41:12.5: SelectRunning: No running plans
25-Jan-2018 12:41:12.5: No pending plans that can be started now.
25-Jan-2018 12:41:12.5: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:41:42.8: SelectRunning: No running plans
25-Jan-2018 12:41:42.8: No pending plans that can be started now.
25-Jan-2018 12:41:42.8: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:42:12.9: SelectRunning: No running plans
25-Jan-2018 12:42:12.9: No pending plans that can be started now.
25-Jan-2018 12:42:12.9: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:42:43.3: SelectRunning: No running plans
25-Jan-2018 12:42:43.3: No pending plans that can be started now.
25-Jan-2018 12:42:43.3: Dispatcher cycle time: 0.0130008 sec.
25-Jan-2018 12:43:13.4: SelectRunning: No running plans
25-Jan-2018 12:43:13.4: No pending plans that can be started now.
25-Jan-2018 12:43:13.4: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:43:43.6: SelectRunning: No running plans
25-Jan-2018 12:43:43.6: No pending plans that can be started now.
25-Jan-2018 12:43:43.6: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:44:13.7: SelectRunning: No running plans
25-Jan-2018 12:44:13.7: No pending plans that can be started now.
25-Jan-2018 12:44:13.7: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:44:43.9: SelectRunning: No running plans
25-Jan-2018 12:44:43.9: No pending plans that can be started now.
25-Jan-2018 12:44:43.9: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:45:14.4: SelectRunning: No running plans
25-Jan-2018 12:45:14.4: No pending plans that can be started now.
25-Jan-2018 12:45:14.4: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:45:44.8: SelectRunning: No running plans
25-Jan-2018 12:45:44.8: No pending plans that can be started now.
25-Jan-2018 12:45:44.8: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:46:15.0: SelectRunning: No running plans
25-Jan-2018 12:46:15.0: No pending plans that can be started now.
25-Jan-2018 12:46:15.0: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:46:45.1: SelectRunning: No running plans
25-Jan-2018 12:46:45.1: No pending plans that can be started now.
25-Jan-2018 12:46:45.1: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:47:15.5: SelectRunning: No running plans
25-Jan-2018 12:47:15.5: No pending plans that can be started now.
25-Jan-2018 12:47:15.5: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:47:45.6: SelectRunning: No running plans
25-Jan-2018 12:47:45.6: No pending plans that can be started now.
25-Jan-2018 12:47:45.6: Dispatcher cycle time: 0.0130007 sec.
25-Jan-2018 12:48:16.2: SelectRunning: No running plans
25-Jan-2018 12:48:16.2: No pending plans that can be started now.
25-Jan-2018 12:48:16.2: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 12:48:46.6: SelectRunning: No running plans
25-Jan-2018 12:48:46.6: No pending plans that can be started now.
25-Jan-2018 12:48:46.6: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:49:16.7: SelectRunning: No running plans
25-Jan-2018 12:49:16.7: No pending plans that can be started now.
25-Jan-2018 12:49:16.7: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:49:46.9: SelectRunning: No running plans
25-Jan-2018 12:49:46.9: No pending plans that can be started now.
25-Jan-2018 12:49:46.9: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:50:17.0: SelectRunning: No running plans
25-Jan-2018 12:50:17.0: No pending plans that can be started now.
25-Jan-2018 12:50:17.0: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:50:47.4: SelectRunning: No running plans
25-Jan-2018 12:50:47.4: No pending plans that can be started now.
25-Jan-2018 12:50:47.4: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:51:17.6: SelectRunning: No running plans
25-Jan-2018 12:51:17.6: No pending plans that can be started now.
25-Jan-2018 12:51:17.6: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:51:48.0: SelectRunning: No running plans
25-Jan-2018 12:51:48.0: No pending plans that can be started now.
25-Jan-2018 12:51:48.0: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:52:18.1: SelectRunning: No running plans
25-Jan-2018 12:52:18.1: No pending plans that can be started now.
25-Jan-2018 12:52:18.1: Dispatcher cycle time: 0.0230013 sec.
25-Jan-2018 12:52:48.3: SelectRunning: No running plans
25-Jan-2018 12:52:48.3: No pending plans that can be started now.
25-Jan-2018 12:52:48.3: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:53:18.6: SelectRunning: No running plans
25-Jan-2018 12:53:18.6: No pending plans that can be started now.
25-Jan-2018 12:53:18.6: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:53:48.8: SelectRunning: No running plans
25-Jan-2018 12:53:48.8: No pending plans that can be started now.
25-Jan-2018 12:53:48.8: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:54:19.1: SelectRunning: No running plans
25-Jan-2018 12:54:19.1: No pending plans that can be started now.
25-Jan-2018 12:54:19.1: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:54:49.2: SelectRunning: No running plans
25-Jan-2018 12:54:49.2: No pending plans that can be started now.
25-Jan-2018 12:54:49.2: Dispatcher cycle time: 0.0150008 sec.
25-Jan-2018 12:55:19.4: SelectRunning: No running plans
25-Jan-2018 12:55:19.4: No pending plans that can be started now.
25-Jan-2018 12:55:19.4: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:55:49.9: SelectRunning: No running plans
25-Jan-2018 12:55:49.9: No pending plans that can be started now.
25-Jan-2018 12:55:49.9: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:56:20.0: SelectRunning: No running plans
25-Jan-2018 12:56:20.0: No pending plans that can be started now.
25-Jan-2018 12:56:20.0: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:56:50.2: SelectRunning: No running plans
25-Jan-2018 12:56:50.2: No pending plans that can be started now.
25-Jan-2018 12:56:50.2: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:57:20.4: SelectRunning: No running plans
25-Jan-2018 12:57:20.4: No pending plans that can be started now.
25-Jan-2018 12:57:20.4: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:57:50.8: SelectRunning: No running plans
25-Jan-2018 12:57:50.8: No pending plans that can be started now.
25-Jan-2018 12:57:50.8: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 12:58:21.1: SelectRunning: No running plans
25-Jan-2018 12:58:21.1: No pending plans that can be started now.
25-Jan-2018 12:58:21.1: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:58:51.6: SelectRunning: No running plans
25-Jan-2018 12:58:51.6: No pending plans that can be started now.
25-Jan-2018 12:58:51.6: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 12:59:21.9: SelectRunning: No running plans
25-Jan-2018 12:59:21.9: No pending plans that can be started now.
25-Jan-2018 12:59:21.9: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 12:59:52.1: SelectRunning: No running plans
25-Jan-2018 12:59:52.1: No pending plans that can be started now.
25-Jan-2018 12:59:52.1: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:00:22.2: SelectRunning: No running plans
25-Jan-2018 13:00:22.2: No pending plans that can be started now.
25-Jan-2018 13:00:22.2: Dispatcher cycle time: 0.0140008 sec.
25-Jan-2018 13:00:52.3: SelectRunning: No running plans
25-Jan-2018 13:00:52.3: No pending plans that can be started now.
25-Jan-2018 13:00:52.3: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:01:22.7: SelectRunning: No running plans
25-Jan-2018 13:01:22.7: No pending plans that can be started now.
25-Jan-2018 13:01:22.7: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 13:01:52.9: SelectRunning: No running plans
25-Jan-2018 13:01:52.9: Plan V841_Oph would extend past daylight, deferred to next night
25-Jan-2018 13:01:52.9: No pending plans that can be started now.
25-Jan-2018 13:01:52.9: Dispatcher cycle time: 0.0130007 sec.
25-Jan-2018 13:02:23.4: SelectRunning: No running plans
25-Jan-2018 13:02:23.4: No pending plans that can be started now.
25-Jan-2018 13:02:23.4: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:02:53.5: SelectRunning: No running plans
25-Jan-2018 13:02:53.5: No pending plans that can be started now.
25-Jan-2018 13:02:53.5: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 13:03:23.6: SelectRunning: No running plans
25-Jan-2018 13:03:23.6: No pending plans that can be started now.
25-Jan-2018 13:03:23.6: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 13:03:53.9: SelectRunning: No running plans
25-Jan-2018 13:03:53.9: No pending plans that can be started now.
25-Jan-2018 13:03:53.9: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:04:24.1: SelectRunning: No running plans
25-Jan-2018 13:04:24.1: No pending plans that can be started now.
25-Jan-2018 13:04:24.1: Dispatcher cycle time: 0.0120007 sec.
25-Jan-2018 13:04:54.5: SelectRunning: No running plans
25-Jan-2018 13:04:54.5: No pending plans that can be started now.
25-Jan-2018 13:04:54.5: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 13:05:25.0: SelectRunning: No running plans
25-Jan-2018 13:05:25.0: No pending plans that can be started now.
25-Jan-2018 13:05:25.0: Dispatcher cycle time: 0.0110007 sec.
25-Jan-2018 13:05:55.1: SelectRunning: No running plans
25-Jan-2018 13:05:55.1: No pending plans that can be started now.
25-Jan-2018 13:05:55.1: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:06:25.4: SelectRunning: No running plans
25-Jan-2018 13:06:25.4: No pending plans that can be started now.
25-Jan-2018 13:06:25.4: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:06:55.5: SelectRunning: No running plans
25-Jan-2018 13:06:55.5: No pending plans that can be started now.
25-Jan-2018 13:06:55.5: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:07:25.7: SelectRunning: No running plans
25-Jan-2018 13:07:25.7: No pending plans that can be started now.
25-Jan-2018 13:07:25.7: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:07:55.9: SelectRunning: No running plans
25-Jan-2018 13:07:55.9: No pending plans that can be started now.
25-Jan-2018 13:07:55.9: Dispatcher cycle time: 0.0270015 sec.
25-Jan-2018 13:08:26.1: SelectRunning: No running plans
25-Jan-2018 13:08:26.1: No pending plans that can be started now.
25-Jan-2018 13:08:26.1: Dispatcher cycle time: 0.0110006 sec.
25-Jan-2018 13:08:56.2: SelectRunning: No running plans
25-Jan-2018 13:08:56.2: No pending plans that can be started now.
25-Jan-2018 13:08:56.2: Dispatcher cycle time: 0.0120006 sec.
25-Jan-2018 13:09:26.4: ++ Dawn Flats ++
25-Jan-2018 13:09:26.4: Start ACP AutoFlat script for Dawn
25-Jan-2018 13:09:36.5: Sequencer is now active
25-Jan-2018 13:55:46.7: Sequencer is no longer active
25-Jan-2018 13:55:46.8: -- Observatory Shutdown --
25-Jan-2018 13:55:46.9: Weather disconnected.
25-Jan-2018 13:55:46.9: Start ACP Sequencer's ShutdownObs script
25-Jan-2018 13:55:57.0: Sequencer is now active
25-Jan-2018 13:59:50.2: Dispatcher stopped at 25-Jan-2018 13:59:50 UTC
25-Jan-2018 13:59:50.2: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
25-Jan-2018 14:00:21.4: Requested shutdown of scheduler
25-Jan-2018 14:00:21.5: Run statistics:
25-Jan-2018 14:00:21.5:   Observations:   51
25-Jan-2018 14:00:21.5:   Considered:     35
25-Jan-2018 14:00:21.5:   Completed:      24
25-Jan-2018 14:00:21.5:   Skipped:        8
25-Jan-2018 14:00:21.5:   Never Eligible: 16
25-Jan-2018 14:00:21.5:   Failed:         3
25-Jan-2018 14:00:21.5: Shutter-Open efficiency: 64.93%
25-Jan-2018 14:00:21.5: Overall Efficiency: 99.90%
25-Jan-2018 14:00:21.5: Release ACP sequencer
Log closed at Thu, Jan 25 2018 14:00:23 UTC (actual time)