Bug 16173 - Interaction between SB and SBS has very long pauses
: Interaction between SB and SBS has very long pauses
Status: UNCONFIRMED
Product: SB 2/3
Classification: Unclassified
Component: SB Server
: 130
: PC Windows Home Server
: -- normal (vote)
: ---
Assigned To: Unassigned bug - please assign me!
:
Depends on:
Blocks:
  Show dependency treegraph
 
Reported: 2010-04-30 12:00 UTC by Steve Sheafor
Modified: 2010-05-05 15:19 UTC (History)
1 user (show)

See Also:
Category: ---


Attachments
Log when the system is hung in an infinite loop (48.83 KB, application/octet-stream)
2010-04-30 12:00 UTC, Steve Sheafor
Details
Log when the server has paused and then restarted (47.11 KB, application/octet-stream)
2010-04-30 12:01 UTC, Steve Sheafor
Details

Note You need to log in before you can comment on or make changes to this bug.
Description Steve Sheafor 2010-04-30 12:00:24 UTC
Created attachment 6815 [details]
Log when the system is hung in an infinite loop

I have SBS running under WHS on an HP MediaSmart EX470.  There is a single
SqueezeBox 3 connected to it in a 100 Mb/s wired Ethernet LAN.  I control the
system from a third client machine running Windows 7.  I can control the SB3
via IR links to a Crestron home management system.  The system has been
operational for roughly 4 years.

When I upgraded to version 7.3 of SBS (then called SqueezeCenter), I began to
have performance issues.  When the SB reached the end of a track, it would
occasionally pause for quite a while, often more than a minute.  If the pause
was relatively short, the next track would eventually play, but if the pause
was long the previous track would repeat.

I upgraded to version 7.4.2, and the behavior changed somewhat.  The pauses
still occurred, and were occasionally longer, but the next track always played
- there was never a repeat of the previous track.  Occasionally, however, the
system would hang completely - the browser display would appear to show a few
seconds of the track playing, and then reset, but there was never any sound.  I
have to hit the Back button to recover from this, as the Forward button doesn't
seem to have any effect.  In addition, the long pause would sometimes occur in
the middle of a track, which I had never observed with 7.3.

The browser display generally shows a "CONNECTING...." message when any of the
delays are occurring.

I recently upgraded to version 7.5.0 - r30464 of SBS.  The behavior is still
the same.  At that point I began monitoring network traffic with Task Manager,
and I notice a consistent pattern.  When things are working correctly, just
before a new track starts there is a burst of data from the server to the SB,
about 15% of the available bandwidth (15 Mb/s, which is the transfer of the
next track), and a similar much smaller burst is received by the client machine
(I assume to update the browser display).  In between bursts, there is a short
data transfer between the server and the client every 10 seconds, which is the
update of the browser display.

When the playback pauses, it appears that there is no traffic at all on the
server and occasionally tiny transmit traffic on the client every 10 seconds,
this can go on for quite a long time (I have observed this to be as long as 3
minutes) and then eventually the large burst happens and the music begins.  It
seems like the server is hung up waiting for something.

In version 7.4.2 I attempted to perform some logging.  I have attached two log
files, one from a pause which eventually restarted and one from the case where
the system loops forever.  It seems like the logging choices have changed in
7.5 and I can't find anything which creates these same logs.

One other seemingly related behavior is that again since the installation of
7.3, the SB3 has become very slow and erratic in responding to IR commands.  It
will often delay 10-15 seconds before responding to a command like Pause or
Play, whether through the Crestron system of using the remote control.  It will
also occasionally fail to respond to a command at all.  This leads me to
believe that the problem could all be in the SB firmware, if it were hanging up
for some  amount of time and failing to respond to either the IR commands or to
request a track from the server.

I am happy to capture logs if you can tell me what would be most useful.
Comment 1 Steve Sheafor 2010-04-30 12:01:02 UTC
Created attachment 6816 [details]
Log when the server has paused and then restarted
Comment 2 Steve Sheafor 2010-05-03 14:42:29 UTC
I installed the nightly release 7.5.1 - r30709.  The behavior seems similar, but the issue of getting hung in an infinite loop seems noticeably worse.
Comment 3 Steve Sheafor 2010-05-05 15:19:49 UTC
The 7.5.1 -r30709 release turned out to be incredibly worse - the looping hang occurs on average about every three tracks.  I went back to 7.5.0 -r30464 and the system behaves as before, with occasional pauses and a few looping hangs.

NOTE: I use Fishbone as my user interface, which is why I see the CONNECTING... messages.  I tried Default and it has the same problems but doesn't seem to have a way to report connection attempts.  In Default, when the playback pauses the track time appears to simply continue to advance, which does not seem to be the case in Fishbone.  On the looping hangs, the remaining time at the right end of the track display goes negative and appears to decrement forever, and the playing time increments forever.