Log opened at Tue, Oct 26 2021 02:53:28 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-10-26 02:53:28.3: REAL TIME internal clock initialized at 26-Oct-2021 02:53:28 UTC
2021-10-26 02:53:28.3: Dispatcher started at 26-Oct-2021 02:53:28 UTC
2021-10-26 02:53:28.4: Loaded Constraint plugin AirMass
2021-10-26 02:53:28.4: Loaded Constraint plugin AirmassRange
2021-10-26 02:53:28.4: Loaded Constraint plugin Horizon
2021-10-26 02:53:28.5: Loaded Constraint plugin HourAngle
2021-10-26 02:53:28.5: Loaded Constraint plugin MoonAvoid
2021-10-26 02:53:28.5: Loaded Constraint plugin MoonDown
2021-10-26 02:53:28.5: Loaded Constraint plugin SkyCondition
2021-10-26 02:53:28.5: Loaded Constraint plugin TimeRange
2021-10-26 02:53:29.4: 4 plans are now pending.
2021-10-26 02:53:29.4: Attach ACP sequencer
2021-10-26 02:53:35.7: Weather successfully connected. Wait for valid data...
2021-10-26 02:53:36.2: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2021-10-26 02:53:36.2: Sequencer does sky flats
2021-10-26 02:53:40.7: HTTP command listener failed to start: Access is denied
2021-10-26 02:53:40.7:   If this is Windows 8-10, you will need to add permission (ACL) to listen on port 9123.
2021-10-26 02:53:40.7:   See Scheduler Help > Configuring the Program > Noteworthy Configuration Options, at the bottom.
2021-10-26 02:53:40.7: ++ Weather Safe ++
2021-10-26 02:53:50.9: ++ Observatory Startup ++
2021-10-26 02:53:50.9: Weather safety is now disabled
2021-10-26 02:53:50.9: Start ACP Sequencer's StartupObs script
2021-10-26 02:54:06.3: Weather safety is re-enabled
2021-10-26 02:54:06.3: Weather safety is now disabled
2021-10-26 02:54:06.3: Open the observatory dome/roof
2021-10-26 02:54:52.0: Weather safety is re-enabled
2021-10-26 02:54:52.0: Observatory startup succeeded, and dome opened successfully
2021-10-26 02:54:52.1: ++ Auto Focus ++
2021-10-26 02:54:52.1: Doing initial autofocus.
2021-10-26 02:54:52.1: Start special ACP AutoFocus script for scheduler
2021-10-26 02:59:21.2: Next periodic autofocus ASAP after 3600sec. 26-Oct-2021 03:59:02 UTC
2021-10-26 02:59:22.1: Dispatcher cycle time: 0.8 sec.
2021-10-26 02:59:22.1: Acquire data for Observation TIC240681314...
2021-10-26 02:59:22.1:   (belongs to Project Transit, Plan TIC240681314)
2021-10-26 02:59:22.2: Send Observation TIC240681314 to ACP Sequencer
2021-10-26 04:37:58.3: ** ACP script "AcquireScheduler" failed:
2021-10-26 04:37:58.3: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 1487 column 13.

2021-10-26 04:37:58.3: ACP OPERATOR ABORT: The operator killed the run
2021-10-26 04:37:58.9: ACP data acquisition failed for Observation TIC240681314.
2021-10-26 04:37:58.9:   (Observation TIC240681314 interrupted by acquisition process failure.)
2021-10-26 04:37:59.1: ++ Auto Focus ++
2021-10-26 04:37:59.2: Doing periodic autofocus.
2021-10-26 04:37:59.2: Start special ACP AutoFocus script for scheduler
2021-10-26 04:43:25.7: Next periodic autofocus ASAP after 3600sec. 26-Oct-2021 05:43:07 UTC
2021-10-26 04:43:26.6: Dispatcher cycle time: 0.8 sec.
2021-10-26 04:43:26.6: Acquire data for Observation TIC382391899...
2021-10-26 04:43:26.6:   (belongs to Project Transit, Plan TIC382391899)
2021-10-26 04:43:26.6: Send Observation TIC382391899 to ACP Sequencer
2021-10-26 04:47:54.9: ACP data acquisition failed for Observation TIC382391899.
2021-10-26 04:47:54.9:   (Observation TIC382391899 interrupted by acquisition process failure.)
2021-10-26 04:47:55.2: Dispatcher cycle time: 0.1 sec.
2021-10-26 04:47:55.2: Acquire data for Observation TIC382391899...
2021-10-26 04:47:55.2:   (belongs to Project Transit, Plan TIC382391899)
2021-10-26 04:47:55.3: Send Observation TIC382391899 to ACP Sequencer
2021-10-26 04:48:21.8: ** ACP script "AcquireScheduler" failed:
2021-10-26 04:48:21.8: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 1487 column 13.

