Spotify playlists do not show up in MPD

MrTolchock · January 16, 2024, 1:50pm

I have a python script which connects to Mopidy via MDP. In essence, it is just the following:

from mpd import MPDClient
MPD_client = MPDClient()
MPD_client.connect("localhost", 6600)
print(MPD_client.status())

However, no playlists are loaded, as the print result is:

{‘volume’: ‘28’, ‘repeat’: ‘0’, ‘random’: ‘0’, ‘single’: ‘0’, ‘consume’: ‘0’, ‘playlist’: ‘0’, ‘playlistlength’: ‘0’, ‘xfade’: ‘0’, ‘state’: ‘stop’}.

However, Spotify was loaded and Mopidy shows 16 refreshed Spotify playlists. Also the MPD connection from the python script shows up in the last row:

INFO [MainThread] mopidy.config Loading config from file:///usr/share/mopidy/conf.d/mopidy.conf
INFO [MainThread] mopidy.config Loading config from file:///etc/mopidy/mopidy.conf
INFO [MainThread] mopidy.config Loading config from command line options
INFO [MainThread] mopidy.main Enabled extensions: stream, alsamixer, mpd, m3u, softwaremixer, spotify
INFO [MainThread] mopidy.main Disabled extensions: http, file
INFO [MainThread] mopidy.commands Starting Mopidy mixer: AlsaMixer
INFO [MainThread] mopidy_alsamixer.mixer Mixing using ALSA, card 0, mixer control ‘Digital’.
INFO [MainThread] mopidy.commands Starting Mopidy audio
INFO [MainThread] mopidy.commands Starting Mopidy backends: SpotifyBackend, M3UBackend, StreamBackend
INFO [Audio-3] mopidy.audio.actor Audio output set to “alsasink”
INFO [SpotifyBackend-4] mopidy_spotify.web Logged into Spotify Web API as ________
INFO [SpotifyBackend-4] mopidy_spotify.playlists Refreshing Spotify playlists
INFO [SpotifyBackend-4] mopidy_spotify.playlists Refreshed 16 Spotify playlists
INFO [MainThread] mopidy.commands Starting Mopidy core
INFO [MainThread] mopidy.commands Starting Mopidy frontends: MpdFrontend
INFO [MainThread] mopidy_mpd.actor MPD server running at [::]:6600
INFO [MainThread] mopidy.commands Starting GLib mainloop
INFO [MpdSession-9] mopidy_mpd.session New MPD connection from [::1]:44586

Do you have any idea what is going wrong? The same script was working a few weeks ago.

kingosticks · January 16, 2024, 3:28pm

Can you please check you have the very latest version of Mopidy-spotify from git? I checked in a few fixes recently following Spotify’s random silent API changes.

MrTolchock · January 16, 2024, 4:24pm

I ran the following, but the problem persists:

sudo python3 -m pip uninstall mopidy-spotify
sudo python3 -m pip install https://github.com/mopidy/mopidy-spotify/archive/main.zip

kingosticks · January 16, 2024, 5:53pm

Oh hang on, you are just doing an MPD status command? What are you expecting to see? Unless you have explicitly loaded a playlist (not shown in your script) then the output you’ve provided looks exactly as I would expect… See Protocol — Music Player Daemon 0.24~git documentation

MrTolchock · January 16, 2024, 8:35pm

You are right! I got the problem wrong, the strange thing actually happens a few steps later:

from mpd import MPDClient
MPD_client = MPDClient()
MPD_client.connect("localhost", 6600)
playlist = MPD_client.listplaylists()[0]
print(playlist)
MPD_client.load(playlist["playlist"])

The “listplaylists” command gives me a correct list of the playlists from Spotify. The print(playlist) output is:

{‘playlist’: ‘test’, ‘last-modified’: ‘2024-01-16T20:29:59Z’}.

However, the code fails if I try to load one of these playlists:

MPD_client.load(playlist[“playlist”])
File “/home/pi/.local/lib/python3.9/site-packages/mpd/base.py”, line 478, in mpd_command
return wrapper(self, name, args, callback)
File “/home/pi/.local/lib/python3.9/site-packages/mpd/base.py”, line 541, in _execute
return retval()
File “/home/pi/.local/lib/python3.9/site-packages/mpd/base.py”, line 463, in command_callback
res = function(self, self._read_lines())
File “/home/pi/.local/lib/python3.9/site-packages/mpd/base.py”, line 396, in _parse_nothing
for line in lines:
File “/home/pi/.local/lib/python3.9/site-packages/mpd/base.py”, line 595, in _read_lines
line = self._read_line()
File “/home/pi/.local/lib/python3.9/site-packages/mpd/base.py”, line 584, in _read_line
raise CommandError(error)
mpd.base.CommandError: [50@0] {load} No such playlist

