spotifyd icon indicating copy to clipboard operation
spotifyd copied to clipboard

Spotifyd crash on track loading

Open klh opened this issue 1 year ago • 11 comments

heres a log when running the debug versions on ubuntu 24.04

./spotifyd --no-daemon Loading config from "/etc/spotifyd.conf" No username specified. Checking username_cmd No username_cmd specified No password specified. Checking password_cmd No password_cmd specified No proxy specified Using software volume controller. no usable credentials found, enabling discovery Connecting to AP "ap2-gew4.spotify.com:443" Authenticated as "114433150" ! Cannot save credentials to cache: Permission denied (os error 13) Mixing with softvol and volume control: Log(60.0) Country: "DK" Using AlsaSink with format: S32 Cannot save volume to cache: Permission denied (os error 13) Fetching autoplay context uri Loading <Garden of Love> with Spotify URI spotify:track:4nnTUfKDl2XkwvHjZHmT6E No autoplay_uri found AutoplayError: MercuryError channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 191170311859469426423200040418154113560, audio_type: Track }>: () Loading <Flowers of Eventide> with Spotify URI spotify:track:3fHjx3ruK4a1OYPoKP80XR channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 142081239768991894398514149858183474223, audio_type: Track }>: () Loading <Diary of a Rose> with Spotify URI spotify:track:610xMaOMK9GylOrNXNY86R channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 262756127457373075864999440008083417689, audio_type: Track }>: () Loading <People Talk Too Much> with Spotify URI spotify:track:4ss7wUyzuLH26NvOBJjFuq channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 154851299808813996972192064036997059478, audio_type: Track }>: () Loading <Making Plans for Nigel> with Spotify URI spotify:track:1wLGaZpnYpcFggvtmCPWUh channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 66757529502991446537255787334206295889, audio_type: Track }>: () Loading <Hide To Seek> with Spotify URI spotify:track:61gEaXyQAtYaBcJxyYdmc9 channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 262939086924336323811252190799368775457, audio_type: Track }>: () Loading <Gentle Persuasion> with Spotify URI spotify:track:4ZwQ1QuIs43sekpZpsTeo6 channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 39129898436559754098773695821424276475, audio_type: Track }>: () Loading <La Californie> with Spotify URI spotify:track:1g7tqO5lzjQIQxdVZapBwf channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 55029952434040089990374237913439267675, audio_type: Track }>: () Loading <Silky Spring> with Spotify URI spotify:track:2kRDxvlF2LyVkAx94UQPhT channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 102046387578937613867729659504398016833, audio_type: Track }>: () Loading <Grass is Grass> with Spotify URI spotify:track:2Fsv6m5KIkPld2uWx7i6Kh channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 116553691544993384063498060646856169101, audio_type: Track }>: () No context to update from! The application panicked (crashed). Message: Map must not be polled after it returned Poll::Ready Location: /home/kk/.cargo/registry/src/index.crates.io-6f17d22bba15001f/futures-util-0.3.28/src/future/future/map.rs:62

Backtrace omitted. Run with RUST_BACKTRACE=1 environment variable to display it. Run with RUST_BACKTRACE=full to include source snippets. The application panicked (crashed). Message: called Option::unwrap() on a None value Location: src/main_loop.rs:196

Backtrace omitted. Run with RUST_BACKTRACE=1 environment variable to display it. Run with RUST_BACKTRACE=full to include source snippets. Player thread Error: Any { .. }

klh avatar Sep 04 '24 19:09 klh

heres a --verbose output:

