Cannot play Spotify : SPOP command error

Hello everybody,
In this period of lockdown, I’ve got some time to spend trying to resolve a Spotify issue.
The problem is that I cannot play Spotify from Volumio.
I can browse my library, when I search an artist I can see the Spotify result, BUT when I try to play any spotify songs nothing happen!
Here the volumio log:

2020-03-23T11:42:41.661Z - info: [1584963761661] ControllerSpop::clearAddPlayTrack 2020-03-23T11:42:41.662Z - info: {"service":"spop","type":"song","title":"Forward","name":"Forward","artist":"Sea Wolf","album":"Through A Dark Wood","albumart":"https://i.scdn.co/image/dhguytwhkjfief000045ewhi","uri":"spotify:track:6ChNwUMN5vZxthdpnzuHXP","samplerate":"320Kbps","bitdepth":"16 bit","trackType":"spotify","duration":76} 2020-03-23T11:42:41.663Z - info: [1584963761662] ControllerSpop::sendSpopCommand 2020-03-23T11:42:41.664Z - info: ADDING DEFER FOR COMMAND uplay 2020-03-23T11:42:41.670Z - error: SPOP command error: Error: This socket has been ended by the other party
I should say that I’ve alvays had this issue.
I do not have problems on using Spotify connect.
Lately I had made a fresh install with the last image and I’ve installed only the Spotify plugin (not Spotify connect)

Here some info on my system:
Volumio version 2.729
Plugin Spotify 2.0.2
Raspberry Pi 3 B+
DAC HiFi Berry DAC+

Thank you for any hint on this issue,

Carlo

me too!

Is anybody out there?

Would be nice if someone could help!

From the beginning I had problem in playing Spotify from Volumio, whereas I can play Spotify using spotify connect, I cannnot play it from Volumio.

Thank you for your help

Carlo

hi!
Can you give the content of /etc/spopd.conf please? (remove your credentials :wink: )

Hi, i have the same problem. I can browse my library but unable to play a song.

Just to try to speed this up, I’m taking the liberty of sending my contents of /etc/spopd.conf, hope you don’t mind.

[spop]
spotify_username = xxxxxxxxx
spotify_password = xxxxxxxxx
high_bitrate = true
refresh_token = none
audio_output = sox
pretty_json = true
search_results = 50
cache_path =/run/shm

[sox]
output_type = alsa
output_name = softvolume

Also, in the log, I can see some messages about error in the authentication. I have double checked the credentials. This is the log when I disable/enable the Spotify plugin (2.0.2 version):

