Log opened at Tue, Nov 30 2021 03:50:17 UTC (actual time)
Current log level is Normal
ACP Expert Scheduler Engine Version 8.3.2
Part of ACP Expert Release 8.3
Full license: Arne Henden
2021-11-30 03:50:17.5: REAL TIME internal clock initialized at 30-Nov-2021 03:50:17 UTC
2021-11-30 03:50:17.6: Dispatcher started at 30-Nov-2021 03:50:17 UTC
2021-11-30 03:50:17.8: Loaded Constraint plugin AirMass
2021-11-30 03:50:17.9: Loaded Constraint plugin AirmassRange
2021-11-30 03:50:18.0: Loaded Constraint plugin Horizon
2021-11-30 03:50:18.0: Loaded Constraint plugin HourAngle
2021-11-30 03:50:18.1: Loaded Constraint plugin MoonAvoid
2021-11-30 03:50:18.2: Loaded Constraint plugin MoonDown
2021-11-30 03:50:18.2: Loaded Constraint plugin SkyCondition
2021-11-30 03:50:18.2: Loaded Constraint plugin TimeRange
2021-11-30 03:50:19.1: 1 plans are now pending.
2021-11-30 03:50:19.4: Attach ACP sequencer
2021-11-30 03:50:26.0: ++ Weather Safe ++
2021-11-30 03:50:27.0: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2021-11-30 03:50:27.1: Sequencer does sky flats
2021-11-30 03:50:28.3: HTTP command listener failed to start: Access is denied
2021-11-30 03:50:28.3:   If this is Windows 8-10, you will need to add permission (ACL) to listen on port 9123.
2021-11-30 03:50:28.3:   See Scheduler Help > Configuring the Program > Noteworthy Configuration Options, at the bottom.
2021-11-30 03:51:30.9: ++ Observatory Startup ++
2021-11-30 03:51:30.9: Weather safety is now disabled
2021-11-30 03:51:30.9: Start ACP Sequencer's StartupObs script
2021-11-30 03:52:00.7: Weather safety is re-enabled
2021-11-30 03:52:00.7: Weather safety is now disabled
2021-11-30 03:52:00.7: Open the observatory dome/roof
2021-11-30 03:53:01.4: Weather safety is re-enabled
2021-11-30 03:53:01.4: Observatory startup succeeded, and dome opened successfully
2021-11-30 03:53:01.4: ++ Auto Focus ++
2021-11-30 03:53:01.4: Doing initial autofocus.
2021-11-30 03:53:01.4: Start special ACP AutoFocus script for scheduler
2021-11-30 03:57:31.2: Next periodic autofocus ASAP after 3600sec. 30-Nov-2021 04:57:17 UTC
2021-11-30 03:57:31.8: Dispatcher cycle time: 0.5 sec.
2021-11-30 03:57:31.8: Acquire data for Observation SA114...
2021-11-30 03:57:31.8:   (belongs to Project Landolt, Plan SA114)
2021-11-30 03:57:31.8: Send Observation SA114 to ACP Sequencer
2021-11-30 04:04:17.4: Acquisition time: 405.5827144 sec.
2021-11-30 04:04:17.4: Data for Observation SA114 of Plan SA114 acquired successfully.
2021-11-30 04:04:17.4: Plan SA114 completed successfully.
2021-11-30 04:04:17.5: Image Efficiency: 34.5%
2021-11-30 04:04:17.5: Cycle Efficiency: 99.9%
2021-11-30 04:04:17.7: Dispatcher cycle time: 0.1 sec.
2021-11-30 04:04:17.7: Acquire data for Observation SA94...
2021-11-30 04:04:17.7:   (belongs to Project Landolt, Plan SA94)
2021-11-30 04:04:17.7: Send Observation SA94 to ACP Sequencer
2021-11-30 04:13:36.2: Acquisition time: 558.5166076 sec.
2021-11-30 04:13:36.2: Data for Observation SA94 of Plan SA94 acquired successfully.
2021-11-30 04:13:36.3: Plan SA94 completed successfully.
2021-11-30 04:13:36.3: Image Efficiency: 34.0%
2021-11-30 04:13:36.3: Cycle Efficiency: 100.0%
2021-11-30 04:28:31.2: Dispatcher cycle time: 0.3 sec.
2021-11-30 04:28:31.2: Acquire data for Observation SA114...
2021-11-30 04:28:31.2:   (belongs to Project Landolt, Plan SA114)
2021-11-30 04:28:31.2: Send Observation SA114 to ACP Sequencer
2021-11-30 04:36:45.1: Acquisition time: 493.9436535 sec.
2021-11-30 04:36:45.1: Data for Observation SA114 of Plan SA114 acquired successfully.
2021-11-30 04:36:45.2: Plan SA114 completed successfully.
2021-11-30 04:36:45.2: Image Efficiency: 28.3%
2021-11-30 04:36:45.2: Cycle Efficiency: 99.9%
2021-11-30 04:36:45.4: Dispatcher cycle time: 0.1 sec.
2021-11-30 04:36:45.4: Acquire data for Observation SA94...
2021-11-30 04:36:45.4:   (belongs to Project Landolt, Plan SA94)
2021-11-30 04:36:45.4: Send Observation SA94 to ACP Sequencer
2021-11-30 04:45:47.5: Acquisition time: 542.1301324 sec.
2021-11-30 04:45:47.5: Data for Observation SA94 of Plan SA94 acquired successfully.
2021-11-30 04:45:47.5: Plan SA94 completed successfully.
2021-11-30 04:45:47.6: Image Efficiency: 35.0%
2021-11-30 04:45:47.6: Cycle Efficiency: 100.0%
2021-11-30 04:57:23.1: ++ Auto Focus ++
2021-11-30 04:57:23.1: Doing periodic autofocus.
2021-11-30 04:57:23.1: Start special ACP AutoFocus script for scheduler
2021-11-30 05:02:57.1: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2021-11-30 05:03:02.3: ++ Auto Focus ++
2021-11-30 05:03:02.3: Doing periodic autofocus.
2021-11-30 05:03:02.3: Start special ACP AutoFocus script for scheduler
2021-11-30 05:06:42.3: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2021-11-30 05:11:43.6: ++ Auto Focus ++
2021-11-30 05:11:43.6: Doing periodic autofocus.
2021-11-30 05:11:43.6: Start special ACP AutoFocus script for scheduler
2021-11-30 05:17:28.1: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2021-11-30 05:27:31.8: ++ Auto Focus ++
2021-11-30 05:27:31.8: Doing periodic autofocus.
2021-11-30 05:27:31.8: Start special ACP AutoFocus script for scheduler
2021-11-30 05:37:40.4: ** Autofocus failed (n=4), will retry ASAP after 15 min.
2021-11-30 05:52:44.1: ++ Auto Focus ++
2021-11-30 05:52:44.1: Doing periodic autofocus.
2021-11-30 05:52:44.1: Start special ACP AutoFocus script for scheduler
2021-11-30 05:56:32.7: Next periodic autofocus ASAP after 3600sec. 30-Nov-2021 06:56:18 UTC
2021-11-30 06:56:20.1: ++ Auto Focus ++
2021-11-30 06:56:20.1: Doing periodic autofocus.
2021-11-30 06:56:20.1: Start special ACP AutoFocus script for scheduler
2021-11-30 06:59:07.6: Next periodic autofocus ASAP after 3600sec. 30-Nov-2021 07:58:49 UTC
2021-11-30 07:58:51.4: ++ Auto Focus ++
2021-11-30 07:58:51.4: Doing periodic autofocus.
2021-11-30 07:58:51.4: Start special ACP AutoFocus script for scheduler
2021-11-30 08:03:18.4: Next periodic autofocus ASAP after 3600sec. 30-Nov-2021 09:03:03 UTC
2021-11-30 09:03:08.9: ++ Auto Focus ++
2021-11-30 09:03:08.9: Doing periodic autofocus.
2021-11-30 09:03:08.9: Start special ACP AutoFocus script for scheduler
2021-11-30 09:08:59.2: Next periodic autofocus ASAP after 3600sec. 30-Nov-2021 10:08:40 UTC
2021-11-30 10:08:43.8: ++ Auto Focus ++
2021-11-30 10:08:43.8: Doing periodic autofocus.
2021-11-30 10:08:43.8: Start special ACP AutoFocus script for scheduler
2021-11-30 10:12:30.7: Next periodic autofocus ASAP after 3600sec. 30-Nov-2021 11:12:16 UTC
2021-11-30 11:12:16.2: ++ Auto Focus ++
2021-11-30 11:12:16.3: Doing periodic autofocus.
2021-11-30 11:12:16.3: Start special ACP AutoFocus script for scheduler
2021-11-30 11:13:33.8: ** ACP script "AutoFocusScheduler" failed:
2021-11-30 11:13:33.8: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 81 column 2.

