wireplumber segfault: system boot and could see in my dmesg
[10:31:36] [~] ❱❱❱ doas dmesg | grep wireplumber [ 105.433111] wireplumber[2055]: segfault at 28 ip 00007fb60ceb8f11 sp 00007ffdb84dee30 error 6 in libwireplumber-0.4.so.0.4.11[7fb60cead000+34000] [10:31:42] [cost 0.026s] doas dmesg | grep wireplumber
Full dmesg dmesg.log
Activity
This is coredumpctl debug
Since your log is lacking debug symbols, I guess I'll add a stacktrace which has them:
I also double checked that all gdm WP backtraces look like that.
-
For Arch you'd need to rebuild the listed libraries with debug symbols, if you used AUR, which you build yourself. For the official Arch binaries it should have automatically fetched that data from the debug server, so either something went wrong or those packages have no debug info published by Arch Linux.
Edited by Niklāvs Koļesņikovs 
You need to set the environmental variable
DEBUGINFOD_URLS=https://debuginfod.archlinux.organd enable it in gdb:set debuginfod enabled on(you can put that line in~/.gdbinitto make the setting persistent).So something like this should work:
export DEBUGINFOD_URLS=https://debuginfod.archlinux.org echo 'set debuginfod enabled on' >> ~/.gdbinit coredumpctl debug wireplumberEdited by Barnabás Pőcze
It seems to crash in WpDBus, but it's not very clear where exactly and why. A more detailed backtrace would be very helpful here. CC @julian
added area::library type::bug labels
According to the above coredump, the segfault happens in the
on_got_buscallback:#0 0x00007f45b7ec5424 on_got_bus (libwireplumber-0.4.so.0 + 0x1f424) #1 0x00007f45b7875298 g_task_return_now (libgio-2.0.so.0 + 0xb8298) #2 0x00007f45b7d48c20 g_main_dispatch (libglib-2.0.so.0 + 0x5bc20) #3 0x00007f45b7d48ff1 g_main_context_iterate (libglib-2.0.so.0 + 0x5bff1) #4 0x00007f45b7d492cf g_main_loop_run (libglib-2.0.so.0 + 0x5c2cf) #5 0x000055d52f546463 main (wireplumber + 0x2463) #6 0x00007f45b79e76d0 __libc_start_call_main (libc.so.6 + 0x296d0) #7 0x00007f45b79e7789 __libc_start_main_impl (libc.so.6 + 0x29789) #8 0x000055d52f546675 _start (wireplumber + 0x2675)The only place I can see a segfault happening in that callback is when self points to invalid memory, here: https://gitlab.freedesktop.org/pipewire/wireplumber/-/blob/master/lib/wp/dbus.c#L65
I think there is a race condition there: self can be destroyed before
on_got_buscallback is triggered.-
@HougeLangley Does this patch solves the segfault for you? julian/wireplumber@f0f27531
I got the error from Journactl after every reboot only.
That only happens with an upgrade from
wireplumberv0.4.10 to v0.4.11.Process 933 (wireplumber) of user 120 dumped core. Module linux-vdso.so.1 with build-id 70743e6fa18b5c64207700f7b95a6f0ab6b1ff10 Module libspa-v4l2.so with build-id f01bc8a61c561672c4e5a1f9f6224314d2cf2da2 Module libudev.so.1 with build-id bce2b8a5c23fcbcf5542f34b741e18db4452160a Module libasound.so.2 with build-id 037b70e73a363662ffa089fcb4370cecb6ca7bd8 Module libspa-alsa.so with build-id d90b05d7d5adfa484750beb978dc2cc01e683010 Module libwireplumber-module-logind.so with build-id ba06b6aa5616f6a27e7bc94143b1e2ddb826d73d Module libwireplumber-module-si-audio-endpoint.so with build-id 8748a763fd09decf36703562a79545da0f96d04d Module libwireplumber-module-si-node.so with build-id d3ae5b8221764926c5208963f148db21267d4f06 Module libwireplumber-module-mixer-api.so with build-id 6c98529d81973729faa2b7a21d9e54cc46023b91 Module libwireplumber-module-si-audio-adapter.so with build-id d072c67fd7c50fdc9b32c3c4b72ae970271ca25e Module libwireplumber-module-default-nodes-api.so with build-id 0c2eb814a76f554cd91cede590c746a02de16ed1 Module libwireplumber-module-si-standard-link.so with build-id 36695a978542b89cad22db5789a596734bdecf89 Module libwireplumber-module-reserve-device.so with build-id 7e6cafc74c530b638502f3256864adf6c9b8c204 Module libwireplumber-module-portal-permissionstore.so with build-id 1a798a1f3ebfce36fe6ee4f2e29ec17c3e399063 Module libwireplumber-module-default-nodes.so with build-id cbb060d8f6ec036d6bddc719732b5532380e2897 Module libwireplumber-module-metadata.so with build-id 2aba1d6959c5469e64a395e0603dbf2c6f38e823 Module libwireplumber-module-default-profile.so with build-id cdff4dacc78a130d7a2ed21923bead1bab199650 Module libwireplumber-module-file-monitor-api.so with build-id 032224a0ce97c7b1b02ebb5e962263ffbf85d3ba Module libgvfscommon.so with build-id 2cfa9a05d5e376857a2dacaf4893238a88eefb9e Module libgvfsdbus.so with build-id f6f918ab413a1eaaa77134863653c4382b7cf8de Module libm.so.6 with build-id 1b7296ef9fd806e47060788389293c824b09ad72 Module libdl.so.2 with build-id 94198b268228074fa9f405bbedbbae94112593ed Module liblua.so.5.4 with build-id 7bdd0ca9ab751d85d87f9f5cc170c7a7a9b7f08f Module libwireplumber-module-lua-scripting.so with build-id 5b466456e157ae2b3365c115fca7fcf5795cfdae Module libpipewire-module-session-manager.so with build-id 2b0119ae941e982d2b92be4e2c03ab7d23579ba8 Module libpipewire-module-metadata.so with build-id 60be1c48e2f0bd4c03d8d8a18ae87e6d3f8e9544 Module libpipewire-module-adapter.so with build-id 1da1733fb0cd3c594f8c18a0cdd88570f429630a Module libpipewire-module-client-device.so with build-id 4e39fde2c49b069d81564301c896ab3d5b9a5875 Module libpipewire-module-client-node.so with build-id f1faac9431417bbd29fe692af66a8a10a54b38e5 Module libpipewire-module-protocol-native.so with build-id 9a5f4ff5e6c2d2b6ca2b124a0535f41788bad17c Module libpipewire-module-rt.so with build-id 1807376eedf83c478415634a62c82889fe941a7b Module libgpg-error.so.0 with build-id 4738b8a9478177c202cccd64e0eb65d3dea2bfae Module liblz4.so.1 with build-id e63600ab23b2f6997f42fac2fa56e1f02ce159a1 Module libzstd.so.1 with build-id ab54c2881f53ab314e134f3e08c76d504376dd5d Module liblzma.so.5 with build-id 28b40c7af8098a66af6ee093b6986b91cad7694d Module libgcrypt.so.20 with build-id 8bf3cb884124273640de797a3e77d86c98434ea4 Module libcap.so.2 with build-id 21b00ab76bb16fde56fd741f07233c78069f0579 Module libsystemd.so.0 with build-id 6430b2bd03335142b596061e30d2508dc604a1b4 Module libdbus-1.so.3 with build-id 7f4b16b4b407cbae2d7118d6f99610e29a18a56a Module libspa-dbus.so with build-id 9f4e1bcbc6a903ea88028a84ff03b1c641059f87 Module libspa-support.so with build-id 4ff8b6276863386bdc342e0af5d3f012baf39be1 Module libblkid.so.1 with build-id 140694a62d8d4d07c6c320a501f948dd1b389d73 Module libpthread.so.0 with build-id 95ae4f30a6f12ccbff645d30f8e1a3ee23ec7d36 Module libmount.so.1 with build-id 4436aeea0cd8c01b5a77969e0531184f8b3513ce Module libz.so.1 with build-id fefe3219a96d682ec98fcfb78866b8594298b5a2 Module ld-linux-x86-64.so.2 with build-id 0effd0e43efa4468d3c31871c93af0b7f3005673 Module libpcre.so.1 with build-id 845483dd0acba86de9f0313102bebbaf3ce52767 Module libffi.so.8 with build-id f0a9586cf0f42d2b9971bd1065ca3a6b19f4a2c2 Module libgio-2.0.so.0 with build-id 7a769ec24a9a705d04ee0297730032f70ed0835b Module libgmodule-2.0.so.0 with build-id abd986222e2cf12fc7324cb0182dfc2c8f2269c0 Module libc.so.6 with build-id 60df1df31f02a7b23da83e8ef923359885b81492 Module libgcc_s.so.1 with build-id 0e3de903950e35ae59a5de8c00b1817a4a71ca01 Module libpipewire-0.3.so.0 with build-id 1c31e9ce9f8164c5e8128338569ffcd56c6163e6 Module libglib-2.0.so.0 with build-id 1340f3a762b2293ebf6d725edf0eb14839f85317 Module libgobject-2.0.so.0 with build-id a7515bd8cd51064d187953c0f506a43958de31a6 Module libwireplumber-0.4.so.0 with build-id 3b077e387ac568e6b3fe46bd1a4ff822da078d9c Module wireplumber with build-id 0d4af843b78c77316d55948702a956e98989edf6 Stack trace of thread 933: #0 0x00007f9a702edf11 n/a (libwireplumber-0.4.so.0 + 0x25f11) #1 0x00007f9a6fcf2544 n/a (libgio-2.0.so.0 + 0xa4544) #2 0x00007f9a6fcf257d n/a (libgio-2.0.so.0 + 0xa457d) #3 0x00007f9a70180c6b g_main_context_dispatch (libglib-2.0.so.0 + 0x54c6b) #4 0x00007f9a701d7001 n/a (libglib-2.0.so.0 + 0xab001) #5 0x00007f9a701801cf g_main_loop_run (libglib-2.0.so.0 + 0x541cf) #6 0x000056306af9e2f2 n/a (wireplumber + 0x22f2) #7 0x00007f9a6fe49290 n/a (libc.so.6 + 0x29290) #8 0x00007f9a6fe4934a __libc_start_main (libc.so.6 + 0x2934a) #9 0x000056306af9e5a5 n/a (wireplumber + 0x25a5) Stack trace of thread 956: #0 0x00007f9a6ff25c3f __poll (libc.so.6 + 0x105c3f) #1 0x00007f9a701d6f68 n/a (libglib-2.0.so.0 + 0xaaf68) #2 0x00007f9a701801cf g_main_loop_run (libglib-2.0.so.0 + 0x541cf) #3 0x00007f9a6fd56acc n/a (libgio-2.0.so.0 + 0x108acc) #4 0x00007f9a701b0405 n/a (libglib-2.0.so.0 + 0x84405) #5 0x00007f9a6feac54d n/a (libc.so.6 + 0x8c54d) #6 0x00007f9a6ff31874 __clone (libc.so.6 + 0x111874) Stack trace of thread 946: #0 0x00007f9a6ff25c3f __poll (libc.so.6 + 0x105c3f) #1 0x00007f9a701d6f68 n/a (libglib-2.0.so.0 + 0xaaf68) #2 0x00007f9a7017e392 g_main_context_iteration (libglib-2.0.so.0 + 0x52392) #3 0x00007f9a7017e3e2 n/a (libglib-2.0.so.0 + 0x523e2) #4 0x00007f9a701b0405 n/a (libglib-2.0.so.0 + 0x84405) #5 0x00007f9a6feac54d n/a (libc.so.6 + 0x8c54d) #6 0x00007f9a6ff31874 __clone (libc.so.6 + 0x111874) Stack trace of thread 941: #0 0x00007f9a6ff31c9e epoll_wait (libc.so.6 + 0x111c9e) #1 0x00007f9a70360489 n/a (libspa-support.so + 0x14489) #2 0x00007f9a70352d11 n/a (libspa-support.so + 0x6d11) #3 0x00007f9a7008dd47 n/a (libpipewire-0.3.so.0 + 0x3fd47) #4 0x00007f9a6feac54d n/a (libc.so.6 + 0x8c54d) #5 0x00007f9a6ff31874 __clone (libc.so.6 + 0x111874) Stack trace of thread 2844: #0 0x00007f9a6ff2b30d syscall (libc.so.6 + 0x10b30d) #1 0x00007f9a701d1063 g_cond_wait_until (libglib-2.0.so.0 + 0xa5063) #2 0x00007f9a7014f8d3 n/a (libglib-2.0.so.0 + 0x238d3) #3 0x00007f9a701b363b n/a (libglib-2.0.so.0 + 0x8763b) #4 0x00007f9a701b0405 n/a (libglib-2.0.so.0 + 0x84405) #5 0x00007f9a6feac54d n/a (libc.so.6 + 0x8c54d) #6 0x00007f9a6ff31874 __clone (libc.so.6 + 0x111874) ELF object binary architecture: AMD x86-64Downgrade back to the old 0.4.10, no error appears in Journactl after reboot.
OS: Manjaro testing branch. Linux Kernel: 5.18.10 Desktop: GNOME 42.3.1, GTK 3.24.34, Display manager: GDM 42.0
Inxi -Aa:Audio: Device-1: Intel Tiger Lake-H HD Audio vendor: Lenovo driver: sof-audio-pci-intel-tgl alternate: snd_hda_intel,snd_sof_pci_intel_tgl bus-ID: 00:1f.3 chip-ID: 8086:43c8 class-ID: 0401 Sound Server-1: ALSA v: k5.18.10-1-MANJARO running: yes Sound Server-2: PulseAudio v: 16.1 running: no Sound Server-3: PipeWire v: 0.3.54 running: yes-
Unfortunately I just got what at first glance looks like the same crash even with the patch applied. I have just in case re-built WirePlumber again this time making sure that Portage has applied the patch, and will try again but it's probably going to behave in the same way.
Here's the latest crash (looks the same to me): gdm_wp_coreump.txt
Also as I was going over coredumpctl list I noticed that the same crash has occasionally happened for my user but I never realized that until know.
-
@HougeLangley I still can't figure out why it segfaults. For me it never crashes (I am on archlinux too).
How often does the segfault happen? Also, what do you exactly do when it happens? You just boot the computer?
It happens here also with default Arch kernel 5.18.10-arch1-1 Downgrading wireplumber 0.4.11-1 -> 0.4.10-3 stops the coredumps.
PS Also for me it happens every boot:
Jul 12 11:46:58 rakete wireplumber[4817]: invalid cast from 'WpDbus' to 'WpTransition' Jul 12 11:46:58 rakete kernel: wireplumber[4817]: segfault at 28 ip 00007ff1c51b5f11 sp 00007fff87d01070 error 6 in libwirepl> Jul 12 11:46:58 rakete kernel: Code: c6 ff 15 f2 09 05 00 48 89 c7 49 89 c5 ff 15 fe fd 04 00 48 c7 45 d0 00 00 00 00 4c 89 e> Jul 12 11:46:58 rakete wireplumber[4817]: wp_transition_get_source_object: assertion 'WP_IS_TRANSITION (self)' failed Jul 12 11:46:58 rakete systemd[4651]: Stopped PipeWire PulseAudio. Jul 12 11:46:58 rakete systemd[4651]: Stopping Multimedia Service Session Manager... Jul 12 11:46:59 rakete systemd[1]: Created slice Slice /system/systemd-coredump. Jul 12 11:46:59 rakete systemd[1]: Started Process Core Dump (PID 8762/UID 0). Jul 12 11:46:59 rakete systemd-coredump[8764]: [🡕] Process 4817 (wireplumber) of user 120 dumped core. Jul 12 11:46:59 rakete systemd[1]: systemd-coredump@0-8762-0.service: Deactivated successfully.Edited by mabod
-
From what I recall it was somewhere in the commit 91837873 to commit 46e7c5c1 range that was introduced i.e. as soon as WpDbus started to be used. It's of course worth double checking but I doubt it will be useful for fixing this as a feature being broken from introduction is equal to saying that the water is wet.
46e7c5c1 is the first bad commit
I believe it is worth to mention that it only happens once during boot resp. shortly after login. If I am fast enough during login (gdm, gnome) I can open a terminal in gnome and see the crash happen with a "journalctl -f".
A stop/restart of the wireplumber service does not crash it.
Status after login:
● wireplumber.service - Multimedia Service Session Manager Loaded: loaded (/usr/lib/systemd/user/wireplumber.service; enabled; vendor preset: enabled) Active: active (running) since Tue 2022-07-12 15:10:33 CEST; 3min 29s ago Main PID: 5517 (wireplumber) Tasks: 4 (limit: 77038) Memory: 8.8M CPU: 264ms CGroup: /user.slice/user-1000.slice/user@1000.service/session.slice/wireplumber.service └─5517 /usr/bin/wireplumber Jul 12 15:10:33 rakete systemd[5500]: Started Multimedia Service Session Manager. Jul 12 15:10:33 rakete wireplumber[5517]: Failed to set scheduler settings: Die Operation ist nicht erlaubt Jul 12 15:10:33 rakete wireplumber[5517]: SPA handle 'api.libcamera.enum.manager' could not be loaded; is it installed? Jul 12 15:10:33 rakete wireplumber[5517]: PipeWire's libcamera SPA missing or broken. libcamera not supported. Jul 12 15:10:33 rakete wireplumber[5517]: reserve-device plugin is not connected to D-Bus, disabling device reservation Jul 12 15:10:34 rakete wireplumber[5517]: <WpSiAudioAdapter:0x5581355ad080> Object activation aborted: proxy destroyed Jul 12 15:10:34 rakete wireplumber[5517]: <WpSiAudioAdapter:0x5581355ad080> failed to activate item: Object activation aborte> Jul 12 15:10:46 rakete systemd-coredump[8914]: [🡕] Process 5005 (wireplumber) of user 120 dumped core.Status after stopping the service:
# systemctl stop --user wireplumber.service # systemctl status --user wireplumber.service ○ wireplumber.service - Multimedia Service Session Manager Loaded: loaded (/usr/lib/systemd/user/wireplumber.service; enabled; vendor preset: enabled) Active: inactive (dead) since Tue 2022-07-12 15:14:25 CEST; 7s ago Duration: 3min 51.815s Process: 5517 ExecStart=/usr/bin/wireplumber (code=exited, status=0/SUCCESS) Main PID: 5517 (code=exited, status=0/SUCCESS) CPU: 272ms Jul 12 15:10:33 rakete wireplumber[5517]: SPA handle 'api.libcamera.enum.manager' could not be loaded; is it installed? Jul 12 15:10:33 rakete wireplumber[5517]: PipeWire's libcamera SPA missing or broken. libcamera not supported. Jul 12 15:10:33 rakete wireplumber[5517]: reserve-device plugin is not connected to D-Bus, disabling device reservation Jul 12 15:10:34 rakete wireplumber[5517]: <WpSiAudioAdapter:0x5581355ad080> Object activation aborted: proxy destroyed Jul 12 15:10:34 rakete wireplumber[5517]: <WpSiAudioAdapter:0x5581355ad080> failed to activate item: Object activation aborte> Jul 12 15:10:46 rakete systemd-coredump[8914]: [🡕] Process 5005 (wireplumber) of user 120 dumped core. Jul 12 15:14:25 rakete wireplumber[5517]: stopped by signal: Beendet Jul 12 15:14:25 rakete systemd[5500]: Stopping Multimedia Service Session Manager... Jul 12 15:14:25 rakete wireplumber[5517]: disconnected from pipewire Jul 12 15:14:25 rakete systemd[5500]: Stopped Multimedia Service Session Manager.Status after restart of the service:
# systemctl start --user wireplumber # systemctl status --user wireplumber.service ● wireplumber.service - Multimedia Service Session Manager Loaded: loaded (/usr/lib/systemd/user/wireplumber.service; enabled; vendor preset: enabled) Active: active (running) since Tue 2022-07-12 15:14:49 CEST; 11s ago Main PID: 12594 (wireplumber) Tasks: 5 (limit: 77038) Memory: 9.0M CPU: 318ms CGroup: /user.slice/user-1000.slice/user@1000.service/session.slice/wireplumber.service └─12594 /usr/bin/wireplumber Jul 12 15:14:49 rakete systemd[5500]: Started Multimedia Service Session Manager. Jul 12 15:14:49 rakete wireplumber[12594]: Failed to set scheduler settings: Die Operation ist nicht erlaubt Jul 12 15:14:49 rakete wireplumber[12594]: reserve-device plugin is not connected to D-Bus, disabling device reservation Jul 12 15:14:49 rakete wireplumber[12594]: SPA handle 'api.libcamera.enum.manager' could not be loaded; is it installed? Jul 12 15:14:50 rakete wireplumber[12594]: <WpSiAudioAdapter:0x562681f36040> Object activation aborted: proxy destroyed Jul 12 15:14:50 rakete wireplumber[12594]: <WpSiAudioAdapter:0x562681f36040> failed to activate item: Object activation abort>But only one core dump:
# journalctl -b | grep "dumped core" Jul 12 15:10:46 rakete systemd-coredump[8914]: Process 5005 (wireplumber) of user 120 dumped core.The restart does not show a coredump.
Edited by mabod-
@HougeLangley I think this should fix the problem: https://gitlab.freedesktop.org/julian/wireplumber/-/commits/dbus-alsa-monitor
No, it does not fix it for me. I downloaded the patch and added it to the PKGBUILD of wireplumber in ARCH.
prepare() { cd $pkgbase # Fix sound inside VM git cherry-pick -n c16e637c329bc9dda8544b18f5bd47a8d63ee253 patch -Np1 < ../0282627c85387de7af40566cb3a31ad0300876f2.patch }During the next boot wireplumber dumps core again.
Edited by mabodadded priority::high label
