Skip to content

[regression] disconnect/connect HDMI cable leads to no sound and some kind of wayfire reload #205

New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom
Open
qrp73 opened this issue Feb 3, 2024 · 5 comments
Open

[regression] disconnect/connect HDMI cable leads to no sound and some kind of wayfire reload #205

qrp73 opened this issue Feb 3, 2024 · 5 comments

Comments

@qrp73
Copy link

qrp73 commented Feb 3, 2024 •
edited
Loading

Steps to reproduce:

  1. Connect USB sound card
  2. Open VLC player and start playing some music
  3. Disconnect HDMI cable and connect it again

Expected result: music should continue play even with no display and after reconnecting HDMI all should works as before, the music play should continue

Actual result: the sound immediately stops when HDMI cable is disconnected and didn't restored even after HDMI cable reconnected again. The apps which playing sounds cannot play sound anymore until app restart

In addition there some weird update of taskbar and background image, probably wayfire restart or something like that...

The sound works after reconnecting HDMI cable, but only for newly opened apps, for apps which continue to run it stops with no way to resume and requires restart the application in order to fix no sound issue.

The same issue with apps which playing sound through OpenAL.

Previously there was no such issue, all worked ok. This is regression issue. It starts to happens with some apt update, but I cannot say exactly how long ago it starts to happens, probably about week or one-two month ago...

Probably it caused with some fix for app close & logout issue which happened sometimes during HDMI cable reconnect.
@spl237
Copy link

spl237 commented Feb 6, 2024

Try using the Advanced Options menu in raspi-config to switch the audio system to pulseaudio instead of pipewire - does that make a difference?

@popcornmix
Copy link

I could reproduce this. Switching to pulseaudio does not have the issue (so may be a temporary workaround).
I could also observe this with a bluetooth device.

Looks like wireplumber (and then pipewire) is "stopped by signal" (not sure if this a crash, or deliberate shutdown based on the hdmi audio device disappearing).

Feb 06 15:04:12 pi5 wireplumber[1317]: stopped by signal: Terminated
Feb 06 15:04:12 pi5 systemd[823]: Stopping wireplumber.service -
Multimedia Service Session Manager...
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/ldac
Feb 06 15:04:12 pi5 wireplumber[1317]: disconnected from pipewire
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSink/aptx_hd
Feb 06 15:04:12 pi5 systemd[823]: Stopped wireplumber.service -
Multimedia Service Session Manager.
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/aptx_hd
Feb 06 15:04:12 pi5 systemd[823]: Stopping pipewire.service - PipeWire
Multimedia Service...
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSink/aptx
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/aptx
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSink/sbc
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/sbc
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSink/sbc_xq
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/sbc_xq
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/aptx_ll_1
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/aptx_ll_0
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/aptx_ll_duplex_1
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/aptx_ll_duplex_0
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/faststream
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/faststream_duplex
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSink/opus_05
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/opus_05
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSink/opus_05_duplex
Feb 06 15:04:12 pi5 bluetoothd[712]: Endpoint unregistered:
sender=:1.41 path=/MediaEndpoint/A2DPSource/opus_05_duplex
Feb 06 15:04:12 pi5 xdg-desktop-por[1095]: Caught PipeWire error:
connection error
Feb 06 15:04:12 pi5 xdg-desktop-portal-wlr[1340]: 2024/02/06 15:04:12
[ERROR] - pipewire: fatal error event from core
Feb 06 15:04:12 pi5 systemd[823]: Stopped pipewire.service - PipeWire
Multimedia Service.
Feb 06 15:04:12 pi5 systemd[823]: xdg-desktop-portal-wlr.service: Main
process exited, code=exited, status=1/FAILURE
Feb 06 15:04:12 pi5 systemd[823]: xdg-desktop-portal-wlr.service:
Failed with result 'exit-code'.

@qrp73
Copy link
Author

qrp73 commented Feb 10, 2024 •
edited
Loading

Try using the Advanced Options menu in raspi-config to switch the audio system to pulseaudio instead of pipewire - does that make a difference?

yes, when I switch to pulseaudio there is no such issue, but I need better control on sound card sample rate from user app to avoid unwanted resampling. In pipewire I just put all supported sample rate into /usr/share/pipewire/pipewire.conf as default.clock.allowed-rates = [ 44100, 48000, 96000, 192000, 384000 ] and it automatically switch sound card sample rate according to requested sample rate from app. For example If app requests 384 kHz, it switch sound card to 384 kHz, so there is no resampling with it's unwanted artifacts.

