[08-08-09 17:49:49.9602] Slim::Player::Source::decoderUnderrun (607) 00:04:20:12:1d:99: Decoder underrun while this mode: playout-play [08-08-09 17:49:49.9607] Slim::Player::Source::nextsong (1700) The next song is number 35, was 34 [08-08-09 17:49:49.9612] Slim::Player::Source::nextsong (1700) The next song is number 35, was 34 [08-08-09 17:49:49.9618] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (377) End of track, logging usage info (235 seconds)... [08-08-09 17:49:49.9673] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\4\x03235" [08-08-09 17:49:51.0413] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\4" [08-08-09 17:49:51.0436] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\3\13Tra.2650799" [08-08-09 17:49:51.8920] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\3\x001http://llnw-672.listen.com/7/2/2/8/3/64838227.rad" [08-08-09 17:49:52.2618] Slim::Player::Source::skipahead (956) **skipahead: opening next song [08-08-09 17:49:52.2624] Slim::Player::Source::gotoNext (1350) Opening next song... [08-08-09 17:49:52.2628] Slim::Player::Source::nextsong (1700) The next song is number 35, was 34 [08-08-09 17:49:52.2643] Slim::Player::TranscodingHelper::getConvertCommand (215) undermax = 1, type = mp3, squeezebox2 = 00:04:20:12:1d:99 [08-08-09 17:49:52.2647] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:49:52.2650] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-00:04:20:12:1d:99 [08-08-09 17:49:52.3210] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-* [08-08-09 17:49:52.3214] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-* [08-08-09 17:49:52.3217] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:49:52.3220] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-00:04:20:12:1d:99 [08-08-09 17:49:52.3224] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-* [08-08-09 17:49:52.3227] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-* [08-08-09 17:49:52.3813] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:49:52.3817] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-00:04:20:12:1d:99 [08-08-09 17:49:52.3820] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-* [08-08-09 17:49:52.3824] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-* [08-08-09 17:49:52.3827] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:49:52.3830] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-00:04:20:12:1d:99 [08-08-09 17:49:52.4405] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-* [08-08-09 17:49:52.4409] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-* [08-08-09 17:49:52.4412] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:49:52.4415] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-00:04:20:12:1d:99 [08-08-09 17:49:52.4418] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-* [08-08-09 17:49:52.4421] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-* [08-08-09 17:49:52.5008] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:49:52.5012] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-00:04:20:12:1d:99 [08-08-09 17:49:52.5015] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-* [08-08-09 17:49:52.5018] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-* [08-08-09 17:49:52.5021] Slim::Player::TranscodingHelper::enabledFormat (119) Checking to see if mp3-mp3-*-* is enabled [08-08-09 17:49:52.5026] Slim::Player::TranscodingHelper::checkBin (160) enabled [08-08-09 17:49:52.5609] Slim::Player::TranscodingHelper::checkBin (162) Found command: - [08-08-09 17:49:53.2644] Slim::Player::TranscodingHelper::getConvertCommand (316) Matched Format: mp3 Type: mp3 Command: - [08-08-09 17:49:53.2649] Slim::Player::Source::gotoNext (1437) opening next song (old format: mp3, new: mp3) current playmode: playout-play [08-08-09 17:49:53.2655] Slim::Player::Source::streamingSongIndex (1494) Adding song index 35 to song queue [08-08-09 17:49:53.2659] Slim::Player::Source::streamingSongIndex (1515) Song queue is now 35,34 [08-08-09 17:49:53.2662] Slim::Player::Source::skipahead (962) **skipahead: restarting [08-08-09 17:49:53.2665] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from playout-play [08-08-09 17:49:53.2670] Slim::Player::Source::resetSong (1739) Resetting song buffer. [08-08-09 17:49:53.2744] Slim::Player::Source::openSong (1840) Trying to open: rhapd://Tra.2650799.mp3 [08-08-09 17:49:53.2749] Slim::Player::Source::openSong (1876) URL supports direct streaming [rhapd://Tra.2650799.mp3] [08-08-09 17:49:53.2803] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: play [08-08-09 17:49:53.2822] Slim::Player::Squeezebox::stream (1017) This player supports direct streaming for rhapd://Tra.2650799.mp3 as http://llnw-672.listen.com/7/2/2/8/3/64838227.rad, let's do it. [08-08-09 17:49:54.6365] Slim::Player::Squeezebox::stream (1055) setting up direct stream (1159502550:80) autostart: 3. [08-08-09 17:49:54.6374] Slim::Player::Squeezebox::stream (1056) request string: GET /7/2/2/8/3/64838227.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-672.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.2/22491 Icy-Metadata: 1 [08-08-09 17:49:54.8949] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: play [08-08-09 17:49:55.2584] Slim::Player::Squeezebox2::directHeaders (290) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.0.58 Accept-Ranges: bytes Content-Length: 4384452 Content-Type: text/plain Age: 190021 Date: Sat, 09 Aug 2008 14:49:55 GMT Last-Modified: Thu, 22 Mar 2007 12:09:25 GMT Connection: close [08-08-09 17:49:55.2888] Slim::Player::Squeezebox2::directHeaders (349) Processing 8 headers [08-08-09 17:49:55.2895] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Server: Apache/2.0.58 [08-08-09 17:49:55.2898] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Accept-Ranges: bytes [08-08-09 17:49:55.2901] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Content-Length: 4384452 [08-08-09 17:49:55.4692] Slim::Player::Squeezebox2::directHeaders (407) Got a stream type: mp3 bitrate: 192000 title: [08-08-09 17:49:55.4699] Slim::Player::Squeezebox2::directHeaders (459) Beginning direct stream! [08-08-09 17:49:59.9651] Slim::Player::Source::trackStartEvent (1605) Got a track starting event [08-08-09 17:49:59.9658] Slim::Player::Source::trackStartEvent (1612) Song 34 had already started, so it's not longer in the queue [08-08-09 17:49:59.9741] Slim::Player::Source::trackStartEvent (1621) Song 35 has now started playing [08-08-09 17:49:59.9762] Slim::Player::Source::trackStartEvent (1649) Song queue is now 35 [08-08-09 17:52:53.9890] Slim::Player::Source::decoderUnderrun (607) 00:04:20:12:1d:99: Decoder underrun while this mode: playout-play [08-08-09 17:52:53.9895] Slim::Player::Source::nextsong (1700) The next song is number 36, was 35 [08-08-09 17:52:53.9904] Slim::Player::Source::nextsong (1700) The next song is number 36, was 35 [08-08-09 17:52:53.9909] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (377) End of track, logging usage info (184 seconds)... [08-08-09 17:52:53.9920] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\4\x03184" [08-08-09 17:52:55.1119] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\4" [08-08-09 17:52:55.1141] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\3\13Tra.2652556" [08-08-09 17:52:56.0869] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\3\x001http://llnw-673.listen.com/7/3/3/6/3/64836337.rad" [08-08-09 17:52:56.4111] Slim::Player::Source::skipahead (956) **skipahead: opening next song [08-08-09 17:52:56.4115] Slim::Player::Source::gotoNext (1350) Opening next song... [08-08-09 17:52:56.4119] Slim::Player::Source::nextsong (1700) The next song is number 36, was 35 [08-08-09 17:52:56.4128] Slim::Player::TranscodingHelper::getConvertCommand (215) undermax = 1, type = mp3, squeezebox2 = 00:04:20:12:1d:99 [08-08-09 17:52:56.4131] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:52:56.4134] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-00:04:20:12:1d:99 [08-08-09 17:52:56.4141] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-* [08-08-09 17:52:56.4144] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-* [08-08-09 17:52:56.4147] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:52:56.4151] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-00:04:20:12:1d:99 [08-08-09 17:52:56.4153] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-* [08-08-09 17:52:56.4156] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-* [08-08-09 17:52:56.4160] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:52:56.4162] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-00:04:20:12:1d:99 [08-08-09 17:52:56.4165] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-* [08-08-09 17:52:56.4168] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-* [08-08-09 17:52:56.4171] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:52:56.4174] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-00:04:20:12:1d:99 [08-08-09 17:52:56.4177] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-* [08-08-09 17:52:56.4180] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-* [08-08-09 17:52:56.4183] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:52:56.4186] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-00:04:20:12:1d:99 [08-08-09 17:52:56.4188] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-* [08-08-09 17:52:56.4191] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-* [08-08-09 17:52:56.4194] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:52:56.4197] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-00:04:20:12:1d:99 [08-08-09 17:52:56.4440] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-* [08-08-09 17:52:56.4457] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-* [08-08-09 17:52:56.4460] Slim::Player::TranscodingHelper::enabledFormat (119) Checking to see if mp3-mp3-*-* is enabled [08-08-09 17:52:56.4464] Slim::Player::TranscodingHelper::checkBin (160) enabled [08-08-09 17:52:56.4472] Slim::Player::TranscodingHelper::checkBin (162) Found command: - [08-08-09 17:52:56.9704] Slim::Player::TranscodingHelper::getConvertCommand (316) Matched Format: mp3 Type: mp3 Command: - [08-08-09 17:52:56.9709] Slim::Player::Source::gotoNext (1437) opening next song (old format: mp3, new: mp3) current playmode: playout-play [08-08-09 17:52:56.9712] Slim::Player::Source::streamingSongIndex (1494) Adding song index 36 to song queue [08-08-09 17:52:56.9715] Slim::Player::Source::streamingSongIndex (1515) Song queue is now 36,35 [08-08-09 17:52:56.9719] Slim::Player::Source::skipahead (962) **skipahead: restarting [08-08-09 17:52:56.9722] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from playout-play [08-08-09 17:52:56.9727] Slim::Player::Source::resetSong (1739) Resetting song buffer. [08-08-09 17:52:57.0095] Slim::Player::Source::openSong (1840) Trying to open: rhapd://Tra.2652556.mp3 [08-08-09 17:52:57.0104] Slim::Player::Source::openSong (1876) URL supports direct streaming [rhapd://Tra.2652556.mp3] [08-08-09 17:52:57.0154] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: play [08-08-09 17:52:57.0213] Slim::Player::Squeezebox::stream (1017) This player supports direct streaming for rhapd://Tra.2652556.mp3 as http://llnw-673.listen.com/7/3/3/6/3/64836337.rad, let's do it. [08-08-09 17:52:58.3224] Slim::Player::Squeezebox::stream (1055) setting up direct stream (3496968512:80) autostart: 3. [08-08-09 17:52:58.3229] Slim::Player::Squeezebox::stream (1056) request string: GET /7/3/3/6/3/64836337.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-673.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.2/22491 Icy-Metadata: 1 [08-08-09 17:52:58.6227] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: play [08-08-09 17:52:58.9839] Slim::Player::Squeezebox2::directHeaders (290) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.0.58 Accept-Ranges: bytes Content-Length: 5203732 Content-Type: text/plain Age: 194750 Date: Sat, 09 Aug 2008 14:52:59 GMT Last-Modified: Thu, 22 Mar 2007 11:03:35 GMT Connection: close [08-08-09 17:52:58.9845] Slim::Player::Squeezebox2::directHeaders (349) Processing 8 headers [08-08-09 17:52:58.9849] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Server: Apache/2.0.58 [08-08-09 17:52:58.9993] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Accept-Ranges: bytes [08-08-09 17:52:58.9997] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Content-Length: 5203732 [08-08-09 17:52:59.1263] Slim::Player::Squeezebox2::directHeaders (407) Got a stream type: mp3 bitrate: 192000 title: [08-08-09 17:52:59.1268] Slim::Player::Squeezebox2::directHeaders (459) Beginning direct stream! [08-08-09 17:53:04.9024] Slim::Player::Source::trackStartEvent (1605) Got a track starting event [08-08-09 17:53:04.9027] Slim::Player::Source::trackStartEvent (1612) Song 35 had already started, so it's not longer in the queue [08-08-09 17:53:04.9031] Slim::Player::Source::trackStartEvent (1621) Song 36 has now started playing [08-08-09 17:53:04.9044] Slim::Player::Source::trackStartEvent (1649) Song queue is now 36 [08-08-09 17:56:33.0962] Slim::Player::Source::decoderUnderrun (607) 00:04:20:12:1d:99: Decoder underrun while this mode: playout-play [08-08-09 17:56:33.0969] Slim::Player::Source::nextsong (1700) The next song is number 37, was 36 [08-08-09 17:56:33.0974] Slim::Player::Source::nextsong (1700) The next song is number 37, was 36 [08-08-09 17:56:33.0981] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (377) End of track, logging usage info (218 seconds)... [08-08-09 17:56:33.1004] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\4\x03218" [08-08-09 17:56:34.1242] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\4" [08-08-09 17:56:34.1256] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\3\13Tra.2652557" [08-08-09 17:56:34.9599] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\3\x001http://llnw-660.listen.com/6/0/4/6/3/64836406.rad" [08-08-09 17:56:35.2328] Slim::Player::Source::skipahead (956) **skipahead: opening next song [08-08-09 17:56:35.2365] Slim::Player::Source::gotoNext (1350) Opening next song... [08-08-09 17:56:35.2371] Slim::Player::Source::nextsong (1700) The next song is number 37, was 36 [08-08-09 17:56:35.2378] Slim::Player::TranscodingHelper::getConvertCommand (215) undermax = 1, type = mp3, squeezebox2 = 00:04:20:12:1d:99 [08-08-09 17:56:35.2382] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:56:35.2385] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-00:04:20:12:1d:99 [08-08-09 17:56:35.2388] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-* [08-08-09 17:56:35.2462] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-* [08-08-09 17:56:35.2466] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:56:35.2469] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-00:04:20:12:1d:99 [08-08-09 17:56:35.2471] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-* [08-08-09 17:56:35.2474] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-* [08-08-09 17:56:35.2477] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:56:35.2599] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-00:04:20:12:1d:99 [08-08-09 17:56:35.2602] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-* [08-08-09 17:56:35.2605] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-* [08-08-09 17:56:35.2608] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:56:35.2611] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-00:04:20:12:1d:99 [08-08-09 17:56:35.2614] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-* [08-08-09 17:56:35.2713] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-* [08-08-09 17:56:35.2717] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:56:35.2720] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-00:04:20:12:1d:99 [08-08-09 17:56:35.2723] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-* [08-08-09 17:56:35.2726] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-* [08-08-09 17:56:35.2729] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-00:04:20:12:1d:99 [08-08-09 17:56:35.2851] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-00:04:20:12:1d:99 [08-08-09 17:56:35.2855] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-* [08-08-09 17:56:35.2858] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-* [08-08-09 17:56:35.2861] Slim::Player::TranscodingHelper::enabledFormat (119) Checking to see if mp3-mp3-*-* is enabled [08-08-09 17:56:35.2864] Slim::Player::TranscodingHelper::checkBin (160) enabled [08-08-09 17:56:35.2867] Slim::Player::TranscodingHelper::checkBin (162) Found command: - [08-08-09 17:56:36.3380] Slim::Player::TranscodingHelper::getConvertCommand (316) Matched Format: mp3 Type: mp3 Command: - [08-08-09 17:56:36.3384] Slim::Player::Source::gotoNext (1437) opening next song (old format: mp3, new: mp3) current playmode: playout-play [08-08-09 17:56:36.3388] Slim::Player::Source::streamingSongIndex (1494) Adding song index 37 to song queue [08-08-09 17:56:36.3391] Slim::Player::Source::streamingSongIndex (1515) Song queue is now 37,36 [08-08-09 17:56:36.3394] Slim::Player::Source::skipahead (962) **skipahead: restarting [08-08-09 17:56:36.3397] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from playout-play [08-08-09 17:56:36.3408] Slim::Player::Source::resetSong (1739) Resetting song buffer. [08-08-09 17:56:36.3470] Slim::Player::Source::openSong (1840) Trying to open: rhapd://Tra.2652557.mp3 [08-08-09 17:56:36.3476] Slim::Player::Source::openSong (1876) URL supports direct streaming [rhapd://Tra.2652557.mp3] [08-08-09 17:56:36.3531] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: play [08-08-09 17:56:36.3550] Slim::Player::Squeezebox::stream (1017) This player supports direct streaming for rhapd://Tra.2652557.mp3 as http://llnw-660.listen.com/6/0/4/6/3/64836406.rad, let's do it. [08-08-09 17:56:36.6498] Slim::Player::Squeezebox::stream (1055) setting up direct stream (1150180288:80) autostart: 3. [08-08-09 17:56:36.6502] Slim::Player::Squeezebox::stream (1056) request string: GET /6/0/4/6/3/64836406.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-660.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.2/22491 Icy-Metadata: 1 [08-08-09 17:56:36.7185] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: play [08-08-09 17:56:37.0755] Slim::Player::Squeezebox2::directHeaders (290) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.0.58 Accept-Ranges: bytes Content-Length: 5115396 Content-Type: text/plain Age: 188896 Date: Sat, 09 Aug 2008 14:56:37 GMT Last-Modified: Thu, 22 Mar 2007 12:03:07 GMT Connection: close [08-08-09 17:56:37.0760] Slim::Player::Squeezebox2::directHeaders (349) Processing 8 headers [08-08-09 17:56:37.0763] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Server: Apache/2.0.58 [08-08-09 17:56:37.0767] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Accept-Ranges: bytes [08-08-09 17:56:37.0769] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Content-Length: 5115396 [08-08-09 17:56:37.1113] Slim::Player::Squeezebox2::directHeaders (407) Got a stream type: mp3 bitrate: 192000 title: [08-08-09 17:56:37.1118] Slim::Player::Squeezebox2::directHeaders (459) Beginning direct stream! [08-08-09 17:56:43.0943] Slim::Player::Source::trackStartEvent (1605) Got a track starting event [08-08-09 17:56:43.0947] Slim::Player::Source::trackStartEvent (1612) Song 36 had already started, so it's not longer in the queue [08-08-09 17:56:43.0950] Slim::Player::Source::trackStartEvent (1621) Song 37 has now started playing [08-08-09 17:56:43.0962] Slim::Player::Source::trackStartEvent (1649) Song queue is now 37 [08-08-09 17:56:43.3650] Slim::Player::Source::outputUnderrun (800) 00:04:20:12:1d:99: Output buffer underrun (decoder: 6 / output: 0) [08-08-09 17:56:43.3653] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode pause from playout-play [08-08-09 17:56:43.3663] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: pause [08-08-09 17:56:43.4127] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: pause [08-08-09 17:56:44.4682] Slim::Player::Source::rebuffer (900) Rebuffering: 6 / 120000 [08-08-09 17:56:45.5373] Slim::Player::Source::rebuffer (900) Rebuffering: 23238 / 120000 [08-08-09 17:56:46.6108] Slim::Player::Source::rebuffer (900) Rebuffering: 69702 / 120000 [08-08-09 17:56:47.7379] Slim::Player::Source::rebuffer (900) Rebuffering: 135042 / 120000 [08-08-09 17:56:47.7400] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from pause [08-08-09 17:56:47.7410] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: resume [08-08-09 17:56:47.7422] Slim::Player::Source::playmode (430) 00:04:20:12:1d:99: Resume, resetting mode: playout-play [08-08-09 17:56:47.7469] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: resume [08-08-09 17:56:59.4840] Slim::Player::Source::outputUnderrun (800) 00:04:20:12:1d:99: Output buffer underrun (decoder: 214 / output: 0) [08-08-09 17:56:59.4844] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode pause from playout-play [08-08-09 17:56:59.4854] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: pause [08-08-09 17:56:59.4866] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: pause [08-08-09 17:57:00.5051] Slim::Player::Source::rebuffer (900) Rebuffering: 6 / 120000 [08-08-09 17:57:01.5164] Slim::Player::Source::rebuffer (900) Rebuffering: 34854 / 120000 [08-08-09 17:57:02.6752] Slim::Player::Source::rebuffer (900) Rebuffering: 113262 / 120000 [08-08-09 17:57:03.6895] Slim::Player::Source::rebuffer (900) Rebuffering: 148110 / 120000 [08-08-09 17:57:03.6900] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from pause [08-08-09 17:57:03.6908] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: resume [08-08-09 17:57:03.6937] Slim::Player::Source::playmode (430) 00:04:20:12:1d:99: Resume, resetting mode: playout-play [08-08-09 17:57:03.6967] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: resume [08-08-09 17:57:58.1009] Slim::Player::Source::outputUnderrun (800) 00:04:20:12:1d:99: Output buffer underrun (decoder: 2 / output: 0) [08-08-09 17:57:58.1013] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode pause from playout-play [08-08-09 17:57:58.1022] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: pause [08-08-09 17:57:58.1034] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: pause [08-08-09 17:57:59.1291] Slim::Player::Source::rebuffer (900) Rebuffering: 2 / 120000 [08-08-09 17:58:00.1407] Slim::Player::Source::rebuffer (900) Rebuffering: 34850 / 120000 [08-08-09 17:58:01.1550] Slim::Player::Source::rebuffer (900) Rebuffering: 87122 / 120000 [08-08-09 17:58:02.1959] Slim::Player::Source::rebuffer (900) Rebuffering: 190214 / 120000 [08-08-09 17:58:02.1982] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from pause [08-08-09 17:58:02.1991] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: resume [08-08-09 17:58:02.2003] Slim::Player::Source::playmode (430) 00:04:20:12:1d:99: Resume, resetting mode: playout-play [08-08-09 17:58:02.2032] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: resume [08-08-09 17:58:17.3594] Slim::Player::Source::outputUnderrun (800) 00:04:20:12:1d:99: Output buffer underrun (decoder: 882 / output: 0) [08-08-09 17:58:17.3604] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode pause from playout-play [08-08-09 17:58:17.3624] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: pause [08-08-09 17:58:17.3656] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: pause [08-08-09 17:58:18.4314] Slim::Player::Source::rebuffer (900) Rebuffering: 2 / 120000 [08-08-09 17:58:19.4692] Slim::Player::Source::rebuffer (900) Rebuffering: 34850 / 120000 [08-08-09 17:58:20.4807] Slim::Player::Source::rebuffer (900) Rebuffering: 90026 / 120000 [08-08-09 17:58:21.4918] Slim::Player::Source::rebuffer (900) Rebuffering: 174242 / 120000 [08-08-09 17:58:21.4940] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from pause [08-08-09 17:58:21.4950] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: resume [08-08-09 17:58:21.4961] Slim::Player::Source::playmode (430) 00:04:20:12:1d:99: Resume, resetting mode: playout-play [08-08-09 17:58:21.4990] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: resume [08-08-09 17:58:42.0551] Slim::Player::Source::decoderUnderrun (607) 00:04:20:12:1d:99: Decoder underrun while this mode: playout-play [08-08-09 17:58:42.0561] Slim::Player::Source::nextsong (1700) The next song is number 38, was 37 [08-08-09 17:58:42.0575] Slim::Player::Source::nextsong (1700) The next song is number 38, was 37 [08-08-09 17:58:42.0588] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (377) End of track, logging usage info (214 seconds)... [08-08-09 17:58:42.0618] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\4\x03214" [08-08-09 17:58:42.0634] Slim::Player::Source::underrun (722) 00:04:20:12:1d:99: Underrun while this mode: playout-play [08-08-09 17:58:42.0647] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onUnderrun (664) Underrun, stopping, playmode: playout-play [08-08-09 17:58:42.0656] Slim::Player::Source::nextsong (1700) The next song is number 38, was 37 [08-08-09 17:58:42.0666] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode stop from playout-stop [08-08-09 17:58:42.0685] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: stop [08-08-09 17:58:42.0694] Slim::Player::Source::playmode (461) 00:04:20:12:1d:99: Stopping and clearing out old chunks [08-08-09 17:58:42.0724] Slim::Player::Source::resetSong (1739) Resetting song buffer. [08-08-09 17:58:42.0733] Slim::Player::Source::resetSongQueue (1568) Resetting song queue [08-08-09 17:58:42.0741] Slim::Player::Source::resetSongQueue (1578) Song queue is now 37 [08-08-09 17:58:42.0757] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: stop [08-08-09 17:58:42.0765] Slim::Player::Source::streamingSongIndex (1494) Adding song index 0 to song queue [08-08-09 17:58:42.0776] Slim::Player::Source::streamingSongIndex (1498) Clearing out song queue first [08-08-09 17:58:42.0803] Slim::Player::Source::streamingSongIndex (1515) Song queue is now 0 [08-08-09 17:58:42.0981] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (698) Skipping to next track (38) [08-08-09 17:58:42.1005] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onJump (412) Handling command "jump", playmode: stop [08-08-09 17:58:42.1442] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onJump (495) Ending any previous playback session [08-08-09 17:58:42.1508] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\6" [08-08-09 17:58:42.1584] Slim::Utils::Misc::msg (1356) Warning: [17:58:42.1558] Use of uninitialized value in concatenation (.) or string at C:/PROGRA~1/SQUEEZ~2/server/Slim/Plugin/RhapsodyDirect/ProtocolHandler.pm line 1101. [08-08-09 17:58:42.1594] Slim::Plugin::RhapsodyDirect::ProtocolHandler::stopCallback (1101) Player stopped (stop ) but another track was already starting, ignoring [08-08-09 17:58:42.1679] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\xFC" [08-08-09 17:58:42.1694] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (294) 00:04:20:12:1d:99 Received RPDS -4, SSL connection already in use, retrying later [08-08-09 17:58:43.0303] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\4" [08-08-09 17:58:43.0309] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (315) 00:04:20:12:1d:99 Ignoring unrequested or old RPDS packet (got 4, expected N/A) [08-08-09 17:58:44.1750] Slim::Plugin::RhapsodyDirect::RPDS::rpds_resend (342) 00:04:20:12:1d:99 Re-sending RPDS packet: "\6" [08-08-09 17:58:44.1763] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\6" [08-08-09 17:58:44.9743] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\6" [08-08-09 17:58:44.9752] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (251) Found IP for secure-direct.rhapsody.com: 207.188.0.25 [08-08-09 17:58:44.9796] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\0\xCF\xBC\0\31\1\xBB" [08-08-09 17:58:44.9801] Slim::Plugin::RhapsodyDirect::ProtocolHandler::getPlaybackSession (271) 00:04:20:12:1d:99 Requesting new playback session... [08-08-09 17:58:44.9878] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: 2 [08-08-09 17:58:45.8222] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\2" [08-08-09 17:58:45.8228] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (328) New playback session obtained, resetting sessionErrors count to 0 [08-08-09 17:58:45.8242] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\3\13Tra.2652559" [08-08-09 17:58:46.7565] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\3\x001http://llnw-680.listen.com/8/0/4/6/3/64836408.rad" [08-08-09 17:58:48.7207] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode stop from stop [08-08-09 17:58:48.7211] Slim::Player::Source::playmode (316) Already in playmode stop : ignoring mode change [08-08-09 17:58:48.7214] Slim::Player::Source::jumpto (1306) Jumping to 38 [08-08-09 17:58:48.7217] Slim::Player::Source::streamingSongIndex (1494) Adding song index 38 to song queue [08-08-09 17:58:48.7220] Slim::Player::Source::streamingSongIndex (1498) Clearing out song queue first [08-08-09 17:58:48.7223] Slim::Player::Source::streamingSongIndex (1515) Song queue is now 38 [08-08-09 17:58:48.7232] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from stop [08-08-09 17:58:48.7237] Slim::Player::Source::resetSong (1739) Resetting song buffer. [08-08-09 17:58:48.7245] Slim::Player::Source::openSong (1840) Trying to open: rhapd://Tra.2652559.mp3 [08-08-09 17:58:48.7249] Slim::Player::Source::openSong (1876) URL supports direct streaming [rhapd://Tra.2652559.mp3] [08-08-09 17:58:48.7310] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: play [08-08-09 17:58:48.7346] Slim::Player::Squeezebox::stream (1017) This player supports direct streaming for rhapd://Tra.2652559.mp3 as http://llnw-680.listen.com/8/0/4/6/3/64836408.rad, let's do it. [08-08-09 17:58:49.0417] Slim::Player::Squeezebox::stream (1055) setting up direct stream (1150180288:80) autostart: 3. [08-08-09 17:58:49.0421] Slim::Player::Squeezebox::stream (1056) request string: GET /8/0/4/6/3/64836408.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-680.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.2/22491 Icy-Metadata: 1 [08-08-09 17:58:49.0614] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: play [08-08-09 17:58:49.1038] Slim::Player::Squeezebox::buffering (303) Buffering... 0 / 73728 [08-08-09 17:58:49.4082] Slim::Player::Squeezebox2::directHeaders (290) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.0.58 Accept-Ranges: bytes Content-Length: 5258476 Content-Type: text/plain Age: 188624 Date: Sat, 09 Aug 2008 14:58:49 GMT Last-Modified: Thu, 22 Mar 2007 11:15:31 GMT Connection: close [08-08-09 17:58:49.4090] Slim::Player::Squeezebox2::directHeaders (349) Processing 8 headers [08-08-09 17:58:49.4095] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Server: Apache/2.0.58 [08-08-09 17:58:49.4100] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Accept-Ranges: bytes [08-08-09 17:58:49.4108] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Content-Length: 5258476 [08-08-09 17:58:49.4578] Slim::Player::Squeezebox2::directHeaders (407) Got a stream type: mp3 bitrate: 192000 title: [08-08-09 17:58:49.4585] Slim::Player::Squeezebox2::directHeaders (459) Beginning direct stream! [08-08-09 17:58:49.5081] Slim::Player::Squeezebox::buffering (303) Buffering... 0 / 73728 [08-08-09 17:58:49.9147] Slim::Player::Squeezebox::buffering (303) Buffering... 1223 / 73728 [08-08-09 17:58:50.3229] Slim::Player::Squeezebox::buffering (303) Buffering... 1223 / 73728 [08-08-09 17:58:50.7314] Slim::Player::Squeezebox::buffering (303) Buffering... 14290 / 73728 [08-08-09 17:58:51.1451] Slim::Player::Squeezebox::buffering (303) Buffering... 38974 / 73728 [08-08-09 17:58:51.5546] Slim::Player::Squeezebox::buffering (303) Buffering... 46234 / 73728 [08-08-09 17:58:51.9655] Slim::Player::Squeezebox::buffering (303) Buffering... 65110 / 73728 [08-08-09 17:58:52.3759] Slim::Player::Squeezebox::buffering (303) Buffering... 65110 / 73728 [08-08-09 17:58:52.4430] Slim::Player::Source::trackStartEvent (1605) Got a track starting event [08-08-09 17:58:52.4434] Slim::Player::Source::trackStartEvent (1621) Song 38 has now started playing [08-08-09 17:58:52.4445] Slim::Player::Source::trackStartEvent (1649) Song queue is now 38 [08-08-09 18:02:23.1914] Slim::Player::Source::decoderUnderrun (607) 00:04:20:12:1d:99: Decoder underrun while this mode: playout-play [08-08-09 18:02:23.1925] Slim::Player::Source::nextsong (1700) The next song is number 39, was 38 [08-08-09 18:02:23.1939] Slim::Player::Source::nextsong (1700) The next song is number 39, was 38 [08-08-09 18:02:23.1952] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (377) End of track, logging usage info (220 seconds)... [08-08-09 18:02:23.1981] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\4\x03220" [08-08-09 18:02:24.3426] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\4" [08-08-09 18:02:24.3458] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\3\13Tra.2652560" [08-08-09 18:02:25.1956] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\3\x001http://llnw-676.listen.com/7/6/3/6/3/64836367.rad" [08-08-09 18:02:25.4871] Slim::Player::Source::skipahead (956) **skipahead: opening next song [08-08-09 18:02:25.4875] Slim::Player::Source::gotoNext (1350) Opening next song... [08-08-09 18:02:25.4879] Slim::Player::Source::nextsong (1700) The next song is number 39, was 38 [08-08-09 18:02:25.4887] Slim::Player::TranscodingHelper::getConvertCommand (215) undermax = 1, type = mp3, squeezebox2 = 00:04:20:12:1d:99 [08-08-09 18:02:25.4890] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:02:25.4893] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-00:04:20:12:1d:99 [08-08-09 18:02:25.4896] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-* [08-08-09 18:02:25.4899] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-* [08-08-09 18:02:25.4902] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:02:25.4904] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-00:04:20:12:1d:99 [08-08-09 18:02:25.4908] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-* [08-08-09 18:02:25.4913] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-* [08-08-09 18:02:25.4918] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:02:25.4921] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-00:04:20:12:1d:99 [08-08-09 18:02:25.4924] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-* [08-08-09 18:02:25.4927] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-* [08-08-09 18:02:25.4930] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:02:25.4932] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-00:04:20:12:1d:99 [08-08-09 18:02:25.4935] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-* [08-08-09 18:02:25.4938] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-* [08-08-09 18:02:25.4941] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:02:25.4944] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-00:04:20:12:1d:99 [08-08-09 18:02:25.4946] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-* [08-08-09 18:02:25.4949] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-* [08-08-09 18:02:25.4952] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:02:25.4955] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-00:04:20:12:1d:99 [08-08-09 18:02:25.4959] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-* [08-08-09 18:02:25.4961] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-* [08-08-09 18:02:25.4965] Slim::Player::TranscodingHelper::enabledFormat (119) Checking to see if mp3-mp3-*-* is enabled [08-08-09 18:02:25.4967] Slim::Player::TranscodingHelper::checkBin (160) enabled [08-08-09 18:02:25.4970] Slim::Player::TranscodingHelper::checkBin (162) Found command: - [08-08-09 18:02:25.6509] Slim::Player::TranscodingHelper::getConvertCommand (316) Matched Format: mp3 Type: mp3 Command: - [08-08-09 18:02:25.6517] Slim::Player::Source::gotoNext (1437) opening next song (old format: mp3, new: mp3) current playmode: playout-play [08-08-09 18:02:25.6521] Slim::Player::Source::streamingSongIndex (1494) Adding song index 39 to song queue [08-08-09 18:02:25.6525] Slim::Player::Source::streamingSongIndex (1515) Song queue is now 39,38 [08-08-09 18:02:25.6528] Slim::Player::Source::skipahead (962) **skipahead: restarting [08-08-09 18:02:25.6532] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from playout-play [08-08-09 18:02:25.6537] Slim::Player::Source::resetSong (1739) Resetting song buffer. [08-08-09 18:02:25.6596] Slim::Player::Source::openSong (1840) Trying to open: rhapd://Tra.2652560.mp3 [08-08-09 18:02:25.6601] Slim::Player::Source::openSong (1876) URL supports direct streaming [rhapd://Tra.2652560.mp3] [08-08-09 18:02:25.6807] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: play [08-08-09 18:02:25.6827] Slim::Player::Squeezebox::stream (1017) This player supports direct streaming for rhapd://Tra.2652560.mp3 as http://llnw-676.listen.com/7/6/3/6/3/64836367.rad, let's do it. [08-08-09 18:02:25.9744] Slim::Player::Squeezebox::stream (1055) setting up direct stream (3496968517:80) autostart: 3. [08-08-09 18:02:25.9751] Slim::Player::Squeezebox::stream (1056) request string: GET /7/6/3/6/3/64836367.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-676.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.2/22491 Icy-Metadata: 1 [08-08-09 18:02:26.0070] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: play [08-08-09 18:02:26.3707] Slim::Player::Squeezebox2::directHeaders (290) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.0.58 Accept-Ranges: bytes Content-Length: 3901100 Content-Type: text/plain Age: 188619 Date: Sat, 09 Aug 2008 15:02:26 GMT Last-Modified: Thu, 22 Mar 2007 11:49:58 GMT Connection: close [08-08-09 18:02:26.3719] Slim::Player::Squeezebox2::directHeaders (349) Processing 8 headers [08-08-09 18:02:26.3731] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Server: Apache/2.0.58 [08-08-09 18:02:26.3739] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Accept-Ranges: bytes [08-08-09 18:02:26.3747] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Content-Length: 3901100 [08-08-09 18:02:26.4410] Slim::Player::Squeezebox2::directHeaders (407) Got a stream type: mp3 bitrate: 192000 title: [08-08-09 18:02:26.4421] Slim::Player::Squeezebox2::directHeaders (459) Beginning direct stream! [08-08-09 18:02:33.2853] Slim::Player::Source::trackStartEvent (1605) Got a track starting event [08-08-09 18:02:33.2857] Slim::Player::Source::trackStartEvent (1612) Song 38 had already started, so it's not longer in the queue [08-08-09 18:02:33.2860] Slim::Player::Source::trackStartEvent (1621) Song 39 has now started playing [08-08-09 18:02:33.2872] Slim::Player::Source::trackStartEvent (1649) Song queue is now 39 [08-08-09 18:05:06.9231] Slim::Player::Source::decoderUnderrun (607) 00:04:20:12:1d:99: Decoder underrun while this mode: playout-play [08-08-09 18:05:06.9241] Slim::Player::Source::nextsong (1700) The next song is number 40, was 39 [08-08-09 18:05:06.9255] Slim::Player::Source::nextsong (1700) The next song is number 40, was 39 [08-08-09 18:05:06.9268] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (377) End of track, logging usage info (163 seconds)... [08-08-09 18:05:06.9299] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\4\x03163" [08-08-09 18:05:08.1036] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\4" [08-08-09 18:05:08.1067] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\3\13Tra.2652561" [08-08-09 18:05:08.9532] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\3\x001http://llnw-626.listen.com/2/6/3/6/3/64836362.rad" [08-08-09 18:05:09.3056] Slim::Player::Source::skipahead (956) **skipahead: opening next song [08-08-09 18:05:09.3060] Slim::Player::Source::gotoNext (1350) Opening next song... [08-08-09 18:05:09.3064] Slim::Player::Source::nextsong (1700) The next song is number 40, was 39 [08-08-09 18:05:09.3072] Slim::Player::TranscodingHelper::getConvertCommand (215) undermax = 1, type = mp3, squeezebox2 = 00:04:20:12:1d:99 [08-08-09 18:05:09.3076] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:05:09.3078] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-00:04:20:12:1d:99 [08-08-09 18:05:09.3081] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-* [08-08-09 18:05:09.3084] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-* [08-08-09 18:05:09.3087] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:05:09.3090] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-00:04:20:12:1d:99 [08-08-09 18:05:09.3093] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-* [08-08-09 18:05:09.3096] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-* [08-08-09 18:05:09.3099] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:05:09.3101] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-00:04:20:12:1d:99 [08-08-09 18:05:09.3104] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-* [08-08-09 18:05:09.3109] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-* [08-08-09 18:05:09.3112] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:05:09.3115] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-00:04:20:12:1d:99 [08-08-09 18:05:09.3118] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-* [08-08-09 18:05:09.3121] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-* [08-08-09 18:05:09.3124] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:05:09.3126] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-00:04:20:12:1d:99 [08-08-09 18:05:09.3129] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-* [08-08-09 18:05:09.3132] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-* [08-08-09 18:05:09.3135] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:05:09.3138] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-00:04:20:12:1d:99 [08-08-09 18:05:09.3140] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-* [08-08-09 18:05:09.3143] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-* [08-08-09 18:05:09.3146] Slim::Player::TranscodingHelper::enabledFormat (119) Checking to see if mp3-mp3-*-* is enabled [08-08-09 18:05:09.3149] Slim::Player::TranscodingHelper::checkBin (160) enabled [08-08-09 18:05:09.3152] Slim::Player::TranscodingHelper::checkBin (162) Found command: - [08-08-09 18:05:09.5668] Slim::Player::TranscodingHelper::getConvertCommand (316) Matched Format: mp3 Type: mp3 Command: - [08-08-09 18:05:09.5675] Slim::Player::Source::gotoNext (1437) opening next song (old format: mp3, new: mp3) current playmode: playout-play [08-08-09 18:05:09.5681] Slim::Player::Source::streamingSongIndex (1494) Adding song index 40 to song queue [08-08-09 18:05:09.5688] Slim::Player::Source::streamingSongIndex (1515) Song queue is now 40,39 [08-08-09 18:05:09.5694] Slim::Player::Source::skipahead (962) **skipahead: restarting [08-08-09 18:05:09.5700] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from playout-play [08-08-09 18:05:09.5713] Slim::Player::Source::resetSong (1739) Resetting song buffer. [08-08-09 18:05:09.5799] Slim::Player::Source::openSong (1840) Trying to open: rhapd://Tra.2652561.mp3 [08-08-09 18:05:09.5810] Slim::Player::Source::openSong (1876) URL supports direct streaming [rhapd://Tra.2652561.mp3] [08-08-09 18:05:09.5879] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: play [08-08-09 18:05:09.5929] Slim::Player::Squeezebox::stream (1017) This player supports direct streaming for rhapd://Tra.2652561.mp3 as http://llnw-626.listen.com/2/6/3/6/3/64836362.rad, let's do it. [08-08-09 18:05:09.8816] Slim::Player::Squeezebox::stream (1055) setting up direct stream (1159502617:80) autostart: 3. [08-08-09 18:05:09.8820] Slim::Player::Squeezebox::stream (1056) request string: GET /2/6/3/6/3/64836362.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-626.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.2/22491 Icy-Metadata: 1 [08-08-09 18:05:09.9034] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: play [08-08-09 18:05:10.2710] Slim::Player::Squeezebox2::directHeaders (290) Processing headers for direct streaming: HTTP/1.0 200 OK Server: Apache/2.0.58 Accept-Ranges: bytes Content-Length: 2977932 Content-Type: text/plain Age: 188620 Date: Sat, 09 Aug 2008 15:05:10 GMT Last-Modified: Thu, 22 Mar 2007 12:00:36 GMT Connection: close [08-08-09 18:05:10.2721] Slim::Player::Squeezebox2::directHeaders (349) Processing 8 headers [08-08-09 18:05:10.2730] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Server: Apache/2.0.58 [08-08-09 18:05:10.2738] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Accept-Ranges: bytes [08-08-09 18:05:10.2746] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Content-Length: 2977932 [08-08-09 18:05:10.3426] Slim::Player::Squeezebox2::directHeaders (407) Got a stream type: mp3 bitrate: 192000 title: [08-08-09 18:05:10.3437] Slim::Player::Squeezebox2::directHeaders (459) Beginning direct stream! [08-08-09 18:05:16.9081] Slim::Player::Source::trackStartEvent (1605) Got a track starting event [08-08-09 18:05:16.9090] Slim::Player::Source::trackStartEvent (1612) Song 39 had already started, so it's not longer in the queue [08-08-09 18:05:16.9098] Slim::Player::Source::trackStartEvent (1621) Song 40 has now started playing [08-08-09 18:05:16.9128] Slim::Player::Source::trackStartEvent (1649) Song queue is now 40 [08-08-09 18:07:11.8944] Slim::Player::Source::decoderUnderrun (607) 00:04:20:12:1d:99: Decoder underrun while this mode: playout-play [08-08-09 18:07:11.8974] Slim::Player::Source::nextsong (1700) The next song is number 41, was 40 [08-08-09 18:07:11.8988] Slim::Player::Source::nextsong (1700) The next song is number 41, was 40 [08-08-09 18:07:11.9001] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onDecoderUnderrun (377) End of track, logging usage info (124 seconds)... [08-08-09 18:07:11.9034] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\4\x03124" [08-08-09 18:07:16.2538] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\4" [08-08-09 18:07:16.2572] Slim::Plugin::RhapsodyDirect::RPDS::rpds (86) 00:04:20:12:1d:99 RPDS packet sent: "\3\13Tra.2652562" [08-08-09 18:07:17.1128] Slim::Plugin::RhapsodyDirect::RPDS::rpds_handler (145) 00:04:20:12:1d:99 Got RPDS packet: \"\3\x001http://llnw-654.listen.com/5/4/3/6/3/64836345.rad" [08-08-09 18:07:17.4363] Slim::Player::Source::skipahead (956) **skipahead: opening next song [08-08-09 18:07:17.4369] Slim::Player::Source::gotoNext (1350) Opening next song... [08-08-09 18:07:17.4373] Slim::Player::Source::nextsong (1700) The next song is number 41, was 40 [08-08-09 18:07:17.4380] Slim::Player::TranscodingHelper::getConvertCommand (215) undermax = 1, type = mp3, squeezebox2 = 00:04:20:12:1d:99 [08-08-09 18:07:17.4384] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:07:17.4387] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-00:04:20:12:1d:99 [08-08-09 18:07:17.4390] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-squeezebox2-* [08-08-09 18:07:17.4392] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wma-*-* [08-08-09 18:07:17.4395] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:07:17.4398] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-00:04:20:12:1d:99 [08-08-09 18:07:17.4401] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-squeezebox2-* [08-08-09 18:07:17.4404] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-ogg-*-* [08-08-09 18:07:17.4406] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:07:17.4409] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-00:04:20:12:1d:99 [08-08-09 18:07:17.4412] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-squeezebox2-* [08-08-09 18:07:17.4415] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-flc-*-* [08-08-09 18:07:17.4418] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:07:17.4420] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-00:04:20:12:1d:99 [08-08-09 18:07:17.4423] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-squeezebox2-* [08-08-09 18:07:17.4426] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-aif-*-* [08-08-09 18:07:17.4429] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:07:17.4432] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-00:04:20:12:1d:99 [08-08-09 18:07:17.4435] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-squeezebox2-* [08-08-09 18:07:17.4437] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-wav-*-* [08-08-09 18:07:17.4440] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-00:04:20:12:1d:99 [08-08-09 18:07:17.4443] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-00:04:20:12:1d:99 [08-08-09 18:07:17.4446] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-squeezebox2-* [08-08-09 18:07:17.4449] Slim::Player::TranscodingHelper::checkBin (152) Checking formats for: mp3-mp3-*-* [08-08-09 18:07:17.4451] Slim::Player::TranscodingHelper::enabledFormat (119) Checking to see if mp3-mp3-*-* is enabled [08-08-09 18:07:17.4454] Slim::Player::TranscodingHelper::checkBin (160) enabled [08-08-09 18:07:17.4457] Slim::Player::TranscodingHelper::checkBin (162) Found command: - [08-08-09 18:07:17.6020] Slim::Player::TranscodingHelper::getConvertCommand (316) Matched Format: mp3 Type: mp3 Command: - [08-08-09 18:07:17.6024] Slim::Player::Source::gotoNext (1437) opening next song (old format: mp3, new: mp3) current playmode: playout-play [08-08-09 18:07:17.6027] Slim::Player::Source::streamingSongIndex (1494) Adding song index 41 to song queue [08-08-09 18:07:17.6030] Slim::Player::Source::streamingSongIndex (1515) Song queue is now 41,40 [08-08-09 18:07:17.6033] Slim::Player::Source::skipahead (962) **skipahead: restarting [08-08-09 18:07:17.6036] Slim::Player::Source::playmode (309) 00:04:20:12:1d:99: Switching to mode play from playout-play [08-08-09 18:07:17.6041] Slim::Player::Source::resetSong (1739) Resetting song buffer. [08-08-09 18:07:17.6106] Slim::Player::Source::openSong (1840) Trying to open: rhapd://Tra.2652562.mp3 [08-08-09 18:07:17.6111] Slim::Player::Source::openSong (1876) URL supports direct streaming [rhapd://Tra.2652562.mp3] [08-08-09 18:07:17.6156] Slim::Player::Source::playmode (412) 00:04:20:12:1d:99 New play mode: play [08-08-09 18:07:17.6178] Slim::Player::Squeezebox::stream (1017) This player supports direct streaming for rhapd://Tra.2652562.mp3 as http://llnw-654.listen.com/5/4/3/6/3/64836345.rad, let's do it. [08-08-09 18:07:18.9186] Slim::Player::Squeezebox::stream (1055) setting up direct stream (1159502554:80) autostart: 3. [08-08-09 18:07:18.9196] Slim::Player::Squeezebox::stream (1056) request string: GET /5/4/3/6/3/64836345.rad HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: llnw-654.listen.com User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1255) SqueezeCenter/7.2/22491 Icy-Metadata: 1 [08-08-09 18:07:18.9770] Slim::Player::Source::playmode (581) 00:04:20:12:1d:99: Current playmode: play [08-08-09 18:07:19.4751] Slim::Player::Squeezebox2::directHeaders (290) Processing headers for direct streaming: HTTP/1.0 200 OK Date: Sat, 09 Aug 2008 15:07:19 GMT Server: Apache/2.0.58 Last-Modified: Fri, 23 Mar 2007 01:19:23 GMT Accept-Ranges: bytes Content-Length: 3990676 Content-Type: text/plain Connection: close [08-08-09 18:07:19.4756] Slim::Player::Squeezebox2::directHeaders (349) Processing 7 headers [08-08-09 18:07:19.4759] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Date: Sat, 09 Aug 2008 15:07:19 GMT [08-08-09 18:07:19.4762] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Server: Apache/2.0.58 [08-08-09 18:07:19.4765] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Last-Modified: Fri, 23 Mar 2007 01:19:23 GMT [08-08-09 18:07:19.4767] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Accept-Ranges: bytes [08-08-09 18:07:19.4770] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (61) RhapsodyDirect header: Content-Length: 3990676 [08-08-09 18:07:19.5120] Slim::Player::Squeezebox2::directHeaders (407) Got a stream type: mp3 bitrate: 192000 title: [08-08-09 18:07:19.5124] Slim::Player::Squeezebox2::directHeaders (459) Beginning direct stream! [08-08-09 18:07:22.2341] Slim::Player::Source::trackStartEvent (1605) Got a track starting event [08-08-09 18:07:22.2410] Slim::Player::Source::trackStartEvent (1612) Song 40 had already started, so it's not longer in the queue [08-08-09 18:07:22.2417] Slim::Player::Source::trackStartEvent (1621) Song 41 has now started playing