Log opened at Fri, Feb 05 2021 03:09:43 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2021-02-05 03:09:43.4: ++ Observatory Startup ++
2021-02-05 03:09:43.4: Start ACP Sequencer's StartupObs script
2021-02-05 03:09:43.4: Starting with open dome, unsafe weather will cause operator intervention error
2021-02-05 03:09:43.4: ACP.RunScript(StartupObs, ):
2021-02-05 03:09:43.4:   Script AutoFocus is loaded, and
2021-02-05 03:09:43.4:   the console is idle.
2021-02-05 03:09:43.4:   In start loop, i = 0
2021-02-05 03:09:43.4:   Console is now idle
2021-02-05 03:09:43.8:   Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully
2021-02-05 03:09:43.8:   Script started successfully
2021-02-05 03:09:53.8: Sequencer is now active
2021-02-05 03:10:34.2: Sequencer is no longer active
2021-02-05 03:10:34.2: Observatory startup succeeded
2021-02-05 03:10:34.2: ++ Auto Focus ++
2021-02-05 03:10:34.2: Doing initial autofocus.
2021-02-05 03:10:34.2: Start special ACP AutoFocus script for scheduler
2021-02-05 03:10:34.2: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 03:10:34.2:   Script StartupObs is loaded, and
2021-02-05 03:10:34.2:   the console is idle.
2021-02-05 03:10:34.2:   In start loop, i = 0
2021-02-05 03:10:34.2:   Console is now idle
2021-02-05 03:10:34.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 03:10:34.3:   Script started successfully
2021-02-05 03:10:44.3: Sequencer is now active
2021-02-05 03:14:22.0: Sequencer is no longer active
2021-02-05 03:14:22.0: Next periodic autofocus ASAP after 3600sec. 05-Feb-2021 04:14:02 UTC
2021-02-05 03:14:24.1: SelectRunning: No running plans
2021-02-05 03:14:24.1: Obs 3C_279 in Plan 3C_279 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.1:     AirmassRange estimates ready after 05-Feb-2021 07:44:44 UTC
2021-02-05 03:14:24.1: Obs AG_Peg in Plan AG_Peg was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.1:     AirmassRange estimates ready after 05-Feb-2021 15:44:18 UTC
2021-02-05 03:14:24.2: Obs CH_Cyg in Plan CH_Cyg was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.2:     AirmassRange estimates ready after 05-Feb-2021 12:05:33 UTC
2021-02-05 03:14:24.2: Obs EE_Cep in Plan EE_Cep was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.2:     AirmassRange estimates ready after 05-Feb-2021 13:51:38 UTC
2021-02-05 03:14:24.2: Obs EE_Cep in Plan EE_Cep was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.2:     AirmassRange estimates ready after 05-Feb-2021 14:40:03 UTC
2021-02-05 03:14:24.2: Obs IX_Dra in Plan IX_Dra was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.2:     AirmassRange estimates ready after 05-Feb-2021 10:20:56 UTC
2021-02-05 03:14:24.4: EPH (Jupiter): type=Major Planet time=03:14:24 ra=20.8907066 dec=-18.049118
2021-02-05 03:14:24.4: Obs Jupiter in Plan Jupiter was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.4:     AirmassRange estimates ready after 05-Feb-2021 15:54:29 UTC
2021-02-05 03:14:24.4: Obs KH15D-B in Plan KH15D-B was vetoed by HourAngle constraint.
2021-02-05 03:14:24.4:     HourAngle estimates ready after 05-Feb-2021 03:16:11 UTC
2021-02-05 03:14:24.4: Obs M10 in Plan M10 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.4:     AirmassRange estimates ready after 05-Feb-2021 11:38:55 UTC
2021-02-05 03:14:24.5: Obs M107 in Plan M107 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 11:51:09 UTC
2021-02-05 03:14:24.5: Obs M12 in Plan M12 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 11:21:45 UTC
2021-02-05 03:14:24.5: Obs M16 in Plan M16 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 13:40:48 UTC
2021-02-05 03:14:24.5: Obs M17 in Plan M17 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 13:55:40 UTC
2021-02-05 03:14:24.5: Obs M18 in Plan M18 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 14:00:21 UTC
2021-02-05 03:14:24.5: Obs M19 in Plan M19 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 14:09:14 UTC
2021-02-05 03:14:24.5: Obs M20 in Plan M20 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 14:27:37 UTC
2021-02-05 03:14:24.5: Obs M21 in Plan M21 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 14:24:33 UTC
2021-02-05 03:14:24.5: Obs M22 in Plan M22 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.5:     AirmassRange estimates ready after 05-Feb-2021 15:10:17 UTC
2021-02-05 03:14:24.6: Obs M23 in Plan M23 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.6:     AirmassRange estimates ready after 05-Feb-2021 13:49:22 UTC
2021-02-05 03:14:24.6: Obs M24 in Plan M24 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.6:     AirmassRange estimates ready after 05-Feb-2021 14:05:51 UTC
2021-02-05 03:14:24.6: Obs M28 in Plan M28 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.6:     AirmassRange estimates ready after 05-Feb-2021 15:09:50 UTC
2021-02-05 03:14:24.6: Obs M4 in Plan M4 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.6:     AirmassRange estimates ready after 05-Feb-2021 13:35:25 UTC
2021-02-05 03:14:24.6: Obs M8 in Plan M8 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.6:     AirmassRange estimates ready after 05-Feb-2021 14:43:16 UTC
2021-02-05 03:14:24.6: Obs M80 in Plan M80 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.6:     AirmassRange estimates ready after 05-Feb-2021 12:41:49 UTC
2021-02-05 03:14:24.7: Obs M9 in Plan M9 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.7:     AirmassRange estimates ready after 05-Feb-2021 13:08:32 UTC
2021-02-05 03:14:24.7: EPH (Mars): type=Major Planet time=03:14:24 ra=2.7743606 dec=17.441761
2021-02-05 03:14:24.7: Obs Mrk_180 in Plan Mrk_180 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.7:     AirmassRange estimates ready after 05-Feb-2021 03:38:16 UTC
2021-02-05 03:14:24.7: Obs NGC_6121 in Plan NGC_6121 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.7:     AirmassRange estimates ready after 05-Feb-2021 13:35:15 UTC
2021-02-05 03:14:24.7: Obs NGC_6254 in Plan NGC_6254 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.7:     AirmassRange estimates ready after 05-Feb-2021 11:38:58 UTC
2021-02-05 03:14:24.7: Obs NGC_7078 in Plan NGC_7078 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.7:     AirmassRange estimates ready after 05-Feb-2021 15:24:24 UTC
2021-02-05 03:14:24.7: Obs NGC_7089 in Plan NGC_7089 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.7:     AirmassRange estimates ready after 05-Feb-2021 16:03:34 UTC
2021-02-05 03:14:24.8: Obs PG_1424+240 in Plan PG_1424+240 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.8:     AirmassRange estimates ready after 05-Feb-2021 07:57:07 UTC
2021-02-05 03:14:24.8: Obs PG_1553+113 in Plan PG_1553+113 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.8:     AirmassRange estimates ready after 05-Feb-2021 09:53:25 UTC
2021-02-05 03:14:24.8: Obs PKS_1222+216 in Plan PKS_1222+216 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.8:     AirmassRange estimates ready after 05-Feb-2021 06:00:18 UTC
2021-02-05 03:14:24.8: Obs PKS_1510-089 in Plan PKS_1510-089 was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.8:     AirmassRange estimates ready after 05-Feb-2021 10:13:59 UTC
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.8: Plan Romanov_V20 couldn't be run before latest time, failed.
2021-02-05 03:14:24.8: Plan Romanov_V20 couldn't be run before latest time, failed.
2021-02-05 03:14:24.8: Plan Romanov_V20 couldn't be run before latest time, failed.
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.8: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.9: Plan Romanov_V20 deferred, too early
2021-02-05 03:14:24.9: EPH (Saturn): type=Major Planet time=03:14:24 ra=20.5301452 dec=-19.313100
2021-02-05 03:14:24.9: Obs Saturn in Plan Saturn was vetoed by AirmassRange constraint.
2021-02-05 03:14:24.9:     AirmassRange estimates ready after 05-Feb-2021 15:39:10 UTC
2021-02-05 03:14:24.9: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 03:14:24.9:  (deferred for 55 min, until 05-Feb-2021 04:09:24 UTC
2021-02-05 03:14:24.9: Plan V510_Ori deferred, too early
2021-02-05 03:14:24.9: Plan V5631_Sgr would extend past daylight, deferred to next night
2021-02-05 03:14:24.9: Efficiency: Selecting from 9 pending plans:
2021-02-05 03:14:25.1:   Selected Plan EU_Cas (TotEff=3.43)
2021-02-05 03:14:25.2: Dispatcher cycle time: 3.2 sec.
2021-02-05 03:14:25.2: Acquire data for Observation EU_Cas...
2021-02-05 03:14:25.2:   (belongs to Project AAVSO_P141A_SPP_AUTO_ver1921, Plan EU_Cas)
2021-02-05 03:14:25.2: Send Observation EU_Cas to ACP Sequencer
2021-02-05 03:14:25.2: ACP.RunScript(AcquireScheduler, ):
2021-02-05 03:14:25.2:   Script AutoFocusScheduler is loaded, and
2021-02-05 03:14:25.2:   the console is idle.
2021-02-05 03:14:25.2:   In start loop, i = 0
2021-02-05 03:14:25.2:   Console is now idle
2021-02-05 03:14:25.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 03:14:25.4:   Script started successfully
2021-02-05 03:14:35.4: Sequencer is now active
2021-02-05 03:40:23.7: Sequencer is no longer active
2021-02-05 03:40:23.7: Post-job status check done (stat=Completed)
2021-02-05 03:40:23.7: Acquisition time: 1558.5055456 sec.
2021-02-05 03:40:23.7: Data for Observation EU_Cas of Plan EU_Cas acquired successfully.
2021-02-05 03:40:23.7: Plan EU_Cas completed successfully.
2021-02-05 03:40:23.8: Image Efficiency: 60.2%
2021-02-05 03:40:23.8: Cycle Efficiency: 99.8%
2021-02-05 03:40:23.9: SelectRunning: No running plans
2021-02-05 03:40:24.0: EPH (Mars): type=Major Planet time=03:40:23 ra=2.7750112 dec=17.444801
2021-02-05 03:40:24.1: Efficiency: Selecting from 10 pending plans:
2021-02-05 03:40:24.2:   Selected Plan V510_Ori (TotEff=2.86)
2021-02-05 03:40:24.3: Dispatcher cycle time: 0.4 sec.
2021-02-05 03:40:24.3: Acquire data for Observation V510_Ori...
2021-02-05 03:40:24.3:   (belongs to Project AAVSO_P159A_WFM_AUTO_ver1920, Plan V510_Ori)
2021-02-05 03:40:24.4: Send Observation V510_Ori to ACP Sequencer
2021-02-05 03:40:24.4: ACP.RunScript(AcquireScheduler, ):
2021-02-05 03:40:24.4:   Script AcquireScheduler is loaded, and
2021-02-05 03:40:24.4:   the console is idle.
2021-02-05 03:40:24.4:   In start loop, i = 0
2021-02-05 03:40:24.4:   Console is now idle
2021-02-05 03:40:24.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 03:40:24.4:   Script started successfully
2021-02-05 03:40:34.4: Sequencer is now active
2021-02-05 04:30:40.0: Sequencer is no longer active
2021-02-05 04:30:40.0: Post-job status check done (stat=Completed)
2021-02-05 04:30:40.0: Acquisition time: 3015.6241748 sec.
2021-02-05 04:30:40.0: Data for Observation V510_Ori of Plan V510_Ori acquired successfully.
2021-02-05 04:30:40.0: Plan V510_Ori completed successfully.
2021-02-05 04:30:40.0: Image Efficiency: 83.6%
2021-02-05 04:30:40.0: Cycle Efficiency: 100.0%
2021-02-05 04:30:40.1: ++ Auto Focus ++
2021-02-05 04:30:40.2: Doing periodic autofocus.
2021-02-05 04:30:40.2: Start special ACP AutoFocus script for scheduler
2021-02-05 04:30:40.2: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 04:30:40.2:   Script AcquireScheduler is loaded, and
2021-02-05 04:30:40.2:   the console is idle.
2021-02-05 04:30:40.2:   In start loop, i = 0
2021-02-05 04:30:40.2:   Console is now idle
2021-02-05 04:30:40.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 04:30:40.4:   Script started successfully
2021-02-05 04:30:50.4: Sequencer is now active
2021-02-05 04:34:20.4: Sequencer is no longer active
2021-02-05 04:34:20.4: Next periodic autofocus ASAP after 3600sec. 05-Feb-2021 05:34:00 UTC
2021-02-05 04:34:20.4: SelectRunning: No running plans
2021-02-05 04:34:20.4: Obs EG_And in Plan EG_And was vetoed by AirmassRange constraint.
2021-02-05 04:34:20.4:     AirmassRange estimates ready after 05-Feb-2021 17:41:32 UTC
2021-02-05 04:34:20.5: EPH (Mars): type=Major Planet time=04:34:20 ra=2.7763614 dec=17.451109
2021-02-05 04:34:20.5: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 04:34:20.5:  (deferred for 54 min, until 05-Feb-2021 05:28:20 UTC
2021-02-05 04:34:20.5: Efficiency: Selecting from 8 pending plans:
2021-02-05 04:34:20.6:   Selected Plan V1112_Per (TotEff=2.75)
2021-02-05 04:34:20.7: Dispatcher cycle time: 0.3 sec.
2021-02-05 04:34:20.7: Acquire data for Observation V1112_Per...
2021-02-05 04:34:20.7:   (belongs to Project AAVSO_P167_HGUA_AUTO_ver1902, Plan V1112_Per)
2021-02-05 04:34:20.8: Send Observation V1112_Per to ACP Sequencer
2021-02-05 04:34:20.8: ACP.RunScript(AcquireScheduler, ):
2021-02-05 04:34:20.8:   Script AutoFocusScheduler is loaded, and
2021-02-05 04:34:20.8:   the console is idle.
2021-02-05 04:34:20.8:   In start loop, i = 0
2021-02-05 04:34:20.8:   Console is now idle
2021-02-05 04:34:20.9:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 04:34:20.9:   Script started successfully
2021-02-05 04:34:30.9: Sequencer is now active
2021-02-05 04:48:48.0: Sequencer is no longer active
2021-02-05 04:48:48.0: Post-job status check done (stat=Failed)
2021-02-05 04:48:48.0: ACP data acquisition failed for Observation V1112_Per.
2021-02-05 04:48:48.0:   (Observation V1112_Per interrupted by acquisition process failure.)
2021-02-05 04:48:48.2: SelectRunning: No running plans
2021-02-05 04:48:48.3: EPH (Mars): type=Major Planet time=04:48:48 ra=2.7767235 dec=17.452800
2021-02-05 04:48:48.3: Efficiency: Selecting from 7 pending plans:
2021-02-05 04:48:48.4:   Selected Plan Mars (TotEff=2.33)
2021-02-05 04:48:48.5: Dispatcher cycle time: 0.3 sec.
2021-02-05 04:48:48.5: Acquire data for Observation Mars...
2021-02-05 04:48:48.5:   (belongs to Project Planet, Plan Mars)
2021-02-05 04:48:48.5: Send Observation Mars to ACP Sequencer
2021-02-05 04:48:48.5: ACP.RunScript(AcquireScheduler, ):
2021-02-05 04:48:48.5:   Script AcquireScheduler is loaded, and
2021-02-05 04:48:48.5:   the console is idle.
2021-02-05 04:48:48.5:   In start loop, i = 0
2021-02-05 04:48:48.5:   Console is now idle
2021-02-05 04:48:48.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 04:48:48.5:   Script started successfully
2021-02-05 04:48:58.5: Sequencer is now active
2021-02-05 04:50:33.0: Sequencer is no longer active
2021-02-05 04:50:33.0: Post-job status check done (stat=Failed)
2021-02-05 04:50:33.0: ACP data acquisition failed for Observation Mars.
2021-02-05 04:50:33.0:   (Observation Mars interrupted by acquisition process failure.)
2021-02-05 04:50:33.2: SelectRunning: No running plans
2021-02-05 04:50:33.3: Efficiency: Selecting from 6 pending plans:
2021-02-05 04:50:33.3:   Selected Plan AX_Per (TotEff=1.73)
2021-02-05 04:50:33.4: Dispatcher cycle time: 0.2 sec.
2021-02-05 04:50:33.4: Acquire data for Observation AX_Per...
2021-02-05 04:50:33.4:   (belongs to Project AAVSO_MISC_SBL_AUTO_ver1899, Plan AX_Per)
2021-02-05 04:50:33.4: Send Observation AX_Per to ACP Sequencer
2021-02-05 04:50:33.4: ACP.RunScript(AcquireScheduler, ):
2021-02-05 04:50:33.4:   Script AcquireScheduler is loaded, and
2021-02-05 04:50:33.4:   the console is idle.
2021-02-05 04:50:33.4:   In start loop, i = 0
2021-02-05 04:50:33.4:   Console is now idle
2021-02-05 04:50:33.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 04:50:33.4:   Script started successfully
2021-02-05 04:50:43.5: Sequencer is now active
2021-02-05 04:52:54.6: Sequencer is no longer active
2021-02-05 04:52:54.6: Post-job status check done (stat=Failed)
2021-02-05 04:52:54.7: ACP data acquisition failed for Observation AX_Per.
2021-02-05 04:52:54.7:   (Observation AX_Per interrupted by acquisition process failure.)
2021-02-05 04:52:54.8: SelectRunning: No running plans
2021-02-05 04:52:54.9: Efficiency: Selecting from 5 pending plans:
2021-02-05 04:52:54.9:   Selected Plan V1261_Ori (TotEff=1.60)
2021-02-05 04:52:55.0: Dispatcher cycle time: 0.2 sec.
2021-02-05 04:52:55.0: Acquire data for Observation V1261_Ori...
2021-02-05 04:52:55.0:   (belongs to Project AAVSO_MISC_SBL_AUTO_ver1899, Plan V1261_Ori)
2021-02-05 04:52:55.0: Send Observation V1261_Ori to ACP Sequencer
2021-02-05 04:52:55.0: ACP.RunScript(AcquireScheduler, ):
2021-02-05 04:52:55.0:   Script AcquireScheduler is loaded, and
2021-02-05 04:52:55.0:   the console is idle.
2021-02-05 04:52:55.0:   In start loop, i = 0
2021-02-05 04:52:55.0:   Console is now idle
2021-02-05 04:52:55.0:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 04:52:55.0:   Script started successfully
2021-02-05 04:53:05.1: Sequencer is now active
2021-02-05 04:55:44.1: Sequencer is no longer active
2021-02-05 04:55:44.1: Post-job status check done (stat=Failed)
2021-02-05 04:55:44.1: ACP data acquisition failed for Observation V1261_Ori.
2021-02-05 04:55:44.1:   (Observation V1261_Ori interrupted by acquisition process failure.)
2021-02-05 04:55:44.3: SelectRunning: No running plans
2021-02-05 04:55:44.3: Efficiency: Selecting from 4 pending plans:
2021-02-05 04:55:44.4:   Selected Plan Mrk_180 (TotEff=1.17)
2021-02-05 04:55:44.5: Dispatcher cycle time: 0.2 sec.
2021-02-05 04:55:44.5: Acquire data for Observation Mrk_180...
2021-02-05 04:55:44.5:   (belongs to Project AAVSO_MISC_OAR_AUTO_ver1895, Plan Mrk_180)
2021-02-05 04:55:44.5: Send Observation Mrk_180 to ACP Sequencer
2021-02-05 04:55:44.5: ACP.RunScript(AcquireScheduler, ):
2021-02-05 04:55:44.5:   Script AcquireScheduler is loaded, and
2021-02-05 04:55:44.5:   the console is idle.
2021-02-05 04:55:44.5:   In start loop, i = 0
2021-02-05 04:55:44.5:   Console is now idle
2021-02-05 04:55:44.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 04:55:44.5:   Script started successfully
2021-02-05 04:55:54.5: Sequencer is now active
2021-02-05 05:02:53.0: Sequencer is no longer active
2021-02-05 05:02:53.0: Post-job status check done (stat=Completed)
2021-02-05 05:02:53.0: Acquisition time: 428.5155894 sec.
2021-02-05 05:02:53.0: Data for Observation Mrk_180 of Plan Mrk_180 acquired successfully.
2021-02-05 05:02:53.0: Plan Mrk_180 completed successfully.
2021-02-05 05:02:53.1: Image Efficiency: 42.0%
2021-02-05 05:02:53.1: Cycle Efficiency: 99.9%
2021-02-05 05:02:53.2: SelectRunning: No running plans
2021-02-05 05:02:53.2: Efficiency: Selecting from 3 pending plans:
2021-02-05 05:02:53.3:   Selected Plan NQ_Gem (TotEff=1.48)
2021-02-05 05:02:53.3: Dispatcher cycle time: 0.2 sec.
2021-02-05 05:02:53.3: Acquire data for Observation NQ_Gem...
2021-02-05 05:02:53.3:   (belongs to Project AAVSO_MISC_SBL_AUTO_ver1899, Plan NQ_Gem)
2021-02-05 05:02:53.4: Send Observation NQ_Gem to ACP Sequencer
2021-02-05 05:02:53.4: ACP.RunScript(AcquireScheduler, ):
2021-02-05 05:02:53.4:   Script AcquireScheduler is loaded, and
2021-02-05 05:02:53.4:   the console is idle.
2021-02-05 05:02:53.4:   In start loop, i = 0
2021-02-05 05:02:53.4:   Console is now idle
2021-02-05 05:02:53.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 05:02:53.4:   Script started successfully
2021-02-05 05:03:03.4: Sequencer is now active
2021-02-05 05:06:10.0: Sequencer is no longer active
2021-02-05 05:06:10.0: Post-job status check done (stat=Failed)
2021-02-05 05:06:10.0: ACP data acquisition failed for Observation NQ_Gem.
2021-02-05 05:06:10.0:   (Observation NQ_Gem interrupted by acquisition process failure.)
2021-02-05 05:06:10.2: SelectRunning: No running plans
2021-02-05 05:06:10.2: Efficiency: Selecting from 2 pending plans:
2021-02-05 05:06:10.2:   Selected Plan KH15D (TotEff=0.87)
2021-02-05 05:06:10.3: Dispatcher cycle time: 0.2 sec.
2021-02-05 05:06:10.3: Acquire data for Observation KH15D...
2021-02-05 05:06:10.3:   (belongs to Project KH15D, Plan KH15D)
2021-02-05 05:06:10.3: Send Observation KH15D to ACP Sequencer
2021-02-05 05:06:10.3: ACP.RunScript(AcquireScheduler, ):
2021-02-05 05:06:10.3:   Script AcquireScheduler is loaded, and
2021-02-05 05:06:10.3:   the console is idle.
2021-02-05 05:06:10.3:   In start loop, i = 0
2021-02-05 05:06:10.3:   Console is now idle
2021-02-05 05:06:10.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 05:06:10.3:   Script started successfully
2021-02-05 05:06:20.4: Sequencer is now active
2021-02-05 06:13:07.3: Sequencer is no longer active
2021-02-05 06:13:07.3: Post-job status check done (stat=Completed)
2021-02-05 06:13:07.3: Acquisition time: 4017.0094603 sec.
2021-02-05 06:13:07.3: Data for Observation KH15D of Plan KH15D acquired successfully.
2021-02-05 06:13:07.4: Plan KH15D completed successfully.
2021-02-05 06:13:07.4: Image Efficiency: 89.6%
2021-02-05 06:13:07.4: Cycle Efficiency: 100.0%
2021-02-05 06:13:07.5: ++ Auto Focus ++
2021-02-05 06:13:07.5: Doing periodic autofocus.
2021-02-05 06:13:07.5: Start special ACP AutoFocus script for scheduler
2021-02-05 06:13:07.5: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 06:13:07.5:   Script AcquireScheduler is loaded, and
2021-02-05 06:13:07.5:   the console is idle.
2021-02-05 06:13:07.5:   In start loop, i = 0
2021-02-05 06:13:07.5:   Console is now idle
2021-02-05 06:13:07.6:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 06:13:07.6:   Script started successfully
2021-02-05 06:13:17.6: Sequencer is now active
2021-02-05 06:16:56.8: Sequencer is no longer active
2021-02-05 06:16:56.8: Next periodic autofocus ASAP after 3600sec. 05-Feb-2021 07:16:31 UTC
2021-02-05 06:16:56.9: SelectRunning: No running plans
2021-02-05 06:16:56.9: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 06:16:56.9:  (deferred for 65 min, until 05-Feb-2021 07:21:56 UTC
2021-02-05 06:16:56.9: Efficiency: Selecting from 2 pending plans:
2021-02-05 06:16:57.0:   Selected Plan PKS_1222+216 (TotEff=1.90)
2021-02-05 06:16:57.0: Dispatcher cycle time: 0.2 sec.
2021-02-05 06:16:57.0: Acquire data for Observation PKS_1222+216...
2021-02-05 06:16:57.0:   (belongs to Project AAVSO_MISC_OAR_AUTO_ver1895, Plan PKS_1222+216)
2021-02-05 06:16:57.0: Send Observation PKS_1222+216 to ACP Sequencer
2021-02-05 06:16:57.0: ACP.RunScript(AcquireScheduler, ):
2021-02-05 06:16:57.0:   Script AutoFocusScheduler is loaded, and
2021-02-05 06:16:57.0:   the console is idle.
2021-02-05 06:16:57.0:   In start loop, i = 0
2021-02-05 06:16:57.0:   Console is now idle
2021-02-05 06:16:57.1:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 06:16:57.1:   Script started successfully
2021-02-05 06:17:07.1: Sequencer is now active
2021-02-05 06:19:30.1: Sequencer is no longer active
2021-02-05 06:19:30.1: Post-job status check done (stat=Failed)
2021-02-05 06:19:30.1: ACP data acquisition failed for Observation PKS_1222+216.
2021-02-05 06:19:30.1:   (Observation PKS_1222+216 interrupted by acquisition process failure.)
2021-02-05 06:19:30.3: SelectRunning: No running plans
2021-02-05 06:19:30.3: Efficiency: Only one pending plan KH15D-B, it is the "best"
2021-02-05 06:19:30.4: Dispatcher cycle time: 0.1 sec.
2021-02-05 06:19:30.4: Acquire data for Observation KH15D-B...
2021-02-05 06:19:30.4:   (belongs to Project KH15D, Plan KH15D-B)
2021-02-05 06:19:30.4: Send Observation KH15D-B to ACP Sequencer
2021-02-05 06:19:30.4: ACP.RunScript(AcquireScheduler, ):
2021-02-05 06:19:30.4:   Script AcquireScheduler is loaded, and
2021-02-05 06:19:30.4:   the console is idle.
2021-02-05 06:19:30.4:   In start loop, i = 0
2021-02-05 06:19:30.4:   Console is now idle
2021-02-05 06:19:30.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 06:19:30.4:   Script started successfully
2021-02-05 06:19:40.4: Sequencer is now active
2021-02-05 06:41:11.0: Sequencer is no longer active
2021-02-05 06:41:11.0: Post-job status check done (stat=Completed)
2021-02-05 06:41:11.0: Observation had successful requested AF, defer next periodic AF:
2021-02-05 06:41:11.0: Next periodic AF will be ASAP after 3600sec. 05-Feb-2021 07:23:37 UTC
2021-02-05 06:41:11.0: Acquisition time: 1300.5930966 sec.
2021-02-05 06:41:11.0: Data for Observation KH15D-B of Plan KH15D-B acquired successfully.
2021-02-05 06:41:11.0: Plan KH15D-B completed successfully.
2021-02-05 06:41:11.0: Image Efficiency: 69.2%
2021-02-05 06:41:11.0: Cycle Efficiency: 100.0%
2021-02-05 06:41:11.2: SelectRunning: No running plans
2021-02-05 06:41:11.2: No pending plans that can be started now.
2021-02-05 06:41:11.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:41:41.8: SelectRunning: No running plans
2021-02-05 06:41:41.8: No pending plans that can be started now.
2021-02-05 06:41:41.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:42:12.4: SelectRunning: No running plans
2021-02-05 06:42:12.4: No pending plans that can be started now.
2021-02-05 06:42:12.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:42:43.0: SelectRunning: No running plans
2021-02-05 06:42:43.0: No pending plans that can be started now.
2021-02-05 06:42:43.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:43:13.6: SelectRunning: No running plans
2021-02-05 06:43:13.6: No pending plans that can be started now.
2021-02-05 06:43:13.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:43:44.1: SelectRunning: No running plans
2021-02-05 06:43:44.1: No pending plans that can be started now.
2021-02-05 06:43:44.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:44:15.0: SelectRunning: No running plans
2021-02-05 06:44:15.0: No pending plans that can be started now.
2021-02-05 06:44:15.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:44:45.6: SelectRunning: No running plans
2021-02-05 06:44:45.6: No pending plans that can be started now.
2021-02-05 06:44:45.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:45:16.2: SelectRunning: No running plans
2021-02-05 06:45:16.2: No pending plans that can be started now.
2021-02-05 06:45:16.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:45:47.1: SelectRunning: No running plans
2021-02-05 06:45:47.1: No pending plans that can be started now.
2021-02-05 06:45:47.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:46:17.7: SelectRunning: No running plans
2021-02-05 06:46:17.7: No pending plans that can be started now.
2021-02-05 06:46:17.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:46:48.3: SelectRunning: No running plans
2021-02-05 06:46:48.3: No pending plans that can be started now.
2021-02-05 06:46:48.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:47:19.2: SelectRunning: No running plans
2021-02-05 06:47:19.2: No pending plans that can be started now.
2021-02-05 06:47:19.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:47:49.8: SelectRunning: No running plans
2021-02-05 06:47:49.8: No pending plans that can be started now.
2021-02-05 06:47:49.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:48:20.4: SelectRunning: No running plans
2021-02-05 06:48:20.4: No pending plans that can be started now.
2021-02-05 06:48:20.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:48:51.4: SelectRunning: No running plans
2021-02-05 06:48:51.4: No pending plans that can be started now.
2021-02-05 06:48:51.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:49:22.0: SelectRunning: No running plans
2021-02-05 06:49:22.0: No pending plans that can be started now.
2021-02-05 06:49:22.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:49:52.6: SelectRunning: No running plans
2021-02-05 06:49:52.6: No pending plans that can be started now.
2021-02-05 06:49:52.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:50:23.5: SelectRunning: No running plans
2021-02-05 06:50:23.5: No pending plans that can be started now.
2021-02-05 06:50:23.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:50:54.1: SelectRunning: No running plans
2021-02-05 06:50:54.1: No pending plans that can be started now.
2021-02-05 06:50:54.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:51:24.7: SelectRunning: No running plans
2021-02-05 06:51:24.7: No pending plans that can be started now.
2021-02-05 06:51:24.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:51:55.6: SelectRunning: No running plans
2021-02-05 06:51:55.6: No pending plans that can be started now.
2021-02-05 06:51:55.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:52:26.2: SelectRunning: No running plans
2021-02-05 06:52:26.2: No pending plans that can be started now.
2021-02-05 06:52:26.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:52:56.8: SelectRunning: No running plans
2021-02-05 06:52:56.8: No pending plans that can be started now.
2021-02-05 06:52:56.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:53:27.7: SelectRunning: No running plans
2021-02-05 06:53:27.7: No pending plans that can be started now.
2021-02-05 06:53:27.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:53:58.3: SelectRunning: No running plans
2021-02-05 06:53:58.3: No pending plans that can be started now.
2021-02-05 06:53:58.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:54:28.9: SelectRunning: No running plans
2021-02-05 06:54:28.9: No pending plans that can be started now.
2021-02-05 06:54:28.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:54:59.9: SelectRunning: No running plans
2021-02-05 06:54:59.9: No pending plans that can be started now.
2021-02-05 06:54:59.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:55:30.5: SelectRunning: No running plans
2021-02-05 06:55:30.5: No pending plans that can be started now.
2021-02-05 06:55:30.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:56:01.1: SelectRunning: No running plans
2021-02-05 06:56:01.1: No pending plans that can be started now.
2021-02-05 06:56:01.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:56:32.0: SelectRunning: No running plans
2021-02-05 06:56:32.0: No pending plans that can be started now.
2021-02-05 06:56:32.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:57:02.6: SelectRunning: No running plans
2021-02-05 06:57:02.6: No pending plans that can be started now.
2021-02-05 06:57:02.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:57:33.2: SelectRunning: No running plans
2021-02-05 06:57:33.2: No pending plans that can be started now.
2021-02-05 06:57:33.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:58:04.1: SelectRunning: No running plans
2021-02-05 06:58:04.1: No pending plans that can be started now.
2021-02-05 06:58:04.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:58:34.7: SelectRunning: No running plans
2021-02-05 06:58:34.7: No pending plans that can be started now.
2021-02-05 06:58:34.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:59:05.3: SelectRunning: No running plans
2021-02-05 06:59:05.3: No pending plans that can be started now.
2021-02-05 06:59:05.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 06:59:36.3: SelectRunning: No running plans
2021-02-05 06:59:36.3: No pending plans that can be started now.
2021-02-05 06:59:36.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:00:06.9: SelectRunning: No running plans
2021-02-05 07:00:06.9: No pending plans that can be started now.
2021-02-05 07:00:06.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:00:37.5: SelectRunning: No running plans
2021-02-05 07:00:37.5: No pending plans that can be started now.
2021-02-05 07:00:37.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:01:08.4: SelectRunning: No running plans
2021-02-05 07:01:08.4: No pending plans that can be started now.
2021-02-05 07:01:08.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:01:39.0: SelectRunning: No running plans
2021-02-05 07:01:39.0: No pending plans that can be started now.
2021-02-05 07:01:39.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:02:09.6: SelectRunning: No running plans
2021-02-05 07:02:09.6: No pending plans that can be started now.
2021-02-05 07:02:09.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:02:40.5: SelectRunning: No running plans
2021-02-05 07:02:40.5: No pending plans that can be started now.
2021-02-05 07:02:40.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:03:11.1: SelectRunning: No running plans
2021-02-05 07:03:11.1: No pending plans that can be started now.
2021-02-05 07:03:11.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:03:41.7: SelectRunning: No running plans
2021-02-05 07:03:41.7: No pending plans that can be started now.
2021-02-05 07:03:41.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:04:12.7: SelectRunning: No running plans
2021-02-05 07:04:12.7: No pending plans that can be started now.
2021-02-05 07:04:12.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:04:43.3: SelectRunning: No running plans
2021-02-05 07:04:43.3: No pending plans that can be started now.
2021-02-05 07:04:43.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:05:13.9: SelectRunning: No running plans
2021-02-05 07:05:13.9: No pending plans that can be started now.
2021-02-05 07:05:13.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:05:44.9: SelectRunning: No running plans
2021-02-05 07:05:44.9: No pending plans that can be started now.
2021-02-05 07:05:44.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:06:15.5: SelectRunning: No running plans
2021-02-05 07:06:15.5: No pending plans that can be started now.
2021-02-05 07:06:15.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:06:46.1: SelectRunning: No running plans
2021-02-05 07:06:46.1: No pending plans that can be started now.
2021-02-05 07:06:46.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:07:17.0: SelectRunning: No running plans
2021-02-05 07:07:17.0: No pending plans that can be started now.
2021-02-05 07:07:17.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:07:47.6: SelectRunning: No running plans
2021-02-05 07:07:47.6: No pending plans that can be started now.
2021-02-05 07:07:47.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:08:18.2: SelectRunning: No running plans
2021-02-05 07:08:18.2: No pending plans that can be started now.
2021-02-05 07:08:18.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:08:48.8: SelectRunning: No running plans
2021-02-05 07:08:48.8: No pending plans that can be started now.
2021-02-05 07:08:48.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:09:19.4: SelectRunning: No running plans
2021-02-05 07:09:19.4: No pending plans that can be started now.
2021-02-05 07:09:19.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:09:50.0: SelectRunning: No running plans
2021-02-05 07:09:50.0: No pending plans that can be started now.
2021-02-05 07:09:50.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:10:20.6: SelectRunning: No running plans
2021-02-05 07:10:20.6: No pending plans that can be started now.
2021-02-05 07:10:20.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:10:51.2: SelectRunning: No running plans
2021-02-05 07:10:51.2: No pending plans that can be started now.
2021-02-05 07:10:51.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:11:21.8: SelectRunning: No running plans
2021-02-05 07:11:21.8: No pending plans that can be started now.
2021-02-05 07:11:21.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:11:52.4: SelectRunning: No running plans
2021-02-05 07:11:52.4: No pending plans that can be started now.
2021-02-05 07:11:52.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:12:23.0: SelectRunning: No running plans
2021-02-05 07:12:23.0: No pending plans that can be started now.
2021-02-05 07:12:23.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:12:53.6: SelectRunning: No running plans
2021-02-05 07:12:53.6: No pending plans that can be started now.
2021-02-05 07:12:53.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:13:24.2: SelectRunning: No running plans
2021-02-05 07:13:24.2: No pending plans that can be started now.
2021-02-05 07:13:24.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:13:54.8: SelectRunning: No running plans
2021-02-05 07:13:54.8: No pending plans that can be started now.
2021-02-05 07:13:54.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:14:25.4: SelectRunning: No running plans
2021-02-05 07:14:25.4: No pending plans that can be started now.
2021-02-05 07:14:25.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:14:56.0: SelectRunning: No running plans
2021-02-05 07:14:56.0: No pending plans that can be started now.
2021-02-05 07:14:56.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:15:26.6: SelectRunning: No running plans
2021-02-05 07:15:26.6: No pending plans that can be started now.
2021-02-05 07:15:26.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:15:57.5: SelectRunning: No running plans
2021-02-05 07:15:57.5: No pending plans that can be started now.
2021-02-05 07:15:57.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:16:28.1: SelectRunning: No running plans
2021-02-05 07:16:28.1: No pending plans that can be started now.
2021-02-05 07:16:28.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:16:58.7: SelectRunning: No running plans
2021-02-05 07:16:58.7: No pending plans that can be started now.
2021-02-05 07:16:58.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:17:29.6: SelectRunning: No running plans
2021-02-05 07:17:29.6: No pending plans that can be started now.
2021-02-05 07:17:29.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:18:00.3: SelectRunning: No running plans
2021-02-05 07:18:00.3: No pending plans that can be started now.
2021-02-05 07:18:00.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:18:30.9: SelectRunning: No running plans
2021-02-05 07:18:30.9: No pending plans that can be started now.
2021-02-05 07:18:30.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:19:01.8: SelectRunning: No running plans
2021-02-05 07:19:01.8: No pending plans that can be started now.
2021-02-05 07:19:01.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:19:32.4: SelectRunning: No running plans
2021-02-05 07:19:32.4: No pending plans that can be started now.
2021-02-05 07:19:32.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:20:03.0: SelectRunning: No running plans
2021-02-05 07:20:03.0: No pending plans that can be started now.
2021-02-05 07:20:03.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:20:33.9: SelectRunning: No running plans
2021-02-05 07:20:33.9: No pending plans that can be started now.
2021-02-05 07:20:33.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:21:04.5: SelectRunning: No running plans
2021-02-05 07:21:04.5: No pending plans that can be started now.
2021-02-05 07:21:04.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:21:35.1: SelectRunning: No running plans
2021-02-05 07:21:35.1: No pending plans that can be started now.
2021-02-05 07:21:35.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:22:06.1: SelectRunning: No running plans
2021-02-05 07:22:06.1: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 07:22:06.1:  (deferred for 68 min, until 05-Feb-2021 08:30:06 UTC
2021-02-05 07:22:06.1: No pending plans that can be started now.
2021-02-05 07:22:06.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:22:36.7: SelectRunning: No running plans
2021-02-05 07:22:36.7: No pending plans that can be started now.
2021-02-05 07:22:36.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:23:07.3: SelectRunning: No running plans
2021-02-05 07:23:07.3: No pending plans that can be started now.
2021-02-05 07:23:07.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:23:38.2: ++ Auto Focus ++
2021-02-05 07:23:38.2: Doing periodic autofocus.
2021-02-05 07:23:38.2: Start special ACP AutoFocus script for scheduler
2021-02-05 07:23:38.2: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 07:23:38.2:   Script AcquireScheduler is loaded, and
2021-02-05 07:23:38.2:   the console is idle.
2021-02-05 07:23:38.2:   In start loop, i = 0
2021-02-05 07:23:38.2:   Console is now idle
2021-02-05 07:23:38.2:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 07:23:38.2:   Script started successfully
2021-02-05 07:23:48.3: Sequencer is now active
2021-02-05 07:27:07.3: Sequencer is no longer active
2021-02-05 07:27:07.3: Next periodic autofocus ASAP after 3600sec. 05-Feb-2021 08:26:53 UTC
2021-02-05 07:27:07.3: SelectRunning: No running plans
2021-02-05 07:27:07.3: No pending plans that can be started now.
2021-02-05 07:27:07.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:27:37.9: SelectRunning: No running plans
2021-02-05 07:27:37.9: No pending plans that can be started now.
2021-02-05 07:27:37.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:28:08.9: SelectRunning: No running plans
2021-02-05 07:28:08.9: No pending plans that can be started now.
2021-02-05 07:28:08.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:28:39.5: SelectRunning: No running plans
2021-02-05 07:28:39.5: No pending plans that can be started now.
2021-02-05 07:28:39.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:29:10.1: SelectRunning: No running plans
2021-02-05 07:29:10.1: No pending plans that can be started now.
2021-02-05 07:29:10.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:29:41.0: SelectRunning: No running plans
2021-02-05 07:29:41.0: No pending plans that can be started now.
2021-02-05 07:29:41.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:30:11.6: SelectRunning: No running plans
2021-02-05 07:30:11.6: No pending plans that can be started now.
2021-02-05 07:30:11.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:30:42.2: SelectRunning: No running plans
2021-02-05 07:30:42.2: No pending plans that can be started now.
2021-02-05 07:30:42.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:31:13.1: SelectRunning: No running plans
2021-02-05 07:31:13.1: No pending plans that can be started now.
2021-02-05 07:31:13.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:31:43.7: SelectRunning: No running plans
2021-02-05 07:31:43.7: No pending plans that can be started now.
2021-02-05 07:31:43.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:32:14.3: SelectRunning: No running plans
2021-02-05 07:32:14.3: No pending plans that can be started now.
2021-02-05 07:32:14.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:32:45.3: SelectRunning: No running plans
2021-02-05 07:32:45.3: No pending plans that can be started now.
2021-02-05 07:32:45.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:33:15.9: SelectRunning: No running plans
2021-02-05 07:33:15.9: No pending plans that can be started now.
2021-02-05 07:33:15.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:33:46.5: SelectRunning: No running plans
2021-02-05 07:33:46.5: No pending plans that can be started now.
2021-02-05 07:33:46.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:34:17.5: SelectRunning: No running plans
2021-02-05 07:34:17.5: No pending plans that can be started now.
2021-02-05 07:34:17.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:34:48.0: SelectRunning: No running plans
2021-02-05 07:34:48.0: No pending plans that can be started now.
2021-02-05 07:34:48.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:35:18.7: SelectRunning: No running plans
2021-02-05 07:35:18.7: No pending plans that can be started now.
2021-02-05 07:35:18.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:35:49.6: SelectRunning: No running plans
2021-02-05 07:35:49.6: No pending plans that can be started now.
2021-02-05 07:35:49.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:36:20.2: SelectRunning: No running plans
2021-02-05 07:36:20.2: No pending plans that can be started now.
2021-02-05 07:36:20.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:36:50.8: SelectRunning: No running plans
2021-02-05 07:36:50.8: No pending plans that can be started now.
2021-02-05 07:36:50.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:37:21.7: SelectRunning: No running plans
2021-02-05 07:37:21.7: No pending plans that can be started now.
2021-02-05 07:37:21.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:37:52.3: SelectRunning: No running plans
2021-02-05 07:37:52.3: No pending plans that can be started now.
2021-02-05 07:37:52.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:38:22.9: SelectRunning: No running plans
2021-02-05 07:38:22.9: No pending plans that can be started now.
2021-02-05 07:38:22.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:38:53.9: SelectRunning: No running plans
2021-02-05 07:38:53.9: No pending plans that can be started now.
2021-02-05 07:38:53.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:39:24.5: SelectRunning: No running plans
2021-02-05 07:39:24.5: No pending plans that can be started now.
2021-02-05 07:39:24.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:39:55.1: SelectRunning: No running plans
2021-02-05 07:39:55.1: No pending plans that can be started now.
2021-02-05 07:39:55.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:40:26.0: SelectRunning: No running plans
2021-02-05 07:40:26.0: No pending plans that can be started now.
2021-02-05 07:40:26.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:40:56.6: SelectRunning: No running plans
2021-02-05 07:40:56.6: No pending plans that can be started now.
2021-02-05 07:40:56.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:41:27.2: SelectRunning: No running plans
2021-02-05 07:41:27.2: No pending plans that can be started now.
2021-02-05 07:41:27.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:41:58.2: SelectRunning: No running plans
2021-02-05 07:41:58.2: No pending plans that can be started now.
2021-02-05 07:41:58.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:42:28.7: SelectRunning: No running plans
2021-02-05 07:42:28.7: No pending plans that can be started now.
2021-02-05 07:42:28.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:42:59.3: SelectRunning: No running plans
2021-02-05 07:42:59.3: No pending plans that can be started now.
2021-02-05 07:42:59.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:43:30.3: SelectRunning: No running plans
2021-02-05 07:43:30.3: No pending plans that can be started now.
2021-02-05 07:43:30.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:44:00.9: SelectRunning: No running plans
2021-02-05 07:44:00.9: No pending plans that can be started now.
2021-02-05 07:44:00.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:44:31.5: SelectRunning: No running plans
2021-02-05 07:44:31.5: No pending plans that can be started now.
2021-02-05 07:44:31.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:45:02.4: SelectRunning: No running plans
2021-02-05 07:45:02.4: Efficiency: Only one pending plan 3C_279, it is the "best"
2021-02-05 07:45:02.5: Dispatcher cycle time: 0.1 sec.
2021-02-05 07:45:02.5: Acquire data for Observation 3C_279...
2021-02-05 07:45:02.5:   (belongs to Project AAVSO_MISC_OAR_AUTO_ver1895, Plan 3C_279)
2021-02-05 07:45:02.5: Send Observation 3C_279 to ACP Sequencer
2021-02-05 07:45:02.5: ACP.RunScript(AcquireScheduler, ):
2021-02-05 07:45:02.5:   Script AutoFocusScheduler is loaded, and
2021-02-05 07:45:02.5:   the console is idle.
2021-02-05 07:45:02.5:   In start loop, i = 0
2021-02-05 07:45:02.5:   Console is now idle
2021-02-05 07:45:02.6:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 07:45:02.6:   Script started successfully
2021-02-05 07:45:12.6: Sequencer is now active
2021-02-05 07:47:13.0: Sequencer is no longer active
2021-02-05 07:47:13.0: Post-job status check done (stat=Failed)
2021-02-05 07:47:13.0: ACP data acquisition failed for Observation 3C_279.
2021-02-05 07:47:13.0:   (Observation 3C_279 interrupted by acquisition process failure.)
2021-02-05 07:47:13.2: SelectRunning: No running plans
2021-02-05 07:47:13.2: No pending plans that can be started now.
2021-02-05 07:47:13.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:47:43.8: SelectRunning: No running plans
2021-02-05 07:47:43.8: No pending plans that can be started now.
2021-02-05 07:47:43.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:48:14.7: SelectRunning: No running plans
2021-02-05 07:48:14.7: No pending plans that can be started now.
2021-02-05 07:48:14.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:48:45.3: SelectRunning: No running plans
2021-02-05 07:48:45.3: No pending plans that can be started now.
2021-02-05 07:48:45.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:49:15.9: SelectRunning: No running plans
2021-02-05 07:49:15.9: No pending plans that can be started now.
2021-02-05 07:49:15.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:49:46.9: SelectRunning: No running plans
2021-02-05 07:49:46.9: No pending plans that can be started now.
2021-02-05 07:49:46.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:50:17.5: SelectRunning: No running plans
2021-02-05 07:50:17.5: No pending plans that can be started now.
2021-02-05 07:50:17.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:50:48.1: SelectRunning: No running plans
2021-02-05 07:50:48.1: No pending plans that can be started now.
2021-02-05 07:50:48.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:51:19.0: SelectRunning: No running plans
2021-02-05 07:51:19.0: No pending plans that can be started now.
2021-02-05 07:51:19.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:51:49.6: SelectRunning: No running plans
2021-02-05 07:51:49.6: No pending plans that can be started now.
2021-02-05 07:51:49.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:52:20.2: SelectRunning: No running plans
2021-02-05 07:52:20.2: No pending plans that can be started now.
2021-02-05 07:52:20.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:52:51.2: SelectRunning: No running plans
2021-02-05 07:52:51.2: No pending plans that can be started now.
2021-02-05 07:52:51.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:53:21.8: SelectRunning: No running plans
2021-02-05 07:53:21.8: No pending plans that can be started now.
2021-02-05 07:53:21.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:53:52.4: SelectRunning: No running plans
2021-02-05 07:53:52.4: No pending plans that can be started now.
2021-02-05 07:53:52.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:54:23.3: SelectRunning: No running plans
2021-02-05 07:54:23.3: No pending plans that can be started now.
2021-02-05 07:54:23.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:54:53.9: SelectRunning: No running plans
2021-02-05 07:54:53.9: No pending plans that can be started now.
2021-02-05 07:54:53.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:55:24.5: SelectRunning: No running plans
2021-02-05 07:55:24.5: No pending plans that can be started now.
2021-02-05 07:55:24.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:55:55.4: SelectRunning: No running plans
2021-02-05 07:55:55.4: No pending plans that can be started now.
2021-02-05 07:55:55.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:56:26.0: SelectRunning: No running plans
2021-02-05 07:56:26.0: No pending plans that can be started now.
2021-02-05 07:56:26.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:56:56.6: SelectRunning: No running plans
2021-02-05 07:56:56.6: No pending plans that can be started now.
2021-02-05 07:56:56.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 07:57:27.2: SelectRunning: No running plans
2021-02-05 07:57:27.2: Efficiency: Only one pending plan PG_1424+240, it is the "best"
2021-02-05 07:57:27.3: Dispatcher cycle time: 0.1 sec.
2021-02-05 07:57:27.3: Acquire data for Observation PG_1424+240...
2021-02-05 07:57:27.3:   (belongs to Project AAVSO_MISC_OAR_AUTO_ver1895, Plan PG_1424+240)
2021-02-05 07:57:27.7: Send Observation PG_1424+240 to ACP Sequencer
2021-02-05 07:57:27.7: ACP.RunScript(AcquireScheduler, ):
2021-02-05 07:57:27.7:   Script AcquireScheduler is loaded, and
2021-02-05 07:57:27.7:   the console is idle.
2021-02-05 07:57:27.7:   In start loop, i = 0
2021-02-05 07:57:27.7:   Console is now idle
2021-02-05 07:57:27.7:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 07:57:27.7:   Script started successfully
2021-02-05 07:57:37.8: Sequencer is now active
2021-02-05 08:03:33.3: Sequencer is no longer active
2021-02-05 08:03:33.3: Post-job status check done (stat=Completed)
2021-02-05 08:03:33.3: Acquisition time: 365.5803904 sec.
2021-02-05 08:03:33.3: Data for Observation PG_1424+240 of Plan PG_1424+240 acquired successfully.
2021-02-05 08:03:33.3: Plan PG_1424+240 completed successfully.
2021-02-05 08:03:33.3: Image Efficiency: 49.2%
2021-02-05 08:03:33.3: Cycle Efficiency: 100.0%
2021-02-05 08:03:33.4: SelectRunning: No running plans
2021-02-05 08:03:33.4: No pending plans that can be started now.
2021-02-05 08:03:33.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:04:04.0: SelectRunning: No running plans
2021-02-05 08:04:04.0: No pending plans that can be started now.
2021-02-05 08:04:04.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:04:34.6: SelectRunning: No running plans
2021-02-05 08:04:34.6: No pending plans that can be started now.
2021-02-05 08:04:34.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:05:05.2: SelectRunning: No running plans
2021-02-05 08:05:05.2: No pending plans that can be started now.
2021-02-05 08:05:05.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:05:35.8: SelectRunning: No running plans
2021-02-05 08:05:35.8: No pending plans that can be started now.
2021-02-05 08:05:35.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:06:06.4: SelectRunning: No running plans
2021-02-05 08:06:06.4: No pending plans that can be started now.
2021-02-05 08:06:06.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:06:37.2: SelectRunning: No running plans
2021-02-05 08:06:37.2: No pending plans that can be started now.
2021-02-05 08:06:37.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:07:07.8: SelectRunning: No running plans
2021-02-05 08:07:07.8: No pending plans that can be started now.
2021-02-05 08:07:07.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:07:38.4: SelectRunning: No running plans
2021-02-05 08:07:38.4: No pending plans that can be started now.
2021-02-05 08:07:38.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:08:09.3: SelectRunning: No running plans
2021-02-05 08:08:09.3: No pending plans that can be started now.
2021-02-05 08:08:09.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:08:39.9: SelectRunning: No running plans
2021-02-05 08:08:39.9: No pending plans that can be started now.
2021-02-05 08:08:39.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:09:10.5: SelectRunning: No running plans
2021-02-05 08:09:10.5: No pending plans that can be started now.
2021-02-05 08:09:10.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:09:41.5: SelectRunning: No running plans
2021-02-05 08:09:41.5: No pending plans that can be started now.
2021-02-05 08:09:41.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:10:12.0: SelectRunning: No running plans
2021-02-05 08:10:12.0: No pending plans that can be started now.
2021-02-05 08:10:12.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:10:42.6: SelectRunning: No running plans
2021-02-05 08:10:42.6: No pending plans that can be started now.
2021-02-05 08:10:42.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:11:13.6: SelectRunning: No running plans
2021-02-05 08:11:13.6: No pending plans that can be started now.
2021-02-05 08:11:13.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:11:44.2: SelectRunning: No running plans
2021-02-05 08:11:44.2: No pending plans that can be started now.
2021-02-05 08:11:44.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:12:14.8: SelectRunning: No running plans
2021-02-05 08:12:14.8: No pending plans that can be started now.
2021-02-05 08:12:14.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:12:45.7: SelectRunning: No running plans
2021-02-05 08:12:45.7: No pending plans that can be started now.
2021-02-05 08:12:45.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:13:16.3: SelectRunning: No running plans
2021-02-05 08:13:16.3: No pending plans that can be started now.
2021-02-05 08:13:16.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:13:46.9: SelectRunning: No running plans
2021-02-05 08:13:46.9: No pending plans that can be started now.
2021-02-05 08:13:46.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:14:17.9: SelectRunning: No running plans
2021-02-05 08:14:17.9: No pending plans that can be started now.
2021-02-05 08:14:17.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:14:48.5: SelectRunning: No running plans
2021-02-05 08:14:48.5: No pending plans that can be started now.
2021-02-05 08:14:48.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:15:19.1: SelectRunning: No running plans
2021-02-05 08:15:19.1: No pending plans that can be started now.
2021-02-05 08:15:19.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:15:50.0: SelectRunning: No running plans
2021-02-05 08:15:50.0: No pending plans that can be started now.
2021-02-05 08:15:50.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:16:20.6: SelectRunning: No running plans
2021-02-05 08:16:20.6: No pending plans that can be started now.
2021-02-05 08:16:20.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:16:51.2: SelectRunning: No running plans
2021-02-05 08:16:51.2: No pending plans that can be started now.
2021-02-05 08:16:51.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:17:22.1: SelectRunning: No running plans
2021-02-05 08:17:22.2: No pending plans that can be started now.
2021-02-05 08:17:22.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:17:52.8: SelectRunning: No running plans
2021-02-05 08:17:52.8: No pending plans that can be started now.
2021-02-05 08:17:52.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:18:23.4: SelectRunning: No running plans
2021-02-05 08:18:23.4: No pending plans that can be started now.
2021-02-05 08:18:23.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:18:54.3: SelectRunning: No running plans
2021-02-05 08:18:54.3: No pending plans that can be started now.
2021-02-05 08:18:54.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:19:24.9: SelectRunning: No running plans
2021-02-05 08:19:24.9: No pending plans that can be started now.
2021-02-05 08:19:24.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:19:55.5: SelectRunning: No running plans
2021-02-05 08:19:55.5: No pending plans that can be started now.
2021-02-05 08:19:55.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:20:26.5: SelectRunning: No running plans
2021-02-05 08:20:26.5: No pending plans that can be started now.
2021-02-05 08:20:26.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:20:57.1: SelectRunning: No running plans
2021-02-05 08:20:57.1: No pending plans that can be started now.
2021-02-05 08:20:57.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:21:27.7: SelectRunning: No running plans
2021-02-05 08:21:27.7: No pending plans that can be started now.
2021-02-05 08:21:27.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:21:58.6: SelectRunning: No running plans
2021-02-05 08:21:58.6: No pending plans that can be started now.
2021-02-05 08:21:58.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:22:29.2: SelectRunning: No running plans
2021-02-05 08:22:29.2: No pending plans that can be started now.
2021-02-05 08:22:29.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:22:59.8: SelectRunning: No running plans
2021-02-05 08:22:59.8: No pending plans that can be started now.
2021-02-05 08:22:59.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:23:30.8: SelectRunning: No running plans
2021-02-05 08:23:30.8: No pending plans that can be started now.
2021-02-05 08:23:30.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:24:01.3: SelectRunning: No running plans
2021-02-05 08:24:01.3: No pending plans that can be started now.
2021-02-05 08:24:01.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:24:32.0: SelectRunning: No running plans
2021-02-05 08:24:32.0: No pending plans that can be started now.
2021-02-05 08:24:32.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:25:02.9: SelectRunning: No running plans
2021-02-05 08:25:02.9: No pending plans that can be started now.
2021-02-05 08:25:02.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:25:33.5: SelectRunning: No running plans
2021-02-05 08:25:33.5: No pending plans that can be started now.
2021-02-05 08:25:33.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:26:04.1: SelectRunning: No running plans
2021-02-05 08:26:04.1: No pending plans that can be started now.
2021-02-05 08:26:04.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:26:35.1: SelectRunning: No running plans
2021-02-05 08:26:35.1: No pending plans that can be started now.
2021-02-05 08:26:35.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:27:05.7: ++ Auto Focus ++
2021-02-05 08:27:05.7: Doing periodic autofocus.
2021-02-05 08:27:05.7: Start special ACP AutoFocus script for scheduler
2021-02-05 08:27:05.7: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 08:27:05.7:   Script AcquireScheduler is loaded, and
2021-02-05 08:27:05.7:   the console is idle.
2021-02-05 08:27:05.7:   In start loop, i = 0
2021-02-05 08:27:05.7:   Console is now idle
2021-02-05 08:27:05.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 08:27:05.8:   Script started successfully
2021-02-05 08:27:15.8: Sequencer is now active
2021-02-05 08:31:52.7: Sequencer is no longer active
2021-02-05 08:31:52.7: Next periodic autofocus ASAP after 3600sec. 05-Feb-2021 09:31:34 UTC
2021-02-05 08:31:52.7: SelectRunning: No running plans
2021-02-05 08:31:52.7: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 08:31:52.7:  (deferred for 55 min, until 05-Feb-2021 09:26:52 UTC
2021-02-05 08:31:52.7: No pending plans that can be started now.
2021-02-05 08:31:52.7: Dispatcher cycle time: 0.1 sec.
2021-02-05 08:32:23.3: SelectRunning: No running plans
2021-02-05 08:32:23.3: No pending plans that can be started now.
2021-02-05 08:32:23.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:32:53.9: SelectRunning: No running plans
2021-02-05 08:32:53.9: No pending plans that can be started now.
2021-02-05 08:32:53.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:33:24.5: SelectRunning: No running plans
2021-02-05 08:33:24.5: No pending plans that can be started now.
2021-02-05 08:33:24.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:33:55.1: SelectRunning: No running plans
2021-02-05 08:33:55.1: No pending plans that can be started now.
2021-02-05 08:33:55.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:34:25.9: SelectRunning: No running plans
2021-02-05 08:34:25.9: No pending plans that can be started now.
2021-02-05 08:34:25.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:34:56.5: SelectRunning: No running plans
2021-02-05 08:34:56.5: No pending plans that can be started now.
2021-02-05 08:34:56.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:35:27.1: SelectRunning: No running plans
2021-02-05 08:35:27.1: No pending plans that can be started now.
2021-02-05 08:35:27.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:35:58.1: SelectRunning: No running plans
2021-02-05 08:35:58.1: No pending plans that can be started now.
2021-02-05 08:35:58.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:36:28.6: SelectRunning: No running plans
2021-02-05 08:36:28.6: No pending plans that can be started now.
2021-02-05 08:36:28.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:36:59.2: SelectRunning: No running plans
2021-02-05 08:36:59.2: No pending plans that can be started now.
2021-02-05 08:36:59.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:37:30.2: SelectRunning: No running plans
2021-02-05 08:37:30.2: No pending plans that can be started now.
2021-02-05 08:37:30.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:38:00.8: SelectRunning: No running plans
2021-02-05 08:38:00.8: No pending plans that can be started now.
2021-02-05 08:38:00.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:38:31.4: SelectRunning: No running plans
2021-02-05 08:38:31.4: No pending plans that can be started now.
2021-02-05 08:38:31.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:39:02.3: SelectRunning: No running plans
2021-02-05 08:39:02.3: No pending plans that can be started now.
2021-02-05 08:39:02.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:39:32.9: SelectRunning: No running plans
2021-02-05 08:39:32.9: No pending plans that can be started now.
2021-02-05 08:39:32.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:40:03.5: SelectRunning: No running plans
2021-02-05 08:40:03.5: No pending plans that can be started now.
2021-02-05 08:40:03.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:40:34.5: SelectRunning: No running plans
2021-02-05 08:40:34.5: No pending plans that can be started now.
2021-02-05 08:40:34.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:41:05.1: SelectRunning: No running plans
2021-02-05 08:41:05.1: No pending plans that can be started now.
2021-02-05 08:41:05.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:41:35.7: SelectRunning: No running plans
2021-02-05 08:41:35.7: No pending plans that can be started now.
2021-02-05 08:41:35.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:42:06.6: SelectRunning: No running plans
2021-02-05 08:42:06.6: No pending plans that can be started now.
2021-02-05 08:42:06.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:42:37.2: SelectRunning: No running plans
2021-02-05 08:42:37.2: No pending plans that can be started now.
2021-02-05 08:42:37.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:43:07.8: SelectRunning: No running plans
2021-02-05 08:43:07.8: No pending plans that can be started now.
2021-02-05 08:43:07.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:43:38.8: SelectRunning: No running plans
2021-02-05 08:43:38.8: No pending plans that can be started now.
2021-02-05 08:43:38.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:44:09.4: SelectRunning: No running plans
2021-02-05 08:44:09.4: No pending plans that can be started now.
2021-02-05 08:44:09.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:44:40.0: SelectRunning: No running plans
2021-02-05 08:44:40.0: No pending plans that can be started now.
2021-02-05 08:44:40.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:45:10.9: SelectRunning: No running plans
2021-02-05 08:45:10.9: No pending plans that can be started now.
2021-02-05 08:45:10.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:45:41.5: SelectRunning: No running plans
2021-02-05 08:45:41.5: No pending plans that can be started now.
2021-02-05 08:45:41.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:46:12.1: SelectRunning: No running plans
2021-02-05 08:46:12.1: No pending plans that can be started now.
2021-02-05 08:46:12.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:46:43.0: SelectRunning: No running plans
2021-02-05 08:46:43.0: No pending plans that can be started now.
2021-02-05 08:46:43.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:47:13.6: SelectRunning: No running plans
2021-02-05 08:47:13.6: No pending plans that can be started now.
2021-02-05 08:47:13.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:47:44.2: SelectRunning: No running plans
2021-02-05 08:47:44.2: No pending plans that can be started now.
2021-02-05 08:47:44.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:48:15.2: SelectRunning: No running plans
2021-02-05 08:48:15.2: No pending plans that can be started now.
2021-02-05 08:48:15.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:48:45.8: SelectRunning: No running plans
2021-02-05 08:48:45.8: No pending plans that can be started now.
2021-02-05 08:48:45.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:49:16.4: SelectRunning: No running plans
2021-02-05 08:49:16.4: No pending plans that can be started now.
2021-02-05 08:49:16.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:49:47.3: SelectRunning: No running plans
2021-02-05 08:49:47.3: No pending plans that can be started now.
2021-02-05 08:49:47.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:50:17.9: SelectRunning: No running plans
2021-02-05 08:50:17.9: No pending plans that can be started now.
2021-02-05 08:50:17.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:50:48.5: SelectRunning: No running plans
2021-02-05 08:50:48.5: No pending plans that can be started now.
2021-02-05 08:50:48.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:51:19.5: SelectRunning: No running plans
2021-02-05 08:51:19.5: No pending plans that can be started now.
2021-02-05 08:51:19.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:51:50.1: SelectRunning: No running plans
2021-02-05 08:51:50.1: No pending plans that can be started now.
2021-02-05 08:51:50.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:52:20.7: SelectRunning: No running plans
2021-02-05 08:52:20.7: No pending plans that can be started now.
2021-02-05 08:52:20.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:52:51.6: SelectRunning: No running plans
2021-02-05 08:52:51.6: No pending plans that can be started now.
2021-02-05 08:52:51.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:53:22.2: SelectRunning: No running plans
2021-02-05 08:53:22.2: No pending plans that can be started now.
2021-02-05 08:53:22.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:53:52.8: SelectRunning: No running plans
2021-02-05 08:53:52.8: No pending plans that can be started now.
2021-02-05 08:53:52.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:54:23.8: SelectRunning: No running plans
2021-02-05 08:54:23.8: No pending plans that can be started now.
2021-02-05 08:54:23.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:54:54.4: SelectRunning: No running plans
2021-02-05 08:54:54.4: No pending plans that can be started now.
2021-02-05 08:54:54.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:55:24.9: SelectRunning: No running plans
2021-02-05 08:55:24.9: No pending plans that can be started now.
2021-02-05 08:55:24.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:55:55.9: SelectRunning: No running plans
2021-02-05 08:55:55.9: No pending plans that can be started now.
2021-02-05 08:55:55.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:56:26.5: SelectRunning: No running plans
2021-02-05 08:56:26.5: No pending plans that can be started now.
2021-02-05 08:56:26.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:56:57.1: SelectRunning: No running plans
2021-02-05 08:56:57.1: No pending plans that can be started now.
2021-02-05 08:56:57.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:57:28.0: SelectRunning: No running plans
2021-02-05 08:57:28.0: No pending plans that can be started now.
2021-02-05 08:57:28.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:57:58.6: SelectRunning: No running plans
2021-02-05 08:57:58.6: No pending plans that can be started now.
2021-02-05 08:57:58.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:58:29.3: SelectRunning: No running plans
2021-02-05 08:58:29.3: No pending plans that can be started now.
2021-02-05 08:58:29.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:59:00.2: SelectRunning: No running plans
2021-02-05 08:59:00.2: No pending plans that can be started now.
2021-02-05 08:59:00.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 08:59:30.8: SelectRunning: No running plans
2021-02-05 08:59:30.8: No pending plans that can be started now.
2021-02-05 08:59:30.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:00:01.4: SelectRunning: No running plans
2021-02-05 09:00:01.4: No pending plans that can be started now.
2021-02-05 09:00:01.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:00:32.3: SelectRunning: No running plans
2021-02-05 09:00:32.3: No pending plans that can be started now.
2021-02-05 09:00:32.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:01:03.0: SelectRunning: No running plans
2021-02-05 09:01:03.0: No pending plans that can be started now.
2021-02-05 09:01:03.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:01:33.5: SelectRunning: No running plans
2021-02-05 09:01:33.5: No pending plans that can be started now.
2021-02-05 09:01:33.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:02:04.5: SelectRunning: No running plans
2021-02-05 09:02:04.5: No pending plans that can be started now.
2021-02-05 09:02:04.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:02:35.1: SelectRunning: No running plans
2021-02-05 09:02:35.1: No pending plans that can be started now.
2021-02-05 09:02:35.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:03:05.7: SelectRunning: No running plans
2021-02-05 09:03:05.7: No pending plans that can be started now.
2021-02-05 09:03:05.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:03:36.7: SelectRunning: No running plans
2021-02-05 09:03:36.7: No pending plans that can be started now.
2021-02-05 09:03:36.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:04:07.3: SelectRunning: No running plans
2021-02-05 09:04:07.3: No pending plans that can be started now.
2021-02-05 09:04:07.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:04:37.9: SelectRunning: No running plans
2021-02-05 09:04:37.9: No pending plans that can be started now.
2021-02-05 09:04:37.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:05:08.8: SelectRunning: No running plans
2021-02-05 09:05:08.8: [AirmassRange] Target will never be below the maximum air mass
2021-02-05 09:05:08.8: Obs Romanov_V20 in Plan Romanov_V20 was failed by AirmassRange constraint.
2021-02-05 09:05:08.8: No pending plans that can be started now.
2021-02-05 09:05:08.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:05:39.4: SelectRunning: No running plans
2021-02-05 09:05:39.4: No pending plans that can be started now.
2021-02-05 09:05:39.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:06:10.0: SelectRunning: No running plans
2021-02-05 09:06:10.0: No pending plans that can be started now.
2021-02-05 09:06:10.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:06:40.9: SelectRunning: No running plans
2021-02-05 09:06:40.9: No pending plans that can be started now.
2021-02-05 09:06:40.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:07:11.5: SelectRunning: No running plans
2021-02-05 09:07:11.5: No pending plans that can be started now.
2021-02-05 09:07:11.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:07:42.1: SelectRunning: No running plans
2021-02-05 09:07:42.1: No pending plans that can be started now.
2021-02-05 09:07:42.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:08:13.1: SelectRunning: No running plans
2021-02-05 09:08:13.1: No pending plans that can be started now.
2021-02-05 09:08:13.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:08:43.7: SelectRunning: No running plans
2021-02-05 09:08:43.7: No pending plans that can be started now.
2021-02-05 09:08:43.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:09:14.3: SelectRunning: No running plans
2021-02-05 09:09:14.3: No pending plans that can be started now.
2021-02-05 09:09:14.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:09:45.2: SelectRunning: No running plans
2021-02-05 09:09:45.2: No pending plans that can be started now.
2021-02-05 09:09:45.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:10:15.8: SelectRunning: No running plans
2021-02-05 09:10:15.8: No pending plans that can be started now.
2021-02-05 09:10:15.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:10:46.4: SelectRunning: No running plans
2021-02-05 09:10:46.4: No pending plans that can be started now.
2021-02-05 09:10:46.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:11:17.4: SelectRunning: No running plans
2021-02-05 09:11:17.4: No pending plans that can be started now.
2021-02-05 09:11:17.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:11:48.0: SelectRunning: No running plans
2021-02-05 09:11:48.0: No pending plans that can be started now.
2021-02-05 09:11:48.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:12:18.6: SelectRunning: No running plans
2021-02-05 09:12:18.6: No pending plans that can be started now.
2021-02-05 09:12:18.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:12:49.5: SelectRunning: No running plans
2021-02-05 09:12:49.5: No pending plans that can be started now.
2021-02-05 09:12:49.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:13:20.1: SelectRunning: No running plans
2021-02-05 09:13:20.1: No pending plans that can be started now.
2021-02-05 09:13:20.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:13:50.7: SelectRunning: No running plans
2021-02-05 09:13:50.7: No pending plans that can be started now.
2021-02-05 09:13:50.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:14:21.6: SelectRunning: No running plans
2021-02-05 09:14:21.6: No pending plans that can be started now.
2021-02-05 09:14:21.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:14:52.2: SelectRunning: No running plans
2021-02-05 09:14:52.2: No pending plans that can be started now.
2021-02-05 09:14:52.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:15:22.8: SelectRunning: No running plans
2021-02-05 09:15:22.8: No pending plans that can be started now.
2021-02-05 09:15:22.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:15:53.8: SelectRunning: No running plans
2021-02-05 09:15:53.8: No pending plans that can be started now.
2021-02-05 09:15:53.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:16:24.4: SelectRunning: No running plans
2021-02-05 09:16:24.4: No pending plans that can be started now.
2021-02-05 09:16:24.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:16:54.9: SelectRunning: No running plans
2021-02-05 09:16:55.0: No pending plans that can be started now.
2021-02-05 09:16:55.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:17:25.9: SelectRunning: No running plans
2021-02-05 09:17:25.9: No pending plans that can be started now.
2021-02-05 09:17:25.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:17:56.5: SelectRunning: No running plans
2021-02-05 09:17:56.5: No pending plans that can be started now.
2021-02-05 09:17:56.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:18:27.1: SelectRunning: No running plans
2021-02-05 09:18:27.1: No pending plans that can be started now.
2021-02-05 09:18:27.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:18:58.0: SelectRunning: No running plans
2021-02-05 09:18:58.0: No pending plans that can be started now.
2021-02-05 09:18:58.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:19:28.6: SelectRunning: No running plans
2021-02-05 09:19:28.6: No pending plans that can be started now.
2021-02-05 09:19:28.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:19:59.2: SelectRunning: No running plans
2021-02-05 09:19:59.2: No pending plans that can be started now.
2021-02-05 09:19:59.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:20:30.1: SelectRunning: No running plans
2021-02-05 09:20:30.1: No pending plans that can be started now.
2021-02-05 09:20:30.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:21:00.7: SelectRunning: No running plans
2021-02-05 09:21:00.7: No pending plans that can be started now.
2021-02-05 09:21:00.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:21:31.4: SelectRunning: No running plans
2021-02-05 09:21:31.4: No pending plans that can be started now.
2021-02-05 09:21:31.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:22:02.3: SelectRunning: No running plans
2021-02-05 09:22:02.3: No pending plans that can be started now.
2021-02-05 09:22:02.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:22:32.9: SelectRunning: No running plans
2021-02-05 09:22:32.9: No pending plans that can be started now.
2021-02-05 09:22:32.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:23:03.5: SelectRunning: No running plans
2021-02-05 09:23:03.5: No pending plans that can be started now.
2021-02-05 09:23:03.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:23:34.4: SelectRunning: No running plans
2021-02-05 09:23:34.4: No pending plans that can be started now.
2021-02-05 09:23:34.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:24:05.0: SelectRunning: No running plans
2021-02-05 09:24:05.0: No pending plans that can be started now.
2021-02-05 09:24:05.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:24:35.6: SelectRunning: No running plans
2021-02-05 09:24:35.6: No pending plans that can be started now.
2021-02-05 09:24:35.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:25:06.6: SelectRunning: No running plans
2021-02-05 09:25:06.6: No pending plans that can be started now.
2021-02-05 09:25:06.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:25:37.2: SelectRunning: No running plans
2021-02-05 09:25:37.2: No pending plans that can be started now.
2021-02-05 09:25:37.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:26:07.8: SelectRunning: No running plans
2021-02-05 09:26:07.8: No pending plans that can be started now.
2021-02-05 09:26:07.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:26:38.7: SelectRunning: No running plans
2021-02-05 09:26:38.7: No pending plans that can be started now.
2021-02-05 09:26:38.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:27:09.3: SelectRunning: No running plans
2021-02-05 09:27:09.3: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 09:27:09.3:  (deferred for 57 min, until 05-Feb-2021 10:24:09 UTC
2021-02-05 09:27:09.3: No pending plans that can be started now.
2021-02-05 09:27:09.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:27:39.9: SelectRunning: No running plans
2021-02-05 09:27:39.9: No pending plans that can be started now.
2021-02-05 09:27:39.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:28:10.9: SelectRunning: No running plans
2021-02-05 09:28:10.9: No pending plans that can be started now.
2021-02-05 09:28:10.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:28:41.5: SelectRunning: No running plans
2021-02-05 09:28:41.5: No pending plans that can be started now.
2021-02-05 09:28:41.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:29:12.1: SelectRunning: No running plans
2021-02-05 09:29:12.1: No pending plans that can be started now.
2021-02-05 09:29:12.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:29:43.0: SelectRunning: No running plans
2021-02-05 09:29:43.0: No pending plans that can be started now.
2021-02-05 09:29:43.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:30:13.6: SelectRunning: No running plans
2021-02-05 09:30:13.6: No pending plans that can be started now.
2021-02-05 09:30:13.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:30:44.2: SelectRunning: No running plans
2021-02-05 09:30:44.2: No pending plans that can be started now.
2021-02-05 09:30:44.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:31:15.2: SelectRunning: No running plans
2021-02-05 09:31:15.2: No pending plans that can be started now.
2021-02-05 09:31:15.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:31:45.7: ++ Auto Focus ++
2021-02-05 09:31:45.8: Doing periodic autofocus.
2021-02-05 09:31:45.8: Start special ACP AutoFocus script for scheduler
2021-02-05 09:31:45.8: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 09:31:45.8:   Script AutoFocusScheduler is loaded, and
2021-02-05 09:31:45.8:   the console is idle.
2021-02-05 09:31:45.8:   In start loop, i = 0
2021-02-05 09:31:45.8:   Console is now idle
2021-02-05 09:31:45.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 09:31:45.8:   Script started successfully
2021-02-05 09:31:55.8: Sequencer is now active
2021-02-05 09:33:40.8: Sequencer is no longer active
2021-02-05 09:33:40.8: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2021-02-05 09:33:40.9: SelectRunning: No running plans
2021-02-05 09:33:40.9: No pending plans that can be started now.
2021-02-05 09:33:40.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:34:11.5: ++ Auto Focus ++
2021-02-05 09:34:11.5: Doing periodic autofocus.
2021-02-05 09:34:11.5: Start special ACP AutoFocus script for scheduler
2021-02-05 09:34:11.5: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 09:34:11.5:   Script AutoFocusScheduler is loaded, and
2021-02-05 09:34:11.5:   the console is idle.
2021-02-05 09:34:11.5:   In start loop, i = 0
2021-02-05 09:34:11.5:   Console is now idle
2021-02-05 09:34:11.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 09:34:11.5:   Script started successfully
2021-02-05 09:34:21.5: Sequencer is now active
2021-02-05 09:36:06.4: Sequencer is no longer active
2021-02-05 09:36:06.4: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2021-02-05 09:36:06.5: SelectRunning: No running plans
2021-02-05 09:36:06.5: No pending plans that can be started now.
2021-02-05 09:36:06.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:36:37.0: SelectRunning: No running plans
2021-02-05 09:36:37.1: No pending plans that can be started now.
2021-02-05 09:36:37.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:37:07.7: SelectRunning: No running plans
2021-02-05 09:37:07.7: No pending plans that can be started now.
2021-02-05 09:37:07.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:37:38.6: SelectRunning: No running plans
2021-02-05 09:37:38.6: No pending plans that can be started now.
2021-02-05 09:37:38.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:38:09.2: SelectRunning: No running plans
2021-02-05 09:38:09.2: No pending plans that can be started now.
2021-02-05 09:38:09.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:38:39.8: SelectRunning: No running plans
2021-02-05 09:38:39.8: No pending plans that can be started now.
2021-02-05 09:38:39.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:39:10.7: SelectRunning: No running plans
2021-02-05 09:39:10.7: No pending plans that can be started now.
2021-02-05 09:39:10.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:39:41.3: SelectRunning: No running plans
2021-02-05 09:39:41.3: No pending plans that can be started now.
2021-02-05 09:39:41.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:40:11.9: SelectRunning: No running plans
2021-02-05 09:40:11.9: No pending plans that can be started now.
2021-02-05 09:40:11.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:40:42.9: SelectRunning: No running plans
2021-02-05 09:40:42.9: No pending plans that can be started now.
2021-02-05 09:40:42.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:41:13.5: ++ Auto Focus ++
2021-02-05 09:41:13.5: Doing periodic autofocus.
2021-02-05 09:41:13.5: Start special ACP AutoFocus script for scheduler
2021-02-05 09:41:13.5: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 09:41:13.5:   Script AutoFocusScheduler is loaded, and
2021-02-05 09:41:13.5:   the console is idle.
2021-02-05 09:41:13.5:   In start loop, i = 0
2021-02-05 09:41:13.5:   Console is now idle
2021-02-05 09:41:13.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 09:41:13.5:   Script started successfully
2021-02-05 09:41:23.5: Sequencer is now active
2021-02-05 09:43:03.4: Sequencer is no longer active
2021-02-05 09:43:03.4: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2021-02-05 09:43:03.5: SelectRunning: No running plans
2021-02-05 09:43:03.5: No pending plans that can be started now.
2021-02-05 09:43:03.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:43:34.0: SelectRunning: No running plans
2021-02-05 09:43:34.0: No pending plans that can be started now.
2021-02-05 09:43:34.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:44:04.6: SelectRunning: No running plans
2021-02-05 09:44:04.6: No pending plans that can be started now.
2021-02-05 09:44:04.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:44:35.2: SelectRunning: No running plans
2021-02-05 09:44:35.2: No pending plans that can be started now.
2021-02-05 09:44:35.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:45:05.8: SelectRunning: No running plans
2021-02-05 09:45:05.8: No pending plans that can be started now.
2021-02-05 09:45:05.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:45:36.4: SelectRunning: No running plans
2021-02-05 09:45:36.4: No pending plans that can be started now.
2021-02-05 09:45:36.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:46:07.0: SelectRunning: No running plans
2021-02-05 09:46:07.0: No pending plans that can be started now.
2021-02-05 09:46:07.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:46:37.6: SelectRunning: No running plans
2021-02-05 09:46:37.6: No pending plans that can be started now.
2021-02-05 09:46:37.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:47:08.6: SelectRunning: No running plans
2021-02-05 09:47:08.6: No pending plans that can be started now.
2021-02-05 09:47:08.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:47:39.2: SelectRunning: No running plans
2021-02-05 09:47:39.2: No pending plans that can be started now.
2021-02-05 09:47:39.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:48:09.8: SelectRunning: No running plans
2021-02-05 09:48:09.8: No pending plans that can be started now.
2021-02-05 09:48:09.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:48:40.7: SelectRunning: No running plans
2021-02-05 09:48:40.7: No pending plans that can be started now.
2021-02-05 09:48:40.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:49:11.3: SelectRunning: No running plans
2021-02-05 09:49:11.3: No pending plans that can be started now.
2021-02-05 09:49:11.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:49:41.9: SelectRunning: No running plans
2021-02-05 09:49:41.9: No pending plans that can be started now.
2021-02-05 09:49:41.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:50:12.8: SelectRunning: No running plans
2021-02-05 09:50:12.8: No pending plans that can be started now.
2021-02-05 09:50:12.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:50:43.4: SelectRunning: No running plans
2021-02-05 09:50:43.4: No pending plans that can be started now.
2021-02-05 09:50:43.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:51:14.0: SelectRunning: No running plans
2021-02-05 09:51:14.0: No pending plans that can be started now.
2021-02-05 09:51:14.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:51:45.0: SelectRunning: No running plans
2021-02-05 09:51:45.0: No pending plans that can be started now.
2021-02-05 09:51:45.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:52:15.6: SelectRunning: No running plans
2021-02-05 09:52:15.6: No pending plans that can be started now.
2021-02-05 09:52:15.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:52:46.2: SelectRunning: No running plans
2021-02-05 09:52:46.2: No pending plans that can be started now.
2021-02-05 09:52:46.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 09:53:17.1: ++ Auto Focus ++
2021-02-05 09:53:17.2: Doing periodic autofocus.
2021-02-05 09:53:17.2: Start special ACP AutoFocus script for scheduler
2021-02-05 09:53:17.2: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 09:53:17.2:   Script AutoFocusScheduler is loaded, and
2021-02-05 09:53:17.2:   the console is idle.
2021-02-05 09:53:17.2:   In start loop, i = 0
2021-02-05 09:53:17.2:   Console is now idle
2021-02-05 09:53:17.2:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 09:53:17.2:   Script started successfully
2021-02-05 09:53:27.2: Sequencer is now active
2021-02-05 09:55:12.2: Sequencer is no longer active
2021-02-05 09:55:12.2: ** Autofocus failed (n=4), will retry ASAP after 15 min.
2021-02-05 09:55:12.2: SelectRunning: No running plans
2021-02-05 09:55:12.2: Efficiency: Only one pending plan PG_1553+113, it is the "best"
2021-02-05 09:55:12.3: Dispatcher cycle time: 0.1 sec.
2021-02-05 09:55:12.3: Acquire data for Observation PG_1553+113...
2021-02-05 09:55:12.3:   (belongs to Project AAVSO_MISC_OAR_AUTO_ver1895, Plan PG_1553+113)
2021-02-05 09:55:12.3: Send Observation PG_1553+113 to ACP Sequencer
2021-02-05 09:55:12.3: ACP.RunScript(AcquireScheduler, ):
2021-02-05 09:55:12.3:   Script AutoFocusScheduler is loaded, and
2021-02-05 09:55:12.3:   the console is idle.
2021-02-05 09:55:12.3:   In start loop, i = 0
2021-02-05 09:55:12.3:   Console is now idle
2021-02-05 09:55:12.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 09:55:12.3:   Script started successfully
2021-02-05 09:55:22.3: Sequencer is now active
2021-02-05 10:05:20.4: Sequencer is no longer active
2021-02-05 10:05:20.4: Post-job status check done (stat=Completed)
2021-02-05 10:05:20.4: Acquisition time: 608.1027789 sec.
2021-02-05 10:05:20.4: Data for Observation PG_1553+113 of Plan PG_1553+113 acquired successfully.
2021-02-05 10:05:20.4: Plan PG_1553+113 completed successfully.
2021-02-05 10:05:20.4: Image Efficiency: 19.7%
2021-02-05 10:05:20.4: Cycle Efficiency: 100.0%
2021-02-05 10:05:20.6: SelectRunning: No running plans
2021-02-05 10:05:20.6: No pending plans that can be started now.
2021-02-05 10:05:20.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:05:51.2: SelectRunning: No running plans
2021-02-05 10:05:51.2: No pending plans that can be started now.
2021-02-05 10:05:51.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:06:21.8: SelectRunning: No running plans
2021-02-05 10:06:21.8: No pending plans that can be started now.
2021-02-05 10:06:21.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:06:52.4: SelectRunning: No running plans
2021-02-05 10:06:52.4: No pending plans that can be started now.
2021-02-05 10:06:52.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:07:23.1: SelectRunning: No running plans
2021-02-05 10:07:23.1: No pending plans that can be started now.
2021-02-05 10:07:23.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:07:53.7: SelectRunning: No running plans
2021-02-05 10:07:53.7: No pending plans that can be started now.
2021-02-05 10:07:53.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:08:24.3: SelectRunning: No running plans
2021-02-05 10:08:24.3: No pending plans that can be started now.
2021-02-05 10:08:24.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:08:55.2: SelectRunning: No running plans
2021-02-05 10:08:55.2: No pending plans that can be started now.
2021-02-05 10:08:55.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:09:25.8: SelectRunning: No running plans
2021-02-05 10:09:25.8: No pending plans that can be started now.
2021-02-05 10:09:25.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:09:56.4: SelectRunning: No running plans
2021-02-05 10:09:56.4: No pending plans that can be started now.
2021-02-05 10:09:56.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:10:27.3: ++ Auto Focus ++
2021-02-05 10:10:27.3: Doing periodic autofocus.
2021-02-05 10:10:27.3: Start special ACP AutoFocus script for scheduler
2021-02-05 10:10:27.3: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 10:10:27.3:   Script AcquireScheduler is loaded, and
2021-02-05 10:10:27.3:   the console is idle.
2021-02-05 10:10:27.3:   In start loop, i = 0
2021-02-05 10:10:27.3:   Console is now idle
2021-02-05 10:10:27.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 10:10:27.3:   Script started successfully
2021-02-05 10:10:37.4: Sequencer is now active
2021-02-05 10:13:29.8: Sequencer is no longer active
2021-02-05 10:13:29.8: ** Autofocus failed (n=5), will retry ASAP after 20 min.
2021-02-05 10:13:29.8: SelectRunning: No running plans
2021-02-05 10:13:29.8: No pending plans that can be started now.
2021-02-05 10:13:29.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:14:00.4: SelectRunning: No running plans
2021-02-05 10:14:00.4: Efficiency: Only one pending plan PKS_1510-089, it is the "best"
2021-02-05 10:14:00.5: Dispatcher cycle time: 0.1 sec.
2021-02-05 10:14:00.5: Acquire data for Observation PKS_1510-089...
2021-02-05 10:14:00.5:   (belongs to Project AAVSO_MISC_OAR_AUTO_ver1895, Plan PKS_1510-089)
2021-02-05 10:14:00.5: Send Observation PKS_1510-089 to ACP Sequencer
2021-02-05 10:14:00.5: ACP.RunScript(AcquireScheduler, ):
2021-02-05 10:14:00.5:   Script AutoFocusScheduler is loaded, and
2021-02-05 10:14:00.5:   the console is idle.
2021-02-05 10:14:00.5:   In start loop, i = 0
2021-02-05 10:14:00.5:   Console is now idle
2021-02-05 10:14:00.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 10:14:00.5:   Script started successfully
2021-02-05 10:14:10.5: Sequencer is now active
2021-02-05 10:16:06.5: Sequencer is no longer active
2021-02-05 10:16:06.5: Post-job status check done (stat=Failed)
2021-02-05 10:16:06.5: ACP data acquisition failed for Observation PKS_1510-089.
2021-02-05 10:16:06.5:   (Observation PKS_1510-089 interrupted by acquisition process failure.)
2021-02-05 10:16:06.7: SelectRunning: No running plans
2021-02-05 10:16:06.7: No pending plans that can be started now.
2021-02-05 10:16:06.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:16:37.3: SelectRunning: No running plans
2021-02-05 10:16:37.3: No pending plans that can be started now.
2021-02-05 10:16:37.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:17:07.9: SelectRunning: No running plans
2021-02-05 10:17:07.9: No pending plans that can be started now.
2021-02-05 10:17:07.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:17:38.5: SelectRunning: No running plans
2021-02-05 10:17:38.5: No pending plans that can be started now.
2021-02-05 10:17:38.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:18:09.1: SelectRunning: No running plans
2021-02-05 10:18:09.1: No pending plans that can be started now.
2021-02-05 10:18:09.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:18:39.7: SelectRunning: No running plans
2021-02-05 10:18:39.7: No pending plans that can be started now.
2021-02-05 10:18:39.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:19:10.3: SelectRunning: No running plans
2021-02-05 10:19:10.3: No pending plans that can be started now.
2021-02-05 10:19:10.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:19:40.9: SelectRunning: No running plans
2021-02-05 10:19:40.9: No pending plans that can be started now.
2021-02-05 10:19:40.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:20:11.5: SelectRunning: No running plans
2021-02-05 10:20:11.5: No pending plans that can be started now.
2021-02-05 10:20:11.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:20:42.1: SelectRunning: No running plans
2021-02-05 10:20:42.1: No pending plans that can be started now.
2021-02-05 10:20:42.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:21:12.7: SelectRunning: No running plans
2021-02-05 10:21:12.7: Efficiency: Only one pending plan IX_Dra, it is the "best"
2021-02-05 10:21:12.8: Dispatcher cycle time: 0.1 sec.
2021-02-05 10:21:12.8: Acquire data for Observation IX_Dra...
2021-02-05 10:21:12.8:   (belongs to Project AAVSO_P153_SFY_AUTO_ver1895, Plan IX_Dra)
2021-02-05 10:21:12.8: Send Observation IX_Dra to ACP Sequencer
2021-02-05 10:21:12.8: ACP.RunScript(AcquireScheduler, ):
2021-02-05 10:21:12.8:   Script AcquireScheduler is loaded, and
2021-02-05 10:21:12.8:   the console is idle.
2021-02-05 10:21:12.8:   In start loop, i = 0
2021-02-05 10:21:12.8:   Console is now idle
2021-02-05 10:21:12.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 10:21:12.8:   Script started successfully
2021-02-05 10:21:22.8: Sequencer is now active
2021-02-05 10:44:56.8: Sequencer is no longer active
2021-02-05 10:44:56.8: Post-job status check done (stat=Completed)
2021-02-05 10:44:56.8: Acquisition time: 1424.0104592 sec.
2021-02-05 10:44:56.8: Data for Observation IX_Dra of Plan IX_Dra acquired successfully.
2021-02-05 10:44:56.8: Plan IX_Dra completed successfully.
2021-02-05 10:44:56.8: Image Efficiency: 84.3%
2021-02-05 10:44:56.8: Cycle Efficiency: 100.0%
2021-02-05 10:44:57.0: ++ Auto Focus ++
2021-02-05 10:44:57.0: Doing periodic autofocus.
2021-02-05 10:44:57.0: Start special ACP AutoFocus script for scheduler
2021-02-05 10:44:57.0: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 10:44:57.0:   Script AcquireScheduler is loaded, and
2021-02-05 10:44:57.0:   the console is idle.
2021-02-05 10:44:57.0:   In start loop, i = 0
2021-02-05 10:44:57.0:   Console is now idle
2021-02-05 10:44:57.0:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 10:44:57.0:   Script started successfully
2021-02-05 10:45:07.0: Sequencer is now active
2021-02-05 10:49:38.0: Sequencer is no longer active
2021-02-05 10:49:38.0: Next periodic autofocus ASAP after 3600sec. 05-Feb-2021 11:49:19 UTC
2021-02-05 10:49:38.0: SelectRunning: No running plans
2021-02-05 10:49:38.0: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 10:49:38.0:  (deferred for 47 min, until 05-Feb-2021 11:36:38 UTC
2021-02-05 10:49:38.0: No pending plans that can be started now.
2021-02-05 10:49:38.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:50:08.6: SelectRunning: No running plans
2021-02-05 10:50:08.6: No pending plans that can be started now.
2021-02-05 10:50:08.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:50:39.2: SelectRunning: No running plans
2021-02-05 10:50:39.2: No pending plans that can be started now.
2021-02-05 10:50:39.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:51:09.8: SelectRunning: No running plans
2021-02-05 10:51:09.8: No pending plans that can be started now.
2021-02-05 10:51:09.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:51:40.4: SelectRunning: No running plans
2021-02-05 10:51:40.4: No pending plans that can be started now.
2021-02-05 10:51:40.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:52:11.0: SelectRunning: No running plans
2021-02-05 10:52:11.0: No pending plans that can be started now.
2021-02-05 10:52:11.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:52:41.6: SelectRunning: No running plans
2021-02-05 10:52:41.6: No pending plans that can be started now.
2021-02-05 10:52:41.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:53:12.2: SelectRunning: No running plans
2021-02-05 10:53:12.2: No pending plans that can be started now.
2021-02-05 10:53:12.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:53:42.8: SelectRunning: No running plans
2021-02-05 10:53:42.8: No pending plans that can be started now.
2021-02-05 10:53:42.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:54:13.4: SelectRunning: No running plans
2021-02-05 10:54:13.4: No pending plans that can be started now.
2021-02-05 10:54:13.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:54:44.0: SelectRunning: No running plans
2021-02-05 10:54:44.0: No pending plans that can be started now.
2021-02-05 10:54:44.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:55:14.6: SelectRunning: No running plans
2021-02-05 10:55:14.6: No pending plans that can be started now.
2021-02-05 10:55:14.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:55:45.2: SelectRunning: No running plans
2021-02-05 10:55:45.2: No pending plans that can be started now.
2021-02-05 10:55:45.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:56:16.0: SelectRunning: No running plans
2021-02-05 10:56:16.0: No pending plans that can be started now.
2021-02-05 10:56:16.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:56:46.6: SelectRunning: No running plans
2021-02-05 10:56:46.6: No pending plans that can be started now.
2021-02-05 10:56:46.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:57:17.2: SelectRunning: No running plans
2021-02-05 10:57:17.2: No pending plans that can be started now.
2021-02-05 10:57:17.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:57:48.2: SelectRunning: No running plans
2021-02-05 10:57:48.2: No pending plans that can be started now.
2021-02-05 10:57:48.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:58:18.8: SelectRunning: No running plans
2021-02-05 10:58:18.8: No pending plans that can be started now.
2021-02-05 10:58:18.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:58:49.4: SelectRunning: No running plans
2021-02-05 10:58:49.4: No pending plans that can be started now.
2021-02-05 10:58:49.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:59:20.3: SelectRunning: No running plans
2021-02-05 10:59:20.3: No pending plans that can be started now.
2021-02-05 10:59:20.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 10:59:50.9: SelectRunning: No running plans
2021-02-05 10:59:50.9: No pending plans that can be started now.
2021-02-05 10:59:50.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:00:21.5: SelectRunning: No running plans
2021-02-05 11:00:21.5: No pending plans that can be started now.
2021-02-05 11:00:21.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:00:52.5: SelectRunning: No running plans
2021-02-05 11:00:52.5: No pending plans that can be started now.
2021-02-05 11:00:52.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:01:23.1: SelectRunning: No running plans
2021-02-05 11:01:23.1: No pending plans that can be started now.
2021-02-05 11:01:23.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:01:53.7: SelectRunning: No running plans
2021-02-05 11:01:53.7: No pending plans that can be started now.
2021-02-05 11:01:53.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:02:24.6: SelectRunning: No running plans
2021-02-05 11:02:24.6: No pending plans that can be started now.
2021-02-05 11:02:24.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:02:55.2: SelectRunning: No running plans
2021-02-05 11:02:55.2: No pending plans that can be started now.
2021-02-05 11:02:55.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:03:25.8: SelectRunning: No running plans
2021-02-05 11:03:25.8: No pending plans that can be started now.
2021-02-05 11:03:25.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:03:56.4: SelectRunning: No running plans
2021-02-05 11:03:56.4: No pending plans that can be started now.
2021-02-05 11:03:56.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:04:27.0: SelectRunning: No running plans
2021-02-05 11:04:27.0: No pending plans that can be started now.
2021-02-05 11:04:27.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:04:57.6: SelectRunning: No running plans
2021-02-05 11:04:57.6: No pending plans that can be started now.
2021-02-05 11:04:57.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:05:28.2: SelectRunning: No running plans
2021-02-05 11:05:28.2: No pending plans that can be started now.
2021-02-05 11:05:28.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:05:58.8: SelectRunning: No running plans
2021-02-05 11:05:58.8: No pending plans that can be started now.
2021-02-05 11:05:58.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:06:29.4: SelectRunning: No running plans
2021-02-05 11:06:29.4: No pending plans that can be started now.
2021-02-05 11:06:29.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:07:00.0: SelectRunning: No running plans
2021-02-05 11:07:00.0: No pending plans that can be started now.
2021-02-05 11:07:00.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:07:30.6: SelectRunning: No running plans
2021-02-05 11:07:30.6: No pending plans that can be started now.
2021-02-05 11:07:30.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:08:01.2: SelectRunning: No running plans
2021-02-05 11:08:01.2: No pending plans that can be started now.
2021-02-05 11:08:01.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:08:31.8: SelectRunning: No running plans
2021-02-05 11:08:31.8: No pending plans that can be started now.
2021-02-05 11:08:31.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:09:02.4: SelectRunning: No running plans
2021-02-05 11:09:02.4: No pending plans that can be started now.
2021-02-05 11:09:02.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:09:33.0: SelectRunning: No running plans
2021-02-05 11:09:33.0: No pending plans that can be started now.
2021-02-05 11:09:33.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:10:03.6: SelectRunning: No running plans
2021-02-05 11:10:03.6: No pending plans that can be started now.
2021-02-05 11:10:03.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:10:34.2: SelectRunning: No running plans
2021-02-05 11:10:34.2: No pending plans that can be started now.
2021-02-05 11:10:34.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:11:05.1: SelectRunning: No running plans
2021-02-05 11:11:05.1: No pending plans that can be started now.
2021-02-05 11:11:05.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:11:35.7: SelectRunning: No running plans
2021-02-05 11:11:35.7: No pending plans that can be started now.
2021-02-05 11:11:35.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:12:06.3: SelectRunning: No running plans
2021-02-05 11:12:06.3: No pending plans that can be started now.
2021-02-05 11:12:06.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:12:37.3: SelectRunning: No running plans
2021-02-05 11:12:37.3: No pending plans that can be started now.
2021-02-05 11:12:37.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:13:07.9: SelectRunning: No running plans
2021-02-05 11:13:07.9: No pending plans that can be started now.
2021-02-05 11:13:07.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:13:38.5: SelectRunning: No running plans
2021-02-05 11:13:38.5: No pending plans that can be started now.
2021-02-05 11:13:38.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:14:09.4: SelectRunning: No running plans
2021-02-05 11:14:09.4: No pending plans that can be started now.
2021-02-05 11:14:09.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:14:40.0: SelectRunning: No running plans
2021-02-05 11:14:40.0: No pending plans that can be started now.
2021-02-05 11:14:40.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:15:10.6: SelectRunning: No running plans
2021-02-05 11:15:10.6: No pending plans that can be started now.
2021-02-05 11:15:10.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:15:41.5: SelectRunning: No running plans
2021-02-05 11:15:41.5: No pending plans that can be started now.
2021-02-05 11:15:41.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:16:12.1: SelectRunning: No running plans
2021-02-05 11:16:12.1: No pending plans that can be started now.
2021-02-05 11:16:12.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:16:42.7: SelectRunning: No running plans
2021-02-05 11:16:42.7: No pending plans that can be started now.
2021-02-05 11:16:42.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:17:13.7: SelectRunning: No running plans
2021-02-05 11:17:13.7: No pending plans that can be started now.
2021-02-05 11:17:13.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:17:44.3: SelectRunning: No running plans
2021-02-05 11:17:44.3: No pending plans that can be started now.
2021-02-05 11:17:44.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:18:14.9: SelectRunning: No running plans
2021-02-05 11:18:14.9: No pending plans that can be started now.
2021-02-05 11:18:14.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:18:45.8: SelectRunning: No running plans
2021-02-05 11:18:45.8: No pending plans that can be started now.
2021-02-05 11:18:45.8: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:19:16.4: SelectRunning: No running plans
2021-02-05 11:19:16.4: No pending plans that can be started now.
2021-02-05 11:19:16.4: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:19:47.0: SelectRunning: No running plans
2021-02-05 11:19:47.0: No pending plans that can be started now.
2021-02-05 11:19:47.0: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:20:17.9: SelectRunning: No running plans
2021-02-05 11:20:17.9: No pending plans that can be started now.
2021-02-05 11:20:17.9: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:20:48.5: SelectRunning: No running plans
2021-02-05 11:20:48.5: No pending plans that can be started now.
2021-02-05 11:20:48.5: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:21:19.1: SelectRunning: No running plans
2021-02-05 11:21:19.1: No pending plans that can be started now.
2021-02-05 11:21:19.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 11:21:50.1: SelectRunning: No running plans
2021-02-05 11:21:50.1: Efficiency: Only one pending plan M12, it is the "best"
2021-02-05 11:21:50.2: Dispatcher cycle time: 0.1 sec.
2021-02-05 11:21:50.2: Acquire data for Observation M12...
2021-02-05 11:21:50.2:   (belongs to Project Messier, Plan M12)
2021-02-05 11:21:50.2: Send Observation M12 to ACP Sequencer
2021-02-05 11:21:50.2: ACP.RunScript(AcquireScheduler, ):
2021-02-05 11:21:50.2:   Script AutoFocusScheduler is loaded, and
2021-02-05 11:21:50.2:   the console is idle.
2021-02-05 11:21:50.2:   In start loop, i = 0
2021-02-05 11:21:50.2:   Console is now idle
2021-02-05 11:21:50.2:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 11:21:50.2:   Script started successfully
2021-02-05 11:22:00.2: Sequencer is now active
2021-02-05 11:41:48.9: Sequencer is no longer active
2021-02-05 11:41:48.9: Post-job status check done (stat=Completed)
2021-02-05 11:41:48.9: Acquisition time: 1198.7218201 sec.
2021-02-05 11:41:48.9: Data for Observation M12 of Plan M12 acquired successfully.
2021-02-05 11:41:48.9: Plan M12 completed successfully.
2021-02-05 11:41:48.9: Image Efficiency: 75.1%
2021-02-05 11:41:48.9: Cycle Efficiency: 100.0%
2021-02-05 11:41:49.1: SelectRunning: No running plans
2021-02-05 11:41:49.1: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 11:41:49.1:  (deferred for 52 min, until 05-Feb-2021 12:33:49 UTC
2021-02-05 11:41:49.1: Efficiency: Selecting from 2 pending plans:
2021-02-05 11:41:49.2:   Selected Plan M10 (TotEff=1.97)
2021-02-05 11:41:49.2: Dispatcher cycle time: 0.2 sec.
2021-02-05 11:41:49.2: Acquire data for Observation M10...
2021-02-05 11:41:49.2:   (belongs to Project Messier, Plan M10)
2021-02-05 11:41:49.3: Send Observation M10 to ACP Sequencer
2021-02-05 11:41:49.3: ACP.RunScript(AcquireScheduler, ):
2021-02-05 11:41:49.3:   Script AcquireScheduler is loaded, and
2021-02-05 11:41:49.3:   the console is idle.
2021-02-05 11:41:49.3:   In start loop, i = 0
2021-02-05 11:41:49.3:   Console is now idle
2021-02-05 11:41:49.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 11:41:49.3:   Script started successfully
2021-02-05 11:41:59.3: Sequencer is now active
2021-02-05 11:59:52.6: Sequencer is no longer active
2021-02-05 11:59:52.6: Post-job status check done (stat=Completed)
2021-02-05 11:59:52.7: Acquisition time: 1083.3822879 sec.
2021-02-05 11:59:52.7: Data for Observation M10 of Plan M10 acquired successfully.
2021-02-05 11:59:52.7: Plan M10 completed successfully.
2021-02-05 11:59:52.7: Image Efficiency: 83.1%
2021-02-05 11:59:52.7: Cycle Efficiency: 100.0%
2021-02-05 11:59:52.8: ++ Auto Focus ++
2021-02-05 11:59:52.9: Doing periodic autofocus.
2021-02-05 11:59:52.9: Start special ACP AutoFocus script for scheduler
2021-02-05 11:59:52.9: ACP.RunScript(AutoFocusScheduler, ):
2021-02-05 11:59:52.9:   Script AcquireScheduler is loaded, and
2021-02-05 11:59:52.9:   the console is idle.
2021-02-05 11:59:52.9:   In start loop, i = 0
2021-02-05 11:59:52.9:   Console is now idle
2021-02-05 11:59:53.0:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-02-05 11:59:53.0:   Script started successfully
2021-02-05 12:00:03.0: Sequencer is now active
2021-02-05 12:04:35.1: Sequencer is no longer active
2021-02-05 12:04:35.1: Next periodic autofocus ASAP after 3600sec. 05-Feb-2021 13:04:20 UTC
2021-02-05 12:04:35.2: SelectRunning: No running plans
2021-02-05 12:04:35.2: Efficiency: Selecting from 2 pending plans:
2021-02-05 12:04:35.2:   Selected Plan M107 (TotEff=1.77)
2021-02-05 12:04:35.3: Dispatcher cycle time: 0.1 sec.
2021-02-05 12:04:35.3: Acquire data for Observation M107...
2021-02-05 12:04:35.3:   (belongs to Project Messier, Plan M107)
2021-02-05 12:04:35.3: Send Observation M107 to ACP Sequencer
2021-02-05 12:04:35.3: ACP.RunScript(AcquireScheduler, ):
2021-02-05 12:04:35.3:   Script AutoFocusScheduler is loaded, and
2021-02-05 12:04:35.3:   the console is idle.
2021-02-05 12:04:35.3:   In start loop, i = 0
2021-02-05 12:04:35.3:   Console is now idle
2021-02-05 12:04:35.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 12:04:35.4:   Script started successfully
2021-02-05 12:04:45.4: Sequencer is now active
2021-02-05 12:23:54.0: Sequencer is no longer active
2021-02-05 12:23:54.0: Post-job status check done (stat=Completed)
2021-02-05 12:23:54.0: Acquisition time: 1158.6607826 sec.
2021-02-05 12:23:54.0: Data for Observation M107 of Plan M107 acquired successfully.
2021-02-05 12:23:54.0: Plan M107 completed successfully.
2021-02-05 12:23:54.0: Image Efficiency: 77.7%
2021-02-05 12:23:54.0: Cycle Efficiency: 100.0%
2021-02-05 12:23:54.2: SelectRunning: No running plans
2021-02-05 12:23:54.2: Efficiency: Selecting from 2 pending plans:
2021-02-05 12:23:54.2:   Selected Plan NGC_6254 (TotEff=1.25)
2021-02-05 12:23:54.3: Dispatcher cycle time: 0.1 sec.
2021-02-05 12:23:54.3: Acquire data for Observation NGC_6254...
2021-02-05 12:23:54.3:   (belongs to Project AAVSO_MISC_WEL_AUTO_ver1895, Plan NGC_6254)
2021-02-05 12:23:54.3: Send Observation NGC_6254 to ACP Sequencer
2021-02-05 12:23:54.3: ACP.RunScript(AcquireScheduler, ):
2021-02-05 12:23:54.3:   Script AcquireScheduler is loaded, and
2021-02-05 12:23:54.3:   the console is idle.
2021-02-05 12:23:54.3:   In start loop, i = 0
2021-02-05 12:23:54.3:   Console is now idle
2021-02-05 12:23:54.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 12:23:54.3:   Script started successfully
2021-02-05 12:24:04.4: Sequencer is now active
2021-02-05 12:38:02.0: Sequencer is no longer active
2021-02-05 12:38:02.0: Post-job status check done (stat=Completed)
2021-02-05 12:38:02.0: Acquisition time: 847.7033946 sec.
2021-02-05 12:38:02.0: Data for Observation NGC_6254 of Plan NGC_6254 acquired successfully.
2021-02-05 12:38:02.0: Plan NGC_6254 completed successfully.
2021-02-05 12:38:02.1: Image Efficiency: 70.8%
2021-02-05 12:38:02.1: Cycle Efficiency: 100.0%
2021-02-05 12:38:02.2: SelectRunning: No running plans
2021-02-05 12:38:02.2: Obs Test in Plan Test vetoed for sequencer hard limit.
2021-02-05 12:38:02.2:  (deferred for 52 min, until 05-Feb-2021 13:30:02 UTC
2021-02-05 12:38:02.2: Efficiency: Only one pending plan CH_Cyg, it is the "best"
2021-02-05 12:38:02.3: Dispatcher cycle time: 0.1 sec.
2021-02-05 12:38:02.3: Acquire data for Observation CH_Cyg...
2021-02-05 12:38:02.3:   (belongs to Project AAVSO_MISC_SBL_AUTO_ver1899, Plan CH_Cyg)
2021-02-05 12:38:02.3: Send Observation CH_Cyg to ACP Sequencer
2021-02-05 12:38:02.3: ACP.RunScript(AcquireScheduler, ):
2021-02-05 12:38:02.3:   Script AcquireScheduler is loaded, and
2021-02-05 12:38:02.3:   the console is idle.
2021-02-05 12:38:02.3:   In start loop, i = 0
2021-02-05 12:38:02.3:   Console is now idle
2021-02-05 12:38:02.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 12:38:02.3:   Script started successfully
2021-02-05 12:38:12.4: Sequencer is now active
2021-02-05 12:42:02.6: Sequencer is no longer active
2021-02-05 12:42:02.6: Post-job status check done (stat=Failed)
2021-02-05 12:42:02.6: ACP data acquisition failed for Observation CH_Cyg.
2021-02-05 12:42:02.6:   (Observation CH_Cyg interrupted by acquisition process failure.)
2021-02-05 12:42:02.8: SelectRunning: No running plans
2021-02-05 12:42:02.8: Efficiency: Only one pending plan M80, it is the "best"
2021-02-05 12:42:02.9: Dispatcher cycle time: 0.1 sec.
2021-02-05 12:42:02.9: Acquire data for Observation M80...
2021-02-05 12:42:02.9:   (belongs to Project Messier, Plan M80)
2021-02-05 12:42:02.9: Send Observation M80 to ACP Sequencer
2021-02-05 12:42:02.9: ACP.RunScript(AcquireScheduler, ):
2021-02-05 12:42:02.9:   Script AcquireScheduler is loaded, and
2021-02-05 12:42:02.9:   the console is idle.
2021-02-05 12:42:02.9:   In start loop, i = 0
2021-02-05 12:42:02.9:   Console is now idle
2021-02-05 12:42:02.9:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-02-05 12:42:02.9:   Script started successfully
2021-02-05 12:42:12.9: Sequencer is now active
2021-02-05 13:01:04.4: Sequencer is no longer active
2021-02-05 13:01:04.4: Post-job status check done (stat=Completed)
2021-02-05 13:01:04.4: Acquisition time: 1141.5207897 sec.
2021-02-05 13:01:04.4: Data for Observation M80 of Plan M80 acquired successfully.
2021-02-05 13:01:04.4: Plan M80 completed successfully.
2021-02-05 13:01:04.5: Image Efficiency: 78.8%
2021-02-05 13:01:04.5: Cycle Efficiency: 100.0%
2021-02-05 13:01:04.6: SelectRunning: No running plans
2021-02-05 13:01:04.6: No pending plans that can be started now.
2021-02-05 13:01:04.6: Dispatcher cycle time: 0.0 sec.
2021-02-05 13:01:35.2: SelectRunning: No running plans
2021-02-05 13:01:35.2: No pending plans that can be started now.
2021-02-05 13:01:35.2: Dispatcher cycle time: 0.0 sec.
2021-02-05 13:02:06.1: SelectRunning: No running plans
2021-02-05 13:02:06.1: No pending plans that can be started now.
2021-02-05 13:02:06.1: Dispatcher cycle time: 0.0 sec.
2021-02-05 13:02:36.7: SelectRunning: No running plans
2021-02-05 13:02:36.7: No pending plans that can be started now.
2021-02-05 13:02:36.7: Dispatcher cycle time: 0.0 sec.
2021-02-05 13:03:07.3: SelectRunning: No running plans
2021-02-05 13:03:07.3: No pending plans that can be started now.
2021-02-05 13:03:07.3: Dispatcher cycle time: 0.0 sec.
2021-02-05 13:15:52.0: ++ Dawn Flats ++
2021-02-05 13:15:52.0: Start ACP AutoFlat script for Dawn flats
2021-02-05 13:15:52.0: ACP.RunScript(AutoFlat, C:\Users\admin\Documents\ACP Astronomy\Plans\SchedulerDawnFlats.txt):
2021-02-05 13:15:52.0:   Script AcquireScheduler is loaded, and
2021-02-05 13:15:52.0:   the console is idle.
2021-02-05 13:15:52.0:   In start loop, i = 0
2021-02-05 13:15:52.0:   Console is now idle
2021-02-05 13:15:52.4:   Loaded C:\Program Files (x86)\ACP Obs Control\Scripts\AutoFlat.vbs successfully
2021-02-05 13:15:52.5:   Set parameter "C:\Users\admin\Documents\ACP Astronomy\Plans\SchedulerDawnFlats.txt" successfully
2021-02-05 13:15:52.5:   Script started successfully
2021-02-05 13:16:02.5: Sequencer is now active
2021-02-05 13:33:44.2: Sequencer is no longer active
2021-02-05 13:34:14.8: -- Observatory Shutdown --
2021-02-05 13:34:14.8: Start ACP Sequencer's ShutdownObs script
2021-02-05 13:34:14.8: ACP.RunScript(ShutdownObs, ):
2021-02-05 13:34:14.8:   Script AutoFlat is loaded, and
2021-02-05 13:34:14.8:   the console is idle.
2021-02-05 13:34:14.8:   In start loop, i = 0
2021-02-05 13:34:14.8:   Console is now idle
2021-02-05 13:34:15.2:   Loaded C:\Users\Public\Documents\ACP Config\Scheduler\ShutdownObs.js successfully
2021-02-05 13:34:15.2:   Script started successfully
2021-02-05 13:34:25.3: Sequencer is now active
2021-02-05 13:35:34.7: Sequencer is no longer active
2021-02-05 13:35:34.9: -- Weather Unsafe --
2021-02-05 23:07:35.4: **EXCEPTION IN SCHEDULER:
2021-02-05 23:07:35.4: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA)
2021-02-05 23:07:36.5: Traceback:
   at ACP.UtilClass.get_Scheduler()
   at DC3.Scheduler.ACPSequencer.set_DispatcherStatus(StatusValue value)
   at DC3.Scheduler.Engine.set_Status(StatusValue value)
   at DC3.Scheduler.Engine.Run()
2021-02-05 23:07:36.5: DOME/ROOF FAILURE: In addition, attempting to close your dome/roof this error occurred:
2021-02-05 23:07:36.5: The RPC server is unavailable. (Exception from HRESULT: 0x800706BA)
2021-02-05 23:07:36.8: No operator intervention command tool specified