Bug 448247 - Krunner sometimes won't start programs - e.g. spotify snap, firefox snap
Summary: Krunner sometimes won't start programs - e.g. spotify snap, firefox snap
Status: CONFIRMED
Alias: None
Product: krunner
Classification: Plasma
Component: general (show other bugs)
Version: 5.23.4
Platform: Manjaro Linux
: NOR normal
Target Milestone: ---
Assignee: Alexander Lohnau
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2022-01-11 08:55 UTC by elman
Modified: 2024-09-26 09:37 UTC (History)
6 users (show)

See Also:
Latest Commit:
Version Fixed In:
Sentry Crash Report:


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description elman 2022-01-11 08:55:26 UTC
SUMMARY
Sometimes when I start an application from KRunner, it won't start. Today I tried Spotify snap. Twice it didn't start, third time it did. When I tried to start the app from Application Lanuncher, it work. But this might be coincidental.

I have seen this issue with other apps.

STEPS TO REPRODUCE
1. Install spotify snap
2. Start krunner
3. Search for spotify and try to run it

OBSERVED RESULT
Application didn't start.

EXPECTED RESULT
Application should start.

SOFTWARE/OS VERSIONS
Operating System: Manjaro Linux
KDE Plasma Version: 5.23.4
KDE Frameworks Version: 5.89.0
Qt Version: 5.15.2
Kernel Version: 5.15.12-1-MANJARO (64-bit)
Graphics Platform: X11

ADDITIONAL INFORMATION

Log from failed start:

```
jan 11 09:38:33 hostname systemd[1289]: Started snap.spotify.spotify.6d23c175-282b-46df-95e4-245da91816c2.scope.
jan 11 09:38:33 hostname systemd[1289]: Started Spotify - Music Player.
jan 11 09:38:33 hostname audit: BPF prog-id=32 op=LOAD
jan 11 09:38:33 hostname audit[208364]: SYSCALL arch=c000003e syscall=321 success=yes exit=9 a0=5 a1=7fff9c85fd50 a2=78 a3=1000 items=0 ppid=20173 pid=208364 auid=1000 uid=1000 gid=1000 euid=0 suid=0 fsuid=0 egid=0 sgid=1000 fsgid=0 tty=(none) ses=3 comm="snap-confine" exe="/usr/lib/snapd/snap-confine" key=(null)
jan 11 09:38:33 hostname audit: PROCTITLE proctitle=2F7573722F6C69622F736E6170642F736E61702D636F6E66696E65002D2D6261736500636F7265313800736E61702E73706F746966792E73706F74696679002F7573722F6C69622F736E6170642F736E61702D657865630073706F74696679002D2D666F7263652D6465766963652D7363616C652D666163746F723D32
jan 11 09:38:33 hostname krunner[208364]: /user.slice/user-1000.slice/user@1000.service/app.slice/app-spotify_spotify-51d0a730d2c54916a31fc147f3079e22.scope is not a snap cgroup
jan 11 09:38:33 hostname audit: BPF prog-id=0 op=UNLOAD
jan 11 09:38:33 hostname kernel: audit: type=1334 audit(1641890313.697:260): prog-id=32 op=LOAD
jan 11 09:38:33 hostname kernel: audit: type=1300 audit(1641890313.697:260): arch=c000003e syscall=321 success=yes exit=9 a0=5 a1=7fff9c85fd50 a2=78 a3=1000 items=0 ppid=20173 pid=208364 auid=1000 uid=1000 gid=1000 euid=0 suid=0 fsuid=0 egid=0 sgid=1000 fsgid=0 tty=(none) ses=3 comm="snap-confine" exe="/usr/lib/snapd/snap-confine" key=(null)
jan 11 09:38:33 hostname kernel: audit: type=1327 audit(1641890313.697:260): proctitle=2F7573722F6C69622F736E6170642F736E61702D636F6E66696E65002D2D6261736500636F7265313800736E61702E73706F746966792E73706F74696679002F7573722F6C69622F736E6170642F736E61702D657865630073706F74696679002D2D666F7263652D6465766963652D7363616C652D666163746F723D32
jan 11 09:38:33 hostname kernel: audit: type=1334 audit(1641890313.697:261): prog-id=0 op=UNLOAD
```

Log from successful start:

