Log opened at Fri, Mar 01 2019 02:17:07 UTC (actual time)
Current log level is Verbose
ACP Expert Scheduler version 8.1.1
Full license: Arne Henden
2019-03-01 02:17:08.8: ++ Observatory Startup ++
2019-03-01 02:17:08.8: Start ACP Sequencer's StartupObs script
2019-03-01 02:18:18.3: Open the observatory dome/roof
2019-03-01 02:19:25.7: Observatory startup succeeded, and dome opened successfully
2019-03-01 02:19:25.7: ++ Auto Focus ++
2019-03-01 02:19:25.7: Doing initial autofocus.
2019-03-01 02:19:25.7: Start special ACP AutoFocus script for scheduler
2019-03-01 02:23:53.4: Next periodic autofocus ASAP after 01-Mar-2019 05:23:37 UTC
2019-03-01 02:23:53.5: Plan CY_UMa has Monitor Mode. Time to resubmit it.
2019-03-01 02:23:53.5: Plan SDSS073224 has Monitor Mode. Time to resubmit it.
2019-03-01 02:23:53.5: Plan M67 has Monitor Mode. Time to resubmit it.
2019-03-01 02:23:53.5: Plan QZ_Aur has Monitor Mode. Time to resubmit it.
2019-03-01 02:23:54.2: Rising plan delay enabled for Plan CY_UMa:
2019-03-01 02:23:54.2:     667 min. remaining to meet strict constraints.
2019-03-01 02:23:54.2:     617 min. remaining for the plan to fit before dawn.
2019-03-01 02:23:54.2:     but only 304 min till mid-Plan transit.
2019-03-01 02:23:54.2:     deferred (rising) for 304 min, until 01-Mar-2019 07:28:41 UTC
2019-03-01 02:23:54.6: Rising plan delay enabled for Plan DN_Lyn:
2019-03-01 02:23:54.6:     417 min. remaining to meet strict constraints.
2019-03-01 02:23:54.6:     600 min. remaining for the plan to fit before dawn.
2019-03-01 02:23:54.6:     but only 91 min till mid-Plan transit.
2019-03-01 02:23:54.6:     deferred (rising) for 89 min, until 01-Mar-2019 03:53:46 UTC
2019-03-01 02:23:54.7: Rising plan delay enabled for Plan M67:
2019-03-01 02:23:54.7:     397 min. remaining to meet strict constraints.
2019-03-01 02:23:54.7:     617 min. remaining for the plan to fit before dawn.
2019-03-01 02:23:54.7:     but only 179 min till mid-Plan transit.
2019-03-01 02:23:54.7:     deferred (rising) for 179 min, until 01-Mar-2019 05:23:22 UTC
2019-03-01 02:23:54.8: Rising plan delay enabled for Plan MP_Gem:
2019-03-01 02:23:54.8:     321 min. remaining to meet strict constraints.
2019-03-01 02:23:54.8:     583 min. remaining for the plan to fit before dawn.
2019-03-01 02:23:54.8:     but only 39 min till mid-Plan transit.
2019-03-01 02:23:54.8:     deferred (rising) for 36 min, until 01-Mar-2019 03:00:14 UTC
2019-03-01 02:23:54.8: Rising plan delay enabled for Plan SDSS073224:
2019-03-01 02:23:54.8:     380 min. remaining to meet strict constraints.
2019-03-01 02:23:54.8:     617 min. remaining for the plan to fit before dawn.
2019-03-01 02:23:54.8:     but only 100 min till mid-Plan transit.
2019-03-01 02:23:54.8:     deferred (rising) for 100 min, until 01-Mar-2019 04:04:42 UTC
2019-03-01 02:23:54.9: Rising plan delay enabled for Plan V0959_Mon:
2019-03-01 02:23:54.9:     280 min. remaining to meet strict constraints.
2019-03-01 02:23:54.9:     601 min. remaining for the plan to fit before dawn.
2019-03-01 02:23:54.9:     but only 39 min till mid-Plan transit.
2019-03-01 02:23:54.9:     deferred (rising) for 38 min, until 01-Mar-2019 03:02:03 UTC
2019-03-01 02:23:55.1: Dispatcher cycle time: 1.6 sec.
2019-03-01 02:23:55.1: Acquire data for Observation QZ_Aur...
2019-03-01 02:23:55.1:   (belongs to Project AAVSO_Monitoring, Plan QZ_Aur)
2019-03-01 02:23:55.7: Send Observation QZ_Aur to ACP Sequencer
2019-03-01 02:30:01.8: ACP data acquisition failed for Observation QZ_Aur.
2019-03-01 02:30:01.8:   (Observation QZ_Aur interrupted by acquisition process failure.)
2019-03-01 02:30:05.4: Rising plan delay enabled for Plan KK_UMa:
2019-03-01 02:30:05.4:     467 min. remaining to meet strict constraints.
2019-03-01 02:30:05.4:     594 min. remaining for the plan to fit before dawn.
2019-03-01 02:30:05.4:     but only 338 min till mid-Plan transit.
2019-03-01 02:30:05.4:     deferred (rising) for 336 min, until 01-Mar-2019 08:06:24 UTC
2019-03-01 02:30:05.5: Dispatcher cycle time: 0.7 sec.
2019-03-01 02:30:05.5: Acquire data for Observation CB_32...
2019-03-01 02:30:05.5:   (belongs to Project Staels, Plan CB_32)
2019-03-01 02:30:05.8: Send Observation CB_32 to ACP Sequencer
2019-03-01 02:34:32.3: Acquisition time: 266.5103731 sec.
2019-03-01 02:34:32.3: Data for Observation CB_32 of Plan CB_32 acquired successfully.
2019-03-01 02:34:32.3: Plan CB_32 completed successfully.
2019-03-01 02:34:32.3: Image Efficiency: 33.7%
2019-03-01 02:34:32.3: Cycle Efficiency: 99.7%
2019-03-01 02:34:37.8: Dispatcher cycle time: 0.3 sec.
2019-03-01 02:34:37.8: Acquire data for Observation T_Ori...
2019-03-01 02:34:37.8:   (belongs to Project AAVSO_Monitoring, Plan T_Ori)
2019-03-01 02:34:37.8: Doing 3 sets
2019-03-01 02:34:37.8: Send Observation T_Ori to ACP Sequencer
2019-03-01 02:38:02.4: Send Observation T_Ori to ACP Sequencer
2019-03-01 02:41:16.8: Send Observation T_Ori to ACP Sequencer
2019-03-01 02:44:25.6: Acquisition time: 587.7508228 sec.
2019-03-01 02:44:25.6: Data for Observation T_Ori of Plan T_Ori acquired successfully.
2019-03-01 02:44:25.6: Plan T_Ori completed successfully.
2019-03-01 02:44:25.6: Image Efficiency: 45.9%
2019-03-01 02:44:25.6: Cycle Efficiency: 99.9%
2019-03-01 02:44:29.2: Dispatcher cycle time: 0.3 sec.
2019-03-01 02:44:29.2: Acquire data for Observation HQ_Aur...
2019-03-01 02:44:29.2:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HQ_Aur)
2019-03-01 02:44:29.2: Send Observation HQ_Aur to ACP Sequencer
2019-03-01 02:49:35.5: ACP data acquisition failed for Observation HQ_Aur.
2019-03-01 02:49:35.5:   (Observation HQ_Aur interrupted by acquisition process failure.)
2019-03-01 02:49:38.3: Dispatcher cycle time: 1.0 sec.
2019-03-01 02:49:38.3: Acquire data for Observation HO_Cam...
2019-03-01 02:49:38.3:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HO_Cam)
2019-03-01 02:49:39.5: Send Observation HO_Cam to ACP Sequencer
2019-03-01 02:52:44.0: ACP data acquisition failed for Observation HO_Cam.
2019-03-01 02:52:44.0:   (Observation HO_Cam interrupted by acquisition process failure.)
2019-03-01 02:52:47.3: Dispatcher cycle time: 1.5 sec.
2019-03-01 02:52:47.3: Acquire data for Observation HI_Cam...
2019-03-01 02:52:47.3:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HI_Cam)
2019-03-01 02:52:47.7: Send Observation HI_Cam to ACP Sequencer
2019-03-01 02:56:03.4: ACP data acquisition failed for Observation HI_Cam.
2019-03-01 02:56:03.4:   (Observation HI_Cam interrupted by acquisition process failure.)
2019-03-01 02:56:06.6: Dispatcher cycle time: 1.2 sec.
2019-03-01 02:56:06.6: Acquire data for Observation HX_Aur...
2019-03-01 02:56:06.6:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan HX_Aur)
2019-03-01 02:56:07.1: Send Observation HX_Aur to ACP Sequencer
2019-03-01 02:59:42.2: ACP data acquisition failed for Observation HX_Aur.
2019-03-01 02:59:42.2:   (Observation HX_Aur interrupted by acquisition process failure.)
2019-03-01 02:59:46.7: Dispatcher cycle time: 0.2 sec.
2019-03-01 02:59:46.7: Acquire data for Observation FW_Cam...
2019-03-01 02:59:46.7:   (belongs to Project AAVSO_HGUA_Miras_Manual_ver167, Plan FW_Cam)
2019-03-01 02:59:47.5: Send Observation FW_Cam to ACP Sequencer
2019-03-01 03:04:11.6: ACP data acquisition failed for Observation FW_Cam.
2019-03-01 03:04:11.7:   (Observation FW_Cam interrupted by acquisition process failure.)
2019-03-01 03:04:16.0: Dispatcher cycle time: 0.2 sec.
2019-03-01 03:04:16.0: Acquire data for Observation MP_Gem...
2019-03-01 03:04:16.0:   (belongs to Project Staels, Plan MP_Gem)
2019-03-01 03:04:16.0: Send Observation MP_Gem to ACP Sequencer
2019-03-01 03:09:48.0: ACP data acquisition failed for Observation MP_Gem.
2019-03-01 03:09:48.0:   (Observation MP_Gem interrupted by acquisition process failure.)
2019-03-01 03:09:53.7: Dispatcher cycle time: 0.2 sec.
2019-03-01 03:09:53.7: Acquire data for Observation V0959_Mon...
2019-03-01 03:09:53.7:   (belongs to Project Nova_Monitoring, Plan V0959_Mon)
2019-03-01 03:09:53.7: Send Observation V0959_Mon to ACP Sequencer
2019-03-01 03:14:31.3: ACP data acquisition failed for Observation V0959_Mon.
2019-03-01 03:14:31.3:   (Observation V0959_Mon interrupted by acquisition process failure.)
2019-03-01 03:14:34.6: Dispatcher cycle time: 0.1 sec.
2019-03-01 03:14:34.6: Acquire data for Observation V0965_Per...
2019-03-01 03:14:34.6:   (belongs to Project Nova_Monitoring, Plan V0965_Per)
2019-03-01 03:14:34.6: Send Observation V0965_Per to ACP Sequencer
2019-03-01 03:15:41.4: ** ACP script "AcquireScheduler" failed:
2019-03-01 03:15:41.4: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 1021 column 9.

