Spotty - 8-10 sec wait between songs

Collapse
X
 
  • Time
  • Show
Clear All
new posts
  • thekman35
    Junior Member
    • Aug 2018
    • 21

    Spotty - 8-10 sec wait between songs

    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
    Babelfish's Best Boy
    • Apr 2005
    • 24653

    #2
    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?
    Michael

    "It doesn't work - what shall I do?" - "Please check your server.log and/or scanner.log file!"
    (LMS: Settings/Information)

    Comment

    • thekman35
      Junior Member
      • Aug 2018
      • 21

      #3
      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

      Comment

      • d6jg
        Senior Member
        • Feb 2011
        • 8953

        #4
        Are you using a standard internet connection or some kind of VPN or DNS proxy?
        Jim



        pCP9.0 / LMS 9.x storage QNAP TS419p (NFS)
        Living Room Joggler & Pi4/Khadas -> Onkyo TXNR686 -> Celestion F20s
        Office Joggler & Pi3 -> Onkyo CRN775 -> Wharfedale Modus Cubes
        Kitchen WiiM Pro -> Topping MX3 - B&W In Ceiling speakers
        Bedroom (Bedside) Pi Zero+DAC ->ToppingTP21 ->AKG Headphones
        Bedroom (TV) & Bathroom SB Touch ->Denon AVR ->Mordaunt Short M10s + Kef ceiling speakers
        Guest Room Joggler > Denon RCFN8 -> Celestions F10s

        Comment

        • thekman35
          Junior Member
          • Aug 2018
          • 21

          #5
          Just a standard internet connection. 50Mbps down/ 20 Mbps up

          Comment

          • edwin2006
            Senior Member
            • May 2017
            • 863

            #6
            Not completely standard with a mikrotik router
            SqueezeBoxes: 1x Transporter (Living room) 1x SB2 (shed), 1x Radio (Kitchen), 1x Boom (Dining room), 1x piCorePlayer (jacuzzi), 1x piCorePlayer (Garden) 1x OSMC + Squeezelite (Movie room), 1x Touch (Study 2), few spare unit's (SB2, SB3, Boom, Touch)
            Server: LMS on Pi3B+ 8.1.2 on PcP 7.0.1
            Network: Draytek, Netgear Smart Switch 24p, Ubiquiti PoE, 3x Ubiquity

            Comment

            • alc23
              Junior Member
              • Jan 2011
              • 15

              #7
              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:

              Code:
              [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)

              Comment

              • mherger
                Babelfish's Best Boy
                • Apr 2005
                • 24653

                #8
                Originally posted by alc23
                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:

                Code:
                [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.
                Michael

                "It doesn't work - what shall I do?" - "Please check your server.log and/or scanner.log file!"
                (LMS: Settings/Information)

                Comment

                • alc23
                  Junior Member
                  • Jan 2011
                  • 15

                  #9
                  Originally posted by mherger
                  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.

                  Comment

                  • alc23
                    Junior Member
                    • Jan 2011
                    • 15

                    #10
                    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.

                    Comment

                    • thekman35
                      Junior Member
                      • Aug 2018
                      • 21

                      #11
                      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.

                      Comment

                      Working...