[11/22/17 22:20:19.033][DEBUG] [Sequence Thread] Telescope: Slewing to J2000 RA: 4.0507 (04h03m02.52s) Dec: 36.27765 (36°16'39.54") [11/22/17 22:20:19.034][DEBUG] [Sequence Thread] Telescope: Slew received J2000 coordinates, mount requires JNOW, converting... [11/22/17 22:20:19.034][DEBUG] [Sequence Thread] Telescope: Slewing to JNOW RA: 4.07048855747623 Dec: 36.3246516860197 [11/22/17 22:20:28.107][DEBUG] [Sequence Thread] Scope reports it is done with synchronous slew, verifying... [11/22/17 22:20:28.108][DEBUG] [Sequence Thread] Telescope: Slewing has completed [11/22/17 22:20:28.108][DEBUG] [Sequence Thread] DoEventGroupChange: Slew complete [11/22/17 22:20:28.108][DEBUG] [Sequence Thread] DoEventGroupChange: Centering on target [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Center telescope message received... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Solving with Plate Solver PlateSolve2... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Setting filter for auto center... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Setting filter position 4... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Filter position 4 is already set. Skipping... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Performing auto center step 1... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Skipping step 1... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Auto center reference frame solved successfully... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Performing auto center step 3 (scope)... [11/22/17 22:20:28.333][DEBUG] [Telescope Thread] Auto center slewing scope to match reference... [11/22/17 22:20:28.334][DEBUG] [Telescope Thread] Telescope: Slewing to J2000 RA: 4.0507 (04h03m02.52s) Dec: 36.27765 (36°16'39.54") [11/22/17 22:20:28.334][DEBUG] [Telescope Thread] Telescope: Slew received J2000 coordinates, mount requires JNOW, converting... [11/22/17 22:20:28.334][DEBUG] [Telescope Thread] Telescope: Slewing to JNOW RA: 4.07048855797652 Dec: 36.3246516903379 [11/22/17 22:20:37.406][DEBUG] [Telescope Thread] Scope reports it is done with synchronous slew, verifying... [11/22/17 22:20:37.407][DEBUG] [Telescope Thread] Telescope: Slewing has completed [11/22/17 22:20:37.407][DEBUG] [Telescope Thread] Auto center slew complete... [11/22/17 22:20:37.407][DEBUG] [Telescope Thread] Performing auto center step 4... [11/22/17 22:20:37.407][DEBUG] [Telescope Thread] Created full file name (file does not exist): C:\Users\guill\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/22/17 22:20:37.411][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE message received... [11/22/17 22:20:37.411][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [11/22/17 22:20:37.411][DEBUG] [Camera Thread] Collecting FITs headers for plate solve frame... [11/22/17 22:20:37.543][DEBUG] [Camera Thread] SetAscomHighSpeed... [11/22/17 22:20:37.543][DEBUG] [Camera Thread] Cannot set readout speed, not supported by camera... [11/22/17 22:20:41.163][DEBUG] [Camera Thread] Created full file name (file does not exist): C:\Users\guill\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/22/17 22:20:41.163][DEBUG] [Camera Thread] SaveFileAscom: Start... [11/22/17 22:20:41.163][DEBUG] [Camera Thread] SaveFileAscom: Checking image data... [11/22/17 22:20:41.163][DEBUG] [Camera Thread] SaveFileAscom: Create normal preview bitmap... [11/22/17 22:20:41.168][DEBUG] [Camera Thread] SaveFileAscom: Locking preview bits... [11/22/17 22:20:41.168][DEBUG] [Camera Thread] SaveFileAscom: Validating file name... [11/22/17 22:20:41.168][DEBUG] [Camera Thread] SaveFileAscom: Starting byte traversal... [11/22/17 22:20:41.303][DEBUG] [Camera Thread] SaveFileAscom: Unlocking preview bits... [11/22/17 22:20:41.303][DEBUG] [Camera Thread] SaveFileAscom: Saving preview bitmap to disk... [11/22/17 22:20:41.303][DEBUG] [Camera Thread] SaveFileBmp16: Locking bitmap for disk write... [11/22/17 22:20:41.303][DEBUG] [Camera Thread] SaveFileBmp16: Opening file stream... [11/22/17 22:20:41.303][DEBUG] [Camera Thread] SaveFileBmp16: Writing FITS headers... [11/22/17 22:20:41.304][DEBUG] [Camera Thread] SaveFileBmp16: Traversing and persisting bitmap data... [11/22/17 22:20:41.458][DEBUG] [Camera Thread] SaveFileBmp16: FITS block fill... [11/22/17 22:20:41.458][DEBUG] [Camera Thread] SaveFileBmp16: Unlocking bitmap... [11/22/17 22:20:41.458][DEBUG] [Camera Thread] SaveFileBmp16: Closing file stream [11/22/17 22:20:41.462][DEBUG] [Camera Thread] Internal Interface: Set Preview... [11/22/17 22:20:41.462][DEBUG] [Camera Thread] Display image preview using asynch task... [11/22/17 22:20:42.221][DEBUG] [Camera Thread] SaveFileAscom: Done [11/22/17 22:20:42.221][DEBUG] [Camera Thread] =========== Save file took 1059 ms [11/22/17 22:20:42.221][DEBUG] [Camera Thread] SGM_CAMERA_PLATE_SOLVER_CAPTURE complete... [11/22/17 22:20:42.264][DEBUG] [Telescope Thread] Auto center verification frame complete. Plate solving image C:\Users\guill\AppData\Local\SequenceGenerator\Temp\plate_solve_image.fit [11/22/17 22:20:42.398][DEBUG] [Telescope Thread] ************* SOLVE HINTS **************** [11/22/17 22:20:42.398][DEBUG] [Telescope Thread] SOLVER: PlateSolve2 [11/22/17 22:20:42.398][DEBUG] [Telescope Thread] BLIND: False [11/22/17 22:20:42.398][DEBUG] [Telescope Thread] METHOD: Max Regions [11/22/17 22:20:42.398][DEBUG] [Telescope Thread] RA: 4.04954946157049 [11/22/17 22:20:42.398][DEBUG] [Telescope Thread] DEC: 36.2867109833374 [11/22/17 22:20:42.398][DEBUG] [Telescope Thread] SCALE: 6.03682930436552 [11/22/17 22:20:42.398][DEBUG] [Telescope Thread] ****************************************** [11/22/17 22:20:42.438][DEBUG] [Telescope Thread] FitsFileHeaderData: Angle - 0 [11/22/17 22:20:42.438][DEBUG] [Telescope Thread] FitsFileHeaderData: Scale - 0 [11/22/17 22:20:42.438][DEBUG] [Telescope Thread] FitsFileHeaderData: RA - 4.04955232114493 [11/22/17 22:20:42.438][DEBUG] [Telescope Thread] FitsFileHeaderData: DEC - 36.2867110531003 [11/22/17 22:20:42.442][DEBUG] [Telescope Thread] PlateSove2 Param: RA (RAD) - 1.06016956990153 [11/22/17 22:20:42.442][DEBUG] [Telescope Thread] PlateSove2 Param: DEC (RAD) - 0.633322581378827 [11/22/17 22:20:42.442][DEBUG] [Telescope Thread] PlateSove2 Param: Width - 4656 [11/22/17 22:20:42.442][DEBUG] [Telescope Thread] PlateSove2 Param: Height - 3520 [11/22/17 22:20:42.442][DEBUG] [Telescope Thread] PlateSolve2 Command Line: [11/22/17 22:20:42.442][DEBUG] [Telescope Thread] C:\Users\guill\AppData\Local\SequenceGenerator\\PlateSolve2.exe 1.06016956990153,0.63332258137883,0.13626889507973,0.10302115779223,3000,C:\Users\guill\AppData\Local\SequenceGenerator\\Temp\psXSolve_1.fit [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] *********** SUCCESSFUL SOLVE ************* [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] SOLVER: False [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] SUCCESS: False [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] CONF: 0 [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] BLIND: False [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] RA: 0 [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] DEC: 0 [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] SCALE: 0 [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] FLIPPED: False [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] ANGLE (EON): -500 [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] MSG: Invalid solve! [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] ****************************************** [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] Auto center validation frame failed to solve. Invalid solve! [11/22/17 22:20:49.951][DEBUG] [Telescope Thread] Adding sequence level notification: Auto center validation frame failed to solve. Invalid solve! [11/22/17 22:20:49.954][DEBUG] [Telescope Thread] Auto center validation frame solve failed, invoking blind failover... [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] Astrometry.NET: Sequence endpoint data: Astrometry.NET (Remote) [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] Astrometry.NET: Sequence endpoint data: Astrometry.NET (Remote) [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] ************* SOLVE HINTS **************** [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] SOLVER: Astrometry.NET [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] BLIND: True [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] METHOD: Max Regions [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] RA: 4.04954946157049 [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] DEC: 36.2867109833374 [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] SCALE: 6.03682930436552 [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] ****************************************** [11/22/17 22:20:49.955][DEBUG] [Telescope Thread] Astrometry.NET: Sequence endpoint data: ANSVR (Local Astrometry.NET) [11/22/17 22:20:50.353][DEBUG] [Telescope Thread] Astrometry.NET convertedAstrometry.fits path: C:\Users\guill\AppData\Local\SequenceGenerator\Temp\convertedAstometry.fits [11/22/17 22:20:50.353][DEBUG] [Telescope Thread] Astrometry.NET - File is too large, resizing [11/22/17 22:20:50.372][DEBUG] [Telescope Thread] Astrometry.NET - Saving file [11/22/17 22:20:50.372][DEBUG] [Telescope Thread] SaveFileBmp16: Locking bitmap for disk write... [11/22/17 22:20:50.372][DEBUG] [Telescope Thread] SaveFileBmp16: Opening file stream... [11/22/17 22:20:50.373][DEBUG] [Telescope Thread] SaveFileBmp16: Writing FITS headers... [11/22/17 22:20:50.373][DEBUG] [Telescope Thread] SaveFileBmp16: Traversing and persisting bitmap data... [11/22/17 22:20:50.382][DEBUG] [Telescope Thread] SaveFileBmp16: FITS block fill... [11/22/17 22:20:50.382][DEBUG] [Telescope Thread] SaveFileBmp16: Unlocking bitmap... [11/22/17 22:20:50.382][DEBUG] [Telescope Thread] SaveFileBmp16: Closing file stream [11/22/17 22:20:50.385][DEBUG] [Telescope Thread] Astrometry.NET using endpoint: http://127.0.0.1:8080/api/ [11/22/17 22:20:50.385][DEBUG] [Telescope Thread] Astrometry.NET - Calling Async Solve [11/22/17 22:20:50.387][DEBUG] [Unknown] Astrometry.NET uploading file: C:\Users\guill\AppData\Local\SequenceGenerator\Temp\convertedAstometry.fits [11/22/17 22:20:51.452][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:51.452][DEBUG] [Unknown] Astrometry.NET returned: {"jobs":[],"processing_finished":"0","processing_started":"1","user_images":[],"user":"0"} [11/22/17 22:20:52.453][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:52.453][DEBUG] [Unknown] Astrometry.NET returned: {"jobs":[],"user_images":[],"user":"0","processing_finished":"0","processing_started":"1"} [11/22/17 22:20:53.455][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:53.455][DEBUG] [Unknown] Astrometry.NET returned: {"jobs":[],"user":"0","user_images":[],"processing_started":"1","processing_finished":"0"} [11/22/17 22:20:54.457][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:54.457][DEBUG] [Unknown] Astrometry.NET returned: {"jobs":[],"user_images":[],"user":"0","processing_finished":"0","processing_started":"1"} [11/22/17 22:20:55.462][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:55.462][DEBUG] [Unknown] Astrometry.NET returned: {"user":"0","user_images":[],"processing_started":"1","processing_finished":"0","jobs":[]} [11/22/17 22:20:56.466][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:56.466][DEBUG] [Unknown] Astrometry.NET returned: {"processing_finished":"0","processing_started":"1","user_images":[],"user":"0","jobs":[]} [11/22/17 22:20:57.472][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:57.472][DEBUG] [Unknown] Astrometry.NET returned: {"processing_finished":"0","processing_started":"1","user_images":[],"user":"0","jobs":[]} [11/22/17 22:20:58.476][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:58.476][DEBUG] [Unknown] Astrometry.NET returned: {"processing_finished":"0","processing_started":"1","user_images":[],"user":"0","jobs":[]} [11/22/17 22:20:59.481][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:20:59.481][DEBUG] [Unknown] Astrometry.NET returned: {"jobs":[],"processing_finished":"0","processing_started":"1","user_images":[],"user":"0"} [11/22/17 22:21:00.482][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:21:00.482][DEBUG] [Unknown] Astrometry.NET returned: {"user_images":[],"user":"0","processing_finished":"0","processing_started":"1","jobs":[]} [11/22/17 22:21:01.496][DEBUG] [Unknown] Astrometry.NET request: /api/submissions/7 [11/22/17 22:21:01.497][DEBUG] [Unknown] Astrometry.NET returned: {"jobs":[7],"processing_finished":"1","processing_started":"1","user_images":[],"user":"0"} [11/22/17 22:21:01.497][DEBUG] [Unknown] Astrometry.NET - Upload complete [11/22/17 22:21:01.497][DEBUG] [Unknown] Astrometry.NET - Waiting for solve to complete [11/22/17 22:21:01.998][DEBUG] [Unknown] Astrometry.NET request: /api/jobs/7 [11/22/17 22:21:01.998][DEBUG] [Unknown] Astrometry.NET returned: {"status":"success"} [11/22/17 22:21:02.000][DEBUG] [Unknown] Astrometry.NET request: /api/jobs/7/calibration [11/22/17 22:21:02.000][DEBUG] [Unknown] Astrometry.NET returned: {"ra":60.7437355053,"pixscale":23.4214986950526,"orientation":-90.5039570246953,"radius":0,"dec":36.2810555918,"epoch":"J2000","parity":1} [11/22/17 22:21:02.001][DEBUG] [Unknown] ------------ Begin CalibrationResponse ------------- [11/22/17 22:21:02.001][DEBUG] [Unknown] dec 36.2810555918 [11/22/17 22:21:02.001][DEBUG] [Unknown] ra 60.7437355053 [11/22/17 22:21:02.001][DEBUG] [Unknown] radius 0 [11/22/17 22:21:02.001][DEBUG] [Unknown] orientation -90.5039570246953 [11/22/17 22:21:02.001][DEBUG] [Unknown] pixscale 23.4214986950526 [11/22/17 22:21:02.001][DEBUG] [Unknown] epoch J2000 [11/22/17 22:21:02.001][DEBUG] [Unknown] time NULL [11/22/17 22:21:02.001][DEBUG] [Unknown] parity 23.4214986950526 [11/22/17 22:21:02.001][DEBUG] [Unknown] ------------ End CalibrationResponse --------------- [11/22/17 22:21:02.001][DEBUG] [Unknown] Astrometry.NET - Job successfully solved [11/22/17 22:21:02.001][DEBUG] [Unknown] Astrometry.NET solve done in 11 seconds. [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] Astrometry.NET - Solve Completed [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] *********** SUCCESSFUL SOLVE ************* [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] SOLVER: True [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] SUCCESS: True [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] CONF: 100 [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] BLIND: True [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] RA: 4.04958236702 [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] DEC: 36.2810555918 [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] SCALE: 6.0364687358383 [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] FLIPPED: False [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] ANGLE (EON): 89.4960429753047 [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] MSG: Solve took 11.554 seconds [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] ****************************************** [11/22/17 22:21:02.395][DEBUG] [Telescope Thread] Checking to see if solve might be bad... [11/22/17 22:21:02.533][DEBUG] [Telescope Thread] Solve appears to be good... [11/22/17 22:21:02.533][DEBUG] [Telescope Thread] Auto center validation frame blind solved successfully... [11/22/17 22:21:02.533][DEBUG] [Telescope Thread] Telescope: Syncing to J2000 RA: 4.04958236702 Dec: 36.2810555918 [11/22/17 22:21:02.533][DEBUG] [Telescope Thread] Telescope: Sync behavior set to "Sync"... [11/22/17 22:21:02.533][DEBUG] [Telescope Thread] Telescope: Sync Passed in J2000 but mount requires JNOW, converting... [11/22/17 22:21:02.534][DEBUG] [Telescope Thread] Telescope: Syncing to JNOW RA: 4.06937081365184 Dec: 36.3280836518731 [11/22/17 22:21:02.672][DEBUG] [Telescope Thread] Attempting to write fits header info for [11/22/17 22:21:02.672][DEBUG] [Telescope Thread] Could not sync the rotator to 89.49604 degrees (not connected)! [11/22/17 22:21:02.673][DEBUG] [Telescope Thread] Auto center complete... [11/22/17 22:21:02.718][DEBUG] [Center Scope Thread] Automatic Auto Center Success - Total Error <= Allowable error: 10.2 <= 200.0 [11/22/17 22:21:02.718][DEBUG] [Center Scope Thread] RA Error: 10.0 [11/22/17 22:21:02.718][DEBUG] [Center Scope Thread] DEC Error: -2.0 [11/22/17 22:21:02.888][DEBUG] [Sequence Thread] DoEventGroupChange: Slewed or Centered, attempting to start guiding. [11/22/17 22:21:02.891][DEBUG] [Sequence Thread] PHD2: Auto Resume [11/22/17 22:21:02.891][DEBUG] [Sequence Thread] Checking PHD2 state... [11/22/17 22:21:02.891][DEBUG] [Sequence Thread] PHD2 GetPhdStatus - Pre-Wait : Stopped [11/22/17 22:21:02.891][DEBUG] [Sequence Thread] Sending to PHD2: {"method": "get_app_state", "id": 1001}