2021-11-30 11:13:33.8: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2021-11-30 11:13:39.0: ++ Auto Focus ++
2021-11-30 11:13:39.0: Doing periodic autofocus.
2021-11-30 11:13:39.0: Start special ACP AutoFocus script for scheduler
2021-11-30 11:13:54.1: ** ACP script "AutoFocusScheduler" failed:
2021-11-30 11:13:54.1: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2021-11-30 11:13:54.1: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2021-11-30 11:18:54.4: ++ Auto Focus ++
2021-11-30 11:18:54.5: Doing periodic autofocus.
2021-11-30 11:18:54.5: Start special ACP AutoFocus script for scheduler
2021-11-30 11:19:09.6: ** ACP script "AutoFocusScheduler" failed:
2021-11-30 11:19:09.6: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2021-11-30 11:19:09.6: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2021-11-30 11:26:20.6: Weather safety is now disabled
2021-11-30 11:26:20.6: Open the observatory dome/roof
2021-11-30 11:27:36.3: Weather safety is re-enabled
2021-11-30 11:27:36.3: ++ Auto Focus ++
2021-11-30 11:27:36.3: Doing initial autofocus.
2021-11-30 11:27:36.3: Start special ACP AutoFocus script for scheduler
2021-11-30 11:27:51.4: ** ACP script "AutoFocusScheduler" failed:
2021-11-30 11:27:51.4: **Script Error**
Source:   ACP
Message:  The telescope is not connected.
Location: line 42 column 5.

2021-11-30 11:27:51.4: ** Autofocus failed (n=4), will retry ASAP after 15 min.
2021-11-30 11:32:43.7: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2021-11-30 11:34:55.3: **EXCEPTION IN SCHEDULER:
2021-11-30 11:34:55.3: The callee (server [not server application]) is not available and disappeared; all connections are invalid. The call may have executed. (Exception from HRESULT: 0x80010007 (RPC_E_SERVER_DIED))
2021-11-30 11:34:56.1: Traceback:
   at ACP.UtilClass.get_Scheduler()
   at DC3.Scheduler.ACPSequencer.set_DispatcherStatus(StatusValue value)
   at DC3.Scheduler.Engine.set_Status(StatusValue value)
   at DC3.Scheduler.Engine.Run()
2021-11-30 11:34:56.1: DOME/ROOF FAILURE: In addition, attempting to close your dome/roof this error occurred:
2021-11-30 11:34:56.1: The callee (server [not server application]) is not available and disappeared; all connections are invalid. The call may have executed. (Exception from HRESULT: 0x80010007 (RPC_E_SERVER_DIED))
2021-11-30 11:34:56.3: No operator intervention command tool specified