```
jan 11 09:40:50 hostname systemd[1289]: Started snap.spotify.spotify.57a868ec-17dd-4e86-bd1c-c701a849a02f.scope.
jan 11 09:40:50 hostname audit: BPF prog-id=33 op=LOAD
jan 11 09:40:50 hostname audit[217532]: SYSCALL arch=c000003e syscall=321 success=yes exit=9 a0=5 a1=7ffc9466c4a0 a2=78 a3=1000 items=0 ppid=1612 pid=217532 auid=1000 uid=1000 gid=1000 euid=0 suid=0 fsuid=0 egid=0 sgid=1000 fsgid=0 tty=(none) ses=3 comm="snap-confine" exe="/usr/lib/snapd/snap-confine" key=(null)
jan 11 09:40:50 hostname audit: PROCTITLE proctitle=2F7573722F6C69622F736E6170642F736E61702D636F6E66696E65002D2D6261736500636F7265313800736E61702E73706F746966792E73706F74696679002F7573722F6C69622F736E6170642F736E61702D657865630073706F74696679002D2D666F7263652D6465766963652D7363616C652D666163746F723D32
jan 11 09:40:50 hostname kernel: audit: type=1334 audit(1641890450.804:262): prog-id=33 op=LOAD
jan 11 09:40:50 hostname kernel: audit: type=1300 audit(1641890450.804:262): arch=c000003e syscall=321 success=yes exit=9 a0=5 a1=7ffc9466c4a0 a2=78 a3=1000 items=0 ppid=1612 pid=217532 auid=1000 uid=1000 gid=1000 euid=0 suid=0 fsuid=0 egid=0 sgid=1000 fsgid=0 tty=(none) ses=3 comm="snap-confine" exe="/usr/lib/snapd/snap-confine" key=(null)
jan 11 09:40:50 hostname kernel: audit: type=1327 audit(1641890450.804:262): proctitle=2F7573722F6C69622F736E6170642F736E61702D636F6E66696E65002D2D6261736500636F7265313800736E61702E73706F746966792E73706F74696679002F7573722F6C69622F736E6170642F736E61702D657865630073706F74696679002D2D666F7263652D6465766963652D7363616C652D666163746F723D32
jan 11 09:40:50 hostname systemd[1]: tmp-snap.rootfs_ZODNcV.mount: Deactivated successfully.
jan 11 09:40:50 hostname systemd[1289]: Started Spotify - Music Player.
jan 11 09:40:50 hostname audit: BPF prog-id=0 op=UNLOAD
jan 11 09:40:50 hostname kernel: audit: type=1334 audit(1641890450.941:263): prog-id=0 op=UNLOAD
jan 11 09:40:51 hostname audit[217627]: SECCOMP auid=1000 uid=1000 gid=1000 ses=3 pid=217627 comm="spotify" exe="/snap/spotify/56/usr/share/spotify/spotify" sig=0 arch=c000003e syscall=203 compat=0 ip=0x7f94642d5c7f code=0x50000
jan 11 09:40:51 hostname audit[217627]: SECCOMP auid=1000 uid=1000 gid=1000 ses=3 pid=217627 comm="spotify" exe="/snap/spotify/56/usr/share/spotify/spotify" sig=0 arch=c000003e syscall=203 compat=0 ip=0x7f94642d5c7f code=0x50000
jan 11 09:40:51 hostname audit[217627]: SECCOMP auid=1000 uid=1000 gid=1000 ses=3 pid=217627 comm="spotify" exe="/snap/spotify/56/usr/share/spotify/spotify" sig=0 arch=c000003e syscall=203 compat=0 ip=0x7f94642d5c7f code=0x50000
jan 11 09:40:51 hostname audit[217627]: SECCOMP auid=1000 uid=1000 gid=1000 ses=3 pid=217627 comm="spotify" exe="/snap/spotify/56/usr/share/spotify/spotify" sig=0 arch=c000003e syscall=203 compat=0 ip=0x7f94642d5c7f code=0x50000
jan 11 09:40:52 hostname kernel: audit: type=1326 audit(1641890451.997:264): auid=1000 uid=1000 gid=1000 ses=3 pid=217627 comm="spotify" exe="/snap/spotify/56/usr/share/spotify/spotify" sig=0 arch=c000003e syscall=203 compat=0 ip=0x7f94642d5c7f code=0x50000
jan 11 09:40:52 hostname kernel: audit: type=1326 audit(1641890451.997:265): auid=1000 uid=1000 gid=1000 ses=3 pid=217627 comm="spotify" exe="/snap/spotify/56/usr/share/spotify/spotify" sig=0 arch=c000003e syscall=203 compat=0 ip=0x7f94642d5c7f code=0x50000
jan 11 09:40:52 hostname kernel: audit: type=1326 audit(1641890451.997:266): auid=1000 uid=1000 gid=1000 ses=3 pid=217627 comm="spotify" exe="/snap/spotify/56/usr/share/spotify/spotify" sig=0 arch=c000003e syscall=203 compat=0 ip=0x7f94642d5c7f code=0x50000
jan 11 09:40:52 hostname kernel: audit: type=1326 audit(1641890451.997:267): auid=1000 uid=1000 gid=1000 ses=3 pid=217627 comm="spotify" exe="/snap/spotify/56/usr/share/spotify/spotify" sig=0 arch=c000003e syscall=203 compat=0 ip=0x7f94642d5c7f code=0x50000
```
Comment 1 Nate Graham 2022-01-11 17:07:36 UTC
Does it happen when you try to launch it from the KRunner-powered search in Kickoff too? Or just KRunner itself?
Comment 2 elman 2022-01-14 09:18:32 UTC
So far I haven't seen this problem with Kickoff, but I rarely use it and when I tried, it worked. Also in KRunner this only happens sometimes. Not every time. For example yesterday everything was fine, but today I had problem with 1st start of teams snap, but second work OK.

