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

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

2019-10-09 01:36:53.7: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2019-10-09 01:36:53.8: **EXCEPTION IN SCHEDULER:
2019-10-09 01:36:53.8: The telescope is not connected.
2019-10-09 01:36:54.0: 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-09 01:36:54.1: No operator intervention command tool specified
2019-10-09 01:36:54.1: Run statistics:
2019-10-09 01:36:54.1:   Observations:   3
2019-10-09 01:36:54.1:   Considered:     0
2019-10-09 01:36:54.1:   Completed:      0
2019-10-09 01:36:54.1:   Skipped:        0
2019-10-09 01:36:54.1:   Never Eligible: 3
2019-10-09 01:36:54.1:   Failed:         0
2019-10-09 01:36:54.1: Shutter-Open efficiency: 2.37%
2019-10-09 01:36:54.1: Overall Efficiency: 3.74%
2019-10-09 01:36:54.1: Release ACP sequencer
Log closed at Wed, Oct 09 2019 01:36:55 UTC (actual time)