With pulseaudio I don't know how to achieve that. The only way that I find is to setup hardcoded sample rate in /etc/pulse/daemon.conf. But since I'm using different sample rate, it requires to reconfigure pulseaudio each time when I need to change sample rate in app...

Could you please fix pipewire service?

PS: also I found that pulseaudio has higher max sound volume, so it seems that something is wrong with sound volume when using pipeware service...

@spl237
Copy link

spl237 commented Feb 10, 2024 •
edited
Loading

Could you please fix pipewire service?

We're trying to - the problem is unfortunately not trivial.

@qrp73 qrp73 mentioned this issue Feb 16, 2024
Closed
@mghadam mghadam mentioned this issue Feb 16, 2024
Closed
@apassu
Copy link

apassu commented Feb 19, 2024

I have a very similar problem with quite the same logs.
I have a RPI 4 with an external HDMI monitor (with Alexa builts in the monitor) and when Alexa activates itself there is a crash of pipewire/wireplumber.

SYSTEMS INFO:

Raspberry PI 4
Raspbian 12 (bookworm)
Linux rpi 6.1.0-rpi8-rpi-v8 raspberrypi/linux#1 SMP PREEMPT Debian 1:6.1.73-1+rpt1 (2024-01-25) aarch64 GNU/Linux
HDMI Monitor Samsung Smart Monitor M7 43" (with Alexa built in)
raspi-config -> 6 Advanced Options -> A7 Audio Config -> 2 Pipewire

Steps to reproduce the behaviour
The monitor has Alexa built in and when it activates itself there is a crash of pipewire/wireplumber.

LOGS:

