New Volumio Spotify Plugin Open Beta-Testing

volumio · July 11, 2022, 7:46am

What was your issue and how did you get it sorted?
This info is helpful

Bud_Kernell · July 11, 2022, 10:04am

Hi all boys
after a few days of use, I encountered this problem which I had not noticed.
By changing the volume, it changes in a crazy way, as you can see in the linked video
video: https://youtube.com/shorts/6kzkhJVUCMY?feature=share

logs: http://logs.volumio.org/volumio/CuIYxYD.html

volumio · July 11, 2022, 6:14pm

Thanks everyone for their feedbacks. The plugin is being currently fixed and already addressed issues are:

Use different workaround for not found tracks
Avoid token expiration for control actions
Fix crash if name contains hyphens

Working on improving volume control.

Hopefully, new release this week

Black_Fuzzy_Lemon · July 13, 2022, 2:51pm

Hello everyone, just finished a 5 days trial of the new plugin on 3 pi zero w and 2 pi zero 2 w; I connected directly my spotify account in volumio page and used the raspberrys like player! I think there is a big problem here: when you play the music spotify doesn’t count the listenings, I know that because I’m also a producer and on my artist page of spotify for artist I can see daily how many plays of my music people performs on spotify.

volumio · July 13, 2022, 3:33pm

This is nothing that we can take care of: we use the official Spotify APIs to play, so it’s the same as using their client. My educated guess is that the listen count is not updated daily.

volumio · July 13, 2022, 6:29pm

GOOD NEWS! I’ve managed to put a lot of work into the Spotify plugin, and solved quite a lot of issues reported by you guys.
As always, thanks for the feedbacks and reports. This time it has been especially helpful since Spotify has some geo-related issues which are not obvious to fix.

This is what has been improved in the latest version (3.0.3)

Use different workaround for not found tracks
Avoid token expiration for control actions
Fix crash if name contains hyphens
Fixed funny behaviour of volume control
Fixed conflicts between browsing mode and connect mode
Do not play unavailable tracks in region
Fix potential conflict with old plugin version settings

The plugin is now released, so feel free to enjoy! And, if there are more issues, please report them here.

IMPORTANT! Remember to provide infos when you report an issue. We need to know

Explain the issue with the most details
Tell us your system (PI etc), DAC, Volumio version
IMPORTANT: Send the log How to send a log link for a bug report? and paste link here (just after the issue occurs)

ENJOY!

Iaudio87 · July 13, 2022, 6:41pm

Since today my spotify stopped working. I can connect with the volumio trough spotify connect, but it plays the first four seconds of the song. Then skips to the next song. No sound. Happens with analog out aswell

What changed?

volumio · July 13, 2022, 6:52pm

Update your plugin to latest version released today

Josh2000 · July 13, 2022, 7:50pm

First time test looks good

Unfortunately i am currently bad sick and totally off power - could please someone test switching between UI and connect feature.

It has been working for me at home - but not in the company office - where especially the “funny” volume bug has been not so funny as the CEO came in while our device switched to 96% volume and that was pretty loud…

Home system tested:
PI3
Allo Isolator
Allo Katana

Office System:
PI3
Allo Reclocker
Allo Piano 2.1 in dual Mono Mode

Josh2000 · July 13, 2022, 8:10pm

No - still not solved

After playing a few songs - it suddenly begins to skip songs after 2 seconds again.

http://logs.volumio.org/volumio/aU2xQDZ.html

After pausing and wait for some minutes it’s working again as expected - but that should not be the way ?

Josh2000 · July 13, 2022, 8:42pm

Also the “funny” volume control came back.

I will test with a fresh installed other device as soon as i get back to be healthy

jol · July 13, 2022, 8:56pm

H!
When will this update be available for the miniDSP OEM version of Volumio?

Josh2000 · July 13, 2022, 9:09pm

Wait for if it is working - i guess that Spotify has to fix things also

soundguybmw · July 13, 2022, 9:33pm

New version 3.0.3: On a Spotify playlist, when using “repeat all” it just plays the same song over and over. (Yes I know there is a “repeat 1” and it is not set to this)
Pi Version 3, DAC is Allo BOSS, Volumio version 3.301
Log: http://logs.volumio.org/volumio/iBCTyyZ.html
It should be noted that on the previous version of the plugin, this was not an issue. I have it set to run continuously 24/7. Sometimes it would stop and get stuck on a song but I’ve never had this issue.
Also am not able to skip forward, it just starts the same track over.

fredhohenstein · July 14, 2022, 6:51am

Hello to All

Today I installed the spotifyplugin from the store.
I first removed the beta plugin

Now I am testing the updated plugin form the store comparing to the beta plugin.
Plugin version used: 3.0.3