ound interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to [ff02::fb]:5353 received packet from [fe80::5605:dbff:feab:adf4%2]:5353 received packet from [fe80::5605:dbff:feab:adf4%2]:5353 with no query received packet from 192.168.0.181:5353 received packet from 192.168.0.181:5353 with no query received packet from 192.168.0.103:5353 received packet from 192.168.0.103:5353 with no query received packet from 192.168.0.191:5353 received question: IN _spotify-connect._tcp.local found interface Interface { name: "enp2s0", addr: V4(Ifv4Addr { ip: 192.168.0.123, netmask: 255.255.255.0, broadcast: Some(192.168.0.255) }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to 224.0.0.251:5353 received packet from [fe80::4ff:b777:dfa2:da62%2]:5353 received question: IN _spotify-connect._tcp.local found interface Interface { name: "enp2s0", addr: V4(Ifv4Addr { ip: 192.168.0.123, netmask: 255.255.255.0, broadcast: Some(192.168.0.255) }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to [ff02::fb]:5353 received packet from 192.168.0.123:5353 received packet from 192.168.0.123:5353 with no query received packet from [fe80::5605:dbff:feab:adf4%2]:5353 received packet from [fe80::5605:dbff:feab:adf4%2]:5353 with no query received packet from 192.168.0.181:5353 received packet from 192.168.0.181:5353 with no query received packet from 192.168.0.139:5353 received question: IN _companion-link._tcp.local received question: IN _hap._tcp.local received question: IN _hap._udp.local received question: IN _rdlink._tcp.local received question: IN _sleep-proxy._udp.local received packet from [fe80::1825:7c0b:b8a0:ad3d%2]:5353 received question: IN _companion-link._tcp.local received question: IN _hap._tcp.local received question: IN _hap._udp.local received question: IN _rdlink._tcp.local received question: IN _sleep-proxy._udp.local received packet from [fd38:45dc:9764:5d49:7274:14ff:feb8:ee5b]:5353 received packet from [fd38:45dc:9764:5d49:7274:14ff:feb8:ee5b]:5353 with no query received packet from 192.168.0.151:5353 received packet from 192.168.0.151:5353 with no query received packet from 192.168.0.191:5353 received question: IN _spotify-connect._tcp.local found interface Interface { name: "enp2s0", addr: V4(Ifv4Addr { ip: 192.168.0.123, netmask: 255.255.255.0, broadcast: Some(192.168.0.255) }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to 224.0.0.251:5353 received packet from 192.168.0.123:5353 received packet from 192.168.0.123:5353 with no query received packet from [fe80::4ff:b777:dfa2:da62%2]:5353 received question: IN _spotify-connect._tcp.local found interface Interface { name: "enp2s0", addr: V4(Ifv4Addr { ip: 192.168.0.123, netmask: 255.255.255.0, broadcast: Some(192.168.0.255) }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to [ff02::fb]:5353 received packet from [fe80::5605:dbff:feab:adf4%2]:5353 received packet from [fe80::5605:dbff:feab:adf4%2]:5353 with no query received packet from 192.168.0.181:5353 received packet from 192.168.0.181:5353 with no query received packet from 192.168.0.103:5353 received packet from 192.168.0.103:5353 with no query received packet from 192.168.0.139:5353 received question: IN _companion-link._tcp.local received question: IN _hap._tcp.local received question: IN _hap._udp.local received question: IN _rdlink._tcp.local received question: IN _sleep-proxy._udp.local received packet from [fe80::1825:7c0b:b8a0:ad3d%2]:5353 received question: IN _companion-link._tcp.local received question: IN _hap._tcp.local received question: IN _hap._udp.local received question: IN _rdlink._tcp.local received question: IN _sleep-proxy._udp.local received packet from 192.168.0.14:5353 received question: IN _netatmo-lcomm._tcp.local received question: IN Netatmo-Presence-g7f5078.local received packet from [fe80::72ee:50ff:fe7f:4bb2%2]:5353 received question: IN _netatmo-lcomm._tcp.local received question: IN Netatmo-Presence-g7f5078.local received packet from 192.168.0.191:5353 received question: IN _spotify-connect._tcp.local found interface Interface { name: "enp2s0", addr: V4(Ifv4Addr { ip: 192.168.0.123, netmask: 255.255.255.0, broadcast: Some(192.168.0.255) }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to 224.0.0.251:5353 received packet from [fe80::4ff:b777:dfa2:da62%2]:5353 received question: IN _spotify-connect._tcp.local found interface Interface { name: "enp2s0", addr: V4(Ifv4Addr { ip: 192.168.0.123, netmask: 255.255.255.0, broadcast: Some(192.168.0.255) }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to [ff02::fb]:5353 received packet from 192.168.0.123:5353 received packet from 192.168.0.123:5353 with no query received packet from [fe80::5605:dbff:feab:adf4%2]:5353 received packet from [fe80::5605:dbff:feab:adf4%2]:5353 with no query received packet from 192.168.0.191:5353 received question: IN lb._dns-sd._udp.local received question: IN _airport._tcp.local received question: IN _rdlink._tcp.local received question: IN _hap._tcp.local received question: IN _airplay._tcp.local received question: IN _hap._udp.local received question: IN _ssh._tcp.local received question: IN _ftp._tcp.local received question: IN _telnet._tcp.local received question: IN _daap._tcp.local received question: IN _touch-remote._tcp.local received question: IN _uscan._tcp.local received question: IN _printer._tcp.local received question: IN _ptp._tcp.local received question: IN _pdl-datastream._tcp.local received question: IN _scanner._tcp.local received question: IN _ipp._tcp.local received question: IN _ippusb._tcp.local received question: IN _ipps._tcp.local received question: IN _uscans._tcp.local received question: IN _afpovertcp._tcp.local received question: IN _rfb._tcp.local received question: IN _adisk._tcp.local received question: IN _apple-mobdev._tcp.local received question: IN 91b907fc._sub._apple-mobdev2._tcp.local received question: IN _apple-pairable._tcp.local received question: IN _companion-link._tcp.local received question: IN _airdrop._tcp.local received packet from 192.168.0.191:5353 received question: IN lb._dns-sd._udp.local received question: IN _airport._tcp.local received question: IN _rdlink._tcp.local received question: IN _hap._tcp.local received question: IN _airplay._tcp.local received question: IN _hap._udp.local received question: IN _ssh._tcp.local received question: IN _ftp._tcp.local received question: IN _telnet._tcp.local received question: IN _daap._tcp.local received question: IN _touch-remote._tcp.local received question: IN _uscan._tcp.local received question: IN _printer._tcp.local received question: IN _ptp._tcp.local received question: IN _pdl-datastream._tcp.local received question: IN _scanner._tcp.local received question: IN _ipp._tcp.local received question: IN _ippusb._tcp.local received question: IN _ipps._tcp.local received question: IN _uscans._tcp.local received question: IN _afpovertcp._tcp.local received question: IN _rfb._tcp.local received question: IN _adisk._tcp.local received question: IN _apple-mobdev._tcp.local received question: IN 91b907fc._sub._apple-mobdev2._tcp.local received question: IN _apple-pairable._tcp.local received question: IN _companion-link._tcp.local received question: IN _airdrop._tcp.local received packet from 192.168.0.14:5353 received packet from 192.168.0.14:5353 with no query received packet from [fe80::72ee:50ff:fe7f:4bb2%2]:5353 received packet from [fe80::72ee:50ff:fe7f:4bb2%2]:5353 with no query received packet from 192.168.0.14:5353 received packet from 192.168.0.14:5353 with no query received packet from [fe80::72ee:50ff:fe7f:4bb2%2]:5353 received packet from [fe80::72ee:50ff:fe7f:4bb2%2]:5353 with no query received packet from 192.168.0.151:5353 received packet from 192.168.0.151:5353 with no query received packet from [fd38:45dc:9764:5d49:7274:14ff:feb8:ee5b]:5353 received packet from [fd38:45dc:9764:5d49:7274:14ff:feb8:ee5b]:5353 with no query received packet from 192.168.0.98:5353 received packet from 192.168.0.98:5353 with no query received packet from [fe80::fa0d:acff:fe79:ab08%2]:5353 received packet from [fe80::fa0d:acff:fe79:ab08%2]:5353 with no query received packet from 192.168.0.192:5353 received packet from 192.168.0.192:5353 with no query received packet from [fe80::4a2:8a46:aaee:c838%2]:5353 received packet from [fe80::4a2:8a46:aaee:c838%2]:5353 with no query POST "/" {} Connecting to AP "ap2-gew4.spotify.com:443" Authenticated as "114433150" ! new Session[0] Mixing with softvol and volume control: Log(60.0) Normalisation Type: Auto Normalisation Pregain: -5.0 dB Normalisation Threshold: -2.0 dBFS Normalisation Method: Dynamic Normalisation Attack: 5 ms Normalisation Release: 100 ms Normalisation Knee: 5 dB Session[0] strong=3 weak=1 Country: "DK" new Spirc[0] canonical_username: 114433150 new MercuryManager Input volume 32767 mapped to: 3.16% new Player[0] Using AlsaSink with format: S32 command=AddEventSender command=VolumeSet(32767) received packet from 192.168.0.191:5353 received question: IN _spotify-connect._tcp.local found interface Interface { name: "enp2s0", addr: V4(Ifv4Addr { ip: 192.168.0.123, netmask: 255.255.255.0, broadcast: Some(192.168.0.255) }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to 224.0.0.251:5353 received packet from [fe80::4ff:b777:dfa2:da62%2]:5353 received question: IN spotify-connect.tcp.local found interface Interface { name: "enp2s0", addr: V4(Ifv4Addr { ip: 192.168.0.123, netmask: 255.255.255.0, broadcast: Some(192.168.0.255) }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:27f0:4394:456d:e7d5, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:fc90:9036:5416:1111, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } found interface Interface { name: "enp2s0", addr: V6(Ifv6Addr { ip: fd38:45dc:9764:5d49:5605:dbff:feab:adf4, netmask: ffff:ffff:ffff:ffff::, broadcast: None }) } sending packet to [ff02::fb]:5353 received packet from 192.168.0.123:5353 received packet from 192.168.0.123:5353 with no query received packet from [fe80::5605:dbff:feab:adf4%2]:5353 received packet from [fe80::5605:dbff:feab:adf4%2]:5353 with no query unknown subscription uri=hm://remote/user/114433150/ subscribed uri=hm://remote/user/114433150/ count=0 received packet from 192.168.0.103:5353 received packet from 192.168.0.103:5353 with no query received packet from 192.168.0.181:5353 received packet from 192.168.0.181:5353 with no query kMessageTypeLoad "Klaus’s MacBook Pro" d9cde253dfcc35345334f93e42d5237459cb0d64 1048019035 1725477387485 kPlayStatusPlay State: context_uri: "spotify:playlist:37i9dQZEVXcWoUr9XU54xI" index: 10 position_ms: 83 status: kPlayStatusPlay position_measured_at: 1725477387627 context_description: "" shuffle: true repeat: false playing_from_fallback: true row: 0 playing_track_index: 10 track {gid: "\n\344\235\235\013dKt\235\222\352]\344\005R\347"} track {gid: "\305\3209\342\020\336OU\203\272zu\201\253g!"} track {gid: "t\177F\210\253WL\236\203.\342\212^\206S\226"} track {gid: "\035p$\361\241CA\337\276\217\007\234\016\272\263\373"} track {gid: "q\222\231+\250\353O\233\266c\277\316\005\327\351i"} track {gid: "7G\353^\370\260@'\215\306\360\262\t\032D\027"} track {gid: "\241\242\366vVLO\006\253\240\t\225\366\354\231\205"} track {gid: "\332M\031\216^mM\267\237\231-\r&\227\3629"} track {gid: "\305\254\375H\357+Fh\204Jn\305\007\200*Y"} track {gid: ")fb!vQB\006\241\026,\004v\353["} track {gid: "\240\334\327\263\022\335F\373\266\306\371|\341\340\226x"} track {gid: "L\305kZ\341\201JJ\230i#B\344m\241A"} track {gid: "z\001r:\022&D\340\260O\024]\364\241\016\206"} track {gid: "29\010Rv\373H*\202\220U\337\023\355\017Q"} track {gid: "W\257l\251\347\220E\036\235\204h\330\022\226\215"} Frame has 15 tracks Fetching autoplay context uri Sending status to server: [kPlayStatusPlay] command=SetAutoNormaliseAsAlbum(false) command=Load(SpotifyId { id: 213823159540208314897219512876648142456, audio_type: Track }, true, 83) Sending status to server: [kPlayStatusPlay] No autoplay_uri found AutoplayError: MercuryError Loading <Let's Take a Trip Together> with Spotify URI spotify:track:4TxHfNgeum23DHbz1dOZle Downloading file 563e6fdab4ca94bc84ec9ba87c0db969f6f232fd new ChannelManager channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 213823159540208314897219512876648142456, audio_type: Track }>: () At track 12 of 15 <"spotify:playlist:37i9dQZEVXcWoUr9XU54xI"> update [true] Sending status to server: [kPlayStatusPlay] command=Load(SpotifyId { id: 102046387578937613867729659504398016833, audio_type: Track }, true, 0) Sending status to server: [kPlayStatusPlay] Loading <Silky Spring> with Spotify URI spotify:track:2kRDxvlF2LyVkAx94UQPhT Downloading file 39dfd6d60d03cce0e1275d0b5e9b0f02c6fa8248 channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 102046387578937613867729659504398016833, audio_type: Track }>: () At track 13 of 15 <"spotify:playlist:37i9dQZEVXcWoUr9XU54xI"> update [true] command=Load(SpotifyId { id: 162173324578163508063278372522830139014, audio_type: Track }, true, 0) Sending status to server: [kPlayStatusPlay] Sending status to server: [kPlayStatusPlay] Loading <It's You> with Spotify URI spotify:track:3IdIW9NqNyz9ulLMHd8IBM Downloading file 718b2c53d4333ac243e3126478092fae8726accd channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 162173324578163508063278372522830139014, audio_type: Track }>: () At track 14 of 15 <"spotify:playlist:37i9dQZEVXcWoUr9XU54xI"> update [true] Sending status to server: [kPlayStatusPlay] command=Load(SpotifyId { id: 66757529502991446537255787334206295889, audio_type: Track }, true, 0) Sending status to server: [kPlayStatusPlay] Loading <Making Plans for Nigel> with Spotify URI spotify:track:1wLGaZpnYpcFggvtmCPWUh Downloading file de7b54728a438282adec7add1bf27cc12679948a channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 66757529502991446537255787334206295889, audio_type: Track }>: () At track 15 of 15 <"spotify:playlist:37i9dQZEVXcWoUr9XU54xI"> update [true] Sending status to server: [kPlayStatusPlay] command=Load(SpotifyId { id: 116553691544993384063498060646856169101, audio_type: Track }, true, 0) Sending status to server: [kPlayStatusPlay] Loading <Grass is Grass> with Spotify URI spotify:track:2Fsv6m5KIkPld2uWx7i6Kh Downloading file 7e13f4d9ab38b8e8289eb1b1173316ca6c89516b channel error: 2 0 Unable to load encrypted file: ChannelError Skipping to next track, unable to load track <SpotifyId { id: 116553691544993384063498060646856169101, audio_type: Track }>: () At track 16 of 15 <"spotify:playlist:37i9dQZEVXcWoUr9XU54xI"> update [true] Extending playlist spotify:playlist:37i9dQZEVXcWoUr9XU54xI No context to update from! Sending status to server: [kPlayStatusPlay] command=SetAutoNormaliseAsAlbum(false) The application panicked (crashed). Message: Map must not be polled after it returned Poll::Ready Location: /home/kk/.cargo/registry/src/index.crates.io-6f17d22bba15001f/futures-util-0.3.28/src/future/future/map.rs:62

Backtrace omitted. Run with RUST_BACKTRACE=1 environment variable to display it. Run with RUST_BACKTRACE=full to include source snippets. drop PlayerInternal[0] The application panicked (crashed). Message: called Option::unwrap() on a None value Location: src/main_loop.rs:196

Backtrace omitted. Run with RUST_BACKTRACE=1 environment variable to display it. Run with RUST_BACKTRACE=full to include source snippets. drop Spirc[0] Shutting down player thread ... Player thread Error: Any { .. } drop Session[0] drop ChannelManager drop MercuryManager drop Dispatch

klh avatar Sep 04 '24 19:09 klh

digging further into this it seems like a few endpoint on Spotify's side are having problems. librespot has blacklisted 2 of them in release 0.4.2

klh avatar Sep 04 '24 19:09 klh

ok - recompiling latest using a locally built version of the librespot dev branch seems to work - librespot has fixed it in dev branch but it is not working in any of the releases.

klh avatar Sep 04 '24 19:09 klh

What does it mean for using Spotifyd? Is it possible to fix the problem by changing a version or edit something in the configuration?

Kowalski127 avatar Sep 04 '24 20:09 Kowalski127

For anyone having an issue with spotifyd skipping or crashing on any new tracks. There is no fix for spotifyd itself as of yet, you will have to migrate to the DEV version of librespot -- and this requires installing rust and compiling the latest DEV release.

1: Install rust & cargo 

FreeBSD
# pkg install rust
Linux (as per https://doc.rust-lang.org/cargo/getting-started/installation.html)
# curl https://sh.rustup.rs -sSf | sh
2: Execute compile 
# cargo install --git https://github.com/librespot-org/librespot.git --branch dev --no-default-features --features pulseaudio-backend 

replace pulse-backend with alsa-backend if you don't use pulse in the command above

Other backends can be compiled and found here: https://github.com/librespot-org/librespot/wiki/Compiling#addition-features

3: Copy ~/.cargo/bin/librespot to your executable dir as root

FreeBSD
# cp ~/.cargo/bin/librespot /usr/local/bin/
Linux
# cp ~/.cargo/bin/librespot /usr/bin/

assuming you previously setup Spotifyd

4: Execute: 
/path/to/librespot -C /path_to/spotifyd/cache/ -c /path_to/spotifyd/ -b 320 -n some_ident -f F32 &

Adapted from the instructions on: https://github.com/librespot-org/librespot/issues/1322#issuecomment-2328160807

whisperzer0 avatar Sep 04 '24 23:09 whisperzer0

Had the same issue and had to install librespot 0.5.0dev on a Raspberry Pi 3 with Debian Bullseye. Cargo is too old on this debian version, so you have to install rustup

export RUSTUP_HOME=/opt/rust/rustup
export CARGO_HOME=/opt/rust/cargo
curl https://sh.rustup.rs -sSf | sh -s -- --default-toolchain stable --profile default --no-modify-path -y

and then export your new PATH variable

export PATH="/opt/rust/cargo/bin:$PATH"

Then I could go and use

cargo build --release

To build the latest librespot, then it's like @whisperzer0 already mentioned, you can run librespot in client mode (no daemon mode AFAIK)

shadzik avatar Sep 05 '24 08:09 shadzik

For anyone having an issue with spotifyd skipping or crashing on any new tracks. There is no fix for spotifyd itself as of yet, you will have to migrate to the DEV version of librespot -- and this requires installing rust and compiling the latest DEV release.

1: Install rust & cargo 

FreeBSD
# pkg install rust
Linux (as per https://doc.rust-lang.org/cargo/getting-started/installation.html)
# curl https://sh.rustup.rs -sSf | sh
2: Execute compile 
# cargo install --git https://github.com/librespot-org/librespot.git --branch dev --no-default-features --features pulse-backend 

replace pulse-backend with alsa-backend if you don't use pulse in the command above

Other backends can be compiled and found here: https://github.com/librespot-org/librespot/wiki/Compiling#addition-features

3: Copy ~/.cargo/bin/librespot to your executable dir as root

FreeBSD
# cp ~/.cargo/bin/librespot /usr/local/bin/
Linux
# cp ~/.cargo/bin/librespot /usr/bin/

assuming you previously setup Spotifyd

4: Execute: 
/path/to/librespot -C /path_to/spotifyd/cache/ -c /path_to/spotifyd/ -b 320 -n some_ident -f F32 &

Adapted from the instructions on: librespot-org/librespot#1322 (comment)

In step two you want to specify the 'pulseaudio-backend' feature, otherwise you get an error. Following this method I got HTTP 403 errors with librespot.

What did fix things for me was pulling the sources and updating the librespot dependencies to version '0.4.2' instead of '0.4'. Rebuilding spotifyd allowed me to play music again.

diff --git a/Cargo.toml b/Cargo.toml
index 71a3cd0..8093137 100644
--- a/Cargo.toml
+++ b/Cargo.toml
@@ -28,11 +28,11 @@ structopt = "0.3.17"
 tokio = {version = "1.26.0", features = ["signal", "rt-multi-thread", "process", "io-std"] }
 tokio-stream = "0.1.7"
 url = "2.2.2"
-librespot-audio = { version = "0.4", default-features = false }
-librespot-playback = { version = "0.4", default-features = false }
-librespot-core = { version = "0.4" }
-librespot-discovery = { version = "0.4" }
-librespot-connect = { version = "0.4" }
+librespot-audio = { version = "0.4.2", default-features = false }
+librespot-playback = { version = "0.4.2", default-features = false }
+librespot-core = { version = "0.4.2" }
+librespot-discovery = { version = "0.4.2" }
+librespot-connect = { version = "0.4.2" }
 toml = "0.7"
 color-eyre = "0.6"
 directories = "5.0.1"

lordievader avatar Sep 05 '24 10:09 lordievader

In step two you want to specify the 'pulseaudio-backend' feature, otherwise you get an error. Following this method I got HTTP 403 errors with librespot.

mb, thanks for the heads-up. I've edited my post to rectified this.

whisperzer0 avatar Sep 06 '24 22:09 whisperzer0

Confirmation here, Updating to 0.4.2 and bumping deps with cargo update fixes the issue

klh avatar Sep 07 '24 12:09 klh

Unfortunately not for long it seems… the issue is back for me.

artenverho avatar Sep 07 '24 18:09 artenverho

Unfortunately not for long it seems… the issue is back for me.

Check that youre not running the old one by mistake - works perfectly here

klh avatar Sep 08 '24 06:09 klh

I'm gonna close this since it seems to be related to an old librespot version. Feel free to (ask to) reopen, however!

eladyn avatar Mar 08 '25 01:03 eladyn