Log opened at Fri, Nov 19 2021 02:53:08 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-19 02:53:08.2: REAL TIME internal clock initialized at 19-Nov-2021 02:53:08 UTC
2021-11-19 02:53:08.2: Dispatcher started at 19-Nov-2021 02:53:08 UTC
2021-11-19 02:53:08.5: Loaded Constraint plugin AirMass
2021-11-19 02:53:08.5: Loaded Constraint plugin AirmassRange
2021-11-19 02:53:08.6: Loaded Constraint plugin Horizon
2021-11-19 02:53:08.6: Loaded Constraint plugin HourAngle
2021-11-19 02:53:08.7: Loaded Constraint plugin MoonAvoid
2021-11-19 02:53:08.8: Loaded Constraint plugin MoonDown
2021-11-19 02:53:08.8: Loaded Constraint plugin SkyCondition
2021-11-19 02:53:08.9: Loaded Constraint plugin TimeRange
2021-11-19 02:53:09.8: 0 plans are now pending.
2021-11-19 02:53:09.9: Attach ACP sequencer
2021-11-19 02:53:16.3: There is no controllable dome or roof.
2021-11-19 02:53:16.7: Weather successfully connected. Wait for valid data...
2021-11-19 02:53:18.0: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2021-11-19 02:53:18.0: Sequencer does sky flats
2021-11-19 02:53:21.7: ++ Weather Safe ++
2021-11-19 02:53:21.8: HTTP command listener failed to start: Access is denied
2021-11-19 02:53:21.8:   If this is Windows 8-10, you will need to add permission (ACL) to listen on port 9123.
2021-11-19 02:53:21.8:   See Scheduler Help > Configuring the Program > Noteworthy Configuration Options, at the bottom.
2021-11-19 02:53:39.0: ++ Observatory Startup ++
2021-11-19 02:53:39.0: Weather safety is now disabled
2021-11-19 02:53:39.0: Start ACP Sequencer's StartupObs script
2021-11-19 02:54:14.4: Weather safety is re-enabled
2021-11-19 02:54:14.4: Weather safety is now disabled
2021-11-19 02:54:14.4: Open the observatory dome/roof
2021-11-19 02:55:45.2: Weather safety is re-enabled
2021-11-19 02:55:45.2: Observatory startup succeeded, and dome opened successfully
2021-11-19 02:55:45.2: ++ Auto Focus ++
2021-11-19 02:55:45.2: Doing initial autofocus.
2021-11-19 02:55:45.2: Start special ACP AutoFocus script for scheduler
2021-11-19 03:03:31.4: Next periodic autofocus ASAP after 3600sec. 19-Nov-2021 04:03:12 UTC
2021-11-19 03:03:32.3: Dispatcher cycle time: 0.8 sec.
2021-11-19 03:03:32.3: Acquire data for Observation SA112...
2021-11-19 03:03:32.3:   (belongs to Project Landolt, Plan SA112)
2021-11-19 03:03:32.3: Send Observation SA112 to ACP Sequencer
2021-11-19 03:11:41.5: Acquisition time: 489.2159778 sec.
2021-11-19 03:11:41.5: Data for Observation SA112 of Plan SA112 acquired successfully.
2021-11-19 03:11:41.6: Plan SA112 completed successfully.
2021-11-19 03:11:41.6: Image Efficiency: 38.8%
2021-11-19 03:11:41.6: Cycle Efficiency: 99.8%
2021-11-19 03:11:41.9: Dispatcher cycle time: 0.2 sec.
2021-11-19 03:11:41.9: Acquire data for Observation SA114...
2021-11-19 03:11:42.0:   (belongs to Project Landolt, Plan SA114)
2021-11-19 03:11:42.0: Send Observation SA114 to ACP Sequencer
2021-11-19 03:19:27.3: Acquisition time: 465.3015688 sec.
2021-11-19 03:19:27.3: Data for Observation SA114 of Plan SA114 acquired successfully.
2021-11-19 03:19:27.3: Plan SA114 completed successfully.
2021-11-19 03:19:27.4: Image Efficiency: 40.8%
2021-11-19 03:19:27.4: Cycle Efficiency: 99.9%
2021-11-19 03:24:29.7: Dispatcher cycle time: 0.1 sec.
2021-11-19 03:24:29.7: Acquire data for Observation SA94...
2021-11-19 03:24:29.7:   (belongs to Project Landolt, Plan SA94)
2021-11-19 03:24:29.7: Send Observation SA94 to ACP Sequencer
2021-11-19 03:32:35.1: Acquisition time: 485.3883224 sec.
2021-11-19 03:32:35.1: Data for Observation SA94 of Plan SA94 acquired successfully.
2021-11-19 03:32:35.1: Plan SA94 completed successfully.
2021-11-19 03:32:35.1: Image Efficiency: 39.1%
2021-11-19 03:32:35.1: Cycle Efficiency: 100.0%
2021-11-19 03:32:35.5: Dispatcher cycle time: 0.2 sec.
2021-11-19 03:32:35.5: Acquire data for Observation SA112...
2021-11-19 03:32:35.5:   (belongs to Project Landolt, Plan SA112)
2021-11-19 03:32:35.5: Send Observation SA112 to ACP Sequencer
2021-11-19 03:41:36.8: Acquisition time: 541.314924 sec.
2021-11-19 03:41:36.8: Data for Observation SA112 of Plan SA112 acquired successfully.
2021-11-19 03:41:36.9: Plan SA112 completed successfully.
2021-11-19 03:41:36.9: Image Efficiency: 35.1%
2021-11-19 03:41:36.9: Cycle Efficiency: 99.9%
2021-11-19 03:41:37.3: Dispatcher cycle time: 0.3 sec.
2021-11-19 03:41:37.3: Acquire data for Observation SA114...
2021-11-19 03:41:37.4:   (belongs to Project Landolt, Plan SA114)
2021-11-19 03:41:37.4: Send Observation SA114 to ACP Sequencer
2021-11-19 03:51:09.4: ACP data acquisition failed for Observation SA114.
2021-11-19 03:51:09.4:   (Observation SA114 interrupted by acquisition process failure.)
2021-11-19 03:54:44.8: Dispatcher cycle time: 0.5 sec.
2021-11-19 03:54:44.8: Acquire data for Observation SA114...
2021-11-19 03:54:44.8:   (belongs to Project Landolt, Plan SA114)
2021-11-19 03:54:44.8: Send Observation SA114 to ACP Sequencer
2021-11-19 04:01:28.9: Acquisition time: 404.1298456 sec.
2021-11-19 04:01:28.9: Data for Observation SA114 of Plan SA114 acquired successfully.
2021-11-19 04:01:29.0: Plan SA114 completed successfully.
2021-11-19 04:01:29.0: Image Efficiency: 46.9%
2021-11-19 04:01:29.0: Cycle Efficiency: 99.8%
2021-11-19 04:03:16.9: ++ Auto Focus ++
2021-11-19 04:03:25.0: Doing periodic autofocus.
2021-11-19 04:03:25.2: Start special ACP AutoFocus script for scheduler
2021-11-19 04:03:25.9: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:04:26.1: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:05:26.5: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:06:26.6: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:07:26.9: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:08:27.0: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:09:27.1: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:10:27.4: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:11:27.8: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:12:28.1: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:13:28.3: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:14:28.4: WARNING: Request sent to busy ACP (AutoFocus)
2021-11-19 04:19:45.5: Next periodic autofocus ASAP after 3600sec. 19-Nov-2021 05:19:27 UTC
2021-11-19 04:22:09.9: Dispatcher cycle time: 0.3 sec.
2021-11-19 04:22:09.9: Acquire data for Observation SA114...
2021-11-19 04:22:09.9:   (belongs to Project Landolt, Plan SA114)
2021-11-19 04:22:10.0: Send Observation SA114 to ACP Sequencer
2021-11-19 04:26:15.7: ACP data acquisition failed for Observation SA114.
2021-11-19 04:26:15.7:   (Observation SA114 interrupted by acquisition process failure.)
2021-11-19 04:32:15.8: Dispatcher cycle time: 0.1 sec.
2021-11-19 04:32:15.8: Acquire data for Observation SA114...
2021-11-19 04:32:15.8:   (belongs to Project Landolt, Plan SA114)
2021-11-19 04:32:15.9: Send Observation SA114 to ACP Sequencer
2021-11-19 04:34:53.8: ** ACP script "AcquireScheduler" failed:
2021-11-19 04:34:53.8: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 1487 column 13.

