[09-09-11 15:15:14.4117] Slim::Player::StreamingController::stop (1904) 00:04:20:05:ab:fa
[09-09-11 15:15:14.4129] Slim::Player::StreamingController::play (1907) 00:04:20:05:ab:fa
[09-09-11 15:15:14.4135] Slim::Player::StreamingController::_setPlayingState (2175) new playing state STOPPED
[09-09-11 15:15:14.4138] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state IDLE
[09-09-11 15:15:14.4146] Slim::Player::Song::new (107) index 0 -> http://feeds.theonion.com/~r/theonion/radionews/~5/DP0ZxReTuGk/podcast_redirect.mp3
[09-09-11 15:15:14.4162] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state TRACKWAIT
[09-09-11 15:15:14.4166] Slim::Player::Song::getNextSong (228) http://feeds.theonion.com/~r/theonion/radionews/~5/DP0ZxReTuGk/podcast_redirect.mp3
[09-09-11 15:15:14.4169] Slim::Player::Song::getNextSong (250) scanning URL http://feeds.theonion.com/~r/theonion/radionews/~5/DP0ZxReTuGk/podcast_redirect.mp3
[09-09-11 15:15:14.4172] Slim::Utils::Scanner::Remote::scanURL (86) Scanning remote stream http://feeds.theonion.com/~r/theonion/radionews/~5/DP0ZxReTuGk/podcast_redirect.mp3
[09-09-11 15:15:14.4181] Slim::Utils::Scanner::Remote::scanURL (202) Scanning remote URL http://feeds.theonion.com/~r/theonion/radionews/~5/DP0ZxReTuGk/podcast_redirect.mp3
[09-09-11 15:15:14.4217] Slim::Player::StreamingController::_playersMessage (768) Getting stream info...: http://feeds.theonion.com/~r/theonion/radionews/~5/DP0ZxReTuGk/podcast_redirect.mp3
[09-09-11 15:15:14.5743] Slim::Utils::Scanner::Remote::handleRedirect (281) Server redirected to http://track.theonion.com/podcast_redirect.mp3?file=files%2Fradionews%2F09-171_Bail_Money_Th.mp3&title=Bail+Money+Factored+Into+Vacation+Fund&issue=4537
[09-09-11 15:15:14.7512] Slim::Utils::Scanner::Remote::handleRedirect (281) Server redirected to http://track.theonion.com/onion_rss.php?issue=4537&type=onion_radionews_podcast&title=Bail+Money+Factored+Into+Vacation+Fund&file_redirect=files%2Fradionews%2F09-171_Bail_Money_Th.mp3
[09-09-11 15:15:14.8609] Slim::Utils::Scanner::Remote::handleRedirect (281) Server redirected to http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3
[09-09-11 15:15:14.9934] Slim::Utils::Scanner::Remote::readRemoteHeaders (324) Headers for http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3 are bless({
  "accept-ranges" => "bytes",
  age => 154_542,
  "cache-control" => "public, max-age=604800",
  connection => "close",
  "content-length" => 362_941,
  "content-type" => "audio/mpeg",
  date => "Fri, 11 Sep 2009 19:15:14 GMT",
  etag => "\"13a00e-589bd-4731345b67180\"",
  expires => "Thu, 17 Sep 2009 00:19:32 GMT",
  "last-modified" => "Tue, 08 Sep 2009 16:15:18 GMT",
  server => "PWS/1.4.26",
  "x-px" => "ms jfk-agg-n2 (jfk-agg-n6), ht jfk-agg-n6",
}, "HTTP::Headers")
[09-09-11 15:15:14.9939] Slim::Utils::Scanner::Remote::readRemoteHeaders (356) Content-type for http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3 detected as mp3 (audio/mpeg)
[09-09-11 15:15:14.9943] Slim::Utils::Scanner::Remote::readRemoteHeaders (361) Updating content-type for http://feeds.theonion.com/~r/theonion/radionews/~5/DP0ZxReTuGk/podcast_redirect.mp3 to mp3
[09-09-11 15:15:14.9951] Slim::Utils::Scanner::Remote::readRemoteHeaders (378) Updating redirected URL http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3
[09-09-11 15:15:14.9958] Slim::Utils::Scanner::Remote::readRemoteHeaders (401) This URL is an audio stream [mp3]: http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3
[09-09-11 15:15:14.9963] Slim::Player::Song::__ANON__ (265) Track updated by scan: http://feeds.theonion.com/~r/theonion/radionews/~5/DP0ZxReTuGk/podcast_redirect.mp3 -> http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3
[09-09-11 15:15:14.9967] Slim::Player::Song::getNextSong (228) http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3
[09-09-11 15:15:14.9971] Slim::Player::StreamingController::_nextTrackReady (725) 00:04:20:05:ab:fa: nextTrack will be index 0
[09-09-11 15:15:14.9975] Slim::Player::StreamingController::_Stream (1126) Song queue is now 0
[09-09-11 15:15:14.9979] Slim::Player::StreamingController::_Stream (1135) 00:04:20:05:ab:fa: preparing to stream song index 0
[09-09-11 15:15:14.9983] Slim::Player::Song::open (357) http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3
[09-09-11 15:15:15.0010] Slim::Player::TranscodingHelper::getConvertCommand2 (430) Error: Didn't find any command matches for type: mp3
[09-09-11 15:15:15.0014] Slim::Player::Song::open (377) seek=false time=0 canSeek=0SEEK_ERROR_MP3_UNKNOWN_BITRATE
[09-09-11 15:15:15.0019] Slim::Player::TranscodingHelper::getConvertCommand2 (433) Matched: mp3->mp3 via: -
[09-09-11 15:15:15.0023] Slim::Player::Song::open (398) Transcoder: streamMode=I, streamformat=mp3
[09-09-11 15:15:15.0027] Slim::Player::Song::open (436) URL supports direct streaming [http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3->http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3]
[09-09-11 15:15:15.0035] Slim::Player::StreamingController::_Stream (1186) 00:04:20:05:ab:fa: stream
[09-09-11 15:15:15.0053] Slim::Player::Squeezebox::stream_s (770) This player supports direct streaming for http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3 as http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3, let's do it.
[09-09-11 15:15:15.0107] Slim::Player::Squeezebox::stream_s (809) setting up direct stream (1114779987:80) autostart: 3 format: m.
[09-09-11 15:15:15.0110] Slim::Player::Squeezebox::stream_s (810) request string: GET /content/files/radionews/09-171_Bail_Money_Th.mp3 HTTP/1.0
Cache-Control: no-cache
Connection: close
Accept: */*
Host: www.theonion.com
User-Agent: iTunes/4.7.1 (Darwin; N; Mac OS X 10.6.1 (10B504); x86_64; EN; utf8) Squeezebox Server/7.4/TRUNK
Icy-Metadata: 1

[09-09-11 15:15:15.0118] Slim::Player::StreamingController::_Stream (1217) Song queue is now 0
[09-09-11 15:15:15.0121] Slim::Player::StreamingController::_setPlayingState (2175) new playing state BUFFERING
[09-09-11 15:15:15.0124] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state STREAMING
[09-09-11 15:15:15.0127] Slim::Utils::Scanner::Remote::readRemoteHeaders (502) Reading audio data in the background to detect bitrate and/or tags
[09-09-11 15:15:15.0145] Slim::Utils::Scanner::Remote::streamAudioData (664) http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3 Buffering audio stream data to temp file /var/folders/+g/+gA+Pg7CEn476mTXa6drR++++TI/-Tmp-/swb4LQCU8x
[09-09-11 15:15:15.0149] Slim::Utils::Scanner::Remote::streamAudioData (685) ID3v2 tag detected, will read 16640 bytes
[09-09-11 15:15:15.0991] Slim::Formats::MP3::scanBitrate (285) Scanned bitrate from stream: 34000 CBR
[09-09-11 15:15:15.1305] Slim::Player::Player::_buffering (1133) Buffering... 0 / 20480
[09-09-11 15:15:15.1366] Slim::Player::Squeezebox2::directHeaders (425) Processing headers for direct streaming:
HTTP/1.1 200 OK
Date: Fri, 11 Sep 2009 19:15:14 GMT
Server: PWS/1.4.26
X-Px: ht jfk-agg-n2
ETag: "13a00e-589bd-4731345b67180"
Content-Length: 362941
Content-Type: audio/mpeg
Last-Modified: Tue, 08 Sep 2009 16:15:18 GMT
Cache-Control: public, max-age=604800
Age: 154542
Expires: Thu, 17 Sep 2009 00:19:32 GMT
Connection: close

[09-09-11 15:15:15.1372] Slim::Player::Squeezebox2::directHeaders (495) Processing 11 headers
[09-09-11 15:15:15.1376] Slim::Player::Squeezebox2::directHeaders (501) Calling Slim::Player::Protocols::HTTP ::parseDirectHeaders
[09-09-11 15:15:15.1379] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Date: Fri, 11 Sep 2009 19:15:14 GMT
[09-09-11 15:15:15.1382] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Server: PWS/1.4.26
[09-09-11 15:15:15.1385] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: X-Px: ht jfk-agg-n2
[09-09-11 15:15:15.1388] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: ETag: "13a00e-589bd-4731345b67180"
[09-09-11 15:15:15.1391] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Length: 362941
[09-09-11 15:15:15.1394] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Type: audio/mpeg
[09-09-11 15:15:15.1397] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Last-Modified: Tue, 08 Sep 2009 16:15:18 GMT
[09-09-11 15:15:15.1401] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Cache-Control: public, max-age=604800
[09-09-11 15:15:15.1403] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Age: 154542
[09-09-11 15:15:15.1406] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Expires: Thu, 17 Sep 2009 00:19:32 GMT
[09-09-11 15:15:15.1408] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Connection: close
[09-09-11 15:15:15.1421] Slim::Player::Squeezebox2::directHeaders (559) Got a stream type: mp3 bitrate: 34000 title: undef
[09-09-11 15:15:15.1426] Slim::Player::Squeezebox2::directHeaders (607) Beginning direct stream!
[09-09-11 15:15:15.1429] Slim::Player::Squeezebox2::sendContCommand (643) Sending cont frame: metaint 0, loop 0
[09-09-11 15:15:15.3731] Slim::Player::StreamingController::playerTrackStarted (1987) 00:04:20:05:ab:fa
[09-09-11 15:15:15.3738] Slim::Player::StreamingController::_setPlayingState (2175) new playing state PLAYING
[09-09-11 15:15:15.3742] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[09-09-11 15:15:15.3749] Slim::Player::StreamingController::_Playing (391) Song queue is now 0
[09-09-11 15:15:17.3061] Slim::Player::StreamingController::playerEndOfStream (2084) 00:04:20:05:ab:fa
[09-09-11 15:15:17.3069] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state STREAMOUT
[09-09-11 15:15:47.0084] Slim::Player::StreamingController::playerReadyToStream (2005) 00:04:20:05:ab:fa
[09-09-11 15:15:47.0090] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state IDLE
[09-09-11 15:15:47.0099] Slim::Player::StreamingController::_RetryOrNext (866) Attempting to re-stream http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3, duration=85.3978823529412 at time offset 41.5807188208617
[09-09-11 15:15:47.0104] Slim::Player::StreamingController::_Stream (1073) 00:04:20:05:ab:fa: got song from params, song index 0
[09-09-11 15:15:47.0108] Slim::Player::StreamingController::_Stream (1126) Song queue is now 0
[09-09-11 15:15:47.0112] Slim::Player::StreamingController::_Stream (1135) 00:04:20:05:ab:fa: preparing to stream song index 0
[09-09-11 15:15:47.0116] Slim::Player::Song::open (357) http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3
[09-09-11 15:15:47.0120] Slim::Player::Song::open (377) seek=true time=41.5807188208617 canSeek=1
[09-09-11 15:15:47.0127] Slim::Player::TranscodingHelper::getConvertCommand2 (433) Matched: mp3->mp3 via: -
[09-09-11 15:15:47.0131] Slim::Player::Song::open (398) Transcoder: streamMode=I, streamformat=mp3
[09-09-11 15:15:47.0135] Slim::Player::Song::open (436) URL supports direct streaming [http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3->http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3]
[09-09-11 15:15:47.0141] Slim::Player::StreamingController::_Stream (1186) 00:04:20:05:ab:fa: stream
[09-09-11 15:15:47.0160] Slim::Player::Squeezebox::stream_s (770) This player supports direct streaming for http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3 as http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3, let's do it.
[09-09-11 15:15:47.0682] Slim::Player::Squeezebox::stream_s (809) setting up direct stream (1114779959:80) autostart: 3 format: m.
[09-09-11 15:15:47.0689] Slim::Player::Squeezebox::stream_s (810) request string: GET /content/files/radionews/09-171_Bail_Money_Th.mp3 HTTP/1.0
Cache-Control: no-cache
Connection: close
Accept: */*
Host: www.theonion.com
Range: bytes=180959-
User-Agent: iTunes/4.7.1 (Darwin; N; Mac OS X 10.6.1 (10B504); x86_64; EN; utf8) Squeezebox Server/7.4/TRUNK
Icy-Metadata: 1