Logs:

failed:
jan 14 08:58:29 hostname systemd[1426]: Started snap.teams.teams.386180cf-603b-4ad0-80df-eb3b979a9419.scope.
jan 14 08:58:29 hostname systemd[1426]: Started Microsoft Teams - Preview.
jan 14 08:58:29 hostname audit: BPF prog-id=28 op=LOAD
jan 14 08:58:29 hostname audit[4718]: SYSCALL arch=c000003e syscall=321 success=yes exit=9 a0=5 a1=7ffcaa71eb80 a2=78 a3=0 items=0 ppid=4665 pid=4718 auid=1000 uid=1000 gid=1000 euid=0 suid=0 fsuid=0 egid=0 sgid=1000 fsgid=0 tty=(none) ses=3 comm="snap-confine" exe="/usr/lib/snapd/snap-confine" key=(null)
jan 14 08:58:29 hostname audit: PROCTITLE proctitle=2F7573722F6C69622F736E6170642F736E61702D636F6E66696E65002D2D6261736500636F7265313800736E61702E7465616D732E7465616D73002F7573722F6C69622F736E6170642F736E61702D65786563007465616D73
jan 14 08:58:29 hostname krunner[4718]: /user.slice/user-1000.slice/user@1000.service/app.slice/app-teams_teams-07c16d4139d64b3d89473a65f1c7cb32.scope is not a snap cgroup
jan 14 08:58:29 hostname audit: BPF prog-id=0 op=UNLOAD
jan 14 08:58:29 hostname kernel: audit: type=1334 audit(1642147109.814:190): prog-id=28 op=LOAD
jan 14 08:58:29 hostname kernel: audit: type=1300 audit(1642147109.814:190): arch=c000003e syscall=321 success=yes exit=9 a0=5 a1=7ffcaa71eb80 a2=78 a3=0 items=0 ppid=4665 pid=4718 auid=1000 uid=1000 gid=1000 euid=0 suid=0 fsuid=0 egid=0 sgid=1000 fsgid=0 tty=(none) ses=3 comm="snap-confine" exe="/usr/lib/snapd/snap-confine" key=(null)
jan 14 08:58:29 hostname kernel: audit: type=1327 audit(1642147109.814:190): proctitle=2F7573722F6C69622F736E6170642F736E61702D636F6E66696E65002D2D6261736500636F7265313800736E61702E7465616D732E7465616D73002F7573722F6C69622F736E6170642F736E61702D65786563007465616D73
jan 14 08:58:29 hostname kernel: audit: type=1334 audit(1642147109.814:191): prog-id=0 op=UNLOAD