2024-02-14T14:13:51.581663+01:00 rpi sh[4488]: Warning: ../src/main.c: 319: Selected output HDMI-A-1 went away
2024-02-14T14:13:51.585451+01:00 rpi sh[4488]: Warning: ../src/main.c: 330: No fallback outputs left. Detaching...
2024-02-14T14:13:52.479597+01:00 rpi wireplumber[5848]: stopped by signal: Terminated
2024-02-14T14:13:52.485894+01:00 rpi systemd[1750]: Stopping wireplumber.service - Multimedia Service Session Manager...
2024-02-14T14:13:52.537204+01:00 rpi wireplumber[5848]: disconnected from pipewire
2024-02-14T14:13:52.574138+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/ldac
2024-02-14T14:13:52.575006+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSink/aptx_hd
2024-02-14T14:13:52.576500+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/aptx_hd
2024-02-14T14:13:52.577591+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSink/aptx
2024-02-14T14:13:52.578691+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/aptx
2024-02-14T14:13:52.580101+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSink/sbc
2024-02-14T14:13:52.581530+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/sbc
2024-02-14T14:13:52.582848+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSink/sbc_xq
2024-02-14T14:13:52.584948+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/sbc_xq
2024-02-14T14:13:52.586777+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/aptx_ll_1
2024-02-14T14:13:52.588349+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/aptx_ll_0
2024-02-14T14:13:52.589798+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/aptx_ll_duplex_1
2024-02-14T14:13:52.591290+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/aptx_ll_duplex_0
2024-02-14T14:13:52.594042+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/faststream
2024-02-14T14:13:52.596998+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/faststream_duplex
2024-02-14T14:13:52.600100+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSink/opus_05
2024-02-14T14:13:52.601406+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/opus_05
2024-02-14T14:13:52.603212+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSink/opus_05_duplex
2024-02-14T14:13:52.603778+01:00 rpi systemd[1750]: Stopped wireplumber.service - Multimedia Service Session Manager.
2024-02-14T14:13:52.604164+01:00 rpi systemd[1750]: wireplumber.service: Consumed 1.551s CPU time.
2024-02-14T14:13:52.605368+01:00 rpi bluetoothd[911]: Endpoint unregistered: sender=:1.92 path=/MediaEndpoint/A2DPSource/opus_05_duplex
2024-02-14T14:13:52.609849+01:00 rpi systemd[1750]: Stopping pipewire.service - PipeWire Multimedia Service...
2024-02-14T14:13:52.637246+01:00 rpi xdg-desktop-portal-wlr[5866]: 2024/02/14 14:13:52 [ERROR] - pipewire: fatal error event from core
2024-02-14T14:13:52.638465+01:00 rpi xdg-desktop-por[2270]: Caught PipeWire error: connection error
2024-02-14T14:13:52.651400+01:00 rpi systemd[1750]: Stopped pipewire.service - PipeWire Multimedia Service.
2024-02-14T14:13:52.651914+01:00 rpi systemd[1750]: pipewire.service: Consumed 2.980s CPU time.
2024-02-14T14:13:52.685947+01:00 rpi systemd[1750]: Started pipewire.service - PipeWire Multimedia Service.
2024-02-14T14:13:52.692411+01:00 rpi systemd[1750]: Started wireplumber.service - Multimedia Service Session Manager.
2024-02-14T14:13:52.693201+01:00 rpi systemd[1750]: xdg-desktop-portal-wlr.service: Main process exited, code=exited, status=1/FAILURE
2024-02-14T14:13:52.693686+01:00 rpi systemd[1750]: xdg-desktop-portal-wlr.service: Failed with result 'exit-code'.
2024-02-14T14:13:52.880896+01:00 rpi systemd[1750]: xdg-desktop-portal-wlr.service: Scheduled restart job, restart counter is at 22.
2024-02-14T14:13:52.881560+01:00 rpi systemd[1750]: Stopped xdg-desktop-portal-wlr.service - Portal service (wlroots implementation).
2024-02-14T14:13:52.913039+01:00 rpi rtkit-daemon[1336]: Successfully made thread 5946 of process 5938 owned by '1000' high priority at nice level -11.
2024-02-14T14:13:52.914130+01:00 rpi rtkit-daemon[1336]: Supervising 1 threads of 1 processes of 1 users.
2024-02-14T14:13:52.914730+01:00 rpi systemd[1750]: Starting xdg-desktop-portal-wlr.service - Portal service (wlroots implementation)...
2024-02-14T14:13:52.935441+01:00 rpi sh[4488]: Warning: ../src/main.c: 319: Selected output NOOP-1 went away
2024-02-14T14:13:52.967394+01:00 rpi rtkit-daemon[1336]: Successfully made thread 5947 of process 5942 owned by '1000' high priority at nice level -11.
2024-02-14T14:13:52.968354+01:00 rpi rtkit-daemon[1336]: Supervising 2 threads of 2 processes of 1 users.
2024-02-14T14:13:52.979169+01:00 rpi xdg-desktop-portal-wlr[5958]: 2024/02/14 14:13:52 [ERROR] - xdpw: Could not find render node
2024-02-14T14:13:52.980339+01:00 rpi xdg-desktop-portal-wlr[5958]: 2024/02/14 14:13:52 [ERROR] - xdpw: Could not find render node
2024-02-14T14:13:53.017015+01:00 rpi rtkit-daemon[1336]: Successfully made thread 5950 of process 5938 owned by '1000' RT at priority 20.
2024-02-14T14:13:53.017898+01:00 rpi rtkit-daemon[1336]: Supervising 3 threads of 2 processes of 1 users.
2024-02-14T14:13:53.075491+01:00 rpi rtkit-daemon[1336]: Successfully made thread 5948 of process 5942 owned by '1000' RT at priority 20.
2024-02-14T14:13:53.076219+01:00 rpi rtkit-daemon[1336]: Supervising 4 threads of 2 processes of 1 users.
2024-02-14T14:13:53.161644+01:00 rpi systemd[1750]: Started xdg-desktop-portal-wlr.service - Portal service (wlroots implementation).
2024-02-14T14:13:53.203937+01:00 rpi kernel: [17287.577184] vc4-drm gpu: swiotlb buffer is full (sz: 524288 bytes), total 32768 (slots), used 7184 (slots)
2024-02-14T14:13:53.341349+01:00 rpi wireplumber[5942]: [4:48:07.398713203] [5942] #33[1;32m INFO #33[1;37mCamera #33[1;34mcamera_manager.cpp:284 #33[0mlibcamera v0.1.0+118-563cd78e
2024-02-14T14:13:53.347852+01:00 rpi kernel: [17287.724462] vc4-drm gpu: swiotlb buffer is full (sz: 524288 bytes), total 32768 (slots), used 7184 (slots)
2024-02-14T14:13:53.547171+01:00 rpi systemd[1750]: Stopping wireplumber.service - Multimedia Service Session Manager...
2024-02-14T14:13:54.554553+01:00 rpi wireplumber[5942]: stopped by signal: Terminated
2024-02-14T14:13:54.566114+01:00 rpi wireplumber[5942]: WpImplMetadata:0x55976ba3f0 Object activation aborted: PipeWire proxy destroyed
2024-02-14T14:13:54.569245+01:00 rpi wireplumber[5942]: failed to activate route-settings metadata: Object activation aborted: PipeWire proxy destroyed
2024-02-14T14:13:54.575536+01:00 rpi wireplumber[5942]: disconnected from pipewire
2024-02-14T14:13:54.625579+01:00 rpi systemd[1750]: Stopped wireplumber.service - Multimedia Service Session Manager.
2024-02-14T14:13:54.627562+01:00 rpi systemd[1750]: wireplumber.service: Consumed 1.398s CPU time.
2024-02-14T14:13:54.632763+01:00 rpi systemd[1750]: Stopping pipewire.service - PipeWire Multimedia Service...
2024-02-14T14:13:54.643623+01:00 rpi xdg-desktop-portal-wlr[5958]: 2024/02/14 14:13:54 [ERROR] - pipewire: fatal error event from core
2024-02-14T14:13:54.647259+01:00 rpi xdg-desktop-por[2270]: Caught PipeWire error: connection error
2024-02-14T14:13:54.662883+01:00 rpi systemd[1750]: Stopped pipewire.service - PipeWire Multimedia Service.
2024-02-14T14:13:54.715623+01:00 rpi systemd[1750]: Started pipewire.service - PipeWire Multimedia Service.
2024-02-14T14:13:54.728564+01:00 rpi systemd[1750]: Started wireplumber.service - Multimedia Service Session Manager.
2024-02-14T14:13:54.732058+01:00 rpi systemd[1750]: xdg-desktop-portal-wlr.service: Main process exited, code=exited, status=1/FAILURE
2024-02-14T14:13:54.733715+01:00 rpi systemd[1750]: xdg-desktop-portal-wlr.service: Failed with result 'exit-code'.
2024-02-14T14:13:54.882785+01:00 rpi systemd[1750]: xdg-desktop-portal-wlr.service: Scheduled restart job, restart counter is at 23.
2024-02-14T14:13:54.885922+01:00 rpi systemd[1750]: Stopped xdg-desktop-portal-wlr.service - Portal service (wlroots implementation).
2024-02-14T14:13:54.931824+01:00 rpi systemd[1750]: Starting xdg-desktop-portal-wlr.service - Portal service (wlroots implementation)...
2024-02-14T14:13:54.940390+01:00 rpi rtkit-daemon[1336]: Successfully made thread 5987 of process 5981 owned by '1000' high priority at nice level -11.
2024-02-14T14:13:54.941011+01:00 rpi rtkit-daemon[1336]: Supervising 1 threads of 1 processes of 1 users.
2024-02-14T14:13:55.023238+01:00 rpi rtkit-daemon[1336]: Successfully made thread 5986 of process 5976 owned by '1000' high priority at nice level -11.
2024-02-14T14:13:55.024609+01:00 rpi rtkit-daemon[1336]: Supervising 2 threads of 2 processes of 1 users.
2024-02-14T14:13:55.034922+01:00 rpi xdg-desktop-portal-wlr[6000]: 2024/02/14 14:13:55 [ERROR] - xdpw: Could not find render node
2024-02-14T14:13:55.036145+01:00 rpi xdg-desktop-portal-wlr[6000]: 2024/02/14 14:13:55 [ERROR] - xdpw: Could not find render node
2024-02-14T14:13:55.108915+01:00 rpi rtkit-daemon[1336]: Successfully made thread 5988 of process 5981 owned by '1000' RT at priority 20.
2024-02-14T14:13:55.110125+01:00 rpi rtkit-daemon[1336]: Supervising 3 threads of 2 processes of 1 users.
2024-02-14T14:13:55.204189+01:00 rpi rtkit-daemon[1336]: Successfully made thread 5989 of process 5976 owned by '1000' RT at priority 20.
2024-02-14T14:13:55.205438+01:00 rpi rtkit-daemon[1336]: Supervising 4 threads of 2 processes of 1 users.
2024-02-14T14:13:55.261598+01:00 rpi systemd[1750]: Started xdg-desktop-portal-wlr.service - Portal service (wlroots implementation).
2024-02-14T14:13:55.485171+01:00 rpi wireplumber[5981]: [4:48:09.544493784] [5981] #33[1;32m INFO #33[1;37mCamera #33[1;34mcamera_manager.cpp:284 #33[0mlibcamera v0.1.0+118-563cd78e
2024-02-14T14:13:56.465094+01:00 rpi wireplumber[5981]: Trying to use legacy bluez5 API for LE Audio - only A2DP will be supported. Please upgrade bluez5.
2024-02-14T14:13:56.500484+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/ldac
2024-02-14T14:13:56.501811+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSink/aptx_hd
2024-02-14T14:13:56.502440+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/aptx_hd
2024-02-14T14:13:56.503315+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSink/aptx
2024-02-14T14:13:56.504046+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/aptx
2024-02-14T14:13:56.506558+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSink/sbc
2024-02-14T14:13:56.507318+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/sbc
2024-02-14T14:13:56.507910+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSink/sbc_xq
2024-02-14T14:13:56.508415+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/sbc_xq
2024-02-14T14:13:56.508892+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/aptx_ll_1
2024-02-14T14:13:56.509357+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/aptx_ll_0
2024-02-14T14:13:56.509850+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/aptx_ll_duplex_1
2024-02-14T14:13:56.510521+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/aptx_ll_duplex_0
2024-02-14T14:13:56.510963+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/faststream
2024-02-14T14:13:56.511445+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/faststream_duplex
2024-02-14T14:13:56.515440+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSink/opus_05
2024-02-14T14:13:56.516684+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/opus_05
2024-02-14T14:13:56.517647+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSink/opus_05_duplex
2024-02-14T14:13:56.518481+01:00 rpi bluetoothd[911]: Endpoint registered: sender=:1.94 path=/MediaEndpoint/A2DPSource/opus_05_duplex
2024-02-14T14:13:56.522852+01:00 rpi wireplumber[5981]: WpPortalPermissionStorePlugin:0x55948fa8d0 Failed to call Lookup: GDBus.Error:org.freedesktop.portal.Error.NotFound: No entry for camera
2024-02-14T14:13:56.587168+01:00 rpi pipewire[5976]: spa.v4l2: '/dev/video14' VIDIOC_ENUM_FRAMEINTERVALS: Inappropriate ioctl for device
2024-02-14T14:13:56.587832+01:00 rpi pipewire[5976]: spa.v4l2: '/dev/video15' VIDIOC_ENUM_FRAMEINTERVALS: Inappropriate ioctl for device
2024-02-14T14:13:56.588360+01:00 rpi pipewire[5976]: spa.v4l2: '/dev/video21' VIDIOC_ENUM_FRAMEINTERVALS: Inappropriate ioctl for device
2024-02-14T14:13:56.588743+01:00 rpi pipewire[5976]: spa.v4l2: '/dev/video22' VIDIOC_ENUM_FRAMEINTERVALS: Inappropriate ioctl for device
2024-02-14T14:13:56.674206+01:00 rpi pipewire[5976]: spa.v4l2: '/dev/video14' VIDIOC_ENUM_FRAMEINTERVALS: Inappropriate ioctl for device
2024-02-14T14:13:56.674863+01:00 rpi pipewire[5976]: spa.v4l2: '/dev/video15' VIDIOC_ENUM_FRAMEINTERVALS: Inappropriate ioctl for device
2024-02-14T14:13:56.675387+01:00 rpi pipewire[5976]: spa.v4l2: '/dev/video21' VIDIOC_ENUM_FRAMEINTERVALS: Inappropriate ioctl for device
2024-02-14T14:13:56.675888+01:00 rpi pipewire[5976]: spa.v4l2: '/dev/video22' VIDIOC_ENUM_FRAMEINTERVALS: Inappropriate ioctl for device
2024-02-14T14:13:56.708663+01:00 rpi wireplumber[5981]: WpPortalPermissionStorePlugin:0x55948fa8d0 Failed to call Lookup: GDBus.Error:org.freedesktop.portal.Error.NotFound: No entry for camera
2024-02-14T14:13:56.723855+01:00 rpi wireplumber[5981]: WpPortalPermissionStorePlugin:0x55948fa8d0 Failed to call Lookup: GDBus.Error:org.freedesktop.portal.Error.NotFound: No entry for camera
2024-02-14T14:13:56.734403+01:00 rpi wireplumber[5981]: WpPortalPermissionStorePlugin:0x55948fa8d0 Failed to call Lookup: GDBus.Error:org.freedesktop.portal.Error.NotFound: No entry for camera
2024-02-14T14:13:56.742703+01:00 rpi wireplumber[5981]: WpPortalPermissionStorePlugin:0x55948fa8d0 Failed to call Lookup: GDBus.Error:org.freedesktop.portal.Error.NotFound: No entry for camera
2024-02-14T14:14:02.708043+01:00 rpi bluetoothd[911]: src/profile.c:record_cb() Unable to get Hands-Free Voice gateway SDP record: Host is down

