Auto Resolve (ASTAP) works but Error after first image during Model Run

[hdiessner]

Describe the bug
MW4 v2.2.4, all devices connected and working.
Manual exposure of picture working and resolved successfully with ASTAP
When Trying to run a 3 points model, after first exposure and first (successful) plate solving, an Error is displayed:

Excerpt from log file:

[2022-05-18 21:45:43.199][D][  astrometry.py][ 156] wcs header: [SIMPLE  =                    T / conforms to FITS standard                      BITPIX  =                   16 / array data type                                NAXIS   =                    2 / number of array dimensions                     NAXIS1  =                 4656                                                  NAXIS2  =                 3520                                                  EXTEND  =                    T                                                  BSCALE  =                    1                                                  BZERO   =                32768                                                  OBJECT  = 'SKY_OBJECT'         / default name from MW4                          FRAME   = 'Light   '           / Modeling works with light frames               EQUINOX =                 2000 / All data is stored in J2000                    PIXSIZE1=                  3.8                                                  PIXSIZE2=                  3.8                                                  XPIXSZ  =                  3.8                                                  YPIXSZ  =                  3.8                                                  FOCALLEN=               2541.0 / Data taken from driver or manual input         SCALE   =   0.3084639905548996                                                  XBINNING=                    1 / MW4 same binning x/y                           YBINNING=                    1 / MW4 same binning x/y                           EXPTIME =                 10.0                                                  OBSERVER= 'MW4     '                                                            DATE-OBS= '2022-05-18T21:46:39' / Time is UTC of mount                          MJD-OBS =    59717.90739933075 / Time is UTC of mount                           CCD-TEMP=                 20.5                                                  SQM     =                    0                                                  RA      =    253.3271982044297 / Float value in degree                          DEC     =    81.33932402303928 / Float value in degree                          TELESCOP= '10micron GM3000HPS' / Mount version from firmware                    SITELAT = '+48:49:59'                                                           SITELON = '+08:50:21'                                                           SITEELEV=                454.4                                                  CTYPE1  = 'RA---TAN'           / first parameter RA  ,  projection TANgential   CTYPE2  = 'DEC--TAN'           / second parameter DEC,  projection TANgential   CUNIT1  = 'deg     '           / Unit of coordinates                            CRPIX1  =  2.328500000000E+003 / X of reference pixel                           CRPIX2  =  1.760500000000E+003 / Y of reference pixel                           CRVAL1  =  2.547332872744E+002 / RA of reference pixel (deg)                    CRVAL2  =  8.153474055389E+001 / DEC of reference pixel (deg)                   CDELT1  =  8.601499400174E-005 / X pixel size (deg)                             CDELT2  =  8.618363015154E-005 / Y pixel size (deg)                             CROTA1  =  9.242697387215E+001 / Image twist of X axis        (deg)             CROTA2  = -2.675733038522E+002 / Image twist of Y axis        (deg)             CD1_1   = -3.641976011607E-006 / CD matrix to convert (x,y) to (Ra, Dec)        CD1_2   =  8.610632386945E-005 / CD matrix to convert (x,y) to (Ra, Dec)        CD2_1   = -8.593785663985E-005 / CD matrix to convert (x,y) to (Ra, Dec)        CD2_2   = -3.649533639521E-006 / CD matrix to convert (x,y) to (Ra, Dec)        PLTSOLVD=                    T / ASTAP internal solver                          END                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                             ]
[2022-05-18 21:45:43.201][D][  fitsHeader.py][  60] HasFloat: [True], HasDeg: [False], Header:[SIMPLE  =                    T / conforms to FITS standard                      BITPIX  =                   16 / array data type                                NAXIS   =                    2 / number of array dimensions                     NAXIS1  =                 4656                                                  NAXIS2  =                 3520                                                  EXTEND  =                    T                                                  BSCALE  =                    1                                                  BZERO   =                32768                                                  OBJECT  = 'SKY_OBJECT'         / default name from MW4                          FRAME   = 'Light   '           / Modeling works with light frames               EQUINOX =                 2000 / All data is stored in J2000                    PIXSIZE1=                  3.8                                                  PIXSIZE2=                  3.8                                                  XPIXSZ  =                  3.8                                                  YPIXSZ  =                  3.8                                                  FOCALLEN=               2541.0 / Data taken from driver or manual input         SCALE   =   0.3084639905548996                                                  XBINNING=                    1 / MW4 same binning x/y                           YBINNING=                    1 / MW4 same binning x/y                           EXPTIME =                 10.0                                                  OBSERVER= 'MW4     '                                                            DATE-OBS= '2022-05-18T21:46:39' / Time is UTC of mount                          MJD-OBS =    59717.90739933075 / Time is UTC of mount                           CCD-TEMP=                 20.5                                                  SQM     =                    0                                                  RA      =    253.3271982044297 / Float value in degree                          DEC     =    81.33932402303928 / Float value in degree                          TELESCOP= '10micron GM3000HPS' / Mount version from firmware                    SITELAT = '+48:49:59'                                                           SITELON = '+08:50:21'                                                           SITEELEV=                454.4                                                  END                                                                                                                                                                                                                                                                                                                                                                                                             ]
[2022-05-18 21:45:43.201][D][  fitsHeader.py][  61] Ra:[16h 53m 18.53s][16.888479880295314], Dec: [81deg 20' 21.6"][81.33932402303928]
[2022-05-18 21:45:43.202][D][astrometryASTAP][ 233] Header: [SIMPLE  =                    T / conforms to FITS standard                      BITPIX  =                   16 / array data type                                NAXIS   =                    2 / number of array dimensions                     NAXIS1  =                 4656                                                  NAXIS2  =                 3520                                                  EXTEND  =                    T                                                  BSCALE  =                    1                                                  BZERO   =                32768                                                  OBJECT  = 'SKY_OBJECT'         / default name from MW4                          FRAME   = 'Light   '           / Modeling works with light frames               EQUINOX =                 2000 / All data is stored in J2000                    PIXSIZE1=                  3.8                                                  PIXSIZE2=                  3.8                                                  XPIXSZ  =                  3.8                                                  YPIXSZ  =                  3.8                                                  FOCALLEN=               2541.0 / Data taken from driver or manual input         SCALE   =   0.3084639905548996                                                  XBINNING=                    1 / MW4 same binning x/y                           YBINNING=                    1 / MW4 same binning x/y                           EXPTIME =                 10.0                                                  OBSERVER= 'MW4     '                                                            DATE-OBS= '2022-05-18T21:46:39' / Time is UTC of mount                          MJD-OBS =    59717.90739933075 / Time is UTC of mount                           CCD-TEMP=                 20.5                                                  SQM     =                    0                                                  RA      =    253.3271982044297 / Float value in degree                          DEC     =    81.33932402303928 / Float value in degree                          TELESCOP= '10micron GM3000HPS' / Mount version from firmware                    SITELAT = '+48:49:59'                                                           SITELON = '+08:50:21'                                                           SITEELEV=                454.4                                                  END                                                                                                                                                                                                                                                                                                                                                                                                             ]
[2022-05-18 21:45:43.202][D][astrometryASTAP][ 234] Solve : [{'raJ2000S': <Angle 16h 58m 55.99s>, 'decJ2000S': <Angle 81deg 32' 05.1">, 'errorRA_S': 5061.920651892899, 'errorDEC_S': 703.4995110625971, 'angleS': 92.42195397022662, 'scaleS': 0.3102599176086932, 'errorRMS_S': 5110.5725949373955, 'mirroredS': False}]
[2022-05-18 21:45:43.205][D][astrometryASTAP][ 243] Result: [{'success': True, 'solvedPath': 'C:\\Mountwizzard4\\Windows_Scripts/image/m-2022-05-18-21-45-07-align3/image-001.fits', 'message': 'Solved', 'raJ2000S': <Angle 16h 58m 55.99s>, 'decJ2000S': <Angle 81deg 32' 05.1">, 'errorRA_S': 5061.920651892899, 'errorDEC_S': 703.4995110625971, 'angleS': 92.42195397022662, 'scaleS': 0.3102599176086932, 'errorRMS_S': 5110.5725949373955, 'mirroredS': False}]
[2022-05-18 21:45:43.206][D][    tabModel.py][ 208] Processing astrometry result
[2022-05-18 21:45:43.207][D][    tabModel.py][ 210] Result from queue [001]: [{'imagePath': 'C:\\Mountwizzard4\\Windows_Scripts/image/m-2022-05-18-21-45-07-align3/image-001.fits', 'exposureTime': 10.0, 'binning': 1, 'subFrame': 100.0, 'fastReadout': True, 'lenSequence': 3, 'countSequence': 1, 'pointNumber': 1, 'modelName': 'm-2022-05-18-21-45-07-align3', 'astrometryApp': 'astap - ASTAP', 'solveTimeout': 30.0, 'searchRadius': 10.0, 'focalLength': 2541.0, 'altitude': 55, 'azimuth': 10, 'raJNowM': <Angle 16h 51m 30.62s>, 'decJNowM': <Angle 81deg 18' 02.5">, 'angularPosRA': <Angle 138deg 53' 48.5">, 'angularPosDEC': <Angle 08deg 42' 22.7">, 'siderealTime': <Angle 14h 06m 53.10s>, 'julianDate': <Time tt=2459718.4072691407>, 'pierside': 'W', 'raJ2000M': <Angle 16h 53m 18.53s>, 'decJ2000M': <Angle 81deg 20' 21.6">}]
[2022-05-18 21:45:43.207][D][    tabModel.py][ 231] Queued to model [001]: [{'imagePath': 'C:\\Mountwizzard4\\Windows_Scripts/image/m-2022-05-18-21-45-07-align3/image-001.fits', 'exposureTime': 10.0, 'binning': 1, 'subFrame': 100.0, 'fastReadout': True, 'lenSequence': 3, 'countSequence': 1, 'pointNumber': 1, 'modelName': 'm-2022-05-18-21-45-07-align3', 'astrometryApp': 'astap - ASTAP', 'solveTimeout': 30.0, 'searchRadius': 10.0, 'focalLength': 2541.0, 'altitude': 55, 'azimuth': 10, 'raJNowM': <Angle 16h 51m 30.62s>, 'decJNowM': <Angle 81deg 18' 02.5">, 'angularPosRA': <Angle 138deg 53' 48.5">, 'angularPosDEC': <Angle 08deg 42' 22.7">, 'siderealTime': <Angle 14h 06m 53.10s>, 'julianDate': <Time tt=2459718.4072691407>, 'pierside': 'W', 'raJ2000M': <Angle 16h 53m 18.53s>, 'decJ2000M': <Angle 81deg 20' 21.6">, 'success': True, 'solvedPath': 'C:\\Mountwizzard4\\Windows_Scripts/image/m-2022-05-18-21-45-07-align3/image-001.fits', 'message': 'Solved', 'raJ2000S': <Angle 16h 58m 55.99s>, 'decJ2000S': <Angle 81deg 32' 05.1">, 'errorRA_S': 5061.920651892899, 'errorDEC_S': 703.4995110625971, 'angleS': 92.42195397022662, 'scaleS': 0.3102599176086932, 'errorRMS_S': 5110.5725949373955, 'mirroredS': False, 'raJNowS': <Angle 16h 57m 02.48s>, 'decJNowS': <Angle 81deg 29' 55.8">}]
[2022-05-18 21:45:43.335][U][     mainApp.py][ 416] Message window: [Solved   image-001:  Ra: 16:58:56 (16.982), Dec: +81:32:05 (81.535), ]
[2022-05-18 21:45:43.335][U][     mainApp.py][ 416] Message window: [                     Angle:  92, Scale: 0.310, Error: 5110.6]
[2022-05-18 21:45:43.337][T][  ascomClass.py][ 263] ASCOM threaded: [<bound method AscomClass.workerPollStatus of <logic.focuser.focuserAscom.FocuserAscom object at 0x000001CBD07495B0>>], args:[()], kwargs:[{}]
[2022-05-18 21:45:43.337][T][  ascomClass.py][ 263] ASCOM threaded: [<bound method FocuserAscom.workerPollData of <logic.focuser.focuserAscom.FocuserAscom object at 0x000001CBD07495B0>>], args:[()], kwargs:[{}]
[2022-05-18 21:45:43.337][T][  ascomClass.py][ 103] [ASCOM.PWI3.Focuser] property [connected] has value: [True]
[2022-05-18 21:45:43.338][T][  ascomClass.py][ 103] [ASCOM.PWI3.Focuser] property [position] has value: [25622]

To Reproduce
Steps to reproduce the behavior:

1. Go to 'Model Points'
2. Click on 'Generate Model points align' - '3 points'
3. Go to "Model Build"
4. Click on 'Model build' - 'Run'
5. See picture taken, see solver succeed
6. See error message in Messages Window, e.g. "Error: 5110.6"

Expected behavior
If this is really an error, it should stop the model build, but apparently the model build process is stalled at 33% (as first point was solved); Elapsed time is stopped counting, but "Cancel" Button is still active (and you have to press it in order to use the software again.

Screenshots
If applicable, add screenshots to help explain your problem.

Desktop (please complete the following information):

• OS: Windows 10, latest updates
• Ascom platform 6.6 - 6.6.0.3444
• MW4 downloaded, installed and configured today

[hdiessner]

Not sure if this is an actual error per se, but at least the model build process does not continue - and I have no idea where this is coming from.

[mworion]

Herwig,
could you provide the full log? Ideally you ran the test in debug (trace mode). Did this work in last version?
Michel

[hdiessner]

Hi Michel,
thank you for your fast answer!
Somehow, I can't attach the log file directly, so I put it here: Log

After the first "stop" occurred, I changed log file settings from default to debug - hope MW4 was able to change this "on the fly". If you need another log file, I can redo it tonight.

As my 10micron was defective, the control box was for service in Italy and when it came back, all data was of course deleted - so I need a new model; for that, I just yesterday migrated from MW3 to MW4 - this is why I don't know if it was working in previous versions of MW4.

[hdiessner]

Hi Michel,
I setup a new PC from scratch with all latest Windows Updates, latest ASCOM, drivers, latest MW4 (updated today), now when building a new model with 3 points, it takes all exposures, slews to the next point until finished.
So the problem of "stop" doesn't occur anymore.
But MW4 doesn't seem to like me: Now the platesolving for each image taken fails during the model creation, with the messages window saying: "Solving failed for image-001 ... 003"
If, however, I manually hit the "solve" button in the Imaging window, the exact same image is resolved immediately and correctly, messages window: "Solving error: None"
Any idea?

[hdiessner]

NoPlatesolve.txt

[mworion]

Herwig,
yes from the log I see an error reading the FITS file with an incorrect HEADER entry. Could you post on of the images? I checked if I write this Header Entry, but I don‘t. Which camera did you choose for getting the images? Was it NINA, SGPro or INDI?.
Michel

[hdiessner]

Hi Michel,
oh, I used the MW4 functionality to acquire the image using the latest ASCOM driver for my ASI1600mm pro. The image was displayed in the imaging window of MW4 without any problems.
I uploaded the fits file as a zip archive.
image-001.zip

Perhaps the latest ASCOM Driver from ZWO is doing some new tricks? I think it is from April or May 2022 so quite new...

[mworion]

Herwig,
many thanks. Coming closer. I will change behavior that if an error arises, the model run stop nicely. You also see the error in manual solve.
I will improve the error output in message window also.
One request: could you tell the ASTAP version and could you post the temp.wcs file out of the /temp folder in your working dir after solving the provided and failed file ?
Michel

[hdiessner]

Hi Michel,
all the images taken were resolved flawlessly when I manually clicked on the Solve button in the imaging window of MW4 (this even worked while a Model Build was running directly after throwing the error. Apparently the manual resolving process is more graceful to the header of the FITS files.
ASTAP Version: 2022.05.29a, 64bit
I just loaded the image-001.fits file I uploaded yesterday into MW4 Imaging Window and hit "Solve" - after a few seconds, the result was there, Messages windows says "Solving error: None"
temp.wcs file attached as zip
temp.zip

[mworion]

Hi Herwig,
I combine you latest issue with the one of Fukinagashi #244 as it has the same reason.