https://bugs.kde.org/show_bug.cgi?id=410094
Bug ID: 410094 Summary: Kstars sometimes fails to wait for a slew to happen before slew is regarded as complete on the mount tool. Product: kstars Version: git Platform: Compiled Sources OS: Linux Status: REPORTED Severity: normal Priority: NOR Component: general Assignee: mutla...@ikarustech.com Reporter: deathstal...@gmail.com Target Milestone: --- SUMMARY In some cases when using the mount model tool, KStars/Ekos has immediately decided the slew is over. Ex: [2019-07-19T01:17:54.891 CDT INFO ][ org.kde.kstars.ekos.align] - "Slewing to target coordinates: RA (00h 00m 00s) DEC ( 55° 51' 27\")." [2019-07-19T01:17:55.064 CDT INFO ][ org.kde.kstars.ekos.align] - "Slew complete. Solving Alignment Point. . ." [2019-07-19T01:17:55.065 CDT INFO ][ org.kde.kstars.ekos.align] - "Settling..." This comes from Align::processNumber in align.cpp, which seems to only check if the Equatorial coordinates show as IPS_OK, even if the mount has had no chance to update the status. (In this case I had it as 200ms, you'll note that the Slew to Slew Complete is less than that, and I think the default polling is something like 500ms from the lx200 derived drivers.) So it seems that there should be a minimum delay before it fires off, and/or a state change to/from tracking/slewing before it registers. Do note this is also kstars running on one machine, and gigabit ethernet to a mini pc (also running the same OS) It's also possible that the driver isn't doing something right, but based on what I can tell, the driver starts doing that immediately after a status update finishes. (Which is a little talky, but I don't belive that's the issue here.) Timeline which may be more clear: 2019-07-19T01:17:54.555 (Update, Mode: Tracking) 2019-07-19T01:17:54.870 (Command to sync sent to mount) 2019-07-19T01:17:54.891 (Ekos align module, says send to slew) 2019-07-19T01:17:54.951 (Update, Mode: Tracking as Command not yet sent) 2019-07-19T01:17:55.064 (Ekos regards slew as complete) 2019-07-19T01:17:55.096 (Command to Goto sent to mount) 2019-07-19T01:17:55.292 (Update, Mode: Slewing) 2019-07-19T01:17:55.365 (Ekos mount registers status change) 2019-07-19T01:17:55.660 (Update, Mode: Slewing) STEPS TO REPRODUCE 1. Keep Aligning and it will sometimes happen. It is not a regular thing. My assumption is that there is the condition of it getting to that case only sometimes. OBSERVED RESULT Using the mount model, sometimes the Align module decides it's done with the slew, even if the slew is far from complete. EXPECTED RESULT Wait for the slew, solve, sync, slew, until everything is done. As it does, some times. SOFTWARE/OS VERSIONS Kstars: (roughly 3.3.2) Build: 2019-07-03T05:13:32Z Operating System: Kubuntu 19.04 KDE Plasma Version: 5.15.4 KDE Frameworks Version: 5.56.0 Qt Version: 5.12.2 Kernel Version: 5.0.0-20-generic OS Type: 64-bit Processors: 8 × Intel® Core™ i7-4700HQ CPU @ 2.40GHz Memory: 23.5 GiB of RAM ADDITIONAL INFORMATION More complete log section, if needed the full one can be attached, but it is 213MB [2019-07-19T01:17:54.790 CDT INFO ][ org.kde.kstars.ekos.align] - "Solver completed in 4 seconds." [2019-07-19T01:17:54.798 CDT INFO ][ org.kde.kstars.ekos.align] - "Solution coordinates: RA (18h 35m 21s) DEC ( 38° 51' 53\") Telescope Coordinates: RA (18h 37m 35s) DEC ( 38° 48' 07\")" [2019-07-19T01:17:54.798 CDT DEBG ][ org.kde.kstars.indi] - ISD:Telescope: Syncing... [2019-07-19T01:17:54.803 CDT DEBG ][ org.kde.kstars.indi] - ISD:Telescope sending coords RA: "18h 35m 21s" ( 18.5893 ) DE: " 38° 51' 53\"" ( 38.8649 ) [2019-07-19T01:17:54.803 CDT INFO ][ org.kde.kstars.ekos.align] - "Syncing to RA (18h 35m 21s) DEC ( 38° 51' 53\")" [2019-07-19T01:17:54.840 CDT INFO ][ org.kde.kstars.indi] - Nikon DSLR DSC D5300 : "[INFO] Saving device configuration... " [2019-07-19T01:17:54.840 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] <setObjectRA> " [2019-07-19T01:17:54.840 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Sr 18:35:21#> " [2019-07-19T01:17:54.840 CDT INFO ][ org.kde.kstars.indi] - Nikon DSLR DSC D5300 : "[INFO] Device configuration saved. " [2019-07-19T01:17:54.841 CDT DEBG ][ org.kde.kstars.indi] - Nikon DSLR DSC D5300 : "[DEBUG] Configuration successfully saved. " [2019-07-19T01:17:54.842 CDT INFO ][ org.kde.kstars.indi] - Nikon DSLR DSC D5300 : "[INFO] CCD FOV rotation updated to -107.446 degrees. " [2019-07-19T01:17:54.853 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Sr 18:35:21#> successful. " [2019-07-19T01:17:54.854 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] <setObjectDEC> " [2019-07-19T01:17:54.854 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Sd +38:51:54#> " [2019-07-19T01:17:54.870 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Sd +38:51:54#> successful. " [2019-07-19T01:17:54.870 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[DEBUG] CMD <:CM#> " [2019-07-19T01:17:54.870 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:CM#> " [2019-07-19T01:17:54.881 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <N/A> " [2019-07-19T01:17:54.882 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[DEBUG] RES <N/A> " [2019-07-19T01:17:54.882 CDT INFO ][ org.kde.kstars.indi] - LX200 OnStep : "[INFO] OnStep: Synchronization successful. " [2019-07-19T01:17:54.882 CDT INFO ][ org.kde.kstars.ekos.align] - "Mount is synced to solution coordinates. Astrometric solver is successful." [2019-07-19T01:17:54.885 CDT DEBG ][ org.kde.kstars.indi] - ISD:Telescope: TRACK [2019-07-19T01:17:54.890 CDT DEBG ][ org.kde.kstars.indi] - ISD:Telescope sending coords RA: "00h 00m 00s" ( 9.8125e-05 ) DE: " 55° 51' 27\"" ( 55.8577 ) [2019-07-19T01:17:54.891 CDT INFO ][ org.kde.kstars.ekos.align] - "Slewing to target coordinates: RA (00h 00m 00s) DEC ( 55° 51' 27\")." [2019-07-19T01:17:54.926 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GR#> " [2019-07-19T01:17:54.926 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <18:37:35> " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] VAL [18.6264] " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GD#> " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <+38*48:07> " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] VAL [38.8019] " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GU#> " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <Nptza/ET270> " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Gm#> " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <E> " [2019-07-19T01:17:54.951 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:%BD#> " [2019-07-19T01:17:54.957 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <0> " [2019-07-19T01:17:54.957 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:%BR#> " [2019-07-19T01:17:54.966 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <0> " [2019-07-19T01:17:54.966 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GX90#> " [2019-07-19T01:17:54.978 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <1.00> " [2019-07-19T01:17:54.979 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[DEBUG] Guide Rate: 1.000000 " [2019-07-19T01:17:54.979 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GX95#> " [2019-07-19T01:17:54.988 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <1> " [2019-07-19T01:17:54.989 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GX96#> " [2019-07-19T01:17:54.998 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <B> " [2019-07-19T01:17:54.998 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GXE9#> " [2019-07-19T01:17:55.009 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <30> " [2019-07-19T01:17:55.009 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GXEA#> " [2019-07-19T01:17:55.019 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <30> " [2019-07-19T01:17:55.021 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:A?#> " [2019-07-19T01:17:55.029 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <636> " [2019-07-19T01:17:55.029 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[DEBUG] Align: max_stars: 6 current star: 3, align_stars 6 " [2019-07-19T01:17:55.030 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GX02#> " [2019-07-19T01:17:55.039 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <0> " [2019-07-19T01:17:55.039 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GX03#> " [2019-07-19T01:17:55.048 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <0> " [2019-07-19T01:17:55.049 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:$QZ?#> " [2019-07-19T01:17:55.058 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <I> " [2019-07-19T01:17:55.064 CDT INFO ][ org.kde.kstars.ekos.align] - "Slew complete. Solving Alignment Point. . ." [2019-07-19T01:17:55.065 CDT INFO ][ org.kde.kstars.ekos.align] - "Settling..." [2019-07-19T01:17:55.065 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] <setObjectRA> " [2019-07-19T01:17:55.066 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Sr 00:00:00#> " [2019-07-19T01:17:55.096 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Sr 00:00:00#> successful. " [2019-07-19T01:17:55.096 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] <setObjectDEC> " [2019-07-19T01:17:55.096 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Sd +55:51:28#> " [2019-07-19T01:17:55.096 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Sd +55:51:28#> successful. " [2019-07-19T01:17:55.096 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] <Slew> " [2019-07-19T01:17:55.096 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:MS#> " [2019-07-19T01:17:55.102 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <0> " [2019-07-19T01:17:55.103 CDT INFO ][ org.kde.kstars.indi] - LX200 OnStep : "[INFO] Slewing to RA: 0:00:00 - DEC: 55:51:28 " [2019-07-19T01:17:55.259 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GR#> " [2019-07-19T01:17:55.275 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <18:37:31> " [2019-07-19T01:17:55.276 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] VAL [18.6253] " [2019-07-19T01:17:55.276 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GD#> " [2019-07-19T01:17:55.291 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <+38*49:05> " [2019-07-19T01:17:55.292 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] VAL [38.8181] " [2019-07-19T01:17:55.292 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GU#> " [2019-07-19T01:17:55.310 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <nptza/ET270> " [2019-07-19T01:17:55.310 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:Gm#> " [2019-07-19T01:17:55.317 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <E> " [2019-07-19T01:17:55.317 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:%BD#> " [2019-07-19T01:17:55.326 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <0> " [2019-07-19T01:17:55.326 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:%BR#> " [2019-07-19T01:17:55.335 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <0> " [2019-07-19T01:17:55.335 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GX90#> " [2019-07-19T01:17:55.348 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <1.00> " [2019-07-19T01:17:55.348 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[DEBUG] Guide Rate: 1.000000 " [2019-07-19T01:17:55.349 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GX95#> " [2019-07-19T01:17:55.358 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] RES <1> " [2019-07-19T01:17:55.358 CDT DEBG ][ org.kde.kstars.indi] - LX200 OnStep : "[SCOPE] CMD <:GX96#> " [2019-07-19T01:17:55.365 CDT DEBG ][ org.kde.kstars.ekos.mount] - Mount status changed from 3 to 2 -- You are receiving this mail because: You are watching all bug changes.