2019-03-01 03:15:44.6: ACP OPERATOR ABORT: The operator killed the run
2019-03-01 03:15:44.6: ACP data acquisition failed for Observation V0965_Per.
2019-03-01 03:15:44.6:   (Observation V0965_Per interrupted by acquisition process failure.)
2019-03-01 03:15:47.6: -- Weather Unsafe --
2019-03-01 07:15:48.9: ++ Weather Safe ++
2019-03-01 07:15:49.9: ++ Observatory Startup ++
2019-03-01 07:15:49.9: Start ACP Sequencer's StartupObs script
2019-03-01 07:16:10.1: Open the observatory dome/roof
2019-03-01 07:17:02.4: Observatory startup succeeded, and dome opened successfully
2019-03-01 07:17:02.4: ++ Auto Focus ++
2019-03-01 07:17:02.4: Doing initial autofocus.
2019-03-01 07:17:02.4: Start special ACP AutoFocus script for scheduler
2019-03-01 09:06:16.2: ** ACP script "AutoFocusScheduler" failed:
2019-03-01 09:06:16.2: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 77 column 9.

2019-03-01 09:06:16.2: ** Autofocus failed (n=1), will retry ASAP after 0 min.
2019-03-01 09:06:17.8: -- Weather Unsafe --
2019-03-01 09:39:49.3: ++ Weather Safe ++
2019-03-01 09:39:50.3: ++ Observatory Startup ++
2019-03-01 09:39:50.3: Start ACP Sequencer's StartupObs script
2019-03-01 09:40:12.5: Open the observatory dome/roof
2019-03-01 09:41:04.6: Observatory startup succeeded, and dome opened successfully
2019-03-01 09:41:04.6: ++ Auto Focus ++
2019-03-01 09:41:04.6: Doing initial autofocus.
2019-03-01 09:41:04.6: Start special ACP AutoFocus script for scheduler
2019-03-01 12:56:46.5: Dispatcher stopped at 01-Mar-2019 12:56:46 UTC
2019-03-01 12:56:46.6: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED**
2019-03-01 12:57:24.1: ** ACP script "AutoFocusScheduler" failed:
2019-03-01 12:57:24.1: **Script Error**
Source:   ACP
Message:  The script was aborted.
Location: line 77 column 9.