[09-09-11 15:15:47.0713] Slim::Player::StreamingController::_Stream (1217) Song queue is now 0
[09-09-11 15:15:47.0717] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state STREAMING
[09-09-11 15:15:47.2395] Slim::Player::Squeezebox2::directHeaders (425) Processing headers for direct streaming:
HTTP/1.1 206 Partial Content
Date: Fri, 11 Sep 2009 19:15:47 GMT
Server: PWS/1.4.26
X-Px: ms jfk-agg-n45 (jfk-agg-n6), ht jfk-agg-n6
ETag: "13a00e-589bd-4731345b67180"
Content-Length: 181982
Content-Type: audio/mpeg
Last-Modified: Tue, 08 Sep 2009 16:15:18 GMT
Content-Range: bytes 180959-362940/362941
Cache-Control: public, max-age=604800
Age: 154574
Expires: Thu, 17 Sep 2009 00:19:33 GMT
Connection: close

[09-09-11 15:15:47.2402] Slim::Player::Squeezebox2::directHeaders (495) Processing 12 headers
[09-09-11 15:15:47.2407] Slim::Player::Squeezebox2::directHeaders (501) Calling Slim::Player::Protocols::HTTP ::parseDirectHeaders
[09-09-11 15:15:47.2411] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Date: Fri, 11 Sep 2009 19:15:47 GMT
[09-09-11 15:15:47.2415] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Server: PWS/1.4.26
[09-09-11 15:15:47.2419] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: X-Px: ms jfk-agg-n45 (jfk-agg-n6), ht jfk-agg-n6
[09-09-11 15:15:47.2423] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: ETag: "13a00e-589bd-4731345b67180"
[09-09-11 15:15:47.2426] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Length: 181982
[09-09-11 15:15:47.2429] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Type: audio/mpeg
[09-09-11 15:15:47.2433] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Last-Modified: Tue, 08 Sep 2009 16:15:18 GMT
[09-09-11 15:15:47.2436] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Range: bytes 180959-362940/362941
[09-09-11 15:15:47.2439] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Cache-Control: public, max-age=604800
[09-09-11 15:15:47.2443] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Age: 154574
[09-09-11 15:15:47.2446] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Expires: Thu, 17 Sep 2009 00:19:33 GMT
[09-09-11 15:15:47.2449] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Connection: close
[09-09-11 15:15:47.2456] Slim::Player::Protocols::HTTP::parseDirectHeaders (375) Setting startOffest based on Content-Range to 42.5785882352941
[09-09-11 15:15:47.2468] Slim::Player::Squeezebox2::directHeaders (559) Got a stream type: mp3 bitrate: 34000 title: undef
[09-09-11 15:15:47.2474] Slim::Player::Squeezebox2::directHeaders (607) Beginning direct stream!
[09-09-11 15:15:47.2478] Slim::Player::Squeezebox2::sendContCommand (643) Sending cont frame: metaint 0, loop 0
[09-09-11 15:15:48.3846] Slim::Player::StreamingController::playerEndOfStream (2084) 00:04:20:05:ab:fa
[09-09-11 15:15:48.3852] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state STREAMOUT
[09-09-11 15:15:48.3856] Slim::Player::StreamingController::_AutoStart (1404) autostart possibly short track
[09-09-11 15:15:56.9831] Slim::Player::StreamingController::playerTrackStarted (1987) 00:04:20:05:ab:fa
[09-09-11 15:15:56.9838] Slim::Player::StreamingController::_setPlayingState (2175) new playing state PLAYING
[09-09-11 15:15:56.9842] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[09-09-11 15:15:56.9849] Slim::Player::StreamingController::_Playing (391) Song queue is now 0
[09-09-11 15:16:07.7273] Slim::Player::StreamingController::playerReadyToStream (2005) 00:04:20:05:ab:fa
[09-09-11 15:16:07.7280] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state IDLE
[09-09-11 15:16:07.7289] Slim::Player::StreamingController::_RetryOrNext (866) Attempting to re-stream http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3, duration=85.3978823529412 at time offset 63.2687129518474
[09-09-11 15:16:07.7293] Slim::Player::StreamingController::_Stream (1073) 00:04:20:05:ab:fa: got song from params, song index 0
[09-09-11 15:16:07.7297] Slim::Player::StreamingController::_Stream (1126) Song queue is now 0
[09-09-11 15:16:07.7301] Slim::Player::StreamingController::_Stream (1135) 00:04:20:05:ab:fa: preparing to stream song index 0
[09-09-11 15:16:07.7305] Slim::Player::Song::open (357) http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3
[09-09-11 15:16:07.7309] Slim::Player::Song::open (377) seek=true time=63.2687129518474 canSeek=1
[09-09-11 15:16:07.7316] Slim::Player::TranscodingHelper::getConvertCommand2 (433) Matched: mp3->mp3 via: -
[09-09-11 15:16:07.7319] Slim::Player::Song::open (398) Transcoder: streamMode=I, streamformat=mp3
[09-09-11 15:16:07.7324] Slim::Player::Song::open (436) URL supports direct streaming [http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3->http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3]
[09-09-11 15:16:07.7330] Slim::Player::StreamingController::_Stream (1186) 00:04:20:05:ab:fa: stream
[09-09-11 15:16:07.7348] Slim::Player::Squeezebox::stream_s (770) This player supports direct streaming for http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3 as http://www.theonion.com/content/files/radionews/09-171_Bail_Money_Th.mp3, let's do it.
[09-09-11 15:16:07.7719] Slim::Player::Squeezebox::stream_s (809) setting up direct stream (1114779967:80) autostart: 3 format: m.
[09-09-11 15:16:07.7727] Slim::Player::Squeezebox::stream_s (810) request string: GET /content/files/radionews/09-171_Bail_Money_Th.mp3 HTTP/1.0
Cache-Control: no-cache
Connection: close
Accept: */*
Host: www.theonion.com
Range: bytes=275345-
User-Agent: iTunes/4.7.1 (Darwin; N; Mac OS X 10.6.1 (10B504); x86_64; EN; utf8) Squeezebox Server/7.4/TRUNK
Icy-Metadata: 1

[09-09-11 15:16:07.7775] Slim::Player::StreamingController::_Stream (1217) Song queue is now 0
[09-09-11 15:16:07.7778] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state STREAMING
[09-09-11 15:16:07.9088] Slim::Player::Squeezebox2::directHeaders (425) Processing headers for direct streaming:
HTTP/1.1 206 Partial Content
Date: Fri, 11 Sep 2009 19:16:13 GMT
Server: PWS/1.4.26
X-Px: ms jfk-agg-n53 (jfk-agg-n6), ht jfk-agg-n6
ETag: "13a00e-589bd-4731345b67180"
Content-Length: 87596
Content-Type: audio/mpeg
Last-Modified: Tue, 08 Sep 2009 16:15:18 GMT
Content-Range: bytes 275345-362940/362941
Cache-Control: public, max-age=604800
Age: 154601
Expires: Thu, 17 Sep 2009 00:19:32 GMT
Connection: close

[09-09-11 15:16:07.9095] Slim::Player::Squeezebox2::directHeaders (495) Processing 12 headers
[09-09-11 15:16:07.9099] Slim::Player::Squeezebox2::directHeaders (501) Calling Slim::Player::Protocols::HTTP ::parseDirectHeaders
[09-09-11 15:16:07.9103] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Date: Fri, 11 Sep 2009 19:16:13 GMT
[09-09-11 15:16:07.9107] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Server: PWS/1.4.26
[09-09-11 15:16:07.9110] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: X-Px: ms jfk-agg-n53 (jfk-agg-n6), ht jfk-agg-n6
[09-09-11 15:16:07.9114] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: ETag: "13a00e-589bd-4731345b67180"
[09-09-11 15:16:07.9117] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Length: 87596
[09-09-11 15:16:07.9120] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Type: audio/mpeg
[09-09-11 15:16:07.9124] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Last-Modified: Tue, 08 Sep 2009 16:15:18 GMT
[09-09-11 15:16:07.9127] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Range: bytes 275345-362940/362941
[09-09-11 15:16:07.9130] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Cache-Control: public, max-age=604800
[09-09-11 15:16:07.9134] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Age: 154601
[09-09-11 15:16:07.9137] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Expires: Thu, 17 Sep 2009 00:19:32 GMT
[09-09-11 15:16:07.9142] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Connection: close
[09-09-11 15:16:07.9148] Slim::Player::Protocols::HTTP::parseDirectHeaders (375) Setting startOffest based on Content-Range to 64.7870588235294
[09-09-11 15:16:07.9161] Slim::Player::Squeezebox2::directHeaders (559) Got a stream type: mp3 bitrate: 34000 title: undef
[09-09-11 15:16:07.9166] Slim::Player::Squeezebox2::directHeaders (607) Beginning direct stream!
[09-09-11 15:16:07.9171] Slim::Player::Squeezebox2::sendContCommand (643) Sending cont frame: metaint 0, loop 0
[09-09-11 15:16:08.4857] Slim::Player::StreamingController::playerEndOfStream (2084) 00:04:20:05:ab:fa
[09-09-11 15:16:08.4863] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state STREAMOUT
[09-09-11 15:16:08.4868] Slim::Player::StreamingController::_AutoStart (1404) autostart possibly short track
[09-09-11 15:16:17.5834] Slim::Player::StreamingController::playerReadyToStream (2005) 00:04:20:05:ab:fa
[09-09-11 15:16:17.5839] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state IDLE
[09-09-11 15:16:17.5845] Slim::Player::StreamingController::nextsong (836) The next song is number 1, was 0
[09-09-11 15:16:17.5854] Slim::Player::Song::new (107) index 1 -> http://feeds.theonion.com/~r/theonion/radionews/~5/ElkSrz0vQfI/podcast_redirect.mp3
[09-09-11 15:16:17.5860] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state TRACKWAIT
[09-09-11 15:16:17.5863] Slim::Player::Song::getNextSong (228) http://feeds.theonion.com/~r/theonion/radionews/~5/ElkSrz0vQfI/podcast_redirect.mp3
[09-09-11 15:16:17.5868] Slim::Player::Song::getNextSong (250) scanning URL http://feeds.theonion.com/~r/theonion/radionews/~5/ElkSrz0vQfI/podcast_redirect.mp3
[09-09-11 15:16:17.5872] Slim::Utils::Scanner::Remote::scanURL (86) Scanning remote stream http://feeds.theonion.com/~r/theonion/radionews/~5/ElkSrz0vQfI/podcast_redirect.mp3
[09-09-11 15:16:17.5883] Slim::Utils::Scanner::Remote::scanURL (202) Scanning remote URL http://feeds.theonion.com/~r/theonion/radionews/~5/ElkSrz0vQfI/podcast_redirect.mp3
[09-09-11 15:16:17.7035] Slim::Player::StreamingController::playerTrackStarted (1987) 00:04:20:05:ab:fa
[09-09-11 15:16:17.7040] Slim::Player::StreamingController::_setPlayingState (2175) new playing state PLAYING
[09-09-11 15:16:17.7044] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[09-09-11 15:16:17.7052] Slim::Player::StreamingController::_Playing (391) Song queue is now 1,0
[09-09-11 15:16:17.7470] Slim::Utils::Scanner::Remote::handleRedirect (281) Server redirected to http://track.theonion.com/podcast_redirect.mp3?file=files%2Fradionews%2F09-175_Rooftop_Press_W.mp3&title=President+Obama+Holds+Surprise+Rooftop+Press+Conference&issue=4537
[09-09-11 15:16:17.9231] Slim::Utils::Scanner::Remote::handleRedirect (281) Server redirected to http://track.theonion.com/onion_rss.php?issue=4537&type=onion_radionews_podcast&title=President+Obama+Holds+Surprise+Rooftop+Press+Conference&file_redirect=files%2Fradionews%2F09-175_Rooftop_Press_W.mp3
[09-09-11 15:16:18.0312] Slim::Utils::Scanner::Remote::handleRedirect (281) Server redirected to http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3
[09-09-11 15:16:18.2045] Slim::Utils::Scanner::Remote::readRemoteHeaders (324) Headers for http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3 are bless({
  "accept-ranges" => "bytes",
  age => 240_962,
  "cache-control" => "public, max-age=604800",
  connection => "close",
  "content-length" => 425_723,
  "content-type" => "audio/mpeg",
  date => "Fri, 11 Sep 2009 19:16:18 GMT",
  etag => "\"2e272c-67efb-4731341b81ac0\"",
  expires => "Wed, 16 Sep 2009 00:20:16 GMT",
  "last-modified" => "Tue, 08 Sep 2009 16:14:11 GMT",
  server => "PWS/1.4.26",
  "x-px" => "ms jfk-agg-n34 (jfk-agg-n55), ht jfk-agg-n55",
}, "HTTP::Headers")
[09-09-11 15:16:18.2049] Slim::Utils::Scanner::Remote::readRemoteHeaders (356) Content-type for http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3 detected as mp3 (audio/mpeg)
[09-09-11 15:16:18.2053] Slim::Utils::Scanner::Remote::readRemoteHeaders (361) Updating content-type for http://feeds.theonion.com/~r/theonion/radionews/~5/ElkSrz0vQfI/podcast_redirect.mp3 to mp3
[09-09-11 15:16:18.2059] Slim::Utils::Scanner::Remote::readRemoteHeaders (378) Updating redirected URL http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3
[09-09-11 15:16:18.2065] Slim::Utils::Scanner::Remote::readRemoteHeaders (401) This URL is an audio stream [mp3]: http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3
[09-09-11 15:16:18.2069] Slim::Player::Song::__ANON__ (265) Track updated by scan: http://feeds.theonion.com/~r/theonion/radionews/~5/ElkSrz0vQfI/podcast_redirect.mp3 -> http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3
[09-09-11 15:16:18.2073] Slim::Player::Song::getNextSong (228) http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3
[09-09-11 15:16:18.2076] Slim::Player::StreamingController::_nextTrackReady (725) 00:04:20:05:ab:fa: nextTrack will be index 1
[09-09-11 15:16:18.2080] Slim::Player::StreamingController::_Stream (1126) Song queue is now 1,0
[09-09-11 15:16:18.2082] Slim::Player::StreamingController::_Stream (1135) 00:04:20:05:ab:fa: preparing to stream song index 1
[09-09-11 15:16:18.2086] Slim::Player::Song::open (357) http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3
[09-09-11 15:16:18.2100] Slim::Player::TranscodingHelper::getConvertCommand2 (430) Error: Didn't find any command matches for type: mp3
[09-09-11 15:16:18.2103] Slim::Player::Song::open (377) seek=false time=0 canSeek=0SEEK_ERROR_MP3_UNKNOWN_BITRATE
[09-09-11 15:16:18.2109] Slim::Player::TranscodingHelper::getConvertCommand2 (433) Matched: mp3->mp3 via: -
[09-09-11 15:16:18.2112] Slim::Player::Song::open (398) Transcoder: streamMode=I, streamformat=mp3
[09-09-11 15:16:18.2115] Slim::Player::Song::open (436) URL supports direct streaming [http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3->http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3]
[09-09-11 15:16:18.2120] Slim::Player::StreamingController::_Stream (1186) 00:04:20:05:ab:fa: stream
[09-09-11 15:16:18.2137] Slim::Player::Squeezebox::stream_s (770) This player supports direct streaming for http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3 as http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3, let's do it.
[09-09-11 15:16:18.2159] Slim::Player::Squeezebox::stream_s (809) setting up direct stream (1114779967:80) autostart: 3 format: m.
[09-09-11 15:16:18.2162] Slim::Player::Squeezebox::stream_s (810) request string: GET /content/files/radionews/09-175_Rooftop_Press_W.mp3 HTTP/1.0
Cache-Control: no-cache
Connection: close
Accept: */*
Host: www.theonion.com
User-Agent: iTunes/4.7.1 (Darwin; N; Mac OS X 10.6.1 (10B504); x86_64; EN; utf8) Squeezebox Server/7.4/TRUNK
Icy-Metadata: 1

