[GH-ISSUE #752] `Permission denied { Response status code: 403 Forbidden }` on lyrics page after a while #1382

New issue

Closed

opened 2026-03-14 14:35:49 +03:00 by kerem · 1 comment

kerem commented

2026-03-14 14:35:49 +03:00

Owner

Originally created by @aome510 on GitHub (Jun 23, 2025).
Original GitHub issue: https://github.com/aome510/spotify-player/issues/752

Describe the bug
After a while, the lyrics page stuck at Loading.... Restart the app seems to resolve the issue

To Reproduce
Open the lyrics page and wait for a while until the issue happens

Log and backtrace

Relevant log section

2025-06-23T14:42:40.955485Z  INFO spotify_player::streaming: Got a new player event: EndOfTrack { playable_id: Track(TrackId("6kxkMrPqppgT3TQjOyhAYk")) }
2025-06-23T14:42:40.955772Z  INFO spotify_player::streaming: Got a new player event: Changed { playable_id: Track(TrackId("6je5cTal6PyeITNrOzkCoS")) }
2025-06-23T14:42:40.955841Z  INFO spotify_player::streaming: Got a new player event: Playing { playable_id: Track(TrackId("6je5cTal6PyeITNrOzkCoS")), position_ms: 0 }
2025-06-23T14:42:42.564254Z  INFO spotify_player::client::handlers: Currently playing track "Welcome to the Show" is different from the track "Popcorn" shown up in the lyrics page. Fetching new track's lyrics...
2025-06-23T14:42:42.655613Z  INFO client_request{request=GetLyrics { track_id: TrackId("6je5cTal6PyeITNrOzkCoS") }}: spotify_player::client: Successfully handled the client request, took: 90ms
2025-06-23T14:42:42.786006Z  INFO client_request{request=GetCurrentUserQueue}: spotify_player::client: Successfully handled the client request, took: 221ms
2025-06-23T14:45:48.864393Z  INFO librespot_playback::player: Loading <Nothing> with Spotify URI <spotify:track:3ym9bzwGG4uxVaJ0pLoQbM>    
2025-06-23T14:45:48.918270Z  WARN librespot_core::cdn_url: Cannot parse CDN URL expiry timestamp 'verify=1750776348-zN6Emex2mhthwmAIL%2BSG4wuH0t%2BthVYGtPeJRF1ISLQ%3D' from 'https://audio-cf.spotifycdn.com/audio/fcf90514759522a0fc8907ed30a736b8cc5cfc5d?verify=1750776348-zN6Emex2mhthwmAIL%2BSG4wuH0t%2BthVYGtPeJRF1ISLQ%3D'    
2025-06-23T14:45:49.715474Z  INFO librespot_playback::player: <Nothing> (211506 ms) loaded    
2025-06-23T14:46:18.289354Z  INFO spotify_player::streaming: Got a new player event: EndOfTrack { playable_id: Track(TrackId("6je5cTal6PyeITNrOzkCoS")) }
2025-06-23T14:46:18.289508Z  INFO spotify_player::streaming: Got a new player event: Changed { playable_id: Track(TrackId("3ym9bzwGG4uxVaJ0pLoQbM")) }
2025-06-23T14:46:18.289560Z  INFO spotify_player::streaming: Got a new player event: Playing { playable_id: Track(TrackId("3ym9bzwGG4uxVaJ0pLoQbM")), position_ms: 0 }
2025-06-23T14:46:18.535828Z  WARN librespot_audio::fetch::receive: Throughput 3 kbps lower than minimum 8, setting to minimum    
2025-06-23T14:46:19.219157Z  INFO client_request{request=GetCurrentPlayback}: spotify_player::client: Successfully handled the client request, took: 229ms
2025-06-23T14:46:19.990966Z  INFO spotify_player::client::handlers: Currently playing track "Nothing" is different from the track "Welcome to the Show" shown up in the lyrics page. Fetching new track's lyrics...
2025-06-23T14:46:20.078865Z  INFO client_request{request=GetLyrics { track_id: TrackId("3ym9bzwGG4uxVaJ0pLoQbM") }}: spotify_player::client: Successfully handled the client request, took: 87ms
2025-06-23T14:46:20.211964Z  INFO client_request{request=GetCurrentUserQueue}: spotify_player::client: Successfully handled the client request, took: 220ms
2025-06-23T14:49:20.362310Z  INFO librespot_playback::player: Loading <didn't know> with Spotify URI <spotify:track:5w7gTLyEWG3zXlawkP4Kf7>    
2025-06-23T14:49:20.418406Z  WARN librespot_core::cdn_url: Cannot parse CDN URL expiry timestamp 'verify=1750776560-DlylwOecOKnktkRryQw%2FTSyxP%2B8mkWSshpqR8BdlSv0%3D' from 'https://audio-cf.spotifycdn.com/audio/29cedd4b5c5861eb509b9c5893a1f7990f8ba6d3?verify=1750776560-DlylwOecOKnktkRryQw%2FTSyxP%2B8mkWSshpqR8BdlSv0%3D'    
2025-06-23T14:49:20.641252Z  INFO librespot_playback::player: <didn't know> (239040 ms) loaded    
2025-06-23T14:49:50.027349Z  INFO spotify_player::streaming: Got a new player event: EndOfTrack { playable_id: Track(TrackId("3ym9bzwGG4uxVaJ0pLoQbM")) }
2025-06-23T14:49:50.027541Z  INFO spotify_player::streaming: Got a new player event: Changed { playable_id: Track(TrackId("5w7gTLyEWG3zXlawkP4Kf7")) }
2025-06-23T14:49:50.027600Z  INFO spotify_player::streaming: Got a new player event: Playing { playable_id: Track(TrackId("5w7gTLyEWG3zXlawkP4Kf7")), position_ms: 0 }
2025-06-23T14:49:50.404200Z  INFO client_request{request=GetCurrentPlayback}: spotify_player::token: Getting a new authentication token...
2025-06-23T14:49:50.475321Z  INFO client_request{request=GetCurrentPlayback}: spotify_player::token: Got new token: Token { access_token: "...", expires_in: TimeDelta { secs: 3600, nanos: 0 }, expires_at: Some(2025-06-23T15:49:50.475312Z), refresh_token: None, scopes: {} }
2025-06-23T14:49:50.676852Z  INFO client_request{request=GetCurrentPlayback}: spotify_player::client: Successfully handled the client request, took: 272ms
2025-06-23T14:49:51.405135Z  INFO spotify_player::client::handlers: Currently playing track "didn't know" is different from the track "Nothing" shown up in the lyrics page. Fetching new track's lyrics...
2025-06-23T14:49:51.485837Z ERROR client_request{request=GetLyrics { track_id: TrackId("5w7gTLyEWG3zXlawkP4Kf7") }}: spotify_player::client::handlers: Failed to handle client request: Permission denied { Response status code: 403 Forbidden }
2025-06-23T14:49:51.623693Z  INFO client_request{request=GetCurrentUserQueue}: spotify_player::client: Successfully handled the client request, took: 218ms
2025-06-23T14:53:19.637995Z  INFO librespot_playback::player: Loading <LOVE COUNTDOWN (Feat. Wonstein)> with Spotify URI <spotify:track:0GnydTKmczMoKOEl1D4URI>    
2025-06-23T14:53:19.687307Z  WARN librespot_core::cdn_url: Cannot parse CDN URL expiry timestamp 'verify=1750776799-RpuWOd1zM8OCBX3ydsJxknp%2B7Xe9cVLSAOfjvD3kr%2FE%3D' from 'https://audio-cf.spotifycdn.com/audio/3db1a4f1df519309fc23dc65d5b320776739b1ed?verify=1750776799-RpuWOd1zM8OCBX3ydsJxknp%2B7Xe9cVLSAOfjvD3kr%2FE%3D'    
2025-06-23T14:53:20.276936Z  INFO librespot_playback::player: <LOVE COUNTDOWN (Feat. Wonstein)> (197613 ms) loaded    
2025-06-23T14:53:49.350805Z  INFO spotify_player::streaming: Got a new player event: EndOfTrack { playable_id: Track(TrackId("5w7gTLyEWG3zXlawkP4Kf7")) }
2025-06-23T14:53:49.350942Z  INFO spotify_player::streaming: Got a new player event: Changed { playable_id: Track(TrackId("0GnydTKmczMoKOEl1D4URI")) }
2025-06-23T14:53:49.351031Z  INFO spotify_player::streaming: Got a new player event: Playing { playable_id: Track(TrackId("0GnydTKmczMoKOEl1D4URI")), position_ms: 0 }

Originally created by @aome510 on GitHub (Jun 23, 2025). Original GitHub issue: https://github.com/aome510/spotify-player/issues/752 **Describe the bug** After a while, the lyrics page stuck at `Loading...`. Restart the app seems to resolve the issue **To Reproduce** Open the lyrics page and wait for a while until the issue happens **Log and backtrace** Relevant log section ``` 2025-06-23T14:42:40.955485Z INFO spotify_player::streaming: Got a new player event: EndOfTrack { playable_id: Track(TrackId("6kxkMrPqppgT3TQjOyhAYk")) } 2025-06-23T14:42:40.955772Z INFO spotify_player::streaming: Got a new player event: Changed { playable_id: Track(TrackId("6je5cTal6PyeITNrOzkCoS")) } 2025-06-23T14:42:40.955841Z INFO spotify_player::streaming: Got a new player event: Playing { playable_id: Track(TrackId("6je5cTal6PyeITNrOzkCoS")), position_ms: 0 } 2025-06-23T14:42:42.564254Z INFO spotify_player::client::handlers: Currently playing track "Welcome to the Show" is different from the track "Popcorn" shown up in the lyrics page. Fetching new track's lyrics... 2025-06-23T14:42:42.655613Z INFO client_request{request=GetLyrics { track_id: TrackId("6je5cTal6PyeITNrOzkCoS") }}: spotify_player::client: Successfully handled the client request, took: 90ms 2025-06-23T14:42:42.786006Z INFO client_request{request=GetCurrentUserQueue}: spotify_player::client: Successfully handled the client request, took: 221ms 2025-06-23T14:45:48.864393Z INFO librespot_playback::player: Loading <Nothing> with Spotify URI <spotify:track:3ym9bzwGG4uxVaJ0pLoQbM> 2025-06-23T14:45:48.918270Z WARN librespot_core::cdn_url: Cannot parse CDN URL expiry timestamp 'verify=1750776348-zN6Emex2mhthwmAIL%2BSG4wuH0t%2BthVYGtPeJRF1ISLQ%3D' from 'https://audio-cf.spotifycdn.com/audio/fcf90514759522a0fc8907ed30a736b8cc5cfc5d?verify=1750776348-zN6Emex2mhthwmAIL%2BSG4wuH0t%2BthVYGtPeJRF1ISLQ%3D' 2025-06-23T14:45:49.715474Z INFO librespot_playback::player: <Nothing> (211506 ms) loaded 2025-06-23T14:46:18.289354Z INFO spotify_player::streaming: Got a new player event: EndOfTrack { playable_id: Track(TrackId("6je5cTal6PyeITNrOzkCoS")) } 2025-06-23T14:46:18.289508Z INFO spotify_player::streaming: Got a new player event: Changed { playable_id: Track(TrackId("3ym9bzwGG4uxVaJ0pLoQbM")) } 2025-06-23T14:46:18.289560Z INFO spotify_player::streaming: Got a new player event: Playing { playable_id: Track(TrackId("3ym9bzwGG4uxVaJ0pLoQbM")), position_ms: 0 } 2025-06-23T14:46:18.535828Z WARN librespot_audio::fetch::receive: Throughput 3 kbps lower than minimum 8, setting to minimum 2025-06-23T14:46:19.219157Z INFO client_request{request=GetCurrentPlayback}: spotify_player::client: Successfully handled the client request, took: 229ms 2025-06-23T14:46:19.990966Z INFO spotify_player::client::handlers: Currently playing track "Nothing" is different from the track "Welcome to the Show" shown up in the lyrics page. Fetching new track's lyrics... 2025-06-23T14:46:20.078865Z INFO client_request{request=GetLyrics { track_id: TrackId("3ym9bzwGG4uxVaJ0pLoQbM") }}: spotify_player::client: Successfully handled the client request, took: 87ms 2025-06-23T14:46:20.211964Z INFO client_request{request=GetCurrentUserQueue}: spotify_player::client: Successfully handled the client request, took: 220ms 2025-06-23T14:49:20.362310Z INFO librespot_playback::player: Loading <didn't know> with Spotify URI <spotify:track:5w7gTLyEWG3zXlawkP4Kf7> 2025-06-23T14:49:20.418406Z WARN librespot_core::cdn_url: Cannot parse CDN URL expiry timestamp 'verify=1750776560-DlylwOecOKnktkRryQw%2FTSyxP%2B8mkWSshpqR8BdlSv0%3D' from 'https://audio-cf.spotifycdn.com/audio/29cedd4b5c5861eb509b9c5893a1f7990f8ba6d3?verify=1750776560-DlylwOecOKnktkRryQw%2FTSyxP%2B8mkWSshpqR8BdlSv0%3D' 2025-06-23T14:49:20.641252Z INFO librespot_playback::player: <didn't know> (239040 ms) loaded 2025-06-23T14:49:50.027349Z INFO spotify_player::streaming: Got a new player event: EndOfTrack { playable_id: Track(TrackId("3ym9bzwGG4uxVaJ0pLoQbM")) } 2025-06-23T14:49:50.027541Z INFO spotify_player::streaming: Got a new player event: Changed { playable_id: Track(TrackId("5w7gTLyEWG3zXlawkP4Kf7")) } 2025-06-23T14:49:50.027600Z INFO spotify_player::streaming: Got a new player event: Playing { playable_id: Track(TrackId("5w7gTLyEWG3zXlawkP4Kf7")), position_ms: 0 } 2025-06-23T14:49:50.404200Z INFO client_request{request=GetCurrentPlayback}: spotify_player::token: Getting a new authentication token... 2025-06-23T14:49:50.475321Z INFO client_request{request=GetCurrentPlayback}: spotify_player::token: Got new token: Token { access_token: "...", expires_in: TimeDelta { secs: 3600, nanos: 0 }, expires_at: Some(2025-06-23T15:49:50.475312Z), refresh_token: None, scopes: {} } 2025-06-23T14:49:50.676852Z INFO client_request{request=GetCurrentPlayback}: spotify_player::client: Successfully handled the client request, took: 272ms 2025-06-23T14:49:51.405135Z INFO spotify_player::client::handlers: Currently playing track "didn't know" is different from the track "Nothing" shown up in the lyrics page. Fetching new track's lyrics... 2025-06-23T14:49:51.485837Z ERROR client_request{request=GetLyrics { track_id: TrackId("5w7gTLyEWG3zXlawkP4Kf7") }}: spotify_player::client::handlers: Failed to handle client request: Permission denied { Response status code: 403 Forbidden } 2025-06-23T14:49:51.623693Z INFO client_request{request=GetCurrentUserQueue}: spotify_player::client: Successfully handled the client request, took: 218ms 2025-06-23T14:53:19.637995Z INFO librespot_playback::player: Loading <LOVE COUNTDOWN (Feat. Wonstein)> with Spotify URI <spotify:track:0GnydTKmczMoKOEl1D4URI> 2025-06-23T14:53:19.687307Z WARN librespot_core::cdn_url: Cannot parse CDN URL expiry timestamp 'verify=1750776799-RpuWOd1zM8OCBX3ydsJxknp%2B7Xe9cVLSAOfjvD3kr%2FE%3D' from 'https://audio-cf.spotifycdn.com/audio/3db1a4f1df519309fc23dc65d5b320776739b1ed?verify=1750776799-RpuWOd1zM8OCBX3ydsJxknp%2B7Xe9cVLSAOfjvD3kr%2FE%3D' 2025-06-23T14:53:20.276936Z INFO librespot_playback::player: <LOVE COUNTDOWN (Feat. Wonstein)> (197613 ms) loaded 2025-06-23T14:53:49.350805Z INFO spotify_player::streaming: Got a new player event: EndOfTrack { playable_id: Track(TrackId("5w7gTLyEWG3zXlawkP4Kf7")) } 2025-06-23T14:53:49.350942Z INFO spotify_player::streaming: Got a new player event: Changed { playable_id: Track(TrackId("0GnydTKmczMoKOEl1D4URI")) } 2025-06-23T14:53:49.351031Z INFO spotify_player::streaming: Got a new player event: Playing { playable_id: Track(TrackId("0GnydTKmczMoKOEl1D4URI")), position_ms: 0 } ```