Skip to content
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.

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

Not able to play tracks (audio sink connection refused) #682

Open
7 tasks done
Wollert opened this issue Oct 22, 2024 · 12 comments
Open
7 tasks done

Not able to play tracks (audio sink connection refused) #682

Wollert opened this issue Oct 22, 2024 · 12 comments

Comments

@Wollert
Copy link

Wollert commented Oct 22, 2024

Compatible Device

  • I'm running Raspotify on a compatible Device

Are you sure?

  • I'm not trying to run Raspotify on a ARMv6 device

Compatible OS

  • I'm running Raspotify on a compatible OS

Compatible Configuration

  • I'm running Raspotify on a compatible Configuration

Latest Version

  • I'm running the latest version of Raspotify

Are you sure?

  • I'm not running Raspotify 0.31.8.1 on a Pi v1 or Pi Zero

Due Diligence

  • I have done my due diligence

What happened?

Clean install on a RPi 3B.

Raspotify shows up as speaker in Spotify app on phone (and in Spotify player on Windows computer), and I am able to connect to it. But I am unable to play any tracks. When I press play nothing happens. When I change tracks and press play multiple times raspotify crashes.

Relevant log output and/or the contents of /etc/raspotify/crash_report if any ( sudo journalctl -u raspotify -b and sudo cat /etc/raspotify/crash_report )

-- System Info --

Linux kurer 6.6.31+rpt-rpi-v8 #1 SMP PREEMPT Debian 1:6.6.31-1+rpt1 (2024-05-29) aarch64 GNU/Linux
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"

-- Logs --

