Not Playing on PleXBMC #53
Description
Im using:
PMS 0.9.11.7 with Spotify2 0.5.8
OpenELEC 5 with PleXBMC 3.4.5
It works fine combined with the Plex Android App.
Browsing the Plugins Menu on PleXBMC also works fine, it lists the playlists and the songs correctly but fails to actually play the songs.
I did some debuging (logs below) and saw PMS never receives a request for the actual mp3 as it does with the Android App.
After looking into the XBMC Logs it seems like its trying to playback the Metadata XML instead of requesting the mp3 from the URL specified in it? Not sure if this is actually an issue of this plugin and not plexbmc.
PMS: Request by OpenELEC
2015-02-26 18:55:27,572 (7f67549d4700) : DEBUG (logging_handler:22) - [spotify.mercury.request] Building object(s) from 49 item(s)
2015-02-26 18:55:27,588 (7f67549d4700) : DEBUG (logging_handler:22) - [spotify.mercury.request] Returning 49 object(s) to response callback
2015-02-26 18:55:27,786 (7f67521cf700) : DEBUG (runtime:918) - Response: [200] MediaContainer, 59237 bytes
2015-02-26 18:55:29,305 (7f67521cf700) : DEBUG (runtime:717) - Handling request GET /music/spotify/metadata/spotify%3Atrack%3A3lWQOHYu0Mp1R2NEjHm5av
2015-02-26 18:55:29,308 (7f67521cf700) : DEBUG (runtime:814) - Found route matching /music/spotify/metadata/spotify:track:3lWQOHYu0Mp1R2NEjHm5av
2015-02-26 18:55:29,308 (7f67521cf700) : DEBUG (__init__:24) - plugin_callback - method: <utils.decorator object at 0x3918050>, kwargs: {'uri': u'spotify:track:3lWQOHYu0Mp1R2NEjHm5av'}, async: True
2015-02-26 18:55:29,309 (7f67521cf700) : DEBUG (utils:50) - authenticated
2015-02-26 18:55:29,309 (7f67521cf700) : DEBUG (host:382) - fetching metadata for uri: "spotify:track:3lWQOHYu0Mp1R2NEjHm5av"
2015-02-26 18:55:29,310 (7f67521cf700) : DEBUG (logging_handler:22) - [spotify.components.metadata] metadata(spotify:track:3lWQOHYu0Mp1R2NEjHm5av)
2015-02-26 18:55:29,311 (7f67521cf700) : DEBUG (logging_handler:22) - [spotify.hermes.cache] retrieved "hm://metadata/track/6e33d9d55bec41bf84da8c6b094368bf" from cache (timestamp: 1424973263.04, valid: True)
2015-02-26 18:55:29,312 (7f67521cf700) : DEBUG (logging_handler:22) - [spotify.mercury.request] Building object(s) from 1 item(s)
2015-02-26 18:55:29,313 (7f67521cf700) : DEBUG (logging_handler:22) - [spotify.mercury.request] Returning 1 object(s) to response callback
2015-02-26 18:55:29,322 (7f67521cf700) : DEBUG (runtime:918) - Response: [200] MediaContainer, 1582 bytes
OpenELEC 5 + PlexBMC
18:55:29 T:140244925396736 NOTICE: ===== PLEXBMC START =====
18:55:29 T:140244925396736 NOTICE: PleXBMC -> Running Python: sys.version_info(major=2, minor=7, micro=3, releaselevel='final', serial=0)
18:55:29 T:140244925396736 NOTICE: PleXBMC -> Running PleXBMC: 3.4.5
18:55:29 T:140244925396736 NOTICE: PleXBMC -> FullRes Thumbs are se to: false
18:55:29 T:140244925396736 NOTICE: PleXBMC -> CWD is set to: /storage/.xbmc/addons/plugin.video.plexbmc-3.4.5
18:55:29 T:140244925396736 NOTICE: PleXBMC -> Platform: Linux/RPi
18:55:29 T:140244925396736 NOTICE: PleXBMC -> Debug is turned off. Running silent
18:55:29 T:140244925396736 NOTICE: PleXBMC -> Detected parameters: {'url': 'http%3A//192.168.2.10%3A32400/music/spotify/metadata/spotify%253Atrack%253A3lWQOHYu0Mp1R2NEjHm5av', 'mode': '12'}
18:55:29 T:140244925396736 NOTICE: ===== PLEXBMC STOP =====
18:55:29 T:140245245593408 ERROR: CAudioDecoder: Unable to Init Codec while loading file http://192.168.2.10:32400/music/spotify/metadata/spotify%3Atrack%3A3lWQOHYu0Mp1R2NEjHm5av
18:55:29 T:140245245593408 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder
18:55:29 T:140245245593408 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.plexbmc/?url=http%3A//192.168.2.10%3A32400/music/spotify/metadata/spotify%253Atrack%253A3lWQOHYu0Mp1R2NEjHm5av&mode=12]