[08-11-19 20:11:03.5320] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:04.5343] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:05.5332] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:06.5322] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:06.9541] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:06:be:04
[08-11-19 20:11:06.9547] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onPlayout (747) onPlayout, logging playback
[08-11-19 20:11:06.9554] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_doLog (797) Logging track playback: 162 seconds, trackId: Tra.14176887, stationId: 
[08-11-19 20:11:06.9590] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-19 20:11:06.9594] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-19 20:11:06.9599] Slim::Player::StreamingController::nextsong (741) The next song is number 9, was 8
[08-11-19 20:11:06.9653] Slim::Player::Song::new (64) index 9 -> rhapd://Tra.14176888.mp3
[08-11-19 20:11:06.9660] Slim::Player::Song::new (101) live=2
[08-11-19 20:11:06.9670] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state TRACKWAIT
[08-11-19 20:11:06.9675] Slim::Player::Song::getNextSong (178) rhapd://Tra.14176888.mp3
[08-11-19 20:11:06.9680] Slim::Player::Song::getNextSong (200) scanning URL rhapd://Tra.14176888.mp3
[08-11-19 20:11:06.9686] Slim::Player::Song::getNextSong (178) rhapd://Tra.14176888.mp3
[08-11-19 20:11:06.9694] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_getTrackInfo (411) Getting next track playback info from SN
[08-11-19 20:11:06.9816] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: ReadyToStream - new state PLAYING-TRACKWAIT
[08-11-19 20:11:07.5345] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:07.6686] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (783) Logging returned: 1
[08-11-19 20:11:08.0040] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:08.0053] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:08.5354] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:09.5321] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:10.1409] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (388) getTrackInfo ok: {
  account => {
        cobrandId => 40_134,
        logon => "money-shopping\@jbdotat.fastmail.fm",
        playbackSessionId => "1227144918125:money-shopping\@jbdotat.fastmail.fm:40134",
      },
  mediaUrl => "http://llnw-1178.listen.com/7/8/3/1/4/121741387.rad",
  trackMetadata => {
        albumId => "Alb.14174725",
        artistId => "Art.7243017",
        discIndex => 1,
        displayAlbumName => "5:55",
        displayArtistName => "Charlotte Gainsbourg",
        genreId => "g.169",
        name => "Everything I Cannot See",
        playbackSeconds => 345,
        price => undef,
        rightFlags => 574,
        trackId => "Tra.14176888",
        trackIndex => 10,
      },
  trackPlaybackFormat => { bitRate => 192, "format" => "RAD MP3", radVersion => 3 },
}
[08-11-19 20:11:10.2216] Slim::Player::StreamingController::_nextTrackReady (633) 00:04:20:06:be:04: nextTrack will be index 9
[08-11-19 20:11:10.2223] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady
[08-11-19 20:11:10.2227] Slim::Player::StreamingController::_Stream (894) 00:04:20:06:be:04: preparing to stream song index 9
[08-11-19 20:11:10.2230] Slim::Player::StreamingController::_Stream (899) Song queue is now 9,8
[08-11-19 20:11:10.2237] Slim::Player::Song::open (302) rhapd://Tra.14176888.mp3
[08-11-19 20:11:10.2249] Slim::Player::Song::open (323) seek=false time=0 canSeek=1
[08-11-19 20:11:10.2258] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mp3, squeezebox2 = 00:04:20:06:be:04
[08-11-19 20:11:10.2262] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled
[08-11-19 20:11:10.2265] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wma-squeezebox2-00:04:20:06:be:04
[08-11-19 20:11:10.2269] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wma-*-00:04:20:06:be:04
[08-11-19 20:11:10.2272] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wma-squeezebox2-*
[08-11-19 20:11:10.2275] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wma-*-*
[08-11-19 20:11:10.2278] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezebox2-00:04:20:06:be:04
[08-11-19 20:11:10.2281] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-00:04:20:06:be:04
[08-11-19 20:11:10.2284] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezebox2-*
[08-11-19 20:11:10.2287] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-*
[08-11-19 20:11:10.2290] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezebox2-00:04:20:06:be:04
[08-11-19 20:11:10.2293] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-00:04:20:06:be:04
[08-11-19 20:11:10.2297] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezebox2-*
[08-11-19 20:11:10.2300] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-*
[08-11-19 20:11:10.2303] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezebox2-00:04:20:06:be:04
[08-11-19 20:11:10.2306] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-00:04:20:06:be:04
[08-11-19 20:11:10.2309] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezebox2-*
[08-11-19 20:11:10.2312] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-*
[08-11-19 20:11:10.2315] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezebox2-00:04:20:06:be:04
[08-11-19 20:11:10.2318] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-00:04:20:06:be:04
[08-11-19 20:11:10.2321] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezebox2-*
[08-11-19 20:11:10.2324] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-*
[08-11-19 20:11:10.2327] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezebox2-00:04:20:06:be:04
[08-11-19 20:11:10.2330] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-00:04:20:06:be:04
[08-11-19 20:11:10.2333] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezebox2-*
[08-11-19 20:11:10.2337] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-*
[08-11-19 20:11:10.2341] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled
[08-11-19 20:11:10.2344] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-19 20:11:10.2347] Slim::Player::TranscodingHelper::checkBin (237)   Found command: -
[08-11-19 20:11:10.2350] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: mp3->mp3 via: -
[08-11-19 20:11:10.2354] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=mp3
[08-11-19 20:11:10.2358] Slim::Player::Song::open (354) URL supports direct streaming [rhapd://Tra.14176888.mp3->http://llnw-1178.listen.com/7/8/3/1/4/121741387.rad]
[08-11-19 20:11:10.2395] Slim::Player::SongStreamController::new (32) live=2
[08-11-19 20:11:10.2403] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-19 20:11:10.2406] Slim::Player::StreamingController::_Stream (937) 00:04:20:06:be:04: stream
[08-11-19 20:11:10.2410] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onStream (485) 00:04:20:06:be:04 Sending playback information: Tra.14176888 / money-shopping@jbdotat.fastmail.fm / 40134 / 1227144918125:money-shopping@jbdotat.fastmail.fm:40134
[08-11-19 20:11:10.2463] Slim::Player::Squeezebox::stream_s (709) This player supports direct streaming for http://llnw-1178.listen.com/7/8/3/1/4/121741387.rad as http://llnw-1178.listen.com/7/8/3/1/4/121741387.rad, let's do it.
[08-11-19 20:11:10.2536] Slim::Player::Squeezebox::stream_s (747) setting up direct stream (1150175263:80) autostart: 3.
[08-11-19 20:11:10.2542] Slim::Player::Squeezebox::stream_s (748) request string: GET /7/8/3/1/4/121741387.rad HTTP/1.0
Cache-Control: no-cache
Connection: close
Accept: */*
Host: llnw-1178.listen.com
User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1252) SqueezeCenter/7.3/23935
Icy-Metadata: 1

[08-11-19 20:11:10.2607] Slim::Player::StreamingController::_Stream (966) Song queue is now 9,8
[08-11-19 20:11:10.2612] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-19 20:11:10.2616] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: NextTrackReady - new state PLAYING-STREAMING
[08-11-19 20:11:10.2640] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:10.2668] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:10.2682] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:10.2840] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:10.4021] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:10.4030] Slim::Player::Squeezebox2::directHeaders (388) Processing headers for direct streaming:
HTTP/1.0 200 OK
Date: Thu, 20 Nov 2008 02:11:09 GMT
Server: Apache
Last-Modified: Thu, 31 Jul 2008 05:30:47 GMT
Accept-Ranges: bytes
Content-Length: 8240716
Content-Type: text/plain
Connection: close

[08-11-19 20:11:10.4036] Slim::Player::Squeezebox2::directHeaders (455) Processing 7 headers
[08-11-19 20:11:10.4040] Slim::Player::Squeezebox2::directHeaders (461) Calling Slim::Plugin::RhapsodyDirect::ProtocolHandler ::parseDirectHeaders
[08-11-19 20:11:10.4043] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Date: Thu, 20 Nov 2008 02:11:09 GMT
[08-11-19 20:11:10.4046] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Server: Apache
[08-11-19 20:11:10.4049] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Last-Modified: Thu, 31 Jul 2008 05:30:47 GMT
[08-11-19 20:11:10.4053] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Accept-Ranges: bytes
[08-11-19 20:11:10.4056] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Content-Length: 8240716
[08-11-19 20:11:10.4067] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Content-Type: text/plain
[08-11-19 20:11:10.4070] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Connection: close
[08-11-19 20:11:10.4679] Slim::Player::Client::streamingProgressBar (1127) url=http://llnw-1178.listen.com/7/8/3/1/4/121741387.rad, duration=343.363, bitrate=undef, contentLength=undef
[08-11-19 20:11:10.4793] Slim::Player::Client::streamingProgressBar (1161) Duration of stream set to 343.363 seconds
[08-11-19 20:11:10.4797] Slim::Player::Squeezebox2::directHeaders (519) Got a stream type: mp3 bitrate: 192000 title: 
[08-11-19 20:11:10.4804] Slim::Player::Squeezebox2::directHeaders (567) Beginning direct stream!
[08-11-19 20:11:10.5334] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:11.5354] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:12.5601] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:13.0038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:13.0051] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:13.5591] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:14.5612] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:15.5591] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:16.5548] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:16.9335] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:06:be:04
[08-11-19 20:11:16.9340] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-19 20:11:16.9343] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-19 20:11:16.9347] Slim::Player::StreamingController::_Playing (342) Song 8 is not longer in the queue
[08-11-19 20:11:16.9352] Slim::Player::Song::DESTROY (111) live=1: index=8, url=rhapd://Tra.14176887.mp3
[08-11-19 20:11:16.9363] Slim::Player::StreamingController::_Playing (348) Song 9 has now started playing
[08-11-19 20:11:16.9382] Slim::Player::StreamingController::_Playing (375) Song queue is now 9
[08-11-19 20:11:17.5544] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:18.0203] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:18.0215] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:18.5477] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:18.7271] Slim::Player::StreamingController::playerOutputUnderrun (1624) 00:04:20:06:be:04: decoder: 1925976 / output: 0
[08-11-19 20:11:18.7275] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: OutputUnderrun in PLAYING-STREAMING -> Slim::Player::StreamingController::_Rebuffer
[08-11-19 20:11:18.7290] Slim::Player::StreamingController::_setPlayingState (1747) new playing state BUFFERING
[08-11-19 20:11:18.7729] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: OutputUnderrun - new state BUFFERING-STREAMING
[08-11-19 20:11:18.8379] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:11:18.8391] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:11:18.9111] Slim::Player::Player::_buffering (1169) Buffering... 1925976 / 120000
[08-11-19 20:11:18.9115] Slim::Player::StreamingController::playerBufferReady (1656) 00:04:20:06:be:04
[08-11-19 20:11:18.9119] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: BufferReady in BUFFERING-STREAMING -> Slim::Player::StreamingController::_WaitToSync
[08-11-19 20:11:18.9125] Slim::Player::StreamingController::_setPlayingState (1747) new playing state WAITING_TO_SYNC
[08-11-19 20:11:18.9334] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-19 20:11:18.9627] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: BufferReady - new state PLAYING-STREAMING
[08-11-19 20:11:18.9721] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:18.9741] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:18.9753] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:18.9760] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:19.0241] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:19.0826] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:19.1448] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:19.2090] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:19.2717] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:23.0037] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:23.0049] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:28.0175] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:28.0187] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:33.0195] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:33.0208] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:38.0081] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:38.0102] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:38.8848] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:38.9021] Slim::Player::StreamingController::playerOutputUnderrun (1624) 00:04:20:06:be:04: decoder: 3142560 / output: 0
[08-11-19 20:11:38.9025] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: OutputUnderrun in PLAYING-STREAMING -> Slim::Player::StreamingController::_Rebuffer
[08-11-19 20:11:38.9029] Slim::Player::StreamingController::_setPlayingState (1747) new playing state BUFFERING
[08-11-19 20:11:38.9098] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: OutputUnderrun - new state BUFFERING-STREAMING
[08-11-19 20:11:38.9110] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:11:38.9117] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:11:39.0471] Slim::Player::Player::_buffering (1169) Buffering... 3142560 / 120000
[08-11-19 20:11:39.0476] Slim::Player::StreamingController::playerBufferReady (1656) 00:04:20:06:be:04
[08-11-19 20:11:39.0479] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: BufferReady in BUFFERING-STREAMING -> Slim::Player::StreamingController::_WaitToSync
[08-11-19 20:11:39.0483] Slim::Player::StreamingController::_setPlayingState (1747) new playing state WAITING_TO_SYNC
[08-11-19 20:11:39.0486] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-19 20:11:39.0505] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: BufferReady - new state PLAYING-STREAMING
[08-11-19 20:11:39.0607] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.0616] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.0629] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.0636] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.1137] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.2084] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.2385] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.2944] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.3565] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:39.4196] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:43.0187] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:43.0200] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:48.1213] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:48.1227] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:53.0159] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:53.0175] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:58.0184] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:11:58.0196] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:00.7042] Slim::Player::StreamingController::playerOutputUnderrun (1624) 00:04:20:06:be:04: decoder: 3142256 / output: 0
[08-11-19 20:12:00.7046] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: OutputUnderrun in PLAYING-STREAMING -> Slim::Player::StreamingController::_Rebuffer
[08-11-19 20:12:00.7050] Slim::Player::StreamingController::_setPlayingState (1747) new playing state BUFFERING
[08-11-19 20:12:00.7110] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: OutputUnderrun - new state BUFFERING-STREAMING
[08-11-19 20:12:00.8036] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:00.8044] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:00.9656] Slim::Player::Player::_buffering (1169) Buffering... 3145160 / 120000
[08-11-19 20:12:00.9661] Slim::Player::StreamingController::playerBufferReady (1656) 00:04:20:06:be:04
[08-11-19 20:12:00.9667] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: BufferReady in BUFFERING-STREAMING -> Slim::Player::StreamingController::_WaitToSync
[08-11-19 20:12:00.9671] Slim::Player::StreamingController::_setPlayingState (1747) new playing state WAITING_TO_SYNC
[08-11-19 20:12:00.9674] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-19 20:12:00.9693] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: BufferReady - new state PLAYING-STREAMING
[08-11-19 20:12:00.9799] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:00.9809] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:00.9816] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:00.9846] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:01.0926] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:01.0966] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:01.1560] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:01.2593] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:01.3101] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:03.0040] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:03.0052] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:03.6885] Slim::Player::StreamingController::playerOutputUnderrun (1624) 00:04:20:06:be:04: decoder: 3141504 / output: 0
[08-11-19 20:12:03.6889] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: OutputUnderrun in PLAYING-STREAMING -> Slim::Player::StreamingController::_Rebuffer
[08-11-19 20:12:03.6893] Slim::Player::StreamingController::_setPlayingState (1747) new playing state BUFFERING
[08-11-19 20:12:03.7090] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: OutputUnderrun - new state BUFFERING-STREAMING
[08-11-19 20:12:03.7572] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:03.7580] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:03.8274] Slim::Player::Player::_buffering (1169) Buffering... 3144408 / 120000
[08-11-19 20:12:03.8278] Slim::Player::StreamingController::playerBufferReady (1656) 00:04:20:06:be:04
[08-11-19 20:12:03.8282] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: BufferReady in BUFFERING-STREAMING -> Slim::Player::StreamingController::_WaitToSync
[08-11-19 20:12:03.8285] Slim::Player::StreamingController::_setPlayingState (1747) new playing state WAITING_TO_SYNC
[08-11-19 20:12:03.8289] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-19 20:12:03.8306] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: BufferReady - new state PLAYING-STREAMING
[08-11-19 20:12:03.9027] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:03.9047] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:03.9055] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:03.9062] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:03.9070] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:04.0063] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:04.3224] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:08.0038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:08.0051] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:13.0041] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:13.0056] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:14.5955] Slim::Player::StreamingController::playerOutputUnderrun (1624) 00:04:20:06:be:04: decoder: 3142588 / output: 0
[08-11-19 20:12:14.5960] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: OutputUnderrun in PLAYING-STREAMING -> Slim::Player::StreamingController::_Rebuffer
[08-11-19 20:12:14.5964] Slim::Player::StreamingController::_setPlayingState (1747) new playing state BUFFERING
[08-11-19 20:12:14.6018] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: OutputUnderrun - new state BUFFERING-STREAMING
[08-11-19 20:12:14.6031] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:14.6038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:14.7346] Slim::Player::Player::_buffering (1169) Buffering... 3142588 / 120000
[08-11-19 20:12:14.7350] Slim::Player::StreamingController::playerBufferReady (1656) 00:04:20:06:be:04
[08-11-19 20:12:14.7354] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: BufferReady in BUFFERING-STREAMING -> Slim::Player::StreamingController::_WaitToSync
[08-11-19 20:12:14.7357] Slim::Player::StreamingController::_setPlayingState (1747) new playing state WAITING_TO_SYNC
[08-11-19 20:12:14.7361] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-19 20:12:14.7379] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: BufferReady - new state PLAYING-STREAMING
[08-11-19 20:12:14.7477] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:14.7486] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:14.7493] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:14.7508] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:14.8000] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:14.8625] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:14.9262] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:14.9876] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:15.0063] Slim::Player::StreamingController::playerEndOfStream (1664) 00:04:20:06:be:04
[08-11-19 20:12:15.0067] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: EndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_AutoStart
[08-11-19 20:12:15.0071] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-19 20:12:15.0075] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: EndOfStream - new state PLAYING-STREAMOUT
[08-11-19 20:12:15.0507] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:15.1132] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:18.0042] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:18.0054] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:23.0542] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:23.0555] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:28.0034] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:28.0046] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:33.0183] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:33.0195] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:38.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:38.0052] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:43.0186] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:43.0199] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:48.0050] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:48.0062] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:52.3873] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:06:be:04
[08-11-19 20:12:52.3878] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onPlayout (747) onPlayout, logging playback
[08-11-19 20:12:52.3885] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_doLog (797) Logging track playback: 343 seconds, trackId: Tra.14176888, stationId: 
[08-11-19 20:12:52.3921] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-19 20:12:52.3925] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-19 20:12:52.3930] Slim::Player::StreamingController::nextsong (741) The next song is number 10, was 9
[08-11-19 20:12:52.3986] Slim::Player::Song::new (64) index 10 -> rhapd://Tra.14176889.mp3
[08-11-19 20:12:52.3995] Slim::Player::Song::new (101) live=2
[08-11-19 20:12:52.3998] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state TRACKWAIT
[08-11-19 20:12:52.4002] Slim::Player::Song::getNextSong (178) rhapd://Tra.14176889.mp3
[08-11-19 20:12:52.4007] Slim::Player::Song::getNextSong (200) scanning URL rhapd://Tra.14176889.mp3
[08-11-19 20:12:52.4012] Slim::Player::Song::getNextSong (178) rhapd://Tra.14176889.mp3
[08-11-19 20:12:52.4020] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_getTrackInfo (411) Getting next track playback info from SN
[08-11-19 20:12:52.4193] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: ReadyToStream - new state PLAYING-TRACKWAIT
[08-11-19 20:12:52.4600] Slim::Player::StreamingController::playerStopped (1567) 00:04:20:06:be:04
[08-11-19 20:12:52.4605] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: Stopped in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayIfReady
[08-11-19 20:12:52.4608] Slim::Player::StreamingController::_setPlayingState (1747) new playing state STOPPED
[08-11-19 20:12:52.4612] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: Stopped - new state STOPPED-TRACKWAIT
[08-11-19 20:12:52.8762] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (783) Logging returned: 1
[08-11-19 20:12:53.0184] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:53.0195] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.1499] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (388) getTrackInfo ok: {
  account => {
        cobrandId => 40_134,
        logon => "money-shopping\@jbdotat.fastmail.fm",
        playbackSessionId => "1227144918125:money-shopping\@jbdotat.fastmail.fm:40134",
      },
  mediaUrl => "http://llnw-1115.listen.com/1/5/5/7/3/121737551.rad",
  trackMetadata => {
        albumId => "Alb.14174725",
        artistId => "Art.7243017",
        discIndex => 1,
        displayAlbumName => "5:55",
        displayArtistName => "Charlotte Gainsbourg",
        genreId => "g.169",
        name => "Morning Song",
        playbackSeconds => 188,
        price => undef,
        rightFlags => 574,
        trackId => "Tra.14176889",
        trackIndex => 11,
      },
  trackPlaybackFormat => { bitRate => 192, "format" => "RAD MP3", radVersion => 3 },
}
[08-11-19 20:12:55.2305] Slim::Player::StreamingController::_nextTrackReady (633) 00:04:20:06:be:04: nextTrack will be index 10
[08-11-19 20:12:55.2311] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: NextTrackReady in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_Stream
[08-11-19 20:12:55.2314] Slim::Player::StreamingController::_Stream (894) 00:04:20:06:be:04: preparing to stream song index 10
[08-11-19 20:12:55.2318] Slim::Player::StreamingController::_Stream (899) Song queue is now 10,9
[08-11-19 20:12:55.2326] Slim::Player::Song::open (302) rhapd://Tra.14176889.mp3
[08-11-19 20:12:55.2338] Slim::Player::Song::open (323) seek=false time=0 canSeek=1
[08-11-19 20:12:55.2347] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mp3, squeezebox2 = 00:04:20:06:be:04
[08-11-19 20:12:55.2351] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled
[08-11-19 20:12:55.2355] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wma-squeezebox2-00:04:20:06:be:04
[08-11-19 20:12:55.2358] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wma-*-00:04:20:06:be:04
[08-11-19 20:12:55.2361] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wma-squeezebox2-*
[08-11-19 20:12:55.2364] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wma-*-*
[08-11-19 20:12:55.2370] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezebox2-00:04:20:06:be:04
[08-11-19 20:12:55.2374] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-00:04:20:06:be:04
[08-11-19 20:12:55.2377] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezebox2-*
[08-11-19 20:12:55.2380] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-*
[08-11-19 20:12:55.2383] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezebox2-00:04:20:06:be:04
[08-11-19 20:12:55.2386] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-00:04:20:06:be:04
[08-11-19 20:12:55.2393] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezebox2-*
[08-11-19 20:12:55.2396] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-*
[08-11-19 20:12:55.2399] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezebox2-00:04:20:06:be:04
[08-11-19 20:12:55.2402] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-00:04:20:06:be:04
[08-11-19 20:12:55.2405] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezebox2-*
[08-11-19 20:12:55.2408] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-*
[08-11-19 20:12:55.2411] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezebox2-00:04:20:06:be:04
[08-11-19 20:12:55.2415] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-00:04:20:06:be:04
[08-11-19 20:12:55.2418] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezebox2-*
[08-11-19 20:12:55.2421] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-*
[08-11-19 20:12:55.2424] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezebox2-00:04:20:06:be:04
[08-11-19 20:12:55.2427] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-00:04:20:06:be:04
[08-11-19 20:12:55.2430] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezebox2-*
[08-11-19 20:12:55.2433] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-*
[08-11-19 20:12:55.2436] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled
[08-11-19 20:12:55.2439] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-19 20:12:55.2442] Slim::Player::TranscodingHelper::checkBin (237)   Found command: -
[08-11-19 20:12:55.2446] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: mp3->mp3 via: -
[08-11-19 20:12:55.2449] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=mp3
[08-11-19 20:12:55.2454] Slim::Player::Song::open (354) URL supports direct streaming [rhapd://Tra.14176889.mp3->http://llnw-1115.listen.com/1/5/5/7/3/121737551.rad]
[08-11-19 20:12:55.2493] Slim::Player::SongStreamController::new (32) live=2
[08-11-19 20:12:55.2500] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-19 20:12:55.2509] Slim::Player::StreamingController::_Stream (937) 00:04:20:06:be:04: stream
[08-11-19 20:12:55.2514] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onStream (485) 00:04:20:06:be:04 Sending playback information: Tra.14176889 / money-shopping@jbdotat.fastmail.fm / 40134 / 1227144918125:money-shopping@jbdotat.fastmail.fm:40134
[08-11-19 20:12:55.2589] Slim::Player::Squeezebox::stream_s (709) This player supports direct streaming for http://llnw-1115.listen.com/1/5/5/7/3/121737551.rad as http://llnw-1115.listen.com/1/5/5/7/3/121737551.rad, let's do it.
[08-11-19 20:12:55.2681] Slim::Player::Squeezebox::stream_s (747) setting up direct stream (3496975761:80) autostart: 3.
[08-11-19 20:12:55.2685] Slim::Player::Squeezebox::stream_s (748) request string: GET /1/5/5/7/3/121737551.rad HTTP/1.0
Cache-Control: no-cache
Connection: close
Accept: */*
Host: llnw-1115.listen.com
User-Agent: iTunes/4.7.1 (Windows; N; Windows XP; 586; EN; cp1252) SqueezeCenter/7.3/23935
Icy-Metadata: 1

