balbuze / volumio-plugins

volumio's plugins from balbuze
190 stars 60 forks source link

Playback stops when opening spotify app on a device #106

Closed thjunge11 closed 6 years ago

thjunge11 commented 6 years ago

volspotconnect ver 1.7.2

Action:

Actual:

Expected:

Appearance:

Environment:

Additional Info:

Trace:

Starting playback

2017-11-13T19:50:51.726Z - info: [Volspotconnect] Session is active!
2017-11-13T19:50:51.743Z - info: [Volspotconnect] SpotConn is playing
2017-11-13T19:50:51.750Z - info: CoreCommandRouter::volumioStop
2017-11-13T19:50:51.759Z - info: [1510602651750] CoreStateMachine::stop
2017-11-13T19:50:51.769Z - info: [1510602651760] CoreStateMachine::setConsumeUpdateService undefined
2017-11-13T19:50:51.772Z - info: [1510602651770] CoreStateMachine::setConsumeUpdateService undefined
2017-11-13T19:50:51.775Z - info: CoreCommandRouter::servicePushState
2017-11-13T19:50:51.793Z - info: [1510602651776] CoreStateMachine::syncState
2017-11-13T19:50:51.796Z - info: [1510602651794] CorePlayQueue::getTrack 0
2017-11-13T19:50:51.811Z - info: [1510602651797] Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received Volspotconnect
2017-11-13T19:50:51.828Z - info: CoreCommandRouter::servicePushState
2017-11-13T19:50:51.837Z - info: [1510602651829] CoreStateMachine::syncState
2017-11-13T19:50:51.840Z - info: [1510602651838] CoreStateMachine::pushState
2017-11-13T19:50:51.843Z - info: [1510602651841] CoreStateMachine::getState
2017-11-13T19:50:51.846Z - info: CoreCommandRouter::volumioPushState
2017-11-13T19:50:51.863Z - info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
2017-11-13T19:50:51.875Z - info: [1510602651871] interfaceApi::pushState
2017-11-13T19:50:51.880Z - info: [1510602651876] InterfaceWebUI::pushState
2017-11-13T19:50:52.010Z - info: Pushing Favourites {"service":"Volspotconnect","uri":"spotify:track:4EgKcG7aswxVfQEqa3dl8S","favourite":false}

Opening App again

2017-11-13T19:51:13.808Z - info: [Volspotconnect] SpotConn is done!
2017-11-13T19:51:13.818Z - info: [1510602673813] CoreStateMachine::resetVolumioState
2017-11-13T19:51:13.820Z - info: [1510602673819] CoreStateMachine::getcurrentVolume
2017-11-13T19:51:13.822Z - info: CoreCommandRouter::volumioRetrievevolume
2017-11-13T19:51:13.867Z - info: [1510602673857] CoreStateMachine::updateTrackBlock
2017-11-13T19:51:13.871Z - info: [1510602673867] CorePlayQueue::getTrackBlock
2017-11-13T19:51:13.884Z - info: CoreCommandRouter::volumioStop
2017-11-13T19:51:13.894Z - info: [1510602673884] CoreStateMachine::stop
2017-11-13T19:51:13.899Z - info: [1510602673894] CoreStateMachine::setConsumeUpdateService undefined
2017-11-13T19:51:13.976Z - info: [1510602673972] VolumeController:: Volume=undefined Mute =undefined
2017-11-13T19:51:13.983Z - info: [1510602673979] CoreStateMachine::pushState
2017-11-13T19:51:13.988Z - info: [1510602673984] CoreStateMachine::getState
2017-11-13T19:51:13.994Z - info: [1510602673989] CorePlayQueue::getTrack 0
2017-11-13T19:51:13.998Z - info: CoreCommandRouter::volumioPushState
2017-11-13T19:51:14.003Z - info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
2017-11-13T19:51:14.010Z - info: [1510602674006] interfaceApi::pushState
2017-11-13T19:51:14.015Z - info: [1510602674011] InterfaceWebUI::pushState
2017-11-13T19:51:14.139Z - info: Pushing Favourites {"service":"spop","uri":"spotify:track:4BP3uh0hFLFRb5cjsgLqDh","favourite":false}
balbuze commented 6 years ago

Are you sure to connect to spotify connect and not on airplay? Because I am sure 100% it works as expected...

thjunge11 commented 6 years ago

No, its really spotify connect :)

All I can say is, that with volspotconnect v 1.6.1 it did not happen.

Now, after updating to v 1.7.2, it showed up.

When some song is running on volumio and all native spotify frontends are closed, then when opening any frontend (on mac, pc, android app) the song on volumio stops and the local sink is the active one. The popup on the android app (saying "do you want to continue playing on volumio?") is showing up but is closing automatically after half a second.

This does not happen with my other volumio device right now, in the same network, still with v 1.6.1.

If you need more logs, I can provide them.

After all, thank you very much for this plugin. I can fallback to v 1.6.1 but i really like the webUI integration ;)

thjunge11 commented 6 years ago

BTW: spop and volspotconnect are both installed on the system

balbuze commented 6 years ago

Very weird... I'll have a look tonight...

balbuze commented 6 years ago

I made some test with android spotify app and Linux Spotify app and it works perfectly ! The popup "do you want to continue on volumio" appears but wait for a choice. If I select continue, it just continue...

thjunge11 commented 6 years ago

OK, understood, thanks.

I am wondering about the last line in trace when I actually open the android App again: 2017-11-13T19:51:14.139Z - info: Pushing Favourites {"service":"spop","uri":"spotify:track:4BP3uh0hFLFRb5cjsgLqDh","favourite":false}

Looks somehow like spop service interferes here...?

balbuze commented 6 years ago

I have to tested with spod activated. Maybe it cause the problem. From where country are you from, just to know if the spotify app could be at a different version. I'm FR (french)

thjunge11 commented 6 years ago

de_DE :)

thjunge11 commented 6 years ago

It looks like this issue was caused because I set mixer to "none" in volumio settings. After updating to latest volumio/volspotconnect I had no sound, reverted to "hardware" and now everything works as expected. Will close the issue.