In New Volumio Spotify Plugin Open Beta-Testing - #181 by fredhohenstein I told that the plugin didn;t play spotify tracks.
I hoped that this nwe plugin solvved this problem.

Problem:

But no, the problem still exists: I can browse/select spotity tracks but thay are not played when i start them.
Nothing happens, no sound. It looks like the playback isn’t started and in the debug session in putty: volumio@volumio:~$ sudo journalctl -f
I still see the messages:

Jul 14 06:42:44 volumio volumio[655]: info: [1657780964253] ControllerSpotify::clearAddPlayTrack
Jul 14 06:42:44 volumio volumio[655]: info: Setting this device active
Jul 14 06:42:44 volumio volumio[655]: info: Failed to Set Device Active: Error: Not Found
Jul 14 06:42:51 volumio volumio[655]: info: CoreCommandRouter::volumioGetState

I can browse through spotify and select a song.
When i start playing the song nothing happens/no sound!
I double checked Volumio:
Playing tracks from my qnap nas: no problem
Listing to webreadio: no problem
rebooted the system several times: problem still exists
switch off/switch on system: problem still exists

Host: Raspberry PI4
Volumio 3.312 Virtuoso membership
Version of Volumio: 3.312
Hostname: volumio
Kernel: 5.10.92-v7l+
Governor: performance
Uptime: 0 days, 0 Hrs, 11 Minutes, 59 Seconds
DAC: Hifiberry DAC+ RCA
Hw audio configured: HiFiBerry DAC Plus
Mixer type: Hardware
Number of channels: 2
Supported sample rate: 44100 48000 88200 96000 176400 192000

Spotify Premium - familiy contract
I installed the plugin from the spotify plugin store

Wheaten · July 14, 2022, 7:01am

Plugin is getting improved, great progress, but found a few things:
System Information:

rPi4-8GB
Allo Digione
NAD D3045
Volumio V3.251

Steps:

Removed previous Spotify plugin (V3.02)
Restarted system
Installed V3.03

Volume settings:

Found issues:
Cosmetics:

After login to Spotify, Screen is not refreshed. Need to reload page to get it updated
When making changes to Initial Volume, hitting the save button doesn’t generate any message. Page seems unresponsive, however changes are stored
In V3.02 there was a button, seems to be missing in V3.03

image1334×176 46.5 KB

technical:

Repeat all (green round arrow) acts as repeat single
When interrupting Spotify connect within Volumio by loading a new list, song won’t start. After a few hits on Play/Pause it starts again.
Skipping tracks happens randomly.



