[08-03-29 20:32:42.7445] Slim::Player::Source::decoderUnderrun (582) 00:04:20:07:6e:1a: Decoder underrun while this mode: playout-play [08-03-29 20:32:42.7456] Slim::Player::Source::nextsong (1556) The next song is number 56, was 55 [08-03-29 20:32:42.7474] Slim::Player::Source::nextsong (1556) The next song is number 56, was 55 [08-03-29 20:32:42.7487] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (400) End of track, logging usage info (171 seconds)... [08-03-29 20:32:42.7515] Slim::Plugin::RhapsodyDirect::RPDS::rpds (72) 00:04:20:07:6e:1a RPDS packet sent: 4 [08-03-29 20:32:44.0629] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (126) 00:04:20:07:6e:1a Got RPDS packet: \"\4" [08-03-29 20:32:44.0669] Slim::Plugin::RhapsodyDirect::RPDS::rpds (72) 00:04:20:07:6e:1a RPDS packet sent: 3 [08-03-29 20:32:45.2713] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (126) 00:04:20:07:6e:1a Got RPDS packet: \"\3\x001http://llnw-750.listen.com/5/0/3/9/8/74689305.rad" [08-03-29 20:32:45.8831] Slim::Player::Source::skipahead (873) **skipahead: opening next song [08-03-29 20:32:45.8840] Slim::Player::Source::gotoNext (1206) Opening next song... [08-03-29 20:32:45.8851] Slim::Player::Source::nextsong (1556) The next song is number 56, was 55 [08-03-29 20:32:45.9413] Slim::Player::TranscodingHelper::getConvertCommand (201) undermax = 1, type = wma, squeezebox2 = 00:04:20:07:6e:1a [08-03-29 20:32:45.9521] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: wma-wma-squeezebox2-00:04:20:07:6e:1a [08-03-29 20:32:45.9531] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: wma-wma-*-00:04:20:07:6e:1a [08-03-29 20:32:45.9539] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: wma-wma-squeezebox2-* [08-03-29 20:32:45.9549] Slim::Player::TranscodingHelper::enabledFormat (105) Checking to see if wma-wma-squeezebox2-* is enabled [08-03-29 20:32:45.9559] Slim::Player::TranscodingHelper::checkBin (146) enabled [08-03-29 20:32:45.9568] Slim::Player::TranscodingHelper::checkBin (148) Found command: - [08-03-29 20:32:45.9580] Slim::Player::TranscodingHelper::getConvertCommand (302) Matched Format: wma Type: wma Command: - [08-03-29 20:32:45.9590] Slim::Player::Source::gotoNext (1293) opening next song (old format: wma, new: wma) current playmode: playout-play [08-03-29 20:32:45.9599] Slim::Player::Source::streamingSongIndex (1350) Adding song index 56 to song queue [08-03-29 20:32:45.9608] Slim::Player::Source::streamingSongIndex (1371) Song queue is now 56,55 [08-03-29 20:32:45.9617] Slim::Player::Source::skipahead (879) **skipahead: restarting [08-03-29 20:32:45.9626] Slim::Player::Source::playmode (298) 00:04:20:07:6e:1a: Switching to mode play from playout-play [08-03-29 20:32:45.9639] Slim::Player::Source::resetSong (1595) Resetting song buffer. [08-03-29 20:32:45.9756] Slim::Player::Source::openSong (1690) Trying to open: rhapd://Tra.15728024.wma [08-03-29 20:32:46.0427] Slim::Player::Source::playmode (401) 00:04:20:07:6e:1a New play mode: play [08-03-29 20:32:46.0600] Slim::Player::Squeezebox::stream (1013) This player supports direct streaming for rhapd://Tra.15728024.wma as http://llnw-750.listen.com/5/0/3/9/8/74689305.rad, let's do it. [08-03-29 20:32:46.0664] Slim::Player::Squeezebox::stream (1044) setting up direct stream (3496968243:80) autostart: 3. [08-03-29 20:32:46.0723] Slim::Player::Squeezebox::stream (1045) request string: GET /5/0/3/9/8/74689305.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-750.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.0/17759 Icy-Metadata: 1 [08-03-29 20:32:46.0823] Slim::Player::Source::playmode (556) 00:04:20:07:6e:1a: Current playmode: play [08-03-29 20:32:46.4360] Slim::Player::Squeezebox2::directHeaders (284) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.2.3 Accept-Ranges: bytes Content-Length: 2934236 Content-Type: text/plain Age: 86045 Date: Sat, 29 Mar 2008 17:32:24 GMT Last-Modified: Tue, 31 Jul 2007 21:15:31 GMT Connection: close [08-03-29 20:32:46.4373] Slim::Player::Squeezebox2::directHeaders (343) Processing 8 headers [08-03-29 20:32:46.4383] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Server: Apache/2.2.3 [08-03-29 20:32:46.4392] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Accept-Ranges: bytes [08-03-29 20:32:46.4402] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Content-Length: 2934236 [08-03-29 20:32:46.5690] Slim::Player::Squeezebox2::directHeaders (396) Got a stream type: wma bitrate: 128000 title: [08-03-29 20:32:46.5747] Slim::Player::Squeezebox2::directHeaders (455) Beginning direct stream! [08-03-29 20:32:48.6558] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 204) [08-03-29 20:32:48.7171] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 264) [08-03-29 20:32:48.7225] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 132) [08-03-29 20:32:48.7317] Slim::Player::Protocols::MMS::setMetadata (271) Setting bitrate to 128 from WMA bitrate properties object [08-03-29 20:32:52.7264] Slim::Player::Source::trackStartEvent (1461) Got a track starting event [08-03-29 20:32:52.7270] Slim::Player::Source::trackStartEvent (1468) Song 55 had already started, so it's not longer in the queue [08-03-29 20:32:52.7486] Slim::Player::Source::trackStartEvent (1477) Song 56 has now started playing [08-03-29 20:32:52.7511] Slim::Player::Source::trackStartEvent (1505) Song queue is now 56 [08-03-29 20:33:50.1113] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onJump (452) Handling command "jump", playmode: playout-play [08-03-29 20:33:50.1802] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onJump (482) Track skip, logging usage info (56 seconds)... [08-03-29 20:33:50.1817] Slim::Plugin::RhapsodyDirect::RPDS::rpds (72) 00:04:20:07:6e:1a RPDS packet sent: 4 [08-03-29 20:33:51.2721] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (126) 00:04:20:07:6e:1a Got RPDS packet: \"\4" [08-03-29 20:33:51.2762] Slim::Plugin::RhapsodyDirect::RPDS::rpds (72) 00:04:20:07:6e:1a RPDS packet sent: 3 [08-03-29 20:33:52.6005] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (126) 00:04:20:07:6e:1a Got RPDS packet: \"\3\x001http://llnw-982.listen.com/8/2/9/8/1/92318928.rad" [08-03-29 20:33:53.0246] Slim::Player::Source::playmode (298) 00:04:20:07:6e:1a: Switching to mode stop from playout-play [08-03-29 20:33:53.0266] Slim::Player::Source::playmode (401) 00:04:20:07:6e:1a New play mode: stop [08-03-29 20:33:53.0276] Slim::Player::Source::playmode (444) 00:04:20:07:6e:1a: Stopping and clearing out old chunks [08-03-29 20:33:53.0366] Slim::Player::Source::resetSong (1595) Resetting song buffer. [08-03-29 20:33:53.0378] Slim::Player::Source::resetSongQueue (1424) Resetting song queue [08-03-29 20:33:53.0387] Slim::Player::Source::resetSongQueue (1434) Song queue is now 56 [08-03-29 20:33:53.0413] Slim::Player::Source::playmode (556) 00:04:20:07:6e:1a: Current playmode: stop [08-03-29 20:33:53.0422] Slim::Player::Source::jumpto (1156) Jumping by +1 [08-03-29 20:33:53.0431] Slim::Player::Source::streamingSongIndex (1350) Adding song index 57 to song queue [08-03-29 20:33:53.0443] Slim::Player::Source::streamingSongIndex (1354) Clearing out song queue first [08-03-29 20:33:53.0452] Slim::Player::Source::streamingSongIndex (1371) Song queue is now 57 [08-03-29 20:33:53.0468] Slim::Player::Source::playmode (298) 00:04:20:07:6e:1a: Switching to mode play from stop [08-03-29 20:33:53.0481] Slim::Player::Source::resetSong (1595) Resetting song buffer. [08-03-29 20:33:53.0591] Slim::Player::Source::openSong (1690) Trying to open: rhapd://Tra.952218.wma [08-03-29 20:33:53.1193] Slim::Player::Source::playmode (401) 00:04:20:07:6e:1a New play mode: play [08-03-29 20:33:53.1423] Slim::Player::Squeezebox::stream (1013) This player supports direct streaming for rhapd://Tra.952218.wma as http://llnw-982.listen.com/8/2/9/8/1/92318928.rad, let's do it. [08-03-29 20:33:53.1491] Slim::Player::Squeezebox::stream (1044) setting up direct stream (1150180293:80) autostart: 3. [08-03-29 20:33:53.1500] Slim::Player::Squeezebox::stream (1045) request string: GET /8/2/9/8/1/92318928.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-982.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.0/17759 Icy-Metadata: 1 [08-03-29 20:33:53.1625] Slim::Player::Source::playmode (556) 00:04:20:07:6e:1a: Current playmode: play [08-03-29 20:33:53.2728] Slim::Player::Squeezebox::buffering (303) Buffering... 0 / 20480 [08-03-29 20:33:53.6567] Slim::Player::Squeezebox2::directHeaders (284) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.0.58 Accept-Ranges: bytes Content-Length: 3740676 Content-Type: text/plain Date: Sat, 29 Mar 2008 17:33:32 GMT Last-Modified: Sun, 27 Jan 2008 16:27:32 GMT Connection: close [08-03-29 20:33:53.6580] Slim::Player::Squeezebox2::directHeaders (343) Processing 7 headers [08-03-29 20:33:53.6589] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Server: Apache/2.0.58 [08-03-29 20:33:53.6598] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Accept-Ranges: bytes [08-03-29 20:33:53.6606] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Content-Length: 3740676 [08-03-29 20:33:53.8059] Slim::Player::Squeezebox2::directHeaders (396) Got a stream type: wma bitrate: 128000 title: [08-03-29 20:33:53.8071] Slim::Player::Squeezebox2::directHeaders (455) Beginning direct stream! [08-03-29 20:33:54.1010] Slim::Player::Squeezebox::buffering (303) Buffering... 0 / 20480 [08-03-29 20:33:54.5172] Slim::Player::Squeezebox::buffering (303) Buffering... 1236 / 20480 [08-03-29 20:33:54.9269] Slim::Player::Squeezebox::buffering (303) Buffering... 1236 / 20480 [08-03-29 20:33:55.3390] Slim::Player::Squeezebox::buffering (303) Buffering... 1236 / 20480 [08-03-29 20:33:55.7000] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 204) [08-03-29 20:33:55.7493] Slim::Player::Squeezebox::buffering (303) Buffering... 9948 / 20480 [08-03-29 20:33:55.7605] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 264) [08-03-29 20:33:55.7632] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 132) [08-03-29 20:33:55.7673] Slim::Player::Protocols::MMS::setMetadata (271) Setting bitrate to 128 from WMA bitrate properties object [08-03-29 20:33:55.9197] Slim::Player::Source::decoderUnderrun (582) 00:04:20:07:6e:1a: Decoder underrun while this mode: playout-play [08-03-29 20:33:55.9255] Slim::Player::Source::nextsong (1556) The next song is number 58, was 57 [08-03-29 20:33:55.9685] Slim::Player::Source::decoderUnderrun (595) Track failed before playback, marking as played [08-03-29 20:33:55.9697] Slim::Player::Source::playmode (298) 00:04:20:07:6e:1a: Switching to mode playout-play from playout-play [08-03-29 20:33:55.9706] Slim::Player::Source::playmode (305) Already in playmode playout-play : ignoring mode change [08-03-29 20:33:55.9883] Slim::Player::Source::nextsong (1556) The next song is number 58, was 57 [08-03-29 20:33:55.9899] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (400) End of track, logging usage info (233 seconds)... [08-03-29 20:33:55.9933] Slim::Plugin::RhapsodyDirect::RPDS::rpds (72) 00:04:20:07:6e:1a RPDS packet sent: 4 [08-03-29 20:33:56.0017] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (126) 00:04:20:07:6e:1a Got RPDS packet: \"\xFC" [08-03-29 20:33:56.0415] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (269) 00:04:20:07:6e:1a Received RPDS -4, SSL connection already in use, retrying later [08-03-29 20:33:56.1587] Slim::Player::Squeezebox::buffering (303) Buffering... 16440 / 20480 [08-03-29 20:33:56.5829] Slim::Player::Squeezebox::buffering (303) Buffering... 26604 / 20480 [08-03-29 20:33:58.3441] Slim::Plugin::RhapsodyDirect::RPDS::rpds_resend (317) 00:04:20:07:6e:1a Re-sending RPDS packet: "\4\x03233" [08-03-29 20:33:58.3457] Slim::Plugin::RhapsodyDirect::RPDS::rpds (72) 00:04:20:07:6e:1a RPDS packet sent: 4 [08-03-29 20:33:59.6639] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (126) 00:04:20:07:6e:1a Got RPDS packet: \"\4" [08-03-29 20:33:59.6704] Slim::Plugin::RhapsodyDirect::RPDS::rpds (72) 00:04:20:07:6e:1a RPDS packet sent: 3 [08-03-29 20:34:00.8784] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (126) 00:04:20:07:6e:1a Got RPDS packet: \"\3\x001http://llnw-971.listen.com/7/1/1/9/1/92319117.rad" [08-03-29 20:34:01.3410] Slim::Player::Source::skipahead (873) **skipahead: opening next song [08-03-29 20:34:01.3414] Slim::Player::Source::gotoNext (1206) Opening next song... [08-03-29 20:34:01.3418] Slim::Player::Source::nextsong (1556) The next song is number 58, was 57 [08-03-29 20:34:01.3462] Slim::Player::TranscodingHelper::getConvertCommand (201) undermax = 1, type = wma, squeezebox2 = 00:04:20:07:6e:1a [08-03-29 20:34:01.3466] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: wma-wma-squeezebox2-00:04:20:07:6e:1a [08-03-29 20:34:01.3470] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: wma-wma-*-00:04:20:07:6e:1a [08-03-29 20:34:01.4064] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: wma-wma-squeezebox2-* [08-03-29 20:34:01.4068] Slim::Player::TranscodingHelper::enabledFormat (105) Checking to see if wma-wma-squeezebox2-* is enabled [08-03-29 20:34:01.4072] Slim::Player::TranscodingHelper::checkBin (146) enabled [08-03-29 20:34:01.4720] Slim::Player::TranscodingHelper::checkBin (148) Found command: - [08-03-29 20:34:01.4727] Slim::Player::TranscodingHelper::getConvertCommand (302) Matched Format: wma Type: wma Command: - [08-03-29 20:34:01.4731] Slim::Player::Source::gotoNext (1293) opening next song (old format: wma, new: wma) current playmode: playout-play [08-03-29 20:34:01.5276] Slim::Player::Source::streamingSongIndex (1350) Adding song index 58 to song queue [08-03-29 20:34:01.5281] Slim::Player::Source::streamingSongIndex (1371) Song queue is now 58,57 [08-03-29 20:34:01.5284] Slim::Player::Source::skipahead (879) **skipahead: restarting [08-03-29 20:34:01.5864] Slim::Player::Source::playmode (298) 00:04:20:07:6e:1a: Switching to mode play from playout-play [08-03-29 20:34:01.5871] Slim::Player::Source::resetSong (1595) Resetting song buffer. [08-03-29 20:34:01.5931] Slim::Player::Source::openSong (1690) Trying to open: rhapd://Tra.952603.wma [08-03-29 20:34:01.7195] Slim::Player::Source::playmode (401) 00:04:20:07:6e:1a New play mode: play [08-03-29 20:34:01.7509] Slim::Player::Squeezebox::stream (1013) This player supports direct streaming for rhapd://Tra.952603.wma as http://llnw-971.listen.com/7/1/1/9/1/92319117.rad, let's do it. [08-03-29 20:34:01.7557] Slim::Player::Squeezebox::stream (1044) setting up direct stream (1159502547:80) autostart: 3. [08-03-29 20:34:01.7561] Slim::Player::Squeezebox::stream (1045) request string: GET /7/1/1/9/1/92319117.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-971.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.0/17759 Icy-Metadata: 1 [08-03-29 20:34:01.7582] Slim::Player::Source::playmode (556) 00:04:20:07:6e:1a: Current playmode: play [08-03-29 20:34:02.1380] Slim::Player::Squeezebox2::directHeaders (284) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.0.58 Accept-Ranges: bytes Content-Length: 3924492 Content-Type: text/plain Age: 235569 Date: Sat, 29 Mar 2008 17:33:40 GMT Last-Modified: Sun, 27 Jan 2008 16:22:11 GMT Connection: close [08-03-29 20:34:02.1385] Slim::Player::Squeezebox2::directHeaders (343) Processing 8 headers [08-03-29 20:34:02.1946] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Server: Apache/2.0.58 [08-03-29 20:34:02.1951] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Accept-Ranges: bytes [08-03-29 20:34:02.1954] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (52) RhapsodyDirect header: Content-Length: 3924492 [08-03-29 20:34:02.3733] Slim::Player::Squeezebox2::directHeaders (396) Got a stream type: wma bitrate: 128000 title: [08-03-29 20:34:02.3740] Slim::Player::Squeezebox2::directHeaders (455) Beginning direct stream! [08-03-29 20:34:04.3369] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 204) [08-03-29 20:34:04.4047] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 264) [08-03-29 20:34:04.4080] Slim::Networking::Slimproto::_http_metadata_handler (808) metadata (len: 132) [08-03-29 20:34:04.4551] Slim::Player::Protocols::MMS::setMetadata (271) Setting bitrate to 128 from WMA bitrate properties object