===== Display starts at offset 288935761 within file of length 289066833. ====
===== Use File->Reload (Cmd-R) to display more. ====
-* vs wav-wav-*-*
[08-11-13 16:27:02.3435] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.3438] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:02.3442] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:02.3445] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:02.3448] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.3452] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:02.3455] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:02.3458] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:02.3461] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.3464] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:02.3468] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:02.3471] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:02.3474] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:02.3477] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.3480] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.3483] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.3486] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.3489] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:02.3492] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.3496] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.3500] Slim::Player::Song::open (323) seek=false time=0 canSeek=2
[08-11-13 16:27:02.3506] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:02.3510] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:02.3513] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.3516] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.3519] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.3522] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.3525] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.3529] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:02.3532] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:02.3535] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:02.3538] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.3541] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:02.3544] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:02.3547] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:02.3550] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.3554] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:02.3557] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:02.3560] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:02.3563] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:02.3566] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.3569] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.3572] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.3575] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.3578] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:02.3581] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.3585] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.3588] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc
[08-11-13 16:27:02.3592] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_44100_2_440_10/wav_32_44100_2_440_10.wav]
[08-11-13 16:27:02.3604] Slim::Player::Protocols::File::open (79) duration: [10] size: [3528000] endian [] offset: [44] for file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_44100_2_440_10/wav_32_44100_2_440_10.wav
[08-11-13 16:27:02.3607] Slim::Player::Protocols::File::open (96) Opening file /Users/qatest/Music/PT_FOABP Title 1 (Ch1 - Ch6)/Bit Rate Test/wav_32_44100_2_440_10/wav_32_44100_2_440_10.wav
[08-11-13 16:27:02.3617] Slim::Formats::Wav::getInitialAudioBlock (94) Reading initial audio block: length 44
[08-11-13 16:27:02.3621] Slim::Player::Protocols::File::open (157) Got initial audio block of size 44
[08-11-13 16:27:02.3626] Slim::Player::Song::open (385) URL is a song (audio): file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_44100_2_440_10/wav_32_44100_2_440_10.wav, type=wav
[08-11-13 16:27:02.3635] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (548) Using command for conversion: "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:02.3639] Slim::Player::Song::open (457) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:02.3950] Slim::Player::SongStreamController::new (32) live=2
[08-11-13 16:27:02.3970] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-13 16:27:02.3974] Slim::Player::StreamingController::_Stream (937) 00:04:20:10:04:d2: stream
[08-11-13 16:27:02.4001] Slim::Player::Transporter::play (123) Setting DigitalInput to 0 for [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_44100_2_440_10/wav_32_44100_2_440_10.wav]
[08-11-13 16:27:02.4005] Slim::Player::Transporter::setDigitalInput (203) Switching to digital input 0
[08-11-13 16:27:02.4064] Slim::Player::StreamingController::_Stream (966) Song queue is now 59,58
[08-11-13 16:27:02.4073] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-13 16:27:02.4077] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: NextTrackReady - new state PLAYING-STREAMING
[08-11-13 16:27:02.4082] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: ReadyToStream - new state PLAYING-STREAMING
[08-11-13 16:27:02.4115] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.4123] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.4140] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.4147] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.4259] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.4275] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:02.4279] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:02.4284] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer
[08-11-13 16:27:02.4287] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:02.4293] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:02.4298] Slim::Player::Source::_readNextChunk (478) readlen undef: (Broken pipe) 32
[08-11-13 16:27:02.4302] Slim::Player::Source::_readNextChunk (505) end of file or error on socket, song pos: 471896
[08-11-13 16:27:02.4306] Slim::Player::Source::_readNextChunk (514) Didn't stream any bytes for this song, so just mark it as played
[08-11-13 16:27:02.4309] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:10:04:d2
[08-11-13 16:27:02.4313] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-13 16:27:02.4317] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-13 16:27:02.4320] Slim::Player::StreamingController::_Playing (342) Song 58 is not longer in the queue
[08-11-13 16:27:02.4325] Slim::Player::Song::DESTROY (111) live=4: index=58, url=file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_44100_1_440_10/wav_32_44100_1_440_10.wav
[08-11-13 16:27:02.4342] Slim::Player::StreamingController::_Playing (348) Song 59 has now started playing
[08-11-13 16:27:02.4360] Slim::Player::StreamingController::_Playing (375) Song queue is now 59
[08-11-13 16:27:02.4363] Slim::Player::Source::_readNextChunk (521) 00:04:20:10:04:d2 mark end of stream
[08-11-13 16:27:02.4370] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout
[08-11-13 16:27:02.4373] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:02.4376] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: LocalEndOfStream - new state PLAYING-STREAMOUT
[08-11-13 16:27:02.4399] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.8413] Slim::Player::StreamingController::playerEndOfStream (1664) 00:04:20:10:04:d2
[08-11-13 16:27:02.8417] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[08-11-13 16:27:02.8420] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:02.8430] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:10:04:d2
[08-11-13 16:27:02.8434] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-13 16:27:02.8439] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-13 16:27:02.8443] Slim::Player::StreamingController::nextsong (741) The next song is number 60, was 59
[08-11-13 16:27:02.8503] Slim::Player::Song::new (64) index 60 -> file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav
[08-11-13 16:27:02.8508] Slim::Player::Song::new (101) live=5
[08-11-13 16:27:02.8511] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state TRACKWAIT
[08-11-13 16:27:02.8516] Slim::Player::Song::getNextSong (178) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav
[08-11-13 16:27:02.8520] Slim::Player::StreamingController::_nextTrackReady (633) 00:04:20:10:04:d2: nextTrack will be index 60
[08-11-13 16:27:02.8524] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady
[08-11-13 16:27:02.8528] Slim::Player::StreamingController::_Stream (894) 00:04:20:10:04:d2: preparing to stream song index 60
[08-11-13 16:27:02.8531] Slim::Player::StreamingController::_Stream (899) Song queue is now 60,59
[08-11-13 16:27:02.8536] Slim::Player::Song::open (302) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav
[08-11-13 16:27:02.8556] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:02.8560] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:02.8564] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.8567] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8570] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8573] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8576] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8580] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8583] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:02.8586] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:02.8589] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8592] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8595] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:02.8599] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:02.8602] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8605] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8608] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:02.8611] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:02.8614] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:02.8617] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.8620] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8624] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8627] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8630] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:02.8633] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.8637] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.8645] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:02.8649] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:02.8652] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.8655] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8658] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8661] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8665] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8668] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8671] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:02.8674] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:02.8677] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8680] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8683] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:02.8686] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:02.8689] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8692] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8696] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:02.8699] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:02.8702] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:02.8705] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.8708] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8711] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8714] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8717] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:02.8720] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.8724] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.8727] Slim::Player::Song::open (323) seek=false time=0 canSeek=2
[08-11-13 16:27:02.8734] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:02.8738] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:02.8741] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.8744] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8747] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8750] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:02.8753] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8756] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8760] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:02.8763] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:02.8766] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8769] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8772] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:02.8775] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:02.8778] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:02.8781] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:02.8784] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:02.8787] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:02.8790] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:02.8794] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:02.8797] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8800] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8803] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:02.8806] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:02.8809] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.8812] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:02.8816] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc
[08-11-13 16:27:02.8819] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav]
[08-11-13 16:27:02.8831] Slim::Player::Protocols::File::open (79) duration: [10] size: [1920000] endian [] offset: [44] for file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav
[08-11-13 16:27:02.8834] Slim::Player::Protocols::File::open (96) Opening file /Users/qatest/Music/PT_FOABP Title 1 (Ch1 - Ch6)/Bit Rate Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav
[08-11-13 16:27:02.8844] Slim::Formats::Wav::getInitialAudioBlock (94) Reading initial audio block: length 44
[08-11-13 16:27:02.8848] Slim::Player::Protocols::File::open (157) Got initial audio block of size 44
[08-11-13 16:27:02.8853] Slim::Player::Song::open (385) URL is a song (audio): file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav, type=wav
[08-11-13 16:27:02.8863] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (548) Using command for conversion: "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:02.8866] Slim::Player::Song::open (457) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:02.9186] Slim::Player::SongStreamController::new (32) live=2
[08-11-13 16:27:02.9207] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-13 16:27:02.9211] Slim::Player::StreamingController::_Stream (937) 00:04:20:10:04:d2: stream
[08-11-13 16:27:02.9239] Slim::Player::Transporter::play (123) Setting DigitalInput to 0 for [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav]
[08-11-13 16:27:02.9243] Slim::Player::Transporter::setDigitalInput (203) Switching to digital input 0
[08-11-13 16:27:02.9303] Slim::Player::StreamingController::_Stream (966) Song queue is now 60,59
[08-11-13 16:27:02.9313] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-13 16:27:02.9317] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: NextTrackReady - new state PLAYING-STREAMING
[08-11-13 16:27:02.9322] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: ReadyToStream - new state PLAYING-STREAMING
[08-11-13 16:27:02.9365] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.9374] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.9383] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.9418] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.9425] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:02.9528] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:02.9533] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:02.9537] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer
[08-11-13 16:27:02.9540] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:02.9546] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:02.9551] Slim::Player::Source::_readNextChunk (478) readlen undef: (Broken pipe) 32
[08-11-13 16:27:02.9555] Slim::Player::Source::_readNextChunk (505) end of file or error on socket, song pos: 471896
[08-11-13 16:27:02.9559] Slim::Player::Source::_readNextChunk (514) Didn't stream any bytes for this song, so just mark it as played
[08-11-13 16:27:02.9562] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:10:04:d2
[08-11-13 16:27:02.9566] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-13 16:27:02.9570] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-13 16:27:02.9573] Slim::Player::StreamingController::_Playing (342) Song 59 is not longer in the queue
[08-11-13 16:27:02.9578] Slim::Player::Song::DESTROY (111) live=4: index=59, url=file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_44100_2_440_10/wav_32_44100_2_440_10.wav
[08-11-13 16:27:02.9595] Slim::Player::StreamingController::_Playing (348) Song 60 has now started playing
[08-11-13 16:27:02.9613] Slim::Player::StreamingController::_Playing (375) Song queue is now 60
[08-11-13 16:27:02.9616] Slim::Player::Source::_readNextChunk (521) 00:04:20:10:04:d2 mark end of stream
[08-11-13 16:27:02.9623] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout
[08-11-13 16:27:02.9627] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:02.9630] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: LocalEndOfStream - new state PLAYING-STREAMOUT
[08-11-13 16:27:02.9653] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:03.3669] Slim::Player::StreamingController::playerEndOfStream (1664) 00:04:20:10:04:d2
[08-11-13 16:27:03.3673] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[08-11-13 16:27:03.3677] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:03.3764] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:10:04:d2
[08-11-13 16:27:03.3769] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-13 16:27:03.3772] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-13 16:27:03.3777] Slim::Player::StreamingController::nextsong (741) The next song is number 61, was 60
[08-11-13 16:27:03.3840] Slim::Player::Song::new (64) index 61 -> file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav
[08-11-13 16:27:03.3846] Slim::Player::Song::new (101) live=5
[08-11-13 16:27:03.3849] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state TRACKWAIT
[08-11-13 16:27:03.3853] Slim::Player::Song::getNextSong (178) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav
[08-11-13 16:27:03.3858] Slim::Player::StreamingController::_nextTrackReady (633) 00:04:20:10:04:d2: nextTrack will be index 61
[08-11-13 16:27:03.3862] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady
[08-11-13 16:27:03.3866] Slim::Player::StreamingController::_Stream (894) 00:04:20:10:04:d2: preparing to stream song index 61
[08-11-13 16:27:03.3869] Slim::Player::StreamingController::_Stream (899) Song queue is now 61,60
[08-11-13 16:27:03.3874] Slim::Player::Song::open (302) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav
[08-11-13 16:27:03.3894] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:03.3898] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:03.3902] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.3905] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.3908] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.3911] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.3915] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.3919] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:03.3922] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:03.3925] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:03.3928] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.3931] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:03.3934] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:03.3937] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:03.3941] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.3944] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:03.3947] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:03.3950] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:03.3953] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:03.3956] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.3959] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.3962] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.3965] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.3968] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:03.3971] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.3975] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.3984] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:03.3987] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:03.3990] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.3993] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.3997] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.4000] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.4003] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.4006] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:03.4009] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:03.4012] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:03.4015] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.4018] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:03.4021] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:03.4024] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:03.4028] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.4031] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:03.4034] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:03.4037] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:03.4041] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:03.4044] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.4047] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.4050] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.4053] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.4056] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:03.4059] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.4063] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.4066] Slim::Player::Song::open (323) seek=false time=0 canSeek=2
[08-11-13 16:27:03.4073] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:03.4076] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:03.4079] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.4082] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.4085] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.4089] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.4092] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.4095] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:03.4098] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:03.4101] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:03.4104] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.4107] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:03.4110] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:03.4113] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:03.4116] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.4120] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:03.4123] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:03.4126] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:03.4129] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:03.4132] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.4135] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.4138] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.4142] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.4145] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:03.4148] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.4151] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.4155] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc
[08-11-13 16:27:03.4158] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav]
[08-11-13 16:27:03.4170] Slim::Player::Protocols::File::open (79) duration: [10] size: [3840000] endian [] offset: [44] for file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav
[08-11-13 16:27:03.4173] Slim::Player::Protocols::File::open (96) Opening file /Users/qatest/Music/PT_FOABP Title 1 (Ch1 - Ch6)/Bit Rate Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav
[08-11-13 16:27:03.4183] Slim::Formats::Wav::getInitialAudioBlock (94) Reading initial audio block: length 44
[08-11-13 16:27:03.4187] Slim::Player::Protocols::File::open (157) Got initial audio block of size 44
[08-11-13 16:27:03.4192] Slim::Player::Song::open (385) URL is a song (audio): file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav, type=wav
[08-11-13 16:27:03.4202] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (548) Using command for conversion: "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:03.4205] Slim::Player::Song::open (457) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:03.4520] Slim::Player::SongStreamController::new (32) live=2
[08-11-13 16:27:03.4541] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-13 16:27:03.4545] Slim::Player::StreamingController::_Stream (937) 00:04:20:10:04:d2: stream
[08-11-13 16:27:03.4570] Slim::Player::Transporter::play (123) Setting DigitalInput to 0 for [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav]
[08-11-13 16:27:03.4574] Slim::Player::Transporter::setDigitalInput (203) Switching to digital input 0
[08-11-13 16:27:03.4634] Slim::Player::StreamingController::_Stream (966) Song queue is now 61,60
[08-11-13 16:27:03.4642] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-13 16:27:03.4646] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: NextTrackReady - new state PLAYING-STREAMING
[08-11-13 16:27:03.4650] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: ReadyToStream - new state PLAYING-STREAMING
[08-11-13 16:27:03.4681] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:03.4689] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:03.4710] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:03.4718] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:03.4832] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:03.4848] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:03.4852] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:03.4857] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer
[08-11-13 16:27:03.4860] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:03.4866] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:03.4871] Slim::Player::Source::_readNextChunk (478) readlen undef: (Broken pipe) 32
[08-11-13 16:27:03.4875] Slim::Player::Source::_readNextChunk (505) end of file or error on socket, song pos: 471896
[08-11-13 16:27:03.4878] Slim::Player::Source::_readNextChunk (514) Didn't stream any bytes for this song, so just mark it as played
[08-11-13 16:27:03.4882] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:10:04:d2
[08-11-13 16:27:03.4886] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-13 16:27:03.4890] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-13 16:27:03.4893] Slim::Player::StreamingController::_Playing (342) Song 60 is not longer in the queue
[08-11-13 16:27:03.4898] Slim::Player::Song::DESTROY (111) live=4: index=60, url=file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_1_440_10/wav_32_48000_1_440_10.wav
[08-11-13 16:27:03.4915] Slim::Player::StreamingController::_Playing (348) Song 61 has now started playing
[08-11-13 16:27:03.4932] Slim::Player::StreamingController::_Playing (375) Song queue is now 61
[08-11-13 16:27:03.4936] Slim::Player::Source::_readNextChunk (521) 00:04:20:10:04:d2 mark end of stream
[08-11-13 16:27:03.4943] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout
[08-11-13 16:27:03.4946] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:03.4949] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: LocalEndOfStream - new state PLAYING-STREAMOUT
[08-11-13 16:27:03.4973] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:03.8989] Slim::Player::StreamingController::playerEndOfStream (1664) 00:04:20:10:04:d2
[08-11-13 16:27:03.8993] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[08-11-13 16:27:03.8997] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:03.9099] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:10:04:d2
[08-11-13 16:27:03.9103] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-13 16:27:03.9106] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-13 16:27:03.9111] Slim::Player::StreamingController::nextsong (741) The next song is number 62, was 61
[08-11-13 16:27:03.9170] Slim::Player::Song::new (64) index 62 -> file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav
[08-11-13 16:27:03.9175] Slim::Player::Song::new (101) live=5
[08-11-13 16:27:03.9179] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state TRACKWAIT
[08-11-13 16:27:03.9183] Slim::Player::Song::getNextSong (178) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav
[08-11-13 16:27:03.9188] Slim::Player::StreamingController::_nextTrackReady (633) 00:04:20:10:04:d2: nextTrack will be index 62
[08-11-13 16:27:03.9192] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady
[08-11-13 16:27:03.9196] Slim::Player::StreamingController::_Stream (894) 00:04:20:10:04:d2: preparing to stream song index 62
[08-11-13 16:27:03.9199] Slim::Player::StreamingController::_Stream (899) Song queue is now 62,61
[08-11-13 16:27:03.9204] Slim::Player::Song::open (302) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav
[08-11-13 16:27:03.9224] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:03.9228] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:03.9232] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.9235] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9238] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9241] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9244] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9248] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9251] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:03.9254] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:03.9257] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9260] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9263] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:03.9266] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:03.9270] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9273] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9276] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:03.9279] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:03.9282] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:03.9285] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.9288] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9291] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9294] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9297] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:03.9300] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.9304] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.9313] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:03.9317] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:03.9320] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.9323] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9326] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9329] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9333] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9336] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9339] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:03.9342] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:03.9345] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9348] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9351] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:03.9354] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:03.9357] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9360] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9364] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:03.9367] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:03.9370] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:03.9373] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.9376] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9379] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9382] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9385] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:03.9388] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.9392] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.9395] Slim::Player::Song::open (323) seek=false time=0 canSeek=2
[08-11-13 16:27:03.9402] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:03.9406] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:03.9409] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.9412] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9415] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9418] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:03.9421] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9424] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9428] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:03.9431] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:03.9434] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9437] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9440] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:03.9443] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:03.9446] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:03.9449] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:03.9453] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:03.9456] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:03.9459] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:03.9462] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:03.9465] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9468] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9471] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:03.9474] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:03.9477] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.9481] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:03.9484] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc
[08-11-13 16:27:03.9488] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav]
[08-11-13 16:27:03.9499] Slim::Player::Protocols::File::open (79) duration: [10] size: [3528000] endian [] offset: [44] for file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav
[08-11-13 16:27:03.9503] Slim::Player::Protocols::File::open (96) Opening file /Users/qatest/Music/PT_FOABP Title 1 (Ch1 - Ch6)/Bit Rate Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav
[08-11-13 16:27:03.9512] Slim::Formats::Wav::getInitialAudioBlock (94) Reading initial audio block: length 44
[08-11-13 16:27:03.9516] Slim::Player::Protocols::File::open (157) Got initial audio block of size 44
[08-11-13 16:27:03.9521] Slim::Player::Song::open (385) URL is a song (audio): file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav, type=wav
[08-11-13 16:27:03.9531] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (548) Using command for conversion: "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:03.9535] Slim::Player::Song::open (457) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:03.9857] Slim::Player::SongStreamController::new (32) live=2
[08-11-13 16:27:03.9876] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-13 16:27:03.9881] Slim::Player::StreamingController::_Stream (937) 00:04:20:10:04:d2: stream
[08-11-13 16:27:03.9907] Slim::Player::Transporter::play (123) Setting DigitalInput to 0 for [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav]
[08-11-13 16:27:03.9911] Slim::Player::Transporter::setDigitalInput (203) Switching to digital input 0
[08-11-13 16:27:03.9971] Slim::Player::StreamingController::_Stream (966) Song queue is now 62,61
[08-11-13 16:27:03.9981] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-13 16:27:03.9984] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: NextTrackReady - new state PLAYING-STREAMING
[08-11-13 16:27:03.9989] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: ReadyToStream - new state PLAYING-STREAMING
[08-11-13 16:27:04.0032] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.0040] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.0050] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.0084] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.0091] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.0193] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:04.0198] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:04.0202] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer
[08-11-13 16:27:04.0205] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:04.0211] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:04.0216] Slim::Player::Source::_readNextChunk (478) readlen undef: (Broken pipe) 32
[08-11-13 16:27:04.0220] Slim::Player::Source::_readNextChunk (505) end of file or error on socket, song pos: 471896
[08-11-13 16:27:04.0224] Slim::Player::Source::_readNextChunk (514) Didn't stream any bytes for this song, so just mark it as played
[08-11-13 16:27:04.0227] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:10:04:d2
[08-11-13 16:27:04.0231] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-13 16:27:04.0235] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-13 16:27:04.0238] Slim::Player::StreamingController::_Playing (342) Song 61 is not longer in the queue
[08-11-13 16:27:04.0243] Slim::Player::Song::DESTROY (111) live=4: index=61, url=file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_48000_2_440_10/wav_32_48000_2_440_10.wav
[08-11-13 16:27:04.0259] Slim::Player::StreamingController::_Playing (348) Song 62 has now started playing
[08-11-13 16:27:04.0279] Slim::Player::StreamingController::_Playing (375) Song queue is now 62
[08-11-13 16:27:04.0283] Slim::Player::Source::_readNextChunk (521) 00:04:20:10:04:d2 mark end of stream
[08-11-13 16:27:04.0290] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout
[08-11-13 16:27:04.0293] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:04.0296] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: LocalEndOfStream - new state PLAYING-STREAMOUT
[08-11-13 16:27:04.0320] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.4337] Slim::Player::StreamingController::playerEndOfStream (1664) 00:04:20:10:04:d2
[08-11-13 16:27:04.4341] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[08-11-13 16:27:04.4344] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:04.4434] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:10:04:d2
[08-11-13 16:27:04.4438] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-13 16:27:04.4441] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-13 16:27:04.4446] Slim::Player::StreamingController::nextsong (741) The next song is number 63, was 62
[08-11-13 16:27:04.4510] Slim::Player::Song::new (64) index 63 -> file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav
[08-11-13 16:27:04.4515] Slim::Player::Song::new (101) live=5
[08-11-13 16:27:04.4518] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state TRACKWAIT
[08-11-13 16:27:04.4523] Slim::Player::Song::getNextSong (178) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav
[08-11-13 16:27:04.4527] Slim::Player::StreamingController::_nextTrackReady (633) 00:04:20:10:04:d2: nextTrack will be index 63
[08-11-13 16:27:04.4531] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady
[08-11-13 16:27:04.4535] Slim::Player::StreamingController::_Stream (894) 00:04:20:10:04:d2: preparing to stream song index 63
[08-11-13 16:27:04.4539] Slim::Player::StreamingController::_Stream (899) Song queue is now 63,62
[08-11-13 16:27:04.4543] Slim::Player::Song::open (302) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav
[08-11-13 16:27:04.4563] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:04.4568] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:04.4572] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.4575] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4578] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4581] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4584] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4587] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4590] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:04.4594] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:04.4597] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4600] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4603] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:04.4606] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:04.4610] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4613] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4616] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:04.4619] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:04.4622] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:04.4625] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.4628] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4632] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4635] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4638] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:04.4641] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:04.4645] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:04.4653] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:04.4657] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:04.4660] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.4663] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4666] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4669] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4672] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4675] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4678] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:04.4681] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:04.4685] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4688] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4691] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:04.4694] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:04.4697] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4700] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4703] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:04.4706] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:04.4709] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:04.4712] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.4715] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4719] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4722] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4725] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:04.4728] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:04.4732] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:04.4735] Slim::Player::Song::open (323) seek=false time=0 canSeek=2
[08-11-13 16:27:04.4742] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:04.4745] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:04.4749] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.4752] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4755] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4758] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.4761] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4764] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4767] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:04.4770] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:04.4773] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4776] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4779] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:04.4782] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:04.4786] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.4789] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:04.4792] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:04.4795] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:04.4798] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:04.4801] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.4804] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4807] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4810] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.4813] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:04.4816] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:04.4820] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:04.4823] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc
[08-11-13 16:27:04.4827] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav]
[08-11-13 16:27:04.4839] Slim::Player::Protocols::File::open (79) duration: [10] size: [7056000] endian [] offset: [44] for file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav
[08-11-13 16:27:04.4842] Slim::Player::Protocols::File::open (96) Opening file /Users/qatest/Music/PT_FOABP Title 1 (Ch1 - Ch6)/Bit Rate Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav
[08-11-13 16:27:04.4852] Slim::Formats::Wav::getInitialAudioBlock (94) Reading initial audio block: length 44
[08-11-13 16:27:04.4856] Slim::Player::Protocols::File::open (157) Got initial audio block of size 44
[08-11-13 16:27:04.4861] Slim::Player::Song::open (385) URL is a song (audio): file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav, type=wav
[08-11-13 16:27:04.4871] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (548) Using command for conversion: "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:04.4874] Slim::Player::Song::open (457) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:04.5184] Slim::Player::SongStreamController::new (32) live=2
[08-11-13 16:27:04.5205] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-13 16:27:04.5210] Slim::Player::StreamingController::_Stream (937) 00:04:20:10:04:d2: stream
[08-11-13 16:27:04.5237] Slim::Player::Transporter::play (123) Setting DigitalInput to 0 for [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav]
[08-11-13 16:27:04.5241] Slim::Player::Transporter::setDigitalInput (203) Switching to digital input 0
[08-11-13 16:27:04.5300] Slim::Player::StreamingController::_Stream (966) Song queue is now 63,62
[08-11-13 16:27:04.5309] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-13 16:27:04.5313] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: NextTrackReady - new state PLAYING-STREAMING
[08-11-13 16:27:04.5318] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: ReadyToStream - new state PLAYING-STREAMING
[08-11-13 16:27:04.5349] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.5357] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.5491] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.5498] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.5505] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.5605] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:04.5610] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:04.5614] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer
[08-11-13 16:27:04.5617] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:04.5623] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:04.5628] Slim::Player::Source::_readNextChunk (478) readlen undef: (Broken pipe) 32
[08-11-13 16:27:04.5632] Slim::Player::Source::_readNextChunk (505) end of file or error on socket, song pos: 471896
[08-11-13 16:27:04.5636] Slim::Player::Source::_readNextChunk (514) Didn't stream any bytes for this song, so just mark it as played
[08-11-13 16:27:04.5640] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:10:04:d2
[08-11-13 16:27:04.5644] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-13 16:27:04.5647] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-13 16:27:04.5650] Slim::Player::StreamingController::_Playing (342) Song 62 is not longer in the queue
[08-11-13 16:27:04.5655] Slim::Player::Song::DESTROY (111) live=4: index=62, url=file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_1_440_10/wav_32_88200_1_440_10.wav
[08-11-13 16:27:04.5671] Slim::Player::StreamingController::_Playing (348) Song 63 has now started playing
[08-11-13 16:27:04.5686] Slim::Player::StreamingController::_Playing (375) Song queue is now 63
[08-11-13 16:27:04.5690] Slim::Player::Source::_readNextChunk (521) 00:04:20:10:04:d2 mark end of stream
[08-11-13 16:27:04.5697] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout
[08-11-13 16:27:04.5700] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:04.5703] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: LocalEndOfStream - new state PLAYING-STREAMOUT
[08-11-13 16:27:04.5725] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:04.9743] Slim::Player::StreamingController::playerEndOfStream (1664) 00:04:20:10:04:d2
[08-11-13 16:27:04.9747] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[08-11-13 16:27:04.9750] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:04.9765] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:10:04:d2
[08-11-13 16:27:04.9769] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-13 16:27:04.9773] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-13 16:27:04.9777] Slim::Player::StreamingController::nextsong (741) The next song is number 64, was 63
[08-11-13 16:27:04.9836] Slim::Player::Song::new (64) index 64 -> file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav
[08-11-13 16:27:04.9842] Slim::Player::Song::new (101) live=5
[08-11-13 16:27:04.9845] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state TRACKWAIT
[08-11-13 16:27:04.9849] Slim::Player::Song::getNextSong (178) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav
[08-11-13 16:27:04.9854] Slim::Player::StreamingController::_nextTrackReady (633) 00:04:20:10:04:d2: nextTrack will be index 64
[08-11-13 16:27:04.9858] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady
[08-11-13 16:27:04.9862] Slim::Player::StreamingController::_Stream (894) 00:04:20:10:04:d2: preparing to stream song index 64
[08-11-13 16:27:04.9865] Slim::Player::StreamingController::_Stream (899) Song queue is now 64,63
[08-11-13 16:27:04.9870] Slim::Player::Song::open (302) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav
[08-11-13 16:27:04.9896] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:04.9902] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:04.9905] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.9908] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.9912] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.9915] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.9918] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.9921] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:04.9924] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:04.9927] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:04.9930] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.9934] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:04.9937] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:04.9940] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:04.9943] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:04.9946] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:04.9949] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:04.9952] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:04.9955] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:04.9958] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.9961] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.9964] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.9967] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:04.9971] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:04.9974] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:04.9978] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:04.9986] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:04.9990] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:04.9993] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:04.9996] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:04.9999] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.0002] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.0005] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.0008] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:05.0012] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:05.0015] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:05.0018] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.0021] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:05.0024] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:05.0027] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:05.0030] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.0034] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:05.0037] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:05.0040] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:05.0043] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:05.0046] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.0049] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.0052] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.0055] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.0058] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:05.0061] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.0065] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.0068] Slim::Player::Song::open (323) seek=false time=0 canSeek=2
[08-11-13 16:27:05.0075] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:05.0079] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:05.0082] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.0085] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.0088] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.0091] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.0094] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.0097] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:05.0101] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:05.0104] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:05.0107] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.0110] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:05.0113] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:05.0116] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:05.0119] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.0122] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:05.0126] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:05.0129] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:05.0132] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:05.0135] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.0138] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.0141] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.0144] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.0147] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:05.0150] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.0154] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.0157] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc
[08-11-13 16:27:05.0161] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav]
[08-11-13 16:27:05.0173] Slim::Player::Protocols::File::open (79) duration: [10] size: [3840000] endian [] offset: [44] for file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav
[08-11-13 16:27:05.0176] Slim::Player::Protocols::File::open (96) Opening file /Users/qatest/Music/PT_FOABP Title 1 (Ch1 - Ch6)/Bit Rate Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav
[08-11-13 16:27:05.0185] Slim::Formats::Wav::getInitialAudioBlock (94) Reading initial audio block: length 44
[08-11-13 16:27:05.0189] Slim::Player::Protocols::File::open (157) Got initial audio block of size 44
[08-11-13 16:27:05.0194] Slim::Player::Song::open (385) URL is a song (audio): file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav, type=wav
[08-11-13 16:27:05.0204] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (548) Using command for conversion: "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:05.0207] Slim::Player::Song::open (457) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:05.0529] Slim::Player::SongStreamController::new (32) live=2
[08-11-13 16:27:05.0552] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-13 16:27:05.0556] Slim::Player::StreamingController::_Stream (937) 00:04:20:10:04:d2: stream
[08-11-13 16:27:05.0583] Slim::Player::Transporter::play (123) Setting DigitalInput to 0 for [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav]
[08-11-13 16:27:05.0587] Slim::Player::Transporter::setDigitalInput (203) Switching to digital input 0
[08-11-13 16:27:05.0645] Slim::Player::StreamingController::_Stream (966) Song queue is now 64,63
[08-11-13 16:27:05.0655] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-13 16:27:05.0659] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: NextTrackReady - new state PLAYING-STREAMING
[08-11-13 16:27:05.0664] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: ReadyToStream - new state PLAYING-STREAMING
[08-11-13 16:27:05.0707] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.0715] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.0725] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.0761] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.0769] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.0907] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.0915] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.1024] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.1045] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:05.1050] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:05.1054] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer
[08-11-13 16:27:05.1057] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:05.1062] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:05.1067] Slim::Player::Source::_readNextChunk (478) readlen undef: (Broken pipe) 32
[08-11-13 16:27:05.1072] Slim::Player::Source::_readNextChunk (505) end of file or error on socket, song pos: 471896
[08-11-13 16:27:05.1075] Slim::Player::Source::_readNextChunk (514) Didn't stream any bytes for this song, so just mark it as played
[08-11-13 16:27:05.1079] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:10:04:d2
[08-11-13 16:27:05.1083] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-13 16:27:05.1086] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-13 16:27:05.1089] Slim::Player::StreamingController::_Playing (342) Song 63 is not longer in the queue
[08-11-13 16:27:05.1094] Slim::Player::Song::DESTROY (111) live=4: index=63, url=file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_88200_2_440_10/wav_32_88200_2_440_10.wav
[08-11-13 16:27:05.1109] Slim::Player::StreamingController::_Playing (348) Song 64 has now started playing
[08-11-13 16:27:05.1127] Slim::Player::StreamingController::_Playing (375) Song queue is now 64
[08-11-13 16:27:05.1130] Slim::Player::Source::_readNextChunk (521) 00:04:20:10:04:d2 mark end of stream
[08-11-13 16:27:05.1137] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout
[08-11-13 16:27:05.1140] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:05.1143] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: LocalEndOfStream - new state PLAYING-STREAMOUT
[08-11-13 16:27:05.5182] Slim::Player::StreamingController::playerEndOfStream (1664) 00:04:20:10:04:d2
[08-11-13 16:27:05.5186] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[08-11-13 16:27:05.5190] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:05.5214] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:10:04:d2
[08-11-13 16:27:05.5219] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-13 16:27:05.5222] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-13 16:27:05.5226] Slim::Player::StreamingController::nextsong (741) The next song is number 65, was 64
[08-11-13 16:27:05.5288] Slim::Player::Song::new (64) index 65 -> file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_2_440_10/wav_32_96000_2_440_10.wav
[08-11-13 16:27:05.5294] Slim::Player::Song::new (101) live=5
[08-11-13 16:27:05.5297] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state TRACKWAIT
[08-11-13 16:27:05.5301] Slim::Player::Song::getNextSong (178) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_2_440_10/wav_32_96000_2_440_10.wav
[08-11-13 16:27:05.5306] Slim::Player::StreamingController::_nextTrackReady (633) 00:04:20:10:04:d2: nextTrack will be index 65
[08-11-13 16:27:05.5310] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady
[08-11-13 16:27:05.5314] Slim::Player::StreamingController::_Stream (894) 00:04:20:10:04:d2: preparing to stream song index 65
[08-11-13 16:27:05.5317] Slim::Player::StreamingController::_Stream (899) Song queue is now 65,64
[08-11-13 16:27:05.5322] Slim::Player::Song::open (302) file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_2_440_10/wav_32_96000_2_440_10.wav
[08-11-13 16:27:05.5342] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:05.5347] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:05.5350] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.5353] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5356] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5359] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5363] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5366] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5369] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:05.5372] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:05.5375] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5379] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5382] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:05.5385] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:05.5388] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5391] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5394] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:05.5397] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:05.5401] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:05.5404] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.5407] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5410] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5413] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5416] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:05.5419] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.5423] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.5432] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:05.5435] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:05.5438] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.5441] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5444] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5447] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5451] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5454] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5457] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:05.5460] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:05.5463] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5466] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5469] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:05.5472] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:05.5475] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5478] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5482] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:05.5485] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:05.5488] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:05.5491] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.5494] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5497] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5500] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5503] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:05.5506] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.5509] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.5514] Slim::Player::Song::open (323) seek=false time=0 canSeek=2
[08-11-13 16:27:05.5520] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = wav, transporter = 00:04:20:10:04:d2
[08-11-13 16:27:05.5524] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-wav-*-* is enabled
[08-11-13 16:27:05.5527] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.5530] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5533] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5536] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-wav-*-*
[08-11-13 16:27:05.5539] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5542] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5545] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-transporter-*
[08-11-13 16:27:05.5548] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-wma-*-*
[08-11-13 16:27:05.5551] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5554] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5558] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-transporter-*
[08-11-13 16:27:05.5561] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-ogg-*-*
[08-11-13 16:27:05.5564] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-00:04:20:10:04:d2
[08-11-13 16:27:05.5567] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-00:04:20:10:04:d2
[08-11-13 16:27:05.5570] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-transporter-*
[08-11-13 16:27:05.5573] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: wav-flc-*-*
[08-11-13 16:27:05.5576] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if wav-flc-*-* is enabled
[08-11-13 16:27:05.5579] Slim::Player::TranscodingHelper::enabledFormat (202) There are 3 disabled formats...
[08-11-13 16:27:05.5582] Slim::Player::TranscodingHelper::enabledFormat (208) Testing aif-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5585] Slim::Player::TranscodingHelper::enabledFormat (208) Testing flc-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5588] Slim::Player::TranscodingHelper::enabledFormat (208) Testing wav-mp3-*-* vs wav-flc-*-*
[08-11-13 16:27:05.5591] Slim::Player::TranscodingHelper::checkBin (235)    enabled
[08-11-13 16:27:05.5594] Slim::Player::TranscodingHelper::checkBin (237)   Found command: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.5598] Slim::Player::TranscodingHelper::getConvertCommand2 (445) Matched: wav->flc via: [flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$
[08-11-13 16:27:05.5601] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc
[08-11-13 16:27:05.5605] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_2_440_10/wav_32_96000_2_440_10.wav]
[08-11-13 16:27:05.5617] Slim::Player::Protocols::File::open (79) duration: [10] size: [7680000] endian [] offset: [44] for file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_2_440_10/wav_32_96000_2_440_10.wav
[08-11-13 16:27:05.5620] Slim::Player::Protocols::File::open (96) Opening file /Users/qatest/Music/PT_FOABP Title 1 (Ch1 - Ch6)/Bit Rate Test/wav_32_96000_2_440_10/wav_32_96000_2_440_10.wav
[08-11-13 16:27:05.5630] Slim::Formats::Wav::getInitialAudioBlock (94) Reading initial audio block: length 44
[08-11-13 16:27:05.5634] Slim::Player::Protocols::File::open (157) Got initial audio block of size 44
[08-11-13 16:27:05.5639] Slim::Player::Song::open (385) URL is a song (audio): file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_2_440_10/wav_32_96000_2_440_10.wav, type=wav
[08-11-13 16:27:05.5648] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (548) Using command for conversion: "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:05.5651] Slim::Player::Song::open (457) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -- "-"
[08-11-13 16:27:05.5962] Slim::Player::SongStreamController::new (32) live=2
[08-11-13 16:27:05.5984] Slim::Player::SongStreamController::DESTROY (45) live=1
[08-11-13 16:27:05.5988] Slim::Player::StreamingController::_Stream (937) 00:04:20:10:04:d2: stream
[08-11-13 16:27:05.6014] Slim::Player::Transporter::play (123) Setting DigitalInput to 0 for [file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_2_440_10/wav_32_96000_2_440_10.wav]
[08-11-13 16:27:05.6018] Slim::Player::Transporter::setDigitalInput (203) Switching to digital input 0
[08-11-13 16:27:05.6070] Slim::Player::StreamingController::_Stream (966) Song queue is now 65,64
[08-11-13 16:27:05.6080] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMING
[08-11-13 16:27:05.6084] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: NextTrackReady - new state PLAYING-STREAMING
[08-11-13 16:27:05.6089] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: ReadyToStream - new state PLAYING-STREAMING
[08-11-13 16:27:05.6221] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.6229] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.6238] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.6245] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.6251] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:05.6355] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:05.6360] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:05.6364] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer
[08-11-13 16:27:05.6368] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source
[08-11-13 16:27:05.6373] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer
[08-11-13 16:27:05.6378] Slim::Player::Source::_readNextChunk (478) readlen undef: (Broken pipe) 32
[08-11-13 16:27:05.6383] Slim::Player::Source::_readNextChunk (505) end of file or error on socket, song pos: 471896
[08-11-13 16:27:05.6386] Slim::Player::Source::_readNextChunk (514) Didn't stream any bytes for this song, so just mark it as played
[08-11-13 16:27:05.6390] Slim::Player::StreamingController::playerTrackStarted (1590) 00:04:20:10:04:d2
[08-11-13 16:27:05.6394] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing
[08-11-13 16:27:05.6398] Slim::Player::StreamingController::_setPlayingState (1747) new playing state PLAYING
[08-11-13 16:27:05.6401] Slim::Player::StreamingController::_Playing (342) Song 64 is not longer in the queue
[08-11-13 16:27:05.6406] Slim::Player::Song::DESTROY (111) live=4: index=64, url=file:///Users/qatest/Music/PT_FOABP%20Title%201%20(Ch1%20-%20Ch6)/Bit%20Rate%20Test/wav_32_96000_1_440_10/wav_32_96000_1_440_10.wav
[08-11-13 16:27:05.6421] Slim::Player::StreamingController::_Playing (348) Song 65 has now started playing
[08-11-13 16:27:05.6437] Slim::Player::StreamingController::_Playing (375) Song queue is now 65
[08-11-13 16:27:05.6441] Slim::Player::Source::_readNextChunk (521) 00:04:20:10:04:d2 mark end of stream
[08-11-13 16:27:05.6448] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout
[08-11-13 16:27:05.6451] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:05.6454] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: LocalEndOfStream - new state PLAYING-STREAMOUT
[08-11-13 16:27:05.6476] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:06.0492] Slim::Player::StreamingController::playerEndOfStream (1664) 00:04:20:10:04:d2
[08-11-13 16:27:06.0496] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[08-11-13 16:27:06.0499] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state STREAMOUT
[08-11-13 16:27:06.0545] Slim::Player::StreamingController::playerReadyToStream (1605) 00:04:20:10:04:d2
[08-11-13 16:27:06.0549] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-11-13 16:27:06.0552] Slim::Player::StreamingController::_setStreamingState (1756) new streaming state IDLE
[08-11-13 16:27:06.0557] Slim::Player::StreamingController::nextsong (741) The next song is number 0, was 65
[08-11-13 16:27:06.0561] Slim::Player::StreamingController::_eventAction (297) 00:04:20:10:04:d2: ReadyToStream - new state PLAYING-IDLE
[08-11-13 16:27:10.0105] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:10.0116] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:15.0026] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:15.0037] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:20.0035] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:20.0046] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:25.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:25.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:30.0029] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:30.0040] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:35.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:35.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:40.0027] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:40.0038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:45.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:45.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:50.0053] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:50.0061] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:55.0029] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:27:55.0040] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:00.0027] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:00.0037] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:05.0051] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:05.0058] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:10.0038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:10.0052] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:15.0026] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:15.0042] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:20.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:20.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:25.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:25.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:30.0027] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:30.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:35.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:35.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:40.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:40.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:45.9029] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:45.9038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:50.0031] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:50.0043] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:55.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:28:55.0339] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:00.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:00.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:05.0046] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:41.5429] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:48.2133] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:48.2276] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:53.0114] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:53.0125] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:58.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:29:58.0040] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:03.0762] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:03.0774] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:08.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:08.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:13.0027] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:13.0038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:18.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:18.0039] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:23.0029] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:23.0201] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:28.0028] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:28.0038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:33.0027] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:33.0038] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:38.0407] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync
[08-11-13 16:30:38.0415] Slim::Player::StreamingController::_eventAction (265) 00:04:20:10:04:d2: StatusHeartbeat in PLAYING-IDLE -> Slim::Player::StreamingController::_CheckSync