Log opened at Sat, Oct 17 2020 02:06:02 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2020-10-17 02:06:02.9: ++ Observatory Startup ++
2020-10-17 02:06:02.9: Start ACP Sequencer's StartupObs script
2020-10-17 02:06:02.9: ACP.RunScript(StartupObs, ):
2020-10-17 02:06:02.9:   No script is loaded. ACP is definitely idle
2020-10-17 02:06:02.9:   In start loop, i = 0
2020-10-17 02:06:02.9:   Console is now idle
2020-10-17 02:06:02.9:   Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully
2020-10-17 02:06:02.9:   Script started successfully
2020-10-17 02:06:12.9: Sequencer is now active
2020-10-17 02:06:40.5: Sequencer is no longer active
2020-10-17 02:06:40.5: Open the observatory dome/roof
2020-10-17 02:07:41.3: Observatory startup succeeded, and dome opened successfully
2020-10-17 02:07:41.3: ++ Auto Focus ++
2020-10-17 02:07:41.3: Doing initial autofocus.
2020-10-17 02:07:41.3: Start special ACP AutoFocus script for scheduler
2020-10-17 02:07:41.3: ACP.RunScript(AutoFocusScheduler, ):
2020-10-17 02:07:41.3:   Script StartupObs is loaded, and
2020-10-17 02:07:41.3:   the console is idle.
2020-10-17 02:07:41.3:   In start loop, i = 0
2020-10-17 02:07:41.3:   Console is now idle
2020-10-17 02:07:41.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2020-10-17 02:07:41.3:   Script started successfully
2020-10-17 02:07:51.4: Sequencer is now active
2020-10-17 02:12:06.1: Sequencer is no longer active
2020-10-17 02:12:06.1: Next periodic autofocus ASAP after 3600sec. 17-Oct-2020 03:11:51 UTC
2020-10-17 02:12:07.8: Plan Saturn has Monitor Mode. Time to resubmit it.
2020-10-17 02:12:07.8: Plan Mars has Monitor Mode. Time to resubmit it.
2020-10-17 02:12:07.8: SelectRunning: No running plans
2020-10-17 02:12:08.0: EPH (Jupiter): type=Major Planet time=02:12:07 ra=19.3711378 dec=-22.535477
2020-10-17 02:12:08.0: Obs KH15D in Plan KH15D was vetoed by AirMass constraint.
2020-10-17 02:12:08.0:     AirMass estimates ready after 17-Oct-2020 08:01:03 UTC
2020-10-17 02:12:08.0: Obs KH15D-B in Plan KH15D-B was vetoed by AirMass constraint.
2020-10-17 02:12:08.0:     AirMass estimates ready after 17-Oct-2020 08:01:03 UTC
2020-10-17 02:12:08.0: Obs M10 in Plan M10 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.0:     AirmassRange estimates ready after 17-Oct-2020 18:55:23 UTC
2020-10-17 02:12:08.0: Obs M100 in Plan M100 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.0:     AirmassRange estimates ready after 17-Oct-2020 13:26:48 UTC
2020-10-17 02:12:08.0: Obs M101 in Plan M101 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.0:     AirmassRange estimates ready after 17-Oct-2020 13:54:13 UTC
2020-10-17 02:12:08.0: Obs M104 in Plan M104 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.0:     AirmassRange estimates ready after 17-Oct-2020 15:08:59 UTC
2020-10-17 02:12:08.1: Obs M105 in Plan M105 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 11:59:27 UTC
2020-10-17 02:12:08.1: Obs M106 in Plan M106 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 12:22:48 UTC
2020-10-17 02:12:08.1: Obs M107 in Plan M107 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 19:07:38 UTC
2020-10-17 02:12:08.1: Obs M108 in Plan M108 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 11:00:36 UTC
2020-10-17 02:12:08.1: Obs M109 in Plan M109 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 11:50:43 UTC
2020-10-17 02:12:08.1: Obs M12 in Plan M12 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 18:38:13 UTC
2020-10-17 02:12:08.1: STRICT VETO:
2020-10-17 02:12:08.1: Obs M16 in Plan M16 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 20:57:17 UTC
2020-10-17 02:12:08.1: Obs M17 in Plan M17 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 21:12:09 UTC
2020-10-17 02:12:08.1: Obs M18 in Plan M18 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.1:     AirmassRange estimates ready after 17-Oct-2020 21:16:49 UTC
2020-10-17 02:12:08.2: Obs M19 in Plan M19 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 21:25:43 UTC
2020-10-17 02:12:08.2: Obs M20 in Plan M20 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 21:44:05 UTC
2020-10-17 02:12:08.2: Obs M21 in Plan M21 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 21:41:01 UTC
2020-10-17 02:12:08.2: Obs M22 in Plan M22 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 22:26:45 UTC
2020-10-17 02:12:08.2: Obs M23 in Plan M23 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 21:05:51 UTC
2020-10-17 02:12:08.2: Obs M24 in Plan M24 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 21:22:20 UTC
2020-10-17 02:12:08.2: Obs M28 in Plan M28 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 22:26:19 UTC
2020-10-17 02:12:08.2: Obs M3 in Plan M3 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 14:19:54 UTC
2020-10-17 02:12:08.2: Obs M35 in Plan M35 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.2:     AirmassRange estimates ready after 17-Oct-2020 06:55:46 UTC
2020-10-17 02:12:08.3: Obs M37 in Plan M37 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 06:23:32 UTC
2020-10-17 02:12:08.3: Obs M4 in Plan M4 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 20:51:54 UTC
2020-10-17 02:12:08.3: Obs M40 in Plan M40 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 12:06:49 UTC
2020-10-17 02:12:08.3: Obs M41 in Plan M41 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 10:10:21 UTC
2020-10-17 02:12:08.3: Obs M44 in Plan M44 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 09:35:31 UTC
2020-10-17 02:12:08.3: Obs M46 in Plan M46 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 10:27:22 UTC
2020-10-17 02:12:08.3: Obs M47 in Plan M47 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 10:20:31 UTC
2020-10-17 02:12:08.3: Obs M48 in Plan M48 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 10:19:38 UTC
2020-10-17 02:12:08.3: Obs M49 in Plan M49 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 13:52:33 UTC
2020-10-17 02:12:08.3: Obs M5 in Plan M5 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.3:     AirmassRange estimates ready after 17-Oct-2020 16:57:16 UTC
2020-10-17 02:12:08.4: Obs M51 in Plan M51 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.4:     AirmassRange estimates ready after 17-Oct-2020 13:33:41 UTC
2020-10-17 02:12:08.4: Obs M53 in Plan M53 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.4:     AirmassRange estimates ready after 17-Oct-2020 14:11:28 UTC
2020-10-17 02:12:08.4: Obs M58 in Plan M58 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.4:     AirmassRange estimates ready after 17-Oct-2020 13:50:53 UTC
2020-10-17 02:12:08.4: Obs M59 in Plan M59 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.4:     AirmassRange estimates ready after 17-Oct-2020 13:55:35 UTC
2020-10-17 02:12:08.4: Obs M60 in Plan M60 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.4:     AirmassRange estimates ready after 17-Oct-2020 13:57:31 UTC
2020-10-17 02:12:08.4: Obs M61 in Plan M61 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.4:     AirmassRange estimates ready after 17-Oct-2020 13:54:12 UTC
2020-10-17 02:12:08.4: Obs M63 in Plan M63 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.4:     AirmassRange estimates ready after 17-Oct-2020 13:28:41 UTC
2020-10-17 02:12:08.5: Obs M64 in Plan M64 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 13:47:51 UTC
2020-10-17 02:12:08.5: Obs M65 in Plan M65 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 12:29:17 UTC
2020-10-17 02:12:08.5: Obs M66 in Plan M66 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 12:30:49 UTC
2020-10-17 02:12:08.5: Obs M67 in Plan M67 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 10:04:13 UTC
2020-10-17 02:12:08.5: Obs M68 in Plan M68 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 17:12:57 UTC
2020-10-17 02:12:08.5: Obs M8 in Plan M8 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 21:59:44 UTC
2020-10-17 02:12:08.5: Obs M80 in Plan M80 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 19:58:17 UTC
2020-10-17 02:12:08.5: Obs M81 in Plan M81 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 09:17:01 UTC
2020-10-17 02:12:08.5: Obs M82 in Plan M82 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.5:     AirmassRange estimates ready after 17-Oct-2020 09:15:38 UTC
2020-10-17 02:12:08.6: Obs M84 in Plan M84 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 13:35:47 UTC
2020-10-17 02:12:08.6: Obs M85 in Plan M85 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 13:24:04 UTC
2020-10-17 02:12:08.6: Obs M86 in Plan M86 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 13:36:43 UTC
2020-10-17 02:12:08.6: Obs M87 in Plan M87 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 13:42:37 UTC
2020-10-17 02:12:08.6: Obs M88 in Plan M88 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 13:39:04 UTC
2020-10-17 02:12:08.6: Obs M89 in Plan M89 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 13:47:08 UTC
2020-10-17 02:12:08.6: Obs M9 in Plan M9 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 20:25:00 UTC
2020-10-17 02:12:08.6: Obs M90 in Plan M90 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 13:46:46 UTC
2020-10-17 02:12:08.6: Obs M91 in Plan M91 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.6:     AirmassRange estimates ready after 17-Oct-2020 13:42:16 UTC
2020-10-17 02:12:08.7: Obs M93 in Plan M93 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.7:     AirmassRange estimates ready after 17-Oct-2020 11:36:22 UTC
2020-10-17 02:12:08.7: Obs M94 in Plan M94 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.7:     AirmassRange estimates ready after 17-Oct-2020 13:05:28 UTC
2020-10-17 02:12:08.7: Obs M95 in Plan M95 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.7:     AirmassRange estimates ready after 17-Oct-2020 11:57:47 UTC
2020-10-17 02:12:08.7: Obs M96 in Plan M96 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.7:     AirmassRange estimates ready after 17-Oct-2020 12:00:18 UTC
2020-10-17 02:12:08.7: Obs M97 in Plan M97 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.7:     AirmassRange estimates ready after 17-Oct-2020 11:05:05 UTC
2020-10-17 02:12:08.7: Obs M98 in Plan M98 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.7:     AirmassRange estimates ready after 17-Oct-2020 13:19:49 UTC
2020-10-17 02:12:08.7: Obs M99 in Plan M99 was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.7:     AirmassRange estimates ready after 17-Oct-2020 13:25:55 UTC
2020-10-17 02:12:08.8: EPH (Mars): type=Major Planet time=02:12:07 ra=1.2895849 dec=5.160293
2020-10-17 02:12:08.8: Obs Mars in Plan Mars was vetoed by AirmassRange constraint.
2020-10-17 02:12:08.8:     AirmassRange estimates ready after 17-Oct-2020 02:49:33 UTC
2020-10-17 02:12:08.8: EPH (Saturn): type=Major Planet time=02:12:07 ra=19.8225705 dec=-21.393103
2020-10-17 02:12:08.8: Efficiency: Selecting from 7 pending plans:
2020-10-17 02:12:08.9:   Selected Plan Jupiter (TotEff=6.22)
2020-10-17 02:12:09.0: Dispatcher cycle time: 2.9 sec.
2020-10-17 02:12:09.0: Acquire data for Observation Jupiter...
2020-10-17 02:12:09.0:   (belongs to Project Planet, Plan Jupiter)
2020-10-17 02:12:09.0: Send Observation Jupiter to ACP Sequencer
2020-10-17 02:12:09.0: ACP.RunScript(AcquireScheduler, ):
2020-10-17 02:12:09.0:   Script AutoFocusScheduler is loaded, and
2020-10-17 02:12:09.0:   the console is idle.
2020-10-17 02:12:09.0:   In start loop, i = 0
2020-10-17 02:12:09.0:   Console is now idle
2020-10-17 02:12:09.1:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2020-10-17 02:12:09.1:   Script started successfully
2020-10-17 02:12:19.1: Sequencer is now active
2020-10-17 02:14:08.4: Sequencer is no longer active
2020-10-17 02:14:08.4: Post-job status check done (stat=Failed)
2020-10-17 02:14:08.4: ACP data acquisition failed for Observation Jupiter.
2020-10-17 02:14:08.4:   (Observation Jupiter interrupted by acquisition process failure.)
2020-10-17 02:14:08.6: SelectRunning: No running plans
2020-10-17 02:14:08.6: EPH (Saturn): type=Major Planet time=02:14:08 ra=19.8225734 dec=-21.393096
2020-10-17 02:14:08.6: Efficiency: Selecting from 6 pending plans:
2020-10-17 02:14:08.7:   Selected Plan Saturn (TotEff=6.20)
2020-10-17 02:14:08.7: Dispatcher cycle time: 0.2 sec.
2020-10-17 02:14:08.7: Acquire data for Observation Saturn...
2020-10-17 02:14:08.7:   (belongs to Project Planet, Plan Saturn)
2020-10-17 02:14:08.8: Send Observation Saturn to ACP Sequencer
2020-10-17 02:14:08.8: ACP.RunScript(AcquireScheduler, ):
2020-10-17 02:14:08.8:   Script AcquireScheduler is loaded, and
2020-10-17 02:14:08.8:   the console is idle.
2020-10-17 02:14:08.8:   In start loop, i = 0
2020-10-17 02:14:08.8:   Console is now idle
2020-10-17 02:14:08.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2020-10-17 02:14:08.8:   Script started successfully
2020-10-17 02:14:18.8: Sequencer is now active
2020-10-17 02:15:07.6: Sequencer is no longer active
2020-10-17 02:15:07.6: Post-job status check done (stat=Failed)
2020-10-17 02:15:07.6: ACP data acquisition failed for Observation Saturn.
2020-10-17 02:15:07.6:   (Observation Saturn interrupted by acquisition process failure.)
2020-10-17 02:15:07.7: SelectRunning: No running plans
2020-10-17 02:15:07.8: Efficiency: Selecting from 5 pending plans:
2020-10-17 02:15:07.8:   Selected Plan EE_Cep (TotEff=4.14)
2020-10-17 02:15:07.9: Dispatcher cycle time: 0.2 sec.
2020-10-17 02:15:07.9: Acquire data for Observation EE_Cep...
2020-10-17 02:15:07.9:   (belongs to Project AAVSO_P124_Staels_AUTO_ver928, Plan EE_Cep)
2020-10-17 02:15:07.9: Send Observation EE_Cep to ACP Sequencer
2020-10-17 02:15:07.9: ACP.RunScript(AcquireScheduler, ):
2020-10-17 02:15:07.9:   Script AcquireScheduler is loaded, and
2020-10-17 02:15:07.9:   the console is idle.
2020-10-17 02:15:07.9:   In start loop, i = 0
2020-10-17 02:15:07.9:   Console is now idle
2020-10-17 02:15:07.9:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2020-10-17 02:15:07.9:   Script started successfully
2020-10-17 02:15:17.9: Sequencer is now active
2020-10-17 02:24:31.1: Sequencer is no longer active
2020-10-17 02:24:31.1: Post-job status check done (stat=Failed)
2020-10-17 02:24:31.1: ACP data acquisition failed for Observation EE_Cep.
2020-10-17 02:24:31.1:   (Observation EE_Cep interrupted by acquisition process failure.)
2020-10-17 02:24:31.2: SelectRunning: No running plans
2020-10-17 02:24:31.3: Efficiency: Selecting from 4 pending plans:
2020-10-17 02:24:31.3:   Selected Plan M11 (TotEff=2.28)
2020-10-17 02:24:31.4: Dispatcher cycle time: 0.2 sec.
2020-10-17 02:24:31.4: Acquire data for Observation M11...
2020-10-17 02:24:31.4:   (belongs to Project Messier, Plan M11)
2020-10-17 02:24:31.4: Send Observation M11 to ACP Sequencer
2020-10-17 02:24:31.4: ACP.RunScript(AcquireScheduler, ):
2020-10-17 02:24:31.4:   Script AcquireScheduler is loaded, and
2020-10-17 02:24:31.4:   the console is idle.
2020-10-17 02:24:31.4:   In start loop, i = 0
2020-10-17 02:24:31.4:   Console is now idle
2020-10-17 02:24:31.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2020-10-17 02:24:31.4:   Script started successfully
2020-10-17 02:24:41.4: Sequencer is now active
2020-10-17 02:43:45.5: Sequencer is no longer active
2020-10-17 02:43:45.5: Post-job status check done (stat=Completed)
2020-10-17 02:43:45.5: Acquisition time: 1154.0843446 sec.
2020-10-17 02:43:45.5: Data for Observation M11 of Plan M11 acquired successfully.
2020-10-17 02:43:45.5: Plan M11 completed successfully.
2020-10-17 02:43:45.5: Image Efficiency: 78.0%
2020-10-17 02:43:45.5: Cycle Efficiency: 100.0%
2020-10-17 02:43:45.7: SelectRunning: No running plans
2020-10-17 02:43:45.7: Efficiency: Selecting from 3 pending plans:
2020-10-17 02:43:45.7:   Selected Plan M92 (TotEff=2.60)
2020-10-17 02:43:45.8: Dispatcher cycle time: 0.1 sec.
2020-10-17 02:43:45.8: Acquire data for Observation M92...
2020-10-17 02:43:45.8:   (belongs to Project Messier, Plan M92)
2020-10-17 02:43:45.8: Send Observation M92 to ACP Sequencer
2020-10-17 02:43:45.8: ACP.RunScript(AcquireScheduler, ):
2020-10-17 02:43:45.8:   Script AcquireScheduler is loaded, and
2020-10-17 02:43:45.8:   the console is idle.
2020-10-17 02:43:45.8:   In start loop, i = 0
2020-10-17 02:43:45.8:   Console is now idle
2020-10-17 02:43:45.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2020-10-17 02:43:45.8:   Script started successfully
2020-10-17 02:43:55.8: Sequencer is now active
2020-10-17 03:02:40.7: Sequencer is no longer active
2020-10-17 03:02:40.7: Post-job status check done (stat=Completed)
2020-10-17 03:02:40.7: Acquisition time: 1134.8661626 sec.
2020-10-17 03:02:40.7: Data for Observation M92 of Plan M92 acquired successfully.
2020-10-17 03:02:40.7: Plan M92 completed successfully.
2020-10-17 03:02:40.7: Image Efficiency: 79.3%
2020-10-17 03:02:40.7: Cycle Efficiency: 100.0%
2020-10-17 03:02:40.8: SelectRunning: No running plans
2020-10-17 03:02:40.9: EPH (Mars): type=Major Planet time=03:02:40 ra=1.2888531 dec=5.158416
2020-10-17 03:02:40.9: Efficiency: Selecting from 3 pending plans:
2020-10-17 03:02:40.9:   Selected Plan Mars (TotEff=5.11)
2020-10-17 03:02:41.0: Dispatcher cycle time: 0.1 sec.
2020-10-17 03:02:41.0: Acquire data for Observation Mars...
2020-10-17 03:02:41.0:   (belongs to Project Planet, Plan Mars)
2020-10-17 03:02:41.0: Send Observation Mars to ACP Sequencer
2020-10-17 03:02:41.0: ACP.RunScript(AcquireScheduler, ):
2020-10-17 03:02:41.0:   Script AcquireScheduler is loaded, and
2020-10-17 03:02:41.0:   the console is idle.
2020-10-17 03:02:41.0:   In start loop, i = 0
2020-10-17 03:02:41.0:   Console is now idle
2020-10-17 03:02:41.0:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2020-10-17 03:02:41.0:   Script started successfully
2020-10-17 03:02:51.0: Sequencer is now active
2020-10-17 03:06:38.1: Sequencer is no longer active
2020-10-17 03:06:38.1: Post-job status check done (stat=Failed)
2020-10-17 03:06:38.1: ACP data acquisition failed for Observation Mars.
2020-10-17 03:06:38.1:   (Observation Mars interrupted by acquisition process failure.)
2020-10-17 03:06:38.3: SelectRunning: No running plans
2020-10-17 03:06:38.3: Efficiency: Selecting from 2 pending plans:
2020-10-17 03:06:38.3:   Selected Plan M71 (TotEff=2.15)
2020-10-17 03:06:38.4: Dispatcher cycle time: 0.1 sec.
2020-10-17 03:06:38.4: Acquire data for Observation M71...
2020-10-17 03:06:38.4:   (belongs to Project Messier, Plan M71)
2020-10-17 03:06:38.4: Send Observation M71 to ACP Sequencer
2020-10-17 03:06:38.4: ACP.RunScript(AcquireScheduler, ):
2020-10-17 03:06:38.4:   Script AcquireScheduler is loaded, and
2020-10-17 03:06:38.4:   the console is idle.
2020-10-17 03:06:38.4:   In start loop, i = 0
2020-10-17 03:06:38.4:   Console is now idle
2020-10-17 03:06:38.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2020-10-17 03:06:38.4:   Script started successfully
2020-10-17 03:06:48.4: Sequencer is now active
2020-10-17 03:26:10.7: Sequencer is no longer active
2020-10-17 03:26:10.7: Post-job status check done (stat=Completed)
2020-10-17 03:26:10.7: Acquisition time: 1172.2941365 sec.
2020-10-17 03:26:10.7: Data for Observation M71 of Plan M71 acquired successfully.
2020-10-17 03:26:10.7: Plan M71 completed successfully.
2020-10-17 03:26:10.7: Image Efficiency: 76.8%
2020-10-17 03:26:10.7: Cycle Efficiency: 100.0%
2020-10-17 03:26:10.9: ++ Auto Focus ++
2020-10-17 03:26:10.9: Doing periodic autofocus.
2020-10-17 03:26:10.9: Start special ACP AutoFocus script for scheduler
2020-10-17 03:26:10.9: ACP.RunScript(AutoFocusScheduler, ):
2020-10-17 03:26:10.9:   Script AcquireScheduler is loaded, and
2020-10-17 03:26:10.9:   the console is idle.
2020-10-17 03:26:10.9:   In start loop, i = 0
2020-10-17 03:26:10.9:   Console is now idle
2020-10-17 03:26:10.9:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2020-10-17 03:26:10.9:   Script started successfully
2020-10-17 03:26:20.9: Sequencer is now active
2020-10-17 03:27:50.0: Sequencer is no longer active
2020-10-17 03:27:50.0: ** ACP script "AutoFocusScheduler" failed:
2020-10-17 03:27:50.0: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 81 column 2.

