[10-04-12 21:16:07.8503] Slim::Player::StreamingController::play (1960) 00:04:20:26:00:73
[10-04-12 21:16:07.8518] Slim::Player::StreamingController::_Stop (602) Song queue is now 0
[10-04-12 21:16:07.8525] Slim::Player::StreamingController::_setPlayingState (2228) new playing state STOPPED
[10-04-12 21:16:07.8531] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state IDLE
[10-04-12 21:16:07.8553] Slim::Player::Song::new (106) index 0 -> file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:16:07.8562] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state TRACKWAIT
[10-04-12 21:16:07.8571] Slim::Player::Song::getNextSong (227) file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:16:07.8579] Slim::Player::StreamingController::_nextTrackReady (728) 00:04:20:26:00:73: nextTrack will be index 0
[10-04-12 21:16:07.8586] Slim::Player::StreamingController::_Stream (1162) Song queue is now 0
[10-04-12 21:16:07.8592] Slim::Player::StreamingController::_Stream (1165) 00:04:20:26:00:73: preparing to stream song index 0
[10-04-12 21:16:07.8600] Slim::Player::Song::open (361) file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:16:07.8623] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:16:07.8642] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:16:07.8650] Slim::Player::Song::open (385) seek=false time=0 canSeek=2
[10-04-12 21:16:07.8666] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:16:07.8673] Slim::Player::Song::open (406) Transcoder: streamMode=F, streamformat=flc
[10-04-12 21:16:07.8695] Slim::Player::Song::open (556) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\faad.exe" -q -w -f 1 "D:\11FAAD~1.M4A" | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\sox.exe" -q -t wav - -t flac -C 0 - |
[10-04-12 21:16:07.9607] Slim::Player::StreamingController::_Stream (1220) 00:04:20:26:00:73: stream
[10-04-12 21:16:07.9676] Slim::Player::StreamingController::_Stream (1255) Song queue is now 0
[10-04-12 21:16:07.9762] Slim::Player::StreamingController::_setPlayingState (2228) new playing state BUFFERING
[10-04-12 21:16:07.9770] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMING
[10-04-12 21:16:08.8173] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:16:08.8185] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:16:09.4068] Slim::Player::StreamingController::playerTrackStarted (2040) 00:04:20:26:00:73
[10-04-12 21:16:09.4072] Slim::Player::StreamingController::_setPlayingState (2228) new playing state PLAYING
[10-04-12 21:16:09.4077] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[10-04-12 21:16:09.4087] Slim::Player::StreamingController::_Playing (389) Song queue is now 0
[10-04-12 21:16:09.7154] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:16:09.7167] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:17:37.5167] Slim::Plugin::MusicMagic::Plugin::_cacheidOK (566) Read cacheid of 1270902136
[10-04-12 21:17:37.5348] Slim::Plugin::MusicMagic::Plugin::_statusOK (489) Read status idle
[10-04-12 21:22:24.1760] Slim::Player::StreamingController::playerActive (1853) 00:04:20:22:01:8e player already active: 00:04:20:22:01:8e
[10-04-12 21:22:24.1769] Slim::Player::Squeezebox::reconnect (112) 00:04:20:22:01:8e restaring play on pseudo-reconnect at 0
[10-04-12 21:22:24.1775] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:22:01:8e
[10-04-12 21:22:24.1782] Slim::Player::Squeezebox::reconnect (120) 00:04:20:22:01:8e forcing stop on pseudo-reconnect
[10-04-12 21:22:24.2122] Slim::Player::Source::_readNextChunk (329) end of file or error on socket, song pos: 73197780
[10-04-12 21:22:24.2129] Slim::Player::Source::_readNextChunk (334) 00:04:20:26:00:73 mark end of stream
[10-04-12 21:22:24.2138] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMOUT
[10-04-12 21:22:24.2288] Slim::Player::StreamingController::playerActive (1853) 00:04:20:26:00:73 player already active: 00:04:20:26:00:73
[10-04-12 21:22:24.2295] Slim::Player::Squeezebox::reconnect (112) 00:04:20:26:00:73 restaring play on pseudo-reconnect at 0
[10-04-12 21:22:24.2301] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:26:00:73
[10-04-12 21:22:24.2309] Slim::Player::StreamingController::_Continue (908) Restarting stream at offset 0
[10-04-12 21:22:24.2315] Slim::Player::StreamingController::_Stream (1088) 00:04:20:26:00:73: got song from params, song index 0
[10-04-12 21:22:24.2322] Slim::Player::StreamingController::_Stream (1162) Song queue is now 0
[10-04-12 21:22:24.2328] Slim::Player::StreamingController::_Stream (1165) 00:04:20:26:00:73: preparing to stream song index 0
[10-04-12 21:22:24.2336] Slim::Player::Song::open (361) file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:22:24.2346] Slim::Player::Song::open (385) seek=false time=0 canSeek=2
[10-04-12 21:22:24.2363] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.2370] Slim::Player::Song::open (406) Transcoder: streamMode=F, streamformat=flc
[10-04-12 21:22:24.2391] Slim::Player::Song::open (556) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\faad.exe" -q -w -f 1 "D:\11FAAD~1.M4A" | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\sox.exe" -q -t wav - -t flac -C 0 - |
[10-04-12 21:22:24.2571] Slim::Player::StreamingController::_Stream (1220) 00:04:20:26:00:73: stream
[10-04-12 21:22:24.2721] Slim::Player::StreamingController::_Stream (1255) Song queue is now 0
[10-04-12 21:22:24.2729] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMING
[10-04-12 21:22:24.2925] Slim::Player::StreamingController::playerActive (1853) 00:04:20:22:01:8e player already active: 00:04:20:22:01:8e
[10-04-12 21:22:24.2931] Slim::Player::Squeezebox::reconnect (112) 00:04:20:22:01:8e restaring play on pseudo-reconnect at 0
[10-04-12 21:22:24.2937] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:22:01:8e
[10-04-12 21:22:24.2944] Slim::Player::Squeezebox::reconnect (120) 00:04:20:22:01:8e forcing stop on pseudo-reconnect
[10-04-12 21:22:24.3052] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.3072] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.3156] Slim::Plugin::MusicMagic::Plugin::_cacheidOK (566) Read cacheid of 1270902136
[10-04-12 21:22:24.3243] Slim::Player::StreamingController::playerActive (1853) 00:04:20:26:00:73 player already active: 00:04:20:26:00:73
[10-04-12 21:22:24.3250] Slim::Player::Squeezebox::reconnect (112) 00:04:20:26:00:73 restaring play on pseudo-reconnect at 0
[10-04-12 21:22:24.3257] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:26:00:73
[10-04-12 21:22:24.3264] Slim::Player::StreamingController::_Continue (908) Restarting stream at offset 0
[10-04-12 21:22:24.3270] Slim::Player::StreamingController::_Stream (1088) 00:04:20:26:00:73: got song from params, song index 0
[10-04-12 21:22:24.3277] Slim::Player::StreamingController::_Stream (1162) Song queue is now 0
[10-04-12 21:22:24.3283] Slim::Player::StreamingController::_Stream (1165) 00:04:20:26:00:73: preparing to stream song index 0
[10-04-12 21:22:24.7189] Slim::Player::Song::open (361) file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:22:24.7194] Slim::Player::Song::open (385) seek=false time=0 canSeek=2
[10-04-12 21:22:24.7204] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.7207] Slim::Player::Song::open (406) Transcoder: streamMode=F, streamformat=flc
[10-04-12 21:22:24.7219] Slim::Player::Song::open (556) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\faad.exe" -q -w -f 1 "D:\11FAAD~1.M4A" | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\sox.exe" -q -t wav - -t flac -C 0 - |
[10-04-12 21:22:24.7322] Slim::Player::StreamingController::_Stream (1220) 00:04:20:26:00:73: stream
[10-04-12 21:22:24.7424] Slim::Player::StreamingController::_Stream (1255) Song queue is now 0
[10-04-12 21:22:24.7428] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMING
[10-04-12 21:22:24.7482] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.7494] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.7605] Slim::Utils::Timers::__ANON__ (260) Error: Timer failed: illegal file descriptor or filehandle (either no attached file descriptor or illegal value):  at /<C:\PROGRA~1\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Networking/IO/Select.pm line 149.
[10-04-12 21:22:24.7648] Slim::Player::StreamingController::playerActive (1853) 00:04:20:22:01:8e player already active: 00:04:20:22:01:8e
[10-04-12 21:22:24.7651] Slim::Player::Squeezebox::reconnect (112) 00:04:20:22:01:8e restaring play on pseudo-reconnect at 0
[10-04-12 21:22:24.7654] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:22:01:8e
[10-04-12 21:22:24.7657] Slim::Player::Squeezebox::reconnect (120) 00:04:20:22:01:8e forcing stop on pseudo-reconnect
[10-04-12 21:22:24.7727] Slim::Player::StreamingController::playerActive (1853) 00:04:20:26:00:73 player already active: 00:04:20:26:00:73
[10-04-12 21:22:24.7731] Slim::Player::Squeezebox::reconnect (112) 00:04:20:26:00:73 restaring play on pseudo-reconnect at 0
[10-04-12 21:22:24.7733] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:26:00:73
[10-04-12 21:22:24.7737] Slim::Player::StreamingController::_Continue (908) Restarting stream at offset 0
[10-04-12 21:22:24.7740] Slim::Player::StreamingController::_Stream (1088) 00:04:20:26:00:73: got song from params, song index 0
[10-04-12 21:22:24.7743] Slim::Player::StreamingController::_Stream (1162) Song queue is now 0
[10-04-12 21:22:24.7746] Slim::Player::StreamingController::_Stream (1165) 00:04:20:26:00:73: preparing to stream song index 0
[10-04-12 21:22:24.9082] Slim::Player::Song::open (361) file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:22:24.9088] Slim::Player::Song::open (385) seek=false time=0 canSeek=2
[10-04-12 21:22:24.9099] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.9103] Slim::Player::Song::open (406) Transcoder: streamMode=F, streamformat=flc
[10-04-12 21:22:24.9118] Slim::Player::Song::open (556) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\faad.exe" -q -w -f 1 "D:\11FAAD~1.M4A" | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\sox.exe" -q -t wav - -t flac -C 0 - |
[10-04-12 21:22:24.9299] Slim::Player::StreamingController::_Stream (1220) 00:04:20:26:00:73: stream
[10-04-12 21:22:24.9332] Slim::Player::StreamingController::_Stream (1255) Song queue is now 0
[10-04-12 21:22:24.9337] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMING
[10-04-12 21:22:24.9486] Slim::Player::StreamingController::playerActive (1853) 00:04:20:22:01:8e player already active: 00:04:20:22:01:8e
[10-04-12 21:22:24.9491] Slim::Player::Squeezebox::reconnect (112) 00:04:20:22:01:8e restaring play on pseudo-reconnect at 0
[10-04-12 21:22:24.9494] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:22:01:8e
[10-04-12 21:22:24.9498] Slim::Player::Squeezebox::reconnect (120) 00:04:20:22:01:8e forcing stop on pseudo-reconnect
[10-04-12 21:22:24.9559] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.9571] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:24.9650] Slim::Player::StreamingController::playerActive (1853) 00:04:20:26:00:73 player already active: 00:04:20:26:00:73
[10-04-12 21:22:24.9654] Slim::Player::Squeezebox::reconnect (112) 00:04:20:26:00:73 restaring play on pseudo-reconnect at 0
[10-04-12 21:22:24.9657] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:26:00:73
[10-04-12 21:22:24.9661] Slim::Player::StreamingController::_Continue (908) Restarting stream at offset 0
[10-04-12 21:22:24.9665] Slim::Player::StreamingController::_Stream (1088) 00:04:20:26:00:73: got song from params, song index 0
[10-04-12 21:22:24.9669] Slim::Player::StreamingController::_Stream (1162) Song queue is now 0
[10-04-12 21:22:24.9672] Slim::Player::StreamingController::_Stream (1165) 00:04:20:26:00:73: preparing to stream song index 0
[10-04-12 21:22:25.1141] Slim::Player::Song::open (361) file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:22:25.1146] Slim::Player::Song::open (385) seek=false time=0 canSeek=2
[10-04-12 21:22:25.1156] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:25.1159] Slim::Player::Song::open (406) Transcoder: streamMode=F, streamformat=flc
[10-04-12 21:22:25.1171] Slim::Player::Song::open (556) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\faad.exe" -q -w -f 1 "D:\11FAAD~1.M4A" | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\sox.exe" -q -t wav - -t flac -C 0 - |
[10-04-12 21:22:25.1287] Slim::Player::StreamingController::_Stream (1220) 00:04:20:26:00:73: stream
[10-04-12 21:22:25.1318] Slim::Player::StreamingController::_Stream (1255) Song queue is now 0
[10-04-12 21:22:25.1322] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMING
[10-04-12 21:22:25.1504] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:25.1516] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:25.1587] Slim::Plugin::MusicMagic::Plugin::_statusOK (489) Read status idle
[10-04-12 21:22:25.1658] Slim::Player::StreamingController::playerActive (1853) 00:04:20:22:01:8e player already active: 00:04:20:22:01:8e
[10-04-12 21:22:25.1661] Slim::Player::Squeezebox::reconnect (112) 00:04:20:22:01:8e restaring play on pseudo-reconnect at 0
[10-04-12 21:22:25.1664] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:22:01:8e
[10-04-12 21:22:25.1667] Slim::Player::Squeezebox::reconnect (120) 00:04:20:22:01:8e forcing stop on pseudo-reconnect
[10-04-12 21:22:25.1762] Slim::Player::StreamingController::playerActive (1853) 00:04:20:26:00:73 player already active: 00:04:20:26:00:73
[10-04-12 21:22:25.1765] Slim::Player::Squeezebox::reconnect (112) 00:04:20:26:00:73 restaring play on pseudo-reconnect at 0
[10-04-12 21:22:25.1768] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:26:00:73
[10-04-12 21:22:25.1773] Slim::Player::StreamingController::_Continue (908) Restarting stream at offset 0
[10-04-12 21:22:25.1777] Slim::Player::StreamingController::_Stream (1088) 00:04:20:26:00:73: got song from params, song index 0
[10-04-12 21:22:25.1780] Slim::Player::StreamingController::_Stream (1162) Song queue is now 0
[10-04-12 21:22:25.1783] Slim::Player::StreamingController::_Stream (1165) 00:04:20:26:00:73: preparing to stream song index 0
[10-04-12 21:22:25.3126] Slim::Player::Song::open (361) file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:22:25.3132] Slim::Player::Song::open (385) seek=false time=0 canSeek=2
[10-04-12 21:22:25.3141] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:25.3145] Slim::Player::Song::open (406) Transcoder: streamMode=F, streamformat=flc
[10-04-12 21:22:25.3157] Slim::Player::Song::open (556) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\faad.exe" -q -w -f 1 "D:\11FAAD~1.M4A" | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\sox.exe" -q -t wav - -t flac -C 0 - |
[10-04-12 21:22:25.3267] Slim::Player::StreamingController::_Stream (1220) 00:04:20:26:00:73: stream
[10-04-12 21:22:25.3315] Slim::Player::StreamingController::_Stream (1255) Song queue is now 0
[10-04-12 21:22:25.3320] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMING
[10-04-12 21:22:25.3375] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:22:25.3386] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:24:24.2927] Slim::Plugin::MusicMagic::Plugin::_cacheidOK (566) Read cacheid of 1270902136
[10-04-12 21:24:24.3103] Slim::Plugin::MusicMagic::Plugin::_statusOK (489) Read status idle
[10-04-12 21:26:24.8389] Slim::Player::Source::_readNextChunk (329) end of file or error on socket, song pos: 97597040
[10-04-12 21:26:24.8395] Slim::Player::Source::_readNextChunk (334) 00:04:20:26:00:73 mark end of stream
[10-04-12 21:26:24.8404] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMOUT
[10-04-12 21:26:24.8455] Slim::Player::StreamingController::playerActive (1853) 00:04:20:26:00:73 player already active: 00:04:20:26:00:73
[10-04-12 21:26:24.8462] Slim::Player::Squeezebox::reconnect (112) 00:04:20:26:00:73 restaring play on pseudo-reconnect at 0
[10-04-12 21:26:24.8468] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:26:00:73
[10-04-12 21:26:24.8475] Slim::Player::StreamingController::_Continue (908) Restarting stream at offset 0
[10-04-12 21:26:24.8481] Slim::Player::StreamingController::_Stream (1088) 00:04:20:26:00:73: got song from params, song index 0
[10-04-12 21:26:24.8488] Slim::Player::StreamingController::_Stream (1162) Song queue is now 0
[10-04-12 21:26:24.8494] Slim::Player::StreamingController::_Stream (1165) 00:04:20:26:00:73: preparing to stream song index 0
[10-04-12 21:26:24.8503] Slim::Player::Song::open (361) file:///D:/11%20Faad_crash_ATU.m4a
[10-04-12 21:26:24.8512] Slim::Player::Song::open (385) seek=false time=0 canSeek=2
[10-04-12 21:26:24.8529] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:26:24.8536] Slim::Player::Song::open (406) Transcoder: streamMode=F, streamformat=flc
[10-04-12 21:26:24.8557] Slim::Player::Song::open (556) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\faad.exe" -q -w -f 1 "D:\11FAAD~1.M4A" | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\sox.exe" -q -t wav - -t flac -C 0 - |
[10-04-12 21:26:24.8754] Slim::Player::StreamingController::_Stream (1220) 00:04:20:26:00:73: stream
[10-04-12 21:26:24.8812] Slim::Player::StreamingController::_Stream (1255) Song queue is now 0
[10-04-12 21:26:24.8821] Slim::Player::StreamingController::_setStreamingState (2241) new streaming state STREAMING
[10-04-12 21:26:24.8913] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:26:24.8933] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:26:24.9147] Slim::Player::StreamingController::playerActive (1853) 00:04:20:22:01:8e player already active: 00:04:20:22:01:8e
[10-04-12 21:26:24.9154] Slim::Player::Squeezebox::reconnect (112) 00:04:20:22:01:8e restaring play on pseudo-reconnect at 0
[10-04-12 21:26:24.9162] Slim::Player::StreamingController::playerReconnect (1932) 00:04:20:22:01:8e
[10-04-12 21:26:24.9169] Slim::Player::Squeezebox::reconnect (120) 00:04:20:22:01:8e forcing stop on pseudo-reconnect
[10-04-12 21:26:25.0549] Slim::Plugin::MusicMagic::Plugin::_cacheidOK (566) Read cacheid of 1270902136
[10-04-12 21:26:25.0904] Slim::Plugin::MusicMagic::Plugin::_statusOK (489) Read status idle
[10-04-12 21:26:25.5470] Slim::Utils::Timers::__ANON__ (260) Error: Timer failed: illegal file descriptor or filehandle (either no attached file descriptor or illegal value):  at /<C:\PROGRA~1\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Networking/IO/Select.pm line 149.
[10-04-12 21:26:25.5766] Slim::Player::StreamingController::playerOutputUnderrun (2079) 00:04:20:26:00:73: decoder: 0 / output: 36864
[10-04-12 21:26:25.5770] Slim::Player::StreamingController::_setPlayingState (2228) new playing state BUFFERING
[10-04-12 21:26:25.7081] Slim::Player::Player::_buffering (1148) Buffering... 0 / 441000
[10-04-12 21:26:25.7085] Slim::Player::Player::_buffering (1149)   +output... 36864 / 1764000
[10-04-12 21:26:26.0080] Slim::Player::Player::_buffering (1148) Buffering... 52040 / 441000
[10-04-12 21:26:26.0084] Slim::Player::Player::_buffering (1149)   +output... 184320 / 1764000
[10-04-12 21:26:26.3041] Slim::Player::Player::_buffering (1148) Buffering... 104968 / 441000
[10-04-12 21:26:26.3045] Slim::Player::Player::_buffering (1149)   +output... 552960 / 1764000
[10-04-12 21:26:26.6010] Slim::Player::Player::_buffering (1148) Buffering... 104968 / 441000
[10-04-12 21:26:26.6013] Slim::Player::Player::_buffering (1149)   +output... 552960 / 1764000
[10-04-12 21:26:26.9082] Slim::Player::Player::_buffering (1148) Buffering... 74464 / 441000
[10-04-12 21:26:26.9089] Slim::Player::Player::_buffering (1149)   +output... 1363968 / 1764000
[10-04-12 21:26:27.2149] Slim::Player::Player::_buffering (1148) Buffering... 74464 / 441000
[10-04-12 21:26:27.2156] Slim::Player::Player::_buffering (1149)   +output... 1363968 / 1764000
[10-04-12 21:26:27.5315] Slim::Player::Player::_buffering (1148) Buffering... 74464 / 441000
[10-04-12 21:26:27.5322] Slim::Player::Player::_buffering (1149)   +output... 1363968 / 1764000
[10-04-12 21:26:27.8441] Slim::Player::Player::_buffering (1148) Buffering... 98504 / 441000
[10-04-12 21:26:27.8447] Slim::Player::Player::_buffering (1149)   +output... 2571264 / 1764000
[10-04-12 21:26:27.8454] Slim::Player::StreamingController::playerBufferReady (2129) 00:04:20:26:00:73
[10-04-12 21:26:27.8460] Slim::Player::StreamingController::_setPlayingState (2228) new playing state WAITING_TO_SYNC
[10-04-12 21:26:27.8467] Slim::Player::StreamingController::_setPlayingState (2228) new playing state PLAYING
[10-04-12 21:26:28.0483] Slim::Player::StreamingController::playerTrackStarted (2040) 00:04:20:26:00:73
[10-04-12 21:26:28.0490] Slim::Player::StreamingController::_setPlayingState (2228) new playing state PLAYING
[10-04-12 21:26:28.0496] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[10-04-12 21:26:28.0511] Slim::Player::StreamingController::_Playing (389) Song queue is now 0
[10-04-12 21:26:28.3654] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:26:28.3675] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: alc->flc via: [faad] -q -w -f 1 $START$ $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[10-04-12 21:26:43.1471] Slim::Player::StreamingController::pause (1976) 00:04:20:26:00:73
[10-04-12 21:26:43.1493] Slim::Player::StreamingController::_setPlayingState (2228) new playing state PAUSED
[10-04-12 21:26:43.1515] Slim::Player::Source::playmode (92) 00:04:20:26:00:73: Current playmode: pause