2021-10-26 04:48:21.8: ACP OPERATOR ABORT: The operator killed the run
2021-10-26 04:48:22.1: ACP data acquisition failed for Observation TIC382391899.
2021-10-26 04:48:22.1:   (Observation TIC382391899 interrupted by acquisition process failure.)
2021-10-26 04:48:22.4: Dispatcher cycle time: 0.1 sec.
2021-10-26 04:48:22.4: Acquire data for Observation TIC382391899...
2021-10-26 04:48:22.4:   (belongs to Project Transit, Plan TIC382391899)
2021-10-26 04:48:22.4: Send Observation TIC382391899 to ACP Sequencer
2021-10-26 04:48:38.1: ** ACP script "AcquireScheduler" failed:
2021-10-26 04:48:38.1: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 956 column 5.

2021-10-26 04:48:38.1: ACP OPERATOR ABORT: The operator killed the run
2021-10-26 04:48:38.3: ACP data acquisition failed for Observation TIC382391899.
2021-10-26 04:48:38.3:   (Observation TIC382391899 interrupted by acquisition process failure.)
2021-10-26 04:56:45.2: Dispatcher cycle time: 0.7 sec.
2021-10-26 04:56:45.2: Acquire data for Observation TIC427761355...
2021-10-26 04:56:45.2:   (belongs to Project Transit, Plan TIC427761355)
2021-10-26 04:56:45.2: Send Observation TIC427761355 to ACP Sequencer
2021-10-26 09:50:36.2: Acquisition time: 17630.9735755 sec.
2021-10-26 09:50:36.2: Data for Observation TIC427761355 of Plan TIC427761355 acquired successfully.
2021-10-26 09:50:36.3: Plan TIC427761355 completed successfully.
2021-10-26 09:50:36.3: Image Efficiency: 81.8%
2021-10-26 09:50:36.3: Cycle Efficiency: 100.0%
2021-10-26 09:50:36.6: ++ Auto Focus ++
2021-10-26 09:50:36.7: Doing periodic autofocus.
2021-10-26 09:50:36.7: Start special ACP AutoFocus script for scheduler
2021-10-26 09:56:28.9: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2021-10-26 09:56:34.8: ++ Auto Focus ++
2021-10-26 09:56:34.8: Doing periodic autofocus.
2021-10-26 09:56:34.8: Start special ACP AutoFocus script for scheduler
2021-10-26 10:00:35.7: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2021-10-26 10:05:36.5: ++ Auto Focus ++
2021-10-26 10:05:36.5: Doing periodic autofocus.
2021-10-26 10:05:36.5: Start special ACP AutoFocus script for scheduler
2021-10-26 10:11:01.9: Next periodic autofocus ASAP after 3600sec. 26-Oct-2021 11:10:36 UTC
2021-10-26 11:10:38.0: ++ Auto Focus ++
2021-10-26 11:10:38.0: Doing periodic autofocus.
2021-10-26 11:10:38.1: Start special ACP AutoFocus script for scheduler
2021-10-26 11:16:10.8: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2021-10-26 11:16:15.9: ++ Auto Focus ++
2021-10-26 11:16:16.0: Doing periodic autofocus.
2021-10-26 11:16:16.0: Start special ACP AutoFocus script for scheduler
2021-10-26 11:22:03.3: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2021-10-26 11:27:03.5: ++ Auto Focus ++
2021-10-26 11:27:03.5: Doing periodic autofocus.
2021-10-26 11:27:03.5: Start special ACP AutoFocus script for scheduler
2021-10-26 11:32:52.7: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2021-10-26 11:42:52.9: ++ Auto Focus ++
2021-10-26 11:42:52.9: Doing periodic autofocus.
2021-10-26 11:42:52.9: Start special ACP AutoFocus script for scheduler
2021-10-26 11:48:00.4: Next periodic autofocus ASAP after 3600sec. 26-Oct-2021 12:47:45 UTC
2021-10-26 11:52:50.5: Run statistics:
2021-10-26 11:52:50.5:   Observations:   16
2021-10-26 11:52:50.5:   Considered:     12
2021-10-26 11:52:50.5:   Completed:      0
2021-10-26 11:52:50.5:   Skipped:        2
2021-10-26 11:52:50.5:   Never Eligible: 4
2021-10-26 11:52:50.5:   Failed:         10
Log closed at Tue, Oct 26 2021 11:52:50 UTC (actual time)