Bug 10612 - Rhapsody synced can stop on one player with decoding error
: Rhapsody synced can stop on one player with decoding error
Status: NEW
Product: Logitech Media Server
Classification: Unclassified
Component: Rhapsody Direct
: 7.3.0
: All Fedora
: P3 normal (vote)
: 8.0.0
Assigned To: Andy Grundman
:
Depends on:
Blocks:
  Show dependency treegraph
 
Reported: 2009-01-09 02:03 UTC by Alan Young
Modified: 2009-07-29 14:58 UTC (History)
0 users

See Also:
Category: ---


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Alan Young 2009-01-09 02:03:55 UTC
When a decoding error occurs on just one player in a sync group, then that player will be silent for that track and the whole sync-group will stall at the end of the track. 

Some relevant log entries:
[09-01-09 10:50:50.7312] Slim::Plugin::RhapsodyDirect::Plugin::rpds_handler (320) 00:04:20:10:0f:5c Rhapsody decoding failure: code 109
[09-01-09 10:50:50.7815] Slim::Player::StreamingController::playerReadyToStream (1645) 00:04:20:10:0f:5c
[09-01-09 10:50:50.7839] Slim::Player::StreamingController::_setStreamingState (1815) new streaming state IDLE
[09-01-09 10:50:50.7844] Slim::Player::StreamingController::nextsong (747) The next song is number 32, was 31
[09-01-09 10:50:50.7877] Slim::Player::Song::new (64) index 32 -> rhapd://Tra.1862269.mp3
[09-01-09 10:50:50.7884] Slim::Player::StreamingController::_setStreamingState (1815) new streaming state TRACKWAIT
[09-01-09 10:50:50.7888] Slim::Player::Song::getNextSong (178) rhapd://Tra.1862269.mp3
[09-01-09 10:50:50.7894] Slim::Player::Song::getNextSong (200) scanning URL rhapd://Tra.1862269.mp3
[09-01-09 10:50:50.7900] Slim::Player::Song::getNextSong (178) rhapd://Tra.1862269.mp3
[09-01-09 10:50:52.5722] Slim::Player::StreamingController::_nextTrackReady (639) 00:04:20:10:0f:5c: nextTrack will be index 32
[09-01-09 10:50:56.8122] Slim::Player::StreamingController::playerTrackStarted (1627) 00:04:20:1e:00:b2
[09-01-09 10:52:21.7904] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 86209820
[09-01-09 10:52:21.7913] Slim::Player::Source::_readNextChunk (515) 00:04:20:10:0f:5c mark end of stream
[09-01-09 10:52:21.7920] Slim::Player::Source::_readNextChunk (515) 00:04:20:1e:00:b2 mark end of stream
[09-01-09 10:52:21.7931] Slim::Player::StreamingController::_Invalid (324) 00:04:20:10:0f:5c: event LocalEndOfStream received while in invalid state PLAYING-TRACKWAIT
[09-01-09 10:52:21.7944] Slim::Utils::Misc::msg (1122) Warning: [10:52:21.7940] Backtrace:

   frame 0: Slim::Player::StreamingController::_Invalid (/data1/awy/oz-workspace/SC7.4/Slim/Player/StreamingController.pm line 286)
   frame 1: Slim::Player::StreamingController::_eventAction (/data1/awy/oz-workspace/SC7.4/Slim/Player/StreamingController.pm line 1315)
   frame 2: Slim::Player::StreamingController::localEndOfStream (/data1/awy/oz-workspace/SC7.4/Slim/Player/Source.pm line 519)
   frame 3: Slim::Player::Source::_readNextChunk (/data1/awy/oz-workspace/SC7.4/Slim/Player/Source.pm line 217)
   frame 4: Slim::Player::Source::nextChunk (/data1/awy/oz-workspace/SC7.4/Slim/Player/Client.pm line 1292)
   frame 5: Slim::Player::Client::nextChunk (/data1/awy/oz-workspace/SC7.4/Slim/Web/HTTP.pm line 2149)
   frame 6: Slim::Web::HTTP::sendStreamingResponse (/data1/awy/oz-workspace/SC7.4/Slim/Networking/IO/Select.pm line 268)
   frame 7: (eval) (/data1/awy/oz-workspace/SC7.4/Slim/Networking/IO/Select.pm line 268)
   frame 8: Slim::Networking::IO::Select::select (slimserver.pl line 543)
   frame 9: main::idle (slimserver.pl line 488)
   frame 10: main::main (slimserver.pl line 1051)

[09-01-09 10:52:24.3960] Slim::Player::StreamingController::playerEndOfStream (1711) 00:04:20:1e:00:b2
[09-01-09 10:54:36.5312] Slim::Player::StreamingController::playerReadyToStream (1645) 00:04:20:1e:00:b2
[09-01-09 10:54:46.5018] Slim::Player::StreamingController::playerStopped (1604) 00:04:20:1e:00:b2
Comment 1 Alan Young 2009-01-09 02:19:39 UTC
Change 24589 passes the error indication to the controller.

Andy, do you want to keep this open as a handle to investigate the problem with these decoding errors arising when synced? Otherwise please add a Changelog entry and close as fixed.
Comment 2 Andy Grundman 2009-01-09 06:00:07 UTC
Yeah we need to get to the bottom of the decoding errors.
Comment 3 Chris Owens 2009-03-16 09:46:15 UTC
We are now planning to make a 7.3.3 release.  Please review your bugs (all marked open against 7.3.3) to see if they can be fixed in the next few weeks, or if they should be retargeted for 7.4 or future.

Thanks!
Comment 4 Chris Owens 2009-03-30 17:31:59 UTC
Since there's now a planned 7.3.3 release, bugs which won't make the cut-off are being moved to the next target out.  If you feel that this bug needs to be addressed more (or less) urgently than the 7.4 release, please cc chris@slimdevices.com and leave a comment in the bug to that effect so we can review it.

Thanks.
Comment 5 Chris Owens 2009-03-31 08:54:24 UTC
For some reason Bugzilla did not change the target when I did this yesterday.  Or maybe it was me.  In either case, I'm trying it again.
Comment 6 Andy Grundman 2009-07-29 14:58:54 UTC
Moving 7.4 bugs to 8.0.