wactuary wrote: 
> I've generally had no issues with Spotty, but I've come across something
> strange.  Trying to play the "Wish I Was Here Sondtrack" playlist by The
> Northern Librarian.  The playlist plays fine through Spotify app on my
> phone.  But through Spotty plugin, the playlist loads, but it skips
> certain songs, including track 1 (The Shins - So Now What), Tack 8
> (Coldplay - Cat Power), Track 9 (Allie Moss - Wait It Out).
> 
> Basic logging didn't find any errors, but when I added some extra log
> checks, I did get the following:
> > 
Code:
--------------------
  >   > 21-06-26 09:35:02.7750] 
Slim::Player::StreamingController::_nextTrackReady (744) 00:04:20:1f:4a:00: 
nextTrack will be index 0
  > [21-06-26 09:35:02.7751] Slim::Player::StreamingController::_Stream (1210) 
Song queue is now 0
  > [21-06-26 09:35:02.7752] Slim::Player::StreamingController::_Stream (1213) 
00:04:20:1f:4a:00: preparing to stream song index 0
  > [21-06-26 09:35:02.7753] Slim::Player::Song::open (360) 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.7766] 
Plugins::Spotty::AccountHelper::purgeAudioCacheAfterXTracks (228) Played 5 
song(s) since last audio cache purge.
  > [21-06-26 09:35:02.7768] Slim::Player::Song::open (384) seek=false time=0 
canSeek=2
  > [21-06-26 09:35:02.7770] 
Slim::Player::TranscodingHelper::getConvertCommand2 (488) Matched: spt->ogg 
via: [spotty-x86_64] --enable-volume-normalisation  -n Squeezebox -c 
"/var/lib/squeezeboxserver/cache/spotty/fce79a84" --single-track $URL$ 
--bitrate 320 --disable-discovery --disable-audio-cache --pass-through
  > [21-06-26 09:35:02.7771] Slim::Player::Song::open (414) Transcoder: 
streamMode=R, streamformat=ogg
  > [21-06-26 09:35:02.7773] 
Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (662) Using command 
for conversion: 
"/var/lib/squeezeboxserver/cache/InstalledPlugins/Plugins/Spotty/Bin/i386-linux/spotty-x86_64"
 --enable-volume-normalisation  -n Squeezebox -c 
"/var/lib/squeezeboxserver/cache/spotty/fce79a84" --single-track 
"spotify://track:4dQKsoCEGMWr23QZTkoGRp" --bitrate 320 --disable-discovery 
--disable-audio-cache --pass-through & |
  > [21-06-26 09:35:02.7774] Slim::Player::Song::open (567) Tokenized command: 
"/var/lib/squeezeboxserver/cache/InstalledPlugins/Plugins/Spotty/Bin/i386-linux/spotty-x86_64"
 --enable-volume-normalisation  -n Squeezebox -c 
"/var/lib/squeezeboxserver/cache/spotty/fce79a84" --single-track 
"spotify://track:4dQKsoCEGMWr23QZTkoGRp" --bitrate 320 --disable-discovery 
--disable-audio-cache --pass-through & |
  > [21-06-26 09:35:02.7876] Slim::Player::StreamingController::_Stream (1282) 
00:04:20:1f:4a:00: stream
  > [21-06-26 09:35:02.7881] Slim::Player::Boom::play (342) Setting LineIn to 0 
for [spotify://track:4dQKsoCEGMWr23QZTkoGRp]
  > [21-06-26 09:35:02.7882] Slim::Player::Boom::setLineIn (434) Switching to 
line in 0
  > [21-06-26 09:35:02.7885] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.7891] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.7896] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(201) Found cached metadata for spotify:track:0q6nRzY4uFEudb8072a3CQ
  > [21-06-26 09:35:02.7899] Slim::Player::StreamingController::_Stream (1319) 
Song queue is now 0
  > [21-06-26 09:35:02.7901] 
Slim::Player::StreamingController::_setPlayingState (2377) new playing state 
BUFFERING
  > [21-06-26 09:35:02.7901] 
Slim::Player::StreamingController::_setStreamingState (2386) new streaming 
state STREAMING
  > [21-06-26 09:35:02.7905] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.7924] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.7941] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.7952] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.7956] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.8153] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.8171] Plugins::Spotty::ProtocolHandler::getMetadataFor 
(181) Returning metadata cached in song object for 
spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:02.9142] Slim::Player::Player::_buffering (1144) 
Buffering... 0 / 20480
  > [21-06-26 09:35:03.1017] Slim::Player::Source::_readNextChunk (372) end of 
file or error on socket, song pos: 5144587
  > [21-06-26 09:35:03.1021] Slim::Player::Source::_readNextChunk (377) 
00:04:20:1f:4a:00 mark end of stream
  > [21-06-26 09:35:03.1024] Slim::Player::Source::_readNextChunk (385) Didn't 
stream any bytes for this song; mark it as failed
  > [21-06-26 09:35:03.1028] 
Slim::Player::StreamingController::playerStreamingFailed (2248) 
00:04:20:1f:4a:00
  > [21-06-26 09:35:03.1033] Slim::Player::StreamingController::_playersMessage 
(796) Problem: Can't open file for:: spotify://track:4dQKsoCEGMWr23QZTkoGRp
  > [21-06-26 09:35:03.1049] Slim::Player::StreamingController::_Stop (610) 
Song queue is now 0
  > [21-06-26 09:35:03.1054] 
Slim::Player::StreamingController::_setPlayingState (2377) new playing state 
STOPPED
  > [21-06-26 09:35:03.1057] 
Slim::Player::StreamingController::_setStreamingState (2386) new streaming 
state IDLE
  > [21-06-26 09:35:03.1061] Slim::Player::StreamingController::_willRetry 
(1408) no retry data
  > [21-06-26 09:35:03.1066] Slim::Player::StreamingController::nextsong (889) 
The next song is number 1, was 0
  > [21-06-26 09:35:03.1073] Slim::Player::Song::new (109) index 1 -> 
spotify://track:0q6nRzY4uFEudb8072a3CQ
--------------------
> > 
> 
> Note the row: 
> [21-06-26 09:35:03.1017] Slim::Player::Source::_readNextChunk (372)
> end of file or error on socket, song pos: 5144587
> 
> Any thoughts on what might be happening here? 
> 
> Things I've done so far:
> >   >   > 
  - Updated to latest LMS nightly build
  - made sure all plugins are updated (restarted LMS afterward)
  - updated rest of system (Ubuntu Focal on Intel NUC)
  - Rebooted full system after updates
  > > > 
> 
> My Spotify is on a family account and I set up a developer Spotify
> Client ID in the plugin.
> 
> Thanks

I looked up that playlist and in the UK the Coldplay and Allie Moss
tracks are not in the playlist.

Sent from my Pixel 3a using Tapatalk




------------------------------------------------------------------------
slartibartfast's Profile: http://forums.slimdevices.com/member.php?userid=35609
View this thread: http://forums.slimdevices.com/showthread.php?t=114726

_______________________________________________
plugins mailing list
[email protected]
http://lists.slimdevices.com/mailman/listinfo/plugins

Reply via email to