After i switched to:
raspi-config -> 6 Advanced Options -> A7 Audio Config -> 1 Pulse Audio

and when Alexa activated itself the logs were:

2024-02-19T21:48:45.120582+01:00 rpi sh[929]: Warning: ../src/main.c: 319: Selected output HDMI-A-1 went away
2024-02-19T21:48:45.121308+01:00 rpi sh[929]: Warning: ../src/main.c: 330: No fallback outputs left. Detaching...
2024-02-19T21:48:46.143632+01:00 rpi xdg-desktop-por[2652]: Caught PipeWire error: connection error
2024-02-19T21:48:46.146523+01:00 rpi systemd[1711]: Stopping pipewire.service - PipeWire Multimedia Service...
2024-02-19T21:48:46.153722+01:00 rpi systemd[1711]: Stopped pipewire.service - PipeWire Multimedia Service.
2024-02-19T21:48:46.155775+01:00 rpi xdg-desktop-portal-wlr[4100]: 2024/02/19 21:48:46 [ERROR] - pipewire: fatal error event from core
2024-02-19T21:48:46.192619+01:00 rpi systemd[1711]: Started pipewire.service - PipeWire Multimedia Service.
2024-02-19T21:48:46.194721+01:00 rpi systemd[1711]: xdg-desktop-portal-wlr.service: Main process exited, code=exited, status=1/FAILURE
2024-02-19T21:48:46.195500+01:00 rpi systemd[1711]: xdg-desktop-portal-wlr.service: Failed with result 'exit-code'.
2024-02-19T21:48:46.385439+01:00 rpi rtkit-daemon[1306]: Successfully made thread 4220 of process 4213 owned by '1000' high priority at nice level -11.
2024-02-19T21:48:46.386258+01:00 rpi rtkit-daemon[1306]: Supervising 1 threads of 1 processes of 1 users.
2024-02-19T21:48:46.434303+01:00 rpi rtkit-daemon[1306]: Successfully made thread 4221 of process 4213 owned by '1000' RT at priority 20.
2024-02-19T21:48:46.434535+01:00 rpi rtkit-daemon[1306]: Supervising 2 threads of 1 processes of 1 users.
2024-02-19T21:48:46.507804+01:00 rpi systemd[1711]: xdg-desktop-portal-wlr.service: Scheduled restart job, restart counter is at 4.
2024-02-19T21:48:46.508379+01:00 rpi systemd[1711]: Stopped xdg-desktop-portal-wlr.service - Portal service (wlroots implementation).
2024-02-19T21:48:46.537332+01:00 rpi sh[929]: Warning: ../src/main.c: 319: Selected output NOOP-1 went away
2024-02-19T21:48:46.539068+01:00 rpi systemd[1711]: Starting xdg-desktop-portal-wlr.service - Portal service (wlroots implementation)...
2024-02-19T21:48:46.595887+01:00 rpi xdg-desktop-portal-wlr[4235]: 2024/02/19 21:48:46 [ERROR] - xdpw: Could not find render node
2024-02-19T21:48:46.596931+01:00 rpi xdg-desktop-portal-wlr[4235]: 2024/02/19 21:48:46 [ERROR] - xdpw: Could not find render node
2024-02-19T21:48:46.742459+01:00 rpi systemd[1711]: Started xdg-desktop-portal-wlr.service - Portal service (wlroots implementation).
2024-02-19T21:48:46.768262+01:00 rpi kernel: [ 569.860018] swiotlb_tbl_map_single: 8 callbacks suppressed
2024-02-19T21:48:46.768314+01:00 rpi kernel: [ 569.860040] vc4-drm gpu: swiotlb buffer is full (sz: 524288 bytes), total 32768 (slots), used 378 (slots)
2024-02-19T21:48:46.832275+01:00 rpi kernel: [ 569.920288] vc4-drm gpu: swiotlb buffer is full (sz: 524288 bytes), total 32768 (slots), used 336 (slots)
2024-02-19T21:48:46.884318+01:00 rpi kernel: [ 569.974447] vc4-drm gpu: swiotlb buffer is full (sz: 524288 bytes), total 32768 (slots), used 920 (slots)
2024-02-19T21:48:47.108221+01:00 rpi kernel: [ 570.199867] vc4-drm gpu: swiotlb buffer is full (sz: 524288 bytes), total 32768 (slots), used 378 (slots)
2024-02-19T21:48:47.156548+01:00 rpi systemd[1711]: Stopping pipewire.service - PipeWire Multimedia Service...
2024-02-19T21:48:47.159269+01:00 rpi xdg-desktop-por[2652]: Caught PipeWire error: connection error
2024-02-19T21:48:47.160818+01:00 rpi xdg-desktop-portal-wlr[4235]: 2024/02/19 21:48:47 [ERROR] - pipewire: fatal error event from core
2024-02-19T21:48:47.175348+01:00 rpi systemd[1711]: Stopped pipewire.service - PipeWire Multimedia Service.
2024-02-19T21:48:47.192341+01:00 rpi kernel: [ 570.280900] vc4-drm gpu: swiotlb buffer is full (sz: 524288 bytes), total 32768 (slots), used 336 (slots)
2024-02-19T21:48:47.202429+01:00 rpi systemd[1711]: Started pipewire.service - PipeWire Multimedia Service.
2024-02-19T21:48:47.205426+01:00 rpi systemd[1711]: xdg-desktop-portal-wlr.service: Main process exited, code=exited, status=1/FAILURE
2024-02-19T21:48:47.206341+01:00 rpi systemd[1711]: xdg-desktop-portal-wlr.service: Failed with result 'exit-code'.
2024-02-19T21:48:47.341622+01:00 rpi rtkit-daemon[1306]: Successfully made thread 4248 of process 4242 owned by '1000' high priority at nice level -11.
2024-02-19T21:48:47.341994+01:00 rpi rtkit-daemon[1306]: Supervising 1 threads of 1 processes of 1 users.
2024-02-19T21:48:47.378992+01:00 rpi rtkit-daemon[1306]: Successfully made thread 4249 of process 4242 owned by '1000' RT at priority 20.
2024-02-19T21:48:47.379277+01:00 rpi rtkit-daemon[1306]: Supervising 2 threads of 1 processes of 1 users.
2024-02-19T21:48:47.436232+01:00 rpi kernel: [ 570.526019] vc4-drm gpu: swiotlb buffer is full (sz: 524288 bytes), total 32768 (slots), used 920 (slots)
2024-02-19T21:48:47.507775+01:00 rpi systemd[1711]: xdg-desktop-portal-wlr.service: Scheduled restart job, restart counter is at 5.
2024-02-19T21:48:47.508412+01:00 rpi systemd[1711]: Stopped xdg-desktop-portal-wlr.service - Portal service (wlroots implementation).
2024-02-19T21:48:47.537987+01:00 rpi systemd[1711]: Starting xdg-desktop-portal-wlr.service - Portal service (wlroots implementation)...
2024-02-19T21:48:47.614274+01:00 rpi xdg-desktop-portal-wlr[4260]: 2024/02/19 21:48:47 [ERROR] - xdpw: Could not find render node
2024-02-19T21:48:47.616248+01:00 rpi xdg-desktop-portal-wlr[4260]: 2024/02/19 21:48:47 [ERROR] - xdpw: Could not find render node
2024-02-19T21:48:47.723053+01:00 rpi systemd[1711]: Started xdg-desktop-portal-wlr.service - Portal service (wlroots implementation).

I noticed that, even if I switched to Pulse Audio, the pipewire service is enabled and active:

$ systemctl list-units --user | grep wire
pipewire.service loaded active running PipeWire Multimedia Service
pipewire.socket loaded active running PipeWire Multimedia System Socket

@popcornmix popcornmix mentioned this issue Feb 22, 2024
Closed
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@popcornmix @spl237 @apassu @qrp73