I started the stream at 20:05.  The log file is pretty long:

[09-01-15 20:05:34.3092] Slim::Networking::Async::DNS::resolve (186)
Starting async DNS lookup for [www.bbc.co.uk] using server(s)
[10.0.1.1]
[09-01-15 20:05:34.3219] Slim::Networking::Async::DNS::_dns_read (299)
Resolved www.bbc.co.uk to 212.58.251.197 (ttl 193), request took 12 ms
[09-01-15 20:05:35.1701] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:36.1743] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:36.6822] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:37.1522] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:38.1594] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:38.4440] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:39.0964] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:39.4375] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:40.3216] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:44.3334] Slim::Player::StreamingController::stop (1543)
00:04:20:16:b3:c0
[09-01-15 20:05:44.3341] Slim::Player::Source::playmode (172)
00:04:20:16:6d:32: Current playmode: stop
[09-01-15 20:05:52.4424] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:53.2184] Slim::Player::StreamingController::stop (1543)
00:04:20:16:b3:c0
[09-01-15 20:05:53.2189] Slim::Player::Source::playmode (172)
00:04:20:16:6d:32: Current playmode: stop
[09-01-15 20:05:53.2228]
Slim::Player::StreamingController::playerActive (1469)
00:04:20:16:b3:c0 sync group now has:
00:04:20:16:b5:f3,00:04:20:16:b3:c0,00:04:20:16:6d:32,00:04:20:16:b5:1f
[09-01-15 20:05:53.2230]
Slim::Player::StreamingController::playerActive (1470)
00:04:20:16:b3:c0 active players are:
00:04:20:16:b3:c0,00:04:20:16:6d:32
[09-01-15 20:05:53.2234] Slim::Player::StreamingController::play (1546)
00:04:20:16:b3:c0
[09-01-15 20:05:53.2245] Slim::Player::StreamingController::_Stop (532)
Song queue is now 0
[09-01-15 20:05:53.2247]
Slim::Player::StreamingController::_setPlayingState (1779) new playing
state STOPPED
[09-01-15 20:05:53.2249]
Slim::Player::StreamingController::_setStreamingState (1792) new
streaming state IDLE
[09-01-15 20:05:53.2295] Slim::Player::Song::new (64) index 0 ->
http://www.bbc.co.uk/iplayer/aod/playlists/h3/zd/g0/0b/RadioBridge_intl_1415_bbc_radio_fourfm.ram
[09-01-15 20:05:53.2299]
Slim::Player::StreamingController::_setStreamingState (1792) new
streaming state TRACKWAIT
[09-01-15 20:05:53.2302] Slim::Player::Song::getNextSong (178)
http://www.bbc.co.uk/iplayer/aod/playlists/h3/zd/g0/0b/RadioBridge_intl_1415_bbc_radio_fourfm.ram
[09-01-15 20:05:53.2304] Slim::Player::Song::getNextSong (200) scanning
URL
http://www.bbc.co.uk/iplayer/aod/playlists/h3/zd/g0/0b/RadioBridge_intl_1415_bbc_radio_fourfm.ram
[09-01-15 20:05:53.2345] Slim::Networking::Async::DNS::resolve (159)
Using cached DNS response 212.58.251.197 for www.bbc.co.uk
[09-01-15 20:05:53.2486]
Slim::Player::StreamingController::_playersMessage (684) Fetching track
details...: Afternoon Play: The Further Adventures of Sherlock Holmes:
The Thirteen Watches 
[09-01-15 20:05:53.3544]
Slim::Networking::SqueezeNetwork::PrefSync::prefEvent (397) Client
prefEvent to sync: 00:04:20:16:6d:32 / server / power / 1
[09-01-15 20:05:53.4526] Slim::Networking::Async::DNS::resolve (186)
Starting async DNS lookup for [rmv8.bbc.net.uk] using server(s)
[10.0.1.1]
[09-01-15 20:05:53.5378] Slim::Networking::Async::DNS::_dns_read (299)
Resolved rmv8.bbc.net.uk to 212.58.252.5 (ttl 360), request took 84 ms
[09-01-15 20:05:53.5556] Slim::Player::Song::__ANON__ (215) Track
updated by scan:
http://www.bbc.co.uk/iplayer/aod/playlists/h3/zd/g0/0b/RadioBridge_intl_1415_bbc_radio_fourfm.ram
->
http://www.bbc.co.uk/iplayer/aod/playlists/h3/zd/g0/0b/RadioBridge_intl_1415_bbc_radio_fourfm.ram
[09-01-15 20:05:53.5559] Slim::Player::Song::__ANON__ (247) Found a
playlist
[09-01-15 20:05:53.5562] Slim::Player::Song::getNextSong (178)
http://www.bbc.co.uk/iplayer/aod/playlists/h3/zd/g0/0b/RadioBridge_intl_1415_bbc_radio_fourfm.ram
[09-01-15 20:05:53.5606] Slim::Player::Song::_getNextPlaylistTrack
(167) Got next URL from playlist; track is:
rtsp://rmv8.bbc.net.uk:554/radio4fmcoyopa/radio_4_fm_-_friday_1415.ra?timestamp=1231518633&pid=b00gdz3h&BBC-UID=f459336f20e00a21e2a92b35713a0d11a9fb6eb9d0b0914613a5152cdbe1539e&SSO2-UID=
[09-01-15 20:05:53.5610]
Slim::Player::StreamingController::_nextTrackReady (639)
00:04:20:16:b3:c0: nextTrack will be index 0
[09-01-15 20:05:53.5612] Slim::Player::StreamingController::_Stream
(913) 00:04:20:16:b3:c0: preparing to stream song index 0
[09-01-15 20:05:53.5614] Slim::Player::StreamingController::_Stream
(918) Song queue is now 0,0
[09-01-15 20:05:53.5617] Slim::Player::Song::open (302)
rtsp://rmv8.bbc.net.uk:554/radio4fmcoyopa/radio_4_fm_-_friday_1415.ra?timestamp=1231518633&pid=b00gdz3h&BBC-UID=f459336f20e00a21e2a92b35713a0d11a9fb6eb9d0b0914613a5152cdbe1539e&SSO2-UID=
[09-01-15 20:05:53.5638] Slim::Player::TranscodingHelper::checkBin
(260)    couldn't find binary for: lame
[09-01-15 20:05:53.5640]
Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't
find any command matches for type: rtsp
[09-01-15 20:05:53.5644] Slim::Player::Song::open (323) seek=false
time=0 canSeek=0SEEK_ERROR_RTSP_UNKNOWN_DURATION
[09-01-15 20:05:53.5655]
Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched:
rtsp->flc via: [mplayer.sh] -really-quiet -vc null -vo null -bandwidth
10000000 -cache 128 -af volume=0 -ao pcm:file=/dev/fd/3 $FILE$ | [flac]
-cs --totally-silent --compression-level-0 -
[09-01-15 20:05:53.5658] Slim::Player::Song::open (340) Transcoder:
streamMode=R, streamformat=flc
[09-01-15 20:05:53.5660] Slim::Player::Song::open (364) Opening stream
(no direct streaming) using Plugins::Alien::RTSP
[rtsp://rmv8.bbc.net.uk:554/radio4fmcoyopa/radio_4_fm_-_friday_1415.ra?timestamp=1231518633&pid=b00gdz3h&BBC-UID=f459336f20e00a21e2a92b35713a0d11a9fb6eb9d0b0914613a5152cdbe1539e&SSO2-UID=]
[09-01-15 20:05:53.5904] Slim::Player::Song::open (385) URL is a song
(audio):
rtsp://rmv8.bbc.net.uk:554/radio4fmcoyopa/radio_4_fm_-_friday_1415.ra?timestamp=1231518633&pid=b00gdz3h&BBC-UID=f459336f20e00a21e2a92b35713a0d11a9fb6eb9d0b0914613a5152cdbe1539e&SSO2-UID=,
type=flc
[09-01-15 20:05:53.5988] Slim::Player::StreamingController::_Stream
(956) 00:04:20:16:b3:c0: stream
[09-01-15 20:05:53.6044] Slim::Player::StreamingController::_Stream
(956) 00:04:20:16:6d:32: stream
[09-01-15 20:05:53.6065] Slim::Player::StreamingController::_Stream
(985) Song queue is now 0,0
[09-01-15 20:05:53.6072]
Slim::Player::StreamingController::_setPlayingState (1779) new playing
state BUFFERING
[09-01-15 20:05:53.6075]
Slim::Player::StreamingController::_setStreamingState (1792) new
streaming state STREAMING
[09-01-15 20:05:53.7654] Slim::Player::Player::_buffering (1172)
Buffering... 0 / 261120
[09-01-15 20:05:54.0661] Slim::Player::Player::_buffering (1172)
Buffering... 0 / 261120
[09-01-15 20:05:54.3668] Slim::Player::Player::_buffering (1172)
Buffering... 0 / 261120
[09-01-15 20:05:54.5105] Slim::Player::Source::_readNextChunk (499) end
of file or error on socket, song pos: 0
[09-01-15 20:05:54.5107] Slim::Player::Source::_readNextChunk (508)
Didn't stream any bytes for this song, so just mark it as played
[09-01-15 20:05:54.5109]
Slim::Player::StreamingController::playerTrackStarted (1613)
00:04:20:16:b3:c0
[09-01-15 20:05:54.5111]
Slim::Player::StreamingController::_setPlayingState (1779) new playing
state PLAYING
[09-01-15 20:05:54.5113] Slim::Player::StreamingController::_Playing
(346) Song 0 is not longer in the queue
[09-01-15 20:05:54.5117] Slim::Player::StreamingController::_Playing
(352) Song 0 has now started playing
[09-01-15 20:05:54.5126] Slim::Player::StreamingController::_Playing
(381) Song queue is now 0
[09-01-15 20:05:54.5128] Slim::Player::Source::_readNextChunk (515)
00:04:20:16:b3:c0 mark end of stream
[09-01-15 20:05:54.5130] Slim::Player::Source::_readNextChunk (515)
00:04:20:16:6d:32 mark end of stream
[09-01-15 20:05:54.5134]
Slim::Player::StreamingController::_setStreamingState (1792) new
streaming state STREAMOUT
[09-01-15 20:05:54.5171]
Slim::Networking::SqueezeNetwork::Stats::logRadio (145) Reporting play
of radio URL to SN:
http://www.bbc.co.uk/iplayer/aod/playlists/h3/zd/g0/0b/RadioBridge_intl_1415_bbc_radio_fourfm.ram,
duration: 300
[09-01-15 20:05:54.5256]
Slim::Player::StreamingController::playerEndOfStream (1688)
00:04:20:16:b3:c0
[09-01-15 20:05:54.5258]
Slim::Player::StreamingController::_setStreamingState (1792) new
streaming state STREAMOUT
[09-01-15 20:05:54.5263]
Slim::Player::StreamingController::playerReadyToStream (1628)
00:04:20:16:b3:c0
[09-01-15 20:05:54.5266]
Slim::Player::StreamingController::_setStreamingState (1792) new
streaming state IDLE
[09-01-15 20:05:54.5315] Slim::Player::StreamingController::nextsong
(747) The next song is number 0, was 0
[09-01-15 20:05:54.9167]
Slim::Player::StreamingController::playerEndOfStream (1688)
00:04:20:16:6d:32
[09-01-15 20:05:54.9233]
Slim::Player::StreamingController::playerReadyToStream (1628)
00:04:20:16:6d:32


-- 
lindburgh
------------------------------------------------------------------------
lindburgh's Profile: http://forums.slimdevices.com/member.php?userid=19256
View this thread: http://forums.slimdevices.com/showthread.php?t=58288

_______________________________________________
plugins mailing list
[email protected]
http://lists.slimdevices.com/lists/listinfo/plugins

Reply via email to