[08-11-19 20:12:55.2769] Slim::Player::StreamingController::_Stream (966) Song queue is now 10,9
[08-11-19 20:12:55.2775] Slim::Player::StreamingController::_setPlayingState (1747) new playing state BUFFERING
[08-11-19 20:12:55.2778] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-19 20:12:55.2782] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: NextTrackReady - new state BUFFERING-STREAMING
[08-11-19 20:12:55.2809] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.2817] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.2846] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.2863] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.2936] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.3963] Slim::Player::Player::_buffering (1169) Buffering... 0 / 20480
[08-11-19 20:12:55.4025] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.4037] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.4368] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.4379] Slim::Player::Squeezebox2::directHeaders (388) Processing headers for direct streaming:
HTTP/1.0 200 OK
Server: Apache/2.2.9
Accept-Ranges: bytes
Content-Length: 4483364
Content-Type: text/plain
Date: Thu, 20 Nov 2008 02:12:54 GMT
Last-Modified: Thu, 31 Jul 2008 04:50:14 GMT
Connection: close

[08-11-19 20:12:55.4385] Slim::Player::Squeezebox2::directHeaders (455) Processing 7 headers
[08-11-19 20:12:55.4388] Slim::Player::Squeezebox2::directHeaders (461) Calling Slim::Plugin::RhapsodyDirect::ProtocolHandler ::parseDirectHeaders
[08-11-19 20:12:55.4392] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Server: Apache/2.2.9
[08-11-19 20:12:55.4395] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Accept-Ranges: bytes
[08-11-19 20:12:55.4398] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Content-Length: 4483364
[08-11-19 20:12:55.4401] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Content-Type: text/plain
[08-11-19 20:12:55.4404] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Date: Thu, 20 Nov 2008 02:12:54 GMT
[08-11-19 20:12:55.4407] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Last-Modified: Thu, 31 Jul 2008 04:50:14 GMT
[08-11-19 20:12:55.4410] Slim::Plugin::RhapsodyDirect::ProtocolHandler::parseDirectHeaders (128) RhapsodyDirect header: Connection: close
[08-11-19 20:12:55.4620] Slim::Player::Client::streamingProgressBar (1127) url=http://llnw-1115.listen.com/1/5/5/7/3/121737551.rad, duration=186.807, bitrate=undef, contentLength=undef
[08-11-19 20:12:55.4730] Slim::Player::Client::streamingProgressBar (1161) Duration of stream set to 186.807 seconds
[08-11-19 20:12:55.4750] Slim::Player::Squeezebox2::directHeaders (519) Got a stream type: mp3 bitrate: 192000 title: 
[08-11-19 20:12:55.4757] Slim::Player::Squeezebox2::directHeaders (567) Beginning direct stream!
[08-11-19 20:12:55.7039] Slim::Player::Player::_buffering (1169) Buffering... 0 / 20480
[08-11-19 20:12:55.7699] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.7711] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.9372] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[08-11-19 20:12:55.9443] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:06:be:04
[08-11-19 20:12:55.9447] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: Started in BUFFERING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-19 20:12:55.9451] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-19 20:12:55.9454] Slim::Player::StreamingController::_Playing (342) Song 9 is not longer in the queue
[08-11-19 20:12:55.9459] Slim::Player::Song::DESTROY (111) live=1: index=9, url=rhapd://Tra.14176888.mp3
[08-11-19 20:12:55.9472] Slim::Player::StreamingController::_Playing (348) Song 10 has now started playing
[08-11-19 20:12:55.9486] Slim::Player::StreamingController::_Playing (375) Song queue is now 10
[08-11-19 20:12:55.9490] Slim::Player::StreamingController::_eventAction (297) 00:04:20:06:be:04: Started - new state PLAYING-STREAMING
[08-11-19 20:12:56.9357] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:57.9363] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:58.0038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:58.0054] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-19 20:12:58.9355] Slim::Player::StreamingController::_eventAction (265) 00:04:20:06:be:04: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync