Log opened at Wed, Oct 20 2021 12:10:19 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2021-10-20 12:10:19.1: ++ Observatory Startup ++
2021-10-20 12:10:19.1: Start ACP Sequencer's StartupObs script
2021-10-20 12:10:19.1: Starting with open dome, unsafe weather will cause operator intervention error
2021-10-20 12:10:19.2: ACP.RunScript(StartupObs, ):
2021-10-20 12:10:19.2:   Script FindBrightStar is loaded, and
2021-10-20 12:10:19.2:   the console is idle.
2021-10-20 12:10:19.2:   In start loop, i = 0
2021-10-20 12:10:19.2:   Console is now idle
2021-10-20 12:10:19.6:   Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully
2021-10-20 12:10:19.7:   Script started successfully
2021-10-20 12:10:29.7: Sequencer is now active
2021-10-20 12:10:40.5: Sequencer is no longer active
2021-10-20 12:10:40.5: Observatory startup succeeded
2021-10-20 12:10:40.6: ++ Auto Focus ++
2021-10-20 12:10:40.6: Doing initial autofocus.
2021-10-20 12:10:40.6: Start special ACP AutoFocus script for scheduler
2021-10-20 12:10:40.6: ACP.RunScript(AutoFocusScheduler, ):
2021-10-20 12:10:40.6:   Script StartupObs is loaded, and
2021-10-20 12:10:40.6:   the console is idle.
2021-10-20 12:10:40.6:   In start loop, i = 0
2021-10-20 12:10:40.6:   Console is now idle
2021-10-20 12:10:40.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2021-10-20 12:10:40.8:   Script started successfully
2021-10-20 12:10:50.8: Sequencer is now active
2021-10-20 12:15:25.3: Sequencer is no longer active
2021-10-20 12:15:25.3: Next periodic autofocus ASAP after 3600sec. 20-Oct-2021 13:15:10 UTC
2021-10-20 12:15:25.5: SelectRunning: No running plans
2021-10-20 12:15:25.5: Efficiency: Only one pending plan test, it is the "best"
2021-10-20 12:15:25.6: Dispatcher cycle time: 0.2 sec.
2021-10-20 12:15:25.6: Acquire data for Observation test...
2021-10-20 12:15:25.6:   (belongs to Project Transit, Plan test)
2021-10-20 12:15:25.6: Doing 10 sets
2021-10-20 12:15:25.6: Send Observation test to ACP Sequencer
2021-10-20 12:15:25.6: ACP.RunScript(AcquireScheduler, ):
2021-10-20 12:15:25.6:   Script AutoFocusScheduler is loaded, and
2021-10-20 12:15:25.6:   the console is idle.
2021-10-20 12:15:25.7:   In start loop, i = 0
2021-10-20 12:15:25.7:   Console is now idle
2021-10-20 12:15:25.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AcquireScheduler.vbs successfully
2021-10-20 12:15:25.8:   Script started successfully
2021-10-20 12:15:35.8: Sequencer is now active
2021-10-20 12:19:25.7: Sequencer is no longer active
2021-10-20 12:19:25.7: Post-job status check done (stat=Failed)
2021-10-20 12:19:25.7: ACP data acquisition failed for Observation test.
2021-10-20 12:19:25.7:   (Observation test interrupted by acquisition process failure.)
2021-10-20 12:19:25.9: SelectRunning: No running plans
2021-10-20 12:19:25.9: No pending plans that can be started now.
2021-10-20 12:19:25.9: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:19:31.0: SelectRunning: No running plans
2021-10-20 12:19:31.0: No pending plans that can be started now.
2021-10-20 12:19:31.0: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:19:36.2: SelectRunning: No running plans
2021-10-20 12:19:36.2: No pending plans that can be started now.
2021-10-20 12:19:36.2: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:19:41.4: SelectRunning: No running plans
2021-10-20 12:19:41.4: No pending plans that can be started now.
2021-10-20 12:19:41.4: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:19:46.6: SelectRunning: No running plans
2021-10-20 12:19:46.6: No pending plans that can be started now.
2021-10-20 12:19:46.6: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:19:51.7: SelectRunning: No running plans
2021-10-20 12:19:51.7: No pending plans that can be started now.
2021-10-20 12:19:51.7: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:19:56.9: SelectRunning: No running plans
2021-10-20 12:19:56.9: No pending plans that can be started now.
2021-10-20 12:19:56.9: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:02.1: SelectRunning: No running plans
2021-10-20 12:20:02.1: No pending plans that can be started now.
2021-10-20 12:20:02.1: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:07.2: SelectRunning: No running plans
2021-10-20 12:20:07.2: No pending plans that can be started now.
2021-10-20 12:20:07.2: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:12.4: SelectRunning: No running plans
2021-10-20 12:20:12.4: No pending plans that can be started now.
2021-10-20 12:20:12.4: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:17.6: SelectRunning: No running plans
2021-10-20 12:20:17.6: No pending plans that can be started now.
2021-10-20 12:20:17.6: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:23.1: SelectRunning: No running plans
2021-10-20 12:20:23.1: No pending plans that can be started now.
2021-10-20 12:20:23.1: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:28.5: SelectRunning: No running plans
2021-10-20 12:20:28.5: No pending plans that can be started now.
2021-10-20 12:20:28.5: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:33.9: SelectRunning: No running plans
2021-10-20 12:20:33.9: No pending plans that can be started now.
2021-10-20 12:20:33.9: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:39.3: SelectRunning: No running plans
2021-10-20 12:20:39.3: No pending plans that can be started now.
2021-10-20 12:20:39.3: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:44.7: SelectRunning: No running plans
2021-10-20 12:20:44.7: No pending plans that can be started now.
2021-10-20 12:20:44.7: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:50.1: SelectRunning: No running plans
2021-10-20 12:20:50.1: No pending plans that can be started now.
2021-10-20 12:20:50.1: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:20:55.5: SelectRunning: No running plans
2021-10-20 12:20:55.5: No pending plans that can be started now.
2021-10-20 12:20:55.5: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:21:00.9: SelectRunning: No running plans
2021-10-20 12:21:00.9: No pending plans that can be started now.
2021-10-20 12:21:00.9: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:21:06.3: SelectRunning: No running plans
2021-10-20 12:21:06.3: No pending plans that can be started now.
2021-10-20 12:21:06.3: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:21:11.6: SelectRunning: No running plans
2021-10-20 12:21:11.6: No pending plans that can be started now.
2021-10-20 12:21:11.6: Dispatcher cycle time: 0.0 sec.
2021-10-20 12:33:09.9: ++ Dawn Flats ++
2021-10-20 12:33:09.9: Start ACP AutoFlat script for Dawn flats
2021-10-20 12:33:09.9: ACP.RunScript(AutoFlat, C:\Users\admin\Documents\ACP Astronomy\Plans\SchedulerDawnFlats.txt):
2021-10-20 12:33:09.9:   Script AcquireScheduler is loaded, and
2021-10-20 12:33:09.9:   the console is idle.
2021-10-20 12:33:09.9:   In start loop, i = 0
2021-10-20 12:33:09.9:   Console is now idle
2021-10-20 12:33:10.0:   Loaded C:\Program Files (x86)\ACP Obs Control\Scripts\AutoFlat.vbs successfully
2021-10-20 12:33:10.2:   Set parameter "C:\Users\admin\Documents\ACP Astronomy\Plans\SchedulerDawnFlats.txt" successfully
2021-10-20 12:33:10.2:   Script started successfully
2021-10-20 12:33:20.2: Sequencer is now active
2021-10-20 13:07:35.9: Sequencer is no longer active
2021-10-20 13:07:41.1: Close the observatory dome/roof.
2021-10-20 13:08:11.8: ++ Morning Cal Frames ++
2021-10-20 13:08:11.8: Start ACP Sequencer's SchedulerCalFrames.txt observing plan
2021-10-20 13:08:11.9: ACP.RunScript(AcquireImages, C:\Users\admin\Documents\ACP Astronomy\Plans\SchedulerCalFrames.txt):
2021-10-20 13:08:11.9:   Script AutoFlat is loaded, and
2021-10-20 13:08:11.9:   the console is idle.
2021-10-20 13:08:11.9:   In start loop, i = 0
2021-10-20 13:08:11.9:   Console is now idle
2021-10-20 13:08:12.4:   Loaded C:\Program Files (x86)\ACP Obs Control\Scripts\AcquireImages.js successfully
2021-10-20 13:08:12.4:   Set parameter "C:\Users\admin\Documents\ACP Astronomy\Plans\SchedulerCalFrames.txt" successfully
2021-10-20 13:08:12.4:   Script started successfully
2021-10-20 13:08:22.4: Sequencer is now active
2021-10-20 13:08:28.7: Sequencer is no longer active
2021-10-20 13:08:33.8: -- Observatory Shutdown --
2021-10-20 13:08:33.8: Start ACP Sequencer's ShutdownObs script
2021-10-20 13:08:33.8: ACP.RunScript(ShutdownObs, ):
2021-10-20 13:08:33.8:   Script AcquireImages is loaded, and
2021-10-20 13:08:33.8:   the console is idle.
2021-10-20 13:08:33.8:   In start loop, i = 0
2021-10-20 13:08:33.8:   Console is now idle
2021-10-20 13:08:33.9:   Loaded C:\Users\Public\Documents\ACP Config\Scheduler\ShutdownObs.js successfully
2021-10-20 13:08:33.9:   Script started successfully
2021-10-20 13:08:43.9: Sequencer is now active
2021-10-20 13:09:29.5: Sequencer is no longer active
2021-10-20 13:14:32.6: -- Weather Unsafe --
2021-10-21 00:40:42.1: ++ Weather Safe ++
2021-10-21 04:10:10.7: Run statistics:
2021-10-21 04:10:10.7:   Observations:   4
2021-10-21 04:10:10.7:   Considered:     4
2021-10-21 04:10:10.7:   Completed:      0
2021-10-21 04:10:10.7:   Skipped:        0
2021-10-21 04:10:10.7:   Never Eligible: 0
2021-10-21 04:10:10.7:   Failed:         4
Log closed at Thu, Oct 21 2021 04:10:10 UTC (actual time)