2021-11-19 04:34:53.8: ACP OPERATOR ABORT: The operator killed the run
2021-11-19 04:34:53.9: ACP data acquisition failed for Observation SA114.
2021-11-19 04:34:53.9:   (Observation SA114 interrupted by acquisition process failure.)
2021-11-19 04:43:25.7: Dispatcher cycle time: 0.1 sec.
2021-11-19 04:43:25.7: Acquire data for Observation SA114...
2021-11-19 04:43:25.7:   (belongs to Project Landolt, Plan SA114)
2021-11-19 04:43:25.8: Send Observation SA114 to ACP Sequencer
2021-11-19 04:46:28.1: ACP data acquisition failed for Observation SA114.
2021-11-19 04:46:28.1:   (Observation SA114 interrupted by acquisition process failure.)
2021-11-19 04:48:12.3: Dispatcher cycle time: 0.1 sec.
2021-11-19 04:48:12.3: Acquire data for Observation SA114...
2021-11-19 04:48:12.3:   (belongs to Project Landolt, Plan SA114)
2021-11-19 04:48:12.3: Send Observation SA114 to ACP Sequencer
2021-11-19 04:48:31.6: ** ACP script "AcquireScheduler" failed:
2021-11-19 04:48:31.6: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 956 column 5.

2021-11-19 04:48:31.6: ACP OPERATOR ABORT: The operator killed the run
2021-11-19 04:48:31.6: ACP data acquisition failed for Observation SA114.
2021-11-19 04:48:31.6:   (Observation SA114 interrupted by acquisition process failure.)
2021-11-19 04:49:30.6: Dispatcher cycle time: 0.2 sec.
2021-11-19 04:49:30.6: Acquire data for Observation SA114...
2021-11-19 04:49:30.6:   (belongs to Project Landolt, Plan SA114)
2021-11-19 04:49:30.6: Send Observation SA114 to ACP Sequencer
2021-11-19 04:50:55.3: ** ACP script "AcquireScheduler" failed:
2021-11-19 04:50:55.3: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 1487 column 13.