2020-10-17 03:27:50.0: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2020-10-17 03:27:50.1: SelectRunning: No running plans
2020-10-17 03:27:50.1: Efficiency: Only one pending plan Test, it is the "best"
2020-10-17 03:27:50.1: Dispatcher cycle time: 0.1 sec.
2020-10-17 03:27:50.1: Acquire data for Observation Test...
2020-10-17 03:27:50.1:   (belongs to Project KH15D, Plan Test)
2020-10-17 03:27:50.1: ++ Auto Focus ++
2020-10-17 03:27:50.2: Doing periodic autofocus.
2020-10-17 03:27:50.2: Start special ACP AutoFocus script for scheduler
2020-10-17 03:27:50.2: ACP.RunScript(AutoFocusScheduler, ):
2020-10-17 03:27:50.2:   Script AutoFocusScheduler is loaded, and
2020-10-17 03:27:50.2:   the console is idle.
2020-10-17 03:27:50.2:   In start loop, i = 0
2020-10-17 03:27:50.2:   Console is now idle
2020-10-17 03:27:50.2:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2020-10-17 03:27:50.2:   Script started successfully
2020-10-17 03:28:00.2: Sequencer is now active
2020-10-17 03:28:05.3: Sequencer is no longer active
2020-10-17 03:28:05.3: ** ACP script "AutoFocusScheduler" failed:
2020-10-17 03:28:05.3: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.
**Script Error**
ACP script error 0x80073B01 from ThinScript.ActiveScript:
The resource loader cache doesn't have loaded MUI entry..
**Script Error**
ACP script error 0x80073AFC from ThinScript.ActiveScript:
The resource loader failed to find MUI file..