[09-09-11 15:16:18.2184] Slim::Player::StreamingController::_Stream (1217) Song queue is now 1,0
[09-09-11 15:16:18.2188] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state STREAMING
[09-09-11 15:16:18.2191] Slim::Utils::Scanner::Remote::readRemoteHeaders (502) Reading audio data in the background to detect bitrate and/or tags
[09-09-11 15:16:18.2205] Slim::Utils::Scanner::Remote::streamAudioData (664) http://www.theonion.com/content/files/radionews/09-175_Rooftop_Press_W.mp3 Buffering audio stream data to temp file /var/folders/+g/+gA+Pg7CEn476mTXa6drR++++TI/-Tmp-/9cDwdUHh2G
[09-09-11 15:16:18.2209] Slim::Utils::Scanner::Remote::streamAudioData (685) ID3v2 tag detected, will read 16640 bytes
[09-09-11 15:16:18.3454] Slim::Player::Squeezebox2::directHeaders (425) Processing headers for direct streaming:
HTTP/1.1 200 OK
Date: Fri, 11 Sep 2009 19:16:24 GMT
Server: PWS/1.4.26
X-Px: ms jfk-agg-n53 (jfk-agg-n55), ht jfk-agg-n55
ETag: "2e272c-67efb-4731341b81ac0"
Content-Length: 425723
Content-Type: audio/mpeg
Last-Modified: Tue, 08 Sep 2009 16:14:11 GMT
Cache-Control: public, max-age=604800
Age: 240968
Expires: Wed, 16 Sep 2009 00:20:16 GMT
Connection: close