Jun 04 11:34:59 volumio systemd[1]: Starting Spotify Daemon...
Jun 04 11:34:59 volumio systemd[1]: Started Spotify Daemon.
Jun 04 11:34:59 volumio sudo[24902]: pam_unix(sudo:session): session closed for user root
Jun 04 11:34:59 volumio volumio[1065]: info: SpopD Daemon Started
Jun 04 11:34:59 volumio volumio[24907]: 2020-06-04 11:34:59 [SPTF] 09:34:59.494 I [offline_authorizer.cpp:297] Unable to login offline: no such user
Jun 04 11:34:59 volumio volumio[24907]: 2020-06-04 11:34:59 [SPTF] 09:34:59.502 I [ap:1752] Connecting to AP ap..spotify..com:4070
Jun 04 11:35:04 volumio volumio[1065]: info: Connecting to daemon
Jun 04 11:35:04 volumio volumio[1065]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 04 11:35:04 volumio volumio[1065]: info: [1591263304500] CoreMusicLibrary::Adding element Spotify
Jun 04 11:35:04 volumio volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 04 11:35:04 volumio volumio[24907]: 2020-06-04 11:35:04 [SPTF] 09:35:04.507 E [ap:1694] AP Socket Error: Timeout reached (20000)
Jun 04 11:35:04 volumio volumio[24907]: 2020-06-04 11:35:04 [SPTF] 09:35:04.507 E [ap:3953] Connection error:  117
Jun 04 11:35:04 volumio volumio[24907]: 2020-06-04 11:35:04 [SPTF] 09:35:04.508 I [ap:1752] Connecting to AP ap..spotify..com:443
Jun 04 11:35:04 volumio volumio[1065]: info: Done.
Jun 04 11:35:04 volumio volumio[1065]: info: FIRST BRANCH
Jun 04 11:35:09 volumio volumio[24907]: 2020-06-04 11:35:09 [SPTF] 09:35:09.511 E [ap:1694] AP Socket Error: Timeout reached (20000)
Jun 04 11:35:09 volumio volumio[24907]: 2020-06-04 11:35:09 [SPTF] 09:35:09.512 E [ap:3953] Connection error:  117
Jun 04 11:35:09 volumio volumio[24907]: 2020-06-04 11:35:09 [SPTF] 09:35:09.512 I [ap:1752] Connecting to AP ap..spotify..com:80 ***>>> NOTE: I "double point it" because as new user i can't post more than 2 URL ....***
Jun 04 11:35:09 volumio volumio[1065]: info: An error occurred while listing Spotify categories WebapiError: Unauthorized
Jun 04 11:35:09 volumio volumio[1065]: info: An error occurred while listing Spotify featured playlists WebapiError: Unauthorized
Jun 04 11:35:09 volumio volumio[1065]: info: An error occurred while listing Spotify new albums WebapiError: Unauthorized
Jun 04 11:35:09 volumio volumio[1065]: info: New Spotify access token = BQAdPQCdoPgal7ABlzOmdxbwO-8oMvgl7B9v-O3gqwCYpKP_Y0CnYK0a8qCwnjtkvElvXcci6EeFkGV-tGuwTk2gz2AkIcRkYFQkB2i8ViNYAoqvAd7S307fsd3duRP8kUHJ8LK4GiC6YqvdCVI9MdhaRBdjvKWLJTaxCIrx4VEItw
Jun 04 11:35:09 volumio volumio[1065]: info: Spotify credentials grant success - running version from March 24, 2019
Jun 04 11:35:14 volumio volumio[24907]: 2020-06-04 11:35:14 [SPTF] 09:35:14.513 E [ap:1694] AP Socket Error: Timeout reached (20000)
Jun 04 11:35:14 volumio volumio[24907]: 2020-06-04 11:35:14 [SPTF] 09:35:14.514 E [ap:3953] Connection error:  117
Jun 04 11:35:14 volumio volumio[24907]: 2020-06-04 11:35:14 [SPTF] 09:35:14.514 I [ap:1752] Connecting to AP ap.spotify.com:4070
Jun 04 11:35:19 volumio volumio[24907]: 2020-06-04 11:35:19 [SPTF] 09:35:19.515 E [ap:1694] AP Socket Error: Timeout reached (20000)
Jun 04 11:35:19 volumio volumio[24907]: 2020-06-04 11:35:19 [SPTF] 09:35:19.516 E [ap:3953] Connection error:  117
Jun 04 11:35:19 volumio volumio[24907]: 2020-06-04 11:35:19 [SPTF] 09:35:19.516 I [ap:1752] Connecting to AP ap..spotify..com:443
Jun 04 11:35:24 volumio volumio[24907]: 2020-06-04 11:35:24 [SPTF] 09:35:24.520 E [ap:1694] AP Socket Error: Timeout reached (20000)
Jun 04 11:35:24 volumio volumio[24907]: 2020-06-04 11:35:24 [SPTF] 09:35:24.520 E [ap:3953] Connection error:  117
Jun 04 11:35:24 volumio volumio[24907]: 2020-06-04 11:35:24 [SPTF] 09:35:24.520 I [ap:1752] Connecting to AP ap..spotify..com:80
Jun 04 11:35:29 volumio volumio[24907]: 2020-06-04 11:35:29 [SPTF] 09:35:29.525 E [ap:1694] AP Socket Error: Timeout reached (20000)
Jun 04 11:35:29 volumio volumio[24907]: 2020-06-04 11:35:29 [SPTF] 09:35:29.525 E [ap:3953] Connection error:  117
Jun 04 11:35:29 volumio volumio[24907]: 2020-06-04 11:35:29 [WARN] Login failed: Cannot connect to Spotify
Jun 04 11:35:29 volumio volumio[24907]: 2020-06-04 11:35:29 [ERR ] Could not get the playlist container.
Jun 04 11:35:29 volumio systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP
Jun 04 11:35:29 volumio systemd[1]: Unit spop.service entered failed state.