started:
jan 14 08:59:22 hostname systemd[1426]: Started snap.teams.teams.14e7f1d0-3854-42bd-bdd4-6cb24246f0b5.scope.
jan 14 08:59:22 hostname audit: BPF prog-id=29 op=LOAD
jan 14 08:59:22 hostname kernel: audit: type=1334 audit(1642147162.758:203): prog-id=29 op=LOAD
jan 14 08:59:22 hostname kernel: audit: type=1300 audit(1642147162.758:203): arch=c000003e syscall=321 success=yes exit=9 a0=5 a1=7ffeba1843c0 a2=78 a3=0 items=0 ppid=4665 pid=6827 auid=1000 uid=1000 gid=1000 euid=0 suid=0 fsuid=0 egid=0 sgid=1000 fsgid=0 tty=(none) ses=3 comm="snap-confine" exe="/usr/lib/snapd/snap-confine" key=(null)
jan 14 08:59:22 hostname kernel: audit: type=1327 audit(1642147162.758:203): proctitle=2F7573722F6C69622F736E6170642F736E61702D636F6E66696E65002D2D6261736500636F7265313800736E61702E7465616D732E7465616D73002F7573722F6C69622F736E6170642F736E61702D65786563007465616D73
jan 14 08:59:22 hostname audit[6827]: SYSCALL arch=c000003e syscall=321 success=yes exit=9 a0=5 a1=7ffeba1843c0 a2=78 a3=0 items=0 ppid=4665 pid=6827 auid=1000 uid=1000 gid=1000 euid=0 suid=0 fsuid=0 egid=0 sgid=1000 fsgid=0 tty=(none) ses=3 comm="snap-confine" exe="/usr/lib/snapd/snap-confine" key=(null)
jan 14 08:59:22 hostname audit: PROCTITLE proctitle=2F7573722F6C69622F736E6170642F736E61702D636F6E66696E65002D2D6261736500636F7265313800736E61702E7465616D732E7465616D73002F7573722F6C69622F736E6170642F736E61702D65786563007465616D73
jan 14 08:59:22 hostname systemd[1]: tmp-snap.rootfs_1hZDLg.mount: Deactivated successfully.
jan 14 08:59:22 hostname systemd[1426]: Started Microsoft Teams - Preview.
jan 14 08:59:22 hostname kwin_x11[1696]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 33565, resource id: 98566312, major code: 18 (ChangeProperty), minor code: 0
jan 14 08:59:22 hostname audit: BPF prog-id=0 op=UNLOAD
jan 14 08:59:22 hostname kernel: audit: type=1334 audit(1642147162.901:204): prog-id=0 op=UNLOAD
jan 14 08:59:23 hostname kwin_x11[1696]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 33920, resource id: 98566313, major code: 18 (ChangeProperty), minor code: 0
jan 14 08:59:29 hostname kwin_x11[1696]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 34571, resource id: 16780531, major code: 18 (ChangeProperty), minor code: 0
jan 14 08:59:29 hostname kded5[1695]: Registering ":1.100/org/ayatana/NotificationItem/Microsoft_Teams___Preview1" to system tray
jan 14 08:59:29 hostname plasmashell[1762]: QFont::setPointSizeF: Point size <= 0 (0.000000), must be greater than 0
jan 14 08:59:29 hostname pipewire-pulse[2094]: mod.protocol-pulse: client 0x55c8ffc9e1d0 [Chromium]: ERROR command:-1 (invalid) tag:2 error:25 (Input/output error)
jan 14 08:59:29 hostname wireplumber[2093]: <WpSiStandardLink:0x55855d5c9c00> si-standard-link: in/out items are not valid anymore
jan 14 08:59:32 hostname kwin_x11[1696]: qt.qpa.xcb: QXcbConnection: XCB error: 3 (BadWindow), sequence: 35715, resource id: 104857608, major code: 15 (QueryTree), minor code: 0
Comment 3 Nate Graham 2022-01-14 17:15:59 UTC
Thanks. That's odd.
Comment 4 elman 2022-01-27 08:38:27 UTC
After another week of testing I still haven't seen the problem with Kickoff. But I saw that KRunner wouldn't start Spotify twice in the row and then Kickoff started it.
Comment 5 pietz 2024-01-29 16:05:53 UTC
I can reproduce this issue.

In my example, my Firefox is installed as snap to /snap/bin/firefox and Alt-F2 (Krunner) won't launch the browser (either by typing an URL or "firefox" directly). But when I change the application command in the plasma menu (the application entry command) to /usr/bin/firefox (which is actually a kubuntu script to launch /snap/bin/firefox) instead of the snap-executable, it works fine!

So there must be some issue with KRunner and snaps… hmmm…
Comment 6 Matthias 2024-09-02 14:35:04 UTC
I have the same problem in KickOff and Krunner. I think I have narrowed down the conditions for the problem to occur - it seems to be connected to whether Krunner/Kickoff are still loading the menu entries while pressing "Enter" :

STEPS TO REPRODUCE
1. Have a graphical snap application (I'll use the example of signal-desktop, but have observed this for all snap applications) installed
2. Open Kickoff and start typing "sign"
3. The application "Signal" is now selected as the topmost result. Quickly press enter to select it.

OBSERVED RESULT
Nothing happens. When plasmashell was started via terminal, the following message is displayed:
"Connecting to deprecated signal QDBusConnectionInterface::serviceOwnerChanged(QString,QString,QString)
/user.slice/user-1000.slice/user@1000.service/app.slice/app-signal\x2ddesktop_signal\x2ddesktop-e7fbed6a9fe04518bed23e43793f11db.scope is not a snap cgroup"


EXPECTED RESULT
Signal is opened. It is worth noting that the behaviour changes when following these slightly different steps:
1. Open KickOff
2. Type "sign"
3. Wait until all entries are displayed and there's no more "movement" in the suggestion list.
4. Press enter -> Signal is opened

Signal is also opened as expected when it had been opened (and closed) in the same session before.

SOFTWARE/OS VERSIONS
Linux/KDE Plasma: Kubuntu 24.04, 
KDE Plasma Version: Plasma 5.27.11
KDE Frameworks Version: 5.115.0
Qt Version: 5.15.13
Comment 7 Matthias 2024-09-26 09:37:36 UTC
I think it might be the same problem as this one: https://bugs.launchpad.net/ubuntu/+source/gnome-shell/+bug/2011806