PDA

View Full Version : Spotty - 8-10 sec wait between songs



thekman35
2018-08-08, 02:46
I'm fairly new to LMS and Squeezeboxes in general so please bear with me. So far I like what I see.

I setup LMS on a Ubuntu 16.04 server with a seperate RPi running 4 instances of squeezelite for multiroom speakers and installed the Spotty plugin and signed up for a Spotify Premium trial. When skipping songs/playing 1st song in a list, there's at least a 8 sec wait before the song starts playing

I have seen various posts mentioning the same issue but no clear reason as to why it happens, so I started monitoring bandwidth on the LMS when a song is changed.

It seems as though the connection which is downloading the song is capping out at around 3Mbps. I initailly thought that there was something wrong with the network card on the server, but a speedtest showed around 50Mbps download, which is my maximum speed. Different routers/internet connections are also showing the connection peaking at 3Mbps.

Has anyone else seen this? I'm thinking Spotify most likely cap inbound connections using the API.

Any feedback most welcome.

mherger
2018-08-08, 05:26
Are the players synchronised? If so, try to un-synch them.

Check Settings/Advanced/File Types and disable transcoding Spotty -> FLAC, leaving Spotty -> PCM in place.

Would any of this make a difference?

thekman35
2018-08-09, 03:48
Thanks for the reply Michael.

I've tried playing on a seperate player, setup on both a Pi or PC and either still takes around 8-10 to start playing.
And currently have FLAC disabled and PCM enabled but it's still happening.

I've been watching my Mikrotik router traffic flow using the Torch function. It's definitely capping out at 3Mbps when downloading the song. You see the same speeds when playing a playlist, when the current song is about 5 seconds from finishing.

The connections seem to going to the 104.196.0.0/14 subnet which belongs to googleusercontent.com

d6jg
2018-08-13, 16:23
Are you using a standard internet connection or some kind of VPN or DNS proxy?

thekman35
2018-08-18, 03:57
Just a standard internet connection. 50Mbps down/ 20 Mbps up

edwin2006
2018-08-18, 14:16
Not completely standard with a mikrotik router ;)

alc23
2018-08-20, 19:45
I can report a similar problem. When listening to songs via Spotty, the current song will finish and there is a gap of 5-10 seconds. For the majority of the time, the display on my SB Touch will say "Rebuffering... 0%" then I can briefly see the percentage shoot up very quickly before the next song in the queue plays.

I have played with switching off synchronisation and disabling Spotty->FLAC transcoding, but the issue remains.

This is on Spotty 2.4.2, LMS 7.9.1.

Between each track I get a bunch of these in the LMS server logs:


[18-08-21 12:38:43.1765] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1769] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1774] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1778] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1782] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1786] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1790] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1793] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1796] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1798] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1801] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1803] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1805] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1808] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1810] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1812] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1814] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1817] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1820] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1822] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1824] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1826] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1829] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1831] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1833] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)
[18-08-21 12:38:43.1837] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)

mherger
2018-08-20, 21:15
I have played with switching off synchronisation and disabling Spotty->FLAC transcoding, but the issue remains.

This is on Spotty 2.4.2, LMS 7.9.1.

Between each track I get a bunch of these in the LMS server logs:


[18-08-21 12:38:43.1765] Slim::Networking::IO::Select::__ANON__ (131) Error: Select task failed calling Slim::Web::HTTP::sendStreamingResponse: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Slim/Networking/IO/Select.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x17a0d75c)


What OS are you running this on? These lines often point to networking issues.

alc23
2018-08-21, 01:03
What OS are you running this on? These lines often point to networking issues.

Hi Michael - LMS runs on a Windows 10 Pro machine. It's got a wired LAN connection to an ASUS router which then goes wi-fi to an SB Touch, 2 x Radio, 1 x Boom, 1 x Duet.

alc23
2018-09-06, 22:47
An update: my issues with pauses between Spotify tracks have disappeared since updating to LMS 7.9.2 and Spotty 2.4.4. There are also no longer the Networking::IO errors in server.log.

There is still a slight pause as the new track buffers ("Rebuffering...x%") but it's minimal.

thekman35
2018-09-07, 17:45
I have installed 7.9.2 and Spotty 2.4.4 but still seeing the same 7-8 sec gap between playing the initial song, or skipping songs in a playlist.

Different router now in place as well.