Log opened at Fri, Jan 03 2020 01:57:51 UTC (actual time)
Current log level is Debug
ACP Expert Scheduler version 8.2.3
Full license: Arne Henden
2020-01-03 01:57:51.7: ++ Observatory Startup ++
2020-01-03 01:57:51.7: Start ACP Sequencer's StartupObs script
2020-01-03 01:57:51.7: ACP.RunScript(StartupObs, ):
2020-01-03 01:57:51.7:   Script ShutdownObs is loaded, and
2020-01-03 01:57:51.7:   the console is idle.
2020-01-03 01:57:51.7:   In start loop, i = 0
2020-01-03 01:57:51.7:   Console is now idle
2020-01-03 01:57:51.8:   Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully
2020-01-03 01:57:51.9:   Script started successfully
2020-01-03 01:58:01.9: Sequencer is now active
2020-01-03 01:58:35.2: Sequencer is no longer active
2020-01-03 01:58:35.2: Open the observatory dome/roof
2020-01-03 01:59:51.3: Observatory startup succeeded, and dome opened successfully
2020-01-03 01:59:51.3: ++ Auto Focus ++
2020-01-03 01:59:51.3: Doing initial autofocus.
2020-01-03 01:59:51.3: Start special ACP AutoFocus script for scheduler
2020-01-03 01:59:51.3: ACP.RunScript(AutoFocusScheduler, ):
2020-01-03 01:59:51.3:   Script StartupObs is loaded, and
2020-01-03 01:59:51.3:   the console is idle.
2020-01-03 01:59:51.3:   In start loop, i = 0
2020-01-03 01:59:51.3:   Console is now idle
2020-01-03 01:59:51.3:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2020-01-03 01:59:51.3:   Script started successfully
2020-01-03 02:00:01.4: Sequencer is now active
2020-01-03 02:11:51.1: Sequencer is no longer active
2020-01-03 02:11:51.1: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2020-01-03 02:11:51.2: Plan KH15D has Monitor Mode. Time to resubmit it.
2020-01-03 02:11:51.2: Plan Test has Monitor Mode. Time to resubmit it.
2020-01-03 02:11:51.2: Plan KH15D-B has Monitor Mode. Time to resubmit it.
2020-01-03 02:11:51.2: SelectRunning: No running plans
2020-01-03 02:11:51.2: Obs KH15D in Plan KH15D was vetoed by AirMass constraint.
2020-01-03 02:11:51.2:     AirMass estimates ready after 03-Jan-2020 02:57:19 UTC
2020-01-03 02:11:51.2: Obs KH15D-B in Plan KH15D-B was vetoed by AirMass constraint.
2020-01-03 02:11:51.2:     AirMass estimates ready after 03-Jan-2020 02:57:19 UTC
2020-01-03 02:11:51.3: Obs SA109 in Plan SA109 was vetoed by AirMass constraint.
2020-01-03 02:11:51.3:     AirMass estimates ready after 03-Jan-2020 14:27:38 UTC
2020-01-03 02:11:51.3: Efficiency: Only one pending plan Test, it is the "best"
2020-01-03 02:11:51.3: Dispatcher cycle time: 0.2 sec.
2020-01-03 02:11:51.3: Acquire data for Observation Test...
2020-01-03 02:11:51.3:   (belongs to Project KH15D, Plan Test)
2020-01-03 02:11:51.3: ++ Auto Focus ++
2020-01-03 02:11:51.4: Doing periodic autofocus.
2020-01-03 02:11:51.4: Start special ACP AutoFocus script for scheduler
2020-01-03 02:11:51.4: ACP.RunScript(AutoFocusScheduler, ):
2020-01-03 02:11:51.4:   Script AutoFocusScheduler is loaded, and
2020-01-03 02:11:51.4:   the console is idle.
2020-01-03 02:11:51.4:   In start loop, i = 0
2020-01-03 02:11:51.4:   Console is now idle
2020-01-03 02:11:51.4:   Loaded C:\Program Files (x86)\ACP Scheduler\AutoFocusScheduler.vbs successfully
2020-01-03 02:11:51.4:   Script started successfully
2020-01-03 02:12:01.4: Sequencer is now active
2020-01-03 02:13:00.9: Sequencer is no longer active
2020-01-03 02:13:00.9: ** ACP script "AutoFocusScheduler" failed:
2020-01-03 02:13:01.0: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 81 column 2.

2020-01-03 02:13:01.0: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2020-01-03 02:13:01.1: **EXCEPTION IN SCHEDULER:
2020-01-03 02:13:01.1: The telescope is not connected.
2020-01-03 02:13:01.4: Traceback:
   at ACP.TelescopeClass.get_SlewSettleTime()
   at DC3.Scheduler.ACPSequencer.AcquireData(Observation Obs)
   at DC3.Scheduler.Engine.DoSchedulePass()
   at DC3.Scheduler.Engine.Run()
2020-01-03 02:13:01.5: No operator intervention command tool specified
2020-01-03 02:13:01.6: Run statistics:
2020-01-03 02:13:01.6:   Observations:   4
2020-01-03 02:13:01.6:   Considered:     0
2020-01-03 02:13:01.6:   Completed:      0
2020-01-03 02:13:01.6:   Skipped:        0
2020-01-03 02:13:01.6:   Never Eligible: 4
2020-01-03 02:13:01.6:   Failed:         0
2020-01-03 02:13:01.6: Shutter-Open efficiency: 23.15%
2020-01-03 02:13:01.6: Overall Efficiency: 33.85%
2020-01-03 02:13:01.6: Release ACP sequencer
Log closed at Fri, Jan 03 2020 02:13:03 UTC (actual time)