Trixie, problem with audio
Hi, I've got two thinkpads T14 gen 2 laptops.
One runs bookworm and the other trixie. The bookworm runs great.
On trixie I've noticed some errors in journal "pipewire[1763]:
spa.alsa: hw:sofhdadspp: (750 suppressed) snd_pcm_avail after recover:
Broken pipe"
It does help if I restart like "systemctl --user restart
pipewire.service" after login, post GDM.
In GDM the audio always work but after login it gets broken (tried with
new user and also reinstalled trixie).
Here are some lines from journalctl:
aug 11 19:47:04 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:04 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:05 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:05 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:05 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:05 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:05 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:05 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:05 magnus-D13 PackageKit[1267]: uid 1000 is trying to
obtain org.freedesktop.packagekit.system-sources-refresh auth
(only_trusted:0)
aug 11 19:47:05 magnus-D13 PackageKit[1267]: uid 1000 obtained auth for
org.freedesktop.packagekit.system-sources-refresh
aug 11 19:47:06 magnus-D13 PackageKit[1267]: refresh-cache transaction
/817_ccaebceb from uid 1000 finished with success after 623ms
aug 11 19:47:06 magnus-D13 kernel: ACPI BIOS Error (bug): Could not
resolve symbol [\_SB.PC00.RP09.PEGP.DDNT], AE_NOT_FOUND
(20240827/psargs-332)
aug 11 19:47:06 magnus-D13 kernel: ACPI Error: Aborting method
\_SB.PC00.LPCB.EC.SEN4._TMP due to previous error (AE_NOT_FOUND)
(20240827/psparse-529)
aug 11 19:47:06 magnus-D13 firefox-esr.desktop[3358]: libva info: VA-
API version 1.22.0
aug 11 19:47:06 magnus-D13 firefox-esr.desktop[3358]: libva info:
Trying to open /usr/lib/x86_64-linux-gnu/dri/iHD_drv_video.so
aug 11 19:47:06 magnus-D13 firefox-esr.desktop[3358]: libva info: Found
init function __vaDriverInit_1_22
aug 11 19:47:06 magnus-D13 firefox-esr.desktop[3358]: libva info:
va_openDriver() returns 0
aug 11 19:47:07 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:07 magnus-D13 rtkit-daemon[1141]: Supervising 16 threads
of 10 processes of 2 users.
aug 11 19:47:08 magnus-D13 gnome-software[2116]: Only 0 apps for
curated list, hiding
aug 11 19:47:08 magnus-D13 PackageKit[1267]: resolve transaction
/818_edecacaa from uid 1000 finished with success after 835ms
aug 11 19:47:09 magnus-D13 PackageKit[1267]: resolve transaction
/819_aaeaaaec from uid 1000 finished with success after 212ms
aug 11 19:47:09 magnus-D13 PackageKit[1267]: resolve transaction
/820_abebcbba from uid 1000 finished with success after 205ms
aug 11 19:47:09 magnus-D13 PackageKit[1267]: resolve transaction
/821_acaecdeb from uid 1000 finished with success after 201ms
aug 11 19:47:09 magnus-D13 PackageKit[1267]: resolve transaction
/822_adeeadcb from uid 1000 finished with success after 209ms
aug 11 19:47:10 magnus-D13 PackageKit[1267]: resolve transaction
/823_ebdecdaa from uid 1000 finished with success after 217ms
aug 11 19:47:10 magnus-D13 PackageKit[1267]: resolve transaction
/824_ebdddeda from uid 1000 finished with success after 189ms
aug 11 19:47:10 magnus-D13 PackageKit[1267]: resolve transaction
/825_acdddcdb from uid 1000 finished with success after 210ms
aug 11 19:47:10 magnus-D13 PackageKit[1267]: resolve transaction
/826_ecbaaeac from uid 1000 finished with success after 201ms
aug 11 19:47:10 magnus-D13 PackageKit[1267]: resolve transaction
/827_abdebeec from uid 1000 finished with success after 217ms
aug 11 19:47:11 magnus-D13 PackageKit[1267]: get-updates transaction
/828_dbcecdcc from uid 1000 finished with success after 438ms
aug 11 19:47:11 magnus-D13 PackageKit[1267]: resolve transaction
/829_aeeeeaad from uid 1000 finished with success after 207ms
aug 11 19:47:11 magnus-D13 PackageKit[1267]: get-updates transaction
/830_cceacddb from uid 1000 finished with success after 347ms
aug 11 19:47:13 magnus-D13 systemd[1]: Stopping user@112.service - User
Manager for UID 112...
aug 11 19:47:13 magnus-D13 systemd[1103]: Activating special unit
exit.target...
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped target default.target
- Main User Target.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping filter-chain.service
- PipeWire filter chain daemon...
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping gnome-keyring-
daemon.service - GNOME Keyring daemon...
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping pipewire-
pulse.service - PipeWire PulseAudio...
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping xdg-permission-
store.service - sandboxed app permission store...
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped filter-chain.service
- PipeWire filter chain daemon.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped xdg-permission-
store.service - sandboxed app permission store.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped gnome-keyring-
daemon.service - GNOME Keyring daemon.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped pipewire-
pulse.service - PipeWire PulseAudio.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping dbus.service - D-Bus
User Message Bus...
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping wireplumber.service
- Multimedia Service Session Manager...
aug 11 19:47:13 magnus-D13 wireplumber[1129]: wireplumber: stopped by
signal: Terminated
aug 11 19:47:13 magnus-D13 wireplumber[1129]: m-dbus-connection:
<WpDBusConnection:0x55bf09668970> DBus connection closed: Underlying
GIOStream returned 0 bytes on an async read
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped dbus.service - D-Bus
User Message Bus.
aug 11 19:47:13 magnus-D13 wireplumber[1129]: m-dbus-connection:
<WpDBusConnection:0x55bf09668970> Trying to reconnect after core sync
aug 11 19:47:13 magnus-D13 wireplumber[1129]: wireplumber: disconnected
from pipewire
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped wireplumber.service -
Multimedia Service Session Manager.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping pipewire.service -
PipeWire Multimedia Service...
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped pipewire.service -
PipeWire Multimedia Service.
aug 11 19:47:13 magnus-D13 systemd[1103]: Removed slice session.slice -
User Core Session Slice.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped target basic.target -
Basic System.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped target paths.target -
Paths.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped target sockets.target
- Sockets.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopped target timers.target
- Timers.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed dbus.socket - D-Bus
User Message Bus Socket.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed dirmngr.socket - GnuPG
network certificate management daemon.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed gcr-ssh-agent.socket -
GCR ssh-agent wrapper.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed gnome-keyring-
daemon.socket - GNOME Keyring daemon.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed gpg-agent-
browser.socket - GnuPG cryptographic agent and passphrase cache (access
for web browsers).
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed gpg-agent-extra.socket
- GnuPG cryptographic agent and passphrase cache (restricted).
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping gpg-agent-ssh.socket
- GnuPG cryptographic agent (ssh-agent emulation)...
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping gpg-agent.socket -
GnuPG cryptographic agent and passphrase cache...
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed keyboxd.socket - GnuPG
public key management service.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed pipewire-pulse.socket
- PipeWire PulseAudio.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed pipewire.socket -
PipeWire Multimedia System Sockets.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed pk-debconf-
helper.socket - debconf communication socket.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed speech-
dispatcher.socket - Speech Dispatcher Socket.
aug 11 19:47:13 magnus-D13 systemd[1103]: Stopping ssh-agent.socket -
OpenSSH Agent socket...
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed gpg-agent-ssh.socket -
GnuPG cryptographic agent (ssh-agent emulation).
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed gpg-agent.socket -
GnuPG cryptographic agent and passphrase cache.
aug 11 19:47:13 magnus-D13 systemd[1103]: Closed ssh-agent.socket -
OpenSSH Agent socket.
aug 11 19:47:13 magnus-D13 systemd[1103]: Removed slice app.slice -
User Application Slice.
aug 11 19:47:13 magnus-D13 systemd[1103]: Reached target
shutdown.target - Shutdown.
aug 11 19:47:13 magnus-D13 systemd[1103]: Finished systemd-exit.service
- Exit the Session.
aug 11 19:47:13 magnus-D13 systemd[1103]: Reached target exit.target -
Exit the Session.
aug 11 19:47:13 magnus-D13 (sd-pam)[1105]: pam_unix(systemd-
user:session): session closed for user Debian-gdm
aug 11 19:47:13 magnus-D13 systemd-logind[925]: Removed session 1.
aug 11 19:47:13 magnus-D13 systemd[1]: user@112.service: Deactivated
successfully.
aug 11 19:47:13 magnus-D13 systemd[1]: Stopped user@112.service - User
Manager for UID 112.
aug 11 19:47:13 magnus-D13 systemd[1]: Stopping
user-runtime-dir@112.service - User Runtime Directory /run/user/112...
aug 11 19:47:13 magnus-D13 systemd[1]: run-user-112.mount: Deactivated
successfully.
aug 11 19:47:13 magnus-D13 systemd[1]: user-runtime-dir@112.service:
Deactivated successfully.
aug 11 19:47:13 magnus-D13 systemd[1]: Stopped
user-runtime-dir@112.service - User Runtime Directory /run/user/112.
aug 11 19:47:13 magnus-D13 systemd[1]: Removed slice user-112.slice -
User Slice of UID 112.
aug 11 19:47:13 magnus-D13 systemd[1]: user-112.slice: Consumed 5.775s
CPU time, 636.4M memory peak.
aug 11 19:47:17 magnus-D13 PackageKit[1267]: get-updates transaction
/831_ccecabcd from uid 1000 finished with success after 389ms
aug 11 19:47:17 magnus-D13 PackageKit[1267]: get-details transaction
/832_cabccbdd from uid 1000 finished with success after 214ms
aug 11 19:47:17 magnus-D13 gnome-software[2116]: Only 0 apps for
curated list, hiding
aug 11 19:47:18 magnus-D13 PackageKit[1267]: resolve transaction
/833_ddeeedca from uid 1000 finished with success after 207ms
aug 11 19:47:18 magnus-D13 PackageKit[1267]: resolve transaction
/834_baabaece from uid 1000 finished with success after 226ms
aug 11 19:47:18 magnus-D13 PackageKit[1267]: resolve transaction
/835_cbaccbbb from uid 1000 finished with success after 205ms
aug 11 19:47:18 magnus-D13 PackageKit[1267]: resolve transaction
/836_dcbbaaac from uid 1000 finished with success after 196ms
aug 11 19:47:19 magnus-D13 PackageKit[1267]: resolve transaction
/837_cebedbba from uid 1000 finished with success after 212ms
aug 11 19:47:19 magnus-D13 PackageKit[1267]: resolve transaction
/838_dbbeadec from uid 1000 finished with success after 218ms
aug 11 19:47:19 magnus-D13 PackageKit[1267]: resolve transaction
/839_eedcdcdc from uid 1000 finished with success after 205ms
aug 11 19:47:19 magnus-D13 PackageKit[1267]: resolve transaction
/840_bdbbbccc from uid 1000 finished with success after 196ms
aug 11 19:47:19 magnus-D13 PackageKit[1267]: resolve transaction
/841_adbcacde from uid 1000 finished with success after 192ms
aug 11 19:47:20 magnus-D13 PackageKit[1267]: resolve transaction
/842_cdcdbbad from uid 1000 finished with success after 191ms
aug 11 19:47:20 magnus-D13 PackageKit[1267]: get-updates transaction
/843_abbbdbbb from uid 1000 finished with success after 343ms
aug 11 19:47:24 magnus-D13 geoclue[1486]: Service not used for 60
seconds. Shutting down..
aug 11 19:47:24 magnus-D13 systemd[1]: geoclue.service: Deactivated
successfully.
aug 11 19:47:25 magnus-D13 realmd[1498]: quitting realmd service after
timeout
aug 11 19:47:25 magnus-D13 realmd[1498]: stopping service
aug 11 19:47:25 magnus-D13 systemd[1]: realmd.service: Deactivated
successfully.
aug 11 19:47:29 magnus-D13 kernel: ACPI BIOS Error (bug): Could not
resolve symbol [\_SB.PC00.RP09.PEGP.DDNT], AE_NOT_FOUND
(20240827/psargs-332)
aug 11 19:47:29 magnus-D13 kernel: ACPI Error: Aborting method
\_SB.PC00.LPCB.EC.SEN4._TMP due to previous error (AE_NOT_FOUND)
(20240827/psparse-529)
aug 11 19:47:32 magnus-D13 systemd[1]: systemd-hostnamed.service:
Deactivated successfully.
aug 11 19:47:32 magnus-D13 sudo[3619]: magnus : TTY=pts/0 ;
PWD=/home/magnus ; USER=root ; COMMAND=/usr/bin/journalctl
aug 11 19:47:32 magnus-D13 sudo[3619]: pam_unix(sudo:session): session
opened for user root(uid=0) by magnus(uid=1000)
aug 11 19:47:33 magnus-D13 sudo[3619]: pam_unix(sudo:session): session
closed for user root
aug 11 19:47:33 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp: (0
suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:47:33 magnus-D13 systemd[1]: systemd-timedated.service:
Deactivated successfully.
aug 11 19:47:36 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:47:39 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:47:41 magnus-D13 systemd[1]: systemd-localed.service:
Deactivated successfully.
aug 11 19:47:42 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:47:45 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:47:48 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:47:51 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:47:54 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:47:57 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:00 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:02 magnus-D13 dbus-daemon[1762]: [session uid=1000
pid=1762 pidfd=5] Activating via systemd: service
name='org.gtk.vfs.Metadata' unit='gvfs-metadata.service' requested by
':1.33' (uid=1000 pid=1934 comm="/usr/bin/gnome-shell")
aug 11 19:48:02 magnus-D13 systemd[1739]: Starting gvfs-
metadata.service - Virtual filesystem metadata service...
aug 11 19:48:02 magnus-D13 dbus-daemon[1762]: [session uid=1000
pid=1762 pidfd=5] Successfully activated service 'org.gtk.vfs.Metadata'
aug 11 19:48:02 magnus-D13 systemd[1739]: Started gvfs-metadata.service
- Virtual filesystem metadata service.
aug 11 19:48:03 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:03 magnus-D13 kernel: ACPI BIOS Error (bug): Could not
resolve symbol [\_SB.PC00.RP09.PEGP.DDNT], AE_NOT_FOUND
(20240827/psargs-332)
aug 11 19:48:03 magnus-D13 kernel: ACPI Error: Aborting method
\_SB.PC00.LPCB.EC.SEN4._TMP due to previous error (AE_NOT_FOUND)
(20240827/psparse-529)
aug 11 19:48:06 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:09 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:12 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:15 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:18 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:21 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:24 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:27 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:30 magnus-D13 pipewire[1763]: spa.alsa: hw:sofhdadspp:
(750 suppressed) snd_pcm_avail after recover: Broken pipe
aug 11 19:48:33 magnus-D13 sudo[3682]: magnus : TTY=pts/0 ;
PWD=/home/magnus ; USER=root ; COMMAND=/usr/bin/journalctl -b0
aug 11 19:48:33 magnus-D13 sudo[3682]: pam_unix(sudo:session): session
opened for user root(uid=0) by magnus(uid=1000)
Reply to: