Log opened at Wed, Apr 03 2019 21:37:35 UTC (actual time) Current log level is Verbose ACP Expert Scheduler version 8.1.1 Full license: Arne Henden 2019-04-03 21:37:35.7: Internal clock initialized at 03-Apr-2019 21:37:35 UTC 2019-04-03 21:37:35.7: Loaded Constraint plugin AirMass 2019-04-03 21:37:35.7: Loaded Constraint plugin AirmassRange 2019-04-03 21:37:35.7: Loaded Constraint plugin Horizon 2019-04-03 21:37:35.7: Loaded Constraint plugin HourAngle 2019-04-03 21:37:35.7: Loaded Constraint plugin MoonAvoid 2019-04-03 21:37:35.7: Loaded Constraint plugin MoonDown 2019-04-03 21:37:35.7: Loaded Constraint plugin SkyCondition 2019-04-03 21:37:35.7: Loaded Constraint plugin TimeRange 2019-04-03 21:37:36.5: 49 plans are now pending. 2019-04-03 21:37:36.6: Attach ACP sequencer 2019-04-03 21:37:42.6: There is no controllable dome or roof. 2019-04-03 21:37:42.6: Sequencer does sky flats 2019-04-03 21:37:58.2: Weather successfully connected. Wait for valid data... Log level changed from Verbose to Debug 2019-04-04 01:59:50.0: Dispatcher started at 04-Apr-2019 01:59:50 UTC 2019-04-04 01:59:50.0: Priority: W[0]=1.00 2019-04-04 01:59:50.0: Transit Altitude: W[1]=0.70 2019-04-04 01:59:50.0: Highest Altitude: W[6]=0.00 2019-04-04 01:59:50.0: Lateness: W[5]=0.00 2019-04-04 01:59:50.0: Slew Distance: W[2]=0.30 2019-04-04 01:59:50.0: Retry Count: W[3]=0.00 2019-04-04 01:59:50.0: Meridian Crossing: W[4]=0.00 2019-04-04 01:59:50.0: Obs Conditions: W[7]=0.40 2019-04-04 01:59:50.0: Rising Plan Delay: in effect 2019-04-04 02:12:14.6: ++ Observatory Startup ++ 2019-04-04 02:12:14.6: Start ACP Sequencer's StartupObs script 2019-04-04 02:12:14.6: ACP.RunScript(StartupObs, ): 2019-04-04 02:12:14.6: Script ACP-Weather is loaded, and 2019-04-04 02:12:14.6: the console is idle. 2019-04-04 02:12:14.6: In start loop, i = 0 2019-04-04 02:12:14.6: Console is now idle 2019-04-04 02:12:14.6: Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully 2019-04-04 02:12:14.6: Script started successfully 2019-04-04 02:12:24.6: Sequencer is now active 2019-04-04 02:12:49.5: Sequencer is no longer active 2019-04-04 02:12:50.2: Observatory startup succeeded in unsafe weather. 2019-04-04 02:19:22.8: Dispatcher stopped at 04-Apr-2019 02:19:22 UTC 2019-04-04 02:19:22.8: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 2019-04-04 03:12:51.9: Dispatcher started at 04-Apr-2019 03:12:51 UTC 2019-04-04 03:12:51.9: Priority: W[0]=1.00 2019-04-04 03:12:51.9: Transit Altitude: W[1]=0.70 2019-04-04 03:12:51.9: Highest Altitude: W[6]=0.00 2019-04-04 03:12:51.9: Lateness: W[5]=0.00 2019-04-04 03:12:51.9: Slew Distance: W[2]=0.30 2019-04-04 03:12:51.9: Retry Count: W[3]=0.00 2019-04-04 03:12:51.9: Meridian Crossing: W[4]=0.00 2019-04-04 03:12:51.9: Obs Conditions: W[7]=0.40 2019-04-04 03:12:51.9: Rising Plan Delay: in effect 2019-04-04 04:43:36.8: ++ Weather Safe ++ 2019-04-04 04:43:37.8: ++ Observatory Startup ++ 2019-04-04 04:43:37.8: Start ACP Sequencer's StartupObs script 2019-04-04 04:43:37.8: ACP.RunScript(StartupObs, ): 2019-04-04 04:43:37.8: Script StartupObs is loaded, and 2019-04-04 04:43:37.8: the console is idle. 2019-04-04 04:43:37.8: In start loop, i = 0 2019-04-04 04:43:37.8: Console is now idle 2019-04-04 04:43:37.8: Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully 2019-04-04 04:43:37.8: Script started successfully 2019-04-04 04:43:47.8: Sequencer is now active 2019-04-04 04:43:57.1: Sequencer is no longer active 2019-04-04 04:43:58.6: Open the observatory dome/roof 2019-04-04 04:44:49.6: Observatory startup succeeded, and dome opened successfully 2019-04-04 04:44:49.6: ++ Auto Focus ++ 2019-04-04 04:44:49.6: Doing initial autofocus. 2019-04-04 04:44:49.6: Start special ACP AutoFocus script for scheduler 2019-04-04 04:44:49.6: ACP.RunScript(AutoFocusScheduler, ): 2019-04-04 04:44:49.6: Script StartupObs is loaded, and 2019-04-04 04:44:49.6: the console is idle. 2019-04-04 04:44:49.6: In start loop, i = 0 2019-04-04 04:44:49.6: Console is now idle 2019-04-04 04:44:49.6: Loaded C:\Program Files\ACP Scheduler\AutoFocusScheduler.vbs successfully 2019-04-04 04:44:49.6: Script started successfully 2019-04-04 04:44:59.6: Sequencer is now active 2019-04-04 04:48:59.3: Sequencer is no longer active 2019-04-04 04:48:59.3: Next periodic autofocus ASAP after 04-Apr-2019 07:48:40 UTC 2019-04-04 04:49:01.3: SelectRunning: No running plans 2019-04-04 04:49:01.3: Obs delOri in Plan delOri was vetoed by Horizon constraint. 2019-04-04 04:49:01.3: Horizon estimates ready after 04-Apr-2019 19:48:33 UTC 2019-04-04 04:49:01.5: Jupiter failed, bad planet name "Jupiter" in Obs Jupiter_manualcoords 2019-04-04 04:49:01.5: Obs piOri in Plan piOri was vetoed by Horizon constraint. 2019-04-04 04:49:01.5: Horizon estimates ready after 04-Apr-2019 18:43:45 UTC 2019-04-04 04:49:01.5: Obs upsOri in Plan upsOri was vetoed by Horizon constraint. 2019-04-04 04:49:01.5: Horizon estimates ready after 04-Apr-2019 20:10:46 UTC 2019-04-04 04:49:01.5: Efficiency: Only one pending plan WD1145+017, it is the "best" 2019-04-04 04:49:01.5: Dispatcher cycle time: 0.4 sec. 2019-04-04 04:49:01.5: Acquire data for Observation WD1145+017... 2019-04-04 04:49:01.5: (belongs to Project ASTR402_Spring2019, Plan WD1145+017) 2019-04-04 04:49:01.5: Doing 30 sets 2019-04-04 04:49:01.5: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 04:49:01.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 04:49:01.5: Script AutoFocusScheduler is loaded, and 2019-04-04 04:49:01.5: the console is idle. 2019-04-04 04:49:01.5: In start loop, i = 0 2019-04-04 04:49:01.5: Console is now idle 2019-04-04 04:49:01.5: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 04:49:01.6: Script started successfully 2019-04-04 04:49:11.6: Sequencer is now active 2019-04-04 05:01:51.3: Sequencer is no longer active 2019-04-04 05:01:51.3: Post-job status check done (stat=Completed) 2019-04-04 05:01:51.3: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 05:01:51.3: ACP.RunScript(AcquireScheduler, ): 2019-04-04 05:01:51.3: Script AcquireScheduler is loaded, and 2019-04-04 05:01:51.3: the console is idle. 2019-04-04 05:01:51.3: In start loop, i = 0 2019-04-04 05:01:51.3: Console is now idle 2019-04-04 05:01:51.6: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 05:01:51.6: Script started successfully 2019-04-04 05:02:01.6: Sequencer is now active 2019-04-04 05:12:48.1: Sequencer is no longer active 2019-04-04 05:12:48.1: Post-job status check done (stat=Completed) 2019-04-04 05:12:48.2: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 05:12:48.2: ACP.RunScript(AcquireScheduler, ): 2019-04-04 05:12:48.2: Script AcquireScheduler is loaded, and 2019-04-04 05:12:48.2: the console is idle. 2019-04-04 05:12:48.2: In start loop, i = 0 2019-04-04 05:12:48.2: Console is now idle 2019-04-04 05:12:48.6: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 05:12:48.6: Script started successfully 2019-04-04 05:12:58.6: Sequencer is now active 2019-04-04 05:23:45.1: Sequencer is no longer active 2019-04-04 05:23:45.1: Post-job status check done (stat=Completed) 2019-04-04 05:23:45.2: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 05:23:45.2: ACP.RunScript(AcquireScheduler, ): 2019-04-04 05:23:45.2: Script AcquireScheduler is loaded, and 2019-04-04 05:23:45.2: the console is idle. 2019-04-04 05:23:45.2: In start loop, i = 0 2019-04-04 05:23:45.2: Console is now idle 2019-04-04 05:23:45.5: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 05:23:45.5: Script started successfully 2019-04-04 05:23:55.5: Sequencer is now active 2019-04-04 05:34:39.3: Sequencer is no longer active 2019-04-04 05:34:39.3: Post-job status check done (stat=Completed) 2019-04-04 05:34:39.3: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 05:34:39.3: ACP.RunScript(AcquireScheduler, ): 2019-04-04 05:34:39.3: Script AcquireScheduler is loaded, and 2019-04-04 05:34:39.3: the console is idle. 2019-04-04 05:34:39.3: In start loop, i = 0 2019-04-04 05:34:39.3: Console is now idle 2019-04-04 05:34:39.6: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 05:34:39.6: Script started successfully 2019-04-04 05:34:49.6: Sequencer is now active 2019-04-04 05:45:35.3: Sequencer is no longer active 2019-04-04 05:45:35.3: Post-job status check done (stat=Completed) 2019-04-04 05:45:35.3: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 05:45:35.3: ACP.RunScript(AcquireScheduler, ): 2019-04-04 05:45:35.3: Script AcquireScheduler is loaded, and 2019-04-04 05:45:35.3: the console is idle. 2019-04-04 05:45:35.3: In start loop, i = 0 2019-04-04 05:45:35.3: Console is now idle 2019-04-04 05:45:35.6: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 05:45:35.6: Script started successfully 2019-04-04 05:45:45.6: Sequencer is now active 2019-04-04 05:56:32.5: Sequencer is no longer active 2019-04-04 05:56:32.5: Post-job status check done (stat=Completed) 2019-04-04 05:56:32.5: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 05:56:32.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 05:56:32.5: Script AcquireScheduler is loaded, and 2019-04-04 05:56:32.5: the console is idle. 2019-04-04 05:56:32.5: In start loop, i = 0 2019-04-04 05:56:32.5: Console is now idle 2019-04-04 05:56:32.8: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 05:56:32.8: Script started successfully 2019-04-04 05:56:42.8: Sequencer is now active 2019-04-04 06:07:27.8: Sequencer is no longer active 2019-04-04 06:07:27.8: Post-job status check done (stat=Completed) 2019-04-04 06:07:27.8: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 06:07:27.8: ACP.RunScript(AcquireScheduler, ): 2019-04-04 06:07:27.8: Script AcquireScheduler is loaded, and 2019-04-04 06:07:27.8: the console is idle. 2019-04-04 06:07:27.8: In start loop, i = 0 2019-04-04 06:07:27.8: Console is now idle 2019-04-04 06:07:28.1: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 06:07:28.1: Script started successfully 2019-04-04 06:07:38.1: Sequencer is now active 2019-04-04 06:18:23.5: Sequencer is no longer active 2019-04-04 06:18:23.5: Post-job status check done (stat=Completed) 2019-04-04 06:18:23.5: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 06:18:23.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 06:18:23.5: Script AcquireScheduler is loaded, and 2019-04-04 06:18:23.5: the console is idle. 2019-04-04 06:18:23.5: In start loop, i = 0 2019-04-04 06:18:23.5: Console is now idle 2019-04-04 06:18:23.8: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 06:18:23.8: Script started successfully 2019-04-04 06:18:33.8: Sequencer is now active 2019-04-04 06:29:20.6: Sequencer is no longer active 2019-04-04 06:29:20.6: Post-job status check done (stat=Completed) 2019-04-04 06:29:20.6: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 06:29:20.6: ACP.RunScript(AcquireScheduler, ): 2019-04-04 06:29:20.6: Script AcquireScheduler is loaded, and 2019-04-04 06:29:20.6: the console is idle. 2019-04-04 06:29:20.6: In start loop, i = 0 2019-04-04 06:29:20.6: Console is now idle 2019-04-04 06:29:20.9: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 06:29:20.9: Script started successfully 2019-04-04 06:29:30.9: Sequencer is now active 2019-04-04 06:40:16.5: Sequencer is no longer active 2019-04-04 06:40:16.5: Post-job status check done (stat=Completed) 2019-04-04 06:40:16.5: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 06:40:16.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 06:40:16.5: Script AcquireScheduler is loaded, and 2019-04-04 06:40:16.5: the console is idle. 2019-04-04 06:40:16.5: In start loop, i = 0 2019-04-04 06:40:16.5: Console is now idle 2019-04-04 06:40:16.8: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 06:40:16.8: Script started successfully 2019-04-04 06:40:26.8: Sequencer is now active 2019-04-04 06:51:11.1: Sequencer is no longer active 2019-04-04 06:51:11.1: Post-job status check done (stat=Completed) 2019-04-04 06:51:11.2: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 06:51:11.2: ACP.RunScript(AcquireScheduler, ): 2019-04-04 06:51:11.2: Script AcquireScheduler is loaded, and 2019-04-04 06:51:11.2: the console is idle. 2019-04-04 06:51:11.2: In start loop, i = 0 2019-04-04 06:51:11.2: Console is now idle 2019-04-04 06:51:11.5: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 06:51:11.5: Script started successfully 2019-04-04 06:51:21.5: Sequencer is now active 2019-04-04 06:58:58.0: Sequencer is no longer active 2019-04-04 06:59:01.0: Post-job status check done (stat=Running) 2019-04-04 06:59:01.0: ACP ERROR: Run failed for unknown reason (see ACP run log) 2019-04-04 06:59:01.0: ACP data acquisition failed for Observation WD1145+017. 2019-04-04 06:59:01.0: (Observation WD1145+017 interrupted by acquisition process failure.) 2019-04-04 06:59:01.1: -- Weather Unsafe -- 2019-04-04 07:54:37.1: ++ Weather Safe ++ 2019-04-04 07:54:38.1: ++ Observatory Startup ++ 2019-04-04 07:54:38.1: Start ACP Sequencer's StartupObs script 2019-04-04 07:54:38.1: Starting with open dome, unsafe weather will cause operator intervention error 2019-04-04 07:54:38.1: ACP.RunScript(StartupObs, ): 2019-04-04 07:54:38.1: Script ACP-Weather is loaded, and 2019-04-04 07:54:38.1: the console is idle. 2019-04-04 07:54:38.1: In start loop, i = 0 2019-04-04 07:54:38.1: Console is now idle 2019-04-04 07:54:38.1: Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully 2019-04-04 07:54:38.1: Script started successfully 2019-04-04 07:54:48.1: Sequencer is now active 2019-04-04 07:54:57.9: Sequencer is no longer active 2019-04-04 07:54:58.4: Observatory startup succeeded 2019-04-04 07:54:59.6: ++ Auto Focus ++ 2019-04-04 07:54:59.6: Doing initial autofocus. 2019-04-04 07:54:59.6: Start special ACP AutoFocus script for scheduler 2019-04-04 07:54:59.6: ACP.RunScript(AutoFocusScheduler, ): 2019-04-04 07:54:59.6: Script StartupObs is loaded, and 2019-04-04 07:54:59.6: the console is idle. 2019-04-04 07:54:59.6: In start loop, i = 0 2019-04-04 07:54:59.6: Console is now idle 2019-04-04 07:54:59.6: Loaded C:\Program Files\ACP Scheduler\AutoFocusScheduler.vbs successfully 2019-04-04 07:54:59.6: Script started successfully 2019-04-04 07:55:09.6: Sequencer is now active 2019-04-04 07:58:46.5: Sequencer is no longer active 2019-04-04 07:58:46.5: Next periodic autofocus ASAP after 04-Apr-2019 10:58:22 UTC 2019-04-04 07:58:48.6: SelectRunning: No running plans 2019-04-04 07:58:48.6: EPH (Jupiter): type=Major Planet time=07:58:48 ra=17.5678681 dec=-22.668971 2019-04-04 07:58:48.6: Obs Jupiter in Plan Jupiter was vetoed by Horizon constraint. 2019-04-04 07:58:48.6: Horizon estimates ready after 04-Apr-2019 09:26:12 UTC 2019-04-04 07:58:48.6: Efficiency: Only one pending plan WD1145+017, it is the "best" 2019-04-04 07:58:48.7: Dispatcher cycle time: 0.6 sec. 2019-04-04 07:58:48.7: Acquire data for Observation WD1145+017... 2019-04-04 07:58:48.7: (belongs to Project ASTR402_Spring2019, Plan WD1145+017) 2019-04-04 07:58:48.7: Doing 30 sets 2019-04-04 07:58:50.1: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 07:58:50.1: ACP.RunScript(AcquireScheduler, ): 2019-04-04 07:58:50.1: Script AutoFocusScheduler is loaded, and 2019-04-04 07:58:50.1: the console is idle. 2019-04-04 07:58:50.1: In start loop, i = 0 2019-04-04 07:58:50.1: Console is now idle 2019-04-04 07:58:50.1: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 07:58:50.1: Script started successfully 2019-04-04 07:59:00.1: Sequencer is now active 2019-04-04 08:10:55.7: Dispatcher stopped at 04-Apr-2019 08:10:55 UTC 2019-04-04 08:10:55.7: **DISPATCHER INTERRUPT LEVEL 1 RECEIVED** 2019-04-04 08:11:18.9: Sequencer is no longer active 2019-04-04 08:11:18.9: ** ACP script "AcquireScheduler" failed: 2019-04-04 08:11:18.9: **Script Error** Source: ACP Message: The script was aborted. Location: line 1377 column 13. 2019-04-04 08:11:21.9: Post-job status check done (stat=Running) 2019-04-04 08:11:21.9: RUN FAILED: Scheduler was stopped during run 2019-04-04 08:11:21.9: ACP data acquisition failed for Observation WD1145+017. 2019-04-04 08:11:21.9: (Observation WD1145+017 interrupted by operator or system.) 2019-04-04 08:14:29.4: Dispatcher started at 04-Apr-2019 08:14:29 UTC 2019-04-04 08:14:29.4: Priority: W[0]=1.00 2019-04-04 08:14:29.4: Transit Altitude: W[1]=0.70 2019-04-04 08:14:29.4: Highest Altitude: W[6]=0.00 2019-04-04 08:14:29.4: Lateness: W[5]=0.00 2019-04-04 08:14:29.4: Slew Distance: W[2]=0.30 2019-04-04 08:14:29.4: Retry Count: W[3]=0.00 2019-04-04 08:14:29.4: Meridian Crossing: W[4]=0.00 2019-04-04 08:14:29.4: Obs Conditions: W[7]=0.40 2019-04-04 08:14:29.4: Rising Plan Delay: in effect 2019-04-04 08:14:31.0: ++ Observatory Startup ++ 2019-04-04 08:14:31.0: Start ACP Sequencer's StartupObs script 2019-04-04 08:14:31.0: Starting with open dome, unsafe weather will cause operator intervention error 2019-04-04 08:14:31.0: ACP.RunScript(StartupObs, ): 2019-04-04 08:14:31.0: Script AcquireScheduler is loaded, and 2019-04-04 08:14:31.0: the console is idle. 2019-04-04 08:14:31.0: In start loop, i = 0 2019-04-04 08:14:31.0: Console is now idle 2019-04-04 08:14:31.0: Loaded C:\Users\Public\Documents\ACP Config\Scheduler\StartupObs.js successfully 2019-04-04 08:14:31.0: Script started successfully 2019-04-04 08:14:41.0: Sequencer is now active 2019-04-04 08:14:51.4: Sequencer is no longer active 2019-04-04 08:14:52.7: Observatory startup succeeded 2019-04-04 08:14:52.9: ++ Auto Focus ++ 2019-04-04 08:14:52.9: Doing initial autofocus. 2019-04-04 08:14:52.9: Start special ACP AutoFocus script for scheduler 2019-04-04 08:14:52.9: ACP.RunScript(AutoFocusScheduler, ): 2019-04-04 08:14:52.9: Script StartupObs is loaded, and 2019-04-04 08:14:52.9: the console is idle. 2019-04-04 08:14:52.9: In start loop, i = 0 2019-04-04 08:14:52.9: Console is now idle 2019-04-04 08:14:52.9: Loaded C:\Program Files\ACP Scheduler\AutoFocusScheduler.vbs successfully 2019-04-04 08:14:52.9: Script started successfully 2019-04-04 08:15:02.9: Sequencer is now active 2019-04-04 08:17:41.2: Sequencer is no longer active 2019-04-04 08:17:41.2: Next periodic autofocus ASAP after 04-Apr-2019 11:17:26 UTC 2019-04-04 08:17:41.5: SelectRunning: No running plans 2019-04-04 08:17:41.5: Efficiency: Only one pending plan WD1145+017, it is the "best" 2019-04-04 08:17:41.6: Dispatcher cycle time: 0.2 sec. 2019-04-04 08:17:41.6: Acquire data for Observation WD1145+017... 2019-04-04 08:17:41.6: (belongs to Project ASTR402_Spring2019, Plan WD1145+017) 2019-04-04 08:17:41.6: Doing 60 sets 2019-04-04 08:17:42.6: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 08:17:42.6: ACP.RunScript(AcquireScheduler, ): 2019-04-04 08:17:42.6: Script AutoFocusScheduler is loaded, and 2019-04-04 08:17:42.6: the console is idle. 2019-04-04 08:17:42.6: In start loop, i = 0 2019-04-04 08:17:42.6: Console is now idle 2019-04-04 08:17:42.6: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 08:17:42.6: Script started successfully 2019-04-04 08:17:52.6: Sequencer is now active 2019-04-04 08:24:49.3: Sequencer is no longer active 2019-04-04 08:24:49.3: Post-job status check done (stat=Completed) 2019-04-04 08:24:49.3: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 08:24:49.3: ACP.RunScript(AcquireScheduler, ): 2019-04-04 08:24:49.3: Script AcquireScheduler is loaded, and 2019-04-04 08:24:49.3: the console is idle. 2019-04-04 08:24:49.3: In start loop, i = 0 2019-04-04 08:24:49.3: Console is now idle 2019-04-04 08:24:49.6: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 08:24:49.6: Script started successfully 2019-04-04 08:24:59.6: Sequencer is now active 2019-04-04 08:30:50.0: Sequencer is no longer active 2019-04-04 08:30:50.0: Post-job status check done (stat=Completed) 2019-04-04 08:30:50.1: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 08:30:50.1: ACP.RunScript(AcquireScheduler, ): 2019-04-04 08:30:50.1: Script AcquireScheduler is loaded, and 2019-04-04 08:30:50.1: the console is idle. 2019-04-04 08:30:50.1: In start loop, i = 0 2019-04-04 08:30:50.1: Console is now idle 2019-04-04 08:30:50.4: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 08:30:50.4: Script started successfully 2019-04-04 08:31:00.4: Sequencer is now active 2019-04-04 08:36:53.0: Sequencer is no longer active 2019-04-04 08:36:53.0: Post-job status check done (stat=Completed) 2019-04-04 08:36:53.0: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 08:36:53.0: ACP.RunScript(AcquireScheduler, ): 2019-04-04 08:36:53.0: Script AcquireScheduler is loaded, and 2019-04-04 08:36:53.0: the console is idle. 2019-04-04 08:36:53.0: In start loop, i = 0 2019-04-04 08:36:53.0: Console is now idle 2019-04-04 08:36:53.4: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 08:36:53.4: Script started successfully 2019-04-04 08:37:03.4: Sequencer is now active 2019-04-04 08:42:53.3: Sequencer is no longer active 2019-04-04 08:42:53.3: Post-job status check done (stat=Completed) 2019-04-04 08:42:53.3: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 08:42:53.3: ACP.RunScript(AcquireScheduler, ): 2019-04-04 08:42:53.3: Script AcquireScheduler is loaded, and 2019-04-04 08:42:53.3: the console is idle. 2019-04-04 08:42:53.3: In start loop, i = 0 2019-04-04 08:42:53.3: Console is now idle 2019-04-04 08:42:53.6: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 08:42:53.6: Script started successfully 2019-04-04 08:43:03.6: Sequencer is now active 2019-04-04 08:48:54.9: Sequencer is no longer active 2019-04-04 08:48:54.9: Post-job status check done (stat=Completed) 2019-04-04 08:48:54.9: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 08:48:54.9: ACP.RunScript(AcquireScheduler, ): 2019-04-04 08:48:54.9: Script AcquireScheduler is loaded, and 2019-04-04 08:48:54.9: the console is idle. 2019-04-04 08:48:54.9: In start loop, i = 0 2019-04-04 08:48:54.9: Console is now idle 2019-04-04 08:48:55.2: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 08:48:55.2: Script started successfully 2019-04-04 08:49:05.2: Sequencer is now active 2019-04-04 08:54:55.3: Sequencer is no longer active 2019-04-04 08:54:55.3: Post-job status check done (stat=Completed) 2019-04-04 08:54:55.3: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 08:54:55.3: ACP.RunScript(AcquireScheduler, ): 2019-04-04 08:54:55.3: Script AcquireScheduler is loaded, and 2019-04-04 08:54:55.3: the console is idle. 2019-04-04 08:54:55.3: In start loop, i = 0 2019-04-04 08:54:55.3: Console is now idle 2019-04-04 08:54:55.6: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 08:54:55.6: Script started successfully 2019-04-04 08:55:05.6: Sequencer is now active 2019-04-04 09:01:00.0: Sequencer is no longer active 2019-04-04 09:01:00.0: Post-job status check done (stat=Completed) 2019-04-04 09:01:00.1: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:01:00.1: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:01:00.1: Script AcquireScheduler is loaded, and 2019-04-04 09:01:00.1: the console is idle. 2019-04-04 09:01:00.1: In start loop, i = 0 2019-04-04 09:01:00.1: Console is now idle 2019-04-04 09:01:00.4: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:01:00.4: Script started successfully 2019-04-04 09:01:10.4: Sequencer is now active 2019-04-04 09:07:00.7: Sequencer is no longer active 2019-04-04 09:07:00.7: Post-job status check done (stat=Completed) 2019-04-04 09:07:00.7: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:07:00.7: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:07:00.7: Script AcquireScheduler is loaded, and 2019-04-04 09:07:00.7: the console is idle. 2019-04-04 09:07:00.7: In start loop, i = 0 2019-04-04 09:07:00.7: Console is now idle 2019-04-04 09:07:01.0: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:07:01.0: Script started successfully 2019-04-04 09:07:11.0: Sequencer is now active 2019-04-04 09:12:56.5: Sequencer is no longer active 2019-04-04 09:12:56.5: Post-job status check done (stat=Completed) 2019-04-04 09:12:56.5: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:12:56.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:12:56.5: Script AcquireScheduler is loaded, and 2019-04-04 09:12:56.5: the console is idle. 2019-04-04 09:12:56.5: In start loop, i = 0 2019-04-04 09:12:56.5: Console is now idle 2019-04-04 09:12:56.8: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:12:56.8: Script started successfully 2019-04-04 09:13:06.8: Sequencer is now active 2019-04-04 09:19:04.5: Sequencer is no longer active 2019-04-04 09:19:04.5: Post-job status check done (stat=Completed) 2019-04-04 09:19:04.5: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:19:04.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:19:04.5: Script AcquireScheduler is loaded, and 2019-04-04 09:19:04.5: the console is idle. 2019-04-04 09:19:04.5: In start loop, i = 0 2019-04-04 09:19:04.5: Console is now idle 2019-04-04 09:19:04.8: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:19:04.8: Script started successfully 2019-04-04 09:19:14.8: Sequencer is now active 2019-04-04 09:25:03.6: Sequencer is no longer active 2019-04-04 09:25:03.6: Post-job status check done (stat=Completed) 2019-04-04 09:25:03.6: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:25:03.6: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:25:03.6: Script AcquireScheduler is loaded, and 2019-04-04 09:25:03.6: the console is idle. 2019-04-04 09:25:03.6: In start loop, i = 0 2019-04-04 09:25:03.6: Console is now idle 2019-04-04 09:25:04.0: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:25:04.0: Script started successfully 2019-04-04 09:25:14.0: Sequencer is now active 2019-04-04 09:31:01.5: Sequencer is no longer active 2019-04-04 09:31:01.5: Post-job status check done (stat=Completed) 2019-04-04 09:31:01.5: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:31:01.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:31:01.5: Script AcquireScheduler is loaded, and 2019-04-04 09:31:01.5: the console is idle. 2019-04-04 09:31:01.5: In start loop, i = 0 2019-04-04 09:31:01.5: Console is now idle 2019-04-04 09:31:01.9: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:31:01.9: Script started successfully 2019-04-04 09:31:11.9: Sequencer is now active 2019-04-04 09:36:59.8: Sequencer is no longer active 2019-04-04 09:36:59.8: Post-job status check done (stat=Completed) 2019-04-04 09:36:59.8: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:36:59.8: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:36:59.8: Script AcquireScheduler is loaded, and 2019-04-04 09:36:59.8: the console is idle. 2019-04-04 09:36:59.8: In start loop, i = 0 2019-04-04 09:36:59.8: Console is now idle 2019-04-04 09:37:00.2: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:37:00.2: Script started successfully 2019-04-04 09:37:10.2: Sequencer is now active 2019-04-04 09:42:58.4: Sequencer is no longer active 2019-04-04 09:42:58.4: Post-job status check done (stat=Completed) 2019-04-04 09:42:58.4: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:42:58.4: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:42:58.4: Script AcquireScheduler is loaded, and 2019-04-04 09:42:58.4: the console is idle. 2019-04-04 09:42:58.4: In start loop, i = 0 2019-04-04 09:42:58.4: Console is now idle 2019-04-04 09:42:58.7: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:42:58.7: Script started successfully 2019-04-04 09:43:08.7: Sequencer is now active 2019-04-04 09:48:59.7: Sequencer is no longer active 2019-04-04 09:48:59.7: Post-job status check done (stat=Completed) 2019-04-04 09:48:59.7: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:48:59.7: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:48:59.7: Script AcquireScheduler is loaded, and 2019-04-04 09:48:59.7: the console is idle. 2019-04-04 09:48:59.7: In start loop, i = 0 2019-04-04 09:48:59.7: Console is now idle 2019-04-04 09:49:00.0: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:49:00.0: Script started successfully 2019-04-04 09:49:10.0: Sequencer is now active 2019-04-04 09:55:01.7: Sequencer is no longer active 2019-04-04 09:55:01.7: Post-job status check done (stat=Completed) 2019-04-04 09:55:01.8: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 09:55:01.8: ACP.RunScript(AcquireScheduler, ): 2019-04-04 09:55:01.8: Script AcquireScheduler is loaded, and 2019-04-04 09:55:01.8: the console is idle. 2019-04-04 09:55:01.8: In start loop, i = 0 2019-04-04 09:55:01.8: Console is now idle 2019-04-04 09:55:02.1: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 09:55:02.1: Script started successfully 2019-04-04 09:55:12.1: Sequencer is now active 2019-04-04 10:01:00.4: Sequencer is no longer active 2019-04-04 10:01:00.4: Post-job status check done (stat=Completed) 2019-04-04 10:01:00.4: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 10:01:00.4: ACP.RunScript(AcquireScheduler, ): 2019-04-04 10:01:00.4: Script AcquireScheduler is loaded, and 2019-04-04 10:01:00.4: the console is idle. 2019-04-04 10:01:00.4: In start loop, i = 0 2019-04-04 10:01:00.4: Console is now idle 2019-04-04 10:01:00.7: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 10:01:00.7: Script started successfully 2019-04-04 10:01:10.7: Sequencer is now active 2019-04-04 10:07:00.9: Sequencer is no longer active 2019-04-04 10:07:00.9: Post-job status check done (stat=Completed) 2019-04-04 10:07:01.0: Send Observation WD1145+017 to ACP Sequencer 2019-04-04 10:07:01.0: ACP.RunScript(AcquireScheduler, ): 2019-04-04 10:07:01.0: Script AcquireScheduler is loaded, and 2019-04-04 10:07:01.0: the console is idle. 2019-04-04 10:07:01.0: In start loop, i = 0 2019-04-04 10:07:01.0: Console is now idle 2019-04-04 10:07:01.3: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 10:07:01.3: Script started successfully 2019-04-04 10:07:11.3: Sequencer is now active 2019-04-04 10:13:02.4: Sequencer is no longer active 2019-04-04 10:13:02.4: Post-job status check done (stat=Completed) 2019-04-04 10:13:02.4: TestConstraints: Horizon vetoed/failed for end time of Obs 2019-04-04 10:13:02.4: ***Running Plan WD1145+017 (best efforts) completed early: 2019-04-04 10:13:02.4: Obs WD1145+017 would not meet strict constraints 2019-04-04 10:13:02.4: Acquisition time: 6919.5546877 sec. 2019-04-04 10:13:02.4: Data for Observation WD1145+017 of Plan WD1145+017 acquired successfully. 2019-04-04 10:13:02.4: Plan WD1145+017 completed successfully. 2019-04-04 10:13:02.4: Image Efficiency: 82.4% 2019-04-04 10:13:02.4: Cycle Efficiency: 100.0% 2019-04-04 10:13:03.1: SelectRunning: No running plans 2019-04-04 10:13:03.1: Rising plan delay enabled for Plan Jup: 2019-04-04 10:13:03.1: TimeSpan: 1673 sec. 2019-04-04 10:13:03.1: Lead: 167 sec. 2019-04-04 10:13:03.1: Centroid: RA=17:34:04 DE=-22°40'08" 2019-04-04 10:13:03.1: Mid-Plan LST: 16:09:46 2019-04-04 10:13:03.1: Mid-Plan HA: -01:24:18 2019-04-04 10:13:03.1: 242 min. remaining to meet strict constraints. 2019-04-04 10:13:03.1: 76 min. remaining for the plan to fit before dawn. 2019-04-04 10:13:03.1: 16696186 min. remaining for the plan to fit before "must run before" time. 2019-04-04 10:13:03.1: deferred (rising) for 74 min, until 04-Apr-2019 11:27:09 UTC 2019-04-04 10:13:03.1: EPH (Jupiter): type=Major Planet time=10:13:03 ra=17.5680008 dec=-22.669036 2019-04-04 10:13:03.1: Rising plan delay enabled for Plan Jupiter: 2019-04-04 10:13:03.1: TimeSpan: 1673 sec. 2019-04-04 10:13:03.1: Lead: 167 sec. 2019-04-04 10:13:03.1: Centroid: RA=17:34:05 DE=-22°40'09" 2019-04-04 10:13:03.1: Mid-Plan LST: 16:09:46 2019-04-04 10:13:03.1: Mid-Plan HA: -01:24:19 2019-04-04 10:13:03.1: 242 min. remaining to meet strict constraints. 2019-04-04 10:13:03.1: 76 min. remaining for the plan to fit before dawn. 2019-04-04 10:13:03.1: deferred (rising) for 74 min, until 04-Apr-2019 11:27:09 UTC 2019-04-04 10:13:03.1: No pending plans that can be started now. 2019-04-04 10:13:03.1: Dispatcher cycle time: 0.1 sec. 2019-04-04 10:13:34.7: SelectRunning: No running plans 2019-04-04 10:13:34.7: No pending plans that can be started now. 2019-04-04 10:13:34.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:14:05.0: SelectRunning: No running plans 2019-04-04 10:14:05.0: No pending plans that can be started now. 2019-04-04 10:14:05.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:14:37.9: SelectRunning: No running plans 2019-04-04 10:14:37.9: No pending plans that can be started now. 2019-04-04 10:14:37.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:15:08.3: SelectRunning: No running plans 2019-04-04 10:15:08.3: No pending plans that can be started now. 2019-04-04 10:15:08.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:15:38.7: SelectRunning: No running plans 2019-04-04 10:15:38.7: No pending plans that can be started now. 2019-04-04 10:15:38.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:16:09.8: SelectRunning: No running plans 2019-04-04 10:16:09.8: No pending plans that can be started now. 2019-04-04 10:16:09.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:16:41.4: SelectRunning: No running plans 2019-04-04 10:16:41.4: No pending plans that can be started now. 2019-04-04 10:16:41.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:17:12.7: SelectRunning: No running plans 2019-04-04 10:17:12.7: No pending plans that can be started now. 2019-04-04 10:17:12.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:17:44.2: SelectRunning: No running plans 2019-04-04 10:17:44.2: No pending plans that can be started now. 2019-04-04 10:17:44.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:18:17.7: SelectRunning: No running plans 2019-04-04 10:18:17.7: No pending plans that can be started now. 2019-04-04 10:18:17.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:18:47.8: SelectRunning: No running plans 2019-04-04 10:18:47.8: No pending plans that can be started now. 2019-04-04 10:18:47.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:19:19.8: SelectRunning: No running plans 2019-04-04 10:19:19.8: No pending plans that can be started now. 2019-04-04 10:19:19.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:19:49.9: SelectRunning: No running plans 2019-04-04 10:19:49.9: No pending plans that can be started now. 2019-04-04 10:19:49.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:20:20.4: SelectRunning: No running plans 2019-04-04 10:20:20.4: No pending plans that can be started now. 2019-04-04 10:20:20.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:20:52.0: SelectRunning: No running plans 2019-04-04 10:20:52.0: No pending plans that can be started now. 2019-04-04 10:20:52.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:21:22.5: SelectRunning: No running plans 2019-04-04 10:21:22.5: No pending plans that can be started now. 2019-04-04 10:21:22.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:21:53.9: SelectRunning: No running plans 2019-04-04 10:21:53.9: No pending plans that can be started now. 2019-04-04 10:21:53.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:22:26.1: SelectRunning: No running plans 2019-04-04 10:22:26.1: No pending plans that can be started now. 2019-04-04 10:22:26.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:22:56.6: SelectRunning: No running plans 2019-04-04 10:22:56.6: No pending plans that can be started now. 2019-04-04 10:22:56.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:23:26.8: SelectRunning: No running plans 2019-04-04 10:23:26.8: No pending plans that can be started now. 2019-04-04 10:23:26.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:23:59.8: SelectRunning: No running plans 2019-04-04 10:23:59.8: No pending plans that can be started now. 2019-04-04 10:23:59.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:24:33.1: SelectRunning: No running plans 2019-04-04 10:24:33.1: No pending plans that can be started now. 2019-04-04 10:24:33.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:25:04.6: SelectRunning: No running plans 2019-04-04 10:25:04.6: No pending plans that can be started now. 2019-04-04 10:25:04.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:25:36.1: SelectRunning: No running plans 2019-04-04 10:25:36.1: No pending plans that can be started now. 2019-04-04 10:25:36.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:26:06.6: SelectRunning: No running plans 2019-04-04 10:26:06.6: No pending plans that can be started now. 2019-04-04 10:26:06.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:26:36.7: SelectRunning: No running plans 2019-04-04 10:26:36.7: No pending plans that can be started now. 2019-04-04 10:26:36.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:27:07.3: SelectRunning: No running plans 2019-04-04 10:27:07.3: No pending plans that can be started now. 2019-04-04 10:27:07.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:27:37.4: SelectRunning: No running plans 2019-04-04 10:27:37.4: No pending plans that can be started now. 2019-04-04 10:27:37.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:28:07.7: SelectRunning: No running plans 2019-04-04 10:28:07.7: No pending plans that can be started now. 2019-04-04 10:28:07.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:28:39.8: SelectRunning: No running plans 2019-04-04 10:28:39.8: No pending plans that can be started now. 2019-04-04 10:28:39.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:29:09.9: SelectRunning: No running plans 2019-04-04 10:29:09.9: No pending plans that can be started now. 2019-04-04 10:29:09.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:29:41.4: SelectRunning: No running plans 2019-04-04 10:29:41.4: No pending plans that can be started now. 2019-04-04 10:29:41.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:30:13.0: SelectRunning: No running plans 2019-04-04 10:30:13.0: No pending plans that can be started now. 2019-04-04 10:30:13.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:30:43.4: SelectRunning: No running plans 2019-04-04 10:30:43.4: No pending plans that can be started now. 2019-04-04 10:30:43.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:31:14.6: SelectRunning: No running plans 2019-04-04 10:31:14.6: No pending plans that can be started now. 2019-04-04 10:31:14.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:31:44.7: SelectRunning: No running plans 2019-04-04 10:31:44.7: No pending plans that can be started now. 2019-04-04 10:31:44.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:32:14.8: SelectRunning: No running plans 2019-04-04 10:32:14.8: No pending plans that can be started now. 2019-04-04 10:32:14.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:32:45.9: SelectRunning: No running plans 2019-04-04 10:32:45.9: No pending plans that can be started now. 2019-04-04 10:32:45.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:33:16.1: SelectRunning: No running plans 2019-04-04 10:33:16.1: No pending plans that can be started now. 2019-04-04 10:33:16.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:33:46.2: SelectRunning: No running plans 2019-04-04 10:33:46.2: No pending plans that can be started now. 2019-04-04 10:33:46.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:34:16.4: SelectRunning: No running plans 2019-04-04 10:34:16.4: No pending plans that can be started now. 2019-04-04 10:34:16.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:34:46.5: SelectRunning: No running plans 2019-04-04 10:34:46.5: No pending plans that can be started now. 2019-04-04 10:34:46.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:35:16.6: SelectRunning: No running plans 2019-04-04 10:35:16.6: No pending plans that can be started now. 2019-04-04 10:35:16.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:35:47.4: SelectRunning: No running plans 2019-04-04 10:35:47.4: No pending plans that can be started now. 2019-04-04 10:35:47.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:36:17.7: SelectRunning: No running plans 2019-04-04 10:36:17.7: No pending plans that can be started now. 2019-04-04 10:36:17.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:36:48.0: SelectRunning: No running plans 2019-04-04 10:36:48.0: No pending plans that can be started now. 2019-04-04 10:36:48.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:37:18.2: SelectRunning: No running plans 2019-04-04 10:37:18.2: No pending plans that can be started now. 2019-04-04 10:37:18.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:37:48.9: SelectRunning: No running plans 2019-04-04 10:37:48.9: No pending plans that can be started now. 2019-04-04 10:37:48.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:38:21.5: SelectRunning: No running plans 2019-04-04 10:38:21.5: No pending plans that can be started now. 2019-04-04 10:38:21.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:38:51.7: SelectRunning: No running plans 2019-04-04 10:38:51.7: No pending plans that can be started now. 2019-04-04 10:38:51.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:39:22.3: SelectRunning: No running plans 2019-04-04 10:39:22.3: No pending plans that can be started now. 2019-04-04 10:39:22.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:39:52.4: SelectRunning: No running plans 2019-04-04 10:39:52.4: No pending plans that can be started now. 2019-04-04 10:39:52.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:40:22.5: SelectRunning: No running plans 2019-04-04 10:40:22.5: No pending plans that can be started now. 2019-04-04 10:40:22.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:40:52.6: SelectRunning: No running plans 2019-04-04 10:40:52.6: No pending plans that can be started now. 2019-04-04 10:40:52.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:41:22.9: SelectRunning: No running plans 2019-04-04 10:41:22.9: No pending plans that can be started now. 2019-04-04 10:41:22.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:41:56.2: SelectRunning: No running plans 2019-04-04 10:41:56.2: No pending plans that can be started now. 2019-04-04 10:41:56.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:42:27.8: SelectRunning: No running plans 2019-04-04 10:42:27.8: No pending plans that can be started now. 2019-04-04 10:42:27.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:42:58.2: SelectRunning: No running plans 2019-04-04 10:42:58.2: No pending plans that can be started now. 2019-04-04 10:42:58.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:43:30.1: SelectRunning: No running plans 2019-04-04 10:43:30.1: No pending plans that can be started now. 2019-04-04 10:43:30.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:44:05.5: SelectRunning: No running plans 2019-04-04 10:44:05.5: No pending plans that can be started now. 2019-04-04 10:44:05.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:44:38.9: SelectRunning: No running plans 2019-04-04 10:44:38.9: No pending plans that can be started now. 2019-04-04 10:44:38.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:45:10.4: SelectRunning: No running plans 2019-04-04 10:45:10.4: No pending plans that can be started now. 2019-04-04 10:45:10.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:45:42.0: SelectRunning: No running plans 2019-04-04 10:45:42.0: No pending plans that can be started now. 2019-04-04 10:45:42.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:46:14.6: SelectRunning: No running plans 2019-04-04 10:46:14.6: No pending plans that can be started now. 2019-04-04 10:46:14.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:46:46.9: SelectRunning: No running plans 2019-04-04 10:46:46.9: No pending plans that can be started now. 2019-04-04 10:46:46.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:47:18.3: SelectRunning: No running plans 2019-04-04 10:47:18.3: No pending plans that can be started now. 2019-04-04 10:47:18.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:47:49.9: SelectRunning: No running plans 2019-04-04 10:47:49.9: No pending plans that can be started now. 2019-04-04 10:47:49.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:48:21.2: SelectRunning: No running plans 2019-04-04 10:48:21.2: No pending plans that can be started now. 2019-04-04 10:48:21.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:48:51.5: SelectRunning: No running plans 2019-04-04 10:48:51.5: No pending plans that can be started now. 2019-04-04 10:48:51.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:49:22.2: SelectRunning: No running plans 2019-04-04 10:49:22.2: No pending plans that can be started now. 2019-04-04 10:49:22.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:49:52.3: SelectRunning: No running plans 2019-04-04 10:49:52.3: No pending plans that can be started now. 2019-04-04 10:49:52.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:50:22.4: SelectRunning: No running plans 2019-04-04 10:50:22.4: No pending plans that can be started now. 2019-04-04 10:50:22.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:50:53.0: SelectRunning: No running plans 2019-04-04 10:50:53.0: No pending plans that can be started now. 2019-04-04 10:50:53.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:51:23.5: SelectRunning: No running plans 2019-04-04 10:51:23.5: No pending plans that can be started now. 2019-04-04 10:51:23.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:51:54.2: SelectRunning: No running plans 2019-04-04 10:51:54.2: No pending plans that can be started now. 2019-04-04 10:51:54.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:52:24.3: SelectRunning: No running plans 2019-04-04 10:52:24.3: No pending plans that can be started now. 2019-04-04 10:52:24.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:52:56.5: SelectRunning: No running plans 2019-04-04 10:52:56.5: No pending plans that can be started now. 2019-04-04 10:52:56.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:53:28.2: SelectRunning: No running plans 2019-04-04 10:53:28.2: No pending plans that can be started now. 2019-04-04 10:53:28.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:53:58.3: SelectRunning: No running plans 2019-04-04 10:53:58.3: No pending plans that can be started now. 2019-04-04 10:53:58.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:54:28.4: SelectRunning: No running plans 2019-04-04 10:54:28.5: No pending plans that can be started now. 2019-04-04 10:54:28.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:55:01.0: SelectRunning: No running plans 2019-04-04 10:55:01.0: No pending plans that can be started now. 2019-04-04 10:55:01.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:55:33.4: SelectRunning: No running plans 2019-04-04 10:55:33.4: No pending plans that can be started now. 2019-04-04 10:55:33.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:56:04.8: SelectRunning: No running plans 2019-04-04 10:56:04.8: No pending plans that can be started now. 2019-04-04 10:56:04.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:56:36.5: SelectRunning: No running plans 2019-04-04 10:56:36.5: No pending plans that can be started now. 2019-04-04 10:56:36.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:57:07.0: SelectRunning: No running plans 2019-04-04 10:57:07.0: No pending plans that can be started now. 2019-04-04 10:57:07.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:57:37.2: SelectRunning: No running plans 2019-04-04 10:57:37.2: No pending plans that can be started now. 2019-04-04 10:57:37.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:58:07.6: SelectRunning: No running plans 2019-04-04 10:58:07.6: No pending plans that can be started now. 2019-04-04 10:58:07.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:58:38.1: SelectRunning: No running plans 2019-04-04 10:58:38.1: No pending plans that can be started now. 2019-04-04 10:58:38.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:59:08.4: SelectRunning: No running plans 2019-04-04 10:59:08.4: No pending plans that can be started now. 2019-04-04 10:59:08.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 10:59:38.5: SelectRunning: No running plans 2019-04-04 10:59:38.5: No pending plans that can be started now. 2019-04-04 10:59:38.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:00:09.2: SelectRunning: No running plans 2019-04-04 11:00:09.2: No pending plans that can be started now. 2019-04-04 11:00:09.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:00:39.3: SelectRunning: No running plans 2019-04-04 11:00:39.3: No pending plans that can be started now. 2019-04-04 11:00:39.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:01:10.9: SelectRunning: No running plans 2019-04-04 11:01:10.9: No pending plans that can be started now. 2019-04-04 11:01:10.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:01:41.4: SelectRunning: No running plans 2019-04-04 11:01:41.4: No pending plans that can be started now. 2019-04-04 11:01:41.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:02:11.5: SelectRunning: No running plans 2019-04-04 11:02:11.5: No pending plans that can be started now. 2019-04-04 11:02:11.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:02:41.9: SelectRunning: No running plans 2019-04-04 11:02:41.9: No pending plans that can be started now. 2019-04-04 11:02:41.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:03:13.5: SelectRunning: No running plans 2019-04-04 11:03:13.5: No pending plans that can be started now. 2019-04-04 11:03:13.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:03:43.6: SelectRunning: No running plans 2019-04-04 11:03:43.6: No pending plans that can be started now. 2019-04-04 11:03:43.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:04:15.6: SelectRunning: No running plans 2019-04-04 11:04:15.6: No pending plans that can be started now. 2019-04-04 11:04:15.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:04:47.1: SelectRunning: No running plans 2019-04-04 11:04:47.1: No pending plans that can be started now. 2019-04-04 11:04:47.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:05:17.4: SelectRunning: No running plans 2019-04-04 11:05:17.4: No pending plans that can be started now. 2019-04-04 11:05:17.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:05:47.9: SelectRunning: No running plans 2019-04-04 11:05:47.9: No pending plans that can be started now. 2019-04-04 11:05:47.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:06:19.4: SelectRunning: No running plans 2019-04-04 11:06:19.4: No pending plans that can be started now. 2019-04-04 11:06:19.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:06:50.8: SelectRunning: No running plans 2019-04-04 11:06:50.8: No pending plans that can be started now. 2019-04-04 11:06:50.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:07:22.2: SelectRunning: No running plans 2019-04-04 11:07:22.2: No pending plans that can be started now. 2019-04-04 11:07:22.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:07:53.5: SelectRunning: No running plans 2019-04-04 11:07:53.5: No pending plans that can be started now. 2019-04-04 11:07:53.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:08:26.5: SelectRunning: No running plans 2019-04-04 11:08:26.5: No pending plans that can be started now. 2019-04-04 11:08:26.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:08:56.8: SelectRunning: No running plans 2019-04-04 11:08:56.8: No pending plans that can be started now. 2019-04-04 11:08:56.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:09:26.9: SelectRunning: No running plans 2019-04-04 11:09:26.9: No pending plans that can be started now. 2019-04-04 11:09:26.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:09:57.0: SelectRunning: No running plans 2019-04-04 11:09:57.0: No pending plans that can be started now. 2019-04-04 11:09:57.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:10:27.3: SelectRunning: No running plans 2019-04-04 11:10:27.3: No pending plans that can be started now. 2019-04-04 11:10:27.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:10:59.2: SelectRunning: No running plans 2019-04-04 11:10:59.2: No pending plans that can be started now. 2019-04-04 11:10:59.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:11:29.3: SelectRunning: No running plans 2019-04-04 11:11:29.3: No pending plans that can be started now. 2019-04-04 11:11:29.3: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:11:59.4: SelectRunning: No running plans 2019-04-04 11:11:59.4: No pending plans that can be started now. 2019-04-04 11:11:59.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:12:29.5: SelectRunning: No running plans 2019-04-04 11:12:29.5: No pending plans that can be started now. 2019-04-04 11:12:29.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:12:59.6: SelectRunning: No running plans 2019-04-04 11:12:59.6: No pending plans that can be started now. 2019-04-04 11:12:59.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:13:29.7: SelectRunning: No running plans 2019-04-04 11:13:29.7: No pending plans that can be started now. 2019-04-04 11:13:29.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:14:00.0: SelectRunning: No running plans 2019-04-04 11:14:00.0: No pending plans that can be started now. 2019-04-04 11:14:00.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:14:30.2: SelectRunning: No running plans 2019-04-04 11:14:30.2: No pending plans that can be started now. 2019-04-04 11:14:30.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:15:01.5: SelectRunning: No running plans 2019-04-04 11:15:01.5: No pending plans that can be started now. 2019-04-04 11:15:01.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:15:31.6: SelectRunning: No running plans 2019-04-04 11:15:31.6: No pending plans that can be started now. 2019-04-04 11:15:31.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:16:01.7: SelectRunning: No running plans 2019-04-04 11:16:01.7: No pending plans that can be started now. 2019-04-04 11:16:01.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:16:31.8: SelectRunning: No running plans 2019-04-04 11:16:31.8: No pending plans that can be started now. 2019-04-04 11:16:31.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:17:03.1: SelectRunning: No running plans 2019-04-04 11:17:03.1: No pending plans that can be started now. 2019-04-04 11:17:03.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:17:33.2: ++ Auto Focus ++ 2019-04-04 11:17:33.2: Doing periodic autofocus. 2019-04-04 11:17:33.2: Start special ACP AutoFocus script for scheduler 2019-04-04 11:17:33.2: ACP.RunScript(AutoFocusScheduler, ): 2019-04-04 11:17:33.2: Script AcquireScheduler is loaded, and 2019-04-04 11:17:33.2: the console is idle. 2019-04-04 11:17:33.2: In start loop, i = 0 2019-04-04 11:17:33.2: Console is now idle 2019-04-04 11:17:33.2: Loaded C:\Program Files\ACP Scheduler\AutoFocusScheduler.vbs successfully 2019-04-04 11:17:33.2: Script started successfully 2019-04-04 11:17:43.2: Sequencer is now active 2019-04-04 11:20:49.6: Sequencer is no longer active 2019-04-04 11:20:49.6: Next periodic autofocus ASAP after 04-Apr-2019 14:20:37 UTC 2019-04-04 11:20:49.7: SelectRunning: No running plans 2019-04-04 11:20:49.7: No pending plans that can be started now. 2019-04-04 11:20:49.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:21:20.1: SelectRunning: No running plans 2019-04-04 11:21:20.1: No pending plans that can be started now. 2019-04-04 11:21:20.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:21:50.2: SelectRunning: No running plans 2019-04-04 11:21:50.2: No pending plans that can be started now. 2019-04-04 11:21:50.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:22:20.4: SelectRunning: No running plans 2019-04-04 11:22:20.4: No pending plans that can be started now. 2019-04-04 11:22:20.4: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:22:53.2: SelectRunning: No running plans 2019-04-04 11:22:53.2: No pending plans that can be started now. 2019-04-04 11:22:53.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:23:24.8: SelectRunning: No running plans 2019-04-04 11:23:24.8: No pending plans that can be started now. 2019-04-04 11:23:24.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:23:54.9: SelectRunning: No running plans 2019-04-04 11:23:54.9: No pending plans that can be started now. 2019-04-04 11:23:54.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:24:25.0: SelectRunning: No running plans 2019-04-04 11:24:25.0: No pending plans that can be started now. 2019-04-04 11:24:25.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:24:55.9: SelectRunning: No running plans 2019-04-04 11:24:55.9: No pending plans that can be started now. 2019-04-04 11:24:55.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:25:28.5: SelectRunning: No running plans 2019-04-04 11:25:28.5: No pending plans that can be started now. 2019-04-04 11:25:28.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:25:58.6: SelectRunning: No running plans 2019-04-04 11:25:58.6: No pending plans that can be started now. 2019-04-04 11:25:58.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:26:28.7: SelectRunning: No running plans 2019-04-04 11:26:28.7: No pending plans that can be started now. 2019-04-04 11:26:28.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:26:58.8: SelectRunning: No running plans 2019-04-04 11:26:58.8: No pending plans that can be started now. 2019-04-04 11:26:58.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:27:28.9: SelectRunning: No running plans 2019-04-04 11:27:29.0: Rising plan delay enabled for Plan Jup: 2019-04-04 11:27:29.0: TimeSpan: 1673 sec. 2019-04-04 11:27:29.0: Lead: 167 sec. 2019-04-04 11:27:29.0: Centroid: RA=17:34:04 DE=-22°40'08" 2019-04-04 11:27:29.0: Mid-Plan LST: 17:24:24 2019-04-04 11:27:29.0: Mid-Plan HA: -00:09:40 2019-04-04 11:27:29.0: 168 min. remaining to meet strict constraints. 2019-04-04 11:27:29.0: 2 min. remaining for the plan to fit before dawn. 2019-04-04 11:27:29.0: 16696112 min. remaining for the plan to fit before "must run before" time. 2019-04-04 11:27:29.0: ending rising plan delay. Plan is now eligible. 2019-04-04 11:27:29.0: EPH (Jupiter): type=Major Planet time=11:27:28 ra=17.5680736 dec=-22.669072 2019-04-04 11:27:29.0: Rising plan delay enabled for Plan Jupiter: 2019-04-04 11:27:29.0: TimeSpan: 1673 sec. 2019-04-04 11:27:29.0: Lead: 167 sec. 2019-04-04 11:27:29.0: Centroid: RA=17:34:05 DE=-22°40'09" 2019-04-04 11:27:29.0: Mid-Plan LST: 17:24:24 2019-04-04 11:27:29.0: Mid-Plan HA: -00:09:41 2019-04-04 11:27:29.0: 168 min. remaining to meet strict constraints. 2019-04-04 11:27:29.0: 2 min. remaining for the plan to fit before dawn. 2019-04-04 11:27:29.0: ending rising plan delay. Plan is now eligible. 2019-04-04 11:27:29.0: Efficiency: Selecting from 2 pending plans: 2019-04-04 11:27:29.0: Selected Plan Jup (TotEff=1.68) 2019-04-04 11:27:29.0: Dispatcher cycle time: 0.1 sec. 2019-04-04 11:27:29.0: Acquire data for Observation Jup... 2019-04-04 11:27:29.0: (belongs to Project ASTR402_Spring2019, Plan Jup) 2019-04-04 11:27:29.0: Doing 5 sets 2019-04-04 11:27:29.1: Send Observation Jup to ACP Sequencer 2019-04-04 11:27:29.1: ACP.RunScript(AcquireScheduler, ): 2019-04-04 11:27:29.1: Script AutoFocusScheduler is loaded, and 2019-04-04 11:27:29.1: the console is idle. 2019-04-04 11:27:29.1: In start loop, i = 0 2019-04-04 11:27:29.1: Console is now idle 2019-04-04 11:27:29.1: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 11:27:29.1: Script started successfully 2019-04-04 11:27:39.1: Sequencer is now active 2019-04-04 11:33:31.9: Sequencer is no longer active 2019-04-04 11:33:31.9: Post-job status check done (stat=Completed) 2019-04-04 11:33:31.9: Send Observation Jup to ACP Sequencer 2019-04-04 11:33:31.9: ACP.RunScript(AcquireScheduler, ): 2019-04-04 11:33:31.9: Script AcquireScheduler is loaded, and 2019-04-04 11:33:31.9: the console is idle. 2019-04-04 11:33:31.9: In start loop, i = 0 2019-04-04 11:33:31.9: Console is now idle 2019-04-04 11:33:32.3: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 11:33:32.3: Script started successfully 2019-04-04 11:33:42.3: Sequencer is now active 2019-04-04 11:37:18.5: Sequencer is no longer active 2019-04-04 11:37:18.5: Post-job status check done (stat=Completed) 2019-04-04 11:37:18.5: Send Observation Jup to ACP Sequencer 2019-04-04 11:37:18.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 11:37:18.5: Script AcquireScheduler is loaded, and 2019-04-04 11:37:18.5: the console is idle. 2019-04-04 11:37:18.5: In start loop, i = 0 2019-04-04 11:37:18.5: Console is now idle 2019-04-04 11:37:18.8: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 11:37:18.8: Script started successfully 2019-04-04 11:37:28.8: Sequencer is now active 2019-04-04 11:41:05.3: Sequencer is no longer active 2019-04-04 11:41:05.3: Post-job status check done (stat=Completed) 2019-04-04 11:41:05.4: Send Observation Jup to ACP Sequencer 2019-04-04 11:41:05.4: ACP.RunScript(AcquireScheduler, ): 2019-04-04 11:41:05.4: Script AcquireScheduler is loaded, and 2019-04-04 11:41:05.4: the console is idle. 2019-04-04 11:41:05.4: In start loop, i = 0 2019-04-04 11:41:05.4: Console is now idle 2019-04-04 11:41:05.7: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 11:41:05.7: Script started successfully 2019-04-04 11:41:15.7: Sequencer is now active 2019-04-04 11:45:01.8: Sequencer is no longer active 2019-04-04 11:45:01.8: Post-job status check done (stat=Completed) 2019-04-04 11:45:01.8: Send Observation Jup to ACP Sequencer 2019-04-04 11:45:01.8: ACP.RunScript(AcquireScheduler, ): 2019-04-04 11:45:01.8: Script AcquireScheduler is loaded, and 2019-04-04 11:45:01.8: the console is idle. 2019-04-04 11:45:01.8: In start loop, i = 0 2019-04-04 11:45:01.8: Console is now idle 2019-04-04 11:45:02.1: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 11:45:02.1: Script started successfully 2019-04-04 11:45:12.1: Sequencer is now active 2019-04-04 11:49:03.9: Sequencer is no longer active 2019-04-04 11:49:03.9: Post-job status check done (stat=Completed) 2019-04-04 11:49:03.9: Acquisition time: 1294.8318128 sec. 2019-04-04 11:49:03.9: Data for Observation Jup of Plan Jup acquired successfully. 2019-04-04 11:49:03.9: Plan Jup completed successfully. 2019-04-04 11:49:03.9: Image Efficiency: 1.2% 2019-04-04 11:49:03.9: Cycle Efficiency: 100.0% 2019-04-04 11:49:06.3: SelectRunning: No running plans 2019-04-04 11:49:06.3: EPH (Jupiter): type=Major Planet time=11:49:06 ra=17.5680946 dec=-22.669082 2019-04-04 11:49:06.4: Efficiency: Only one pending plan Jupiter, it is the "best" 2019-04-04 11:49:06.4: Dispatcher cycle time: 0.1 sec. 2019-04-04 11:49:06.4: Acquire data for Observation Jupiter... 2019-04-04 11:49:06.4: (belongs to Project ASTR402_Spring2019, Plan Jupiter) 2019-04-04 11:49:06.4: Doing 5 sets 2019-04-04 11:49:06.5: Send Observation Jupiter to ACP Sequencer 2019-04-04 11:49:06.5: ACP.RunScript(AcquireScheduler, ): 2019-04-04 11:49:06.5: Script AcquireScheduler is loaded, and 2019-04-04 11:49:06.5: the console is idle. 2019-04-04 11:49:06.5: In start loop, i = 0 2019-04-04 11:49:06.5: Console is now idle 2019-04-04 11:49:06.5: Loaded C:\Program Files\ACP Scheduler\AcquireScheduler.vbs successfully 2019-04-04 11:49:06.5: Script started successfully 2019-04-04 11:49:16.5: Sequencer is now active 2019-04-04 11:53:10.5: Sequencer is no longer active 2019-04-04 11:53:10.5: Post-job status check done (stat=Completed) 2019-04-04 11:53:10.5: ***Running Plan Jupiter (best efforts) completed early: 2019-04-04 11:53:10.5: Obs Jupiter would extend past dawn 2019-04-04 11:53:10.5: Acquisition time: 244.0003416 sec. 2019-04-04 11:53:10.5: Data for Observation Jupiter of Plan Jupiter acquired successfully. 2019-04-04 11:53:10.5: Plan Jupiter completed successfully. 2019-04-04 11:53:10.5: Image Efficiency: 1.2% 2019-04-04 11:53:10.5: Cycle Efficiency: 99.9% 2019-04-04 11:53:13.6: SelectRunning: No running plans 2019-04-04 11:53:13.6: No pending plans that can be started now. 2019-04-04 11:53:13.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:53:45.5: SelectRunning: No running plans 2019-04-04 11:53:45.5: No pending plans that can be started now. 2019-04-04 11:53:45.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:54:15.6: SelectRunning: No running plans 2019-04-04 11:54:15.6: No pending plans that can be started now. 2019-04-04 11:54:15.6: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:54:45.8: SelectRunning: No running plans 2019-04-04 11:54:45.8: No pending plans that can be started now. 2019-04-04 11:54:45.8: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:55:15.9: SelectRunning: No running plans 2019-04-04 11:55:15.9: No pending plans that can be started now. 2019-04-04 11:55:15.9: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:55:46.0: SelectRunning: No running plans 2019-04-04 11:55:46.0: No pending plans that can be started now. 2019-04-04 11:55:46.0: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:56:16.1: SelectRunning: No running plans 2019-04-04 11:56:16.1: No pending plans that can be started now. 2019-04-04 11:56:16.1: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:56:46.5: SelectRunning: No running plans 2019-04-04 11:56:46.5: No pending plans that can be started now. 2019-04-04 11:56:46.5: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:57:16.7: SelectRunning: No running plans 2019-04-04 11:57:16.7: No pending plans that can be started now. 2019-04-04 11:57:16.7: Dispatcher cycle time: 0.0 sec. 2019-04-04 11:57:48.2: SelectRunning: No running plans 2019-04-04 11:57:48.2: No pending plans that can be started now. 2019-04-04 11:57:48.2: Dispatcher cycle time: 0.0 sec. 2019-04-04 12:12:32.3: ++ Dawn Flats ++ 2019-04-04 12:12:32.3: Start ACP AutoFlat script for Dawn flats 2019-04-04 12:12:32.3: ACP.RunScript(AutoFlat, C:\Users\user\Documents\ACP Astronomy\Plans\SchedulerDawnFlats.txt): 2019-04-04 12:12:32.3: Script AcquireScheduler is loaded, and 2019-04-04 12:12:32.3: the console is idle. 2019-04-04 12:12:32.3: In start loop, i = 0 2019-04-04 12:12:32.3: Console is now idle 2019-04-04 12:12:32.3: Loaded C:\Program Files\ACP Obs Control\Scripts\AutoFlat.vbs successfully 2019-04-04 12:12:32.3: Set parameter "C:\Users\user\Documents\ACP Astronomy\Plans\SchedulerDawnFlats.txt" successfully 2019-04-04 12:12:32.3: Script started successfully 2019-04-04 12:12:42.3: Sequencer is now active 2019-04-04 12:41:58.0: Sequencer is no longer active 2019-04-04 12:41:58.0: ** ACP script "AutoFlat" failed: 2019-04-04 12:41:58.0: **Script Error** Source: ACP Message: The script was aborted. Location: line 1548 column 25. 2019-04-04 12:41:58.9: -- Weather Unsafe -- 2019-04-04 12:42:31.7: -- Observatory Shutdown -- 2019-04-04 12:42:31.7: Start ACP Sequencer's ShutdownObs script 2019-04-04 12:42:31.7: ACP.RunScript(ShutdownObs, ): 2019-04-04 12:42:31.7: Script ACP-Weather is loaded, and 2019-04-04 12:42:31.7: the console is RUNNING. 2019-04-04 12:42:31.7: In start loop, i = 0 2019-04-04 12:42:31.7: Console is busy, and foundIdle is False 2019-04-04 12:42:31.7: WARNING: Request sent while Weather Safety Script is running 2019-04-04 12:43:31.7: In start loop, i = 1 2019-04-04 12:43:31.7: Console is now idle 2019-04-04 12:43:32.1: Loaded C:\Users\Public\Documents\ACP Config\Scheduler\ShutdownObs.js successfully 2019-04-04 12:43:32.1: Script started successfully 2019-04-04 12:43:42.1: Sequencer is now active 2019-04-04 12:45:48.9: Sequencer is no longer active 2019-04-04 19:11:44.9: Run statistics: 2019-04-04 19:11:44.9: Observations: 63 2019-04-04 19:11:44.9: Considered: 11 2019-04-04 19:11:44.9: Completed: 6 2019-04-04 19:11:44.9: Skipped: 0 2019-04-04 19:11:44.9: Never Eligible: 52 2019-04-04 19:11:44.9: Failed: 5 Log closed at Thu, Apr 04 2019 19:11:44 UTC (actual time)