Log opened at Tue, Oct 15 2019 19:01:00 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2019-10-16 01:22:12.0: ++ Weather Safe ++
2019-10-16 01:22:13.1: ++ Observatory Startup ++
2019-10-16 01:22:13.1: Startup attempted, but no StartupObs script found
2019-10-16 01:22:13.1: Observatory startup succeeded
2019-10-16 01:27:49.4: ++ Auto Focus ++
2019-10-16 01:27:49.5: Doing initial autofocus.
2019-10-16 01:27:49.5: Start special ACP AutoFocus script for scheduler
2019-10-16 01:27:49.5: ACP.RunScript(AutoFocusScheduler, ):
2019-10-16 01:27:49.5:   Script ShutdownObs is loaded, and
2019-10-16 01:27:49.5:   the console is idle.
2019-10-16 01:27:49.5:   In start loop, i = 0
2019-10-16 01:27:49.5:   Console is now idle
2019-10-16 01:27:49.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-16 01:27:49.5:   Script started successfully
2019-10-16 01:27:59.5: Sequencer is now active
2019-10-16 01:28:04.6: Sequencer is no longer active
2019-10-16 01:28:04.6: ** ACP script "AutoFocusScheduler" failed:
2019-10-16 01:28:04.6: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2019-10-16 01:28:04.6: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2019-10-16 01:28:04.6: Plan Test has Monitor Mode. Time to resubmit it.
2019-10-16 01:28:04.6: SelectRunning: No running plans
2019-10-16 01:28:04.6: Obs KH15D in Plan KH15D was vetoed by AirMass constraint.
2019-10-16 01:28:04.6:     AirMass estimates ready after 16-Oct-2019 08:07:58 UTC
2019-10-16 01:28:04.6: Obs KH15D-B in Plan KH15D-B was vetoed by AirMass constraint.
2019-10-16 01:28:04.6:     AirMass estimates ready after 16-Oct-2019 08:07:58 UTC
2019-10-16 01:28:04.7: Efficiency: Selecting from 2 pending plans:
2019-10-16 01:28:04.7:   Selected Plan SA109 (TotEff=0.00)
2019-10-16 01:28:04.7: Dispatcher cycle time: 0.1 sec.
2019-10-16 01:28:04.7: Acquire data for Observation SA109...
2019-10-16 01:28:04.7:   (belongs to Project Landolt fields, Plan SA109)
2019-10-16 01:28:04.7: Doing 3 sets
2019-10-16 01:28:04.7: ++ Auto Focus ++
2019-10-16 01:28:04.8: Doing periodic autofocus.
2019-10-16 01:28:04.8: Start special ACP AutoFocus script for scheduler
2019-10-16 01:28:04.8: ACP.RunScript(AutoFocusScheduler, ):
2019-10-16 01:28:04.8:   Script AutoFocusScheduler is loaded, and
2019-10-16 01:28:04.8:   the console is idle.
2019-10-16 01:28:04.8:   In start loop, i = 0
2019-10-16 01:28:04.8:   Console is now idle
2019-10-16 01:28:04.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-10-16 01:28:04.8:   Script started successfully
2019-10-16 01:28:14.8: Sequencer is now active
2019-10-16 01:28:19.9: Sequencer is no longer active
2019-10-16 01:28:19.9: ** ACP script "AutoFocusScheduler" failed:
2019-10-16 01:28:19.9: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2019-10-16 01:28:19.9: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2019-10-16 01:28:19.9: **EXCEPTION IN SCHEDULER:
2019-10-16 01:28:19.9: The telescope is not connected.
2019-10-16 01:28:20.1: Traceback:
   at ACP.TelescopeClass.get_SlewSettleTime()
   at DC3.Scheduler.ACPSequencer.AcquireData(Observation Obs)
   at DC3.Scheduler.Engine.DoSchedulePass()
   at DC3.Scheduler.Engine.Run()
2019-10-16 01:28:20.2: No operator intervention command tool specified
2019-10-16 01:28:20.3: Run statistics:
2019-10-16 01:28:20.3:   Observations:   4
2019-10-16 01:28:20.3:   Considered:     0
2019-10-16 01:28:20.3:   Completed:      0
2019-10-16 01:28:20.3:   Skipped:        0
2019-10-16 01:28:20.3:   Never Eligible: 4
2019-10-16 01:28:20.3:   Failed:         0
2019-10-16 01:28:20.3: Shutter-Open efficiency: 12.87%
2019-10-16 01:28:20.3: Overall Efficiency: 22.56%
2019-10-16 01:28:20.3: Release ACP sequencer
Log closed at Wed, Oct 16 2019 01:28:22 UTC (actual time)