[10-03-25 08:25:19.5728] main::init (323) Starting Squeezebox Server (v7.5.0, r30409, Thu Mar 25 01:05:47 PDT 2010) perl 5.010000
[10-03-25 10:22:09.0578] Slim::Player::StreamingController::stop (1960) 00:04:20:22:19:0a
[10-03-25 10:22:09.0983] Slim::Player::StreamingController::resetSongqueue (1643) Song queue is now 
[10-03-25 10:22:09.3299] Slim::Player::StreamingController::play (1963) 00:04:20:22:19:0a
[10-03-25 10:22:09.4119] Slim::Player::StreamingController::_setPlayingState (2231) new playing state STOPPED
[10-03-25 10:22:09.4125] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state IDLE
[10-03-25 10:22:09.4797] Slim::Player::Song::new (107) index 0 -> file:///C:/Users/DTMLLUAdminUser/Music/01.mp4
[10-03-25 10:22:09.5060] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state TRACKWAIT
[10-03-25 10:22:09.5073] Slim::Player::Song::getNextSong (228) file:///C:/Users/DTMLLUAdminUser/Music/01.mp4
[10-03-25 10:22:09.5086] Slim::Player::StreamingController::_nextTrackReady (730) 00:04:20:22:19:0a: nextTrack will be index 0
[10-03-25 10:22:09.5350] Slim::Player::StreamingController::_Stream (1161) Song queue is now 0
[10-03-25 10:22:09.5354] Slim::Player::StreamingController::_Stream (1164) 00:04:20:22:19:0a: preparing to stream song index 0
[10-03-25 10:22:09.5358] Slim::Player::Song::open (362) file:///C:/Users/DTMLLUAdminUser/Music/01.mp4
[10-03-25 10:22:09.8278] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp4->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes -
[10-03-25 10:22:09.8284] Slim::Player::Song::open (386) seek=false time=0 canSeek=2
[10-03-25 10:22:09.8463] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp4->aac via: -
[10-03-25 10:22:09.8469] Slim::Player::Song::open (407) Transcoder: streamMode=I, streamformat=aac
[10-03-25 10:22:09.8624] Slim::Player::Song::open (455) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///C:/Users/DTMLLUAdminUser/Music/01.mp4]
[10-03-25 10:22:09.8891] Slim::Player::Protocols::File::open (78) duration: [219.043] size: [3479263] endian [] offset: [0] for file:///C:/Users/DTMLLUAdminUser/Music/01.mp4
[10-03-25 10:22:09.8897] Slim::Player::Protocols::File::open (95) Opening file C:\Users\DTMLLUAdminUser\Music\01.mp4
[10-03-25 10:22:09.8910] Slim::Player::Protocols::File::open (173) Seeking in 0 into C:\Users\DTMLLUAdminUser\Music\01.mp4
[10-03-25 10:22:09.8919] Slim::Player::Song::open (476) URL is a song (audio): file:///C:/Users/DTMLLUAdminUser/Music/01.mp4, type=mp4
[10-03-25 10:22:10.6349] Slim::Player::StreamingController::_Stream (1219) 00:04:20:22:19:0a: stream
[10-03-25 10:22:10.7088] Slim::Player::StreamingController::_Stream (1254) Song queue is now 0
[10-03-25 10:22:10.7096] Slim::Player::StreamingController::_setPlayingState (2231) new playing state BUFFERING
[10-03-25 10:22:10.7102] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMING
[10-03-25 10:22:11.9463] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp4->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes -
[10-03-25 10:22:13.4092] Slim::Player::StreamingController::playerTrackStarted (2043) 00:04:20:22:19:0a
[10-03-25 10:22:13.4099] Slim::Player::StreamingController::_setPlayingState (2231) new playing state PLAYING
[10-03-25 10:22:13.4108] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[10-03-25 10:22:13.4123] Slim::Player::StreamingController::_Playing (389) Song queue is now 0
[10-03-25 10:22:13.7605] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp4->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes -
[10-03-25 10:22:17.7167] Slim::Player::Protocols::File::sysread (218) Trying to read past the end of file: file:///C:/Users/DTMLLUAdminUser/Music/01.mp4
[10-03-25 10:22:17.7172] Slim::Player::Source::_readNextChunk (330) end of file or error on socket, song pos: 3479263, tell says: 3479263, totalbytes: 3479263
[10-03-25 10:22:17.7176] Slim::Player::Source::_readNextChunk (335) 00:04:20:22:19:0a mark end of stream
[10-03-25 10:22:17.7182] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMOUT
[10-03-25 10:22:22.9751] Slim::Player::StreamingController::playerEndOfStream (2140) 00:04:20:22:19:0a
[10-03-25 10:22:22.9755] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMOUT
[10-03-25 10:22:30.1878] Slim::Player::StreamingController::jumpToTime (2009) 00:04:20:22:19:0a
[10-03-25 10:22:30.1891] Slim::Player::StreamingController::_Stop (604) Song queue is now 0
[10-03-25 10:22:30.1895] Slim::Player::StreamingController::_setPlayingState (2231) new playing state STOPPED
[10-03-25 10:22:30.1898] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state IDLE
[10-03-25 10:22:30.1902] Slim::Player::StreamingController::_Stream (1087) 00:04:20:22:19:0a: got song from params, song index 0
[10-03-25 10:22:30.1906] Slim::Player::StreamingController::_Stream (1161) Song queue is now 0
[10-03-25 10:22:30.1911] Slim::Player::StreamingController::_Stream (1164) 00:04:20:22:19:0a: preparing to stream song index 0
[10-03-25 10:22:30.1916] Slim::Player::Song::open (362) file:///C:/Users/DTMLLUAdminUser/Music/01.mp4
[10-03-25 10:22:30.1930] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp4->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes -
[10-03-25 10:22:30.1934] Slim::Player::Song::open (386) seek=false time=0 canSeek=2
[10-03-25 10:22:30.1942] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp4->aac via: -
[10-03-25 10:22:30.1945] Slim::Player::Song::open (407) Transcoder: streamMode=I, streamformat=aac
[10-03-25 10:22:30.1949] Slim::Player::Song::open (455) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///C:/Users/DTMLLUAdminUser/Music/01.mp4]
[10-03-25 10:22:30.1962] Slim::Player::Protocols::File::open (78) duration: [219.043] size: [3479263] endian [] offset: [0] for file:///C:/Users/DTMLLUAdminUser/Music/01.mp4
[10-03-25 10:22:30.1965] Slim::Player::Protocols::File::open (95) Opening file C:\Users\DTMLLUAdminUser\Music\01.mp4
[10-03-25 10:22:30.1973] Slim::Player::Protocols::File::open (173) Seeking in 0 into C:\Users\DTMLLUAdminUser\Music\01.mp4
[10-03-25 10:22:30.1979] Slim::Player::Song::open (476) URL is a song (audio): file:///C:/Users/DTMLLUAdminUser/Music/01.mp4, type=mp4
[10-03-25 10:22:30.2285] Slim::Player::StreamingController::_Stream (1219) 00:04:20:22:19:0a: stream
[10-03-25 10:22:30.2306] Slim::Player::StreamingController::_Stream (1254) Song queue is now 0
[10-03-25 10:22:30.2310] Slim::Player::StreamingController::_setPlayingState (2231) new playing state BUFFERING
[10-03-25 10:22:30.2313] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMING
[10-03-25 10:22:30.2650] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp4->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes -
[10-03-25 10:22:30.4971] Slim::Player::Squeezebox2::statHandler (140) Error: 00:04:20:22:19:0a: Decoder does not support file format, code 0
[10-03-25 10:22:30.4975] Slim::Player::StreamingController::playerStreamingFailed (2102) 00:04:20:22:19:0a
[10-03-25 10:22:30.4981] Slim::Player::StreamingController::_playersMessage (774) Problem: Can't open file for:: file:///C:/Users/DTMLLUAdminUser/Music/01.mp4
[10-03-25 10:22:30.5001] Slim::Player::StreamingController::_Stop (604) Song queue is now 0
[10-03-25 10:22:30.5008] Slim::Player::StreamingController::_setPlayingState (2231) new playing state STOPPED
[10-03-25 10:22:30.5011] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state IDLE
[10-03-25 10:22:30.5017] Slim::Player::StreamingController::nextsong (842) The next song is number 1, was 0
[10-03-25 10:22:30.5065] Slim::Player::Song::new (107) index 1 -> file:///C:/Users/DTMLLUAdminUser/Music/02.flac
[10-03-25 10:22:30.5071] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state TRACKWAIT
[10-03-25 10:22:30.5075] Slim::Player::Song::getNextSong (228) file:///C:/Users/DTMLLUAdminUser/Music/02.flac
[10-03-25 10:22:30.5080] Slim::Player::StreamingController::_nextTrackReady (730) 00:04:20:22:19:0a: nextTrack will be index 1
[10-03-25 10:22:30.5084] Slim::Player::StreamingController::_Stream (1161) Song queue is now 1
[10-03-25 10:22:30.5087] Slim::Player::StreamingController::_Stream (1164) 00:04:20:22:19:0a: preparing to stream song index 1
[10-03-25 10:22:30.5093] Slim::Player::Song::open (362) file:///C:/Users/DTMLLUAdminUser/Music/02.flac
[10-03-25 10:22:30.6156] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: flc->flc via: -
[10-03-25 10:22:30.6160] Slim::Player::Song::open (386) seek=false time=0 canSeek=1
[10-03-25 10:22:30.6167] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: flc->flc via: -
[10-03-25 10:22:30.6171] Slim::Player::Song::open (407) Transcoder: streamMode=I, streamformat=flc
[10-03-25 10:22:30.6175] Slim::Player::Song::open (455) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///C:/Users/DTMLLUAdminUser/Music/02.flac]
[10-03-25 10:22:30.6185] Slim::Player::Protocols::File::open (78) duration: [31.2] size: [3149562] endian [] offset: [0] for file:///C:/Users/DTMLLUAdminUser/Music/02.flac
[10-03-25 10:22:30.6188] Slim::Player::Protocols::File::open (95) Opening file C:\Users\DTMLLUAdminUser\Music\02.flac
[10-03-25 10:22:30.6194] Slim::Player::Protocols::File::open (173) Seeking in 0 into C:\Users\DTMLLUAdminUser\Music\02.flac
[10-03-25 10:22:30.6199] Slim::Player::Song::open (476) URL is a song (audio): file:///C:/Users/DTMLLUAdminUser/Music/02.flac, type=flc
[10-03-25 10:22:30.6616] Slim::Player::StreamingController::_Stream (1219) 00:04:20:22:19:0a: stream
[10-03-25 10:22:30.6633] Slim::Player::StreamingController::_Stream (1254) Song queue is now 1
[10-03-25 10:22:30.6637] Slim::Player::StreamingController::_setPlayingState (2231) new playing state BUFFERING
[10-03-25 10:22:30.6640] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMING
[10-03-25 10:22:31.9647] Slim::Player::StreamingController::playerTrackStarted (2043) 00:04:20:22:19:0a
[10-03-25 10:22:31.9654] Slim::Player::StreamingController::_setPlayingState (2231) new playing state PLAYING
[10-03-25 10:22:31.9660] Slim::Player::StreamingController::_Playing (361) Song 1 has now started playing
[10-03-25 10:22:31.9675] Slim::Player::StreamingController::_Playing (389) Song queue is now 1
[10-03-25 10:22:32.2739] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: flc->flc via: -
[10-03-25 10:22:35.6136] Slim::Player::Protocols::File::sysread (218) Trying to read past the end of file: file:///C:/Users/DTMLLUAdminUser/Music/02.flac
[10-03-25 10:22:35.6144] Slim::Player::Source::_readNextChunk (330) end of file or error on socket, song pos: 3149562, tell says: 3149562, totalbytes: 3149562
[10-03-25 10:22:35.6150] Slim::Player::Source::_readNextChunk (335) 00:04:20:22:19:0a mark end of stream
[10-03-25 10:22:35.6160] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMOUT
[10-03-25 10:22:36.0271] Slim::Player::StreamingController::playerEndOfStream (2140) 00:04:20:22:19:0a
[10-03-25 10:22:36.0278] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMOUT
[10-03-25 10:22:53.6238] Slim::Player::StreamingController::playerReadyToStream (2061) 00:04:20:22:19:0a
[10-03-25 10:22:53.6245] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state IDLE
[10-03-25 10:22:53.6254] Slim::Player::StreamingController::nextsong (842) The next song is number 2, was 1
[10-03-25 10:22:53.6322] Slim::Player::Song::new (107) index 2 -> file:///C:/Users/DTMLLUAdminUser/Music/04.vbr.mp3
[10-03-25 10:22:53.6331] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state TRACKWAIT
[10-03-25 10:22:53.6339] Slim::Player::Song::getNextSong (228) file:///C:/Users/DTMLLUAdminUser/Music/04.vbr.mp3
[10-03-25 10:22:53.6346] Slim::Player::StreamingController::_nextTrackReady (730) 00:04:20:22:19:0a: nextTrack will be index 2
[10-03-25 10:22:53.6353] Slim::Player::StreamingController::_Stream (1161) Song queue is now 2,1
[10-03-25 10:22:53.6359] Slim::Player::StreamingController::_Stream (1164) 00:04:20:22:19:0a: preparing to stream song index 2
[10-03-25 10:22:53.6366] Slim::Player::Song::open (362) file:///C:/Users/DTMLLUAdminUser/Music/04.vbr.mp3
[10-03-25 10:22:53.6392] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp3->mp3 via: -
[10-03-25 10:22:53.6399] Slim::Player::Song::open (386) seek=false time=0 canSeek=1
[10-03-25 10:22:53.6413] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp3->mp3 via: -
[10-03-25 10:22:53.6419] Slim::Player::Song::open (407) Transcoder: streamMode=I, streamformat=mp3
[10-03-25 10:22:53.6426] Slim::Player::Song::open (455) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///C:/Users/DTMLLUAdminUser/Music/04.vbr.mp3]
[10-03-25 10:22:53.6442] Slim::Player::Protocols::File::open (78) duration: [31.242] size: [472030] endian [] offset: [2133] for file:///C:/Users/DTMLLUAdminUser/Music/04.vbr.mp3
[10-03-25 10:22:53.6447] Slim::Player::Protocols::File::open (95) Opening file C:\Users\DTMLLUAdminUser\Music\04.vbr.mp3
[10-03-25 10:22:53.6459] Slim::Player::Protocols::File::open (173) Seeking in 2133 into C:\Users\DTMLLUAdminUser\Music\04.vbr.mp3
[10-03-25 10:22:53.6468] Slim::Player::Song::open (476) URL is a song (audio): file:///C:/Users/DTMLLUAdminUser/Music/04.vbr.mp3, type=mp3
[10-03-25 10:22:53.6931] Slim::Player::StreamingController::_Stream (1219) 00:04:20:22:19:0a: stream
[10-03-25 10:22:53.6952] Slim::Player::StreamingController::_Stream (1254) Song queue is now 2,1
[10-03-25 10:22:53.6956] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMING
[10-03-25 10:22:54.3413] Slim::Player::Protocols::File::sysread (218) Trying to read past the end of file: file:///C:/Users/DTMLLUAdminUser/Music/04.vbr.mp3
[10-03-25 10:22:54.3420] Slim::Player::Source::_readNextChunk (330) end of file or error on socket, song pos: 474163, tell says: 474163, totalbytes: 472030
[10-03-25 10:22:54.3426] Slim::Player::Source::_readNextChunk (335) 00:04:20:22:19:0a mark end of stream
[10-03-25 10:22:54.3436] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMOUT
[10-03-25 10:22:54.8954] Slim::Player::StreamingController::playerEndOfStream (2140) 00:04:20:22:19:0a
[10-03-25 10:22:54.8961] Slim::Player::StreamingController::_setStreamingState (2244) new streaming state STREAMOUT
[10-03-25 10:22:54.8967] Slim::Player::StreamingController::_AutoStart (1441) autostart possibly short track
[10-03-25 10:23:03.0766] Slim::Player::StreamingController::playerTrackStarted (2043) 00:04:20:22:19:0a
[10-03-25 10:23:03.0775] Slim::Player::StreamingController::_setPlayingState (2231) new playing state PLAYING
[10-03-25 10:23:03.0782] Slim::Player::StreamingController::_Playing (355) Song 1 is not longer in the queue
[10-03-25 10:23:03.0788] Slim::Player::StreamingController::_Playing (361) Song 2 has now started playing
[10-03-25 10:23:03.0805] Slim::Player::StreamingController::_Playing (389) Song queue is now 2
[10-03-25 10:23:03.1272] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: mp3->mp3 via: -
[10-03-25 10:23:16.2963] Slim::Player::StreamingController::pause (1979) 00:04:20:22:19:0a
[10-03-25 10:23:16.2971] Slim::Player::StreamingController::_setPlayingState (2231) new playing state PAUSED
[10-03-25 10:23:16.2994] Slim::Player::Source::playmode (93) 00:04:20:22:19:0a: Current playmode: pause