Oct 22 12:47:01 kurer librespot[22247]: [2024-10-22T10:47:01Z WARN  librespot_core::cdn_url] Cannot parse CDN URL expiry timestamp 'verify=1729680421-hHw6CuunbdsfCCyJW%2FHUxO7zViEK0byjM3JTlCelFhE%3D' from 'https://audio-cf-del-574.spotifycdn.com/audio/5c8ed42de32a27f84170e3fd494becc01ad1d3bd?verify=1729680421-hHw6CuunbdsfCCyJW%2FHUxO7zViEK0byjM3JTlCelFhE%3D'
Oct 22 12:47:03 kurer librespot[22247]: [2024-10-22T10:47:03Z WARN  librespot_core::cdn_url] Cannot parse CDN URL expiry timestamp 'verify=1729680423-tkp%2FU5XOMZoVjtEW6Nj58zKrmhH1n3jRdnPfwqh4Kr4%3D' from 'https://audio-cf-del-574.spotifycdn.com/audio/295e84c54f406bfcb8654e4cb3159d8993115d3c?verify=1729680423-tkp%2FU5XOMZoVjtEW6Nj58zKrmhH1n3jRdnPfwqh4Kr4%3D'
Oct 22 12:47:04 kurer librespot[22247]: [2024-10-22T10:47:04Z WARN  librespot_core::cdn_url] Cannot parse CDN URL expiry timestamp 'verify=1729680424-69x0zCOUiswU5rKHpI5JPnW9W%2BqNnIFVGGSpgwdPr9M%3D' from 'https://audio-cf-del-574.spotifycdn.com/audio/984470bd039456fbebcb0e48b9eedeb55c76cce7?verify=1729680424-69x0zCOUiswU5rKHpI5JPnW9W%2BqNnIFVGGSpgwdPr9M%3D'
Oct 22 12:47:06 kurer librespot[22247]: [2024-10-22T10:47:06Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:07 kurer librespot[22247]: [2024-10-22T10:47:07Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:08 kurer librespot[22247]: [2024-10-22T10:47:08Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:10 kurer librespot[22247]: [2024-10-22T10:47:10Z WARN  librespot_core::cdn_url] Cannot parse CDN URL expiry timestamp 'verify=1729680430-%2BUHEMe8a7TvClrLQ6g9Fn1Qo2sDvdXkGgL0fub3jVw8%3D' from 'https://audio-cf-del-574.spotifycdn.com/audio/eb4235e2ecbd751a3def02b609a6b115a8b0be21?verify=1729680430-%2BUHEMe8a7TvClrLQ6g9Fn1Qo2sDvdXkGgL0fub3jVw8%3D'
Oct 22 12:47:11 kurer librespot[22247]: [2024-10-22T10:47:11Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:12 kurer librespot[22247]: [2024-10-22T10:47:12Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:14 kurer librespot[22247]: [2024-10-22T10:47:14Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:15 kurer librespot[22247]: [2024-10-22T10:47:15Z WARN  librespot_core::cdn_url] Cannot parse CDN URL expiry timestamp 'verify=1729680435-13%2FWYGKveHcOTwVXVWa1%2BJjC87cutROH4l4jQ%2B6AxYA%3D' from 'https://audio-cf-del-574.spotifycdn.com/audio/4d030967fe7191c5992da68afc18383a74080ca9?verify=1729680435-13%2FWYGKveHcOTwVXVWa1%2BJjC87cutROH4l4jQ%2B6AxYA%3D'
Oct 22 12:47:17 kurer librespot[22247]: [2024-10-22T10:47:17Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:18 kurer librespot[22247]: [2024-10-22T10:47:18Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:20 kurer librespot[22247]: [2024-10-22T10:47:20Z WARN  librespot_core::cdn_url] Cannot parse CDN URL expiry timestamp 'verify=1729680440-M357DsUMtqdHu89i0eDYCUbVLoafItMj9poOuYD4P1I%3D' from 'https://audio-cf-del-574.spotifycdn.com/audio/a6c726982b70d5b6794ad3b3e23fe46c23ab00b2?verify=1729680440-M357DsUMtqdHu89i0eDYCUbVLoafItMj9poOuYD4P1I%3D'
Oct 22 12:47:23 kurer librespot[22247]: [2024-10-22T10:47:23Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:23 kurer librespot[22247]: [2024-10-22T10:47:23Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'
Oct 22 12:47:23 kurer librespot[22247]: [2024-10-22T10:47:23Z ERROR librespot_playback::player] PlayerInternal poll: Invalid PlayerState
Oct 22 12:47:23 kurer systemd[1]: raspotify.service: Main process exited, code=exited, status=1/FAILURE
Oct 22 12:47:23 kurer systemd[1]: raspotify.service: Failed with result 'exit-code'.
Oct 22 12:47:23 kurer systemd[1]: raspotify.service: Triggering OnFailure= dependencies.
Oct 22 12:47:23 kurer systemd[1]: raspotify.service: Consumed 1.616s CPU time.

-- Config --

LIBRESPOT_QUIET=on
LIBRESPOT_DISABLE_AUDIO_CACHE=on
LIBRESPOT_DISABLE_CREDENTIAL_CACHE=on
LIBRESPOT_ENABLE_VOLUME_NORMALISATION=on

-- Ouput of aplay -l --

**** List of PLAYBACK Hardware Devices ****
card 0: vc4hdmi [vc4-hdmi], device 0: MAI PCM i2s-hifi-0 [MAI PCM i2s-hifi-0]
  Subdevices: 1/1
  Subdevice #0: subdevice #0
card 1: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones]
  Subdevices: 8/8
  Subdevice #0: subdevice #0
  Subdevice #1: subdevice #1
  Subdevice #2: subdevice #2
  Subdevice #3: subdevice #3
  Subdevice #4: subdevice #4
  Subdevice #5: subdevice #5
  Subdevice #6: subdevice #6
  Subdevice #7: subdevice #7

-- Ouput of aplay -L --

null
    Discard all samples (playback) or generate zero samples (capture)
default
    Default Audio Device
sysdefault
    Default Audio Device
lavrate
    Rate Converter Plugin Using Libav/FFmpeg Library
samplerate
    Rate Converter Plugin Using Samplerate Library
speexrate
    Rate Converter Plugin Using Speex Resampler
jack
    JACK Audio Connection Kit
oss
    Open Sound System
pulse
    PulseAudio Sound Server
speex
    Plugin using Speex DSP (resample, agc, denoise, echo, dereverb)
upmix
    Plugin for channel upmix (4,6,8)
vdownmix
    Plugin for channel downmix (stereo) with a simple spacialization
hw:CARD=vc4hdmi,DEV=0
    vc4-hdmi, MAI PCM i2s-hifi-0
    Direct hardware device without any conversions
plughw:CARD=vc4hdmi,DEV=0
    vc4-hdmi, MAI PCM i2s-hifi-0
    Hardware device with all software conversions
default:CARD=vc4hdmi
    vc4-hdmi, MAI PCM i2s-hifi-0
    Default Audio Device
sysdefault:CARD=vc4hdmi
    vc4-hdmi, MAI PCM i2s-hifi-0
    Default Audio Device
hdmi:CARD=vc4hdmi,DEV=0
    vc4-hdmi, MAI PCM i2s-hifi-0
    HDMI Audio Output
dmix:CARD=vc4hdmi,DEV=0
    vc4-hdmi, MAI PCM i2s-hifi-0
    Direct sample mixing device
usbstream:CARD=vc4hdmi
    vc4-hdmi
    USB Stream Output
hw:CARD=Headphones,DEV=0
    bcm2835 Headphones, bcm2835 Headphones
    Direct hardware device without any conversions
plughw:CARD=Headphones,DEV=0
    bcm2835 Headphones, bcm2835 Headphones
    Hardware device with all software conversions
default:CARD=Headphones
    bcm2835 Headphones, bcm2835 Headphones
    Default Audio Device
sysdefault:CARD=Headphones
    bcm2835 Headphones, bcm2835 Headphones
    Default Audio Device
dmix:CARD=Headphones,DEV=0
    bcm2835 Headphones, bcm2835 Headphones
    Direct sample mixing device
usbstream:CARD=Headphones
    bcm2835 Headphones
    USB Stream Output

-- Ouput of librespot -d ? --


	Compatible alsa device(s):

	------------------------------------------------------

	Device:

		hw:CARD=Headphones,DEV=0

	Description:

		bcm2835 Headphones, bcm2835 Headphones
		Direct hardware device without any conversions

	Supported Format(s):

		S16

	------------------------------------------------------

	Device:

		plughw:CARD=Headphones,DEV=0

	Description:

		bcm2835 Headphones, bcm2835 Headphones
		Hardware device with all software conversions

	Supported Format(s):

		S16 S24 S24_3 S32 F32 F64

	------------------------------------------------------

	Device:

		default:CARD=Headphones

	Description:

		bcm2835 Headphones, bcm2835 Headphones
		Default Audio Device

	Supported Format(s):

		S16 S24 S24_3 S32 F32 F64

	------------------------------------------------------

	Device:

		sysdefault:CARD=Headphones

	Description:

		bcm2835 Headphones, bcm2835 Headphones
		Default Audio Device

	Supported Format(s):

		S16 S24 S24_3 S32 F32 F64

	------------------------------------------------------
@kimtore
Copy link
Collaborator

kimtore commented Oct 22, 2024

Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'

It looks like your sound card is already in use by another application?

@Wollert
Copy link
Author

Wollert commented Oct 22, 2024

Audio Sink Error Connection Refused: Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Unknown errno (524)'

It looks like your sound card is already in use by another application?

I tried sudo lsof /dev/snd/* and got only pipewire and wireplumb. I killed these processes and restarted the raspotify service, but I still get the same error. Is there any other way to find the application(-s) that might be causing the problem?

Please note that I have not installed any additional applications on this version of Raspbian, I downloaded the image and flashed it just before installing raspotify.

@kimtore
Copy link
Collaborator

kimtore commented Oct 22, 2024

How about installing the pipewire-alsa package and restarting Raspotify?

You could also try the same approach with the pipewire-pulse package and pulseaudio backend.

@Wollert
Copy link
Author

Wollert commented Oct 22, 2024

Installing the pipewire-alsa package and restarting Raspotify resulted in a new error message. I understand that something might not be running that should be, but I don't know how to fix the issue.

Oct 22 14:38:02 kurer librespot[678]: [2024-10-22T12:38:02Z ERROR librespot_playback::player] Audio Sink Error Connection Refused: <AlsaSink> Device default May be Invalid, Busy, or Already in Use, ALSA function 'snd_pcm_open' failed with error 'Host is down (112)'

@kimtore
Copy link
Collaborator

kimtore commented Oct 22, 2024

Not sure about this. I suspect Pipewire might be running as a different user than librespot, and that it has something to do with the connection refused message.

As a last resort, you could try uninstalling Pipewire altogether and see if that works for you.

@Wollert
Copy link
Author

Wollert commented Oct 22, 2024

That didn't help I'm afraid, but that you for your help!

@kimtore
Copy link
Collaborator

kimtore commented Oct 23, 2024

Do other audio-based applications work? e.g. try the speaker-test application, which IIRC is in the package alsa-utils, and see if you get any sound.

@Wollert
Copy link
Author

Wollert commented Oct 23, 2024

Yes, speaker-test works fine.

@kimtore
Copy link
Collaborator

kimtore commented Oct 23, 2024

Good sign then.
My guess is that librespot is simply misconfigured, perhaps missing some permissions.
You could try to verify this by running librespot as root on the command line, tweaking parameters as needed.
Right now I don't have a fresh Raspbian system (nor a RPI 3B) to test on so I can't really make any progress yet.

@Wollert
Copy link
Author

Wollert commented Oct 23, 2024

I'm getting the same error when running librespot as root. However, when I run librespot (not as root) everything works fine...

@kimtore
Copy link
Collaborator

kimtore commented Oct 24, 2024

From this info I can only guess that:

  • Pipewire is running as some default user (usually pi or similar)
  • You are running logged-in to a desktop environment
  • Only the same user as is running Pipewire can use the audio device

Is this correct?

@kimtore kimtore changed the title Not able to play tracks Not able to play tracks (audio sink connection refused) Oct 24, 2024
@twbonnot
Copy link

twbonnot commented Nov 1, 2024

So I have the same problem and I just did the speaker test and it works I just don't know why it won't connect. It does the same thing it connects on Spotify but when I press play it immediately pauses and doesn't move on the timeline at all

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

3 participants