Hello all,

I have this strange issue since latest beta update of LMS:
Spotify tracks do not make it to the end. After about 3 minutes, the
song stops playing and immediately the next song starts.
What can be the issue?


Code:
--------------------
    [21-10-21 20:03:51.0256] Slim::Player::Squeezebox2::directHeaders (478) 
Processing headers for direct streaming:
  HTTP/1.1 200 OK
  Server: Logitech Media Server (8.3.0 - 1634705773)
  Connection: close
  Content-Type: audio/L16
  Set-Cookie: Squeezebox-albumView=; path=/
  Set-Cookie: Squeezebox-expandPlayerControl=true; path=/
  Set-Cookie: Squeezebox-expanded-MY_MUSIC=1; path=/
  Set-Cookie: Squeezebox-expanded-FAVORITES=1; path=/
  Set-Cookie: Squeezebox-expanded-PLUGINS=0; path=/
  Set-Cookie: Squeezebox-expanded-PLUGIN_MY_APPS_MODULE_NAME=1; path=/
  Set-Cookie: Squeezebox-expanded-RADIO=0; path=/
  
  [21-10-21 20:04:00.4696] 
Slim::Player::StreamingController::playerTrackStarted (2200) 02:00:4c:4f:4f:50
  [21-10-21 20:04:00.6561] 
Slim::Player::StreamingController::playerTrackStarted (2200) 00:04:20:16:ce:f7
  [21-10-21 20:04:00.6765] 
Slim::Player::StreamingController::playerTrackStarted (2200) 00:04:20:17:71:bd
  [21-10-21 20:04:00.7923] 
Slim::Player::StreamingController::playerTrackStarted (2200) 00:04:20:27:a3:ff
  [21-10-21 20:04:00.7924] Slim::Player::StreamingController::_setPlayingState 
(2377) new playing state PLAYING
  [21-10-21 20:04:00.7925] Slim::Player::StreamingController::_Playing (362) 
Song 5 is not longer in the queue
  [21-10-21 20:04:00.7927] Slim::Player::StreamingController::_Playing (368) 
Song 6 has now started playing
  [21-10-21 20:04:00.7935] Slim::Player::StreamingController::_Playing (397) 
Song queue is now 6
  [21-10-21 20:04:01.0339] 
Slim::Player::StreamingController::playerTrackStarted (2200) 1c:1a:df:f8:78:0c
  [21-10-21 20:04:32.0063] Slim::Player::StreamingController::_newMaster (2342) 
new master: 02:00:4c:4f:4f:50
  [21-10-21 20:04:35.2627] Slim::Player::StreamingController::_newMaster (2342) 
new master: 00:04:20:17:71:bd
  [21-10-21 20:06:30.3199] Slim::Player::Source::_readNextChunk (378) end of 
file or error on socket, song pos: 19981824
  [21-10-21 20:06:30.3201] Slim::Player::Source::_readNextChunk (383) 
00:04:20:17:71:bd mark end of stream
  [21-10-21 20:06:30.3204] 
Slim::Player::StreamingController::_setStreamingState (2386) new streaming 
state STREAMOUT
  [21-10-21 20:06:30.7230] Slim::Player::StreamingController::playerEndOfStream 
(2286) 00:04:20:17:71:bd
  [21-10-21 20:06:30.7232] 
Slim::Player::StreamingController::_setStreamingState (2386) new streaming 
state STREAMOUT
  [21-10-21 20:06:48.4754] 
Slim::Player::StreamingController::playerReadyToStream (2218) 00:04:20:17:71:bd
  [21-10-21 20:06:48.4756] 
Slim::Player::StreamingController::_setStreamingState (2386) new streaming 
state IDLE
  [21-10-21 20:06:48.4758] Slim::Player::StreamingController::nextsong (889) 
The next song is number 7, was 6
  [21-10-21 20:06:48.4760] Slim::Player::Song::new (109) index 7 -> 
spotify://track:54o9SStYYAPLGbNGOmf96C
  [21-10-21 20:06:48.4764] 
Slim::Player::StreamingController::_setStreamingState (2386) new streaming 
state TRACKWAIT
  [21-10-21 20:06:48.4766] Slim::Player::Song::getNextSong (222) 