2021-11-19 04:50:55.3: ACP OPERATOR ABORT: The operator killed the run
2021-11-19 04:50:55.3: ACP data acquisition failed for Observation SA114.
2021-11-19 04:50:55.3:   (Observation SA114 interrupted by acquisition process failure.)
2021-11-19 04:55:50.5: Dispatcher cycle time: 0.1 sec.
2021-11-19 04:55:50.5: Acquire data for Observation SA114...
2021-11-19 04:55:50.5:   (belongs to Project Landolt, Plan SA114)
2021-11-19 04:55:50.6: Send Observation SA114 to ACP Sequencer
2021-11-19 04:57:42.0: ACP data acquisition failed for Observation SA114.
2021-11-19 04:57:42.0:   (Observation SA114 interrupted by acquisition process failure.)
2021-11-19 05:03:57.2: Dispatcher cycle time: 0.1 sec.
2021-11-19 05:03:57.2: Acquire data for Observation SA114...
2021-11-19 05:03:57.2:   (belongs to Project Landolt, Plan SA114)
2021-11-19 05:03:57.2: Send Observation SA114 to ACP Sequencer
2021-11-19 05:09:04.5: Acquisition time: 307.2864728 sec.
2021-11-19 05:09:04.5: Data for Observation SA114 of Plan SA114 acquired successfully.
2021-11-19 05:09:04.5: Plan SA114 completed successfully.
2021-11-19 05:09:04.5: Image Efficiency: 45.5%
2021-11-19 05:09:04.5: Cycle Efficiency: 99.9%
2021-11-19 05:19:33.0: ++ Auto Focus ++
2021-11-19 05:19:33.2: Doing periodic autofocus.
2021-11-19 05:19:33.2: Start special ACP AutoFocus script for scheduler
2021-11-19 14:23:37.8: ** ACP script "AutoFocusScheduler" failed:
2021-11-19 14:23:37.8: **Script Error (Tracking has been stopped)**
Source:   ACP Observatory Control Software
Message:  
Location: line 81 column 2.

2021-11-19 14:23:37.9: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2021-11-19 14:23:43.4: Run statistics:
2021-11-19 14:23:43.4:   Observations:   1
2021-11-19 14:23:43.4:   Considered:     0
2021-11-19 14:23:43.4:   Completed:      0
2021-11-19 14:23:43.4:   Skipped:        0
2021-11-19 14:23:43.4:   Never Eligible: 1
2021-11-19 14:23:43.4:   Failed:         0
Log closed at Fri, Nov 19 2021 14:23:43 UTC (actual time)