info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus play
info: CoreStateMachine::play index undefined
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 2
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 2
info: [1657787078761] ControllerSpotify::clearAddPlayTrack
info: Setting this device active
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[SpotifyConnect]  Device palyback is inactive
info: touch_display: Setting screensaver timeout to 120 seconds.
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
[Vollibrespot] : Fetching autoplay context uri
[Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track }, track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track } }
[Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=
[Vollibrespot] : AutoplayError: MercuryError
info: CoreCommandRouter::volumioGetState
info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
info: touch_display: Setting screensaver timeout to 120 seconds.
[Vollibrespot] : Event: SinkActive
[Vollibrespot] : Event: Next { track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track } }
[Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track }, track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track } }
[SpotifyConnect]  Self Esteem
info: [1657787079107] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 2


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[SpotifyConnect]  Sink acquired
info: Continuing Spotify Session
info: Checking Spotify Web API
[Vollibrespot] : Event: SinkInactive
[Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track } }
[SpotifyConnect]  Self Esteem
info: [1657787079185] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
[SpotifyConnect]  Sink released
info: [1657787079190] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 2


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus play
info: CoreStateMachine::play index undefined
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[Vollibrespot] : Fetching autoplay context uri
[Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track }, track_id: SpotifyId { id: 295246024522152435297779322183121786258, audio_type: Track } }
info: CorePlayQueue::getTrack 3
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 3
info: [1657787079216] ControllerSpotify::clearAddPlayTrack
info: Setting this device active
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=
[Vollibrespot] : AutoplayError: MercuryError
[SpotifyConnect]  Device palyback is inactive
[Vollibrespot] : Loading  with Spotify URI 
[Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 295246024522152435297779322183121786258, audio_type: Track } }
[Vollibrespot] :  (181533 ms) loaded
[Vollibrespot] : Event: SinkActive
[SpotifyConnect]  Basket Case
[SpotifyConnect]  Sink acquired
info: Continuing Spotify Session
info: Checking Spotify Web API
info: touch_display: Setting screensaver timeout to 0 seconds.
info: touch_display: Setting screensaver timeout to 120 seconds.
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
[Vollibrespot] : Fetching autoplay context uri
[Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 295246024522152435297779322183121786258, audio_type: Track }, track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track } }
[Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=
[Vollibrespot] : AutoplayError: MercuryError
[SpotifyConnect]  Self Esteem
info: [1657787079670] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
[Vollibrespot] : Fetching autoplay context uri
info: CoreCommandRouter::volumioGetState
info: touch_display: Setting screensaver timeout to 0 seconds.
info: CoreCommandRouter::volumioGetState
[Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=
[Vollibrespot] : AutoplayError: MercuryError
[Vollibrespot] : Event: SinkInactive
[Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track } }
[Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track }, track_id: SpotifyId { id: 73295774072209172946745029855206367861, audio_type: Track } }
[SpotifyConnect]  Sink released
info: [1657787079998] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 3


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus play
info: CoreStateMachine::play index undefined
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 4
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 4
info: [1657787080007] ControllerSpotify::clearAddPlayTrack
info: Setting this device active
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[Vollibrespot] : Loading  with Spotify URI 
[Vollibrespot] : Loading  with Spotify URI 
[Vollibrespot] :  (257826 ms) loaded
[Vollibrespot] :  (215906 ms) loaded
info: touch_display: Setting screensaver timeout to 120 seconds.
info: CoreCommandRouter::volumioGetState
info: Is Not Connect Playback
info: [1657787080106] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 4


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 73295774072209172946745029855206367861, audio_type: Track } }
[Vollibrespot] : Event: SinkActive
info: CoreCommandRouter::volumioGetState
[SpotifyConnect]  Scar Tissue
[SpotifyConnect]  Sink acquired
info: Continuing Spotify Session
info: Checking Spotify Web API
[Vollibrespot] : Fetching autoplay context uri
[Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 73295774072209172946745029855206367861, audio_type: Track }, track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track } }
[Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=
[Vollibrespot] : AutoplayError: MercuryError
[SpotifyConnect]  Self Esteem
[Vollibrespot] : Fetching autoplay context uri
[Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=
[Vollibrespot] : AutoplayError: MercuryError
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
[Vollibrespot] : Event: SinkInactive
[Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track } }
[SpotifyConnect]  Sink released
info: [1657787080777] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
[Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 72787414551552412743303113338438041855, audio_type: Track }, track_id: SpotifyId { id: 119047454566201459263048238731580377631, audio_type: Track } }
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 4


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[Vollibrespot] : Loading  with Spotify URI 
info: Is Not Connect Playback
info: [1657787080816] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[Vollibrespot] : Loading  with Spotify URI 
info: CorePlayQueue::getTrack 4


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[Vollibrespot] :  (257826 ms) loaded
[Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 119047454566201459263048238731580377631, audio_type: Track } }
[SpotifyConnect]  Zombie
[Vollibrespot] :  (306440 ms) loaded
[Vollibrespot] : Event: SinkActive
[SpotifyConnect]  Sink acquired
info: Continuing Spotify Session
info: Checking Spotify Web API
info: Is Not Connect Playback
info: [1657787081055] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioGetState
info: touch_display: Setting screensaver timeout to 0 seconds.
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
info: Is Not Connect Playback
info: [1657787081656] ControllerSpotify::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetState

When skipping tracks has occurred, Spotify stops after playing a single track

http://logs.volumio.org/volumio/CfZlCxX.html

Question:

When playing a list from the Volumio Spotify integration, is it normal that Volumio keeps sending information to the Spotify application on my iPhone, even after reopening the application and rebooting the system?

Solved:

Playing a loaded playlist after reboot skipping tracks every 2 seconds
Skipping songs while switching between Spotify integration and Spotify connect, vise versa

volumio · July 14, 2022, 8:47am

Yes, this implementation relies heavily on the “Connect” functionality. So Spotify is always in control of your playback sessions. Volumio now is merely acting as a client.

PS: The fact that you have a volume slider in the configuration page does not make much sense to me. Probably you still have the old settings in place. Would you mind uninstalling then reinstalling the plugin and report if it makes any difference to you?
If that’s the case, I have to account for this leftover settings

volumio · July 14, 2022, 8:49am

Thanks guys for the feedbacks.

This plugin is a very hard nut to crack, since the vollibrespot event system is quite unpredictable (plus, Volumio was not designed to accommodate standard and volatile playback in a single plugin).

I will work on it until is perfect, will not be quick but we will get there.

Wheaten · July 14, 2022, 8:59am

Hi,

Already did it 4 times, so now for the 5th, with all taken steps:

Uninstalled V3.03
Shut down the system
Pulled the power plug
Restarted the system
Installed V3.03
Enabled plugin
Restarted the system
Entered credentials
Reloaded the page

Tried to run the same test on my 2nd rPi4-8GB, rev1.4, but Volumio won’t register it, so the plugin section is unavailable (Superstar)

volumio · July 14, 2022, 9:21am

What is your volume setting? Software or none?