spotify://track:54o9SStYYAPLGbNGOmf96C
  [21-10-21 20:06:48.4767] Slim::Player::StreamingController::_nextTrackReady 
(744) 00:04:20:17:71:bd: nextTrack will be index 7
  [21-10-21 20:06:48.4768] Slim::Player::StreamingController::_Stream (1210) 
Song queue is now 7,6
  [21-10-21 20:06:48.4769] Slim::Player::StreamingController::_Stream (1213) 
00:04:20:17:71:bd: preparing to stream song index 7
  [21-10-21 20:06:48.4771] Slim::Player::Song::open (362) 
spotify://track:54o9SStYYAPLGbNGOmf96C
  [21-10-21 20:06:48.4779] Slim::Player::Song::open (386) seek=false time=0 
canSeek=2
  [21-10-21 20:06:48.5105] Slim::Player::TranscodingHelper::checkBin (301)    
couldn't find binary for: spotty-ogg
  [21-10-21 20:06:48.5107] Slim::Player::TranscodingHelper::getConvertCommand2 
(493) Matched: spt->pcm via: [spotty.exe] --enable-volume-normalisation  -n 
Squeezebox -c "C:\ProgramData\Squeezebox\Cache\spotty\95e154df" --single-track 
$URL$ --bitrate 160 --disable-discovery --disable-audio-cache $START$
  [21-10-21 20:06:48.5108] Slim::Player::Song::open (416) Transcoder: 
streamMode=R, streamformat=pcm
  [21-10-21 20:06:48.5111] 
Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (667) Using command 
for conversion: 
"C:\ProgramData\Squeezebox\Cache\InstalledPlugins\Plugins\Spotty\Bin\MSWin32-x86-multi-thread\spotty.exe"
 --enable-volume-normalisation  -n Squeezebox -c 
"C:\ProgramData\Squeezebox\Cache\spotty\95e154df" --single-track 
"spotify://track:54o9SStYYAPLGbNGOmf96C" --bitrate 160 --disable-discovery 
--disable-audio-cache
  [21-10-21 20:06:48.5112] Slim::Player::Song::open (578) Tokenized command: 
"C:\ProgramData\Squeezebox\Cache\InstalledPlugins\Plugins\Spotty\Bin\MSWin32-x86-multi-thread\spotty.exe"
 --enable-volume-normalisation  -n Squeezebox -c 
"C:\ProgramData\Squeezebox\Cache\spotty\95e154df" --single-track 
"spotify://track:54o9SStYYAPLGbNGOmf96C" --bitrate 160 --disable-discovery 
--disable-audio-cache
  [21-10-21 20:06:48.5121] Slim::Player::Pipeline::new (95) Launching process 
with command: 
"C:\PROGRA~2\SQUEEZ~2\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe"  
-d  -w -o 57548 -c 
"\"C:\ProgramData\Squeezebox\Cache\InstalledPlugins\Plugins\Spotty\Bin\MSWin32-x86-multi-thread\spotty.exe\"
 --enable-volume-normalisation  -n Squeezebox -c 
\"C:\ProgramData\Squeezebox\Cache\spotty\95e154df\" --single-track 
\"spotify://track:54o9SStYYAPLGbNGOmf96C\" --bitrate 160 --disable-discovery 
--disable-audio-cache"
  [21-10-21 20:06:48.5189] Slim::Player::StreamingController::_Stream (1282) 
00:04:20:17:71:bd: stream
  [21-10-21 20:06:48.5209] Slim::Player::StreamingController::_Stream (1319) 
Song queue is now 7,6
  [21-10-21 20:06:48.5211] 
Slim::Player::StreamingController::_setStreamingState (2386) new streaming 
state STREAMING
--------------------


------------------------------------------------------------------------
stephanvdplas's Profile: http://forums.slimdevices.com/member.php?userid=44861
View this thread: http://forums.slimdevices.com/showthread.php?t=114836

_______________________________________________
plugins mailing list
plugins@lists.slimdevices.com
http://lists.slimdevices.com/mailman/listinfo/plugins

Reply via email to