Log opened at Thu, Apr 16 2020 02:13:04 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2020-04-16 02:23:16.1: ++ Weather Safe ++
2020-04-16 02:23:17.3: ++ Observatory Startup ++
2020-04-16 02:23:17.3: Start ACP Sequencer's StartupObs script
2020-04-16 02:23:17.3: ACP.RunScript(StartupObs, ):
2020-04-16 02:23:17.3:   Script ShutdownObs is loaded, and
2020-04-16 02:23:17.3:   the console is idle.
2020-04-16 02:23:17.3:   In start loop, i = 0
2020-04-16 02:23:17.3:   Console is now idle
2020-04-16 02:23:17.7:   Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully
2020-04-16 02:23:17.7:   Script started successfully
2020-04-16 02:23:27.8: Sequencer is now active
2020-04-16 02:23:42.4: Sequencer is no longer active
2020-04-16 02:23:42.4: Open the observatory dome/roof
2020-04-16 02:24:43.1: Observatory startup succeeded, and dome opened successfully
2020-04-16 02:32:21.8: ++ Auto Focus ++
2020-04-16 02:32:21.8: Doing initial autofocus.
2020-04-16 02:32:21.8: Start special ACP AutoFocus script for scheduler
2020-04-16 02:32:21.8: ACP.RunScript(AutoFocusScheduler, ):
2020-04-16 02:32:21.8:   Script StartupObs is loaded, and
2020-04-16 02:32:21.8:   the console is idle.
2020-04-16 02:32:21.8:   In start loop, i = 0
2020-04-16 02:32:21.8:   Console is now idle
2020-04-16 02:32:21.9:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2020-04-16 02:32:21.9:   Script started successfully
2020-04-16 02:32:32.0: Sequencer is now active
2020-04-16 02:32:37.0: Sequencer is no longer active
2020-04-16 02:32:37.0: ** ACP script "AutoFocusScheduler" failed:
2020-04-16 02:32:37.0: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2020-04-16 02:32:37.0: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2020-04-16 02:32:37.0: Plan KH15D has Monitor Mode. Time to resubmit it.
2020-04-16 02:32:37.0: Plan Test has Monitor Mode. Time to resubmit it.
2020-04-16 02:32:37.1: Plan KH15D-B has Monitor Mode. Time to resubmit it.
2020-04-16 02:32:37.1: SelectRunning: No running plans
2020-04-16 02:32:37.1: Obs Test in Plan Test vetoed for sequencer hard limit.
2020-04-16 02:32:37.1:  (deferred for 68 min, until 16-Apr-2020 03:40:37 UTC
2020-04-16 02:32:37.1: Efficiency: Selecting from 2 pending plans:
2020-04-16 02:32:37.1: Efficiency found nothing to do
2020-04-16 02:32:37.1: Dispatcher cycle time: 0.1 sec.
2020-04-16 02:33:07.7: ++ Auto Focus ++
2020-04-16 02:33:07.8: Doing periodic autofocus.
2020-04-16 02:33:07.8: Start special ACP AutoFocus script for scheduler
2020-04-16 02:33:07.8: ACP.RunScript(AutoFocusScheduler, ):
2020-04-16 02:33:07.8:   Script AutoFocusScheduler is loaded, and
2020-04-16 02:33:07.8:   the console is idle.
2020-04-16 02:33:07.8:   In start loop, i = 0
2020-04-16 02:33:07.8:   Console is now idle
2020-04-16 02:33:07.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2020-04-16 02:33:07.8:   Script started successfully
2020-04-16 02:33:17.8: Sequencer is now active
2020-04-16 02:33:22.9: Sequencer is no longer active
2020-04-16 02:33:22.9: ** ACP script "AutoFocusScheduler" failed:
2020-04-16 02:33:22.9: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2020-04-16 02:33:22.9: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2020-04-16 02:33:22.9: SelectRunning: No running plans
2020-04-16 02:33:23.0: Efficiency: Selecting from 2 pending plans:
2020-04-16 02:33:23.0:   Selected Plan KH15D (TotEff=2.09)
2020-04-16 02:33:23.0: Dispatcher cycle time: 0.2 sec.
2020-04-16 02:33:23.0: Acquire data for Observation KH15D...
2020-04-16 02:33:23.1:   (belongs to Project KH15D, Plan KH15D)
2020-04-16 02:33:23.3: **EXCEPTION IN SCHEDULER:
2020-04-16 02:33:23.3: The telescope is not connected.
2020-04-16 02:33:23.9: Traceback:
   at ACP.TelescopeClass.get_SlewSettleTime()
   at DC3.Scheduler.ACPSequencer.AcquireData(Observation Obs)
   at DC3.Scheduler.Engine.DoSchedulePass()
   at DC3.Scheduler.Engine.Run()
2020-04-16 02:33:24.2: No operator intervention command tool specified
2020-04-16 02:33:24.3: Run statistics:
2020-04-16 02:33:24.3:   Observations:   3
2020-04-16 02:33:24.3:   Considered:     0
2020-04-16 02:33:24.3:   Completed:      0
2020-04-16 02:33:24.3:   Skipped:        0
2020-04-16 02:33:24.3:   Never Eligible: 3
2020-04-16 02:33:24.3:   Failed:         0
2020-04-16 02:33:24.3: Shutter-Open efficiency: 12.96%
2020-04-16 02:33:24.3: Overall Efficiency: 16.15%
2020-04-16 02:33:24.3: Release ACP sequencer
Log closed at Thu, Apr 16 2020 02:33:26 UTC (actual time)