Log opened at Tue, Nov 05 2019 18:58:07 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2019-11-06 00:58:56.4: ++ Weather Safe ++
2019-11-06 00:58:57.5: ++ Observatory Startup ++
2019-11-06 00:58:57.5: Startup attempted, but no StartupObs script found
2019-11-06 00:58:57.5: Observatory startup succeeded
2019-11-06 01:08:38.3: ++ Auto Focus ++
2019-11-06 01:08:38.3: Doing initial autofocus.
2019-11-06 01:08:38.3: Start special ACP AutoFocus script for scheduler
2019-11-06 01:08:38.3: ACP.RunScript(AutoFocusScheduler, ):
2019-11-06 01:08:38.3:   Script ShutdownObs is loaded, and
2019-11-06 01:08:38.3:   the console is idle.
2019-11-06 01:08:38.3:   In start loop, i = 0
2019-11-06 01:08:38.3:   Console is now idle
2019-11-06 01:08:38.5:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-11-06 01:08:38.5:   Script started successfully
2019-11-06 01:08:48.5: Sequencer is now active
2019-11-06 01:08:53.6: Sequencer is no longer active
2019-11-06 01:08:53.6: ** ACP script "AutoFocusScheduler" failed:
2019-11-06 01:08:53.6: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2019-11-06 01:08:53.6: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2019-11-06 01:08:53.6: Plan KH15D has Monitor Mode. Time to resubmit it.
2019-11-06 01:08:53.6: Plan Test has Monitor Mode. Time to resubmit it.
2019-11-06 01:08:53.6: Plan KH15D-B has Monitor Mode. Time to resubmit it.
2019-11-06 01:08:53.6: SelectRunning: No running plans
2019-11-06 01:08:53.6: Obs KH15D in Plan KH15D was vetoed by AirMass constraint.
2019-11-06 01:08:53.6:     AirMass estimates ready after 06-Nov-2019 06:45:23 UTC
2019-11-06 01:08:53.6: Obs KH15D-B in Plan KH15D-B was vetoed by AirMass constraint.
2019-11-06 01:08:53.6:     AirMass estimates ready after 06-Nov-2019 06:45:23 UTC
2019-11-06 01:08:53.6: STRICT VETO:
2019-11-06 01:08:53.6: Obs SA109 in Plan SA109 was vetoed by AirMass constraint.
2019-11-06 01:08:53.6:     AirMass estimates ready after 06-Nov-2019 18:15:42 UTC
2019-11-06 01:08:53.6: Efficiency: Only one pending plan Test, it is the "best"
2019-11-06 01:08:53.7: Dispatcher cycle time: 0.1 sec.
2019-11-06 01:08:53.7: Acquire data for Observation Test...
2019-11-06 01:08:53.7:   (belongs to Project KH15D, Plan Test)
2019-11-06 01:08:53.7: ++ Auto Focus ++
2019-11-06 01:08:53.8: Doing periodic autofocus.
2019-11-06 01:08:53.8: Start special ACP AutoFocus script for scheduler
2019-11-06 01:08:53.8: ACP.RunScript(AutoFocusScheduler, ):
2019-11-06 01:08:53.8:   Script AutoFocusScheduler is loaded, and
2019-11-06 01:08:53.8:   the console is idle.
2019-11-06 01:08:53.8:   In start loop, i = 0
2019-11-06 01:08:53.8:   Console is now idle
2019-11-06 01:08:53.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-11-06 01:08:53.8:   Script started successfully
2019-11-06 01:09:03.8: Sequencer is now active
2019-11-06 01:09:08.9: Sequencer is no longer active
2019-11-06 01:09:08.9: ** ACP script "AutoFocusScheduler" failed:
2019-11-06 01:09:08.9: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2019-11-06 01:09:08.9: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2019-11-06 01:09:08.9: **EXCEPTION IN SCHEDULER:
2019-11-06 01:09:08.9: The telescope is not connected.
2019-11-06 01:09:09.8: Traceback:
   at ACP.TelescopeClass.get_SlewSettleTime()
   at DC3.Scheduler.ACPSequencer.AcquireData(Observation Obs)
   at DC3.Scheduler.Engine.DoSchedulePass()
   at DC3.Scheduler.Engine.Run()
2019-11-06 01:09:09.9: No operator intervention command tool specified
2019-11-06 01:09:09.9: Run statistics:
2019-11-06 01:09:09.9:   Observations:   4
2019-11-06 01:09:09.9:   Considered:     0
2019-11-06 01:09:09.9:   Completed:      0
2019-11-06 01:09:09.9:   Skipped:        0
2019-11-06 01:09:09.9:   Never Eligible: 4
2019-11-06 01:09:09.9:   Failed:         0
2019-11-06 01:09:09.9: Shutter-Open efficiency: 22.01%
2019-11-06 01:09:09.9: Overall Efficiency: 25.86%
2019-11-06 01:09:09.9: Release ACP sequencer
Log closed at Wed, Nov 06 2019 01:09:11 UTC (actual time)