starred/librespot
1
0
Fork 0
mirror of https://github.com/librespot-org/librespot.git synced 2026-04-27 08:15:50 +03:00
Code Issues 95 Projects Releases 10 Packages Wiki Activity

[GH-ISSUE #1672] Spotify is not finding the device, despite librespot advertising correctly #761

New issue
Closed
opened 2026-02-27 19:32:20 +03:00 by kerem · 9 comments
kerem commented 2026-02-27 19:32:20 +03:00
Owner
Copy link

Originally created by @twaclaw on GitHub (Dec 31, 2025).
Original GitHub issue: https://github.com/librespot-org/librespot/issues/1672

I am using version 0.8.0 over Moode audio (10.3) on a Raspberry Pi 5. The installed version is 0.8.0-moode1.

librespot seems to be advertising correctly but the Spotify app cannot find the device.

$ dns-sd -B _spotify-connect._tcp
Browsing for _spotify-connect._tcp
DATE: ---Wed 31 Dec 2025---
 8:37:04.818  ...STARTING...
Timestamp     A/R    Flags  if Domain               Service Type         Instance Name
8:37:04.818  Add        2  11 local.               _spotify-connect._tcp. moode

This is the Moode log

[2025-12-31T07:32:58Z INFO  librespot] librespot 0.8.0 d36f9f1 (Built on 2025-11-14, Build ID: jYIxsttK, Profile: release)
[2025-12-31T07:32:58Z TRACE librespot] Command line argument(s):
[2025-12-31T07:32:58Z TRACE librespot] 		name "moode"
[2025-12-31T07:32:58Z TRACE librespot] 		bitrate "320"
[2025-12-31T07:32:58Z TRACE librespot] 		format "S32"
[2025-12-31T07:32:58Z TRACE librespot] 		mixer "softvol"
[2025-12-31T07:32:58Z TRACE librespot] 		initial-volume "100"
[2025-12-31T07:32:58Z TRACE librespot] 		volume-ctrl "log"
[2025-12-31T07:32:58Z TRACE librespot] 		volume-range "100"
[2025-12-31T07:32:58Z TRACE librespot] 		cache "/var/local/www/spotify_cache"
[2025-12-31T07:32:58Z TRACE librespot] 		disable-audio-cache
[2025-12-31T07:32:58Z TRACE librespot] 		backend "alsa"
[2025-12-31T07:32:58Z TRACE librespot] 		device "_audioout"
[2025-12-31T07:32:58Z TRACE librespot] 		onevent "/var/local/www/commandw/spotevent.sh"
[2025-12-31T07:32:58Z TRACE librespot] 		v
[2025-12-31T07:32:58Z DEBUG librespot_core::session] new Session
[2025-12-31T07:32:58Z DEBUG librespot_discovery::server] Zeroconf server listening on 0.0.0.0:35439
[2025-12-31T07:32:58Z INFO  librespot_playback::mixer::softmixer] Mixing with softvol and volume control: Log(100.0)
[2025-12-31T07:32:58Z DEBUG librespot_playback::player] new Player [0]
[2025-12-31T07:32:58Z INFO  librespot_playback::audio_backend::alsa] Using AlsaSink with format: S32
[2025-12-31T07:32:58Z DEBUG librespot_playback::player] command=AddEventSender
Originally created by @twaclaw on GitHub (Dec 31, 2025). Original GitHub issue: https://github.com/librespot-org/librespot/issues/1672 I am using version `0.8.0` over Moode audio (`10.3`) on a Raspberry Pi 5. The installed version is `0.8.0-moode1`. `librespot` seems to be advertising correctly but the Spotify app cannot find the device. ```bash $ dns-sd -B _spotify-connect._tcp Browsing for _spotify-connect._tcp DATE: ---Wed 31 Dec 2025--- 8:37:04.818 ...STARTING... Timestamp A/R Flags if Domain Service Type Instance Name 8:37:04.818 Add 2 11 local. _spotify-connect._tcp. moode ``` This is the Moode log ``` [2025-12-31T07:32:58Z INFO librespot] librespot 0.8.0 d36f9f1 (Built on 2025-11-14, Build ID: jYIxsttK, Profile: release) [2025-12-31T07:32:58Z TRACE librespot] Command line argument(s): [2025-12-31T07:32:58Z TRACE librespot] name "moode" [2025-12-31T07:32:58Z TRACE librespot] bitrate "320" [2025-12-31T07:32:58Z TRACE librespot] format "S32" [2025-12-31T07:32:58Z TRACE librespot] mixer "softvol" [2025-12-31T07:32:58Z TRACE librespot] initial-volume "100" [2025-12-31T07:32:58Z TRACE librespot] volume-ctrl "log" [2025-12-31T07:32:58Z TRACE librespot] volume-range "100" [2025-12-31T07:32:58Z TRACE librespot] cache "/var/local/www/spotify_cache" [2025-12-31T07:32:58Z TRACE librespot] disable-audio-cache [2025-12-31T07:32:58Z TRACE librespot] backend "alsa" [2025-12-31T07:32:58Z TRACE librespot] device "_audioout" [2025-12-31T07:32:58Z TRACE librespot] onevent "/var/local/www/commandw/spotevent.sh" [2025-12-31T07:32:58Z TRACE librespot] v [2025-12-31T07:32:58Z DEBUG librespot_core::session] new Session [2025-12-31T07:32:58Z DEBUG librespot_discovery::server] Zeroconf server listening on 0.0.0.0:35439 [2025-12-31T07:32:58Z INFO librespot_playback::mixer::softmixer] Mixing with softvol and volume control: Log(100.0) [2025-12-31T07:32:58Z DEBUG librespot_playback::player] new Player [0] [2025-12-31T07:32:58Z INFO librespot_playback::audio_backend::alsa] Using AlsaSink with format: S32 [2025-12-31T07:32:58Z DEBUG librespot_playback::player] command=AddEventSender ```
kerem closed this issue 2026-02-27 19:32:20 +03:00
kerem commented 2026-02-27 19:32:20 +03:00
Author
Owner
Copy link

@kingosticks commented on GitHub (Dec 31, 2025):

Can you get more log, there's nothing to show a problem here.

<!-- gh-comment-id:3701769201 --> @kingosticks commented on GitHub (Dec 31, 2025): Can you get more log, there's nothing to show a problem here.
kerem commented 2026-02-27 19:32:20 +03:00
Author
Owner
Copy link

@twaclaw commented on GitHub (Dec 31, 2025):

Thanks @kingosticks, that's as much as I got from moode's initialization command:

librespot --name "moode" --bitrate 320 --format S32 --mixer softvol --initial-volume 100 --volume-ctrl log --volume-range 100 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&librespot1 &

I will check to see if I can collect any additional logs, or if I can make them more verbose, and then I will post them here.

<!-- gh-comment-id:3701783658 --> @twaclaw commented on GitHub (Dec 31, 2025): Thanks @kingosticks, that's as much as I got from moode's initialization command: ```bash librespot --name "moode" --bitrate 320 --format S32 --mixer softvol --initial-volume 100 --volume-ctrl log --volume-range 100 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&librespot1 & ``` I will check to see if I can collect any additional logs, or if I can make them more verbose, and then I will post them here.
kerem commented 2026-02-27 19:32:20 +03:00
Author
Owner
Copy link

@twaclaw commented on GitHub (Dec 31, 2025):

@kingosticks, I don't see more log output than the one above. The command is already running with -v.

Spotify connect was working before I flashed the latest moode image moOde: 10.0.3 2025-12-28. I am using the latest Spotify app 9.1.6.1142. As I mentioned before, librespot seems to be advertising correctly, I don't see traces of any error. I am puzzled.

<!-- gh-comment-id:3702276259 --> @twaclaw commented on GitHub (Dec 31, 2025): @kingosticks, I don't see more log output than the one above. The command is already running with `-v`. Spotify connect was working before I flashed the latest moode image `moOde: 10.0.3 2025-12-28`. I am using the latest Spotify app `9.1.6.1142`. As I mentioned before, `librespot` seems to be advertising correctly, I don't see traces of any error. I am puzzled.
kerem commented 2026-02-27 19:32:20 +03:00
Author
Owner
Copy link

@kingosticks commented on GitHub (Dec 31, 2025):

You could run it in your terminal without the output redirection. Remove:

> /var/log/moode_librespot.log 2>&librespot1 &

from the end and reproduce the issue.

<!-- gh-comment-id:3702288557 --> @kingosticks commented on GitHub (Dec 31, 2025): You could run it in your terminal without the output redirection. Remove: ``` > /var/log/moode_librespot.log 2>&librespot1 & ``` from the end and reproduce the issue.
kerem commented 2026-02-27 19:32:20 +03:00
Author
Owner
Copy link

@twaclaw commented on GitHub (Dec 31, 2025):

I did so, I get the same log output.

<!-- gh-comment-id:3702315197 --> @twaclaw commented on GitHub (Dec 31, 2025): I did so, I get the same log output.
kerem commented 2026-02-27 19:32:21 +03:00
Author
Owner
Copy link

@lumixing commented on GitHub (Dec 31, 2025):

I've also just stumbled upon a similar issue where the librespot device is shown on the official Spotify app device list but not in their Web API (https://developer.spotify.com/documentation/web-api/reference/get-a-users-available-devices). I'm pretty sure that was not an issue some time ago (I don't remember exactly when). Also, verbose logs don't indicate anything wrong.

(using version: librespot 0.8.0 3eca1ab (Built on 2025-12-30, Build ID: tsllhEcI, Profile: debug)).

<!-- gh-comment-id:3702875350 --> @lumixing commented on GitHub (Dec 31, 2025): I've also just stumbled upon a similar issue where the librespot device is shown on the official Spotify app device list but *not* in their Web API (https://developer.spotify.com/documentation/web-api/reference/get-a-users-available-devices). I'm pretty sure that was not an issue some time ago (I don't remember exactly when). Also, verbose logs don't indicate anything wrong. (using version: librespot 0.8.0 3eca1ab (Built on 2025-12-30, Build ID: tsllhEcI, Profile: debug)).
kerem commented 2026-02-27 19:32:21 +03:00
Author
Owner
Copy link

@kingosticks commented on GitHub (Dec 31, 2025):

For librespot to be shown on their web API you must have librespot login to your account i.e. using oauth. I don't think that's what the OP wants to do here as they are talking about zeroconf advertisements and there's clearly no oauth or saved credentials login happening.

<!-- gh-comment-id:3702915539 --> @kingosticks commented on GitHub (Dec 31, 2025): For librespot to be shown on their web API you must have librespot login to your account i.e. using oauth. I don't think that's what the OP wants to do here as they are talking about zeroconf advertisements and there's clearly no oauth or saved credentials login happening.
kerem commented 2026-02-27 19:32:21 +03:00
Author
Owner
Copy link

@twaclaw commented on GitHub (Jan 3, 2026):

As I mentioned above, my Spotify App is @ 9.1.6.1142. I tried with a different device which is at version 9.1.2.1254. This time I can see my spotify connect device but I cannot connect to it. Since I did this, I get more log lines.

cat log.log
[2026-01-03T08:56:06Z INFO  librespot] librespot 0.8.0 d36f9f1 (Built on 2025-11-14, Build ID: jYIxsttK, Profile: release)
[2026-01-03T08:56:06Z TRACE librespot] Command line argument(s):
[2026-01-03T08:56:06Z TRACE librespot] 		name "Guguto"
[2026-01-03T08:56:06Z TRACE librespot] 		bitrate "320"
[2026-01-03T08:56:06Z TRACE librespot] 		format "S32"
[2026-01-03T08:56:06Z TRACE librespot] 		mixer "softvol"
[2026-01-03T08:56:06Z TRACE librespot] 		initial-volume "100"
[2026-01-03T08:56:06Z TRACE librespot] 		volume-ctrl "log"
[2026-01-03T08:56:06Z TRACE librespot] 		volume-range "100"
[2026-01-03T08:56:06Z TRACE librespot] 		cache "/var/local/www/spotify_cache"
[2026-01-03T08:56:06Z TRACE librespot] 		disable-audio-cache
[2026-01-03T08:56:06Z TRACE librespot] 		backend "alsa"
[2026-01-03T08:56:06Z TRACE librespot] 		device "_audioout"
[2026-01-03T08:56:06Z TRACE librespot] 		onevent "/var/local/www/commandw/spotevent.sh"
[2026-01-03T08:56:06Z TRACE librespot] 		v
[2026-01-03T08:56:06Z TRACE librespot] Using cached credentials.
[2026-01-03T08:56:06Z DEBUG librespot_core::session] new Session
[2026-01-03T08:56:06Z DEBUG librespot_discovery::server] Zeroconf server listening on 0.0.0.0:35371
[2026-01-03T08:56:06Z INFO  librespot_playback::mixer::softmixer] Mixing with softvol and volume control: Log(100.0)
[2026-01-03T08:56:06Z DEBUG librespot_connect::spirc] new Spirc[0]
[2026-01-03T08:56:06Z DEBUG librespot::component] new DealerManager
[2026-01-03T08:56:06Z DEBUG librespot::component] new SpClient
[2026-01-03T08:56:06Z DEBUG librespot_core::spclient] Client token unavailable or expired, requesting new token.
[2026-01-03T08:56:06Z DEBUG librespot_core::http_client] Requesting https://clienttoken.spotify.com/v1/clienttoken
[2026-01-03T08:56:06Z DEBUG librespot_playback::player] new Player [0]
[2026-01-03T08:56:06Z INFO  librespot_playback::audio_backend::alsa] Using AlsaSink with format: S32
[2026-01-03T08:56:06Z DEBUG librespot_playback::player] command=AddEventSender
[2026-01-03T08:56:07Z DEBUG librespot_core::spclient] Received a granted token
[2026-01-03T08:56:07Z TRACE librespot_core::spclient] Got client token: GrantedTokenResponse { token: "AAABegaP8w1fXlNZDkA8HPNLPRpir1xEsBJcWMasy0Esef9MssgH/A2BtGy/......", expires_after_seconds: 1216800, refresh_after_seconds: 1209600, domains: [TokenDomain { domain: "spotify.com", special_fields: SpecialFields { unknown_fields: UnknownFields { fields: None }, cached_size: CachedSize { size: 0 } } }, TokenDomain { domain: "spotify.net", special_fields: SpecialFields { unknown_fields: UnknownFields { fields: None }, cached_size: CachedSize { size: 0 } } }], special_fields: SpecialFields { unknown_fields: UnknownFields { fields: None }, cached_size: CachedSize { size: 0 } } }
[2026-01-03T08:56:07Z DEBUG librespot::component] new ApResolver
[2026-01-03T08:56:07Z DEBUG librespot_core::http_client] Requesting https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient
[2026-01-03T08:56:07Z INFO  librespot_core::session] Connecting to AP "ap-gew4.spotify.com:4070"
[2026-01-03T08:56:07Z DEBUG librespot_core::connection] Connection to "ap-gew4.spotify.com:4070" failed: Connection refused (os error 111)
[2026-01-03T08:56:07Z DEBUG librespot_core::connection] Retry access point...
[2026-01-03T08:56:07Z DEBUG librespot_core::connection] Connection to AP established.
[2026-01-03T08:56:07Z DEBUG librespot_core::connection] Authenticating with AP using AUTHENTICATION_STORED_SPOTIFY_CREDENTIALS
[2026-01-03T08:56:07Z INFO  librespot_core::session] Authenticated as 'ezne322vdgbt2hxzhamj4hm8u' !
[2026-01-03T08:56:07Z DEBUG librespot::component] new Login5Manager
[2026-01-03T08:56:07Z DEBUG librespot_core::http_client] Requesting https://login5.spotify.com/v3/login
[2026-01-03T08:56:07Z TRACE librespot_core::session] Received Ping
[2026-01-03T08:56:07Z TRACE librespot_core::session] keep-alive state: PendingPong, timeout in 60.0
[2026-01-03T08:56:07Z DEBUG librespot_core::session] Session strong=5 weak=6
[2026-01-03T08:56:07Z INFO  librespot_core::session] Country: "CH"
[2026-01-03T08:56:07Z TRACE librespot_core::session] Received product info: {
        "enable-crossfade": "1",
        "audiobook-onboarding-completed": "0",
        "offline": "1",
        "video-manifest-url": "https://spclient.wg.spotify.com/manifests/v6/{type}/sources/{source_id}",
        "enable-annotations-read": "0",
        "shuffle": "0",
        "audio-preview-url-template": "https://p.scdn.co/mp3-preview/{id}",
        "ab_recently_played_feature_time_filter_threshold": "com.spotify.gaia=30,driving-mode=120,spotify%3Ainternal%3Astartpage=30",
        "incognito_mode_timeout": "21600",
        "arsenal_country": "1",
        "libspotify": "1",
        "mobile": "1",
        "publish-playlist": "1",
        "key-caching-max-offline-seconds": "1800",
        "remote-control": "0",
        "playlist-annotations-markup": "0",
        "ads": "0",
        "video-cdn-sampling": "100",
        "prefetch-keys": "1",
        "restrict-playlist-collaboration": "0",
        "widevine-license-url": "https://spclient.wg.spotify.com/widevine-license/v1/video/license",
        "financial-product": "pr:premium,tc:0,rt:v2_CH_default_full-price-premium-1m_15.95_CHF_default",
        "nft-disabled": "1",
        "video-device-blacklisted": "0",
        "head-file-caching": "1",
        "head-files": "1",
        "is_email_verified": "1",
        "capping-bar-threshold": "3601",
        "publish-activity": "0",
        "sidebar-navigation-enabled": "0",
        "payments-locked-state": "0",
        "player-license-v2": "premium",
        "image-url": "https://i.scdn.co/image/{file_id}",
        "radio": "1",
        "head-files-url": "http://heads-fa.spotify.com/head/{file_id}",
        "prefetch-window-max": "2",
        "ab-ad-player-targeting": "1",
        "ugc-abuse-report-url": "https://support.spotify.com/abuse/?uri={uri}",
        "employee-free-opt-in": "0",
        "ugc-abuse-report": "0",
        "player-license": "premium",
        "ad-formats-preroll-video": "0",
        "high-bitrate": "1",
        "preferred-locale": "en-ch",
        "shows-collection-jam": "0",
        "catalogue": "premium",
        "explicit-content": "1",
        "unrestricted": "1",
        "app-developer": "0",
        "metadata-link-lookup-modes": "0",
        "type": "premium",
        "collection": "1",
        "key-caching-max-count": "10000",
        "storage-size-config": "10240,90,500,3",
        "streaming": "1",
        "payments-initial-campaign": "default",
        "on-demand": "1",
        "send-email": "1",
        "ad-session-persistence": "1",
        "prefetch-strategy": "18",
        "name": "Spotify Premium",
        "ab-watch-now": "0",
        "on-demand-trial-in-progress": "0",
        "shows-collection": "0",
    }
[2026-01-03T08:56:07Z DEBUG librespot::component] new MercuryManager
[2026-01-03T08:56:07Z TRACE librespot_core::mercury] mercury response <hm://pusher/v1/connections/OGRlNGFiNjIzZjA2NDk0MTNiNDgyMjFjNGRkOGVhZDYxZjQxYWNmYitBUCt0Y3A6Ly8wYWIxNTA3NC5pcC5nZXc0LnNwb3RpZnkubmV0OjUwMDgrRjVDRTc5MkZBQTFERjYxNTY3MDU2QTM0OEIwQzQ5MUM4NTQzNUUxN0JGQkJGN0ZFQjU0QURFNTA3NDMzMUUyQw%3D%3D> is handled by dealer
[2026-01-03T08:56:08Z TRACE librespot_core::login5] Got auth token: Token { access_token: "BQBUxPJ0le....", expires_in: 3600s, token_type: "Bearer", scopes: [], timestamp: SystemTime { tv_sec: 1767430568, tv_nsec: 76111335 } }
[2026-01-03T08:56:08Z DEBUG librespot_connect::spirc] SpircTask::set_volume(65535)
[2026-01-03T08:56:08Z DEBUG librespot_playback::player] command=AddEventSender
[2026-01-03T08:56:08Z DEBUG librespot_core::dealer::manager] Launching dealer
[2026-01-03T08:56:08Z TRACE librespot_core::dealer] Sent ping
[2026-01-03T08:56:08Z TRACE librespot_connect::spirc] Received connection ID update: "OTFjMjE1MDktYmE3Zi00YTQyLWIxYmEtZGVhODA0YjQ5OWEyK2RlYWxlcit0Y3A6Ly8wYWIxNTAxMy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMjJDNDlCQUVFNDE1NDA1OEFBNjQ2RkQ0NzA0MTdGRkIzMUQ0RkU4QzA5QjMxNzEwNjZGNTU3RTRENjc1MjhDNA=="
[2026-01-03T08:56:08Z INFO  librespot_core::spclient] Resolved "gew4-spclient.spotify.com:443" as spclient access point
[2026-01-03T08:56:08Z DEBUG librespot_core::http_client] Requesting https://gew4-spclient.spotify.com:443/connect-state/v1/devices/8de4ab623f0649413b48221c4dd8ead61f41acfb?product=0&country=CH&salt=876726852
[2026-01-03T08:56:08Z TRACE librespot_core::dealer] Received pong
[2026-01-03T08:56:08Z DEBUG librespot_connect::spirc] successfully put connect state for 8de4ab623f0649413b48221c4dd8ead61f41acfb with connection-id OTFjMjE1MDktYmE3Zi00YTQyLWIxYmEtZGVhODA0YjQ5OWEyK2RlYWxlcit0Y3A6Ly8wYWIxNTAxMy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMjJDNDlCQUVFNDE1NDA1OEFBNjQ2RkQ0NzA0MTdGRkIzMUQ0RkU4QzA5QjMxNzEwNjZGNTU3RTRENjc1MjhDNA==
[2026-01-03T08:56:08Z INFO  librespot_connect::spirc] active device is <> with session <0733feeebdbd44d388dbc2d90782f4ff>
[2026-01-03T08:56:30Z TRACE librespot_core::dealer::protocol] message was sent with gzip encoding
[2026-01-03T08:56:30Z DEBUG librespot_connect::spirc] cluster update: Ok(DEVICES_DISAPPEARED) from fe7158fb28b5a0bcd859e7146e7e2c785733d1e6, active device:
[2026-01-03T08:56:38Z TRACE librespot_core::dealer] Sent ping
[2026-01-03T08:56:38Z TRACE librespot_core::dealer] Received pong

This is the only error I spotted [2026-01-03T08:56:07Z DEBUG librespot_core::connection] Connection to "ap-gew4.spotify.com:4070" failed: Connection refused (os error 111).

Any ideas? Suggestions?

Thanks in advance

<!-- gh-comment-id:3706909051 --> @twaclaw commented on GitHub (Jan 3, 2026): As I mentioned above, my Spotify App is @ `9.1.6.1142`. I tried with a different device which is at version `9.1.2.1254`. This time I can see my spotify connect device but I cannot connect to it. Since I did this, I get more log lines. ``` cat log.log [2026-01-03T08:56:06Z INFO librespot] librespot 0.8.0 d36f9f1 (Built on 2025-11-14, Build ID: jYIxsttK, Profile: release) [2026-01-03T08:56:06Z TRACE librespot] Command line argument(s): [2026-01-03T08:56:06Z TRACE librespot] name "Guguto" [2026-01-03T08:56:06Z TRACE librespot] bitrate "320" [2026-01-03T08:56:06Z TRACE librespot] format "S32" [2026-01-03T08:56:06Z TRACE librespot] mixer "softvol" [2026-01-03T08:56:06Z TRACE librespot] initial-volume "100" [2026-01-03T08:56:06Z TRACE librespot] volume-ctrl "log" [2026-01-03T08:56:06Z TRACE librespot] volume-range "100" [2026-01-03T08:56:06Z TRACE librespot] cache "/var/local/www/spotify_cache" [2026-01-03T08:56:06Z TRACE librespot] disable-audio-cache [2026-01-03T08:56:06Z TRACE librespot] backend "alsa" [2026-01-03T08:56:06Z TRACE librespot] device "_audioout" [2026-01-03T08:56:06Z TRACE librespot] onevent "/var/local/www/commandw/spotevent.sh" [2026-01-03T08:56:06Z TRACE librespot] v [2026-01-03T08:56:06Z TRACE librespot] Using cached credentials. [2026-01-03T08:56:06Z DEBUG librespot_core::session] new Session [2026-01-03T08:56:06Z DEBUG librespot_discovery::server] Zeroconf server listening on 0.0.0.0:35371 [2026-01-03T08:56:06Z INFO librespot_playback::mixer::softmixer] Mixing with softvol and volume control: Log(100.0) [2026-01-03T08:56:06Z DEBUG librespot_connect::spirc] new Spirc[0] [2026-01-03T08:56:06Z DEBUG librespot::component] new DealerManager [2026-01-03T08:56:06Z DEBUG librespot::component] new SpClient [2026-01-03T08:56:06Z DEBUG librespot_core::spclient] Client token unavailable or expired, requesting new token. [2026-01-03T08:56:06Z DEBUG librespot_core::http_client] Requesting https://clienttoken.spotify.com/v1/clienttoken [2026-01-03T08:56:06Z DEBUG librespot_playback::player] new Player [0] [2026-01-03T08:56:06Z INFO librespot_playback::audio_backend::alsa] Using AlsaSink with format: S32 [2026-01-03T08:56:06Z DEBUG librespot_playback::player] command=AddEventSender [2026-01-03T08:56:07Z DEBUG librespot_core::spclient] Received a granted token [2026-01-03T08:56:07Z TRACE librespot_core::spclient] Got client token: GrantedTokenResponse { token: "AAABegaP8w1fXlNZDkA8HPNLPRpir1xEsBJcWMasy0Esef9MssgH/A2BtGy/......", expires_after_seconds: 1216800, refresh_after_seconds: 1209600, domains: [TokenDomain { domain: "spotify.com", special_fields: SpecialFields { unknown_fields: UnknownFields { fields: None }, cached_size: CachedSize { size: 0 } } }, TokenDomain { domain: "spotify.net", special_fields: SpecialFields { unknown_fields: UnknownFields { fields: None }, cached_size: CachedSize { size: 0 } } }], special_fields: SpecialFields { unknown_fields: UnknownFields { fields: None }, cached_size: CachedSize { size: 0 } } } [2026-01-03T08:56:07Z DEBUG librespot::component] new ApResolver [2026-01-03T08:56:07Z DEBUG librespot_core::http_client] Requesting https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient [2026-01-03T08:56:07Z INFO librespot_core::session] Connecting to AP "ap-gew4.spotify.com:4070" [2026-01-03T08:56:07Z DEBUG librespot_core::connection] Connection to "ap-gew4.spotify.com:4070" failed: Connection refused (os error 111) [2026-01-03T08:56:07Z DEBUG librespot_core::connection] Retry access point... [2026-01-03T08:56:07Z DEBUG librespot_core::connection] Connection to AP established. [2026-01-03T08:56:07Z DEBUG librespot_core::connection] Authenticating with AP using AUTHENTICATION_STORED_SPOTIFY_CREDENTIALS [2026-01-03T08:56:07Z INFO librespot_core::session] Authenticated as 'ezne322vdgbt2hxzhamj4hm8u' ! [2026-01-03T08:56:07Z DEBUG librespot::component] new Login5Manager [2026-01-03T08:56:07Z DEBUG librespot_core::http_client] Requesting https://login5.spotify.com/v3/login [2026-01-03T08:56:07Z TRACE librespot_core::session] Received Ping [2026-01-03T08:56:07Z TRACE librespot_core::session] keep-alive state: PendingPong, timeout in 60.0 [2026-01-03T08:56:07Z DEBUG librespot_core::session] Session strong=5 weak=6 [2026-01-03T08:56:07Z INFO librespot_core::session] Country: "CH" [2026-01-03T08:56:07Z TRACE librespot_core::session] Received product info: { "enable-crossfade": "1", "audiobook-onboarding-completed": "0", "offline": "1", "video-manifest-url": "https://spclient.wg.spotify.com/manifests/v6/{type}/sources/{source_id}", "enable-annotations-read": "0", "shuffle": "0", "audio-preview-url-template": "https://p.scdn.co/mp3-preview/{id}", "ab_recently_played_feature_time_filter_threshold": "com.spotify.gaia=30,driving-mode=120,spotify%3Ainternal%3Astartpage=30", "incognito_mode_timeout": "21600", "arsenal_country": "1", "libspotify": "1", "mobile": "1", "publish-playlist": "1", "key-caching-max-offline-seconds": "1800", "remote-control": "0", "playlist-annotations-markup": "0", "ads": "0", "video-cdn-sampling": "100", "prefetch-keys": "1", "restrict-playlist-collaboration": "0", "widevine-license-url": "https://spclient.wg.spotify.com/widevine-license/v1/video/license", "financial-product": "pr:premium,tc:0,rt:v2_CH_default_full-price-premium-1m_15.95_CHF_default", "nft-disabled": "1", "video-device-blacklisted": "0", "head-file-caching": "1", "head-files": "1", "is_email_verified": "1", "capping-bar-threshold": "3601", "publish-activity": "0", "sidebar-navigation-enabled": "0", "payments-locked-state": "0", "player-license-v2": "premium", "image-url": "https://i.scdn.co/image/{file_id}", "radio": "1", "head-files-url": "http://heads-fa.spotify.com/head/{file_id}", "prefetch-window-max": "2", "ab-ad-player-targeting": "1", "ugc-abuse-report-url": "https://support.spotify.com/abuse/?uri={uri}", "employee-free-opt-in": "0", "ugc-abuse-report": "0", "player-license": "premium", "ad-formats-preroll-video": "0", "high-bitrate": "1", "preferred-locale": "en-ch", "shows-collection-jam": "0", "catalogue": "premium", "explicit-content": "1", "unrestricted": "1", "app-developer": "0", "metadata-link-lookup-modes": "0", "type": "premium", "collection": "1", "key-caching-max-count": "10000", "storage-size-config": "10240,90,500,3", "streaming": "1", "payments-initial-campaign": "default", "on-demand": "1", "send-email": "1", "ad-session-persistence": "1", "prefetch-strategy": "18", "name": "Spotify Premium", "ab-watch-now": "0", "on-demand-trial-in-progress": "0", "shows-collection": "0", } [2026-01-03T08:56:07Z DEBUG librespot::component] new MercuryManager [2026-01-03T08:56:07Z TRACE librespot_core::mercury] mercury response <hm://pusher/v1/connections/OGRlNGFiNjIzZjA2NDk0MTNiNDgyMjFjNGRkOGVhZDYxZjQxYWNmYitBUCt0Y3A6Ly8wYWIxNTA3NC5pcC5nZXc0LnNwb3RpZnkubmV0OjUwMDgrRjVDRTc5MkZBQTFERjYxNTY3MDU2QTM0OEIwQzQ5MUM4NTQzNUUxN0JGQkJGN0ZFQjU0QURFNTA3NDMzMUUyQw%3D%3D> is handled by dealer [2026-01-03T08:56:08Z TRACE librespot_core::login5] Got auth token: Token { access_token: "BQBUxPJ0le....", expires_in: 3600s, token_type: "Bearer", scopes: [], timestamp: SystemTime { tv_sec: 1767430568, tv_nsec: 76111335 } } [2026-01-03T08:56:08Z DEBUG librespot_connect::spirc] SpircTask::set_volume(65535) [2026-01-03T08:56:08Z DEBUG librespot_playback::player] command=AddEventSender [2026-01-03T08:56:08Z DEBUG librespot_core::dealer::manager] Launching dealer [2026-01-03T08:56:08Z TRACE librespot_core::dealer] Sent ping [2026-01-03T08:56:08Z TRACE librespot_connect::spirc] Received connection ID update: "OTFjMjE1MDktYmE3Zi00YTQyLWIxYmEtZGVhODA0YjQ5OWEyK2RlYWxlcit0Y3A6Ly8wYWIxNTAxMy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMjJDNDlCQUVFNDE1NDA1OEFBNjQ2RkQ0NzA0MTdGRkIzMUQ0RkU4QzA5QjMxNzEwNjZGNTU3RTRENjc1MjhDNA==" [2026-01-03T08:56:08Z INFO librespot_core::spclient] Resolved "gew4-spclient.spotify.com:443" as spclient access point [2026-01-03T08:56:08Z DEBUG librespot_core::http_client] Requesting https://gew4-spclient.spotify.com:443/connect-state/v1/devices/8de4ab623f0649413b48221c4dd8ead61f41acfb?product=0&country=CH&salt=876726852 [2026-01-03T08:56:08Z TRACE librespot_core::dealer] Received pong [2026-01-03T08:56:08Z DEBUG librespot_connect::spirc] successfully put connect state for 8de4ab623f0649413b48221c4dd8ead61f41acfb with connection-id OTFjMjE1MDktYmE3Zi00YTQyLWIxYmEtZGVhODA0YjQ5OWEyK2RlYWxlcit0Y3A6Ly8wYWIxNTAxMy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMjJDNDlCQUVFNDE1NDA1OEFBNjQ2RkQ0NzA0MTdGRkIzMUQ0RkU4QzA5QjMxNzEwNjZGNTU3RTRENjc1MjhDNA== [2026-01-03T08:56:08Z INFO librespot_connect::spirc] active device is <> with session <0733feeebdbd44d388dbc2d90782f4ff> [2026-01-03T08:56:30Z TRACE librespot_core::dealer::protocol] message was sent with gzip encoding [2026-01-03T08:56:30Z DEBUG librespot_connect::spirc] cluster update: Ok(DEVICES_DISAPPEARED) from fe7158fb28b5a0bcd859e7146e7e2c785733d1e6, active device: [2026-01-03T08:56:38Z TRACE librespot_core::dealer] Sent ping [2026-01-03T08:56:38Z TRACE librespot_core::dealer] Received pong ``` This is the only error I spotted `[2026-01-03T08:56:07Z DEBUG librespot_core::connection] Connection to "ap-gew4.spotify.com:4070" failed: Connection refused (os error 111)`. Any ideas? Suggestions? Thanks in advance
kerem commented 2026-02-27 19:32:21 +03:00
Author
Owner
Copy link

@twaclaw commented on GitHub (Jan 3, 2026):

I don't know what I did, but the problem is resolved. I can see my spotify connect device.

<!-- gh-comment-id:3707092897 --> @twaclaw commented on GitHub (Jan 3, 2026): I don't know what I did, but the problem is resolved. I can see my spotify connect device.
Sign in to join this conversation.
No Branch/Tag specified
Branches Tags
dev
v0.8.0
v0.7.1
v0.7.0
v0.6.0
v0.5.0
v0.4.2
v0.4.1
v0.4.0
v0.3.1
v0.3.0
v0.2.0
v0.1.6
v0.1.5
v0.1.3
v0.1.2
v0.1.1
v0.1.0
Labels
Clear labels   
A-Alsa

   
SpotifyAPI

   
Tokio 1.0

   
audio

   
bug

   
can't reproduce

   
compilation

   
dependencies

   
duplicate

   
enhancement

   
good first issue

   
help wanted

   
high priority

   
imported

   
imported

   
invalid

   
new api

   
pull-request

Mirrored from GitHub Pull Request

  
question

   
reverse engineering

   
wiki

   
wontfix
No labels
A-Alsa
SpotifyAPI
Tokio 1.0
audio
bug
can't reproduce
compilation
dependencies
duplicate
enhancement
good first issue
help wanted
high priority
imported
imported
invalid
new api
pull-request
question
reverse engineering
wiki
wontfix
Milestone
Clear milestone
No items
No milestone
Projects
Clear projects
No items
No project
Assignees
Clear assignees
No assignees
1 participant
Notifications
Due date
The due date is invalid or out of range. Please use the format "yyyy-mm-dd".

No due date set.

Dependencies

No dependencies set.

Reference
starred/librespot#761
No description provided.