[09-09-11 15:16:18.3461] Slim::Player::Squeezebox2::directHeaders (495) Processing 11 headers
[09-09-11 15:16:18.3464] Slim::Player::Squeezebox2::directHeaders (501) Calling Slim::Player::Protocols::HTTP ::parseDirectHeaders
[09-09-11 15:16:18.3467] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Date: Fri, 11 Sep 2009 19:16:24 GMT
[09-09-11 15:16:18.3470] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Server: PWS/1.4.26
[09-09-11 15:16:18.3474] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: X-Px: ms jfk-agg-n53 (jfk-agg-n55), ht jfk-agg-n55
[09-09-11 15:16:18.3478] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: ETag: "2e272c-67efb-4731341b81ac0"
[09-09-11 15:16:18.3482] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Length: 425723
[09-09-11 15:16:18.3485] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Content-Type: audio/mpeg
[09-09-11 15:16:18.3488] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Last-Modified: Tue, 08 Sep 2009 16:14:11 GMT
[09-09-11 15:16:18.3492] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Cache-Control: public, max-age=604800
[09-09-11 15:16:18.3495] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Age: 240968
[09-09-11 15:16:18.3498] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Expires: Wed, 16 Sep 2009 00:20:16 GMT
[09-09-11 15:16:18.3502] Slim::Player::Protocols::HTTP::parseDirectHeaders (323) header-ds: Connection: close
[09-09-11 15:16:18.3512] Slim::Player::Squeezebox2::directHeaders (559) Got a stream type: mp3 bitrate:  title: undef
[09-09-11 15:16:18.3518] Slim::Player::Squeezebox2::directHeaders (607) Beginning direct stream!
[09-09-11 15:16:18.3523] Slim::Player::Squeezebox2::sendContCommand (643) Sending cont frame: metaint 0, loop 0
[09-09-11 15:16:18.4040] Slim::Formats::MP3::scanBitrate (285) Scanned bitrate from stream: 34000 CBR
[09-09-11 15:16:20.9002] Slim::Player::StreamingController::playerEndOfStream (2084) 00:04:20:05:ab:fa
[09-09-11 15:16:20.9008] Slim::Player::StreamingController::_setStreamingState (2188) new streaming state STREAMOUT
[09-09-11 15:16:20.9012] Slim::Player::StreamingController::_AutoStart (1404) autostart possibly short track
[09-09-11 15:16:27.5580] Slim::Player::StreamingController::playerTrackStarted (1987) 00:04:20:05:ab:fa
[09-09-11 15:16:27.5583] Slim::Player::StreamingController::_setPlayingState (2175) new playing state PLAYING
[09-09-11 15:16:27.5587] Slim::Player::StreamingController::_Playing (355) Song 0 is not longer in the queue
[09-09-11 15:16:27.5592] Slim::Player::StreamingController::_Playing (361) Song 1 has now started playing
[09-09-11 15:16:27.5602] Slim::Player::StreamingController::_Playing (391) Song queue is now 1