2020-10-17 03:28:05.3: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2020-10-17 03:28:05.3: **EXCEPTION IN SCHEDULER:
2020-10-17 03:28:05.3: The telescope is not connected.
2020-10-17 03:28:05.3: Traceback:
   at ACP.TelescopeClass.get_SlewSettleTime()
   at DC3.Scheduler.ACPSequencer.AcquireData(Observation Obs)
   at DC3.Scheduler.Engine.DoSchedulePass()
   at DC3.Scheduler.Engine.Run()
2020-10-17 03:28:05.3: No operator intervention command tool specified
2020-10-17 03:28:05.6: Run statistics:
2020-10-17 03:28:05.6:   Observations:   86
2020-10-17 03:28:05.6:   Considered:     11
2020-10-17 03:28:05.6:   Completed:      0
2020-10-17 03:28:05.6:   Skipped:        0
2020-10-17 03:28:05.6:   Never Eligible: 75
2020-10-17 03:28:05.6:   Failed:         11
2020-10-17 03:28:05.6: Shutter-Open efficiency: 60.76%
2020-10-17 03:28:05.6: Overall Efficiency: 99.90%
2020-10-17 03:28:05.6: Release ACP sequencer
Log closed at Sat, Oct 17 2020 03:28:07 UTC (actual time)