Log opened at Thu, Jan 05 2023 03:27:30 UTC (actual time)
Current log level is Normal
ACP Expert Scheduler Engine Version 9.0.4
Part of ACP Expert 9.0 Release
Full license: Arne Henden
2023-01-05 03:27:30.0: REAL TIME internal clock initialized at 05-Jan-2023 03:27:30 UTC
2023-01-05 03:27:30.0: Dispatcher started at 05-Jan-2023 03:27:30 UTC
2023-01-05 03:27:30.0: Loaded Constraint plugin AirMass
2023-01-05 03:27:30.0: Loaded Constraint plugin AirmassRange
2023-01-05 03:27:30.0: Loaded Constraint plugin Horizon
2023-01-05 03:27:30.0: Loaded Constraint plugin HourAngle
2023-01-05 03:27:30.0: Loaded Constraint plugin MoonAvoid
2023-01-05 03:27:30.0: Loaded Constraint plugin MoonDown
2023-01-05 03:27:30.0: Loaded Constraint plugin SkyCondition
2023-01-05 03:27:30.0: Loaded Constraint plugin TimeRange
2023-01-05 03:27:31.9: 228 plans are now pending.
2023-01-05 03:27:31.9: Attach ACP sequencer
2023-01-05 03:27:39.7: ++ Weather Safe ++
2023-01-05 03:27:40.0: ==== Dispatcher is running in NORMAL (NIGHT) mode ====
2023-01-05 03:27:40.0: Sequencer does sky flats
2023-01-05 03:27:48.4: ++ Observatory Startup ++
2023-01-05 03:27:48.4: Weather safety is now disabled
2023-01-05 03:27:48.4: Start ACP Sequencer's StartupObs script
2023-01-05 03:28:21.3: Weather safety is re-enabled
2023-01-05 03:28:21.3: Observatory startup succeeded
2023-01-05 03:28:21.3: Periodic AF schedule reset. Interval is now 1.0 hours
2023-01-05 03:28:21.3: Last AutoFocus was completed at 27-Dec-2022 12:13:26 UTC
2023-01-05 03:28:21.3: Autofocus will be done ASAP.
2023-01-05 03:28:21.3: ++ Auto Focus ++
2023-01-05 03:28:21.3: Doing periodic autofocus.
2023-01-05 03:28:21.3: Start special ACP AutoFocus script for scheduler
2023-01-05 03:32:00.0: Next periodic autofocus ASAP after 3600sec. 05-Jan-2023 04:31:46 UTC
2023-01-05 03:32:02.4: Rising plan delay enabled for Plan CSS091110:060919-064155:
2023-01-05 03:32:02.4:     357 min. remaining to meet strict constraints.
2023-01-05 03:32:02.4:     556 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.4:     but only 154 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.4:     deferred (rising) for 152 min, until 05-Jan-2023 06:04:19 UTC
2023-01-05 03:32:02.4: Rising plan delay enabled for Plan CSS091110:060919-064155:
2023-01-05 03:32:02.4:     357 min. remaining to meet strict constraints.
2023-01-05 03:32:02.4:     556 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.4:     but only 154 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.4:     deferred (rising) for 152 min, until 05-Jan-2023 06:04:19 UTC
2023-01-05 03:32:02.4: Rising plan delay enabled for Plan CW_Mon:
2023-01-05 03:32:02.4:     408 min. remaining to meet strict constraints.
2023-01-05 03:32:02.4:     571 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.4:     but only 189 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.4:     deferred (rising) for 188 min, until 05-Jan-2023 06:40:53 UTC
2023-01-05 03:32:02.4: Rising plan delay enabled for Plan CW_Mon:
2023-01-05 03:32:02.4:     408 min. remaining to meet strict constraints.
2023-01-05 03:32:02.4:     571 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.4:     but only 189 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.4:     deferred (rising) for 188 min, until 05-Jan-2023 06:40:53 UTC
2023-01-05 03:32:02.4: Rising plan delay enabled for Plan GR_Ori:
2023-01-05 03:32:02.4:     336 min. remaining to meet strict constraints.
2023-01-05 03:32:02.4:     572 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.4:     but only 114 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.4:     deferred (rising) for 114 min, until 05-Jan-2023 05:26:07 UTC
2023-01-05 03:32:02.4: Rising plan delay enabled for Plan GR_Ori:
2023-01-05 03:32:02.4:     336 min. remaining to meet strict constraints.
2023-01-05 03:32:02.4:     572 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.4:     but only 114 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.4:     deferred (rising) for 114 min, until 05-Jan-2023 05:26:07 UTC
2023-01-05 03:32:02.5: Rising plan delay enabled for Plan J072816:
2023-01-05 03:32:02.5:     623 min. remaining to meet strict constraints.
2023-01-05 03:32:02.5:     552 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.5:     but only 231 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.5:     deferred (rising) for 228 min, until 05-Jan-2023 07:20:41 UTC
2023-01-05 03:32:02.5: Rising plan delay enabled for Plan J072816:
2023-01-05 03:32:02.5:     623 min. remaining to meet strict constraints.
2023-01-05 03:32:02.5:     552 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.5:     but only 231 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.5:     deferred (rising) for 228 min, until 05-Jan-2023 07:20:41 UTC
2023-01-05 03:32:02.5: Rising plan delay enabled for Plan KN_Lyn:
2023-01-05 03:32:02.5:     651 min. remaining to meet strict constraints.
2023-01-05 03:32:02.5:     541 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.5:     but only 274 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.5:     deferred (rising) for 270 min, until 05-Jan-2023 08:02:27 UTC
2023-01-05 03:32:02.6: Rising plan delay enabled for Plan MP_Gem:
2023-01-05 03:32:02.6:     469 min. remaining to meet strict constraints.
2023-01-05 03:32:02.6:     546 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.6:     but only 188 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.6:     deferred (rising) for 185 min, until 05-Jan-2023 06:37:36 UTC
2023-01-05 03:32:02.6: Rising plan delay enabled for Plan MP_Gem:
2023-01-05 03:32:02.6:     469 min. remaining to meet strict constraints.
2023-01-05 03:32:02.6:     522 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.6:     but only 176 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.6:     deferred (rising) for 170 min, until 05-Jan-2023 06:22:51 UTC
2023-01-05 03:32:02.7: Rising plan delay enabled for Plan NQ_Gem:
2023-01-05 03:32:02.7:     523 min. remaining to meet strict constraints.
2023-01-05 03:32:02.7:     572 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.7:     but only 244 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.7:     deferred (rising) for 244 min, until 05-Jan-2023 07:36:08 UTC
2023-01-05 03:32:02.7: Rising plan delay enabled for Plan NSVS_0421121:
2023-01-05 03:32:02.7:     316 min. remaining to meet strict constraints.
2023-01-05 03:32:02.7:     562 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.7:     but only 49 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.7:     deferred (rising) for 48 min, until 05-Jan-2023 04:20:08 UTC
2023-01-05 03:32:02.7: Rising plan delay enabled for Plan NSVS_0421121:
2023-01-05 03:32:02.7:     316 min. remaining to meet strict constraints.
2023-01-05 03:32:02.7:     562 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.7:     but only 49 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.7:     deferred (rising) for 48 min, until 05-Jan-2023 04:20:08 UTC
2023-01-05 03:32:02.8: Rising plan delay enabled for Plan OI_158:
2023-01-05 03:32:02.8:     515 min. remaining to meet strict constraints.
2023-01-05 03:32:02.8:     565 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.8:     but only 247 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.8:     deferred (rising) for 246 min, until 05-Jan-2023 07:38:19 UTC
2023-01-05 03:32:02.8: Rising plan delay enabled for Plan OI_158:
2023-01-05 03:32:02.8:     515 min. remaining to meet strict constraints.
2023-01-05 03:32:02.8:     565 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.8:     but only 247 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.8:     deferred (rising) for 246 min, until 05-Jan-2023 07:38:19 UTC
2023-01-05 03:32:02.8: Rising plan delay enabled for Plan S_Ori:
2023-01-05 03:32:02.8:     325 min. remaining to meet strict constraints.
2023-01-05 03:32:02.8:     559 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.8:     but only 115 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.8:     deferred (rising) for 113 min, until 05-Jan-2023 05:25:52 UTC
2023-01-05 03:32:02.8: Rising plan delay enabled for Plan S5_0716+714:
2023-01-05 03:32:02.8:     603 min. remaining to meet strict constraints.
2023-01-05 03:32:02.8:     575 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.8:     but only 236 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.8:     deferred (rising) for 235 min, until 05-Jan-2023 07:27:50 UTC
2023-01-05 03:32:02.8: Rising plan delay enabled for Plan SU_Lyn:
2023-01-05 03:32:02.8:     530 min. remaining to meet strict constraints.
2023-01-05 03:32:02.8:     572 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.8:     but only 195 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.8:     deferred (rising) for 195 min, until 05-Jan-2023 06:47:13 UTC
2023-01-05 03:32:02.8: Rising plan delay enabled for Plan SU_Lyn:
2023-01-05 03:32:02.8:     530 min. remaining to meet strict constraints.
2023-01-05 03:32:02.8:     573 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.8:     but only 196 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.8:     deferred (rising) for 195 min, until 05-Jan-2023 06:47:45 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan TIC279999655:
2023-01-05 03:32:02.9:     512 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     208 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 67 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 30 min, until 05-Jan-2023 04:02:03 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan TIC279999655:
2023-01-05 03:32:02.9:     512 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     301 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 113 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 85 min, until 05-Jan-2023 04:57:33 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan TIC279999655:
2023-01-05 03:32:02.9:     512 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     393 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 159 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 141 min, until 05-Jan-2023 05:53:03 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan TV_Cam:
2023-01-05 03:32:02.9:     384 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     565 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 37 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 36 min, until 05-Jan-2023 04:08:04 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan TV_Cam:
2023-01-05 03:32:02.9:     384 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     565 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 37 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 36 min, until 05-Jan-2023 04:08:04 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan TV_Cam:
2023-01-05 03:32:02.9:     384 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     565 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 37 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 36 min, until 05-Jan-2023 04:08:04 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan V1112_Per:
2023-01-05 03:32:02.9:     376 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     563 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 58 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 56 min, until 05-Jan-2023 04:28:29 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan V1261_Ori:
2023-01-05 03:32:02.9:     303 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     575 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 117 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 116 min, until 05-Jan-2023 05:28:44 UTC
2023-01-05 03:32:02.9: Rising plan delay enabled for Plan V1647_Ori:
2023-01-05 03:32:02.9:     357 min. remaining to meet strict constraints.
2023-01-05 03:32:02.9:     564 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:02.9:     but only 135 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:02.9:     deferred (rising) for 133 min, until 05-Jan-2023 05:45:55 UTC
2023-01-05 03:32:03.0: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 03:32:03.0:     456 min. remaining to meet strict constraints.
2023-01-05 03:32:03.0:     557 min. remaining for the plan to fit before dawn.
2023-01-05 03:32:03.0:     but only 209 min till start so Plan transits mid-way in its time span.
2023-01-05 03:32:03.0:     deferred (rising) for 207 min, until 05-Jan-2023 06:59:13 UTC
2023-01-05 03:32:03.2: Dispatcher cycle time: 3.2 sec.
2023-01-05 03:32:03.2: Acquire data for Observation TIC35022727...
2023-01-05 03:32:03.2:   (belongs to Project Transit, Plan TIC35022727)
2023-01-05 03:32:03.3: Send Observation TIC35022727 to ACP Sequencer
2023-01-05 03:33:38.4: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2023-01-05 03:35:21.9: ** ACP script "AcquireScheduler" failed:
2023-01-05 03:35:21.9: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 1168 column 17.

