[09-11-29 11:00:20.4328] Slim::Player::Source::_readNextChunk (330) end of file or error on socket, song pos: 191419242
[09-11-29 11:00:20.4342] Slim::Player::Source::_readNextChunk (344) 00:04:20:10:11:0d mark end of stream
[09-11-29 11:00:20.4358] Slim::Player::StreamingController::_setStreamingState (2237) new streaming state STREAMOUT
[09-11-29 11:00:21.3375] Slim::Player::StreamingController::playerEndOfStream (2133) 00:04:20:10:11:0d
[09-11-29 11:00:21.3390] Slim::Player::StreamingController::_setStreamingState (2237) new streaming state STREAMOUT
[09-11-29 11:00:23.0448] Slim::Player::StreamingController::playerActive (1879) 00:04:20:10:11:0d sync group now has: 00:04:20:10:11:0d,00:04:20:22:00:94
[09-11-29 11:00:23.0461] Slim::Player::StreamingController::playerActive (1880) 00:04:20:10:11:0d active players are: 00:04:20:10:11:0d,00:04:20:22:00:94
[09-11-29 11:00:23.0475] Slim::Player::StreamingController::playerActive (1884) 00:04:20:10:11:0d restart play
[09-11-29 11:00:23.0600] Slim::Player::StreamingController::_Stop (607) Song queue is now 5
[09-11-29 11:00:23.0617] Slim::Player::StreamingController::_setPlayingState (2224) new playing state STOPPED
[09-11-29 11:00:23.0630] Slim::Player::StreamingController::_setStreamingState (2237) new streaming state IDLE
[09-11-29 11:00:23.0645] Slim::Player::StreamingController::_Stream (1088) 00:04:20:10:11:0d: got song from params, song index 5
[09-11-29 11:00:23.0659] Slim::Player::StreamingController::_Stream (1162) Song queue is now 5
[09-11-29 11:00:23.0673] Slim::Player::StreamingController::_Stream (1165) 00:04:20:10:11:0d: preparing to stream song index 5
[09-11-29 11:00:23.0693] Slim::Player::Song::open (362) file:///mnt/slugpublic/Media/Music/Lily%20Allen/Alright,%20Still/06%20Friday%20Night.m4a
[09-11-29 11:00:23.0767] Slim::Player::TranscodingHelper::checkBin (265)    couldn't find binary for: lame
[09-11-29 11:00:23.0781] Slim::Player::TranscodingHelper::getConvertCommand2 (421) Error: Didn't find any command matches for type: mp4
[09-11-29 11:00:23.0795] Slim::Player::Song::open (382) seek=true time=151.385 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4
[09-11-29 11:00:23.0829] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes -
[09-11-29 11:00:23.0843] Slim::Player::Song::open (403) Transcoder: streamMode=F, streamformat=flc
[09-11-29 11:00:23.0874] Slim::Player::Song::open (548) Tokenized command "/usr/share/squeezeboxserver/Bin/i386-linux/faad" -q -w -f 1 "/mnt/slugpublic/Media/Music/Lily Allen/Alright, Still/06 Friday Night.m4a" | "/usr/share/squeezeboxserver/Bin/i386-linux/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & |
[09-11-29 11:00:23.2478] Slim::Player::StreamingController::_Stream (1216) 00:04:20:10:11:0d: stream
[09-11-29 11:00:23.2516] Slim::Player::Transporter::play (120) Setting DigitalInput to 0 for [file:///mnt/slugpublic/Media/Music/Lily%20Allen/Alright,%20Still/06%20Friday%20Night.m4a]
[09-11-29 11:00:23.2532] Slim::Player::Transporter::setDigitalInput (203) Switching to digital input 0
[09-11-29 11:00:23.2704] Slim::Player::StreamingController::_Stream (1216) 00:04:20:22:00:94: stream
[09-11-29 11:00:23.2838] Slim::Player::StreamingController::_Stream (1247) Song queue is now 5
[09-11-29 11:00:23.2858] Slim::Player::StreamingController::_setPlayingState (2224) new playing state BUFFERING
[09-11-29 11:00:23.2874] Slim::Player::StreamingController::_setStreamingState (2237) new streaming state STREAMING
[09-11-29 11:00:24.2444] Slim::Player::StreamingController::playerBufferReady (2125) 00:04:20:10:11:0d
[09-11-29 11:00:24.2459] Slim::Player::StreamingController::_setPlayingState (2224) new playing state WAITING_TO_SYNC
[09-11-29 11:00:27.1180] Slim::Player::TranscodingHelper::checkBin (265)    couldn't find binary for: lame
[09-11-29 11:00:27.1193] Slim::Player::TranscodingHelper::getConvertCommand2 (421) Error: Didn't find any command matches for type: mp4
[09-11-29 11:00:27.4446] Slim::Player::StreamingController::playerBufferReady (2125) 00:04:20:22:00:94
[09-11-29 11:00:27.4473] Slim::Player::StreamingController::_setPlayingState (2224) new playing state PLAYING
[09-11-29 11:00:27.4490] Slim::Player::StreamingController::_Playing (361) Song 5 has now started playing
[09-11-29 11:00:27.4534] Slim::Player::StreamingController::_Playing (391) Song queue is now 5
[09-11-29 11:00:27.5534] Slim::Player::StreamingController::playerTrackStarted (2036) 00:04:20:10:11:0d
[09-11-29 11:00:27.7855] Slim::Player::TranscodingHelper::checkBin (265)    couldn't find binary for: lame
[09-11-29 11:00:27.7868] Slim::Player::TranscodingHelper::getConvertCommand2 (421) Error: Didn't find any command matches for type: mp4
[09-11-29 11:00:29.1012] Slim::Player::StreamingController::playerTrackStarted (2036) 00:04:20:22:00:94
[09-11-29 11:00:29.7989] Slim::Player::StreamingController::_CheckSync (563) 00:04:20:22:00:94 resync: skipAhead 1242ms
[09-11-29 11:00:37.0419] Slim::Web::Graphics::processCoverArtRequest (262) Error: Unable to resize plugins/cache/icons/radioworld_40x40_m.png: Can't call method "width" on an undefined value at /usr/share/perl5/Slim/Utils/ImageResizer.pm line 107.
[09-11-29 11:00:37.6816] Slim::Player::StreamingController::playerOutputUnderrun (2075) 00:04:20:22:00:94: decoder: 22544 / output: 0
[09-11-29 11:00:37.6830] Slim::Player::StreamingController::_setPlayingState (2224) new playing state BUFFERING
[09-11-29 11:00:37.8154] Slim::Player::Player::_buffering (1138) Buffering... 3145168 / 441000
[09-11-29 11:00:37.8166] Slim::Player::Player::_buffering (1139)   +output... 3491520 / 1764000
[09-11-29 11:00:37.8182] Slim::Player::StreamingController::playerBufferReady (2125) 00:04:20:10:11:0d
[09-11-29 11:00:37.8195] Slim::Player::StreamingController::_setPlayingState (2224) new playing state WAITING_TO_SYNC
[09-11-29 11:00:37.8433] Slim::Player::Player::_buffering (1138) Buffering... 22544 / 441000
[09-11-29 11:00:38.1594] Slim::Player::Player::_buffering (1138) Buffering... 22544 / 441000
[09-11-29 11:00:38.4684] Slim::Player::Player::_buffering (1138) Buffering... 22544 / 441000
[09-11-29 11:00:38.7202] Slim::Web::Graphics::processCoverArtRequest (262) Error: Unable to resize plugins/cache/icons/radiomusic_40x40_m.png: Can't call method "width" on an undefined value at /usr/share/perl5/Slim/Utils/ImageResizer.pm line 107.
[09-11-29 11:00:38.7784] Slim::Player::Player::_buffering (1138) Buffering... 18780 / 441000
[09-11-29 11:00:38.7797] Slim::Player::Player::_buffering (1139)   +output... 276480 / 1764000
[09-11-29 11:00:39.0884] Slim::Player::Player::_buffering (1138) Buffering... 18780 / 441000
[09-11-29 11:00:39.0897] Slim::Player::Player::_buffering (1139)   +output... 276480 / 1764000
[09-11-29 11:00:39.3984] Slim::Player::Player::_buffering (1138) Buffering... 18780 / 441000
[09-11-29 11:00:39.3997] Slim::Player::Player::_buffering (1139)   +output... 276480 / 1764000
[09-11-29 11:00:39.7085] Slim::Player::Player::_buffering (1138) Buffering... 19796 / 441000
[09-11-29 11:00:39.7097] Slim::Player::Player::_buffering (1139)   +output... 525312 / 1764000
[09-11-29 11:00:40.0184] Slim::Player::Player::_buffering (1138) Buffering... 19796 / 441000
[09-11-29 11:00:40.0196] Slim::Player::Player::_buffering (1139)   +output... 525312 / 1764000
[09-11-29 11:00:40.3284] Slim::Player::Player::_buffering (1138) Buffering... 19796 / 441000
[09-11-29 11:00:40.3296] Slim::Player::Player::_buffering (1139)   +output... 525312 / 1764000
[09-11-29 11:00:40.4515] Slim::Web::Graphics::processCoverArtRequest (262) Error: Unable to resize plugins/cache/icons/radiolocal_40x40_m.png: Can't call method "width" on an undefined value at /usr/share/perl5/Slim/Utils/ImageResizer.pm line 107.
[09-11-29 11:00:40.6416] Slim::Player::Player::_buffering (1138) Buffering... 20408 / 441000
[09-11-29 11:00:40.6430] Slim::Player::Player::_buffering (1139)   +output... 709632 / 1764000
[09-11-29 11:00:40.9584] Slim::Player::Player::_buffering (1138) Buffering... 20408 / 441000
[09-11-29 11:00:40.9596] Slim::Player::Player::_buffering (1139)   +output... 709632 / 1764000
[09-11-29 11:00:41.2684] Slim::Player::Player::_buffering (1138) Buffering... 20408 / 441000
[09-11-29 11:00:41.2697] Slim::Player::Player::_buffering (1139)   +output... 709632 / 1764000
[09-11-29 11:00:41.5785] Slim::Player::Player::_buffering (1138) Buffering... 23180 / 441000
[09-11-29 11:00:41.5797] Slim::Player::Player::_buffering (1139)   +output... 866304 / 1764000
[09-11-29 11:00:41.8884] Slim::Player::Player::_buffering (1138) Buffering... 23180 / 441000
[09-11-29 11:00:41.8896] Slim::Player::Player::_buffering (1139)   +output... 866304 / 1764000
[09-11-29 11:00:42.1984] Slim::Player::Player::_buffering (1138) Buffering... 23180 / 441000
[09-11-29 11:00:42.1997] Slim::Player::Player::_buffering (1139)   +output... 866304 / 1764000
[09-11-29 11:00:42.5084] Slim::Player::Player::_buffering (1138) Buffering... 23180 / 441000
[09-11-29 11:00:42.5097] Slim::Player::Player::_buffering (1139)   +output... 866304 / 1764000
[09-11-29 11:00:42.8185] Slim::Player::Player::_buffering (1138) Buffering... 20904 / 441000
[09-11-29 11:00:42.8197] Slim::Player::Player::_buffering (1139)   +output... 1078272 / 1764000
[09-11-29 11:00:43.1275] Slim::Player::Player::_buffering (1138) Buffering... 20904 / 441000
[09-11-29 11:00:43.1288] Slim::Player::Player::_buffering (1139)   +output... 1078272 / 1764000
[09-11-29 11:00:43.4384] Slim::Player::Player::_buffering (1138) Buffering... 20904 / 441000
[09-11-29 11:00:43.4398] Slim::Player::Player::_buffering (1139)   +output... 1078272 / 1764000
[09-11-29 11:00:43.7484] Slim::Player::Player::_buffering (1138) Buffering... 23712 / 441000
[09-11-29 11:00:43.7498] Slim::Player::Player::_buffering (1139)   +output... 1290240 / 1764000
[09-11-29 11:00:44.0584] Slim::Player::Player::_buffering (1138) Buffering... 23712 / 441000
[09-11-29 11:00:44.0597] Slim::Player::Player::_buffering (1139)   +output... 1290240 / 1764000
[09-11-29 11:00:44.3684] Slim::Player::Player::_buffering (1138) Buffering... 31748 / 441000
[09-11-29 11:00:44.3696] Slim::Player::Player::_buffering (1139)   +output... 1483776 / 1764000
[09-11-29 11:00:44.6784] Slim::Player::Player::_buffering (1138) Buffering... 31748 / 441000
[09-11-29 11:00:44.6797] Slim::Player::Player::_buffering (1139)   +output... 1483776 / 1764000
[09-11-29 11:00:44.9884] Slim::Player::Player::_buffering (1138) Buffering... 31748 / 441000
[09-11-29 11:00:44.9896] Slim::Player::Player::_buffering (1139)   +output... 1483776 / 1764000
[09-11-29 11:00:45.3267] Slim::Player::Player::_buffering (1138) Buffering... 21744 / 441000
[09-11-29 11:00:45.3280] Slim::Player::Player::_buffering (1139)   +output... 1640448 / 1764000
[09-11-29 11:00:45.6384] Slim::Player::Player::_buffering (1138) Buffering... 21744 / 441000
[09-11-29 11:00:45.6399] Slim::Player::Player::_buffering (1139)   +output... 1640448 / 1764000
[09-11-29 11:00:45.9484] Slim::Player::Player::_buffering (1138) Buffering... 22088 / 441000
[09-11-29 11:00:45.9496] Slim::Player::Player::_buffering (1139)   +output... 1880064 / 1764000
[09-11-29 11:00:45.9509] Slim::Player::StreamingController::playerBufferReady (2125) 00:04:20:22:00:94
[09-11-29 11:00:45.9524] Slim::Player::StreamingController::_setPlayingState (2224) new playing state PLAYING
[09-11-29 11:00:45.9731] Slim::Player::StreamingController::_CheckSync (563) 00:04:20:22:00:94 resync: skipAhead 270ms
[09-11-29 11:00:48.7990] Slim::Player::StreamingController::_CheckSync (563) 00:04:20:22:00:94 resync: skipAhead 996ms
[09-11-29 11:01:06.7460] Slim::Player::StreamingController::playerOutputUnderrun (2075) 00:04:20:22:00:94: decoder: 24400 / output: 0
[09-11-29 11:01:06.7475] Slim::Player::StreamingController::_setPlayingState (2224) new playing state BUFFERING
[09-11-29 11:01:06.8885] Slim::Player::Player::_buffering (1138) Buffering... 3145204 / 441000
[09-11-29 11:01:06.8897] Slim::Player::Player::_buffering (1139)   +output... 3490880 / 1764000
[09-11-29 11:01:06.8910] Slim::Player::StreamingController::playerBufferReady (2125) 00:04:20:10:11:0d
[09-11-29 11:01:06.8923] Slim::Player::StreamingController::_setPlayingState (2224) new playing state WAITING_TO_SYNC
[09-11-29 11:01:06.9158] Slim::Player::Player::_buffering (1138) Buffering... 24400 / 441000
[09-11-29 11:01:07.2285] Slim::Player::Player::_buffering (1138) Buffering... 24400 / 441000
[09-11-29 11:01:07.5519] Slim::Player::Player::_buffering (1138) Buffering... 19704 / 441000
[09-11-29 11:01:07.5531] Slim::Player::Player::_buffering (1139)   +output... 165888 / 1764000
[09-11-29 11:01:07.8685] Slim::Player::Player::_buffering (1138) Buffering... 19704 / 441000
[09-11-29 11:01:07.8697] Slim::Player::Player::_buffering (1139)   +output... 165888 / 1764000
[09-11-29 11:01:08.1785] Slim::Player::Player::_buffering (1138) Buffering... 21256 / 441000
[09-11-29 11:01:08.1797] Slim::Player::Player::_buffering (1139)   +output... 294912 / 1764000
[09-11-29 11:01:08.4884] Slim::Player::Player::_buffering (1138) Buffering... 24200 / 441000
[09-11-29 11:01:08.4896] Slim::Player::Player::_buffering (1139)   +output... 359424 / 1764000
[09-11-29 11:01:08.7985] Slim::Player::Player::_buffering (1138) Buffering... 91404 / 441000
[09-11-29 11:01:08.7997] Slim::Player::Player::_buffering (1139)   +output... 525312 / 1764000
[09-11-29 11:01:09.1086] Slim::Player::Player::_buffering (1138) Buffering... 91404 / 441000
[09-11-29 11:01:09.1098] Slim::Player::Player::_buffering (1139)   +output... 525312 / 1764000
[09-11-29 11:01:09.4185] Slim::Player::Player::_buffering (1138) Buffering... 398388 / 441000
[09-11-29 11:01:09.4198] Slim::Player::Player::_buffering (1139)   +output... 838656 / 1764000
[09-11-29 11:01:09.4211] Slim::Player::StreamingController::playerBufferReady (2125) 00:04:20:22:00:94
[09-11-29 11:01:09.4226] Slim::Player::StreamingController::_setPlayingState (2224) new playing state PLAYING
[09-11-29 11:01:09.4436] Slim::Player::StreamingController::_CheckSync (563) 00:04:20:10:11:0d resync: skipAhead 207ms
[09-11-29 11:01:11.8023] Slim::Player::StreamingController::_CheckSync (563) 00:04:20:22:00:94 resync: skipAhead 348ms