kingosticks · January 16, 2024, 9:01pm

Could you run Mopidy with verbose logging and then reproduce the problem?

MrTolchock · January 17, 2024, 7:53pm

It works now! I have no clue why, probably the new mopidy-spotify version, which is basically the only thing I changed. Sorry for the circumstances, I don’t know why it did not work yesterday, not all changes must have gone through.
I highly appreciate your relentless efforts, it was not the first time you helped me, and my kids really love their radio!

kingosticks · January 17, 2024, 9:08pm

No worries. I’ve done this to myself anyway since there’s been no new release and hence no obvious version number for people to check. Need to resolve that.

MrTolchock · January 19, 2024, 7:23pm

Unfortunately, the problem came back from nothing, after it disappeared miraculously. Here is the verbose Mopidy log:

Jan 19 20:14:46 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy.__main__ Enabled extensions: mpd, m3u, stream, spotify, softwaremixer, alsamixer
Jan 19 20:14:46 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy.__main__ Disabled extensions: file, http
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] mopidy.commands Available Mopidy mixers: AlsaMixer, SoftwareMixer
Jan 19 20:14:47 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy.commands Starting Mopidy mixer: AlsaMixer
Jan 19 20:14:47 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy_alsamixer.mixer Mixing using ALSA, card 0, mixer control 'Digital'.
Jan 19 20:14:47 ghettopi3 [mopidy1905]: DEBUG    [MainThread] pykka Registered AlsaMixer (urn:uuid:f3dcaa7d-12c7-467a-943c-e0a8mopidy765f1c46)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Starting AlsaMixer (urn:uuid:f3dcaa7d-12c7-467a-943c-e0a8765f1c46)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] mopidy.commands Mixer volume left unchanged
Jan 19 20:14:47 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy.commands Starting Mopidy audio
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Registered Audio (urn:uuid:52fd0cb6-ce50-4eb9-b4b9-c7954749a336)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Starting Audio (urn:uuid:52fd0cb6-ce50-4eb9-b4b9-c7954749a336)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy.commands Starting Mopidy backends: M3UBackend, StreamBackend, SpotifyBackend
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Registered M3UBackend (urn:uuid:f145bfd9-5a75-4ebe-9db1-f89fed8d1160)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Starting M3UBackend (urn:uuid:f145bfd9-5a75-4ebe-9db1-f89fed8d1160)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: TRACE    [MainThread] mopidy.internal.timer M3UBackend took 8ms
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Registered StreamBackend (urn:uuid:209ec5c3-9254-4fab-bff8-ed0debe27856)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Starting StreamBackend (urn:uuid:209ec5c3-9254-4fab-bff8-ed0debe27856)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: TRACE    [MainThread] mopidy.internal.timer StreamBackend took 29ms
Jan 19 20:14:47 ghettopi3 mopidy[1905]: INFO     [Audio-3] mopidy.audio.actor Audio output set to "alsasink"
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Registered SpotifyBackend (urn:uuid:ece693c1-d102-46ae-bdc4-0cedc0fff9d0)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Starting SpotifyBackend (urn:uuid:ece693c1-d102-46ae-bdc4-0cedc0fff9d0)
Jan 19 20:14:47 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'me'
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.web Fetching OAuth token from https://auth.mopidy.com/spotify/token
Jan 19 20:14:47 ghettopi3 mopidy[1905]: TRACE    [MainThread] mopidy.internal.timer SpotifyBackend took 33ms
Jan 19 20:14:47 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool Starting new HTTPS connection (1): auth.mopidy.com:443
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://auth.mopidy.com:443 "POST /spotify/token HTTP/1.1" 200 612
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://auth.mopidy.com/spotify/token expires at: 2024-01-19 20:14:>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.web Token expires in 3600 seconds.
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.web Token scopes: playlist-read-private playlist-read-collaborative streaming user-library-r>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool Starting new HTTPS connection (1): api.spotify.com:443
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/me HTTP/1.1" 200 None
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/me expires at: 2024-01-19 20:14:48.19777>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: INFO     [SpotifyBackend-6] mopidy_spotify.web Logged into Spotify Web API as w0w3317r7benm3tmf2l9mk02q
Jan 19 20:14:48 ghettopi3 mopidy[1905]: INFO     [SpotifyBackend-6] mopidy_spotify.playlists Refreshing Spotify playlists
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'users/w0w3317r7benm3tmf2l9mk02q/playlists'
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'users/w0w3317r7benm3tmf2l9mk02q/playlists?limit=50'
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/users/w0w3317r7benm3tmf2l9mk02q/playlists?limit>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/users/w0w3317r7benm3tmf2l9mk02q/playlist>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:4UygHderJcI6LjQGiJsi1M'"
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/4UygHderJcI6LjQGiJsi1M'
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/4UygHderJcI6LjQGiJsi1M?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/4UygHderJcI6LjQGiJsi1M?fields=name%2C>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/4UygHderJcI6LjQGiJsi1M?fields=>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:1rIPkaJeXXPIObBXqQJyYn'"
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/1rIPkaJeXXPIObBXqQJyYn'
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/1rIPkaJeXXPIObBXqQJyYn?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/1rIPkaJeXXPIObBXqQJyYn?fields=name%2C>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/1rIPkaJeXXPIObBXqQJyYn?fields=>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:2gqrNFBwcCpelmBSkrixFH'"
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/2gqrNFBwcCpelmBSkrixFH'
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/2gqrNFBwcCpelmBSkrixFH?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/2gqrNFBwcCpelmBSkrixFH?fields=name%2C>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/2gqrNFBwcCpelmBSkrixFH?fields=>
Jan 19 20:14:48 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:0lnzJ1jrjvz0ngl4CE7IiJ'"
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/0lnzJ1jrjvz0ngl4CE7IiJ'
Jan 19 20:14:48 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/0lnzJ1jrjvz0ngl4CE7IiJ?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/0lnzJ1jrjvz0ngl4CE7IiJ?fields=name%2C>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/0lnzJ1jrjvz0ngl4CE7IiJ?fields=>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:38sHvws9N3bYBfPRdbiLzE'"
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/38sHvws9N3bYBfPRdbiLzE'
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/38sHvws9N3bYBfPRdbiLzE?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/38sHvws9N3bYBfPRdbiLzE?fields=name%2C>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/38sHvws9N3bYBfPRdbiLzE?fields=>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:5EheM6WVpNCgijthJlz2JP'"
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/5EheM6WVpNCgijthJlz2JP'
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/5EheM6WVpNCgijthJlz2JP?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/5EheM6WVpNCgijthJlz2JP?fields=name%2C>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/5EheM6WVpNCgijthJlz2JP?fields=>
Jan 19 20:14:49 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:7r3AMPIOdYvgaQKRDiwrVy'"
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/7r3AMPIOdYvgaQKRDiwrVy'
Jan 19 20:14:49 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/7r3AMPIOdYvgaQKRDiwrVy?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/7r3AMPIOdYvgaQKRDiwrVy?fields=name%2C>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/7r3AMPIOdYvgaQKRDiwrVy?fields=>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:61QTofFyVixxoxzha3AtLt'"
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/61QTofFyVixxoxzha3AtLt'
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/61QTofFyVixxoxzha3AtLt?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/61QTofFyVixxoxzha3AtLt?fields=name%2C>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/61QTofFyVixxoxzha3AtLt?fields=>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:51WxVH2yeNaDeqqDa0FhjV'"
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/51WxVH2yeNaDeqqDa0FhjV'
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/51WxVH2yeNaDeqqDa0FhjV?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/51WxVH2yeNaDeqqDa0FhjV?fields=name%2C>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/51WxVH2yeNaDeqqDa0FhjV?fields=>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:3OUxOVwYwTk0YMbaWqWUJl'"
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/3OUxOVwYwTk0YMbaWqWUJl'
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/3OUxOVwYwTk0YMbaWqWUJl?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/3OUxOVwYwTk0YMbaWqWUJl?fields=name%2C>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/3OUxOVwYwTk0YMbaWqWUJl?fields=>
Jan 19 20:14:50 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:5gMVBpty5IGrcf984UZzRl'"
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/5gMVBpty5IGrcf984UZzRl'
Jan 19 20:14:50 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/5gMVBpty5IGrcf984UZzRl?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/5gMVBpty5IGrcf984UZzRl?fields=name%2C>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/5gMVBpty5IGrcf984UZzRl?fields=>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:6MF7nABYGQ8TgKFIQ6W2mp'"
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/6MF7nABYGQ8TgKFIQ6W2mp'
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/6MF7nABYGQ8TgKFIQ6W2mp?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/6MF7nABYGQ8TgKFIQ6W2mp?fields=name%2C>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/6MF7nABYGQ8TgKFIQ6W2mp?fields=>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:2lBFkbbWOFOfsY8cPMqw1b'"
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/2lBFkbbWOFOfsY8cPMqw1b'
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/2lBFkbbWOFOfsY8cPMqw1b?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/2lBFkbbWOFOfsY8cPMqw1b?fields=name%2C>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/2lBFkbbWOFOfsY8cPMqw1b?fields=>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:2z7Hsexnwnpw8h20JImOe6'"
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/2z7Hsexnwnpw8h20JImOe6'
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/2z7Hsexnwnpw8h20JImOe6?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/2z7Hsexnwnpw8h20JImOe6?fields=name%2C>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/2z7Hsexnwnpw8h20JImOe6?fields=>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:3pSvRbwLbeWtn3yz54ZrgE'"
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/3pSvRbwLbeWtn3yz54ZrgE'
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/3pSvRbwLbeWtn3yz54ZrgE?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/3pSvRbwLbeWtn3yz54ZrgE?fields=name%2C>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/3pSvRbwLbeWtn3yz54ZrgE?fields=>
Jan 19 20:14:51 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:6GVWKMqYTQtxMrG4jHHmjN'"
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/6GVWKMqYTQtxMrG4jHHmjN'
Jan 19 20:14:51 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/6GVWKMqYTQtxMrG4jHHmjN?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:14:52 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/6GVWKMqYTQtxMrG4jHHmjN?fields=name%2C>
Jan 19 20:14:52 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/6GVWKMqYTQtxMrG4jHHmjN?fields=>
Jan 19 20:14:52 ghettopi3 mopidy[1905]: INFO     [SpotifyBackend-6] mopidy_spotify.playlists Refreshed 16 Spotify playlists
Jan 19 20:14:52 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.utils playlists.refresh() took 3888ms
Jan 19 20:14:52 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy.commands Starting Mopidy core
Jan 19 20:14:52 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Registered Core (urn:uuid:1548f20d-316f-4644-8df4-7133dadd17f2)
Jan 19 20:14:52 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Starting Core (urn:uuid:1548f20d-316f-4644-8df4-7133dadd17f2)
Jan 19 20:14:52 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy.commands Starting Mopidy frontends: MpdFrontend
Jan 19 20:14:52 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy_mpd.actor MPD server running at [::ffff:127.0.0.1]:6600
Jan 19 20:14:52 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Registered MpdFrontend (urn:uuid:42497883-7144-4c98-822a-440a535a672c)
Jan 19 20:14:52 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Starting MpdFrontend (urn:uuid:42497883-7144-4c98-822a-440a535a672c)
Jan 19 20:14:52 ghettopi3 mopidy[1905]: DEBUG    [MpdFrontend-8] mopidy.zeroconf Zeroconf service None (_mpd._tcp at []:6600): dbus not installed; publish failed.
Jan 19 20:14:52 ghettopi3 mopidy[1905]: TRACE    [MainThread] mopidy.internal.timer MpdFrontend took 7ms
Jan 19 20:14:52 ghettopi3 mopidy[1905]: INFO     [MainThread] mopidy.commands Starting GLib mainloop
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Registered MpdSession (urn:uuid:69e9a224-2f0e-4347-93cd-74d01df94374)
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MainThread] pykka Starting MpdSession (urn:uuid:69e9a224-2f0e-4347-93cd-74d01df94374)
Jan 19 20:16:05 ghettopi3 mopidy[1905]: INFO     [MpdSession-9] mopidy_mpd.session New MPD connection from [::ffff:127.0.0.1]:58626
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MpdSession-9] mopidy_mpd.session Request from [::ffff:127.0.0.1]:58626: listplaylists
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'users/w0w3317r7benm3tmf2l9mk02q/playlists'
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'users/w0w3317r7benm3tmf2l9mk02q/playlists?limit=50'
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Cached data expired for URL: https://api.spotify.com/v1/users/w0w3317r7benm3tmf2l9mk02q/>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/users/w0w3317r7benm3tmf2l9mk02q/playlists?limit>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/users/w0w3317r7benm3tmf2l9mk02q/playlist>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web ETag match for URL: https://api.spotify.com/v1/users/w0w3317r7benm3tmf2l9mk02q/playlists>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.utils playlists.as_list() took 90ms
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'users/w0w3317r7benm3tmf2l9mk02q/playlists'
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'users/w0w3317r7benm3tmf2l9mk02q/playlists?limit=50'
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Cached data fresh for URL: https://api.spotify.com/v1/users/w0w3317r7benm3tmf2l9mk02q/pl>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.utils playlists.as_list() took 6ms
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MpdSession-9] mopidy_mpd.session Response to [::ffff:127.0.0.1]:58626:
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_0
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_1
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_2
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_3
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_4
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_5
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_6
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_7
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_8
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_9
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_10
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_11
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_12
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_13
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_14
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     playlist: Ghetto_15
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     Last-Modified: 2024-01-19T19:16:05Z
Jan 19 20:16:05 ghettopi3 mopidy[1905]:     OK
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MpdSession-9] mopidy_mpd.session Request from [::ffff:127.0.0.1]:58626: load "Ghetto_0"
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.playlists Fetching Spotify playlist "'spotify:playlist:4UygHderJcI6LjQGiJsi1M'"
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Fetching page 'playlists/4UygHderJcI6LjQGiJsi1M'
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Get 'playlists/4UygHderJcI6LjQGiJsi1M?fields=name%2Cowner.id%2Ctype%2Curi%2Csnapshot_id%>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web Cached data expired for URL: https://api.spotify.com/v1/playlists/4UygHderJcI6LjQGiJsi1M>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] urllib3.connectionpool https://api.spotify.com:443 "GET /v1/playlists/4UygHderJcI6LjQGiJsi1M?fields=name%2C>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web New WebResponse URL: https://api.spotify.com/v1/playlists/4UygHderJcI6LjQGiJsi1M?fields=>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: TRACE    [SpotifyBackend-6] mopidy_spotify.web ETag match for URL: https://api.spotify.com/v1/playlists/4UygHderJcI6LjQGiJsi1M?fields=n>
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [SpotifyBackend-6] mopidy_spotify.utils playlists.lookup('spotify:playlist:4UygHderJcI6LjQGiJsi1M') took 173ms
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MpdSession-9] mopidy_mpd.session Response to [::ffff:127.0.0.1]:58626: ACK [50@0] {load} No such playlist
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MpdSession-9] mopidy_mpd.network Client most likely disconnected.
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MpdSession-9] pykka Unregistered MpdSession (urn:uuid:69e9a224-2f0e-4347-93cd-74d01df94374)
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MpdSession-9] pykka Stopped MpdSession (urn:uuid:69e9a224-2f0e-4347-93cd-74d01df94374)
Jan 19 20:16:05 ghettopi3 mopidy[1905]: DEBUG    [MpdSession-9] mopidy_mpd.network Already stopping: Actor is shutting down.

kingosticks · January 19, 2024, 10:26pm

There’s something up with the install, I can see what’s not the latest version because it’s missing a fix for the playlist fields format GET request.

MrTolchock · January 20, 2024, 6:21am

Do you mean that that reinstalling Mopidy-Spotify should fix it?

kingosticks · January 20, 2024, 8:56am

You need a way to obtain the latest version. A pip forced upgrade from GitHub might be one way, uninstall and reinstall might be another.

MrTolchock · January 20, 2024, 7:00pm

I did it and it worked now (again)! I hope it stays that way, many thanks again for your efforts!

Topic		Replies	Views
Cant seem to load playlists from spotify General	6	1847	March 24, 2017
Sometimes, spotify playlist doesnt load General	2	1260	October 20, 2016
Mopidy spotify install and connect but not in devices list in my smartphone General	2	2366	July 11, 2017
No playlists on Mopidy-http General	4	1780	February 7, 2015
Control Spotify using mpc with Mopidy General	6	7133	July 10, 2015

Spotify playlists do not show up in MPD

Related Topics