2023-01-05 03:35:21.9: RUN FAILED: Scheduler was stopped during run
2023-01-05 03:35:22.0: ACP data acquisition failed for Observation TIC35022727.
2023-01-05 03:35:22.0:   (Observation TIC35022727 interrupted by operator or system.)
2023-01-05 03:35:25.2: ++ Observatory Startup ++
2023-01-05 03:35:25.2: Weather safety is now disabled
2023-01-05 03:35:25.2: Start ACP Sequencer's StartupObs script
2023-01-05 03:35:46.8: Weather safety is re-enabled
2023-01-05 03:35:46.8: Observatory startup succeeded
2023-01-05 03:35:46.8: Periodic AF schedule reset. Interval is now 1.0 hours
2023-01-05 03:35:46.8: Last AutoFocus was completed at 05-Jan-2023 03:31:46 UTC
2023-01-05 03:35:46.8: Next AutoFocus in 56.0 minutes or ASAP after that.
2023-01-05 03:35:48.6: Rising plan delay enabled for Plan CSS091110:060919-064155:
2023-01-05 03:35:48.6:     354 min. remaining to meet strict constraints.
2023-01-05 03:35:48.6:     552 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.6:     but only 150 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.6:     deferred (rising) for 148 min, until 05-Jan-2023 06:04:19 UTC
2023-01-05 03:35:48.6: Rising plan delay enabled for Plan CSS091110:060919-064155:
2023-01-05 03:35:48.6:     354 min. remaining to meet strict constraints.
2023-01-05 03:35:48.6:     552 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.6:     but only 150 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.6:     deferred (rising) for 148 min, until 05-Jan-2023 06:04:19 UTC
2023-01-05 03:35:48.6: Rising plan delay enabled for Plan CW_Mon:
2023-01-05 03:35:48.6:     404 min. remaining to meet strict constraints.
2023-01-05 03:35:48.6:     567 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.6:     but only 185 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.6:     deferred (rising) for 185 min, until 05-Jan-2023 06:40:53 UTC
2023-01-05 03:35:48.6: Rising plan delay enabled for Plan CW_Mon:
2023-01-05 03:35:48.6:     404 min. remaining to meet strict constraints.
2023-01-05 03:35:48.6:     567 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.6:     but only 185 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.6:     deferred (rising) for 185 min, until 05-Jan-2023 06:40:53 UTC
2023-01-05 03:35:48.7: Rising plan delay enabled for Plan GR_Ori:
2023-01-05 03:35:48.7:     333 min. remaining to meet strict constraints.
2023-01-05 03:35:48.7:     568 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.7:     but only 111 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.7:     deferred (rising) for 110 min, until 05-Jan-2023 05:26:07 UTC
2023-01-05 03:35:48.7: Rising plan delay enabled for Plan GR_Ori:
2023-01-05 03:35:48.7:     333 min. remaining to meet strict constraints.
2023-01-05 03:35:48.7:     568 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.7:     but only 111 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.7:     deferred (rising) for 110 min, until 05-Jan-2023 05:26:07 UTC
2023-01-05 03:35:48.7: Rising plan delay enabled for Plan J072816:
2023-01-05 03:35:48.7:     619 min. remaining to meet strict constraints.
2023-01-05 03:35:48.7:     548 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.7:     but only 227 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.7:     deferred (rising) for 224 min, until 05-Jan-2023 07:20:41 UTC
2023-01-05 03:35:48.7: Rising plan delay enabled for Plan J072816:
2023-01-05 03:35:48.7:     619 min. remaining to meet strict constraints.
2023-01-05 03:35:48.7:     548 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.7:     but only 227 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.7:     deferred (rising) for 224 min, until 05-Jan-2023 07:20:41 UTC
2023-01-05 03:35:48.8: Rising plan delay enabled for Plan KN_Lyn:
2023-01-05 03:35:48.8:     647 min. remaining to meet strict constraints.
2023-01-05 03:35:48.8:     538 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.8:     but only 270 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.8:     deferred (rising) for 266 min, until 05-Jan-2023 08:02:27 UTC
2023-01-05 03:35:48.8: Rising plan delay enabled for Plan MP_Gem:
2023-01-05 03:35:48.8:     466 min. remaining to meet strict constraints.
2023-01-05 03:35:48.8:     518 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.8:     but only 172 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.8:     deferred (rising) for 167 min, until 05-Jan-2023 06:22:51 UTC
2023-01-05 03:35:48.8: Rising plan delay enabled for Plan MP_Gem:
2023-01-05 03:35:48.8:     466 min. remaining to meet strict constraints.
2023-01-05 03:35:48.8:     543 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.8:     but only 185 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.8:     deferred (rising) for 181 min, until 05-Jan-2023 06:37:36 UTC
2023-01-05 03:35:48.9: Rising plan delay enabled for Plan NQ_Gem:
2023-01-05 03:35:48.9:     519 min. remaining to meet strict constraints.
2023-01-05 03:35:48.9:     568 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:48.9:     but only 241 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:48.9:     deferred (rising) for 240 min, until 05-Jan-2023 07:36:08 UTC
2023-01-05 03:35:49.0: Rising plan delay enabled for Plan NSVS_0421121:
2023-01-05 03:35:49.0:     312 min. remaining to meet strict constraints.
2023-01-05 03:35:49.0:     558 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.0:     but only 46 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.0:     deferred (rising) for 44 min, until 05-Jan-2023 04:20:08 UTC
2023-01-05 03:35:49.0: Rising plan delay enabled for Plan NSVS_0421121:
2023-01-05 03:35:49.0:     312 min. remaining to meet strict constraints.
2023-01-05 03:35:49.0:     558 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.0:     but only 46 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.0:     deferred (rising) for 44 min, until 05-Jan-2023 04:20:08 UTC
2023-01-05 03:35:49.0: Rising plan delay enabled for Plan OI_158:
2023-01-05 03:35:49.0:     511 min. remaining to meet strict constraints.
2023-01-05 03:35:49.0:     561 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.0:     but only 243 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.0:     deferred (rising) for 242 min, until 05-Jan-2023 07:38:19 UTC
2023-01-05 03:35:49.0: Rising plan delay enabled for Plan OI_158:
2023-01-05 03:35:49.0:     511 min. remaining to meet strict constraints.
2023-01-05 03:35:49.0:     561 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.0:     but only 243 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.0:     deferred (rising) for 242 min, until 05-Jan-2023 07:38:19 UTC
2023-01-05 03:35:49.0: Rising plan delay enabled for Plan S_Ori:
2023-01-05 03:35:49.1:     321 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     555 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 112 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 110 min, until 05-Jan-2023 05:25:52 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan S5_0716+714:
2023-01-05 03:35:49.1:     600 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     571 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 232 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 232 min, until 05-Jan-2023 07:27:50 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan SU_Lyn:
2023-01-05 03:35:49.1:     526 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     568 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 192 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 191 min, until 05-Jan-2023 06:47:13 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan SU_Lyn:
2023-01-05 03:35:49.1:     526 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     569 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 192 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 191 min, until 05-Jan-2023 06:47:45 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan TV_Cam:
2023-01-05 03:35:49.1:     381 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     561 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 33 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 32 min, until 05-Jan-2023 04:08:04 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan TV_Cam:
2023-01-05 03:35:49.1:     381 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     561 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 33 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 32 min, until 05-Jan-2023 04:08:04 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan TV_Cam:
2023-01-05 03:35:49.1:     381 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     561 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 33 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 32 min, until 05-Jan-2023 04:08:04 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan V1112_Per:
2023-01-05 03:35:49.1:     373 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     559 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 54 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 52 min, until 05-Jan-2023 04:28:29 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan V1261_Ori:
2023-01-05 03:35:49.1:     299 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     571 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 113 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 112 min, until 05-Jan-2023 05:28:44 UTC
2023-01-05 03:35:49.1: Rising plan delay enabled for Plan V1647_Ori:
2023-01-05 03:35:49.1:     353 min. remaining to meet strict constraints.
2023-01-05 03:35:49.1:     560 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.1:     but only 131 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.1:     deferred (rising) for 130 min, until 05-Jan-2023 05:45:55 UTC
2023-01-05 03:35:49.2: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 03:35:49.2:     452 min. remaining to meet strict constraints.
2023-01-05 03:35:49.2:     553 min. remaining for the plan to fit before dawn.
2023-01-05 03:35:49.2:     but only 205 min till start so Plan transits mid-way in its time span.
2023-01-05 03:35:49.2:     deferred (rising) for 203 min, until 05-Jan-2023 06:59:13 UTC
2023-01-05 03:35:49.4: Dispatcher cycle time: 2.6 sec.
2023-01-05 03:35:49.4: Acquire data for Observation EE_Cep...
2023-01-05 03:35:49.4:   (belongs to Project AAVSO_MISC_SBL_AUTO_ver3391, Plan EE_Cep)
2023-01-05 03:35:49.4: Send Observation EE_Cep to ACP Sequencer
2023-01-05 03:51:21.4: Acquisition time: 932.0184984 sec.
2023-01-05 03:51:21.4: Data for Observation EE_Cep of Plan EE_Cep acquired successfully.
2023-01-05 03:51:21.4: Plan EE_Cep completed successfully.
2023-01-05 03:51:21.4: Image Efficiency: 70.2%
2023-01-05 03:51:21.4: Cycle Efficiency: 99.7%
2023-01-05 03:51:21.6: Rising plan delay enabled for Plan HQ_Mon:
2023-01-05 03:51:21.6:     426 min. remaining to meet strict constraints.
2023-01-05 03:51:21.6:     549 min. remaining for the plan to fit before dawn.
2023-01-05 03:51:21.6:     but only 203 min till start so Plan transits mid-way in its time span.
2023-01-05 03:51:21.6:     deferred (rising) for 202 min, until 05-Jan-2023 07:13:39 UTC
2023-01-05 03:51:21.6: Rising plan delay enabled for Plan HQ_Mon:
2023-01-05 03:51:21.6:     426 min. remaining to meet strict constraints.
2023-01-05 03:51:21.6:     549 min. remaining for the plan to fit before dawn.
2023-01-05 03:51:21.6:     but only 203 min till start so Plan transits mid-way in its time span.
2023-01-05 03:51:21.6:     deferred (rising) for 202 min, until 05-Jan-2023 07:13:39 UTC
2023-01-05 03:51:21.7: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 03:51:21.7:     403 min. remaining to meet strict constraints.
2023-01-05 03:51:21.7:     522 min. remaining for the plan to fit before dawn.
2023-01-05 03:51:21.7:     121148 min. remaining for the plan to fit before "must run before" time.
2023-01-05 03:51:21.7:     but only 182 min till start so Plan transits mid-way in its time span.
2023-01-05 03:51:21.7:     deferred (rising) for 178 min, until 05-Jan-2023 06:50:02 UTC
2023-01-05 03:51:21.7: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 03:51:21.7:     403 min. remaining to meet strict constraints.
2023-01-05 03:51:21.7:     474 min. remaining for the plan to fit before dawn.
2023-01-05 03:51:21.7:     but only 158 min till start so Plan transits mid-way in its time span.
2023-01-05 03:51:21.7:     deferred (rising) for 149 min, until 05-Jan-2023 06:20:56 UTC
2023-01-05 03:51:21.9: Dispatcher cycle time: 0.3 sec.
2023-01-05 03:51:21.9: Acquire data for Observation AF_And...
2023-01-05 03:51:21.9:   (belongs to Project AAVSO_P251_MSD_AUTO_ver2819, Plan AF_And)
2023-01-05 03:51:21.9: Send Observation AF_And to ACP Sequencer
2023-01-05 04:18:21.1: Acquisition time: 1619.2435923 sec.
2023-01-05 04:18:21.1: Data for Observation AF_And of Plan AF_And acquired successfully.
2023-01-05 04:18:21.1: Plan AF_And completed successfully.
2023-01-05 04:18:21.1: Image Efficiency: 81.5%
2023-01-05 04:18:21.1: Cycle Efficiency: 100.0%
2023-01-05 04:18:21.2: Rising plan delay enabled for Plan 2MASS_J07092139-1029344:
2023-01-05 04:18:21.2:     373 min. remaining to meet strict constraints.
2023-01-05 04:18:21.2:     516 min. remaining for the plan to fit before dawn.
2023-01-05 04:18:21.2:     but only 171 min till start so Plan transits mid-way in its time span.
2023-01-05 04:18:21.2:     deferred (rising) for 169 min, until 05-Jan-2023 07:07:51 UTC
2023-01-05 04:18:21.3: Rising plan delay enabled for Plan L1022_IRS:
2023-01-05 04:18:21.3:     353 min. remaining to meet strict constraints.
2023-01-05 04:18:21.3:     523 min. remaining for the plan to fit before dawn.
2023-01-05 04:18:21.3:     but only 162 min till start so Plan transits mid-way in its time span.
2023-01-05 04:18:21.3:     deferred (rising) for 161 min, until 05-Jan-2023 06:59:53 UTC
2023-01-05 04:18:21.3: Rising plan delay enabled for Plan L1022_IRS:
2023-01-05 04:18:21.3:     353 min. remaining to meet strict constraints.
2023-01-05 04:18:21.3:     523 min. remaining for the plan to fit before dawn.
2023-01-05 04:18:21.3:     but only 162 min till start so Plan transits mid-way in its time span.
2023-01-05 04:18:21.3:     deferred (rising) for 161 min, until 05-Jan-2023 06:59:53 UTC
2023-01-05 04:18:21.3: Rising plan delay enabled for Plan NGC_1904:
2023-01-05 04:18:21.3:     156 min. remaining to meet strict constraints.
2023-01-05 04:18:21.3:     513 min. remaining for the plan to fit before dawn.
2023-01-05 04:18:21.3:     but only 65 min till start so Plan transits mid-way in its time span.
2023-01-05 04:18:21.3:     deferred (rising) for 63 min, until 05-Jan-2023 05:21:28 UTC
2023-01-05 04:18:21.3: Rising plan delay enabled for Plan RY_Lep:
2023-01-05 04:18:21.3:     221 min. remaining to meet strict constraints.
2023-01-05 04:18:21.3:     528 min. remaining for the plan to fit before dawn.
2023-01-05 04:18:21.3:     but only 96 min till start so Plan transits mid-way in its time span.
2023-01-05 04:18:21.3:     deferred (rising) for 95 min, until 05-Jan-2023 05:54:11 UTC
2023-01-05 04:18:21.4: Rising plan delay enabled for Plan V900_Mon:
2023-01-05 04:18:21.4:     352 min. remaining to meet strict constraints.
2023-01-05 04:18:21.4:     508 min. remaining for the plan to fit before dawn.
2023-01-05 04:18:21.4:     but only 155 min till start so Plan transits mid-way in its time span.
2023-01-05 04:18:21.4:     deferred (rising) for 152 min, until 05-Jan-2023 06:51:14 UTC
2023-01-05 04:18:21.5: Dispatcher cycle time: 0.3 sec.
2023-01-05 04:18:21.5: Acquire data for Observation TV_Cam...
2023-01-05 04:18:21.5:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3389, Plan TV_Cam)
2023-01-05 04:18:21.5: Send Observation TV_Cam to ACP Sequencer
2023-01-05 04:35:41.3: Acquisition time: 1039.7519434 sec.
2023-01-05 04:35:41.3: Data for Observation TV_Cam of Plan TV_Cam acquired successfully.
2023-01-05 04:35:41.3: Plan TV_Cam completed successfully.
2023-01-05 04:35:41.3: Image Efficiency: 53.8%
2023-01-05 04:35:41.3: Cycle Efficiency: 100.0%
2023-01-05 04:35:41.4: ++ Auto Focus ++
2023-01-05 04:35:41.4: Doing periodic autofocus.
2023-01-05 04:35:41.4: Start special ACP AutoFocus script for scheduler
2023-01-05 04:40:14.4: Next periodic autofocus ASAP after 3600sec. 05-Jan-2023 05:39:53 UTC
2023-01-05 04:40:14.5: Rising plan delay enabled for Plan OJ287:
2023-01-05 04:40:14.5:     528 min. remaining to meet strict constraints.
2023-01-05 04:40:14.5:     493 min. remaining for the plan to fit before dawn.
2023-01-05 04:40:14.5:     but only 253 min till start so Plan transits mid-way in its time span.
2023-01-05 04:40:14.5:     deferred (rising) for 251 min, until 05-Jan-2023 08:52:13 UTC
2023-01-05 04:40:14.5: Rising plan delay enabled for Plan OJ287:
2023-01-05 04:40:14.5:     528 min. remaining to meet strict constraints.
2023-01-05 04:40:14.5:     493 min. remaining for the plan to fit before dawn.
2023-01-05 04:40:14.5:     but only 253 min till start so Plan transits mid-way in its time span.
2023-01-05 04:40:14.5:     deferred (rising) for 251 min, until 05-Jan-2023 08:52:13 UTC
2023-01-05 04:40:14.6: Dispatcher cycle time: 0.3 sec.
2023-01-05 04:40:14.6: Acquire data for Observation V0704_And...
2023-01-05 04:40:14.6:   (belongs to Project AAVSO_P253_CDAG_AUTO_ver3388, Plan V0704_And)
2023-01-05 04:40:14.7: Send Observation V0704_And to ACP Sequencer
2023-01-05 04:49:16.5: Acquisition time: 541.8222318 sec.
2023-01-05 04:49:16.5: Data for Observation V0704_And of Plan V0704_And acquired successfully.
2023-01-05 04:49:16.5: Plan V0704_And completed successfully.
2023-01-05 04:49:16.5: Image Efficiency: 39.8%
2023-01-05 04:49:16.5: Cycle Efficiency: 100.0%
2023-01-05 04:49:16.9: Dispatcher cycle time: 0.3 sec.
2023-01-05 04:49:16.9: Acquire data for Observation AZ_Cas...
2023-01-05 04:49:16.9:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan AZ_Cas)
2023-01-05 04:49:17.0: Send Observation AZ_Cas to ACP Sequencer
2023-01-05 04:51:58.1: Acquisition time: 161.0695528 sec.
2023-01-05 04:51:58.1: Data for Observation AZ_Cas of Plan AZ_Cas acquired successfully.
2023-01-05 04:51:58.1: Plan AZ_Cas completed successfully.
2023-01-05 04:51:58.1: Image Efficiency: 18.6%
2023-01-05 04:51:58.1: Cycle Efficiency: 99.8%
2023-01-05 04:51:58.4: Dispatcher cycle time: 0.2 sec.
2023-01-05 04:51:58.4: Acquire data for Observation KK_Cas...
2023-01-05 04:51:58.4:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan KK_Cas)
2023-01-05 04:51:58.5: Send Observation KK_Cas to ACP Sequencer
2023-01-05 05:07:10.5: Acquisition time: 912.0550882 sec.
2023-01-05 05:07:10.5: Data for Observation KK_Cas of Plan KK_Cas acquired successfully.
2023-01-05 05:07:10.5: Plan KK_Cas completed successfully.
2023-01-05 05:07:10.5: Image Efficiency: 57.0%
2023-01-05 05:07:10.5: Cycle Efficiency: 100.0%
2023-01-05 05:07:10.9: Dispatcher cycle time: 0.2 sec.
2023-01-05 05:07:10.9: Acquire data for Observation V504_Per...
2023-01-05 05:07:10.9:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan V504_Per)
2023-01-05 05:07:10.9: Send Observation V504_Per to ACP Sequencer
2023-01-05 05:19:28.9: Acquisition time: 738.0515172 sec.
2023-01-05 05:19:28.9: Data for Observation V504_Per of Plan V504_Per acquired successfully.
2023-01-05 05:19:28.9: Plan V504_Per completed successfully.
2023-01-05 05:19:28.9: Image Efficiency: 24.9%
2023-01-05 05:19:28.9: Cycle Efficiency: 100.0%
2023-01-05 05:19:29.1: Rising plan delay enabled for Plan QX_Pup:
2023-01-05 05:19:29.1:     306 min. remaining to meet strict constraints.
2023-01-05 05:19:29.1:     460 min. remaining for the plan to fit before dawn.
2023-01-05 05:19:29.1:     but only 144 min till start so Plan transits mid-way in its time span.
2023-01-05 05:19:29.1:     deferred (rising) for 143 min, until 05-Jan-2023 07:43:01 UTC
2023-01-05 05:19:29.4: Dispatcher cycle time: 0.4 sec.
2023-01-05 05:19:29.4: Acquire data for Observation B0133+47...
2023-01-05 05:19:29.4:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan B0133+47)
2023-01-05 05:19:29.4: Send Observation B0133+47 to ACP Sequencer
2023-01-05 05:31:36.7: Acquisition time: 727.2673241 sec.
2023-01-05 05:31:36.7: Data for Observation B0133+47 of Plan B0133+47 acquired successfully.
2023-01-05 05:31:36.7: Plan B0133+47 completed successfully.
2023-01-05 05:31:36.7: Image Efficiency: 74.2%
2023-01-05 05:31:36.7: Cycle Efficiency: 99.9%
2023-01-05 05:31:36.8: Rising plan delay enabled for Plan GZ_Cnc:
2023-01-05 05:31:36.8:     472 min. remaining to meet strict constraints.
2023-01-05 05:31:36.8:     440 min. remaining for the plan to fit before dawn.
2023-01-05 05:31:36.8:     but only 222 min till start so Plan transits mid-way in its time span.
2023-01-05 05:31:36.8:     deferred (rising) for 220 min, until 05-Jan-2023 09:12:21 UTC
2023-01-05 05:31:36.8: Rising plan delay enabled for Plan GZ_Cnc:
2023-01-05 05:31:36.8:     472 min. remaining to meet strict constraints.
2023-01-05 05:31:36.8:     440 min. remaining for the plan to fit before dawn.
2023-01-05 05:31:36.8:     but only 222 min till start so Plan transits mid-way in its time span.
2023-01-05 05:31:36.8:     deferred (rising) for 220 min, until 05-Jan-2023 09:12:21 UTC
2023-01-05 05:31:36.9: Rising plan delay enabled for Plan NGC_1904:
2023-01-05 05:31:36.9:     83 min. remaining to meet strict constraints.
2023-01-05 05:31:36.9:     440 min. remaining for the plan to fit before dawn.
2023-01-05 05:31:36.9:     but only -8 min till start so Plan transits mid-way in its time span.
2023-01-05 05:31:36.9:     ending rising plan delay. Plan is now eligible.
2023-01-05 05:31:36.9: Rising plan delay enabled for Plan S_Ori:
2023-01-05 05:31:36.9:     205 min. remaining to meet strict constraints.
2023-01-05 05:31:36.9:     440 min. remaining for the plan to fit before dawn.
2023-01-05 05:31:36.9:     but only -3 min till start so Plan transits mid-way in its time span.
2023-01-05 05:31:36.9:     ending rising plan delay. Plan is now eligible.
2023-01-05 05:31:37.3: Dispatcher cycle time: 0.5 sec.
2023-01-05 05:31:37.3: Acquire data for Observation AE_And...
2023-01-05 05:31:37.3:   (belongs to Project AAVSO_P251_MSD_AUTO_ver2819, Plan AE_And)
2023-01-05 05:31:37.3: Send Observation AE_And to ACP Sequencer
2023-01-05 05:58:39.4: Acquisition time: 1622.0482722 sec.
2023-01-05 05:58:39.4: Data for Observation AE_And of Plan AE_And acquired successfully.
2023-01-05 05:58:39.4: Plan AE_And completed successfully.
2023-01-05 05:58:39.4: Image Efficiency: 81.4%
2023-01-05 05:58:39.4: Cycle Efficiency: 100.0%
2023-01-05 05:58:39.5: ++ Auto Focus ++
2023-01-05 05:58:39.5: Doing periodic autofocus.
2023-01-05 05:58:39.5: Start special ACP AutoFocus script for scheduler
2023-01-05 06:03:44.8: Next periodic autofocus ASAP after 7200sec. 05-Jan-2023 08:03:28 UTC
2023-01-05 06:03:44.9: Rising plan delay enabled for Plan Mrk_180:
2023-01-05 06:03:44.9:     702 min. remaining to meet strict constraints.
2023-01-05 06:03:44.9:     423 min. remaining for the plan to fit before dawn.
2023-01-05 06:03:44.9:     but only 338 min till start so Plan transits mid-way in its time span.
2023-01-05 06:03:44.9:     deferred (rising) for 337 min, until 05-Jan-2023 11:41:42 UTC
2023-01-05 06:03:44.9: Rising plan delay enabled for Plan R_Leo:
2023-01-05 06:03:44.9:     478 min. remaining to meet strict constraints.
2023-01-05 06:03:44.9:     415 min. remaining for the plan to fit before dawn.
2023-01-05 06:03:44.9:     but only 225 min till start so Plan transits mid-way in its time span.
2023-01-05 06:03:44.9:     deferred (rising) for 224 min, until 05-Jan-2023 09:48:30 UTC
2023-01-05 06:03:45.1: Dispatcher cycle time: 0.3 sec.
2023-01-05 06:03:45.1: Acquire data for Observation V504_Per...
2023-01-05 06:03:45.1:   (belongs to Project AAVSO_MISC_RNO_AUTO_ver2706, Plan V504_Per)
2023-01-05 06:03:45.5: Send Observation V504_Per to ACP Sequencer
2023-01-05 06:15:02.4: Acquisition time: 676.9409697 sec.
2023-01-05 06:15:02.4: Data for Observation V504_Per of Plan V504_Per acquired successfully.
2023-01-05 06:15:02.4: Plan V504_Per completed successfully.
2023-01-05 06:15:02.4: Image Efficiency: 27.2%
2023-01-05 06:15:02.4: Cycle Efficiency: 100.0%
2023-01-05 06:15:02.8: Rising plan delay enabled for Plan CSS091110:060919-064155:
2023-01-05 06:15:02.8:     194 min. remaining to meet strict constraints.
2023-01-05 06:15:02.8:     393 min. remaining for the plan to fit before dawn.
2023-01-05 06:15:02.8:     but only -8 min till start so Plan transits mid-way in its time span.
2023-01-05 06:15:02.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 06:15:02.8: Rising plan delay enabled for Plan CSS091110:060919-064155:
2023-01-05 06:15:02.8:     194 min. remaining to meet strict constraints.
2023-01-05 06:15:02.8:     393 min. remaining for the plan to fit before dawn.
2023-01-05 06:15:02.8:     but only -8 min till start so Plan transits mid-way in its time span.
2023-01-05 06:15:02.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 06:15:03.1: Dispatcher cycle time: 0.3 sec.
2023-01-05 06:15:03.1: Acquire data for Observation RY_Lep...
2023-01-05 06:15:03.1:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3389, Plan RY_Lep)
2023-01-05 06:15:03.8: Send Observation RY_Lep to ACP Sequencer
2023-01-05 06:20:57.4: Acquisition time: 353.9810632 sec.
2023-01-05 06:20:57.4: Data for Observation RY_Lep of Plan RY_Lep acquired successfully.
2023-01-05 06:20:57.4: Plan RY_Lep completed successfully.
2023-01-05 06:20:57.4: Image Efficiency: 4.8%
2023-01-05 06:20:57.4: Cycle Efficiency: 99.9%
2023-01-05 06:20:57.6: Rising plan delay enabled for Plan U_Leo:
2023-01-05 06:20:57.6:     503 min. remaining to meet strict constraints.
2023-01-05 06:20:57.6:     401 min. remaining for the plan to fit before dawn.
2023-01-05 06:20:57.6:     but only 246 min till start so Plan transits mid-way in its time span.
2023-01-05 06:20:57.6:     deferred (rising) for 245 min, until 05-Jan-2023 10:26:28 UTC
2023-01-05 06:20:57.6: Rising plan delay enabled for Plan U_Leo:
2023-01-05 06:20:57.6:     503 min. remaining to meet strict constraints.
2023-01-05 06:20:57.6:     401 min. remaining for the plan to fit before dawn.
2023-01-05 06:20:57.6:     but only 246 min till start so Plan transits mid-way in its time span.
2023-01-05 06:20:57.6:     deferred (rising) for 245 min, until 05-Jan-2023 10:26:28 UTC
2023-01-05 06:20:57.7: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 06:20:57.7:     253 min. remaining to meet strict constraints.
2023-01-05 06:20:57.7:     324 min. remaining for the plan to fit before dawn.
2023-01-05 06:20:57.7:     but only 8 min till start so Plan transits mid-way in its time span.
2023-01-05 06:20:57.7:     ending rising plan delay. Plan is now eligible.
2023-01-05 06:20:57.7: Dispatcher cycle time: 0.2 sec.
2023-01-05 06:20:57.7: Acquire data for Observation TV_Cam...
2023-01-05 06:20:57.7:   (belongs to Project AAVSO_DCEP_HQA_AUTO_ver3391, Plan TV_Cam)
2023-01-05 06:20:57.8: Send Observation TV_Cam to ACP Sequencer
2023-01-05 06:39:45.6: Acquisition time: 1127.8554692 sec.
2023-01-05 06:39:45.6: Data for Observation TV_Cam of Plan TV_Cam acquired successfully.
2023-01-05 06:39:45.6: Plan TV_Cam completed successfully.
2023-01-05 06:39:45.6: Image Efficiency: 49.6%
2023-01-05 06:39:45.6: Cycle Efficiency: 100.0%
2023-01-05 06:39:45.8: Rising plan delay enabled for Plan BX_Pup:
2023-01-05 06:39:45.8:     167 min. remaining to meet strict constraints.
2023-01-05 06:39:45.8:     381 min. remaining for the plan to fit before dawn.
2023-01-05 06:39:45.8:     but only 77 min till start so Plan transits mid-way in its time span.
2023-01-05 06:39:45.8:     deferred (rising) for 76 min, until 05-Jan-2023 07:56:14 UTC
2023-01-05 06:39:45.8: Rising plan delay enabled for Plan BX_Pup:
2023-01-05 06:39:45.8:     167 min. remaining to meet strict constraints.
2023-01-05 06:39:45.8:     381 min. remaining for the plan to fit before dawn.
2023-01-05 06:39:45.8:     but only 77 min till start so Plan transits mid-way in its time span.
2023-01-05 06:39:45.8:     deferred (rising) for 76 min, until 05-Jan-2023 07:56:14 UTC
2023-01-05 06:39:46.3: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 06:39:46.3:     235 min. remaining to meet strict constraints.
2023-01-05 06:39:46.3:     305 min. remaining for the plan to fit before dawn.
2023-01-05 06:39:46.3:     but only -10 min till start so Plan transits mid-way in its time span.
2023-01-05 06:39:46.3:     ending rising plan delay. Plan is now eligible.
2023-01-05 06:39:46.4: Dispatcher cycle time: 0.7 sec.
2023-01-05 06:39:46.4: Acquire data for Observation CSS091110:060919-064155...
2023-01-05 06:39:46.4:   (belongs to Project AAVSO_MISC_WLP_AUTO_ver2706, Plan CSS091110:060919-064155)
2023-01-05 06:39:46.8: Send Observation CSS091110:060919-064155 to ACP Sequencer
2023-01-05 07:03:27.4: Acquisition time: 1420.6763261 sec.
2023-01-05 07:03:27.4: Data for Observation CSS091110:060919-064155 of Plan CSS091110:060919-064155 acquired successfully.
2023-01-05 07:03:27.5: Plan CSS091110:060919-064155 completed successfully.
2023-01-05 07:03:27.5: Image Efficiency: 67.5%
2023-01-05 07:03:27.5: Cycle Efficiency: 100.0%
2023-01-05 07:03:27.6: Rising plan delay enabled for Plan L1022_IRS:
2023-01-05 07:03:27.6:     188 min. remaining to meet strict constraints.
2023-01-05 07:03:27.6:     357 min. remaining for the plan to fit before dawn.
2023-01-05 07:03:27.6:     but only -2 min till start so Plan transits mid-way in its time span.
2023-01-05 07:03:27.6:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:03:27.6: Rising plan delay enabled for Plan L1022_IRS:
2023-01-05 07:03:27.6:     188 min. remaining to meet strict constraints.
2023-01-05 07:03:27.6:     357 min. remaining for the plan to fit before dawn.
2023-01-05 07:03:27.6:     but only -2 min till start so Plan transits mid-way in its time span.
2023-01-05 07:03:27.6:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:03:28.1: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:03:28.1:     211 min. remaining to meet strict constraints.
2023-01-05 07:03:28.1:     281 min. remaining for the plan to fit before dawn.
2023-01-05 07:03:28.1:     but only -33 min till start so Plan transits mid-way in its time span.
2023-01-05 07:03:28.1:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:03:28.1: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:03:28.1:     244 min. remaining to meet strict constraints.
2023-01-05 07:03:28.1:     345 min. remaining for the plan to fit before dawn.
2023-01-05 07:03:28.1:     but only -1 min till start so Plan transits mid-way in its time span.
2023-01-05 07:03:28.1:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:03:28.1: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:03:28.1:     211 min. remaining to meet strict constraints.
2023-01-05 07:03:28.1:     330 min. remaining for the plan to fit before dawn.
2023-01-05 07:03:28.1:     120956 min. remaining for the plan to fit before "must run before" time.
2023-01-05 07:03:28.1:     but only -9 min till start so Plan transits mid-way in its time span.
2023-01-05 07:03:28.1:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:03:28.1: Rising plan delay enabled for Plan V900_Mon:
2023-01-05 07:03:28.1:     187 min. remaining to meet strict constraints.
2023-01-05 07:03:28.1:     343 min. remaining for the plan to fit before dawn.
2023-01-05 07:03:28.1:     but only -9 min till start so Plan transits mid-way in its time span.
2023-01-05 07:03:28.1:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:03:28.4: Dispatcher cycle time: 0.8 sec.
2023-01-05 07:03:28.4: Acquire data for Observation V1261_Ori...
2023-01-05 07:03:28.4:   (belongs to Project AAVSO_MISC_SBL_AUTO_ver3391, Plan V1261_Ori)
2023-01-05 07:03:28.4: Send Observation V1261_Ori to ACP Sequencer
2023-01-05 07:09:09.4: Acquisition time: 341.0390088 sec.
2023-01-05 07:09:09.4: Data for Observation V1261_Ori of Plan V1261_Ori acquired successfully.
2023-01-05 07:09:09.4: Plan V1261_Ori completed successfully.
2023-01-05 07:09:09.4: Image Efficiency: 43.9%
2023-01-05 07:09:09.4: Cycle Efficiency: 99.8%
2023-01-05 07:09:09.6: Rising plan delay enabled for Plan 2MASS_J07092139-1029344:
2023-01-05 07:09:09.6:     202 min. remaining to meet strict constraints.
2023-01-05 07:09:09.6:     345 min. remaining for the plan to fit before dawn.
2023-01-05 07:09:09.6:     but only 0 min till start so Plan transits mid-way in its time span.
2023-01-05 07:09:09.6:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:09:09.6: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 07:09:09.6:     477 min. remaining to meet strict constraints.
2023-01-05 07:09:09.6:     348 min. remaining for the plan to fit before dawn.
2023-01-05 07:09:09.6:     but only 229 min till start so Plan transits mid-way in its time span.
2023-01-05 07:09:09.6:     deferred (rising) for 228 min, until 05-Jan-2023 10:57:36 UTC
2023-01-05 07:09:09.6: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 07:09:09.6:     477 min. remaining to meet strict constraints.
2023-01-05 07:09:09.6:     348 min. remaining for the plan to fit before dawn.
2023-01-05 07:09:09.6:     but only 229 min till start so Plan transits mid-way in its time span.
2023-01-05 07:09:09.6:     deferred (rising) for 228 min, until 05-Jan-2023 10:57:36 UTC
2023-01-05 07:09:09.6: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:09:09.6:     239 min. remaining to meet strict constraints.
2023-01-05 07:09:09.6:     340 min. remaining for the plan to fit before dawn.
2023-01-05 07:09:09.6:     but only -7 min till start so Plan transits mid-way in its time span.
2023-01-05 07:09:09.6:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:09:09.7: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:09:09.7:     205 min. remaining to meet strict constraints.
2023-01-05 07:09:09.7:     324 min. remaining for the plan to fit before dawn.
2023-01-05 07:09:09.7:     120950 min. remaining for the plan to fit before "must run before" time.
2023-01-05 07:09:09.7:     but only -15 min till start so Plan transits mid-way in its time span.
2023-01-05 07:09:09.7:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:09:09.7: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:09:09.7:     205 min. remaining to meet strict constraints.
2023-01-05 07:09:09.7:     276 min. remaining for the plan to fit before dawn.
2023-01-05 07:09:09.7:     but only -39 min till start so Plan transits mid-way in its time span.
2023-01-05 07:09:09.7:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:09:09.8: Dispatcher cycle time: 0.2 sec.
2023-01-05 07:09:09.8: Acquire data for Observation V1647_Ori...
2023-01-05 07:09:09.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan V1647_Ori)
2023-01-05 07:09:09.8: Send Observation V1647_Ori to ACP Sequencer
2023-01-05 07:10:48.6: ACP data acquisition failed for Observation V1647_Ori.
2023-01-05 07:10:48.6:   (Observation V1647_Ori interrupted by acquisition process failure.)
2023-01-05 07:10:48.8: Rising plan delay enabled for Plan 2MASS_J07092139-1029344:
2023-01-05 07:10:48.8:     200 min. remaining to meet strict constraints.
2023-01-05 07:10:48.8:     343 min. remaining for the plan to fit before dawn.
2023-01-05 07:10:48.8:     but only -1 min till start so Plan transits mid-way in its time span.
2023-01-05 07:10:48.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:10:48.8: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:10:48.8:     204 min. remaining to meet strict constraints.
2023-01-05 07:10:48.8:     323 min. remaining for the plan to fit before dawn.
2023-01-05 07:10:48.8:     120949 min. remaining for the plan to fit before "must run before" time.
2023-01-05 07:10:48.8:     but only -16 min till start so Plan transits mid-way in its time span.
2023-01-05 07:10:48.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:10:48.8: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:10:48.8:     237 min. remaining to meet strict constraints.
2023-01-05 07:10:48.8:     338 min. remaining for the plan to fit before dawn.
2023-01-05 07:10:48.8:     but only -9 min till start so Plan transits mid-way in its time span.
2023-01-05 07:10:48.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:10:48.8: Rising plan delay enabled for Plan V838_Mon:
2023-01-05 07:10:48.8:     204 min. remaining to meet strict constraints.
2023-01-05 07:10:48.8:     274 min. remaining for the plan to fit before dawn.
2023-01-05 07:10:48.8:     but only -41 min till start so Plan transits mid-way in its time span.
2023-01-05 07:10:48.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 07:10:49.4: Dispatcher cycle time: 0.7 sec.
2023-01-05 07:10:49.4: Acquire data for Observation V838_Mon...
2023-01-05 07:10:49.4:   (belongs to Project AAVSO_P304_SPP_AUTO_ver3383, Plan V838_Mon)
2023-01-05 07:10:49.4: Doing 4 sets
2023-01-05 07:10:49.6: Send Observation V838_Mon to ACP Sequencer
2023-01-05 07:22:09.1: Send Observation V838_Mon to ACP Sequencer
2023-01-05 07:32:00.6: Send Observation V838_Mon to ACP Sequencer
2023-01-05 07:41:46.8: Send Observation V838_Mon to ACP Sequencer
2023-01-05 08:00:20.7: Acquisition time: 2971.1969547 sec.
2023-01-05 08:00:20.7: Data for Observation V838_Mon of Plan V838_Mon acquired successfully.
2023-01-05 08:00:20.7: Plan V838_Mon completed successfully.
2023-01-05 08:00:20.7: Image Efficiency: 50.5%
2023-01-05 08:00:20.7: Cycle Efficiency: 100.0%
2023-01-05 08:00:20.9: Rising plan delay enabled for Plan BX_Pup:
2023-01-05 08:00:20.9:     86 min. remaining to meet strict constraints.
2023-01-05 08:00:20.9:     300 min. remaining for the plan to fit before dawn.
2023-01-05 08:00:20.9:     but only -3 min till start so Plan transits mid-way in its time span.
2023-01-05 08:00:20.9:     ending rising plan delay. Plan is now eligible.
2023-01-05 08:00:20.9: Rising plan delay enabled for Plan BX_Pup:
2023-01-05 08:00:20.9:     86 min. remaining to meet strict constraints.
2023-01-05 08:00:20.9:     300 min. remaining for the plan to fit before dawn.
2023-01-05 08:00:20.9:     but only -3 min till start so Plan transits mid-way in its time span.
2023-01-05 08:00:20.9:     ending rising plan delay. Plan is now eligible.
2023-01-05 08:00:21.1: Dispatcher cycle time: 0.2 sec.
2023-01-05 08:00:21.1: Acquire data for Observation V900_Mon...
2023-01-05 08:00:21.1:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan V900_Mon)
2023-01-05 08:00:21.1: Send Observation V900_Mon to ACP Sequencer
2023-01-05 08:25:10.0: Acquisition time: 1488.8384041 sec.
2023-01-05 08:25:10.0: Data for Observation V900_Mon of Plan V900_Mon acquired successfully.
2023-01-05 08:25:10.0: Plan V900_Mon completed successfully.
2023-01-05 08:25:10.0: Image Efficiency: 72.5%
2023-01-05 08:25:10.0: Cycle Efficiency: 100.0%
2023-01-05 08:25:10.7: ++ Auto Focus ++
2023-01-05 08:25:10.7: Doing periodic autofocus.
2023-01-05 08:25:10.7: Start special ACP AutoFocus script for scheduler
2023-01-05 08:28:45.1: Next periodic autofocus ASAP after 7200sec. 05-Jan-2023 10:28:31 UTC
2023-01-05 08:28:45.7: Rising plan delay enabled for Plan IR_Com:
2023-01-05 08:28:45.7:     526 min. remaining to meet strict constraints.
2023-01-05 08:28:45.7:     269 min. remaining for the plan to fit before dawn.
2023-01-05 08:28:45.7:     but only 251 min till start so Plan transits mid-way in its time span.
2023-01-05 08:28:45.7:     deferred (rising) for 250 min, until 05-Jan-2023 12:38:55 UTC
2023-01-05 08:28:45.7: Rising plan delay enabled for Plan IR_Com:
2023-01-05 08:28:45.7:     526 min. remaining to meet strict constraints.
2023-01-05 08:28:45.7:     269 min. remaining for the plan to fit before dawn.
2023-01-05 08:28:45.7:     but only 251 min till start so Plan transits mid-way in its time span.
2023-01-05 08:28:45.7:     deferred (rising) for 250 min, until 05-Jan-2023 12:38:55 UTC
2023-01-05 08:28:45.8: Rising plan delay enabled for Plan PKS_1222+216:
2023-01-05 08:28:45.8:     512 min. remaining to meet strict constraints.
2023-01-05 08:28:45.8:     276 min. remaining for the plan to fit before dawn.
2023-01-05 08:28:45.8:     but only 240 min till start so Plan transits mid-way in its time span.
2023-01-05 08:28:45.8:     deferred (rising) for 239 min, until 05-Jan-2023 12:28:32 UTC
2023-01-05 08:28:45.8: Rising plan delay enabled for Plan PKS_1222+216:
2023-01-05 08:28:45.8:     512 min. remaining to meet strict constraints.
2023-01-05 08:28:45.8:     276 min. remaining for the plan to fit before dawn.
2023-01-05 08:28:45.8:     but only 240 min till start so Plan transits mid-way in its time span.
2023-01-05 08:28:45.8:     deferred (rising) for 239 min, until 05-Jan-2023 12:28:32 UTC
2023-01-05 08:28:45.8: Rising plan delay enabled for Plan RZ_Leo:
2023-01-05 08:28:45.8:     416 min. remaining to meet strict constraints.
2023-01-05 08:28:45.8:     269 min. remaining for the plan to fit before dawn.
2023-01-05 08:28:45.8:     but only 189 min till start so Plan transits mid-way in its time span.
2023-01-05 08:28:45.8:     deferred (rising) for 188 min, until 05-Jan-2023 11:36:55 UTC
2023-01-05 08:28:45.9: Dispatcher cycle time: 0.4 sec.
2023-01-05 08:28:45.9: Acquire data for Observation QX_Pup...
2023-01-05 08:28:45.9:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3389, Plan QX_Pup)
2023-01-05 08:28:45.9: Send Observation QX_Pup to ACP Sequencer
2023-01-05 08:42:56.1: Acquisition time: 850.208985 sec.
2023-01-05 08:42:56.1: Data for Observation QX_Pup of Plan QX_Pup acquired successfully.
2023-01-05 08:42:56.1: Plan QX_Pup completed successfully.
2023-01-05 08:42:56.1: Image Efficiency: 52.2%
2023-01-05 08:42:56.1: Cycle Efficiency: 99.9%
2023-01-05 08:42:58.8: Dispatcher cycle time: 2.0 sec.
2023-01-05 08:42:58.8: Acquire data for Observation J072816...
2023-01-05 08:42:58.8:   (belongs to Project AAVSO_MISC_WLP_AUTO_ver2706, Plan J072816)
2023-01-05 08:42:59.0: Send Observation J072816 to ACP Sequencer
2023-01-05 08:43:45.3: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 08:43:45.3: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 08:43:45.3: ACP data acquisition failed for Observation J072816.
2023-01-05 08:43:45.3:   (Observation J072816 interrupted by acquisition process failure.)
2023-01-05 08:43:46.5: Dispatcher cycle time: 0.9 sec.
2023-01-05 08:43:46.5: Acquire data for Observation L1022_IRS...
2023-01-05 08:43:46.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan L1022_IRS)
2023-01-05 08:43:46.5: Send Observation L1022_IRS to ACP Sequencer
2023-01-05 08:54:31.2: Acquisition time: 644.701005 sec.
2023-01-05 08:54:31.2: Data for Observation L1022_IRS of Plan L1022_IRS acquired successfully.
2023-01-05 08:54:31.2: Plan L1022_IRS completed successfully.
2023-01-05 08:54:31.2: Image Efficiency: 65.1%
2023-01-05 08:54:31.2: Cycle Efficiency: 99.9%
2023-01-05 08:54:32.3: Rising plan delay enabled for Plan OJ287:
2023-01-05 08:54:32.3:     274 min. remaining to meet strict constraints.
2023-01-05 08:54:32.3:     238 min. remaining for the plan to fit before dawn.
2023-01-05 08:54:32.3:     but only 0 min till start so Plan transits mid-way in its time span.
2023-01-05 08:54:32.3:     ending rising plan delay. Plan is now eligible.
2023-01-05 08:54:32.3: Rising plan delay enabled for Plan OJ287:
2023-01-05 08:54:32.3:     274 min. remaining to meet strict constraints.
2023-01-05 08:54:32.3:     238 min. remaining for the plan to fit before dawn.
2023-01-05 08:54:32.3:     but only 0 min till start so Plan transits mid-way in its time span.
2023-01-05 08:54:32.3:     ending rising plan delay. Plan is now eligible.
2023-01-05 08:54:32.6: Dispatcher cycle time: 1.2 sec.
2023-01-05 08:54:32.6: Acquire data for Observation 2MASS_J07092139-1029344...
2023-01-05 08:54:32.6:   (belongs to Project AAVSO_P129_SGUA_AUTO_ver2823, Plan 2MASS_J07092139-1029344)
2023-01-05 08:54:32.7: Send Observation 2MASS_J07092139-1029344 to ACP Sequencer
2023-01-05 08:55:18.9: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 08:55:18.9: ACP data acquisition failed for Observation 2MASS_J07092139-1029344.
2023-01-05 08:55:18.9:   (Observation 2MASS_J07092139-1029344 interrupted by acquisition process failure.)
2023-01-05 08:55:23.3: Rising plan delay enabled for Plan OJ287:
2023-01-05 08:55:23.3:     273 min. remaining to meet strict constraints.
2023-01-05 08:55:23.3:     238 min. remaining for the plan to fit before dawn.
2023-01-05 08:55:23.3:     but only -1 min till start so Plan transits mid-way in its time span.
2023-01-05 08:55:23.3:     ending rising plan delay. Plan is now eligible.
2023-01-05 08:55:23.4: Rising plan delay enabled for Plan OJ287:
2023-01-05 08:55:23.4:     273 min. remaining to meet strict constraints.
2023-01-05 08:55:23.4:     238 min. remaining for the plan to fit before dawn.
2023-01-05 08:55:23.4:     but only -1 min till start so Plan transits mid-way in its time span.
2023-01-05 08:55:23.4:     ending rising plan delay. Plan is now eligible.
2023-01-05 08:55:29.5: Dispatcher cycle time: 8.9 sec.
2023-01-05 08:55:29.5: Acquire data for Observation CW_Mon...
2023-01-05 08:55:29.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan CW_Mon)
2023-01-05 08:55:29.9: Send Observation CW_Mon to ACP Sequencer
2023-01-05 08:55:29.9: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 08:56:29.9: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 08:57:30.0: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 08:58:30.1: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 08:59:30.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:00:30.3: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:01:30.5: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:02:30.5: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:03:30.7: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:04:30.7: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:05:30.8: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:06:31.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:07:31.3: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:08:31.5: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:09:31.5: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 09:10:31.5: ERROR: Failed to start ACP script due to ACP being busy or locked
2023-01-05 09:10:31.5: ACP data acquisition failed for Observation CW_Mon.
2023-01-05 09:10:31.5:   (Observation CW_Mon interrupted by ACP sequencer problem.)
2023-01-05 09:10:34.3: Rising plan delay enabled for Plan M3-V154:
2023-01-05 09:10:34.3:     561 min. remaining to meet strict constraints.
2023-01-05 09:10:34.3:     236 min. remaining for the plan to fit before dawn.
2023-01-05 09:10:34.3:     deferred (rising) for 236 min, until 05-Jan-2023 13:07:06 UTC
2023-01-05 09:12:04.2: Dispatcher cycle time: 91.8 sec.
2023-01-05 09:12:04.2: Acquire data for Observation V838_Mon...
2023-01-05 09:12:04.2:   (belongs to Project AAVSO_P237_CWT_AUTO_ver2685, Plan V838_Mon)
2023-01-05 09:12:04.2: Send Observation V838_Mon to ACP Sequencer
2023-01-05 09:34:30.9: Acquisition time: 1346.711166 sec.
2023-01-05 09:34:30.9: Data for Observation V838_Mon of Plan V838_Mon acquired successfully.
2023-01-05 09:34:30.9: Plan V838_Mon completed successfully.
2023-01-05 09:34:30.9: Image Efficiency: 75.1%
2023-01-05 09:34:30.9: Cycle Efficiency: 93.6%
2023-01-05 09:34:32.1: Dispatcher cycle time: 0.4 sec.
2023-01-05 09:34:32.1: Acquire data for Observation L1022_IRS...
2023-01-05 09:34:32.1:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3389, Plan L1022_IRS)
2023-01-05 09:34:32.1: Send Observation L1022_IRS to ACP Sequencer
2023-01-05 09:44:38.3: Acquisition time: 606.2060574 sec.
2023-01-05 09:44:38.3: Data for Observation L1022_IRS of Plan L1022_IRS acquired successfully.
2023-01-05 09:44:38.3: Plan L1022_IRS completed successfully.
2023-01-05 09:44:38.3: Image Efficiency: 69.2%
2023-01-05 09:44:38.3: Cycle Efficiency: 99.9%
2023-01-05 09:44:39.4: Rising plan delay enabled for Plan HS1340+1524:
2023-01-05 09:44:39.4:     501 min. remaining to meet strict constraints.
2023-01-05 09:44:39.4:     199 min. remaining for the plan to fit before dawn.
2023-01-05 09:44:39.4:     deferred (rising) for 198 min, until 05-Jan-2023 13:02:59 UTC
2023-01-05 09:44:39.4: Rising plan delay enabled for Plan HS1340+1524:
2023-01-05 09:44:39.4:     501 min. remaining to meet strict constraints.
2023-01-05 09:44:39.4:     199 min. remaining for the plan to fit before dawn.
2023-01-05 09:44:39.4:     deferred (rising) for 198 min, until 05-Jan-2023 13:02:59 UTC
2023-01-05 09:44:39.5: Dispatcher cycle time: 0.9 sec.
2023-01-05 09:44:39.5: Acquire data for Observation HQ_Mon...
2023-01-05 09:44:39.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan HQ_Mon)
2023-01-05 09:44:40.1: Send Observation HQ_Mon to ACP Sequencer
2023-01-05 09:45:41.4: ACP data acquisition failed for Observation HQ_Mon.
2023-01-05 09:45:41.4:   (Observation HQ_Mon interrupted by acquisition process failure.)
2023-01-05 09:45:42.6: Dispatcher cycle time: 0.9 sec.
2023-01-05 09:45:42.6: Acquire data for Observation OJ287...
2023-01-05 09:45:42.6:   (belongs to Project AAVSO_MISC_PYG_AUTO_ver3260, Plan OJ287)
2023-01-05 09:45:42.6: Send Observation OJ287 to ACP Sequencer
2023-01-05 10:08:07.7: Acquisition time: 1345.0741773 sec.
2023-01-05 10:08:07.7: Data for Observation OJ287 of Plan OJ287 acquired successfully.
2023-01-05 10:08:07.7: Plan OJ287 completed successfully.
2023-01-05 10:08:07.7: Image Efficiency: 58.0%
2023-01-05 10:08:07.7: Cycle Efficiency: 99.9%
2023-01-05 10:08:08.0: Rising plan delay enabled for Plan 3C_279:
2023-01-05 10:08:08.0:     370 min. remaining to meet strict constraints.
2023-01-05 10:08:08.0:     176 min. remaining for the plan to fit before dawn.
2023-01-05 10:08:08.0:     but only 172 min till start so Plan transits mid-way in its time span.
2023-01-05 10:08:08.0:     deferred (rising) for 171 min, until 05-Jan-2023 12:59:44 UTC
2023-01-05 10:08:08.0: Rising plan delay enabled for Plan 3C_279:
2023-01-05 10:08:08.0:     370 min. remaining to meet strict constraints.
2023-01-05 10:08:08.0:     176 min. remaining for the plan to fit before dawn.
2023-01-05 10:08:08.0:     but only 172 min till start so Plan transits mid-way in its time span.
2023-01-05 10:08:08.0:     deferred (rising) for 171 min, until 05-Jan-2023 12:59:44 UTC
2023-01-05 10:08:08.1: Rising plan delay enabled for Plan NSV-6690:
2023-01-05 10:08:08.1:     541 min. remaining to meet strict constraints.
2023-01-05 10:08:08.1:     149 min. remaining for the plan to fit before dawn.
2023-01-05 10:08:08.1:     deferred (rising) for 145 min, until 05-Jan-2023 12:33:44 UTC
2023-01-05 10:08:08.3: Rising plan delay enabled for Plan PG_1424+240:
2023-01-05 10:08:08.3:     539 min. remaining to meet strict constraints.
2023-01-05 10:08:08.3:     179 min. remaining for the plan to fit before dawn.
2023-01-05 10:08:08.3:     deferred (rising) for 178 min, until 05-Jan-2023 13:06:50 UTC
2023-01-05 10:08:08.3: Rising plan delay enabled for Plan PG_1424+240:
2023-01-05 10:08:08.3:     539 min. remaining to meet strict constraints.
2023-01-05 10:08:08.3:     179 min. remaining for the plan to fit before dawn.
2023-01-05 10:08:08.3:     deferred (rising) for 178 min, until 05-Jan-2023 13:06:50 UTC
2023-01-05 10:08:09.2: Dispatcher cycle time: 1.2 sec.
2023-01-05 10:08:09.2: Acquire data for Observation OJ287...
2023-01-05 10:08:09.2:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan OJ287)
2023-01-05 10:08:09.2: Send Observation OJ287 to ACP Sequencer
2023-01-05 10:08:57.7: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 10:08:57.7: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 10:08:57.7: ACP data acquisition failed for Observation OJ287.
2023-01-05 10:08:57.7:   (Observation OJ287 interrupted by acquisition process failure.)
2023-01-05 10:08:58.3: Dispatcher cycle time: 0.4 sec.
2023-01-05 10:08:58.3: Acquire data for Observation R_Leo...
2023-01-05 10:08:58.3:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan R_Leo)
2023-01-05 10:08:58.3: Send Observation R_Leo to ACP Sequencer
2023-01-05 10:09:47.1: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 10:09:47.1: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 10:09:47.1: ACP data acquisition failed for Observation R_Leo.
2023-01-05 10:09:47.1:   (Observation R_Leo interrupted by acquisition process failure.)
2023-01-05 10:09:48.1: Dispatcher cycle time: 0.1 sec.
2023-01-05 10:09:48.1: Acquire data for Observation CW_Mon...
2023-01-05 10:09:48.1:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3389, Plan CW_Mon)
2023-01-05 10:09:48.4: Send Observation CW_Mon to ACP Sequencer
2023-01-05 10:20:12.5: Acquisition time: 624.1564262 sec.
2023-01-05 10:20:12.5: Data for Observation CW_Mon of Plan CW_Mon acquired successfully.
2023-01-05 10:20:12.5: Plan CW_Mon completed successfully.
2023-01-05 10:20:12.5: Image Efficiency: 57.7%
2023-01-05 10:20:12.5: Cycle Efficiency: 100.0%
2023-01-05 10:20:13.2: Rising plan delay enabled for Plan AG_Dra:
2023-01-05 10:20:13.2:     702 min. remaining to meet strict constraints.
2023-01-05 10:20:13.2:     166 min. remaining for the plan to fit before dawn.
2023-01-05 10:20:13.2:     deferred (rising) for 165 min, until 05-Jan-2023 13:06:00 UTC
2023-01-05 10:20:13.2: Rising plan delay enabled for Plan AG_Dra:
2023-01-05 10:20:13.2:     702 min. remaining to meet strict constraints.
2023-01-05 10:20:13.2:     166 min. remaining for the plan to fit before dawn.
2023-01-05 10:20:13.2:     deferred (rising) for 165 min, until 05-Jan-2023 13:06:00 UTC
2023-01-05 10:20:13.2: Rising plan delay enabled for Plan X_Boo:
2023-01-05 10:20:13.2:     508 min. remaining to meet strict constraints.
2023-01-05 10:20:13.2:     166 min. remaining for the plan to fit before dawn.
2023-01-05 10:20:13.2:     deferred (rising) for 165 min, until 05-Jan-2023 13:05:54 UTC
2023-01-05 10:20:13.2: Rising plan delay enabled for Plan X_Boo:
2023-01-05 10:20:13.2:     508 min. remaining to meet strict constraints.
2023-01-05 10:20:13.2:     166 min. remaining for the plan to fit before dawn.
2023-01-05 10:20:13.2:     deferred (rising) for 165 min, until 05-Jan-2023 13:05:54 UTC
2023-01-05 10:20:13.3: Dispatcher cycle time: 0.1 sec.
2023-01-05 10:20:13.3: Acquire data for Observation GZ_Cnc...
2023-01-05 10:20:13.3:   (belongs to Project AAVSO_MISC_MZK_AUTO_ver2706, Plan GZ_Cnc)
2023-01-05 10:20:13.3: Send Observation GZ_Cnc to ACP Sequencer
2023-01-05 10:21:01.9: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 10:21:01.9: ACP data acquisition failed for Observation GZ_Cnc.
2023-01-05 10:21:01.9:   (Observation GZ_Cnc interrupted by acquisition process failure.)
2023-01-05 10:21:02.4: Dispatcher cycle time: 0.1 sec.
2023-01-05 10:21:02.4: Acquire data for Observation GZ_Cnc...
2023-01-05 10:21:02.4:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan GZ_Cnc)
2023-01-05 10:21:02.4: Send Observation GZ_Cnc to ACP Sequencer
2023-01-05 10:21:02.4: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:22:02.4: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:23:03.0: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:24:03.1: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:25:03.1: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:26:03.3: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:27:03.8: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:28:04.6: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:29:05.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:30:05.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:31:05.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:32:05.8: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:33:06.0: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:34:06.5: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:35:06.8: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:36:06.8: ERROR: Failed to start ACP script due to ACP being busy or locked
2023-01-05 10:36:06.8: ACP data acquisition failed for Observation GZ_Cnc.
2023-01-05 10:36:06.8:   (Observation GZ_Cnc interrupted by ACP sequencer problem.)
2023-01-05 10:36:07.3: ++ Auto Focus ++
2023-01-05 10:36:23.5: Doing periodic autofocus.
2023-01-05 10:36:23.5: Start special ACP AutoFocus script for scheduler
2023-01-05 10:36:23.5: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:37:24.4: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:38:25.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:39:25.4: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:40:25.9: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:41:26.1: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:42:26.5: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:43:27.4: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:44:28.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:45:29.1: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:46:29.3: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:47:29.8: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:48:30.6: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:49:31.4: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 10:50:49.5: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2023-01-05 10:50:50.0: Dispatcher cycle time: 0.1 sec.
2023-01-05 10:50:50.0: Acquire data for Observation J072816...
2023-01-05 10:50:50.0:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan J072816)
2023-01-05 10:50:50.0: ++ Auto Focus ++
2023-01-05 10:50:50.0: Doing periodic autofocus.
2023-01-05 10:50:50.0: Start special ACP AutoFocus script for scheduler
2023-01-05 10:51:08.7: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2023-01-05 10:51:08.7: Send Observation J072816 to ACP Sequencer
2023-01-05 10:51:56.3: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 10:51:56.3: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 10:51:56.3: ACP data acquisition failed for Observation J072816.
2023-01-05 10:51:56.3:   (Observation J072816 interrupted by acquisition process failure.)
2023-01-05 10:51:57.7: Dispatcher cycle time: 0.4 sec.
2023-01-05 10:51:57.7: Acquire data for Observation KN_Lyn...
2023-01-05 10:51:57.7:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3389, Plan KN_Lyn)
2023-01-05 10:51:58.0: Send Observation KN_Lyn to ACP Sequencer
2023-01-05 10:52:46.7: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 10:52:46.7: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 10:52:46.7: ACP data acquisition failed for Observation KN_Lyn.
2023-01-05 10:52:46.7:   (Observation KN_Lyn interrupted by acquisition process failure.)
2023-01-05 10:52:47.8: Dispatcher cycle time: 0.1 sec.
2023-01-05 10:52:47.8: Acquire data for Observation SU_Lyn...
2023-01-05 10:52:47.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan SU_Lyn)
2023-01-05 10:52:47.8: Send Observation SU_Lyn to ACP Sequencer
2023-01-05 11:02:39.2: Acquisition time: 591.4301274 sec.
2023-01-05 11:02:39.2: Data for Observation SU_Lyn of Plan SU_Lyn acquired successfully.
2023-01-05 11:02:39.2: Plan SU_Lyn completed successfully.
2023-01-05 11:02:39.2: Image Efficiency: 36.7%
2023-01-05 11:02:39.2: Cycle Efficiency: 100.0%
2023-01-05 11:02:39.6: ++ Auto Focus ++
2023-01-05 11:02:39.6: Doing periodic autofocus.
2023-01-05 11:02:39.6: Start special ACP AutoFocus script for scheduler
2023-01-05 11:02:58.3: ** Autofocus failed (n=3), will retry ASAP after 10 min.
2023-01-05 11:02:58.4: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 11:02:58.4:     244 min. remaining to meet strict constraints.
2023-01-05 11:02:58.4:     114 min. remaining for the plan to fit before dawn.
2023-01-05 11:02:58.4:     but only -3 min till start so Plan transits mid-way in its time span.
2023-01-05 11:02:58.4:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:02:58.4: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 11:02:58.4:     244 min. remaining to meet strict constraints.
2023-01-05 11:02:58.4:     114 min. remaining for the plan to fit before dawn.
2023-01-05 11:02:58.4:     but only -3 min till start so Plan transits mid-way in its time span.
2023-01-05 11:02:58.4:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:02:58.7: Dispatcher cycle time: 0.4 sec.
2023-01-05 11:02:58.7: Acquire data for Observation OI_158...
2023-01-05 11:02:58.7:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan OI_158)
2023-01-05 11:02:59.1: Send Observation OI_158 to ACP Sequencer
2023-01-05 11:03:47.8: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 11:03:47.8: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:03:47.8: ACP data acquisition failed for Observation OI_158.
2023-01-05 11:03:47.8:   (Observation OI_158 interrupted by acquisition process failure.)
2023-01-05 11:03:48.8: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 11:03:48.8:     243 min. remaining to meet strict constraints.
2023-01-05 11:03:48.8:     113 min. remaining for the plan to fit before dawn.
2023-01-05 11:03:48.8:     but only -4 min till start so Plan transits mid-way in its time span.
2023-01-05 11:03:48.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:03:48.8: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 11:03:48.8:     243 min. remaining to meet strict constraints.
2023-01-05 11:03:48.8:     113 min. remaining for the plan to fit before dawn.
2023-01-05 11:03:48.8:     but only -4 min till start so Plan transits mid-way in its time span.
2023-01-05 11:03:48.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:03:49.1: Dispatcher cycle time: 0.4 sec.
2023-01-05 11:03:49.1: Acquire data for Observation U_Leo...
2023-01-05 11:03:49.1:   (belongs to Project AAVSO_MISC_SFY_AUTO_ver2706, Plan U_Leo)
2023-01-05 11:03:49.1: Send Observation U_Leo to ACP Sequencer
2023-01-05 11:04:38.1: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 11:04:38.1: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:04:38.1: ACP data acquisition failed for Observation U_Leo.
2023-01-05 11:04:38.1:   (Observation U_Leo interrupted by acquisition process failure.)
2023-01-05 11:04:39.1: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 11:04:39.1:     242 min. remaining to meet strict constraints.
2023-01-05 11:04:39.1:     113 min. remaining for the plan to fit before dawn.
2023-01-05 11:04:39.1:     but only -5 min till start so Plan transits mid-way in its time span.
2023-01-05 11:04:39.1:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:04:39.1: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 11:04:39.1:     242 min. remaining to meet strict constraints.
2023-01-05 11:04:39.1:     113 min. remaining for the plan to fit before dawn.
2023-01-05 11:04:39.1:     but only -5 min till start so Plan transits mid-way in its time span.
2023-01-05 11:04:39.1:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:04:39.5: Dispatcher cycle time: 0.4 sec.
2023-01-05 11:04:39.5: Acquire data for Observation S5_0716+714...
2023-01-05 11:04:39.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan S5_0716+714)
2023-01-05 11:04:39.5: Send Observation S5_0716+714 to ACP Sequencer
2023-01-05 11:05:28.5: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 11:05:28.5: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:05:28.5: ACP data acquisition failed for Observation S5_0716+714.
2023-01-05 11:05:28.5:   (Observation S5_0716+714 interrupted by acquisition process failure.)
2023-01-05 11:05:29.4: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 11:05:29.4:     241 min. remaining to meet strict constraints.
2023-01-05 11:05:29.4:     112 min. remaining for the plan to fit before dawn.
2023-01-05 11:05:29.4:     but only -6 min till start so Plan transits mid-way in its time span.
2023-01-05 11:05:29.4:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:05:29.4: Rising plan delay enabled for Plan IU_Leo:
2023-01-05 11:05:29.4:     241 min. remaining to meet strict constraints.
2023-01-05 11:05:29.4:     112 min. remaining for the plan to fit before dawn.
2023-01-05 11:05:29.4:     but only -6 min till start so Plan transits mid-way in its time span.
2023-01-05 11:05:29.4:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:05:29.8: Dispatcher cycle time: 0.3 sec.
2023-01-05 11:05:29.8: Acquire data for Observation NQ_Gem...
2023-01-05 11:05:29.8:   (belongs to Project AAVSO_MISC_SBL_AUTO_ver3391, Plan NQ_Gem)
2023-01-05 11:05:30.1: Send Observation NQ_Gem to ACP Sequencer
2023-01-05 11:06:18.8: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 11:06:18.8: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:06:18.8: ACP data acquisition failed for Observation NQ_Gem.
2023-01-05 11:06:18.8:   (Observation NQ_Gem interrupted by acquisition process failure.)
2023-01-05 11:06:19.8: Dispatcher cycle time: 0.1 sec.
2023-01-05 11:06:19.8: Acquire data for Observation OI_158...
2023-01-05 11:06:19.8:   (belongs to Project AAVSO_MISC_GCO_AUTO_ver2706, Plan OI_158)
2023-01-05 11:06:20.1: Send Observation OI_158 to ACP Sequencer
2023-01-05 11:07:09.1: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 11:07:09.1: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:07:09.1: ACP data acquisition failed for Observation OI_158.
2023-01-05 11:07:09.1:   (Observation OI_158 interrupted by acquisition process failure.)
2023-01-05 11:07:10.2: Dispatcher cycle time: 0.1 sec.
2023-01-05 11:07:10.2: Acquire data for Observation IU_Leo...
2023-01-05 11:07:10.2:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3389, Plan IU_Leo)
2023-01-05 11:07:10.5: Send Observation IU_Leo to ACP Sequencer
2023-01-05 11:07:59.5: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:07:59.5: ACP data acquisition failed for Observation IU_Leo.
2023-01-05 11:07:59.5:   (Observation IU_Leo interrupted by acquisition process failure.)
2023-01-05 11:08:02.6: Dispatcher cycle time: 1.4 sec.
2023-01-05 11:08:02.6: Acquire data for Observation SU_Lyn...
2023-01-05 11:08:02.6:   (belongs to Project AAVSO_MISC_HQA_AUTO_ver3389, Plan SU_Lyn)
2023-01-05 11:08:02.6: Send Observation SU_Lyn to ACP Sequencer
2023-01-05 11:08:02.6: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:09:02.7: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:10:02.9: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:11:03.6: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:12:04.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:13:04.9: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:14:05.5: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:15:06.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:16:06.7: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:17:07.3: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:18:08.0: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:19:08.7: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:20:08.8: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:21:08.9: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:22:09.2: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:23:09.2: ERROR: Failed to start ACP script due to ACP being busy or locked
2023-01-05 11:23:09.2: ACP data acquisition failed for Observation SU_Lyn.
2023-01-05 11:23:09.2:   (Observation SU_Lyn interrupted by ACP sequencer problem.)
2023-01-05 11:23:09.5: ++ Auto Focus ++
2023-01-05 11:23:48.0: Doing periodic autofocus.
2023-01-05 11:23:48.0: Start special ACP AutoFocus script for scheduler
2023-01-05 11:23:48.0: WARNING: Request sent to busy ACP (AcquireScheduler)
2023-01-05 11:25:05.5: ** Autofocus failed (n=4), will retry ASAP after 15 min.
2023-01-05 11:25:05.5: Rising plan delay enabled for Plan NGC_5634:
2023-01-05 11:25:05.5:     386 min. remaining to meet strict constraints.
2023-01-05 11:25:05.5:     74 min. remaining for the plan to fit before dawn.
2023-01-05 11:25:05.5:     deferred (rising) for 71 min, until 05-Jan-2023 12:36:35 UTC
2023-01-05 11:25:05.6: Dispatcher cycle time: 0.0 sec.
2023-01-05 11:25:05.6: Acquire data for Observation U_Leo...
2023-01-05 11:25:05.6:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan U_Leo)
2023-01-05 11:25:05.9: Send Observation U_Leo to ACP Sequencer
2023-01-05 11:25:54.8: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 11:25:54.8: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:25:54.8: ACP data acquisition failed for Observation U_Leo.
2023-01-05 11:25:54.8:   (Observation U_Leo interrupted by acquisition process failure.)
2023-01-05 11:25:55.7: Dispatcher cycle time: 0.0 sec.
2023-01-05 11:25:55.7: Acquire data for Observation IU_Leo...
2023-01-05 11:25:55.7:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan IU_Leo)
2023-01-05 11:25:55.7: Send Observation IU_Leo to ACP Sequencer
2023-01-05 11:26:43.2: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 11:26:43.2: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:26:43.2: ACP data acquisition failed for Observation IU_Leo.
2023-01-05 11:26:43.2:   (Observation IU_Leo interrupted by acquisition process failure.)
2023-01-05 11:37:08.5: Rising plan delay enabled for Plan RZ_Leo:
2023-01-05 11:37:08.5:     228 min. remaining to meet strict constraints.
2023-01-05 11:37:08.5:     80 min. remaining for the plan to fit before dawn.
2023-01-05 11:37:08.5:     but only 1 min till start so Plan transits mid-way in its time span.
2023-01-05 11:37:08.5:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:37:08.5: Dispatcher cycle time: 0.0 sec.
2023-01-05 11:37:08.5: Acquire data for Observation RZ_Leo...
2023-01-05 11:37:08.5:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan RZ_Leo)
2023-01-05 11:37:08.5: Send Observation RZ_Leo to ACP Sequencer
2023-01-05 11:37:57.6: ASSERT: ACP script exited with AcquireNow still True
2023-01-05 11:37:57.6: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:37:57.6: ACP data acquisition failed for Observation RZ_Leo.
2023-01-05 11:37:57.6:   (Observation RZ_Leo interrupted by acquisition process failure.)
2023-01-05 11:40:34.5: ++ Auto Focus ++
2023-01-05 11:40:34.5: Doing periodic autofocus.
2023-01-05 11:40:34.5: Start special ACP AutoFocus script for scheduler
2023-01-05 11:40:53.5: ** Autofocus failed (n=5), will retry ASAP after 20 min.
2023-01-05 11:41:55.8: Rising plan delay enabled for Plan Mrk_180:
2023-01-05 11:41:55.8:     364 min. remaining to meet strict constraints.
2023-01-05 11:41:55.8:     85 min. remaining for the plan to fit before dawn.
2023-01-05 11:41:55.8:     but only 0 min till start so Plan transits mid-way in its time span.
2023-01-05 11:41:55.8:     ending rising plan delay. Plan is now eligible.
2023-01-05 11:41:55.8: Dispatcher cycle time: 0.0 sec.
2023-01-05 11:41:55.8: Acquire data for Observation Mrk_180...
2023-01-05 11:41:55.8:   (belongs to Project AAVSO_survey_HQ_AUTO_ver3391, Plan Mrk_180)
2023-01-05 11:41:55.8: Send Observation Mrk_180 to ACP Sequencer
2023-01-05 11:42:43.4: ACP ERROR: Run failed for unknown reason (see ACP run log)
2023-01-05 11:42:43.4: ACP data acquisition failed for Observation Mrk_180.
2023-01-05 11:42:43.4:   (Observation Mrk_180 interrupted by acquisition process failure.)
2023-01-05 11:44:51.6: Rising plan delay enabled for Plan M5-V42:
2023-01-05 11:44:51.6:     441 min. remaining to meet strict constraints.
2023-01-05 11:44:51.6:     81 min. remaining for the plan to fit before dawn.
2023-01-05 11:44:51.6:     deferred (rising) for 81 min, until 05-Jan-2023 13:06:06 UTC
2023-01-05 11:44:51.9: Rising plan delay enabled for Plan M5-V84:
2023-01-05 11:44:51.9:     442 min. remaining to meet strict constraints.
2023-01-05 11:44:51.9:     81 min. remaining for the plan to fit before dawn.
2023-01-05 11:44:51.9:     deferred (rising) for 81 min, until 05-Jan-2023 13:06:06 UTC
2023-01-05 11:49:01.6: Rising plan delay enabled for Plan Pal_5:
2023-01-05 11:49:01.6:     428 min. remaining to meet strict constraints.
2023-01-05 11:49:01.6:     59 min. remaining for the plan to fit before dawn.
2023-01-05 11:49:01.6:     deferred (rising) for 56 min, until 05-Jan-2023 12:45:45 UTC
2023-01-05 11:57:47.9: Rising plan delay enabled for Plan PG_1553+113:
2023-01-05 11:57:47.9:     490 min. remaining to meet strict constraints.
2023-01-05 11:57:47.9:     70 min. remaining for the plan to fit before dawn.
2023-01-05 11:57:47.9:     deferred (rising) for 70 min, until 05-Jan-2023 13:07:56 UTC
2023-01-05 11:57:48.0: Rising plan delay enabled for Plan PG_1553+113:
2023-01-05 11:57:48.0:     490 min. remaining to meet strict constraints.
2023-01-05 11:57:48.0:     70 min. remaining for the plan to fit before dawn.
2023-01-05 11:57:48.0:     deferred (rising) for 70 min, until 05-Jan-2023 13:07:56 UTC
2023-01-05 12:00:55.9: ++ Auto Focus ++
2023-01-05 12:00:55.9: Doing periodic autofocus.
2023-01-05 12:00:55.9: Start special ACP AutoFocus script for scheduler
2023-01-05 12:01:14.5: ** Autofocus failed (n=6), will retry ASAP after 20 min.
2023-01-05 12:14:08.0: Run statistics:
2023-01-05 12:14:08.0:   Observations:   272
2023-01-05 12:14:08.0:   Considered:     59
2023-01-05 12:14:08.0:   Completed:      4
2023-01-05 12:14:08.0:   Skipped:        35
2023-01-05 12:14:08.0:   Never Eligible: 213
2023-01-05 12:14:08.0:   Failed:         20
Log closed at Thu, Jan 05 2023 12:14:08 UTC (actual time)