Log opened at Thu, Oct 31 2019 03:58:19 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2019-10-31 03:58:19.8: ++ Observatory Startup ++
2019-10-31 03:58:19.8: Startup attempted, but no StartupObs script found
2019-10-31 03:58:19.8: Open the observatory dome/roof
2019-10-31 03:59:35.6: Observatory startup succeeded, and dome opened successfully
2019-10-31 03:59:35.6: ++ Auto Focus ++
2019-10-31 03:59:35.6: Doing initial autofocus.
2019-10-31 03:59:35.6: Start special ACP AutoFocus script for scheduler
2019-10-31 03:59:35.6: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 03:59:35.6:   Script ACP-Weather is loaded, and
2019-10-31 03:59:35.6:   the console is idle.
2019-10-31 03:59:35.6:   In start loop, i = 0
2019-10-31 03:59:35.6:   Console is now idle
2019-10-31 03:59:35.6:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 03:59:35.6:   Script started successfully
2019-10-31 03:59:45.6: Sequencer is now active
2019-10-31 04:04:50.0: Sequencer is no longer active
2019-10-31 04:04:50.0: Next periodic autofocus ASAP after 3600sec. 31-Oct-2019 05:04:25 UTC
2019-10-31 04:04:50.2: SelectRunning: No running plans
2019-10-31 04:04:50.2: Obs KH15D in Plan KH15D was vetoed by AirMass constraint.
2019-10-31 04:04:50.2:     AirMass estimates ready after 31-Oct-2019 07:08:59 UTC
2019-10-31 04:04:50.2: Obs KH15D-B in Plan KH15D-B was vetoed by AirMass constraint.
2019-10-31 04:04:50.2:     AirMass estimates ready after 31-Oct-2019 07:08:59 UTC
2019-10-31 04:04:50.2: Obs SA109 in Plan SA109 was vetoed by AirMass constraint.
2019-10-31 04:04:50.2:     AirMass estimates ready after 31-Oct-2019 18:39:18 UTC
2019-10-31 04:04:50.2: Efficiency: Only one pending plan Test, it is the "best"
2019-10-31 04:04:50.3: Dispatcher cycle time: 0.2 sec.
2019-10-31 04:04:50.3: Acquire data for Observation Test...
2019-10-31 04:04:50.3:   (belongs to Project KH15D, Plan Test)
2019-10-31 04:04:50.3: Send Observation Test to ACP Sequencer
2019-10-31 04:04:50.3: ACP.RunScript(AcquireScheduler, ):
2019-10-31 04:04:50.3:   Script AutoFocusScheduler is loaded, and
2019-10-31 04:04:50.3:   the console is idle.
2019-10-31 04:04:50.3:   In start loop, i = 0
2019-10-31 04:04:50.3:   Console is now idle
2019-10-31 04:04:50.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2019-10-31 04:04:50.5:   Script started successfully
2019-10-31 04:05:00.5: Sequencer is now active
2019-10-31 04:17:06.6: Sequencer is no longer active
2019-10-31 04:17:06.6: Post-job status check done (stat=Completed)
2019-10-31 04:17:06.6: Acquisition time: 736.2421693 sec.
2019-10-31 04:17:06.6: Data for Observation Test of Plan Test acquired successfully.
2019-10-31 04:17:06.6: Plan Test completed successfully.
2019-10-31 04:17:06.6: Image Efficiency: 81.5%
2019-10-31 04:17:06.6: Cycle Efficiency: 100.0%
2019-10-31 04:17:06.7: SelectRunning: No running plans
2019-10-31 04:17:06.7: No pending plans that can be started now.
2019-10-31 04:17:06.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:17:37.3: SelectRunning: No running plans
2019-10-31 04:17:37.3: No pending plans that can be started now.
2019-10-31 04:17:37.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:18:07.9: SelectRunning: No running plans
2019-10-31 04:18:07.9: No pending plans that can be started now.
2019-10-31 04:18:07.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:18:38.5: SelectRunning: No running plans
2019-10-31 04:18:38.5: No pending plans that can be started now.
2019-10-31 04:18:38.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:19:09.1: SelectRunning: No running plans
2019-10-31 04:19:09.1: No pending plans that can be started now.
2019-10-31 04:19:09.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:19:40.0: SelectRunning: No running plans
2019-10-31 04:19:40.0: No pending plans that can be started now.
2019-10-31 04:19:40.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:20:10.6: SelectRunning: No running plans
2019-10-31 04:20:10.6: No pending plans that can be started now.
2019-10-31 04:20:10.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:20:41.2: SelectRunning: No running plans
2019-10-31 04:20:41.2: No pending plans that can be started now.
2019-10-31 04:20:41.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:21:11.8: SelectRunning: No running plans
2019-10-31 04:21:11.8: No pending plans that can be started now.
2019-10-31 04:21:11.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:21:42.4: SelectRunning: No running plans
2019-10-31 04:21:42.4: No pending plans that can be started now.
2019-10-31 04:21:42.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:22:12.9: SelectRunning: No running plans
2019-10-31 04:22:13.0: No pending plans that can be started now.
2019-10-31 04:22:13.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:22:43.5: SelectRunning: No running plans
2019-10-31 04:22:43.5: No pending plans that can be started now.
2019-10-31 04:22:43.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:23:14.1: SelectRunning: No running plans
2019-10-31 04:23:14.1: No pending plans that can be started now.
2019-10-31 04:23:14.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:23:44.7: SelectRunning: No running plans
2019-10-31 04:23:44.7: No pending plans that can be started now.
2019-10-31 04:23:44.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:24:15.3: SelectRunning: No running plans
2019-10-31 04:24:15.3: No pending plans that can be started now.
2019-10-31 04:24:15.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:24:45.9: SelectRunning: No running plans
2019-10-31 04:24:45.9: No pending plans that can be started now.
2019-10-31 04:24:45.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:25:16.5: SelectRunning: No running plans
2019-10-31 04:25:16.5: No pending plans that can be started now.
2019-10-31 04:25:16.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:25:47.1: SelectRunning: No running plans
2019-10-31 04:25:47.1: No pending plans that can be started now.
2019-10-31 04:25:47.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:26:17.6: SelectRunning: No running plans
2019-10-31 04:26:17.6: No pending plans that can be started now.
2019-10-31 04:26:17.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:26:48.4: SelectRunning: No running plans
2019-10-31 04:26:48.4: No pending plans that can be started now.
2019-10-31 04:26:48.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:27:18.9: SelectRunning: No running plans
2019-10-31 04:27:18.9: No pending plans that can be started now.
2019-10-31 04:27:18.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:27:49.6: SelectRunning: No running plans
2019-10-31 04:27:49.6: No pending plans that can be started now.
2019-10-31 04:27:49.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:28:20.5: SelectRunning: No running plans
2019-10-31 04:28:20.5: No pending plans that can be started now.
2019-10-31 04:28:20.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:28:51.1: SelectRunning: No running plans
2019-10-31 04:28:51.1: No pending plans that can be started now.
2019-10-31 04:28:51.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:29:21.7: SelectRunning: No running plans
2019-10-31 04:29:21.7: No pending plans that can be started now.
2019-10-31 04:29:21.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:29:52.6: SelectRunning: No running plans
2019-10-31 04:29:52.6: No pending plans that can be started now.
2019-10-31 04:29:52.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:30:23.2: SelectRunning: No running plans
2019-10-31 04:30:23.2: No pending plans that can be started now.
2019-10-31 04:30:23.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:30:53.8: SelectRunning: No running plans
2019-10-31 04:30:53.8: No pending plans that can be started now.
2019-10-31 04:30:53.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:31:24.7: SelectRunning: No running plans
2019-10-31 04:31:24.7: No pending plans that can be started now.
2019-10-31 04:31:24.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:31:55.3: SelectRunning: No running plans
2019-10-31 04:31:55.3: No pending plans that can be started now.
2019-10-31 04:31:55.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:32:25.9: SelectRunning: No running plans
2019-10-31 04:32:25.9: No pending plans that can be started now.
2019-10-31 04:32:25.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:32:56.8: SelectRunning: No running plans
2019-10-31 04:32:56.8: No pending plans that can be started now.
2019-10-31 04:32:56.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:33:27.4: SelectRunning: No running plans
2019-10-31 04:33:27.4: No pending plans that can be started now.
2019-10-31 04:33:27.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:33:58.0: SelectRunning: No running plans
2019-10-31 04:33:58.0: No pending plans that can be started now.
2019-10-31 04:33:58.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:34:28.6: SelectRunning: No running plans
2019-10-31 04:34:28.6: No pending plans that can be started now.
2019-10-31 04:34:28.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:34:59.2: SelectRunning: No running plans
2019-10-31 04:34:59.2: No pending plans that can be started now.
2019-10-31 04:34:59.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:35:29.8: SelectRunning: No running plans
2019-10-31 04:35:29.8: No pending plans that can be started now.
2019-10-31 04:35:29.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:36:00.4: SelectRunning: No running plans
2019-10-31 04:36:00.4: No pending plans that can be started now.
2019-10-31 04:36:00.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:36:30.9: SelectRunning: No running plans
2019-10-31 04:36:30.9: No pending plans that can be started now.
2019-10-31 04:36:30.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:37:01.5: SelectRunning: No running plans
2019-10-31 04:37:01.5: No pending plans that can be started now.
2019-10-31 04:37:01.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:37:32.1: SelectRunning: No running plans
2019-10-31 04:37:32.1: No pending plans that can be started now.
2019-10-31 04:37:32.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:38:02.7: SelectRunning: No running plans
2019-10-31 04:38:02.7: No pending plans that can be started now.
2019-10-31 04:38:02.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:38:33.3: SelectRunning: No running plans
2019-10-31 04:38:33.3: No pending plans that can be started now.
2019-10-31 04:38:33.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:39:03.9: SelectRunning: No running plans
2019-10-31 04:39:03.9: No pending plans that can be started now.
2019-10-31 04:39:03.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:39:34.5: SelectRunning: No running plans
2019-10-31 04:39:34.5: No pending plans that can be started now.
2019-10-31 04:39:34.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:40:05.2: SelectRunning: No running plans
2019-10-31 04:40:05.2: No pending plans that can be started now.
2019-10-31 04:40:05.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:40:35.8: SelectRunning: No running plans
2019-10-31 04:40:35.8: No pending plans that can be started now.
2019-10-31 04:40:35.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:41:06.3: SelectRunning: No running plans
2019-10-31 04:41:06.3: No pending plans that can be started now.
2019-10-31 04:41:06.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:41:36.9: SelectRunning: No running plans
2019-10-31 04:41:36.9: No pending plans that can be started now.
2019-10-31 04:41:36.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:42:07.5: SelectRunning: No running plans
2019-10-31 04:42:07.5: No pending plans that can be started now.
2019-10-31 04:42:07.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:42:38.1: SelectRunning: No running plans
2019-10-31 04:42:38.1: No pending plans that can be started now.
2019-10-31 04:42:38.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:43:08.7: SelectRunning: No running plans
2019-10-31 04:43:08.7: No pending plans that can be started now.
2019-10-31 04:43:08.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:43:39.3: SelectRunning: No running plans
2019-10-31 04:43:39.3: No pending plans that can be started now.
2019-10-31 04:43:39.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:44:09.9: SelectRunning: No running plans
2019-10-31 04:44:09.9: No pending plans that can be started now.
2019-10-31 04:44:09.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:44:40.5: SelectRunning: No running plans
2019-10-31 04:44:40.5: No pending plans that can be started now.
2019-10-31 04:44:40.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:45:11.1: SelectRunning: No running plans
2019-10-31 04:45:11.1: No pending plans that can be started now.
2019-10-31 04:45:11.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:45:41.6: SelectRunning: No running plans
2019-10-31 04:45:41.6: No pending plans that can be started now.
2019-10-31 04:45:41.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:46:12.2: SelectRunning: No running plans
2019-10-31 04:46:12.2: No pending plans that can be started now.
2019-10-31 04:46:12.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:46:42.8: SelectRunning: No running plans
2019-10-31 04:46:42.8: No pending plans that can be started now.
2019-10-31 04:46:42.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:47:13.5: SelectRunning: No running plans
2019-10-31 04:47:13.5: No pending plans that can be started now.
2019-10-31 04:47:13.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:47:44.1: SelectRunning: No running plans
2019-10-31 04:47:44.1: No pending plans that can be started now.
2019-10-31 04:47:44.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:48:14.7: SelectRunning: No running plans
2019-10-31 04:48:14.7: No pending plans that can be started now.
2019-10-31 04:48:14.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:48:45.3: SelectRunning: No running plans
2019-10-31 04:48:45.3: No pending plans that can be started now.
2019-10-31 04:48:45.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:49:15.9: SelectRunning: No running plans
2019-10-31 04:49:15.9: No pending plans that can be started now.
2019-10-31 04:49:15.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:49:46.4: SelectRunning: No running plans
2019-10-31 04:49:46.4: No pending plans that can be started now.
2019-10-31 04:49:46.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:50:17.0: SelectRunning: No running plans
2019-10-31 04:50:17.0: No pending plans that can be started now.
2019-10-31 04:50:17.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:50:47.6: SelectRunning: No running plans
2019-10-31 04:50:47.6: No pending plans that can be started now.
2019-10-31 04:50:47.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:51:18.2: SelectRunning: No running plans
2019-10-31 04:51:18.2: No pending plans that can be started now.
2019-10-31 04:51:18.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:51:48.8: SelectRunning: No running plans
2019-10-31 04:51:48.8: No pending plans that can be started now.
2019-10-31 04:51:48.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:52:19.4: SelectRunning: No running plans
2019-10-31 04:52:19.4: No pending plans that can be started now.
2019-10-31 04:52:19.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:52:50.0: SelectRunning: No running plans
2019-10-31 04:52:50.0: No pending plans that can be started now.
2019-10-31 04:52:50.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:53:20.5: SelectRunning: No running plans
2019-10-31 04:53:20.5: No pending plans that can be started now.
2019-10-31 04:53:20.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:53:51.1: SelectRunning: No running plans
2019-10-31 04:53:51.1: No pending plans that can be started now.
2019-10-31 04:53:51.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:54:21.9: SelectRunning: No running plans
2019-10-31 04:54:21.9: No pending plans that can be started now.
2019-10-31 04:54:21.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:54:52.4: SelectRunning: No running plans
2019-10-31 04:54:52.4: No pending plans that can be started now.
2019-10-31 04:54:52.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:55:23.0: SelectRunning: No running plans
2019-10-31 04:55:23.0: No pending plans that can be started now.
2019-10-31 04:55:23.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:55:53.6: SelectRunning: No running plans
2019-10-31 04:55:53.6: No pending plans that can be started now.
2019-10-31 04:55:53.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:56:24.2: SelectRunning: No running plans
2019-10-31 04:56:24.2: No pending plans that can be started now.
2019-10-31 04:56:24.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:56:54.8: SelectRunning: No running plans
2019-10-31 04:56:54.8: No pending plans that can be started now.
2019-10-31 04:56:54.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:57:25.4: SelectRunning: No running plans
2019-10-31 04:57:25.4: No pending plans that can be started now.
2019-10-31 04:57:25.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:57:55.9: SelectRunning: No running plans
2019-10-31 04:57:55.9: No pending plans that can be started now.
2019-10-31 04:57:55.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:58:26.5: SelectRunning: No running plans
2019-10-31 04:58:26.5: No pending plans that can be started now.
2019-10-31 04:58:26.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:58:57.1: SelectRunning: No running plans
2019-10-31 04:58:57.1: No pending plans that can be started now.
2019-10-31 04:58:57.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:59:27.7: SelectRunning: No running plans
2019-10-31 04:59:27.7: No pending plans that can be started now.
2019-10-31 04:59:27.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 04:59:58.3: SelectRunning: No running plans
2019-10-31 04:59:58.3: No pending plans that can be started now.
2019-10-31 04:59:58.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:00:28.9: SelectRunning: No running plans
2019-10-31 05:00:28.9: No pending plans that can be started now.
2019-10-31 05:00:28.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:00:59.5: SelectRunning: No running plans
2019-10-31 05:00:59.5: No pending plans that can be started now.
2019-10-31 05:00:59.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:01:30.2: SelectRunning: No running plans
2019-10-31 05:01:30.2: No pending plans that can be started now.
2019-10-31 05:01:30.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:02:00.8: SelectRunning: No running plans
2019-10-31 05:02:00.8: No pending plans that can be started now.
2019-10-31 05:02:00.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:02:31.4: SelectRunning: No running plans
2019-10-31 05:02:31.4: No pending plans that can be started now.
2019-10-31 05:02:31.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:03:01.9: SelectRunning: No running plans
2019-10-31 05:03:01.9: No pending plans that can be started now.
2019-10-31 05:03:01.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:03:32.5: SelectRunning: No running plans
2019-10-31 05:03:32.5: No pending plans that can be started now.
2019-10-31 05:03:32.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:04:03.1: SelectRunning: No running plans
2019-10-31 05:04:03.1: No pending plans that can be started now.
2019-10-31 05:04:03.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:04:33.7: ++ Auto Focus ++
2019-10-31 05:04:33.7: Doing periodic autofocus.
2019-10-31 05:04:33.7: Start special ACP AutoFocus script for scheduler
2019-10-31 05:04:33.7: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 05:04:33.7:   Script AcquireScheduler is loaded, and
2019-10-31 05:04:33.7:   the console is idle.
2019-10-31 05:04:33.7:   In start loop, i = 0
2019-10-31 05:04:33.7:   Console is now idle
2019-10-31 05:04:33.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 05:04:33.8:   Script started successfully
2019-10-31 05:04:43.8: Sequencer is now active
2019-10-31 05:09:41.6: Sequencer is no longer active
2019-10-31 05:09:41.6: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2019-10-31 05:09:41.6: SelectRunning: No running plans
2019-10-31 05:09:41.7: No pending plans that can be started now.
2019-10-31 05:09:41.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:10:12.2: ++ Auto Focus ++
2019-10-31 05:10:12.3: Doing periodic autofocus.
2019-10-31 05:10:12.3: Start special ACP AutoFocus script for scheduler
2019-10-31 05:10:12.3: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 05:10:12.3:   Script AutoFocusScheduler is loaded, and
2019-10-31 05:10:12.3:   the console is idle.
2019-10-31 05:10:12.3:   In start loop, i = 0
2019-10-31 05:10:12.3:   Console is now idle
2019-10-31 05:10:12.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 05:10:12.3:   Script started successfully
2019-10-31 05:10:22.3: Sequencer is now active
2019-10-31 05:13:47.0: Sequencer is no longer active
2019-10-31 05:13:47.0: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2019-10-31 05:13:47.0: SelectRunning: No running plans
2019-10-31 05:13:47.0: No pending plans that can be started now.
2019-10-31 05:13:47.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:14:17.6: SelectRunning: No running plans
2019-10-31 05:14:17.6: No pending plans that can be started now.
2019-10-31 05:14:17.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:14:48.2: SelectRunning: No running plans
2019-10-31 05:14:48.2: No pending plans that can be started now.
2019-10-31 05:14:48.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:15:18.8: SelectRunning: No running plans
2019-10-31 05:15:18.8: No pending plans that can be started now.
2019-10-31 05:15:18.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:15:49.4: SelectRunning: No running plans
2019-10-31 05:15:49.4: No pending plans that can be started now.
2019-10-31 05:15:49.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:16:20.0: SelectRunning: No running plans
2019-10-31 05:16:20.0: No pending plans that can be started now.
2019-10-31 05:16:20.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:16:50.5: SelectRunning: No running plans
2019-10-31 05:16:50.5: No pending plans that can be started now.
2019-10-31 05:16:50.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:17:21.1: SelectRunning: No running plans
2019-10-31 05:17:21.1: No pending plans that can be started now.
2019-10-31 05:17:21.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:17:51.7: SelectRunning: No running plans
2019-10-31 05:17:51.7: No pending plans that can be started now.
2019-10-31 05:17:51.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:18:22.3: SelectRunning: No running plans
2019-10-31 05:18:22.3: No pending plans that can be started now.
2019-10-31 05:18:22.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:18:52.9: ++ Auto Focus ++
2019-10-31 05:18:52.9: Doing periodic autofocus.
2019-10-31 05:18:52.9: Start special ACP AutoFocus script for scheduler
2019-10-31 05:18:52.9: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 05:18:52.9:   Script AutoFocusScheduler is loaded, and
2019-10-31 05:18:52.9:   the console is idle.
2019-10-31 05:18:52.9:   In start loop, i = 0
2019-10-31 05:18:52.9:   Console is now idle
2019-10-31 05:18:53.0:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 05:18:53.0:   Script started successfully
2019-10-31 05:19:03.0: Sequencer is now active
2019-10-31 05:22:30.2: Sequencer is no longer active
2019-10-31 05:22:30.2: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2019-10-31 05:22:30.2: SelectRunning: No running plans
2019-10-31 05:22:30.2: No pending plans that can be started now.
2019-10-31 05:22:30.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:23:00.8: SelectRunning: No running plans
2019-10-31 05:23:00.8: No pending plans that can be started now.
2019-10-31 05:23:00.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:23:31.4: SelectRunning: No running plans
2019-10-31 05:23:31.4: No pending plans that can be started now.
2019-10-31 05:23:31.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:24:02.0: SelectRunning: No running plans
2019-10-31 05:24:02.0: No pending plans that can be started now.
2019-10-31 05:24:02.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:24:32.6: SelectRunning: No running plans
2019-10-31 05:24:32.6: No pending plans that can be started now.
2019-10-31 05:24:32.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:25:03.4: SelectRunning: No running plans
2019-10-31 05:25:03.4: No pending plans that can be started now.
2019-10-31 05:25:03.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:25:34.0: SelectRunning: No running plans
2019-10-31 05:25:34.0: No pending plans that can be started now.
2019-10-31 05:25:34.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:26:04.6: SelectRunning: No running plans
2019-10-31 05:26:04.6: No pending plans that can be started now.
2019-10-31 05:26:04.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:26:35.2: SelectRunning: No running plans
2019-10-31 05:26:35.2: No pending plans that can be started now.
2019-10-31 05:26:35.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:27:05.7: SelectRunning: No running plans
2019-10-31 05:27:05.7: No pending plans that can be started now.
2019-10-31 05:27:05.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:27:36.3: SelectRunning: No running plans
2019-10-31 05:27:36.3: No pending plans that can be started now.
2019-10-31 05:27:36.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:28:06.9: SelectRunning: No running plans
2019-10-31 05:28:06.9: No pending plans that can be started now.
2019-10-31 05:28:06.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:28:37.5: SelectRunning: No running plans
2019-10-31 05:28:37.5: No pending plans that can be started now.
2019-10-31 05:28:37.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:29:08.1: SelectRunning: No running plans
2019-10-31 05:29:08.1: No pending plans that can be started now.
2019-10-31 05:29:08.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:29:38.7: SelectRunning: No running plans
2019-10-31 05:29:38.7: No pending plans that can be started now.
2019-10-31 05:29:38.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:30:09.3: SelectRunning: No running plans
2019-10-31 05:30:09.3: No pending plans that can be started now.
2019-10-31 05:30:09.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:30:39.9: SelectRunning: No running plans
2019-10-31 05:30:39.9: No pending plans that can be started now.
2019-10-31 05:30:39.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:31:10.4: SelectRunning: No running plans
2019-10-31 05:31:10.4: No pending plans that can be started now.
2019-10-31 05:31:10.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:31:41.0: SelectRunning: No running plans
2019-10-31 05:31:41.0: No pending plans that can be started now.
2019-10-31 05:31:41.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:32:11.8: SelectRunning: No running plans
2019-10-31 05:32:11.8: No pending plans that can be started now.
2019-10-31 05:32:11.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:32:42.4: ++ Auto Focus ++
2019-10-31 05:32:42.4: Doing periodic autofocus.
2019-10-31 05:32:42.4: Start special ACP AutoFocus script for scheduler
2019-10-31 05:32:42.4: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 05:32:42.4:   Script AutoFocusScheduler is loaded, and
2019-10-31 05:32:42.4:   the console is idle.
2019-10-31 05:32:42.4:   In start loop, i = 0
2019-10-31 05:32:42.4:   Console is now idle
2019-10-31 05:32:42.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 05:32:42.5:   Script started successfully
2019-10-31 05:32:52.5: Sequencer is now active
2019-10-31 05:36:20.2: Sequencer is no longer active
2019-10-31 05:36:20.2: ** Autofocus failed (n=4), will retry ASAP after 15 min.
2019-10-31 05:36:20.2: SelectRunning: No running plans
2019-10-31 05:36:20.2: No pending plans that can be started now.
2019-10-31 05:36:20.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:36:50.8: SelectRunning: No running plans
2019-10-31 05:36:50.8: No pending plans that can be started now.
2019-10-31 05:36:50.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:37:21.4: SelectRunning: No running plans
2019-10-31 05:37:21.4: No pending plans that can be started now.
2019-10-31 05:37:21.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:37:52.0: SelectRunning: No running plans
2019-10-31 05:37:52.0: No pending plans that can be started now.
2019-10-31 05:37:52.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:38:22.6: SelectRunning: No running plans
2019-10-31 05:38:22.6: No pending plans that can be started now.
2019-10-31 05:38:22.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:38:53.5: SelectRunning: No running plans
2019-10-31 05:38:53.5: No pending plans that can be started now.
2019-10-31 05:38:53.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:39:24.1: SelectRunning: No running plans
2019-10-31 05:39:24.1: No pending plans that can be started now.
2019-10-31 05:39:24.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:39:54.6: SelectRunning: No running plans
2019-10-31 05:39:54.7: No pending plans that can be started now.
2019-10-31 05:39:54.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:40:25.6: SelectRunning: No running plans
2019-10-31 05:40:25.6: No pending plans that can be started now.
2019-10-31 05:40:25.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:40:56.2: SelectRunning: No running plans
2019-10-31 05:40:56.2: No pending plans that can be started now.
2019-10-31 05:40:56.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:41:26.8: SelectRunning: No running plans
2019-10-31 05:41:26.8: No pending plans that can be started now.
2019-10-31 05:41:26.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:41:57.7: SelectRunning: No running plans
2019-10-31 05:41:57.7: No pending plans that can be started now.
2019-10-31 05:41:57.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:42:28.3: SelectRunning: No running plans
2019-10-31 05:42:28.3: No pending plans that can be started now.
2019-10-31 05:42:28.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:42:58.9: SelectRunning: No running plans
2019-10-31 05:42:58.9: No pending plans that can be started now.
2019-10-31 05:42:58.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:43:29.8: SelectRunning: No running plans
2019-10-31 05:43:29.8: No pending plans that can be started now.
2019-10-31 05:43:29.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:44:00.4: SelectRunning: No running plans
2019-10-31 05:44:00.4: No pending plans that can be started now.
2019-10-31 05:44:00.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:44:31.0: SelectRunning: No running plans
2019-10-31 05:44:31.0: No pending plans that can be started now.
2019-10-31 05:44:31.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:45:01.9: SelectRunning: No running plans
2019-10-31 05:45:01.9: No pending plans that can be started now.
2019-10-31 05:45:01.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:45:32.5: SelectRunning: No running plans
2019-10-31 05:45:32.6: No pending plans that can be started now.
2019-10-31 05:45:32.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:46:03.1: SelectRunning: No running plans
2019-10-31 05:46:03.1: No pending plans that can be started now.
2019-10-31 05:46:03.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:46:34.1: SelectRunning: No running plans
2019-10-31 05:46:34.1: No pending plans that can be started now.
2019-10-31 05:46:34.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:47:04.6: SelectRunning: No running plans
2019-10-31 05:47:04.6: No pending plans that can be started now.
2019-10-31 05:47:04.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:47:35.2: SelectRunning: No running plans
2019-10-31 05:47:35.2: No pending plans that can be started now.
2019-10-31 05:47:35.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:48:05.8: SelectRunning: No running plans
2019-10-31 05:48:05.8: No pending plans that can be started now.
2019-10-31 05:48:05.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:48:36.4: SelectRunning: No running plans
2019-10-31 05:48:36.4: No pending plans that can be started now.
2019-10-31 05:48:36.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:49:07.0: SelectRunning: No running plans
2019-10-31 05:49:07.0: No pending plans that can be started now.
2019-10-31 05:49:07.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:49:37.6: SelectRunning: No running plans
2019-10-31 05:49:37.6: No pending plans that can be started now.
2019-10-31 05:49:37.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:50:08.2: SelectRunning: No running plans
2019-10-31 05:50:08.2: No pending plans that can be started now.
2019-10-31 05:50:08.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:50:38.8: SelectRunning: No running plans
2019-10-31 05:50:38.8: No pending plans that can be started now.
2019-10-31 05:50:38.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:51:09.3: SelectRunning: No running plans
2019-10-31 05:51:09.3: No pending plans that can be started now.
2019-10-31 05:51:09.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:51:39.9: ++ Auto Focus ++
2019-10-31 05:51:39.9: Doing periodic autofocus.
2019-10-31 05:51:39.9: Start special ACP AutoFocus script for scheduler
2019-10-31 05:51:39.9: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 05:51:39.9:   Script AutoFocusScheduler is loaded, and
2019-10-31 05:51:39.9:   the console is idle.
2019-10-31 05:51:39.9:   In start loop, i = 0
2019-10-31 05:51:39.9:   Console is now idle
2019-10-31 05:51:39.9:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 05:51:39.9:   Script started successfully
2019-10-31 05:51:50.0: Sequencer is now active
2019-10-31 05:55:21.0: Sequencer is no longer active
2019-10-31 05:55:21.0: ** Autofocus failed (n=5), will retry ASAP after 20 min.
2019-10-31 05:55:21.0: SelectRunning: No running plans
2019-10-31 05:55:21.0: No pending plans that can be started now.
2019-10-31 05:55:21.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:55:51.6: SelectRunning: No running plans
2019-10-31 05:55:51.6: No pending plans that can be started now.
2019-10-31 05:55:51.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:56:22.2: SelectRunning: No running plans
2019-10-31 05:56:22.2: No pending plans that can be started now.
2019-10-31 05:56:22.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:56:52.8: SelectRunning: No running plans
2019-10-31 05:56:52.8: No pending plans that can be started now.
2019-10-31 05:56:52.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:57:23.4: SelectRunning: No running plans
2019-10-31 05:57:23.4: No pending plans that can be started now.
2019-10-31 05:57:23.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:57:54.0: SelectRunning: No running plans
2019-10-31 05:57:54.0: No pending plans that can be started now.
2019-10-31 05:57:54.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:58:24.6: SelectRunning: No running plans
2019-10-31 05:58:24.6: No pending plans that can be started now.
2019-10-31 05:58:24.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:58:55.1: SelectRunning: No running plans
2019-10-31 05:58:55.1: No pending plans that can be started now.
2019-10-31 05:58:55.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:59:25.7: SelectRunning: No running plans
2019-10-31 05:59:25.7: No pending plans that can be started now.
2019-10-31 05:59:25.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 05:59:56.3: SelectRunning: No running plans
2019-10-31 05:59:56.3: No pending plans that can be started now.
2019-10-31 05:59:56.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:00:26.9: SelectRunning: No running plans
2019-10-31 06:00:26.9: No pending plans that can be started now.
2019-10-31 06:00:26.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:00:57.5: SelectRunning: No running plans
2019-10-31 06:00:57.5: No pending plans that can be started now.
2019-10-31 06:00:57.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:01:28.1: SelectRunning: No running plans
2019-10-31 06:01:28.1: No pending plans that can be started now.
2019-10-31 06:01:28.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:01:58.9: SelectRunning: No running plans
2019-10-31 06:01:58.9: No pending plans that can be started now.
2019-10-31 06:01:58.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:02:29.5: SelectRunning: No running plans
2019-10-31 06:02:29.5: No pending plans that can be started now.
2019-10-31 06:02:29.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:03:00.2: SelectRunning: No running plans
2019-10-31 06:03:00.2: No pending plans that can be started now.
2019-10-31 06:03:00.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:03:31.1: SelectRunning: No running plans
2019-10-31 06:03:31.1: No pending plans that can be started now.
2019-10-31 06:03:31.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:04:01.7: SelectRunning: No running plans
2019-10-31 06:04:01.7: No pending plans that can be started now.
2019-10-31 06:04:01.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:04:32.3: SelectRunning: No running plans
2019-10-31 06:04:32.3: No pending plans that can be started now.
2019-10-31 06:04:32.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:05:02.9: SelectRunning: No running plans
2019-10-31 06:05:02.9: No pending plans that can be started now.
2019-10-31 06:05:02.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:05:33.4: SelectRunning: No running plans
2019-10-31 06:05:33.4: No pending plans that can be started now.
2019-10-31 06:05:33.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:06:04.0: SelectRunning: No running plans
2019-10-31 06:06:04.0: No pending plans that can be started now.
2019-10-31 06:06:04.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:06:34.7: SelectRunning: No running plans
2019-10-31 06:06:34.7: No pending plans that can be started now.
2019-10-31 06:06:34.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:07:05.2: SelectRunning: No running plans
2019-10-31 06:07:05.3: No pending plans that can be started now.
2019-10-31 06:07:05.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:07:35.8: SelectRunning: No running plans
2019-10-31 06:07:35.8: No pending plans that can be started now.
2019-10-31 06:07:35.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:08:06.4: SelectRunning: No running plans
2019-10-31 06:08:06.4: No pending plans that can be started now.
2019-10-31 06:08:06.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:08:37.0: SelectRunning: No running plans
2019-10-31 06:08:37.0: No pending plans that can be started now.
2019-10-31 06:08:37.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:09:07.6: SelectRunning: No running plans
2019-10-31 06:09:07.6: No pending plans that can be started now.
2019-10-31 06:09:07.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:09:38.2: SelectRunning: No running plans
2019-10-31 06:09:38.2: No pending plans that can be started now.
2019-10-31 06:09:38.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:10:08.8: SelectRunning: No running plans
2019-10-31 06:10:08.8: No pending plans that can be started now.
2019-10-31 06:10:08.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:10:39.4: SelectRunning: No running plans
2019-10-31 06:10:39.4: No pending plans that can be started now.
2019-10-31 06:10:39.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:11:10.0: SelectRunning: No running plans
2019-10-31 06:11:10.0: No pending plans that can be started now.
2019-10-31 06:11:10.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:11:40.6: SelectRunning: No running plans
2019-10-31 06:11:40.6: No pending plans that can be started now.
2019-10-31 06:11:40.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:12:11.6: SelectRunning: No running plans
2019-10-31 06:12:11.6: No pending plans that can be started now.
2019-10-31 06:12:11.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:12:42.2: SelectRunning: No running plans
2019-10-31 06:12:42.2: No pending plans that can be started now.
2019-10-31 06:12:42.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:13:12.7: SelectRunning: No running plans
2019-10-31 06:13:12.7: No pending plans that can be started now.
2019-10-31 06:13:12.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:13:43.7: SelectRunning: No running plans
2019-10-31 06:13:43.7: No pending plans that can be started now.
2019-10-31 06:13:43.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:14:14.3: SelectRunning: No running plans
2019-10-31 06:14:14.3: No pending plans that can be started now.
2019-10-31 06:14:14.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:14:44.8: SelectRunning: No running plans
2019-10-31 06:14:44.8: No pending plans that can be started now.
2019-10-31 06:14:44.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:15:15.8: SelectRunning: No running plans
2019-10-31 06:15:15.8: No pending plans that can be started now.
2019-10-31 06:15:15.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:15:46.4: ++ Auto Focus ++
2019-10-31 06:15:46.4: Doing periodic autofocus.
2019-10-31 06:15:46.4: Start special ACP AutoFocus script for scheduler
2019-10-31 06:15:46.4: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 06:15:46.4:   Script AutoFocusScheduler is loaded, and
2019-10-31 06:15:46.4:   the console is idle.
2019-10-31 06:15:46.4:   In start loop, i = 0
2019-10-31 06:15:46.4:   Console is now idle
2019-10-31 06:15:46.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 06:15:46.4:   Script started successfully
2019-10-31 06:15:56.4: Sequencer is now active
2019-10-31 06:19:15.0: Sequencer is no longer active
2019-10-31 06:19:15.0: ** Autofocus failed (n=6), will retry ASAP after 20 min.
2019-10-31 06:19:15.0: SelectRunning: No running plans
2019-10-31 06:19:15.0: No pending plans that can be started now.
2019-10-31 06:19:15.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:19:45.9: SelectRunning: No running plans
2019-10-31 06:19:45.9: No pending plans that can be started now.
2019-10-31 06:19:45.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:20:16.5: SelectRunning: No running plans
2019-10-31 06:20:16.5: No pending plans that can be started now.
2019-10-31 06:20:16.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:20:47.4: SelectRunning: No running plans
2019-10-31 06:20:47.5: No pending plans that can be started now.
2019-10-31 06:20:47.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:21:18.0: SelectRunning: No running plans
2019-10-31 06:21:18.0: No pending plans that can be started now.
2019-10-31 06:21:18.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:21:48.6: SelectRunning: No running plans
2019-10-31 06:21:48.6: No pending plans that can be started now.
2019-10-31 06:21:48.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:22:19.6: SelectRunning: No running plans
2019-10-31 06:22:19.6: No pending plans that can be started now.
2019-10-31 06:22:19.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:22:50.2: SelectRunning: No running plans
2019-10-31 06:22:50.2: No pending plans that can be started now.
2019-10-31 06:22:50.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:23:20.8: SelectRunning: No running plans
2019-10-31 06:23:20.8: No pending plans that can be started now.
2019-10-31 06:23:20.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:23:51.7: SelectRunning: No running plans
2019-10-31 06:23:51.7: No pending plans that can be started now.
2019-10-31 06:23:51.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:24:22.3: SelectRunning: No running plans
2019-10-31 06:24:22.3: No pending plans that can be started now.
2019-10-31 06:24:22.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:24:52.8: SelectRunning: No running plans
2019-10-31 06:24:52.8: No pending plans that can be started now.
2019-10-31 06:24:52.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:25:23.8: SelectRunning: No running plans
2019-10-31 06:25:23.8: No pending plans that can be started now.
2019-10-31 06:25:23.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:25:54.4: SelectRunning: No running plans
2019-10-31 06:25:54.4: No pending plans that can be started now.
2019-10-31 06:25:54.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:26:25.0: SelectRunning: No running plans
2019-10-31 06:26:25.0: No pending plans that can be started now.
2019-10-31 06:26:25.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:26:55.5: SelectRunning: No running plans
2019-10-31 06:26:55.6: No pending plans that can be started now.
2019-10-31 06:26:55.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:27:26.1: SelectRunning: No running plans
2019-10-31 06:27:26.1: No pending plans that can be started now.
2019-10-31 06:27:26.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:27:56.7: SelectRunning: No running plans
2019-10-31 06:27:56.7: No pending plans that can be started now.
2019-10-31 06:27:56.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:28:27.3: SelectRunning: No running plans
2019-10-31 06:28:27.3: No pending plans that can be started now.
2019-10-31 06:28:27.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:28:57.9: SelectRunning: No running plans
2019-10-31 06:28:57.9: No pending plans that can be started now.
2019-10-31 06:28:57.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:29:28.5: SelectRunning: No running plans
2019-10-31 06:29:28.5: No pending plans that can be started now.
2019-10-31 06:29:28.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:29:59.1: SelectRunning: No running plans
2019-10-31 06:29:59.1: No pending plans that can be started now.
2019-10-31 06:29:59.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:30:29.6: SelectRunning: No running plans
2019-10-31 06:30:29.7: No pending plans that can be started now.
2019-10-31 06:30:29.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:31:00.3: SelectRunning: No running plans
2019-10-31 06:31:00.3: No pending plans that can be started now.
2019-10-31 06:31:00.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:31:30.8: SelectRunning: No running plans
2019-10-31 06:31:30.8: No pending plans that can be started now.
2019-10-31 06:31:30.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:32:01.5: SelectRunning: No running plans
2019-10-31 06:32:01.5: No pending plans that can be started now.
2019-10-31 06:32:01.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:32:32.1: SelectRunning: No running plans
2019-10-31 06:32:32.1: No pending plans that can be started now.
2019-10-31 06:32:32.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:33:02.7: SelectRunning: No running plans
2019-10-31 06:33:02.7: No pending plans that can be started now.
2019-10-31 06:33:02.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:33:33.3: SelectRunning: No running plans
2019-10-31 06:33:33.3: No pending plans that can be started now.
2019-10-31 06:33:33.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:34:04.2: SelectRunning: No running plans
2019-10-31 06:34:04.2: No pending plans that can be started now.
2019-10-31 06:34:04.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:34:34.8: SelectRunning: No running plans
2019-10-31 06:34:34.8: No pending plans that can be started now.
2019-10-31 06:34:34.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:35:05.4: SelectRunning: No running plans
2019-10-31 06:35:05.4: No pending plans that can be started now.
2019-10-31 06:35:05.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:35:36.0: SelectRunning: No running plans
2019-10-31 06:35:36.0: No pending plans that can be started now.
2019-10-31 06:35:36.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:36:06.6: SelectRunning: No running plans
2019-10-31 06:36:06.6: No pending plans that can be started now.
2019-10-31 06:36:06.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:36:37.2: SelectRunning: No running plans
2019-10-31 06:36:37.2: No pending plans that can be started now.
2019-10-31 06:36:37.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:37:07.7: SelectRunning: No running plans
2019-10-31 06:37:07.7: No pending plans that can be started now.
2019-10-31 06:37:07.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:37:38.3: SelectRunning: No running plans
2019-10-31 06:37:38.3: No pending plans that can be started now.
2019-10-31 06:37:38.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:38:08.9: SelectRunning: No running plans
2019-10-31 06:38:08.9: No pending plans that can be started now.
2019-10-31 06:38:08.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:38:39.5: SelectRunning: No running plans
2019-10-31 06:38:39.5: No pending plans that can be started now.
2019-10-31 06:38:39.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:39:10.1: SelectRunning: No running plans
2019-10-31 06:39:10.1: No pending plans that can be started now.
2019-10-31 06:39:10.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:39:40.7: ++ Auto Focus ++
2019-10-31 06:39:40.7: Doing periodic autofocus.
2019-10-31 06:39:40.7: Start special ACP AutoFocus script for scheduler
2019-10-31 06:39:40.7: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 06:39:40.7:   Script AutoFocusScheduler is loaded, and
2019-10-31 06:39:40.7:   the console is idle.
2019-10-31 06:39:40.7:   In start loop, i = 0
2019-10-31 06:39:40.7:   Console is now idle
2019-10-31 06:39:40.7:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 06:39:40.7:   Script started successfully
2019-10-31 06:39:50.7: Sequencer is now active
2019-10-31 06:42:57.2: Sequencer is no longer active
2019-10-31 06:42:57.2: ** Autofocus failed (n=7), will retry ASAP after 20 min.
2019-10-31 06:42:57.2: SelectRunning: No running plans
2019-10-31 06:42:57.2: No pending plans that can be started now.
2019-10-31 06:42:57.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:43:27.8: SelectRunning: No running plans
2019-10-31 06:43:27.8: No pending plans that can be started now.
2019-10-31 06:43:27.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:43:58.4: SelectRunning: No running plans
2019-10-31 06:43:58.4: No pending plans that can be started now.
2019-10-31 06:43:58.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:44:29.0: SelectRunning: No running plans
2019-10-31 06:44:29.0: No pending plans that can be started now.
2019-10-31 06:44:29.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:44:59.6: SelectRunning: No running plans
2019-10-31 06:44:59.6: No pending plans that can be started now.
2019-10-31 06:44:59.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:45:30.2: SelectRunning: No running plans
2019-10-31 06:45:30.2: No pending plans that can be started now.
2019-10-31 06:45:30.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:46:00.8: SelectRunning: No running plans
2019-10-31 06:46:00.8: No pending plans that can be started now.
2019-10-31 06:46:00.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:46:31.4: SelectRunning: No running plans
2019-10-31 06:46:31.4: No pending plans that can be started now.
2019-10-31 06:46:31.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:47:02.2: SelectRunning: No running plans
2019-10-31 06:47:02.2: No pending plans that can be started now.
2019-10-31 06:47:02.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:47:32.8: SelectRunning: No running plans
2019-10-31 06:47:32.8: No pending plans that can be started now.
2019-10-31 06:47:32.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:48:03.4: SelectRunning: No running plans
2019-10-31 06:48:03.4: No pending plans that can be started now.
2019-10-31 06:48:03.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:48:34.3: SelectRunning: No running plans
2019-10-31 06:48:34.3: No pending plans that can be started now.
2019-10-31 06:48:34.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:49:04.9: SelectRunning: No running plans
2019-10-31 06:49:04.9: No pending plans that can be started now.
2019-10-31 06:49:04.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:49:35.5: SelectRunning: No running plans
2019-10-31 06:49:35.5: No pending plans that can be started now.
2019-10-31 06:49:35.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:50:06.0: SelectRunning: No running plans
2019-10-31 06:50:06.1: No pending plans that can be started now.
2019-10-31 06:50:06.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:50:36.6: SelectRunning: No running plans
2019-10-31 06:50:36.6: No pending plans that can be started now.
2019-10-31 06:50:36.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:51:07.2: SelectRunning: No running plans
2019-10-31 06:51:07.2: No pending plans that can be started now.
2019-10-31 06:51:07.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:51:37.8: SelectRunning: No running plans
2019-10-31 06:51:37.8: No pending plans that can be started now.
2019-10-31 06:51:37.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:52:08.4: SelectRunning: No running plans
2019-10-31 06:52:08.4: No pending plans that can be started now.
2019-10-31 06:52:08.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:52:39.0: SelectRunning: No running plans
2019-10-31 06:52:39.0: No pending plans that can be started now.
2019-10-31 06:52:39.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:53:09.6: SelectRunning: No running plans
2019-10-31 06:53:09.6: No pending plans that can be started now.
2019-10-31 06:53:09.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:53:40.2: SelectRunning: No running plans
2019-10-31 06:53:40.2: No pending plans that can be started now.
2019-10-31 06:53:40.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:54:10.8: SelectRunning: No running plans
2019-10-31 06:54:10.8: No pending plans that can be started now.
2019-10-31 06:54:10.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:54:41.4: SelectRunning: No running plans
2019-10-31 06:54:41.4: No pending plans that can be started now.
2019-10-31 06:54:41.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:55:11.9: SelectRunning: No running plans
2019-10-31 06:55:12.0: No pending plans that can be started now.
2019-10-31 06:55:12.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:55:42.6: SelectRunning: No running plans
2019-10-31 06:55:42.6: No pending plans that can be started now.
2019-10-31 06:55:42.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:56:13.2: SelectRunning: No running plans
2019-10-31 06:56:13.2: No pending plans that can be started now.
2019-10-31 06:56:13.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:56:43.8: SelectRunning: No running plans
2019-10-31 06:56:43.8: No pending plans that can be started now.
2019-10-31 06:56:43.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:57:14.4: SelectRunning: No running plans
2019-10-31 06:57:14.4: No pending plans that can be started now.
2019-10-31 06:57:14.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:57:45.0: SelectRunning: No running plans
2019-10-31 06:57:45.0: No pending plans that can be started now.
2019-10-31 06:57:45.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:58:15.6: SelectRunning: No running plans
2019-10-31 06:58:15.6: No pending plans that can be started now.
2019-10-31 06:58:15.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:58:46.1: SelectRunning: No running plans
2019-10-31 06:58:46.1: No pending plans that can be started now.
2019-10-31 06:58:46.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:59:16.7: SelectRunning: No running plans
2019-10-31 06:59:16.8: No pending plans that can be started now.
2019-10-31 06:59:16.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 06:59:47.3: SelectRunning: No running plans
2019-10-31 06:59:47.3: No pending plans that can be started now.
2019-10-31 06:59:47.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:00:17.9: SelectRunning: No running plans
2019-10-31 07:00:17.9: No pending plans that can be started now.
2019-10-31 07:00:17.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:00:48.5: SelectRunning: No running plans
2019-10-31 07:00:48.5: No pending plans that can be started now.
2019-10-31 07:00:48.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:01:19.1: SelectRunning: No running plans
2019-10-31 07:01:19.1: No pending plans that can be started now.
2019-10-31 07:01:19.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:01:49.7: SelectRunning: No running plans
2019-10-31 07:01:49.7: No pending plans that can be started now.
2019-10-31 07:01:49.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:02:20.3: SelectRunning: No running plans
2019-10-31 07:02:20.3: No pending plans that can be started now.
2019-10-31 07:02:20.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:02:51.0: SelectRunning: No running plans
2019-10-31 07:02:51.0: No pending plans that can be started now.
2019-10-31 07:02:51.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:03:21.6: ++ Auto Focus ++
2019-10-31 07:03:21.6: Doing periodic autofocus.
2019-10-31 07:03:21.6: Start special ACP AutoFocus script for scheduler
2019-10-31 07:03:21.6: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 07:03:21.6:   Script AutoFocusScheduler is loaded, and
2019-10-31 07:03:21.6:   the console is idle.
2019-10-31 07:03:21.6:   In start loop, i = 0
2019-10-31 07:03:21.6:   Console is now idle
2019-10-31 07:03:21.6:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 07:03:21.6:   Script started successfully
2019-10-31 07:03:31.6: Sequencer is now active
2019-10-31 07:06:35.8: Sequencer is no longer active
2019-10-31 07:06:35.8: ** Autofocus failed (n=8), will retry ASAP after 20 min.
2019-10-31 07:06:35.8: SelectRunning: No running plans
2019-10-31 07:06:35.8: No pending plans that can be started now.
2019-10-31 07:06:35.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:07:06.4: SelectRunning: No running plans
2019-10-31 07:07:06.4: No pending plans that can be started now.
2019-10-31 07:07:06.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:07:37.0: SelectRunning: No running plans
2019-10-31 07:07:37.0: No pending plans that can be started now.
2019-10-31 07:07:37.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:08:07.9: SelectRunning: No running plans
2019-10-31 07:08:07.9: No pending plans that can be started now.
2019-10-31 07:08:07.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:08:38.5: SelectRunning: No running plans
2019-10-31 07:08:38.5: No pending plans that can be started now.
2019-10-31 07:08:38.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:09:09.1: SelectRunning: No running plans
2019-10-31 07:09:09.1: Obs KH15D in Plan KH15D was vetoed by HourAngle constraint.
2019-10-31 07:09:09.1:     HourAngle estimates ready after 31-Oct-2019 08:40:46 UTC
2019-10-31 07:09:09.1: Obs KH15D-B in Plan KH15D-B was vetoed by HourAngle constraint.
2019-10-31 07:09:09.1:     HourAngle estimates ready after 31-Oct-2019 09:40:36 UTC
2019-10-31 07:09:09.1: No pending plans that can be started now.
2019-10-31 07:09:09.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:09:40.0: SelectRunning: No running plans
2019-10-31 07:09:40.0: No pending plans that can be started now.
2019-10-31 07:09:40.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:10:10.6: SelectRunning: No running plans
2019-10-31 07:10:10.6: No pending plans that can be started now.
2019-10-31 07:10:10.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:10:41.2: SelectRunning: No running plans
2019-10-31 07:10:41.2: No pending plans that can be started now.
2019-10-31 07:10:41.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:11:12.1: SelectRunning: No running plans
2019-10-31 07:11:12.1: No pending plans that can be started now.
2019-10-31 07:11:12.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:11:42.7: SelectRunning: No running plans
2019-10-31 07:11:42.7: No pending plans that can be started now.
2019-10-31 07:11:42.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:12:13.3: SelectRunning: No running plans
2019-10-31 07:12:13.3: No pending plans that can be started now.
2019-10-31 07:12:13.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:12:44.2: SelectRunning: No running plans
2019-10-31 07:12:44.2: No pending plans that can be started now.
2019-10-31 07:12:44.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:13:14.8: SelectRunning: No running plans
2019-10-31 07:13:14.8: No pending plans that can be started now.
2019-10-31 07:13:14.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:13:45.4: SelectRunning: No running plans
2019-10-31 07:13:45.4: No pending plans that can be started now.
2019-10-31 07:13:45.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:14:16.3: SelectRunning: No running plans
2019-10-31 07:14:16.3: No pending plans that can be started now.
2019-10-31 07:14:16.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:14:47.0: SelectRunning: No running plans
2019-10-31 07:14:47.0: No pending plans that can be started now.
2019-10-31 07:14:47.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:15:17.5: SelectRunning: No running plans
2019-10-31 07:15:17.5: No pending plans that can be started now.
2019-10-31 07:15:17.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:15:48.5: SelectRunning: No running plans
2019-10-31 07:15:48.5: No pending plans that can be started now.
2019-10-31 07:15:48.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:16:19.1: SelectRunning: No running plans
2019-10-31 07:16:19.1: No pending plans that can be started now.
2019-10-31 07:16:19.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:16:49.6: SelectRunning: No running plans
2019-10-31 07:16:49.6: No pending plans that can be started now.
2019-10-31 07:16:49.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:17:20.2: SelectRunning: No running plans
2019-10-31 07:17:20.2: No pending plans that can be started now.
2019-10-31 07:17:20.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:17:50.8: SelectRunning: No running plans
2019-10-31 07:17:50.8: No pending plans that can be started now.
2019-10-31 07:17:50.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:18:21.4: SelectRunning: No running plans
2019-10-31 07:18:21.4: No pending plans that can be started now.
2019-10-31 07:18:21.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:18:52.0: SelectRunning: No running plans
2019-10-31 07:18:52.0: No pending plans that can be started now.
2019-10-31 07:18:52.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:19:22.6: SelectRunning: No running plans
2019-10-31 07:19:22.6: No pending plans that can be started now.
2019-10-31 07:19:22.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:19:53.2: SelectRunning: No running plans
2019-10-31 07:19:53.2: No pending plans that can be started now.
2019-10-31 07:19:53.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:20:23.7: SelectRunning: No running plans
2019-10-31 07:20:23.7: No pending plans that can be started now.
2019-10-31 07:20:23.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:20:54.3: SelectRunning: No running plans
2019-10-31 07:20:54.3: No pending plans that can be started now.
2019-10-31 07:20:54.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:21:24.9: SelectRunning: No running plans
2019-10-31 07:21:24.9: No pending plans that can be started now.
2019-10-31 07:21:24.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:21:55.5: SelectRunning: No running plans
2019-10-31 07:21:55.5: No pending plans that can be started now.
2019-10-31 07:21:55.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:22:26.1: SelectRunning: No running plans
2019-10-31 07:22:26.1: No pending plans that can be started now.
2019-10-31 07:22:26.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:22:56.8: SelectRunning: No running plans
2019-10-31 07:22:56.8: No pending plans that can be started now.
2019-10-31 07:22:56.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:23:27.4: SelectRunning: No running plans
2019-10-31 07:23:27.4: No pending plans that can be started now.
2019-10-31 07:23:27.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:23:58.0: SelectRunning: No running plans
2019-10-31 07:23:58.0: No pending plans that can be started now.
2019-10-31 07:23:58.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:24:28.9: SelectRunning: No running plans
2019-10-31 07:24:28.9: No pending plans that can be started now.
2019-10-31 07:24:28.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:24:59.5: SelectRunning: No running plans
2019-10-31 07:24:59.5: No pending plans that can be started now.
2019-10-31 07:24:59.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:25:30.1: SelectRunning: No running plans
2019-10-31 07:25:30.1: No pending plans that can be started now.
2019-10-31 07:25:30.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:26:01.1: SelectRunning: No running plans
2019-10-31 07:26:01.1: No pending plans that can be started now.
2019-10-31 07:26:01.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:26:31.6: SelectRunning: No running plans
2019-10-31 07:26:31.6: No pending plans that can be started now.
2019-10-31 07:26:31.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:27:02.2: ++ Auto Focus ++
2019-10-31 07:27:02.3: Doing periodic autofocus.
2019-10-31 07:27:02.3: Start special ACP AutoFocus script for scheduler
2019-10-31 07:27:02.3: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 07:27:02.3:   Script AutoFocusScheduler is loaded, and
2019-10-31 07:27:02.3:   the console is idle.
2019-10-31 07:27:02.3:   In start loop, i = 0
2019-10-31 07:27:02.3:   Console is now idle
2019-10-31 07:27:02.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 07:27:02.3:   Script started successfully
2019-10-31 07:27:12.3: Sequencer is now active
2019-10-31 07:30:38.2: Sequencer is no longer active
2019-10-31 07:30:38.2: ** Autofocus failed (n=9), will retry ASAP after 20 min.
2019-10-31 07:30:38.2: SelectRunning: No running plans
2019-10-31 07:30:38.2: No pending plans that can be started now.
2019-10-31 07:30:38.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:31:08.8: SelectRunning: No running plans
2019-10-31 07:31:08.8: No pending plans that can be started now.
2019-10-31 07:31:08.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:31:39.4: SelectRunning: No running plans
2019-10-31 07:31:39.4: No pending plans that can be started now.
2019-10-31 07:31:39.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:32:10.0: SelectRunning: No running plans
2019-10-31 07:32:10.0: No pending plans that can be started now.
2019-10-31 07:32:10.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:32:40.6: SelectRunning: No running plans
2019-10-31 07:32:40.6: No pending plans that can be started now.
2019-10-31 07:32:40.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:33:11.2: SelectRunning: No running plans
2019-10-31 07:33:11.2: No pending plans that can be started now.
2019-10-31 07:33:11.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:33:41.8: SelectRunning: No running plans
2019-10-31 07:33:41.8: No pending plans that can be started now.
2019-10-31 07:33:41.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:34:12.4: SelectRunning: No running plans
2019-10-31 07:34:12.4: No pending plans that can be started now.
2019-10-31 07:34:12.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:34:43.3: SelectRunning: No running plans
2019-10-31 07:34:43.3: No pending plans that can be started now.
2019-10-31 07:34:43.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:35:14.0: SelectRunning: No running plans
2019-10-31 07:35:14.0: No pending plans that can be started now.
2019-10-31 07:35:14.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:35:44.6: SelectRunning: No running plans
2019-10-31 07:35:44.6: No pending plans that can be started now.
2019-10-31 07:35:44.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:36:15.5: SelectRunning: No running plans
2019-10-31 07:36:15.5: No pending plans that can be started now.
2019-10-31 07:36:15.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:36:46.1: SelectRunning: No running plans
2019-10-31 07:36:46.1: No pending plans that can be started now.
2019-10-31 07:36:46.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:37:16.7: SelectRunning: No running plans
2019-10-31 07:37:16.7: No pending plans that can be started now.
2019-10-31 07:37:16.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:37:47.3: SelectRunning: No running plans
2019-10-31 07:37:47.3: No pending plans that can be started now.
2019-10-31 07:37:47.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:38:17.8: SelectRunning: No running plans
2019-10-31 07:38:17.9: No pending plans that can be started now.
2019-10-31 07:38:17.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:38:48.4: SelectRunning: No running plans
2019-10-31 07:38:48.4: No pending plans that can be started now.
2019-10-31 07:38:48.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:39:19.0: SelectRunning: No running plans
2019-10-31 07:39:19.1: No pending plans that can be started now.
2019-10-31 07:39:19.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:39:49.6: SelectRunning: No running plans
2019-10-31 07:39:49.6: No pending plans that can be started now.
2019-10-31 07:39:49.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:40:20.2: SelectRunning: No running plans
2019-10-31 07:40:20.2: No pending plans that can be started now.
2019-10-31 07:40:20.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:40:50.8: SelectRunning: No running plans
2019-10-31 07:40:50.8: No pending plans that can be started now.
2019-10-31 07:40:50.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:41:21.4: SelectRunning: No running plans
2019-10-31 07:41:21.4: No pending plans that can be started now.
2019-10-31 07:41:21.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:41:52.0: SelectRunning: No running plans
2019-10-31 07:41:52.0: No pending plans that can be started now.
2019-10-31 07:41:52.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:42:22.6: SelectRunning: No running plans
2019-10-31 07:42:22.6: No pending plans that can be started now.
2019-10-31 07:42:22.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:42:53.2: SelectRunning: No running plans
2019-10-31 07:42:53.2: No pending plans that can be started now.
2019-10-31 07:42:53.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:43:23.8: SelectRunning: No running plans
2019-10-31 07:43:23.8: No pending plans that can be started now.
2019-10-31 07:43:23.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:43:54.4: SelectRunning: No running plans
2019-10-31 07:43:54.4: No pending plans that can be started now.
2019-10-31 07:43:54.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:44:25.0: SelectRunning: No running plans
2019-10-31 07:44:25.0: No pending plans that can be started now.
2019-10-31 07:44:25.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:44:55.9: SelectRunning: No running plans
2019-10-31 07:44:56.0: No pending plans that can be started now.
2019-10-31 07:44:56.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:45:26.5: SelectRunning: No running plans
2019-10-31 07:45:26.5: No pending plans that can be started now.
2019-10-31 07:45:26.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:45:57.1: SelectRunning: No running plans
2019-10-31 07:45:57.1: No pending plans that can be started now.
2019-10-31 07:45:57.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:46:27.7: SelectRunning: No running plans
2019-10-31 07:46:27.7: No pending plans that can be started now.
2019-10-31 07:46:27.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:46:58.3: SelectRunning: No running plans
2019-10-31 07:46:58.3: No pending plans that can be started now.
2019-10-31 07:46:58.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:47:28.9: SelectRunning: No running plans
2019-10-31 07:47:28.9: No pending plans that can be started now.
2019-10-31 07:47:28.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:47:59.4: SelectRunning: No running plans
2019-10-31 07:47:59.4: No pending plans that can be started now.
2019-10-31 07:47:59.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:48:30.0: SelectRunning: No running plans
2019-10-31 07:48:30.0: No pending plans that can be started now.
2019-10-31 07:48:30.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:49:00.6: SelectRunning: No running plans
2019-10-31 07:49:00.6: No pending plans that can be started now.
2019-10-31 07:49:00.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:49:31.2: SelectRunning: No running plans
2019-10-31 07:49:31.2: No pending plans that can be started now.
2019-10-31 07:49:31.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:50:01.8: SelectRunning: No running plans
2019-10-31 07:50:01.8: No pending plans that can be started now.
2019-10-31 07:50:01.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:50:32.4: SelectRunning: No running plans
2019-10-31 07:50:32.4: No pending plans that can be started now.
2019-10-31 07:50:32.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:51:03.0: ++ Auto Focus ++
2019-10-31 07:51:03.0: Doing periodic autofocus.
2019-10-31 07:51:03.0: Start special ACP AutoFocus script for scheduler
2019-10-31 07:51:03.0: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 07:51:03.0:   Script AutoFocusScheduler is loaded, and
2019-10-31 07:51:03.0:   the console is idle.
2019-10-31 07:51:03.0:   In start loop, i = 0
2019-10-31 07:51:03.0:   Console is now idle
2019-10-31 07:51:03.0:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 07:51:03.0:   Script started successfully
2019-10-31 07:51:13.0: Sequencer is now active
2019-10-31 07:54:58.0: Sequencer is no longer active
2019-10-31 07:54:58.0: ** Autofocus failed (n=10), will retry ASAP after 20 min.
2019-10-31 07:54:58.0: SelectRunning: No running plans
2019-10-31 07:54:58.0: No pending plans that can be started now.
2019-10-31 07:54:58.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:55:28.6: SelectRunning: No running plans
2019-10-31 07:55:28.6: No pending plans that can be started now.
2019-10-31 07:55:28.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:55:59.2: SelectRunning: No running plans
2019-10-31 07:55:59.2: No pending plans that can be started now.
2019-10-31 07:55:59.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:56:29.8: SelectRunning: No running plans
2019-10-31 07:56:29.8: No pending plans that can be started now.
2019-10-31 07:56:29.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:57:00.3: SelectRunning: No running plans
2019-10-31 07:57:00.4: No pending plans that can be started now.
2019-10-31 07:57:00.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:57:31.3: SelectRunning: No running plans
2019-10-31 07:57:31.3: No pending plans that can be started now.
2019-10-31 07:57:31.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:58:01.9: SelectRunning: No running plans
2019-10-31 07:58:01.9: No pending plans that can be started now.
2019-10-31 07:58:01.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:58:32.5: SelectRunning: No running plans
2019-10-31 07:58:32.5: No pending plans that can be started now.
2019-10-31 07:58:32.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:59:03.4: SelectRunning: No running plans
2019-10-31 07:59:03.4: No pending plans that can be started now.
2019-10-31 07:59:03.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 07:59:34.0: SelectRunning: No running plans
2019-10-31 07:59:34.0: No pending plans that can be started now.
2019-10-31 07:59:34.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:00:04.6: SelectRunning: No running plans
2019-10-31 08:00:04.6: No pending plans that can be started now.
2019-10-31 08:00:04.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:00:35.2: SelectRunning: No running plans
2019-10-31 08:00:35.2: No pending plans that can be started now.
2019-10-31 08:00:35.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:01:05.8: SelectRunning: No running plans
2019-10-31 08:01:05.8: No pending plans that can be started now.
2019-10-31 08:01:05.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:01:36.4: SelectRunning: No running plans
2019-10-31 08:01:36.4: No pending plans that can be started now.
2019-10-31 08:01:36.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:02:06.9: SelectRunning: No running plans
2019-10-31 08:02:06.9: No pending plans that can be started now.
2019-10-31 08:02:06.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:02:37.5: SelectRunning: No running plans
2019-10-31 08:02:37.5: No pending plans that can be started now.
2019-10-31 08:02:37.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:03:08.1: SelectRunning: No running plans
2019-10-31 08:03:08.1: No pending plans that can be started now.
2019-10-31 08:03:08.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:03:38.7: SelectRunning: No running plans
2019-10-31 08:03:38.7: No pending plans that can be started now.
2019-10-31 08:03:38.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:04:09.3: SelectRunning: No running plans
2019-10-31 08:04:09.3: No pending plans that can be started now.
2019-10-31 08:04:09.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:04:39.8: SelectRunning: No running plans
2019-10-31 08:04:39.9: No pending plans that can be started now.
2019-10-31 08:04:39.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:05:10.5: SelectRunning: No running plans
2019-10-31 08:05:10.5: No pending plans that can be started now.
2019-10-31 08:05:10.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:05:41.0: SelectRunning: No running plans
2019-10-31 08:05:41.0: No pending plans that can be started now.
2019-10-31 08:05:41.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:06:11.8: SelectRunning: No running plans
2019-10-31 08:06:11.8: No pending plans that can be started now.
2019-10-31 08:06:11.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:06:42.3: SelectRunning: No running plans
2019-10-31 08:06:42.3: No pending plans that can be started now.
2019-10-31 08:06:42.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:07:12.9: SelectRunning: No running plans
2019-10-31 08:07:12.9: No pending plans that can be started now.
2019-10-31 08:07:12.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:07:43.5: SelectRunning: No running plans
2019-10-31 08:07:43.5: No pending plans that can be started now.
2019-10-31 08:07:43.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:08:14.1: SelectRunning: No running plans
2019-10-31 08:08:14.1: No pending plans that can be started now.
2019-10-31 08:08:14.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:08:44.7: SelectRunning: No running plans
2019-10-31 08:08:44.7: No pending plans that can be started now.
2019-10-31 08:08:44.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:09:15.2: SelectRunning: No running plans
2019-10-31 08:09:15.3: No pending plans that can be started now.
2019-10-31 08:09:15.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:09:45.8: SelectRunning: No running plans
2019-10-31 08:09:45.8: No pending plans that can be started now.
2019-10-31 08:09:45.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:10:16.4: SelectRunning: No running plans
2019-10-31 08:10:16.4: No pending plans that can be started now.
2019-10-31 08:10:16.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:10:47.0: SelectRunning: No running plans
2019-10-31 08:10:47.0: No pending plans that can be started now.
2019-10-31 08:10:47.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:11:17.6: SelectRunning: No running plans
2019-10-31 08:11:17.6: No pending plans that can be started now.
2019-10-31 08:11:17.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:11:48.2: SelectRunning: No running plans
2019-10-31 08:11:48.2: No pending plans that can be started now.
2019-10-31 08:11:48.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:12:18.8: SelectRunning: No running plans
2019-10-31 08:12:18.8: No pending plans that can be started now.
2019-10-31 08:12:18.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:12:49.4: SelectRunning: No running plans
2019-10-31 08:12:49.4: No pending plans that can be started now.
2019-10-31 08:12:49.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:13:20.1: SelectRunning: No running plans
2019-10-31 08:13:20.1: No pending plans that can be started now.
2019-10-31 08:13:20.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:13:50.7: SelectRunning: No running plans
2019-10-31 08:13:50.7: No pending plans that can be started now.
2019-10-31 08:13:50.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:14:21.3: SelectRunning: No running plans
2019-10-31 08:14:21.3: No pending plans that can be started now.
2019-10-31 08:14:21.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:14:52.2: SelectRunning: No running plans
2019-10-31 08:14:52.2: No pending plans that can be started now.
2019-10-31 08:14:52.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:15:22.8: ++ Auto Focus ++
2019-10-31 08:15:22.8: Doing periodic autofocus.
2019-10-31 08:15:22.8: Start special ACP AutoFocus script for scheduler
2019-10-31 08:15:22.8: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 08:15:22.8:   Script AutoFocusScheduler is loaded, and
2019-10-31 08:15:22.8:   the console is idle.
2019-10-31 08:15:22.8:   In start loop, i = 0
2019-10-31 08:15:22.8:   Console is now idle
2019-10-31 08:15:22.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 08:15:22.8:   Script started successfully
2019-10-31 08:15:32.8: Sequencer is now active
2019-10-31 08:19:00.2: Sequencer is no longer active
2019-10-31 08:19:00.2: ** Autofocus failed (n=11), will retry ASAP after 20 min.
2019-10-31 08:19:00.2: SelectRunning: No running plans
2019-10-31 08:19:00.2: No pending plans that can be started now.
2019-10-31 08:19:00.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:19:30.7: SelectRunning: No running plans
2019-10-31 08:19:30.7: No pending plans that can be started now.
2019-10-31 08:19:30.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:20:01.3: SelectRunning: No running plans
2019-10-31 08:20:01.3: No pending plans that can be started now.
2019-10-31 08:20:01.3: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:20:31.9: SelectRunning: No running plans
2019-10-31 08:20:31.9: No pending plans that can be started now.
2019-10-31 08:20:31.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:21:02.5: SelectRunning: No running plans
2019-10-31 08:21:02.5: No pending plans that can be started now.
2019-10-31 08:21:02.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:21:33.1: SelectRunning: No running plans
2019-10-31 08:21:33.1: No pending plans that can be started now.
2019-10-31 08:21:33.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 08:22:08.9: -- Weather Unsafe --
2019-10-31 08:42:04.9: ++ Weather Safe ++
2019-10-31 08:42:06.0: ++ Observatory Startup ++
2019-10-31 08:42:06.0: Startup attempted, but no StartupObs script found
2019-10-31 08:42:06.0: Open the observatory dome/roof
2019-10-31 08:43:21.7: Observatory startup succeeded, and dome opened successfully
2019-10-31 08:43:21.7: ++ Auto Focus ++
2019-10-31 08:43:21.8: Doing initial autofocus.
2019-10-31 08:43:21.8: Start special ACP AutoFocus script for scheduler
2019-10-31 08:43:21.8: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 08:43:21.8:   Script ACP-Weather is loaded, and
2019-10-31 08:43:21.8:   the console is idle.
2019-10-31 08:43:21.8:   In start loop, i = 0
2019-10-31 08:43:21.8:   Console is now idle
2019-10-31 08:43:21.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 08:43:21.8:   Script started successfully
2019-10-31 08:43:31.8: Sequencer is now active
2019-10-31 08:48:13.9: Sequencer is no longer active
2019-10-31 08:48:13.9: ** Autofocus failed (n=12), will retry ASAP after 20 min.
2019-10-31 08:48:13.9: SelectRunning: No running plans
2019-10-31 08:48:13.9: Efficiency: Only one pending plan KH15D, it is the "best"
2019-10-31 08:48:14.0: Dispatcher cycle time: 0.1 sec.
2019-10-31 08:48:14.0: Acquire data for Observation KH15D...
2019-10-31 08:48:14.0:   (belongs to Project KH15D, Plan KH15D)
2019-10-31 08:48:14.0: Send Observation KH15D to ACP Sequencer
2019-10-31 08:48:14.0: ACP.RunScript(AcquireScheduler, ):
2019-10-31 08:48:14.0:   Script AutoFocusScheduler is loaded, and
2019-10-31 08:48:14.0:   the console is idle.
2019-10-31 08:48:14.0:   In start loop, i = 0
2019-10-31 08:48:14.0:   Console is now idle
2019-10-31 08:48:14.1:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2019-10-31 08:48:14.1:   Script started successfully
2019-10-31 08:48:24.2: Sequencer is now active
2019-10-31 09:56:41.9: Sequencer is no longer active
2019-10-31 09:56:41.9: Post-job status check done (stat=Completed)
2019-10-31 09:56:41.9: Acquisition time: 4107.8612652 sec.
2019-10-31 09:56:41.9: Data for Observation KH15D of Plan KH15D acquired successfully.
2019-10-31 09:56:41.9: Plan KH15D completed successfully.
2019-10-31 09:56:41.9: Image Efficiency: 87.6%
2019-10-31 09:56:41.9: Cycle Efficiency: 100.0%
2019-10-31 09:56:42.0: ++ Auto Focus ++
2019-10-31 09:56:42.1: Doing periodic autofocus.
2019-10-31 09:56:42.1: Start special ACP AutoFocus script for scheduler
2019-10-31 09:56:42.1: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 09:56:42.1:   Script AcquireScheduler is loaded, and
2019-10-31 09:56:42.1:   the console is idle.
2019-10-31 09:56:42.1:   In start loop, i = 0
2019-10-31 09:56:42.1:   Console is now idle
2019-10-31 09:56:42.1:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 09:56:42.1:   Script started successfully
2019-10-31 09:56:52.1: Sequencer is now active
2019-10-31 10:01:08.9: Sequencer is no longer active
2019-10-31 10:01:08.9: Next periodic autofocus ASAP after 3600sec. 31-Oct-2019 11:00:50 UTC
2019-10-31 10:01:08.9: SelectRunning: No running plans
2019-10-31 10:01:08.9: Efficiency: Only one pending plan KH15D-B, it is the "best"
2019-10-31 10:01:09.0: Dispatcher cycle time: 0.1 sec.
2019-10-31 10:01:09.0: Acquire data for Observation KH15D-B...
2019-10-31 10:01:09.0:   (belongs to Project KH15D, Plan KH15D-B)
2019-10-31 10:01:09.0: Send Observation KH15D-B to ACP Sequencer
2019-10-31 10:01:09.0: ACP.RunScript(AcquireScheduler, ):
2019-10-31 10:01:09.0:   Script AutoFocusScheduler is loaded, and
2019-10-31 10:01:09.0:   the console is idle.
2019-10-31 10:01:09.0:   In start loop, i = 0
2019-10-31 10:01:09.0:   Console is now idle
2019-10-31 10:01:09.0:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2019-10-31 10:01:09.0:   Script started successfully
2019-10-31 10:01:19.0: Sequencer is now active
2019-10-31 11:11:24.1: Sequencer is no longer active
2019-10-31 11:11:24.1: Post-job status check done (stat=Completed)
2019-10-31 11:11:24.1: Observation had successful requested AF, defer next periodic AF:
2019-10-31 11:11:24.1: Next periodic AF will be ASAP after 3600sec. 31-Oct-2019 11:05:14 UTC
2019-10-31 11:11:24.1: Acquisition time: 4215.1203999 sec.
2019-10-31 11:11:24.1: Data for Observation KH15D-B of Plan KH15D-B acquired successfully.
2019-10-31 11:11:24.2: Plan KH15D-B completed successfully.
2019-10-31 11:11:24.2: Image Efficiency: 85.4%
2019-10-31 11:11:24.2: Cycle Efficiency: 100.0%
2019-10-31 11:11:24.3: ++ Auto Focus ++
2019-10-31 11:11:24.3: Doing periodic autofocus.
2019-10-31 11:11:24.3: Start special ACP AutoFocus script for scheduler
2019-10-31 11:11:24.3: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 11:11:24.3:   Script AcquireScheduler is loaded, and
2019-10-31 11:11:24.3:   the console is idle.
2019-10-31 11:11:24.3:   In start loop, i = 0
2019-10-31 11:11:24.3:   Console is now idle
2019-10-31 11:11:24.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 11:11:24.4:   Script started successfully
2019-10-31 11:11:34.4: Sequencer is now active
2019-10-31 11:15:50.6: Sequencer is no longer active
2019-10-31 11:15:50.6: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2019-10-31 11:15:50.6: SelectRunning: No running plans
2019-10-31 11:15:50.6: No pending plans that can be started now.
2019-10-31 11:15:50.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:16:21.2: ++ Auto Focus ++
2019-10-31 11:16:21.2: Doing periodic autofocus.
2019-10-31 11:16:21.2: Start special ACP AutoFocus script for scheduler
2019-10-31 11:16:21.2: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 11:16:21.2:   Script AutoFocusScheduler is loaded, and
2019-10-31 11:16:21.2:   the console is idle.
2019-10-31 11:16:21.2:   In start loop, i = 0
2019-10-31 11:16:21.2:   Console is now idle
2019-10-31 11:16:21.2:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 11:16:21.2:   Script started successfully
2019-10-31 11:16:31.2: Sequencer is now active
2019-10-31 11:19:41.4: Sequencer is no longer active
2019-10-31 11:19:41.4: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2019-10-31 11:19:41.4: SelectRunning: No running plans
2019-10-31 11:19:41.4: No pending plans that can be started now.
2019-10-31 11:19:41.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:20:12.0: SelectRunning: No running plans
2019-10-31 11:20:12.0: No pending plans that can be started now.
2019-10-31 11:20:12.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:20:42.6: SelectRunning: No running plans
2019-10-31 11:20:42.6: No pending plans that can be started now.
2019-10-31 11:20:42.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:21:13.5: SelectRunning: No running plans
2019-10-31 11:21:13.5: No pending plans that can be started now.
2019-10-31 11:21:13.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:21:44.1: SelectRunning: No running plans
2019-10-31 11:21:44.1: No pending plans that can be started now.
2019-10-31 11:21:44.1: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:22:14.6: SelectRunning: No running plans
2019-10-31 11:22:14.6: No pending plans that can be started now.
2019-10-31 11:22:14.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:22:45.2: SelectRunning: No running plans
2019-10-31 11:22:45.2: No pending plans that can be started now.
2019-10-31 11:22:45.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:23:15.8: SelectRunning: No running plans
2019-10-31 11:23:15.8: No pending plans that can be started now.
2019-10-31 11:23:15.8: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:23:46.4: SelectRunning: No running plans
2019-10-31 11:23:46.4: No pending plans that can be started now.
2019-10-31 11:23:46.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:24:17.0: SelectRunning: No running plans
2019-10-31 11:24:17.0: No pending plans that can be started now.
2019-10-31 11:24:17.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:24:47.6: ++ Auto Focus ++
2019-10-31 11:24:47.6: Doing periodic autofocus.
2019-10-31 11:24:47.6: Start special ACP AutoFocus script for scheduler
2019-10-31 11:24:47.6: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 11:24:47.6:   Script AutoFocusScheduler is loaded, and
2019-10-31 11:24:47.6:   the console is idle.
2019-10-31 11:24:47.6:   In start loop, i = 0
2019-10-31 11:24:47.6:   Console is now idle
2019-10-31 11:24:47.6:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 11:24:47.6:   Script started successfully
2019-10-31 11:24:57.7: Sequencer is now active
2019-10-31 11:24:58.8: ** Script interrupted by weather safety event.
2019-10-31 11:26:17.4: Sequencer is no longer active
2019-10-31 11:26:17.4: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2019-10-31 11:26:17.4: -- Weather Unsafe --
2019-10-31 11:45:10.6: ++ Weather Safe ++
2019-10-31 11:45:11.6: ++ Observatory Startup ++
2019-10-31 11:45:11.6: Startup attempted, but no StartupObs script found
2019-10-31 11:45:11.6: Open the observatory dome/roof
2019-10-31 11:46:27.4: Observatory startup succeeded, and dome opened successfully
2019-10-31 11:46:27.4: ++ Auto Focus ++
2019-10-31 11:46:27.4: Doing initial autofocus.
2019-10-31 11:46:27.4: Start special ACP AutoFocus script for scheduler
2019-10-31 11:46:27.4: ACP.RunScript(AutoFocusScheduler, ):
2019-10-31 11:46:27.4:   Script ACP-Weather is loaded, and
2019-10-31 11:46:27.4:   the console is idle.
2019-10-31 11:46:27.4:   In start loop, i = 0
2019-10-31 11:46:27.4:   Console is now idle
2019-10-31 11:46:27.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-31 11:46:27.4:   Script started successfully
2019-10-31 11:46:37.5: Sequencer is now active
2019-10-31 11:50:57.5: Sequencer is no longer active
2019-10-31 11:50:57.5: ** Autofocus failed (n=4), will retry ASAP after 15 min.
2019-10-31 11:50:57.5: SelectRunning: No running plans
2019-10-31 11:50:57.5: No pending plans that can be started now.
2019-10-31 11:50:57.5: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:51:28.4: SelectRunning: No running plans
2019-10-31 11:51:28.4: No pending plans that can be started now.
2019-10-31 11:51:28.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:51:59.0: SelectRunning: No running plans
2019-10-31 11:51:59.0: No pending plans that can be started now.
2019-10-31 11:51:59.0: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:52:29.6: SelectRunning: No running plans
2019-10-31 11:52:29.6: No pending plans that can be started now.
2019-10-31 11:52:29.6: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:53:00.2: SelectRunning: No running plans
2019-10-31 11:53:00.2: No pending plans that can be started now.
2019-10-31 11:53:00.2: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:53:30.7: SelectRunning: No running plans
2019-10-31 11:53:30.7: No pending plans that can be started now.
2019-10-31 11:53:30.7: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:54:01.4: SelectRunning: No running plans
2019-10-31 11:54:01.4: No pending plans that can be started now.
2019-10-31 11:54:01.4: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:54:31.9: SelectRunning: No running plans
2019-10-31 11:54:31.9: No pending plans that can be started now.
2019-10-31 11:54:31.9: Dispatcher cycle time: 0.0 sec.
2019-10-31 11:55:15.7: -- Weather Unsafe --
2019-10-31 12:35:35.3: ++ Weather Safe ++
2019-10-31 12:41:13.0: ++ Observatory Startup ++
2019-10-31 12:41:13.0: Startup attempted, but no StartupObs script found
2019-10-31 12:41:13.3: Open the observatory dome/roof
2019-10-31 12:42:44.1: Observatory startup succeeded, and dome opened successfully
2019-10-31 12:42:44.1: ++ Dawn Flats ++
2019-10-31 12:42:44.1: Start ACP AutoFlat script for Dawn flats
2019-10-31 12:42:44.1: ACP.RunScript(AutoFlat, C:\Users\admin\Documents\ACP Astronomy\Plans\SchedulerDawnFlats.txt):
2019-10-31 12:42:44.1:   Script ACP-Weather is loaded, and
2019-10-31 12:42:44.1:   the console is idle.
2019-10-31 12:42:44.1:   In start loop, i = 0
2019-10-31 12:42:44.1:   Console is now idle
2019-10-31 12:42:44.3:   Loaded C:\Program Files (x86)\ACP Obs Control\Scripts\AutoFlat.vbs successfully
2019-10-31 12:42:44.5:   Set parameter "C:\Users\admin\Documents\ACP Astronomy\Plans\SchedulerDawnFlats.txt" successfully
2019-10-31 12:42:44.5:   Script started successfully
2019-10-31 12:42:54.5: Sequencer is now active
2019-10-31 12:50:33.3: ** Script interrupted by weather safety event.
2019-10-31 12:51:49.5: Sequencer is no longer active
2019-10-31 12:51:49.5: -- Weather Unsafe --
2019-10-31 12:52:21.1: -- Observatory Shutdown --
2019-10-31 12:52:21.1: Start ACP Sequencer's ShutdownObs script
2019-10-31 12:52:21.1: ACP.RunScript(ShutdownObs, ):
2019-10-31 12:52:21.1:   Script ACP-Weather is loaded, and
2019-10-31 12:52:21.1:   the console is idle.
2019-10-31 12:52:21.1:   In start loop, i = 0
2019-10-31 12:52:21.1:   Console is now idle
2019-10-31 12:52:21.7:   Loaded C:\Users\Public\Documents\ACP Config\Scheduler\ShutdownObs.js successfully
2019-10-31 12:52:21.7:   Script started successfully
2019-10-31 12:52:31.7: Sequencer is now active
2019-10-31 12:52:36.8: Sequencer is no longer active
2019-10-31 18:58:32.4: Run statistics:
2019-10-31 18:58:32.6:   Observations:   1
2019-10-31 18:58:32.6:   Considered:     0
2019-10-31 18:58:32.6:   Completed:      0
2019-10-31 18:58:32.6:   Skipped:        0
2019-10-31 18:58:32.6:   Never Eligible: 1
2019-10-31 18:58:32.6:   Failed:         0
Log closed at Thu, Oct 31 2019 18:58:34 UTC (actual time)