Many thanks!

Anyone have a clue about the problem?

FWIW, I just captured this output from the Live Log on the volumio DEV dashboard. Just installed volumio today, from a volumio.org download

2021-03-08 21:08:59 [SPTF] 21:08:59.356 I [offline_authorizer.cpp:297] Unable to login offline: no such user
info: SpopD Daemon Started
2021-03-08 21:08:59 [SPTF] 21:08:59.364 I [ap:1752] Connecting to AP ap.spotify.com:4070
info: Connecting to daemon
2021-03-08 21:09:04 [SPTF] 21:09:04.368 E [ap:1694] AP Socket Error: Timeout reached (20000)
2021-03-08 21:09:04 [SPTF] 21:09:04.368 E [ap:3953] Connection error: 117
2021-03-08 21:09:04 [SPTF] 21:09:04.368 I [ap:1752] Connecting to AP ap.spotify.com:443
info: FIRST BRANCH
2021-03-08 21:09:09 [SPTF] 21:09:09.372 E [ap:1694] AP Socket Error: Timeout reached (20000)
2021-03-08 21:09:09 [SPTF] 21:09:09.372 E [ap:3953] Connection error: 117
2021-03-08 21:09:09 [SPTF] 21:09:09.372 I [ap:1752] Connecting to AP ap.spotify.com:80
2021-03-08 21:09:14 [SPTF] 21:09:14.378 E [ap:1694] AP Socket Error: Timeout reached (20000)
2021-03-08 21:09:14 [SPTF] 21:09:14.378 E [ap:3953] Connection error: 117
2021-03-08 21:09:14 [SPTF] 21:09:14.378 I [ap:1752] Connecting to AP ap.spotify.com:4070
2021-03-08 21:09:19 [SPTF] 21:09:19.383 E [ap:1694] AP Socket Error: Timeout reached (20000)
2021-03-08 21:09:19 [SPTF] 21:09:19.383 E [ap:3953] Connection error: 117
2021-03-08 21:09:19 [SPTF] 21:09:19.383 I [ap:1752] Connecting to AP ap.spotify.com:443
2021-03-08 21:09:24 [SPTF] 21:09:24.388 E [ap:1694] AP Socket Error: Timeout reached (20000)
2021-03-08 21:09:24 [SPTF] 21:09:24.388 E [ap:3953] Connection error: 117
2021-03-08 21:09:24 [SPTF] 21:09:24.389 I [ap:1752] Connecting to AP ap.spotify.com:80
2021-03-08 21:09:29 [SPTF] 21:09:29.394 E [ap:1694] AP Socket Error: Timeout reached (20000)
2021-03-08 21:09:29 [SPTF] 21:09:29.394 E [ap:3953] Connection error: 117
2021-03-08 21:09:29 [WARN] Login failed: Cannot connect to Spotify
2021-03-08 21:09:29 [ERR ] Could not get the playlist container.
spop.service: main process exited, code=killed, status=5/TRAP
Unit spop.service entered failed state.

Here are some specs for my system:

OS info

  • Version of Volumio: 2.873
  • Kernel: 4.19.118-v7+
  • Governor: performance
  • Uptime: 0 days, 13 Hrs, 34 Minutes, 59 Seconds

Audio info

  • Hw audio configured: Allo BOSS
  • Mixer type: Hardware
  • Number of channels: 2
  • Supported sample rate: 44100 48000 88200 96000 176400 192000

Board info

  • Manufacturer: Raspberry Pi Foundation
  • Model: Raspberry Pi 3 Model B Plus Rev 1.3
  • Version: a020d3
  • Firmware Version: Apr 27 2020 14:35:17 - 3a8f1793b758d6fb7f375edaa260e069ecd34c88

CPU info

  • Brand: Processor rev 4 (v7l)
  • Speed: 1.40Mhz
  • Number of cores: 4
  • Physical cores: 4
  • Average load: 1%
  • Temperature: 53°C