Log opened at Fri, Nov 15 2019 18:59:57 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2019-11-16 00:46:45.8: ++ Weather Safe ++
2019-11-16 00:46:46.9: ++ Observatory Startup ++
2019-11-16 00:46:46.9: Startup attempted, but no StartupObs script found
2019-11-16 00:46:46.9: Observatory startup succeeded
2019-11-16 01:02:34.7: ++ Auto Focus ++
2019-11-16 01:02:34.7: Doing initial autofocus.
2019-11-16 01:02:34.7: Start special ACP AutoFocus script for scheduler
2019-11-16 01:02:34.7: ACP.RunScript(AutoFocusScheduler, ):
2019-11-16 01:02:34.7:   Script ShutdownObs is loaded, and
2019-11-16 01:02:34.7:   the console is idle.
2019-11-16 01:02:34.7:   In start loop, i = 0
2019-11-16 01:02:34.7:   Console is now idle
2019-11-16 01:02:34.8:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-11-16 01:02:34.8:   Script started successfully
2019-11-16 01:02:44.8: Sequencer is now active
2019-11-16 01:02:49.9: Sequencer is no longer active
2019-11-16 01:02:49.9: ** ACP script "AutoFocusScheduler" failed:
2019-11-16 01:02:49.9: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2019-11-16 01:02:49.9: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2019-11-16 01:02:49.9: SelectRunning: No running plans
2019-11-16 01:02:49.9: Obs KH15D in Plan KH15D was vetoed by AirMass constraint.
2019-11-16 01:02:49.9:     AirMass estimates ready after 16-Nov-2019 06:06:05 UTC
2019-11-16 01:02:50.0: Obs KH15D-B in Plan KH15D-B was vetoed by AirMass constraint.
2019-11-16 01:02:50.0:     AirMass estimates ready after 16-Nov-2019 06:06:05 UTC
2019-11-16 01:02:50.0: Obs SA109 in Plan SA109 was vetoed by AirMass constraint.
2019-11-16 01:02:50.0:     AirMass estimates ready after 16-Nov-2019 17:36:23 UTC
2019-11-16 01:02:50.0: Efficiency: Only one pending plan Test, it is the "best"
2019-11-16 01:02:50.0: Dispatcher cycle time: 0.2 sec.
2019-11-16 01:02:50.0: Acquire data for Observation Test...
2019-11-16 01:02:50.0:   (belongs to Project KH15D, Plan Test)
2019-11-16 01:02:50.0: ++ Auto Focus ++
2019-11-16 01:02:50.1: Doing periodic autofocus.
2019-11-16 01:02:50.1: Start special ACP AutoFocus script for scheduler
2019-11-16 01:02:50.1: ACP.RunScript(AutoFocusScheduler, ):
2019-11-16 01:02:50.1:   Script AutoFocusScheduler is loaded, and
2019-11-16 01:02:50.1:   the console is idle.
2019-11-16 01:02:50.1:   In start loop, i = 0
2019-11-16 01:02:50.1:   Console is now idle
2019-11-16 01:02:50.1:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2019-11-16 01:02:50.1:   Script started successfully
2019-11-16 01:03:00.1: Sequencer is now active
2019-11-16 01:03:05.2: Sequencer is no longer active
2019-11-16 01:03:05.2: ** ACP script "AutoFocusScheduler" failed:
2019-11-16 01:03:05.2: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2019-11-16 01:03:05.2: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2019-11-16 01:03:05.2: **EXCEPTION IN SCHEDULER:
2019-11-16 01:03:05.2: The telescope is not connected.
2019-11-16 01:03:05.4: 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-16 01:03:05.4: No operator intervention command tool specified
2019-11-16 01:03:05.5: Run statistics:
2019-11-16 01:03:05.5:   Observations:   4
2019-11-16 01:03:05.5:   Considered:     0
2019-11-16 01:03:05.5:   Completed:      0
2019-11-16 01:03:05.5:   Skipped:        0
2019-11-16 01:03:05.5:   Never Eligible: 4
2019-11-16 01:03:05.5:   Failed:         0
2019-11-16 01:03:05.5: Shutter-Open efficiency: 32.28%
2019-11-16 01:03:05.5: Overall Efficiency: 36.93%
2019-11-16 01:03:05.5: Release ACP sequencer
Log closed at Sat, Nov 16 2019 01:03:07 UTC (actual time)