2019-03-01 12:57:24.1: ** Autofocus failed (n=2), will retry ASAP after 5 min.
2019-03-01 13:28:26.4: -- Weather Unsafe --
2019-03-02 03:51:24.0: ++ Weather Safe ++
2019-03-02 04:33:07.2: -- Weather Unsafe --
2019-03-02 05:07:22.6: ++ Weather Safe ++
2019-03-02 06:08:06.8: -- Weather Unsafe --
2019-03-02 07:10:05.4: ++ Weather Safe ++
2019-03-02 13:34:27.4: -- Weather Unsafe --
2019-03-02 16:04:59.7: Weather successfully connected. Wait for valid data...
2019-03-03 09:22:22.8: ++ Weather Safe ++
2019-03-03 10:38:59.7: -- Weather Unsafe --
2019-03-03 11:58:11.1: ++ Weather Safe ++
2019-03-03 13:22:28.2: -- Weather Unsafe --
2019-03-04 04:31:16.1: ++ Weather Safe ++
2019-03-04 13:21:59.1: -- Weather Unsafe --
2019-03-05 01:40:16.1: ++ Weather Safe ++
2019-03-05 13:20:22.5: -- Weather Unsafe --
2019-03-06 01:49:57.2: ++ Weather Safe ++
2019-03-06 05:00:10.6: -- Weather Unsafe --
2019-03-06 05:30:51.1: ++ Weather Safe ++
2019-03-06 05:31:21.3: -- Weather Unsafe --
2019-03-06 06:07:25.7: ++ Weather Safe ++
2019-03-06 06:10:07.2: -- Weather Unsafe --
2019-03-06 06:40:33.9: ++ Weather Safe ++
2019-03-06 11:32:26.0: -- Weather Unsafe --
2019-03-06 12:03:42.0: ++ Weather Safe ++
2019-03-06 13:23:48.5: -- Weather Unsafe --
2019-03-07 01:37:36.0: ++ Weather Safe ++
2019-03-07 05:58:18.4: -- Weather Unsafe --
2019-03-07 06:41:47.6: ++ Weather Safe ++
2019-03-07 13:30:29.1: -- Weather Unsafe --
2019-03-08 01:34:05.7: ++ Weather Safe ++
2019-03-08 02:23:38.1: -- Weather Unsafe --
2019-03-08 05:20:59.2: ++ Weather Safe ++
2019-03-08 13:32:35.4: -- Weather Unsafe --
2019-03-09 01:41:04.4: ++ Weather Safe ++
2019-03-09 04:20:32.7: -- Weather Unsafe --
2019-03-09 09:33:12.5: ++ Weather Safe ++
2019-03-09 09:41:29.2: -- Weather Unsafe --
2019-03-09 11:33:39.4: ++ Weather Safe ++
2019-03-09 11:46:36.9: -- Weather Unsafe --
2019-03-09 12:29:22.1: ++ Weather Safe ++
2019-03-09 12:46:13.0: -- Weather Unsafe --
2019-03-10 01:38:44.1: ++ Weather Safe ++
2019-03-10 13:25:37.6: -- Weather Unsafe --
2019-03-11 01:50:44.7: ++ Weather Safe ++
2019-03-11 05:30:54.3: -- Weather Unsafe --
2019-03-11 06:49:16.6: ++ Weather Safe ++
2019-03-11 08:13:49.4: -- Weather Unsafe --
2019-03-11 08:49:06.6: ++ Weather Safe ++
2019-03-11 09:00:10.1: -- Weather Unsafe --
2019-03-11 11:16:12.3: ++ Weather Safe ++
2019-03-11 13:42:01.4: -- Weather Unsafe --
2019-03-12 01:33:12.4: ++ Weather Safe ++
2019-03-12 08:14:10.8: -- Weather Unsafe --
2019-03-12 08:46:22.1: ++ Weather Safe ++
2019-03-12 08:47:22.9: -- Weather Unsafe --
2019-03-12 10:46:50.2: ++ Weather Safe ++
2019-03-12 12:54:40.3: -- Weather Unsafe --